-- Logs begin at Fri 2024-11-08 17:04:03 CET, end at Tue 2025-02-25 20:12:56 CET. -- Feb 25 20:11:03 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:03 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:03 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:03 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:03 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:03 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:18 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout Feb 25 20:11:18 rivo volumio[3470]: info: [MyVolumio PluginManager] Subscribed plan changed to free Feb 25 20:11:18 rivo volumio[3470]: info: MYVOLUMIO LOGGED OUT Feb 25 20:11:18 rivo volumio[3470]: info: Removing browser output: myVolumio user plan is not superstar Feb 25 20:11:18 rivo volumio[3470]: info: Removing audio output: Feb 25 20:11:18 rivo volumio[3470]: info: Stoppping Tunnel 1 Feb 25 20:11:18 rivo sudo[4576]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 25 20:11:18 rivo sudo[4576]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:18 rivo sudo[4576]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:18 rivo volumio[3470]: info: Remote SSH Stopped Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 20:11:20 rivo volumio[3470]: info: Received Get System Info Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:20 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:20 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:20 rivo volumio[3470]: info: MyVolumio not started Feb 25 20:11:20 rivo volumio[3470]: info: Initializing device activation check Feb 25 20:11:20 rivo volumio[3470]: info: MyVolumio not started Feb 25 20:11:20 rivo volumio[3470]: info: Initializing device activation check Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 20:11:20 rivo volumio[3470]: info: Received Get System Info Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:20 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:20 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:20 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:22 rivo sudo[4599]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 20:11:22 rivo sudo[4599]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:22 rivo sudo[4599]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:22 rivo sudo[4601]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 20:11:22 rivo sudo[4601]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:22 rivo sudo[4601]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:22 rivo volumio[3470]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.167 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 20:11:22 rivo sudo[4607]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 20:11:22 rivo sudo[4607]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 20:11:22 rivo sudo[4609]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 20:11:22 rivo sudo[4609]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:22 rivo sudo[4607]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:22 rivo sudo[4609]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:22 rivo volumio[3470]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.167 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:22 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 25 20:11:22 rivo volumio[3470]: info: Received Get System Info Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:22 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:22 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:22 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:22 rivo volumio[3470]: info: Listing playlists Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 20:11:22 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 20:11:24 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 25 20:11:24 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 20:11:24 rivo volumio[3470]: info: Received Get System Info Feb 25 20:11:24 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:24 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:24 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:24 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:24 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:24 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:32 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 20:11:33 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:33 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:33 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:33 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:33 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:33 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 20:11:35 rivo volumio[3470]: No protocol specified Feb 25 20:11:35 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 20:11:35 rivo volumio[3470]: No protocol specified Feb 25 20:11:35 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 25 20:11:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 20:11:40 rivo volumio[3470]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 20:11:40 rivo volumio[3470]: info: Received Get System Version Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 20:11:40 rivo volumio[3470]: info: Received Get System Info Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:11:40 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:40 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:40 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:11:50 rivo volumio[3470]: info: CALLMETHOD: audio_interface alsa_controller saveAlsaOptions [object Object] Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , saveAlsaOptions Feb 25 20:11:50 rivo volumio[3470]: info: Preparing to save Alsa Options, stopping services first Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:11:50 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::volumioPause Feb 25 20:11:50 rivo volumio[3470]: info: CoreStateMachine::pause Feb 25 20:11:50 rivo volumio[3470]: info: Saving Audio Output to: {"output_device":{"value":"5","label":"ADI-2 DAC (55780079)"}} Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: info: Setting default mixerSoftMaster for Softvolume device Feb 25 20:11:50 rivo vtcs[4128]: [2025-02-25 20:11:50.298] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Feb 25 20:11:50 rivo vtcs[4128]: [2025-02-25 20:11:50.299] [tisoc] [error] [SpkconServer.cpp:381] recv error. client fd=7 errorno=104 error=Connection reset by peer Feb 25 20:11:50 rivo vtcs[4128]: [2025-02-25 20:11:50.299] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected Feb 25 20:11:50 rivo sudo[4728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 20:11:50 rivo sudo[4728]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:50 rivo systemd[1]: Stopping Volumio Tidal Connect Service... Feb 25 20:11:50 rivo systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Feb 25 20:11:50 rivo systemd[1]: vtcs.service: Succeeded. Feb 25 20:11:50 rivo systemd[1]: Stopped Volumio Tidal Connect Service. Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::volumioUpdateVolumeSettings Feb 25 20:11:50 rivo volumio[3470]: info: Updating Volume Controller Parameters: Device: 5 Name: softvolume Mixer: SoftMaster Max Vol: 100 Vol Curve; logarithmic Vol Steps: 2 Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Feb 25 20:11:50 rivo volumio[3470]: info: Disabling external Volume Control Feb 25 20:11:50 rivo sudo[4728]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 20:11:50 rivo volumio[3470]: info: Enable softmixer device for audio device undefined Feb 25 20:11:50 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:50 rivo sudo[4740]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 20:11:50 rivo sudo[4740]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:50 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:50 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:50 rivo sudo[4740]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:50 rivo volumio[3470]: info: Software Volume ALSA configuration written Feb 25 20:11:50 rivo volumio[3470]: info: Preparing to generate the ALSA configuration file Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Feb 25 20:11:50 rivo volumio[3470]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Feb 25 20:11:50 rivo volumio[3470]: info: Reading ALSA contributions from plugins. Feb 25 20:11:50 rivo volumio[3470]: info: Asound.conf file written Feb 25 20:11:50 rivo sudo[4748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Feb 25 20:11:50 rivo sudo[4748]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:50 rivo sudo[4748]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:50 rivo kernel: Fine tdm clk setting range (0~2000000), 12287994 Feb 25 20:11:50 rivo kernel: Fine spdif sysclk setting range(0~2000000), 4644799 Feb 25 20:11:50 rivo kernel: out of value, fixed it Feb 25 20:11:50 rivo kernel: id=0 set inskew=0 Feb 25 20:11:50 rivo volumio[3470]: No protocol specified Feb 25 20:11:50 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:50 rivo volumio[3470]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:eARC_TX CDS:0' : Operation not permitted Feb 25 20:11:50 rivo volumio[3470]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:I2SIn CLK:0' : Operation not permitted Feb 25 20:11:50 rivo volumio[3470]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN audio samplerate:0' : Operation not permitted Feb 25 20:11:50 rivo volumio[3470]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:SPDIFIN Audio Type:0' : Operation not permitted Feb 25 20:11:50 rivo volumio[3470]: info: Output device has changed, restarting MPD Feb 25 20:11:50 rivo sudo[4753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 20:11:50 rivo volumio[3470]: info: Output device has changed, restarting Shairport Sync Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:50 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 20:11:50 rivo sudo[4753]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:50 rivo sudo[4753]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:50 rivo sudo[4756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 20:11:50 rivo sudo[4756]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo systemd[1]: Stopping Music Player Daemon... Feb 25 20:11:51 rivo volumio[3470]: No protocol specified Feb 25 20:11:51 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:51 rivo volumio[3470]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 20:11:51 rivo volumio[3470]: No protocol specified Feb 25 20:11:51 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo systemd[1]: mpd.service: Succeeded. Feb 25 20:11:51 rivo systemd[1]: Stopped Music Player Daemon. Feb 25 20:11:51 rivo volumio[3470]: info: Output device has changed, restarting MPD Feb 25 20:11:51 rivo systemd[1]: Starting Music Player Daemon... Feb 25 20:11:51 rivo sudo[4763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 20:11:51 rivo sudo[4763]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo volumio[3470]: info: Output device has changed, restarting Shairport Sync Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 20:11:51 rivo sudo[4774]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Feb 25 20:11:51 rivo sudo[4774]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo sudo[4774]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo sudo[4763]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo sudo[4777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Feb 25 20:11:51 rivo sudo[4777]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo volumio[3470]: No protocol specified Feb 25 20:11:51 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:51 rivo volumio[3470]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Feb 25 20:11:51 rivo volumio[3470]: No protocol specified Feb 25 20:11:51 rivo volumio[3470]: xcb_connection_has_error() returned true Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Feb 25 20:11:51 rivo systemd[1]: mpd.service: Succeeded. Feb 25 20:11:51 rivo systemd[1]: Stopped Music Player Daemon. Feb 25 20:11:51 rivo systemd[1]: Starting Music Player Daemon... Feb 25 20:11:51 rivo sudo[4784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 20:11:51 rivo sudo[4784]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo sudo[4788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 20:11:51 rivo sudo[4788]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo sudo[4784]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:51 rivo sudo[4791]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Feb 25 20:11:51 rivo sudo[4791]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 25 20:11:51 rivo sudo[4788]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:51 rivo volumio[3470]: info: MPD Permissions set Feb 25 20:11:51 rivo volumio[3470]: info: MPD Permissions set Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo sudo[4785]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Feb 25 20:11:51 rivo sudo[4785]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo sudo[4791]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo sudo[4785]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Feb 25 20:11:51 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:51 rivo volumio[3470]: info: Starting Shairport Sync Feb 25 20:11:51 rivo volumio[3470]: info: Starting Shairport Sync Feb 25 20:11:51 rivo sudo[4811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 20:11:51 rivo sudo[4811]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo sudo[4813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Feb 25 20:11:51 rivo sudo[4813]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:51 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 25 20:11:51 rivo systemd[1]: shairport-sync.service: Succeeded. Feb 25 20:11:51 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 25 20:11:51 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 25 20:11:51 rivo sudo[4811]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Feb 25 20:11:51 rivo systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Feb 25 20:11:51 rivo systemd[1]: shairport-sync.service: Succeeded. Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: running Feb 25 20:11:51 rivo volumio[3470]: info: Shairport-Sync Started Feb 25 20:11:51 rivo systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Feb 25 20:11:51 rivo volumio[3470]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Feb 25 20:11:51 rivo systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Feb 25 20:11:51 rivo sudo[4813]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:51 rivo volumio[3470]: info: Shairport-Sync Started Feb 25 20:11:53 rivo mpd[4801]: Feb 25 20:11 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Feb 25 20:11:53 rivo systemd[1]: Started Music Player Daemon. Feb 25 20:11:53 rivo sudo[4777]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:53 rivo sudo[4756]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:53 rivo volumio[3470]: error: MPD error: The expression evaluated to a falsy value: Feb 25 20:11:53 rivo volumio[3470]: assert.ok(self.idling) Feb 25 20:11:53 rivo volumio[3470]: error: The expression evaluated to a falsy value: Feb 25 20:11:53 rivo volumio[3470]: assert.ok(self.idling) Feb 25 20:11:53 rivo volumio[3470]: error: updateQueue error: null Feb 25 20:11:53 rivo volumio[3470]: info: TidalConnect service stoped! Feb 25 20:11:53 rivo volumio[3470]: info: TidalConnect service stoped! Feb 25 20:11:53 rivo volumio[3470]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 25 20:11:53 rivo volumio[3470]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 25 20:11:53 rivo sudo[4831]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 25 20:11:53 rivo sudo[4831]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:53 rivo systemd[1]: Started Volumio Tidal Connect Service. Feb 25 20:11:53 rivo sudo[4831]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:54 rivo volumio[3470]: info: Executing endpoint tc_getconfig Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Feb 25 20:11:54 rivo vtcs[4833]: STARTING TidalConnect services, version: 1.4.0.34 Feb 25 20:11:54 rivo volumio[3470]: info: TidalConnect service stoped! Feb 25 20:11:54 rivo vtcs[4833]: STARTED TidalConnect services. Feb 25 20:11:54 rivo volumio[3470]: info: Executing endpoint tc_connect Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Feb 25 20:11:54 rivo volumio[3470]: info: Connecting to TidalConnect Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::servicePushState Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Feb 25 20:11:54 rivo volumio[3470]: verbose: CURRENT POSITION 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::syncState stateService stop Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::syncState currentStatus stop Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: No code Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::servicePushState Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: verbose: STATE SERVICE {"status":"stop","service":"tidalconnect","title":"","artist":"","album":"","albumart":"/albumart","uri":"","icon":"fa fa-spinner","trackType":"tidal","codec":"","seek":0,"duration":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","bitrate":"","channels":2,"random":false,"repeat":false,"repeatSingle":false} Feb 25 20:11:54 rivo volumio[3470]: verbose: CURRENT POSITION 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::syncState stateService stop Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::syncState currentStatus stop Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: No code Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: TidalConnect service stoped! Feb 25 20:11:54 rivo volumio[3470]: info: TidalConnect service stoped! Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::getcurrentVolume Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 20:11:54 rivo volumio[3470]: info: TidalConnect service stoped! Feb 25 20:11:54 rivo volumio[3470]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 25 20:11:54 rivo volumio[3470]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::updateTrackBlock Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrackBlock Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioRetrievevolume Feb 25 20:11:54 rivo sudo[4875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 25 20:11:54 rivo sudo[4875]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:54 rivo sudo[4875]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:54 rivo volumio[3470]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Feb 25 20:11:54 rivo volumio[3470]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Feb 25 20:11:54 rivo volumio[3470]: info: CoreStateMachine::pushState Feb 25 20:11:54 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:11:54 rivo volumio[3470]: info: CoreCommandRouter::volumioPushState Feb 25 20:11:54 rivo sudo[4889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Feb 25 20:11:54 rivo sudo[4889]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:11:54 rivo sudo[4889]: pam_unix(sudo:session): session closed for user root Feb 25 20:11:55 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Feb 25 20:11:56 rivo volumio[3470]: info: TidalConnect service started! Feb 25 20:11:57 rivo volumio[3470]: info: TidalConnect service started! Feb 25 20:11:57 rivo volumio[3470]: info: TidalConnect service started! Feb 25 20:12:03 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:03 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:03 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:03 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:03 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:03 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:25 rivo sudo[4954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 20:12:25 rivo sudo[4954]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:25 rivo sudo[4954]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:25 rivo sudo[4956]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 20:12:25 rivo sudo[4956]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:25 rivo sudo[4956]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:25 rivo volumio[3470]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.167 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Feb 25 20:12:25 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 20:12:25 rivo sudo[4962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 20:12:25 rivo sudo[4962]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:25 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 20:12:25 rivo sudo[4962]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:25 rivo sudo[4965]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 20:12:25 rivo sudo[4965]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:25 rivo sudo[4965]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:25 rivo volumio[3470]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.167 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:26 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 25 20:12:26 rivo volumio[3470]: info: Received Get System Info Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:26 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:26 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:26 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:26 rivo volumio[3470]: info: Listing playlists Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 20:12:26 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 20:12:27 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 25 20:12:27 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 20:12:27 rivo volumio[3470]: info: Received Get System Info Feb 25 20:12:27 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:27 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:27 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:27 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:27 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:27 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:28 rivo volumio[3470]: info: CoreCommandRouter::volumioGetQueue Feb 25 20:12:28 rivo volumio[3470]: info: CoreStateMachine::getQueue Feb 25 20:12:28 rivo volumio[3470]: info: CorePlayQueue::getQueue Feb 25 20:12:33 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:33 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:33 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:33 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:33 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:33 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:35 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 20:12:37 rivo sudo[5032]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 20:12:37 rivo sudo[5032]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:37 rivo sudo[5032]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:37 rivo sudo[5035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 20:12:37 rivo sudo[5035]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:37 rivo sudo[5035]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:37 rivo volumio[3470]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.167 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 20:12:37 rivo sudo[5040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Feb 25 20:12:37 rivo sudo[5040]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:37 rivo sudo[5040]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:37 rivo sudo[5043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Feb 25 20:12:37 rivo sudo[5043]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 25 20:12:37 rivo sudo[5043]: pam_unix(sudo:session): session closed for user root Feb 25 20:12:37 rivo volumio[3470]: verbose: New Socket.io Connection to 192.168.1.115 from 192.168.1.167 UA: Mozilla/5.0 (Linux; Android 15; motorola edge 50 neo Build/V1UIS35H.11-39-10-1; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/132.0.6834.165 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:37 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 25 20:12:37 rivo volumio[3470]: info: Received Get System Info Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:37 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:37 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:37 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:37 rivo volumio[3470]: info: Listing playlists Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 20:12:37 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 20:12:39 rivo volumio[3470]: info: Received Get System Info Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:39 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:39 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:39 rivo volumio[3470]: info: CoreCommandRouter::volumioGetQueue Feb 25 20:12:39 rivo volumio[3470]: info: CoreStateMachine::getQueue Feb 25 20:12:39 rivo volumio[3470]: info: CorePlayQueue::getQueue Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 20:12:44 rivo volumio[3470]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Feb 25 20:12:44 rivo volumio[3470]: info: Received Get System Version Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Feb 25 20:12:44 rivo volumio[3470]: info: Received Get System Info Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 20:12:44 rivo volumio[3470]: info: Discovery: Getting this device information Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::volumioGetState Feb 25 20:12:44 rivo volumio[3470]: info: CorePlayQueue::getTrack 0 Feb 25 20:12:44 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 20:12:47 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 20:12:52 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 25 20:12:52 rivo volumio[3470]: info: Preload queue cleared Feb 25 20:12:55 rivo volumio[3470]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Feb 25 20:12:55 rivo volumio[3470]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 20:12:55 rivo volumio[3470]: TypeError: Cannot read property 'length' of undefined Feb 25 20:12:55 rivo volumio[3470]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Feb 25 20:12:55 rivo volumio[3470]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Feb 25 20:12:55 rivo volumio[3470]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Feb 25 20:12:55 rivo volumio[3470]: at Parser.emit (events.js:400:28) Feb 25 20:12:55 rivo volumio[3470]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Feb 25 20:12:55 rivo volumio[3470]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Feb 25 20:12:55 rivo volumio[3470]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Feb 25 20:12:55 rivo volumio[3470]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Feb 25 20:12:55 rivo volumio[3470]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Feb 25 20:12:55 rivo volumio[3470]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Feb 25 20:12:55 rivo volumio[3470]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Feb 25 20:12:55 rivo volumio[3470]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Feb 25 20:12:55 rivo volumio[3470]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Feb 25 20:12:55 rivo volumio[3470]: at IncomingMessage.emit (events.js:412:35) Feb 25 20:12:55 rivo volumio[3470]: at endReadableNT (internal/streams/readable.js:1333:12) Feb 25 20:12:55 rivo volumio[3470]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Feb 25 20:12:55 rivo volumio[3470]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 20:12:56 rivo sudo[5097]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-02-25 20:11 Feb 25 20:12:56 rivo sudo[5097]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 05:04:03 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b3e66dc85ea2c87aca7db72b97d00dff"