-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Mon 2025-06-02 19:13:26 CST. -- Jun 02 19:12:06 volumio go-librespot[1683]: time="2025-06-02T19:12:06+08:00" level=trace msg="sent dealer ping" Jun 02 19:12:07 volumio go-librespot[1683]: time="2025-06-02T19:12:07+08:00" level=trace msg="received dealer pong" Jun 02 19:12:29 volumio volumio[1423]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jun 02 19:12:29 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:12:29 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 19:12:29 volumio volumio[1423]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 02 19:12:29 volumio volumio[1423]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 19:12:29 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 19:12:29 volumio volumio[1423]: info: Listing playlists Jun 02 19:12:29 volumio volumio[1423]: info: CoreCommandRouter::volumioGetQueue Jun 02 19:12:29 volumio volumio[1423]: info: CoreStateMachine::getQueue Jun 02 19:12:29 volumio volumio[1423]: info: CorePlayQueue::getQueue Jun 02 19:12:31 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 19:12:31 volumio volumio[1423]: info: Received Get System Info Jun 02 19:12:31 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 19:12:31 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 19:12:31 volumio volumio[1423]: info: Discovery: Getting this device information Jun 02 19:12:31 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:12:31 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 19:12:36 volumio go-librespot[1683]: time="2025-06-02T19:12:36+08:00" level=trace msg="sent dealer ping" Jun 02 19:12:37 volumio go-librespot[1683]: time="2025-06-02T19:12:37+08:00" level=trace msg="received dealer pong" Jun 02 19:12:41 volumio volumio[1423]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS aarch64 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Jun 02 19:12:42 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:12:42 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 02 19:12:42 volumio volumio[1423]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jun 02 19:12:42 volumio volumio[1423]: info: CoreCommandRouter::volumioGetVisibleSources Jun 02 19:12:42 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 19:12:42 volumio volumio[1423]: info: Listing playlists Jun 02 19:12:42 volumio volumio[1423]: info: CoreCommandRouter::volumioGetQueue Jun 02 19:12:42 volumio volumio[1423]: info: CoreStateMachine::getQueue Jun 02 19:12:42 volumio volumio[1423]: info: CorePlayQueue::getQueue Jun 02 19:12:44 volumio go-librespot[1683]: time="2025-06-02T19:12:44+08:00" level=trace msg="received accesspoint ping" Jun 02 19:12:44 volumio go-librespot[1683]: time="2025-06-02T19:12:44+08:00" level=trace msg="received accesspoint pong ack" Jun 02 19:13:04 volumio volumio[1423]: info: VolumeController::SetAlsaVolume47 Jun 02 19:13:04 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 47 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 46 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 47 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: false Jun 02 19:13:04 volumio volumio[1423]: info: VolumeController::SetAlsaVolume50 Jun 02 19:13:04 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 50 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 46 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 50 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:04 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 50 Jun 02 19:13:04 volumio volumio[1423]: info: VolumeController::SetAlsaVolume55 Jun 02 19:13:04 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 55 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 50 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 55 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:04 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 55 Jun 02 19:13:04 volumio volumio[1423]: info: VolumeController::SetAlsaVolume59 Jun 02 19:13:04 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:04 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:04 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 59 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 55 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 59 Jun 02 19:13:04 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:04 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 59 Jun 02 19:13:05 volumio volumio[1423]: info: VolumeController::SetAlsaVolume61 Jun 02 19:13:05 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 61 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 59 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 61 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:05 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 61 Jun 02 19:13:05 volumio volumio[1423]: info: VolumeController::SetAlsaVolume58 Jun 02 19:13:05 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 58 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 61 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 58 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:05 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 58 Jun 02 19:13:05 volumio volumio[1423]: info: VolumeController::SetAlsaVolume48 Jun 02 19:13:05 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 48 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 58 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 48 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:05 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 48 Jun 02 19:13:05 volumio volumio[1423]: info: VolumeController::SetAlsaVolume4 Jun 02 19:13:05 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:05 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:05 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 4 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 48 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 4 Jun 02 19:13:05 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:05 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 4 Jun 02 19:13:06 volumio volumio[1423]: info: VolumeController::SetAlsaVolume5 Jun 02 19:13:06 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 5 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 4 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 5 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: false Jun 02 19:13:06 volumio volumio[1423]: info: VolumeController::SetAlsaVolume7 Jun 02 19:13:06 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 7 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 4 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 7 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:06 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 7 Jun 02 19:13:06 volumio volumio[1423]: info: VolumeController::SetAlsaVolume29 Jun 02 19:13:06 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 29 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 7 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 29 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:06 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 29 Jun 02 19:13:06 volumio go-librespot[1683]: time="2025-06-02T19:13:06+08:00" level=trace msg="sent dealer ping" Jun 02 19:13:06 volumio volumio[1423]: info: VolumeController::SetAlsaVolume36 Jun 02 19:13:06 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:06 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:06 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 36 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 29 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 36 Jun 02 19:13:06 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:06 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 36 Jun 02 19:13:07 volumio go-librespot[1683]: time="2025-06-02T19:13:07+08:00" level=trace msg="received dealer pong" Jun 02 19:13:07 volumio volumio[1423]: info: VolumeController::SetAlsaVolume23 Jun 02 19:13:07 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:07 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:07 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:07 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:07 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:07 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:07 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 23 Jun 02 19:13:07 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 36 Jun 02 19:13:07 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 23 Jun 02 19:13:07 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:07 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 23 Jun 02 19:13:08 volumio volumio[1423]: info: VolumeController::SetAlsaVolume35 Jun 02 19:13:08 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:08 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:08 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:08 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:08 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:08 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:08 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:08 volumio volumio[1423]: SPOTIFY: SPOTIFY VOLUME 23 Jun 02 19:13:08 volumio volumio[1423]: SPOTIFY: VOLUMIO VOLUME 35 Jun 02 19:13:08 volumio volumio[1423]: SPOTIFY: DELTA VOLUME ENOUGH: true Jun 02 19:13:08 volumio volumio[1423]: info: Setting Spotify Volume from Volumio: 35 Jun 02 19:13:09 volumio volumio[1423]: SPOTIFY: SETTING SPOTIFY VOLUME 35 Jun 02 19:13:09 volumio volumio[1423]: info: Sending Spotify command with payload to local API: /player/volume Jun 02 19:13:09 volumio go-librespot[1683]: time="2025-06-02T19:13:09+08:00" level=debug msg="update volume to 22937/65535" Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioNext Jun 02 19:13:11 volumio volumio[1423]: info: CoreStateMachine::next Jun 02 19:13:11 volumio volumio[1423]: info: Received next Jun 02 19:13:11 volumio volumio[1423]: info: Pushing metadata Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:11 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:11 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:11 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:11 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:11 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:11 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:11 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:11 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:11 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:11 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:11 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:11 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:11 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:11 volumio go-librespot[1683]: time="2025-06-02T19:13:11+08:00" level=debug msg="put connect state because VOLUME_CHANGED" Jun 02 19:13:11 volumio go-librespot[1683]: time="2025-06-02T19:13:11+08:00" level=trace msg="emitting websocket event: volume" Jun 02 19:13:11 volumio volumio[1423]: SPOTIFY: received: {"type":"volume","data":{"value":35,"max":100}} Jun 02 19:13:11 volumio volumio[1423]: SPOTIFY: RECEIVED SPOTIFY VOLUME 35 Jun 02 19:13:12 volumio volumio[1423]: info: Pushing metadata Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:12 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:12 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:12 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:12 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:12 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:12 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:12 volumio volumio[1423]: info: touch_display: Setting screensaver timeout to 120 seconds. Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:13 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:13 volumio volumio[1423]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 02 19:13:13 volumio volumio[1423]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 02 19:13:13 volumio volumio[1423]: info: camilladsp stopping service pid 28255... Jun 02 19:13:13 volumio volumio[1423]: info: camilladsp service terminated, instance 1 Jun 02 19:13:13 volumio volumio[1423]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 02 19:13:13 volumio volumio[1423]: info: camilladsp service started and running in background, instance 1 Jun 02 19:13:13 volumio volumio[1423]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 02 19:13:13 volumio volumio[1423]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 02 19:13:13 volumio volumio[1423]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:13 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:13 volumio volumio[1423]: error: FusionDsp - WebSocket error: [object Object] Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:13 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::servicePushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreStateMachine::pushState Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioPushState Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output update for this device Jun 02 19:13:13 volumio volumio[1423]: info: MRS: Pushing multiroomSync output Jun 02 19:13:13 volumio volumio[1423]: info: CoreCommandRouter::volumioGetState Jun 02 19:13:13 volumio volumio[1423]: SPOTIFY: RECEIVED VOLUMIO VOLUME 35 Jun 02 19:13:25 volumio volumio[1423]: info: CoreCommandRouter::volumioRemoveQueueItem Jun 02 19:13:25 volumio volumio[1423]: info: CoreStateMachine::removeQueueItem Jun 02 19:13:25 volumio volumio[1423]: info: CoreStateMachine::stop Jun 02 19:13:25 volumio volumio[1423]: info: CoreStateMachine::serviceStop Jun 02 19:13:25 volumio volumio[1423]: info: CoreCommandRouter::serviceStop Jun 02 19:13:25 volumio volumio[1423]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 19:13:25 volumio volumio[1423]: TypeError: Cannot read property 'then' of undefined Jun 02 19:13:25 volumio volumio[1423]: at CoreStateMachine.removeQueueItem (/volumio/app/statemachine.js:1368:7) Jun 02 19:13:25 volumio volumio[1423]: at CoreCommandRouter.volumioRemoveQueueItem (/volumio/app/index.js:121:28) Jun 02 19:13:25 volumio volumio[1423]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:173:33) Jun 02 19:13:25 volumio volumio[1423]: at Socket.emit (events.js:315:20) Jun 02 19:13:25 volumio volumio[1423]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 02 19:13:25 volumio volumio[1423]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 02 19:13:25 volumio volumio[1423]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 19:13:25 volumio vtcs[2369]: [2025-06-02 19:13:25] [info] asio async_shutdown error: asio.misc:2 (End of file) Jun 02 19:13:26 volumio sudo[28363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-02 19:12 Jun 02 19:13:26 volumio sudo[28363]: 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"