-- Logs begin at Wed 2024-07-10 18:29:09 CEST, end at Wed 2024-07-10 21:15:51 CEST. -- Jul 10 21:14:03 volumio volumio[1151]: info: FusionDsp - Stopping FusionDsp service Jul 10 21:14:03 volumio volumio[1151]: info: camilladsp stopping service pid 5596... Jul 10 21:14:03 volumio volumio[1151]: info: camilladsp service terminated, instance 3 Jul 10 21:14:03 volumio volumio[1151]: info: Disabling plugin fusiondsp Jul 10 21:14:03 volumio volumio[1151]: info: Preparing to generate the ALSA configuration file Jul 10 21:14:03 volumio sudo[5624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Jul 10 21:14:03 volumio sudo[5624]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio volumio[1151]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 10 21:14:03 volumio volumio[1151]: info: Reading ALSA contributions from plugins. Jul 10 21:14:03 volumio systemd[1]: Stopping FusionDsp Daemon... Jul 10 21:14:03 volumio volumio[5442]: Backend configuration: Jul 10 21:14:03 volumio volumio[5442]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jul 10 21:14:03 volumio volumio[5442]: active_config_txt: null Jul 10 21:14:03 volumio volumio[5442]: camilla_host: 127.0.0.1 Jul 10 21:14:03 volumio volumio[5442]: camilla_port: 9876 Jul 10 21:14:03 volumio volumio[5442]: coeff_dir: /data/INTERNAL/FusionDsp/filters Jul 10 21:14:03 volumio volumio[5442]: config_dir: /data/configuration/audio_interface/fusiondsp Jul 10 21:14:03 volumio volumio[5442]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jul 10 21:14:03 volumio volumio[5442]: log_file: /tmp/camilladsp.log Jul 10 21:14:03 volumio volumio[5442]: on_get_active_config: null Jul 10 21:14:03 volumio volumio[5442]: on_set_active_config: null Jul 10 21:14:03 volumio volumio[5442]: port: 5011 Jul 10 21:14:03 volumio volumio[5442]: supported_capture_types: null Jul 10 21:14:03 volumio volumio[5442]: supported_playback_types: null Jul 10 21:14:03 volumio volumio[5442]: update_config_symlink: false Jul 10 21:14:03 volumio volumio[5442]: update_config_txt: false Jul 10 21:14:03 volumio volumio[5442]: ======== Running on http://0.0.0.0:5011 ======== Jul 10 21:14:03 volumio volumio[5442]: (Press CTRL+C to quit) Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:03 volumio volumio[1151]: info: Asound.conf file written Jul 10 21:14:03 volumio sudo[5627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 10 21:14:03 volumio sudo[5627]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio sudo[5627]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio systemd[1]: fusiondsp.service: Succeeded. Jul 10 21:14:03 volumio systemd[1]: Stopped FusionDsp Daemon. Jul 10 21:14:03 volumio sudo[5624]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: No protocol specified Jul 10 21:14:03 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:14:03 volumio volumio[1151]: info: Output device has changed, restarting MPD Jul 10 21:14:03 volumio sudo[5633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 10 21:14:03 volumio sudo[5633]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio sudo[5633]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: info: Output device has changed, restarting Shairport Sync Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 21:14:03 volumio sudo[5636]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 10 21:14:03 volumio sudo[5636]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio systemd[1]: Stopping Music Player Daemon... Jul 10 21:14:03 volumio systemd[1]: mpd.service: Succeeded. Jul 10 21:14:03 volumio systemd[1]: Stopped Music Player Daemon. Jul 10 21:14:03 volumio volumio[1151]: No protocol specified Jul 10 21:14:03 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:14:03 volumio volumio[1151]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 10 21:14:03 volumio volumio[1151]: No protocol specified Jul 10 21:14:03 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:14:03 volumio volumio[1151]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: Relinquishing Volumio State Jul 10 21:14:03 volumio volumio[1151]: verbose: UNSET VOLATILE: Service: tidalconnect Jul 10 21:14:03 volumio volumio[1151]: info: unSetVolatile called Jul 10 21:14:03 volumio volumio[1151]: info: Relinquishing Volumio State to another service Jul 10 21:14:03 volumio vtcs[5463]: [2024-07-10 21:14:03.566] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jul 10 21:14:03 volumio vtcs[5463]: [2024-07-10 21:14:03.566] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=8 errorno=104 error=Connection reset by peer Jul 10 21:14:03 volumio vtcs[5463]: [2024-07-10 21:14:03.566] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jul 10 21:14:03 volumio sudo[5646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 10 21:14:03 volumio volumio[1151]: info: Done. Jul 10 21:14:03 volumio systemd[1]: Starting Music Player Daemon... Jul 10 21:14:03 volumio sudo[5646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jul 10 21:14:03 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 10 21:14:03 volumio systemd[1]: vtcs.service: Succeeded. Jul 10 21:14:03 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jul 10 21:14:03 volumio sudo[5646]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:03 volumio sudo[5649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 10 21:14:03 volumio sudo[5649]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:03 volumio volumio[1151]: info: MPD Permissions set Jul 10 21:14:03 volumio volumio[1151]: info: FusionDsp - Reporting Fusion DSP Disabled Jul 10 21:14:03 volumio volumio[1151]: info: Removing fusiondspeq DSP Signal Path Element Jul 10 21:14:03 volumio sudo[5649]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio sudo[5641]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 10 21:14:03 volumio sudo[5641]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio sudo[5641]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 10 21:14:03 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:14:03 volumio volumio[1151]: info: Starting Shairport Sync Jul 10 21:14:03 volumio sudo[5662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 10 21:14:03 volumio sudo[5662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:03 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 10 21:14:03 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:03 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 10 21:14:03 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 10 21:14:03 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 10 21:14:03 volumio sudo[5662]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: info: Shairport-Sync Started Jul 10 21:14:03 volumio mpd[5655]: Jul 10 21:14 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 10 21:14:03 volumio systemd[1]: Started Music Player Daemon. Jul 10 21:14:03 volumio sudo[5636]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:03 volumio volumio[1151]: error: updateQueue error: null Jul 10 21:14:06 volumio volumio[1151]: info: TidalConnect service stoped! Jul 10 21:14:06 volumio volumio[1151]: info: TidalConnect service stoped! Jul 10 21:14:06 volumio volumio[1151]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 10 21:14:06 volumio volumio[1151]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 10 21:14:06 volumio sudo[5678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 10 21:14:06 volumio sudo[5678]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:06 volumio systemd[1]: Started Volumio Tidal Connect Service. Jul 10 21:14:06 volumio sudo[5678]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:06 volumio volumio[1151]: info: Executing endpoint tc_getconfig Jul 10 21:14:06 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 10 21:14:06 volumio vtcs[5680]: STARTING TidalConnect services, version: 1.4.0.34 Jul 10 21:14:06 volumio vtcs[5680]: STARTED TidalConnect services. Jul 10 21:14:06 volumio volumio[1151]: info: Executing endpoint tc_connect Jul 10 21:14:06 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 10 21:14:06 volumio volumio[1151]: info: Connecting to TidalConnect Jul 10 21:14:06 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:06 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:14:06 volumio volumio[1151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jul 10 21:14:06 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:06 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:14:06 volumio volumio[1151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jul 10 21:14:08 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:08 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:09 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:09 volumio volumio[1151]: info: TidalConnect service started! Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:14:16 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:14:16 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:14:16 volumio volumio[1151]: info: Currently active: tidal Jul 10 21:14:16 volumio volumio[1151]: info: Stopping currently active service Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioStop Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::stop Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::stPlaybackTimer Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::updateTrackBlock Jul 10 21:14:16 volumio volumio[1151]: info: CorePlayQueue::getTrackBlock Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:16 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::serviceStop Jul 10 21:14:16 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::serviceStop Jul 10 21:14:16 volumio volumio[1151]: info: [1720638856013] ControllerTidal::stop Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 21:14:16 volumio volumio[1151]: info: ControllerMpd::stop Jul 10 21:14:16 volumio volumio[1151]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 21:14:16 volumio volumio[1151]: info: sendMpdCommand stop took 10 milliseconds Jul 10 21:14:16 volumio volumio[1151]: info: TidalConnect Active Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:14:16 volumio volumio[1151]: info: Currently active: mpd Jul 10 21:14:16 volumio volumio[1151]: info: Setting Volatile state to tidalconnect Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:16 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:16 volumio volumio[1151]: error: service is not defined Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:16 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:16 volumio volumio[1151]: error: service is not defined Jul 10 21:14:16 volumio vtcs[5680]: [2024-07-10 21:14:16.449] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Jul 10 21:14:16 volumio volumio[1151]: info: Pushing metadata Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:16 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:16 volumio volumio[1151]: error: service is not defined Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:16 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:16 volumio volumio[1151]: error: service is not defined Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:16 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:16 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:17 volumio volumio[1151]: info: Pushing metadata Jul 10 21:14:17 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:17 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:17 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:17 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:17 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:17 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:17 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:17 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:17 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:17 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:17 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:17 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:17 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:17 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:17 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:17 volumio vtcs[5680]: [2024-07-10 21:14:17.447] [tisoc] [warning] [flac_decoder.cpp:282] FLACDecoder::error_callback FLAC__STREAM_DECODER_ERROR_STATUS_LOST_SYNC Jul 10 21:14:18 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:18 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:18 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:18 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:18 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:18 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:18 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:18 volumio volumio[1151]: error: service is not defined Jul 10 21:14:19 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:19 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:19 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:19 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:19 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:19 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:19 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:19 volumio volumio[1151]: error: service is not defined Jul 10 21:14:25 volumio volumio[1151]: info: Pushing metadata Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:25 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:25 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:25 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:25 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:25 volumio volumio[1151]: error: service is not defined Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:25 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:25 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:25 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:25 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:25 volumio volumio[1151]: error: service is not defined Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:14:25 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:14:25 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:14:25 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:14:25 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:14:25 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:14:25 volumio volumio[1151]: error: service is not defined Jul 10 21:14:28 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 21:14:28 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 21:14:28 volumio volumio[1151]: info: Discovery: Getting this device information Jul 10 21:14:28 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:14:28 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 21:14:33 volumio ntpd[30124]: Soliciting pool server 2a01:238:43f2:8900:dd04:e3a0:ee11:a73d Jul 10 21:14:34 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Jul 10 21:14:34 volumio volumio[1151]: info: MRS: Setting this device as single Jul 10 21:14:34 volumio volumio[1151]: info: Jul 10 21:14:34 volumio volumio[1151]: [1720638874222] ---------------------------- Setting Multiroom Single Jul 10 21:14:34 volumio volumio[1151]: info: MRS: disable multiroom output Jul 10 21:14:34 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioDiscard Jul 10 21:14:34 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Jul 10 21:14:34 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:14:34 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Jul 10 21:14:35 volumio volumio[1151]: info: MRS: STOPPING volumioStreaming Jul 10 21:14:35 volumio sudo[5778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 10 21:14:35 volumio sudo[5778]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:35 volumio volumio[1151]: info: MRS: Stopping cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:35 volumio systemd[1]: Stopping VolumioStreamingService... Jul 10 21:14:35 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Jul 10 21:14:35 volumio systemd[1]: volumioStreaming.service: Succeeded. Jul 10 21:14:35 volumio systemd[1]: Stopped VolumioStreamingService. Jul 10 21:14:35 volumio sudo[5781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream10.ts /tmp/hls/stream11.ts /tmp/hls/stream12.ts /tmp/hls/stream13.ts /tmp/hls/stream14.ts /tmp/hls/stream15.ts /tmp/hls/stream16.ts /tmp/hls/stream17.ts /tmp/hls/stream18.ts /tmp/hls/stream19.ts /tmp/hls/stream2.ts /tmp/hls/stream20.ts /tmp/hls/stream21.ts /tmp/hls/stream22.ts /tmp/hls/stream23.ts /tmp/hls/stream24.ts /tmp/hls/stream25.ts /tmp/hls/stream26.ts /tmp/hls/stream27.ts /tmp/hls/stream28.ts /tmp/hls/stream29.ts /tmp/hls/stream3.ts /tmp/hls/stream30.ts /tmp/hls/stream31.ts /tmp/hls/stream32.ts /tmp/hls/stream33.ts /tmp/hls/stream34.ts /tmp/hls/stream35.ts /tmp/hls/stream36.ts /tmp/hls/stream37.ts /tmp/hls/stream38.ts /tmp/hls/stream39.ts /tmp/hls/stream4.ts /tmp/hls/stream40.ts /tmp/hls/stream41.ts /tmp/hls/stream42.ts /tmp/hls/stream43.ts /tmp/hls/stream44.ts /tmp/hls/stream45.ts Jul 10 21:14:35 volumio sudo[5781]: volumio : (command continued) /tmp/hls/stream46.ts /tmp/hls/stream47.ts /tmp/hls/stream48.ts /tmp/hls/stream49.ts /tmp/hls/stream5.ts /tmp/hls/stream50.ts /tmp/hls/stream51.ts /tmp/hls/stream52.ts /tmp/hls/stream53.ts /tmp/hls/stream54.ts /tmp/hls/stream55.ts /tmp/hls/stream56.ts /tmp/hls/stream57.ts /tmp/hls/stream58.ts /tmp/hls/stream59.ts /tmp/hls/stream6.ts /tmp/hls/stream60.ts /tmp/hls/stream61.ts /tmp/hls/stream62.ts /tmp/hls/stream63.ts /tmp/hls/stream64.ts /tmp/hls/stream65.ts /tmp/hls/stream66.ts /tmp/hls/stream67.ts /tmp/hls/stream68.ts /tmp/hls/stream69.ts /tmp/hls/stream7.ts /tmp/hls/stream70.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts Jul 10 21:14:35 volumio sudo[5781]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:35 volumio sudo[5778]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:35 volumio sudo[5781]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:35 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:35 volumio volumio[1151]: info: MRS: Removed streaming files Jul 10 21:14:35 volumio volumio[1151]: info: MRS: volumioStreaming STOPPED Jul 10 21:14:36 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Jul 10 21:14:36 volumio volumio[1151]: info: MRS: Starting cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:36 volumio volumio[1151]: info: Enabled audio output: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:36 volumio volumio[1151]: info: MRS: Setting this device as Streaming Server Jul 10 21:14:36 volumio volumio[1151]: info: Jul 10 21:14:36 volumio volumio[1151]: [1720638876949] ---------------------------- MRS: Setting Streaming Server Jul 10 21:14:36 volumio volumio[1151]: info: MRS: enable multiroom server output Jul 10 21:14:36 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioMultiRoom Jul 10 21:14:36 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Jul 10 21:14:36 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:14:36 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Jul 10 21:14:36 volumio volumio[1151]: info: MRS: STARTING volumioStreaming Jul 10 21:14:36 volumio sudo[5791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:14:36 volumio sudo[5791]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:37 volumio sudo[5791]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:37 volumio sudo[5794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Jul 10 21:14:37 volumio sudo[5794]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:37 volumio volumio[1151]: info: MRS: Connected to cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:37 volumio systemd[1]: Started VolumioStreamingService. Jul 10 21:14:37 volumio sudo[5794]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:37 volumio volumio[1151]: info: MRS: volumioStreaming STARTED Jul 10 21:14:37 volumio sudo[5797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:14:37 volumio sudo[5797]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:37 volumio sudo[5797]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:37 volumio volumio[1151]: info: Refreshing Cached IP Addresses Jul 10 21:14:37 volumio sudo[5801]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 21:14:37 volumio sudo[5801]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:37 volumio sudo[5801]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:37 volumio sudo[5804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 21:14:37 volumio sudo[5804]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:37 volumio sudo[5804]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:37 volumio volumio[1151]: info: MRS: Cast player state: IDLE Jul 10 21:14:38 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:39 volumio volumio[1151]: info: MRS: Cast player state: PLAYING Jul 10 21:14:39 volumio volumio[1151]: info: MRS: cast media loaded Jul 10 21:14:39 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:39 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Jul 10 21:14:39 volumio volumio[1151]: info: MRS: Setting this device as single Jul 10 21:14:39 volumio volumio[1151]: info: Jul 10 21:14:39 volumio volumio[1151]: [1720638879728] ---------------------------- Setting Multiroom Single Jul 10 21:14:39 volumio volumio[1151]: info: MRS: disable multiroom output Jul 10 21:14:39 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioDiscard Jul 10 21:14:39 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Jul 10 21:14:40 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:14:40 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Jul 10 21:14:41 volumio volumio[1151]: info: MRS: STOPPING volumioStreaming Jul 10 21:14:41 volumio sudo[5813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 10 21:14:41 volumio sudo[5813]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:41 volumio volumio[1151]: info: MRS: Stopping cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:41 volumio systemd[1]: Stopping VolumioStreamingService... Jul 10 21:14:41 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Jul 10 21:14:41 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:14:41 volumio sudo[5816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream2.ts /tmp/hls/stream3.ts Jul 10 21:14:41 volumio sudo[5816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:41 volumio systemd[1]: volumioStreaming.service: Succeeded. Jul 10 21:14:41 volumio systemd[1]: Stopped VolumioStreamingService. Jul 10 21:14:41 volumio sudo[5816]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:41 volumio volumio[1151]: info: MRS: Removed streaming files Jul 10 21:14:41 volumio sudo[5813]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:41 volumio volumio[1151]: info: MRS: volumioStreaming STOPPED Jul 10 21:14:42 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Jul 10 21:14:42 volumio volumio[1151]: info: MRS: Starting cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:42 volumio volumio[1151]: info: Enabled audio output: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:42 volumio volumio[1151]: info: MRS: Setting this device as Streaming Server Jul 10 21:14:42 volumio volumio[1151]: info: Jul 10 21:14:42 volumio volumio[1151]: [1720638882486] ---------------------------- MRS: Setting Streaming Server Jul 10 21:14:42 volumio volumio[1151]: info: MRS: enable multiroom server output Jul 10 21:14:42 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioMultiRoom Jul 10 21:14:42 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Jul 10 21:14:42 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:14:42 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Jul 10 21:14:42 volumio volumio[1151]: info: MRS: STARTING volumioStreaming Jul 10 21:14:42 volumio sudo[5821]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:14:42 volumio sudo[5821]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:42 volumio sudo[5821]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:42 volumio sudo[5824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Jul 10 21:14:42 volumio sudo[5824]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:42 volumio systemd[1]: Started VolumioStreamingService. Jul 10 21:14:42 volumio sudo[5824]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:42 volumio volumio[1151]: info: MRS: volumioStreaming STARTED Jul 10 21:14:42 volumio sudo[5827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:14:42 volumio sudo[5827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:42 volumio sudo[5827]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:47 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Jul 10 21:14:47 volumio volumio[1151]: info: MRS: Connected to cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:14:47 volumio volumio[1151]: info: Refreshing Cached IP Addresses Jul 10 21:14:47 volumio sudo[5841]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 10 21:14:47 volumio sudo[5841]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:47 volumio sudo[5841]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:47 volumio sudo[5844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 10 21:14:47 volumio sudo[5844]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:14:47 volumio sudo[5844]: pam_unix(sudo:session): session closed for user root Jul 10 21:14:47 volumio volumio[1151]: info: MRS: Cast player state: IDLE Jul 10 21:14:47 volumio volumio[1151]: info: MRS: Cast player state: PLAYING Jul 10 21:14:47 volumio volumio[1151]: info: MRS: cast media loaded Jul 10 21:14:48 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:48 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:14:49 volumio volumio[1151]: info: MRS: Cast player state: PLAYING Jul 10 21:14:50 volumio volumio[1151]: info: MRS: Cast player state: PLAYING Jul 10 21:14:55 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 21:14:55 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 21:14:55 volumio volumio[1151]: info: Discovery: Getting this device information Jul 10 21:14:55 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:14:55 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 21:15:08 volumio volumio[1151]: info: CALLMETHOD: audio_interface fusiondsp enableeffect undefined Jul 10 21:15:08 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: fusiondsp , enableeffect Jul 10 21:15:10 volumio volumio[1151]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 10 21:15:19 volumio volumio[1151]: error: [now-playing] API endpoint weather/fetchInfo returned error: Error: Could not access weather service: missing geographic coordinates. Jul 10 21:15:19 volumio volumio[1151]: at WeatherAPI.fetchInfo (/data/plugins/user_interface/now_playing/dist/lib/api/WeatherAPI.js:106:19) Jul 10 21:15:19 volumio volumio[1151]: at Object.api (/data/plugins/user_interface/now_playing/dist/app/Handler.js:113:37) Jul 10 21:15:19 volumio volumio[1151]: at /data/plugins/user_interface/now_playing/dist/app/Router.js:47:13 Jul 10 21:15:19 volumio volumio[1151]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jul 10 21:15:19 volumio volumio[1151]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:149:13) Jul 10 21:15:19 volumio volumio[1151]: at Route.dispatch (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/route.js:119:3) Jul 10 21:15:19 volumio volumio[1151]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jul 10 21:15:19 volumio volumio[1151]: at /data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:284:15 Jul 10 21:15:19 volumio volumio[1151]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:365:14) Jul 10 21:15:19 volumio volumio[1151]: at param (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:376:14) Jul 10 21:15:19 volumio volumio[1151]: at Function.process_params (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:421:3) Jul 10 21:15:19 volumio volumio[1151]: at next (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:280:10) Jul 10 21:15:19 volumio volumio[1151]: at Function.handle (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:175:3) Jul 10 21:15:19 volumio volumio[1151]: at router (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/index.js:47:12) Jul 10 21:15:19 volumio volumio[1151]: at Layer.handle [as handle_request] (/data/plugins/user_interface/now_playing/node_modules/express/lib/router/layer.js:95:5) Jul 10 21:15:20 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 10 21:15:20 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jul 10 21:15:24 volumio volumio[1151]: info: Enabling plugin fusiondsp Jul 10 21:15:24 volumio volumio[1151]: info: Loading plugin "fusiondsp"... Jul 10 21:15:24 volumio volumio[1151]: info: Applying required configuration parameters for plugin fusiondsp Jul 10 21:15:24 volumio volumio[1151]: info: Preparing to generate the ALSA configuration file Jul 10 21:15:24 volumio volumio[1151]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 10 21:15:24 volumio volumio[1151]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 10 21:15:24 volumio volumio[1151]: info: Reading ALSA contributions from plugins. Jul 10 21:15:24 volumio volumio[1151]: info: Asound.conf file written Jul 10 21:15:24 volumio sudo[5849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 10 21:15:24 volumio sudo[5849]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio sudo[5849]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio volumio[1151]: No protocol specified Jul 10 21:15:24 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:24 volumio volumio[1151]: info: Output device has changed, restarting MPD Jul 10 21:15:24 volumio sudo[5854]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 10 21:15:24 volumio sudo[5854]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio sudo[5854]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio volumio[1151]: info: Output device has changed, restarting Shairport Sync Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 21:15:24 volumio sudo[5858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 10 21:15:24 volumio sudo[5858]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio systemd[1]: Stopping Music Player Daemon... Jul 10 21:15:24 volumio systemd[1]: mpd.service: Succeeded. Jul 10 21:15:24 volumio systemd[1]: Stopped Music Player Daemon. Jul 10 21:15:24 volumio volumio[1151]: No protocol specified Jul 10 21:15:24 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:24 volumio volumio[1151]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 10 21:15:24 volumio volumio[1151]: No protocol specified Jul 10 21:15:24 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:24 volumio volumio[1151]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: Relinquishing Volumio State Jul 10 21:15:24 volumio volumio[1151]: verbose: UNSET VOLATILE: Service: tidalconnect Jul 10 21:15:24 volumio volumio[1151]: info: unSetVolatile called Jul 10 21:15:24 volumio volumio[1151]: info: Relinquishing Volumio State to another service Jul 10 21:15:24 volumio vtcs[5680]: [2024-07-10 21:15:24.806] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Jul 10 21:15:24 volumio vtcs[5680]: [2024-07-10 21:15:24.806] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Jul 10 21:15:24 volumio sudo[5868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 10 21:15:24 volumio volumio[1151]: info: PLUGIN START: fusiondsp Jul 10 21:15:24 volumio volumio[1151]: info: Loading i18n strings for locale en Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: FusionDsp - mixtype--------------------- Hardware Jul 10 21:15:24 volumio volumio[1151]: info: Preparing to generate the ALSA configuration file Jul 10 21:15:24 volumio sudo[5868]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio systemd[1]: Starting Music Player Daemon... Jul 10 21:15:24 volumio volumio[1151]: info: Done. Jul 10 21:15:24 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jul 10 21:15:24 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jul 10 21:15:24 volumio systemd[1]: vtcs.service: Succeeded. Jul 10 21:15:24 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jul 10 21:15:24 volumio volumio[1151]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jul 10 21:15:24 volumio volumio[1151]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 10 21:15:24 volumio volumio[1151]: info: Reading ALSA contributions from plugins. Jul 10 21:15:24 volumio sudo[5868]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:24 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 10 21:15:24 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:24 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:24 volumio sudo[5871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 10 21:15:24 volumio sudo[5871]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio volumio[1151]: info: MPD Permissions set Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio sudo[5863]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 10 21:15:24 volumio sudo[5863]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio sudo[5871]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio sudo[5863]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: Starting Shairport Sync Jul 10 21:15:24 volumio volumio[1151]: info: Asound.conf file unchanged, so no further update is needed Jul 10 21:15:24 volumio volumio[1151]: info: Output device has changed, restarting MPD Jul 10 21:15:24 volumio sudo[5884]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 10 21:15:24 volumio sudo[5884]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 10 21:15:24 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 10 21:15:24 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 10 21:15:24 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 10 21:15:24 volumio sudo[5887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 10 21:15:24 volumio sudo[5884]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio sudo[5887]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio sudo[5887]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:24 volumio volumio[1151]: info: Output device has changed, restarting Shairport Sync Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 21:15:24 volumio sudo[5891]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 10 21:15:24 volumio sudo[5891]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:24 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 10 21:15:24 volumio systemd[1]: mpd.service: Succeeded. Jul 10 21:15:24 volumio systemd[1]: Stopped Music Player Daemon. Jul 10 21:15:24 volumio systemd[1]: Starting Music Player Daemon... Jul 10 21:15:24 volumio volumio[1151]: No protocol specified Jul 10 21:15:24 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:24 volumio volumio[1151]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 10 21:15:24 volumio volumio[1151]: No protocol specified Jul 10 21:15:24 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:24 volumio volumio[1151]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jul 10 21:15:24 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:24 volumio volumio[1151]: info: Relinquishing Volumio State Jul 10 21:15:25 volumio sudo[5900]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 10 21:15:25 volumio sudo[5900]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:25 volumio sudo[5900]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:25 volumio sudo[5920]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 10 21:15:25 volumio sudo[5920]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:25 volumio volumio[1151]: info: MPD Permissions set Jul 10 21:15:25 volumio volumio[1151]: info: Shairport-Sync Started Jul 10 21:15:25 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:25 volumio sudo[5930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jul 10 21:15:25 volumio sudo[5930]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:25 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 10 21:15:25 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jul 10 21:15:25 volumio sudo[5920]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:25 volumio sudo[5930]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:25 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:25 volumio volumio[1151]: info: Starting Shairport Sync Jul 10 21:15:25 volumio sudo[5978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 10 21:15:25 volumio sudo[5978]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:25 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 10 21:15:25 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:25 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 10 21:15:25 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 10 21:15:25 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 10 21:15:25 volumio sudo[5978]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:25 volumio volumio[1151]: info: Shairport-Sync Started Jul 10 21:15:25 volumio mpd[5921]: Jul 10 21:15 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 10 21:15:25 volumio systemd[1]: Started Music Player Daemon. Jul 10 21:15:25 volumio sudo[5891]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:25 volumio sudo[5858]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:25 volumio volumio[1151]: error: MPD error: The expression evaluated to a falsy value: Jul 10 21:15:25 volumio volumio[1151]: assert.ok(self.idling) Jul 10 21:15:25 volumio volumio[1151]: error: The expression evaluated to a falsy value: Jul 10 21:15:25 volumio volumio[1151]: assert.ok(self.idling) Jul 10 21:15:25 volumio volumio[1151]: error: updateQueue error: null Jul 10 21:15:26 volumio volumio[1151]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 10 21:15:26 volumio volumio[1151]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jul 10 21:15:26 volumio volumio[1151]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jul 10 21:15:26 volumio volumio[1151]: info: camilladsp spawned new process with pid 5991, instance 4, run: true Jul 10 21:15:26 volumio volumio[1151]: info: camilladsp service started and running in background, instance 4 Jul 10 21:15:26 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 10 21:15:26 volumio volumio[1151]: No protocol specified Jul 10 21:15:26 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:26 volumio volumio[1151]: cannot open device 'volumioHw': Device or resource busy Jul 10 21:15:26 volumio volumio[1151]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 10 21:15:26 volumio volumio[1151]: No protocol specified Jul 10 21:15:26 volumio volumio[1151]: xcb_connection_has_error() returned true Jul 10 21:15:26 volumio volumio[1151]: cannot open device 'volumioHw': Device or resource busy Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp loaded Jul 10 21:15:26 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 21:15:26 volumio sudo[6001]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 10 21:15:26 volumio sudo[6001]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 10 21:15:26 volumio volumio[1151]: info: Adding Signal Path Element [object Object] Jul 10 21:15:26 volumio volumio[1151]: info: Adding fusiondspeq DSP Signal Path Element Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - ---- installed callbackRead Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:26 volumio volumio[1151]: info: FusionDsp - Effects disabled Jul 10 21:15:26 volumio systemd[1]: Started FusionDsp Daemon. Jul 10 21:15:26 volumio sudo[6001]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:27 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:27 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:27 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:28 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:28 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:28 volumio volumio[1151]: info: camilladsp stopping service pid 5991... Jul 10 21:15:28 volumio volumio[1151]: info: camilladsp service terminated, instance 4 Jul 10 21:15:28 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:28 volumio volumio[1151]: info: camilladsp service started and running in background, instance 4 Jul 10 21:15:30 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:15:30 volumio volumio[1151]: error: FusionDsp - WebSocket error: [object Object] Jul 10 21:15:30 volumio volumio[1151]: error: FusionDsp - WebSocket error: [object Object] Jul 10 21:15:30 volumio volumio[1151]: error: FusionDsp - WebSocket error: [object Object] Jul 10 21:15:30 volumio volumio[1151]: error: FusionDsp - WebSocket error: [object Object] Jul 10 21:15:30 volumio volumio[1151]: info: TidalConnect service stoped! Jul 10 21:15:30 volumio volumio[1151]: info: TidalConnect service stoped! Jul 10 21:15:30 volumio volumio[1151]: info: TidalConnect service stoped! Jul 10 21:15:30 volumio volumio[1151]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jul 10 21:15:30 volumio volumio[1151]: info: camilladsp spawned new process with pid 6018, instance 4, run: true Jul 10 21:15:30 volumio volumio[1151]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 10 21:15:30 volumio volumio[1151]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 10 21:15:30 volumio volumio[1151]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jul 10 21:15:30 volumio volumio[1151]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Jul 10 21:15:30 volumio sudo[6031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 10 21:15:30 volumio sudo[6031]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:30 volumio sudo[6035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jul 10 21:15:30 volumio sudo[6035]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:30 volumio systemd[1]: Started Volumio Tidal Connect Service. Jul 10 21:15:30 volumio sudo[6031]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:30 volumio sudo[6035]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:30 volumio volumio[1151]: info: Executing endpoint tc_getconfig Jul 10 21:15:30 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jul 10 21:15:30 volumio vtcs[6034]: STARTING TidalConnect services, version: 1.4.0.34 Jul 10 21:15:30 volumio vtcs[6034]: STARTED TidalConnect services. Jul 10 21:15:30 volumio volumio[1151]: info: Executing endpoint tc_connect Jul 10 21:15:30 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jul 10 21:15:30 volumio volumio[1151]: info: Connecting to TidalConnect Jul 10 21:15:30 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:30 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:15:30 volumio volumio[1151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jul 10 21:15:30 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:30 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:15:30 volumio volumio[1151]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current tidal Received tidalconnect Jul 10 21:15:30 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:15:31 volumio volumio[1151]: info: MRS: Cast player state: BUFFERING Jul 10 21:15:33 volumio volumio[1151]: info: TidalConnect service started! Jul 10 21:15:33 volumio volumio[1151]: info: TidalConnect service started! Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:15:37 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:15:37 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:15:37 volumio volumio[1151]: info: Currently active: tidal Jul 10 21:15:37 volumio volumio[1151]: info: Stopping currently active service Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioStop Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::stop Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::stPlaybackTimer Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::updateTrackBlock Jul 10 21:15:37 volumio volumio[1151]: info: CorePlayQueue::getTrackBlock Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:37 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::serviceStop Jul 10 21:15:37 volumio volumio[1151]: info: CorePlayQueue::getTrack 43 Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::serviceStop Jul 10 21:15:37 volumio volumio[1151]: info: [1720638937165] ControllerTidal::stop Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 10 21:15:37 volumio volumio[1151]: info: ControllerMpd::stop Jul 10 21:15:37 volumio volumio[1151]: verbose: ControllerMpd::sendMpdCommand stop Jul 10 21:15:37 volumio volumio[1151]: info: sendMpdCommand stop took 6 milliseconds Jul 10 21:15:37 volumio volumio[1151]: info: TidalConnect Active Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:15:37 volumio volumio[1151]: info: Currently active: mpd Jul 10 21:15:37 volumio volumio[1151]: info: Setting Volatile state to tidalconnect Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:37 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:15:37 volumio volumio[1151]: error: service is not defined Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:37 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:15:37 volumio volumio[1151]: error: service is not defined Jul 10 21:15:37 volumio vtcs[6034]: [2024-07-10 21:15:37.424] [tisoc] [warning] [PlaybackControllerImpl.cpp:510] Illegal state:1 Jul 10 21:15:37 volumio volumio[1151]: info: Pushing metadata Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:37 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:15:37 volumio volumio[1151]: error: service is not defined Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:37 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:15:37 volumio volumio[1151]: error: service is not defined Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:15:37 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:37 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:38 volumio volumio[1151]: info: Pushing metadata Jul 10 21:15:38 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:38 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:38 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:38 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:38 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:38 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:38 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:38 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:38 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:38 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:38 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:38 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:38 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:38 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:38 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:38 volumio vtcs[6034]: [2024-07-10 21:15:38.348] [tisoc] [warning] [flac_decoder.cpp:282] FLACDecoder::error_callback FLAC__STREAM_DECODER_ERROR_STATUS_LOST_SYNC Jul 10 21:15:40 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:40 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:40 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:15:40 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:40 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:40 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:40 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:15:40 volumio volumio[1151]: error: service is not defined Jul 10 21:15:40 volumio ntpd[30124]: Soliciting pool server 2a00:d78:0:712:94:198:159:16 Jul 10 21:15:40 volumio volumio[1151]: info: CoreCommandRouter::servicePushState Jul 10 21:15:40 volumio volumio[1151]: info: CoreStateMachine::pushState Jul 10 21:15:40 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 10 21:15:40 volumio volumio[1151]: info: CoreCommandRouter::volumioPushState Jul 10 21:15:40 volumio volumio[1151]: info: MRS: Pushing multiroomSync output update for this device Jul 10 21:15:40 volumio volumio[1151]: info: MRS: Pushing multiroomSync output Jul 10 21:15:40 volumio volumio[1151]: error: Help! Some callbacks for volumioPushState are crashing! Jul 10 21:15:40 volumio volumio[1151]: error: service is not defined Jul 10 21:15:43 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 10 21:15:43 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 10 21:15:43 volumio volumio[1151]: info: Discovery: Getting this device information Jul 10 21:15:43 volumio volumio[1151]: info: CoreCommandRouter::volumioGetState Jul 10 21:15:43 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 10 21:15:48 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , disableAudioOutput Jul 10 21:15:48 volumio volumio[1151]: info: MRS: Setting this device as single Jul 10 21:15:48 volumio volumio[1151]: info: Jul 10 21:15:48 volumio volumio[1151]: [1720638948813] ---------------------------- Setting Multiroom Single Jul 10 21:15:48 volumio volumio[1151]: info: MRS: disable multiroom output Jul 10 21:15:48 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioDiscard Jul 10 21:15:48 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioDiscard Jul 10 21:15:49 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:15:49 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioLocalPlayback Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - Effects disabled Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:49 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - Effects disabled Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - ---- read samplerate from file: 44100 Jul 10 21:15:50 volumio volumio[1151]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jul 10 21:15:51 volumio volumio[1151]: info: MRS: STOPPING volumioStreaming Jul 10 21:15:51 volumio sudo[6070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jul 10 21:15:51 volumio sudo[6070]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Stopping cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:15:51 volumio systemd[1]: Stopping VolumioStreamingService... Jul 10 21:15:51 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Jul 10 21:15:51 volumio systemd[1]: volumioStreaming.service: Succeeded. Jul 10 21:15:51 volumio systemd[1]: Stopped VolumioStreamingService. Jul 10 21:15:51 volumio sudo[6073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/stream.m3u8 /tmp/hls/stream0.ts /tmp/hls/stream1.ts /tmp/hls/stream10.ts /tmp/hls/stream11.ts /tmp/hls/stream12.ts /tmp/hls/stream13.ts /tmp/hls/stream14.ts /tmp/hls/stream15.ts /tmp/hls/stream16.ts /tmp/hls/stream17.ts /tmp/hls/stream18.ts /tmp/hls/stream19.ts /tmp/hls/stream2.ts /tmp/hls/stream20.ts /tmp/hls/stream21.ts /tmp/hls/stream22.ts /tmp/hls/stream23.ts /tmp/hls/stream24.ts /tmp/hls/stream25.ts /tmp/hls/stream26.ts /tmp/hls/stream27.ts /tmp/hls/stream28.ts /tmp/hls/stream29.ts /tmp/hls/stream3.ts /tmp/hls/stream30.ts /tmp/hls/stream31.ts /tmp/hls/stream32.ts /tmp/hls/stream33.ts /tmp/hls/stream34.ts /tmp/hls/stream35.ts /tmp/hls/stream36.ts /tmp/hls/stream37.ts /tmp/hls/stream38.ts /tmp/hls/stream39.ts /tmp/hls/stream4.ts /tmp/hls/stream40.ts /tmp/hls/stream41.ts /tmp/hls/stream42.ts /tmp/hls/stream43.ts /tmp/hls/stream44.ts /tmp/hls/stream45.ts Jul 10 21:15:51 volumio sudo[6073]: volumio : (command continued) /tmp/hls/stream46.ts /tmp/hls/stream47.ts /tmp/hls/stream48.ts /tmp/hls/stream49.ts /tmp/hls/stream5.ts /tmp/hls/stream50.ts /tmp/hls/stream51.ts /tmp/hls/stream52.ts /tmp/hls/stream53.ts /tmp/hls/stream54.ts /tmp/hls/stream55.ts /tmp/hls/stream56.ts /tmp/hls/stream57.ts /tmp/hls/stream58.ts /tmp/hls/stream59.ts /tmp/hls/stream6.ts /tmp/hls/stream60.ts /tmp/hls/stream7.ts /tmp/hls/stream8.ts /tmp/hls/stream9.ts Jul 10 21:15:51 volumio sudo[6073]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio sudo[6070]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio sudo[6073]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Jul 10 21:15:51 volumio volumio[1151]: info: CoreCommandRouter::executeOnPlugin: multiroom , enableAudioOutput Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Starting cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Starting cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:15:51 volumio volumio[1151]: info: Enabled audio output: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:15:51 volumio volumio[1151]: info: Enabled audio output: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Setting this device as Streaming Server Jul 10 21:15:51 volumio volumio[1151]: info: Jul 10 21:15:51 volumio volumio[1151]: [1720638951468] ---------------------------- MRS: Setting Streaming Server Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Setting this device as Streaming Server Jul 10 21:15:51 volumio volumio[1151]: info: Jul 10 21:15:51 volumio volumio[1151]: [1720638951468] ---------------------------- MRS: Setting Streaming Server Jul 10 21:15:51 volumio volumio[1151]: info: MRS: enable multiroom server output Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioMultiRoom Jul 10 21:15:51 volumio volumio[1151]: info: MRS: enable multiroom server output Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioMultiRoom Jul 10 21:15:51 volumio volumio[1151]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Removed streaming files Jul 10 21:15:51 volumio volumio[1151]: info: MRS: volumioStreaming STOPPED Jul 10 21:15:51 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Jul 10 21:15:51 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/server/switch.target to volumioMultiRoom Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Set multiroom target PCM to volumioLocalPlayback Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jul 10 21:15:51 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Jul 10 21:15:51 volumio volumio[1151]: info: Changed audio target for /tmp/multiroom/client/switch.target to volumioLocalPlayback Jul 10 21:15:51 volumio volumio[1151]: info: MRS: STARTING volumioStreaming Jul 10 21:15:51 volumio sudo[6093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:15:51 volumio sudo[6093]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio sudo[6093]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio volumio[1151]: info: MRS: STARTING volumioStreaming Jul 10 21:15:51 volumio sudo[6096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Jul 10 21:15:51 volumio sudo[6096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio sudo[6100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:15:51 volumio sudo[6100]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio volumio[1151]: info: MRS: Connected to cast device: Chromecast-Audio-be38d027326ffc1d4b11fd10ede06542 Jul 10 21:15:51 volumio volumio[1151]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 21:15:51 volumio volumio[1151]: TypeError: Cannot read property 'launch' of null Jul 10 21:15:51 volumio volumio[1151]: at PlatformSender.launch (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:94:17) Jul 10 21:15:51 volumio volumio[1151]: at /myvolumio/plugins/audio_interface/multiroom/multiroom_real:1:29118 Jul 10 21:15:51 volumio volumio[1151]: at Client. (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2-client/lib/senders/platform.js:61:5) Jul 10 21:15:51 volumio volumio[1151]: at Object.onceWrapper (events.js:519:28) Jul 10 21:15:51 volumio volumio[1151]: at Client.emit (events.js:400:28) Jul 10 21:15:51 volumio volumio[1151]: at TLSSocket. (/myvolumio/plugins/audio_interface/multiroom/node_modules/castv2/lib/client.js:40:10) Jul 10 21:15:51 volumio volumio[1151]: at Object.onceWrapper (events.js:519:28) Jul 10 21:15:51 volumio volumio[1151]: at TLSSocket.emit (events.js:400:28) Jul 10 21:15:51 volumio volumio[1151]: at TLSSocket.onConnectSecure (_tls_wrap.js:1548:10) Jul 10 21:15:51 volumio volumio[1151]: at TLSSocket.emit (events.js:400:28) Jul 10 21:15:51 volumio volumio[1151]: at TLSSocket._finishInit (_tls_wrap.js:937:8) Jul 10 21:15:51 volumio volumio[1151]: at TLSWrap.ssl.onhandshakedone (_tls_wrap.js:709:12) Jul 10 21:15:51 volumio volumio[1151]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 10 21:15:51 volumio sudo[6100]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio systemd[1]: Started VolumioStreamingService. Jul 10 21:15:51 volumio sudo[6103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumioStreaming Jul 10 21:15:51 volumio sudo[6103]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio sudo[6096]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio sudo[6112]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:15:51 volumio sudo[6112]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio systemd[1]: Stopping VolumioStreamingService... Jul 10 21:15:51 volumio sudo[6112]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio systemd[1]: volumioStreaming.service: Main process exited, code=killed, status=15/TERM Jul 10 21:15:51 volumio systemd[1]: volumioStreaming.service: Succeeded. Jul 10 21:15:51 volumio systemd[1]: Stopped VolumioStreamingService. Jul 10 21:15:51 volumio systemd[1]: Started VolumioStreamingService. Jul 10 21:15:51 volumio sudo[6103]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio sudo[6115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jul 10 21:15:51 volumio sudo[6115]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 10 21:15:51 volumio sudo[6115]: pam_unix(sudo:session): session closed for user root Jul 10 21:15:51 volumio sudo[6119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-10 21:14 Jul 10 21:15:51 volumio sudo[6119]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"