-- Logs begin at Wed 2024-04-03 19:29:42 +07, end at Thu 2024-04-04 12:37:06 +07. -- Apr 04 12:36:03 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:04 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:05 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:06 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:15 volumio kernel: usb 1-1.4: new high-speed USB device number 3 using xhci_hcd Apr 04 12:36:15 volumio kernel: usb 1-1.4: New USB device found, idVendor=16d0, idProduct=071a, bcdDevice= 1.96 Apr 04 12:36:15 volumio kernel: usb 1-1.4: New USB device strings: Mfr=1, Product=2, SerialNumber=3 Apr 04 12:36:15 volumio kernel: usb 1-1.4: Product: Combo384 Amanero Apr 04 12:36:15 volumio kernel: usb 1-1.4: Manufacturer: Amanero Technologies Apr 04 12:36:15 volumio kernel: usb 1-1.4: SerialNumber: 413-001 Apr 04 12:36:15 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 04 12:36:15 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 2, val = -32767/0/1 Apr 04 12:36:15 volumio kernel: usb 1-1.4: Warning! Unlikely big volume range (=32767), cval->res is probably wrong. Apr 04 12:36:15 volumio kernel: usb 1-1.4: [10] FU [PCM Playback Volume] ch = 1, val = -32767/0/1 Apr 04 12:36:15 volumio kernel: usbcore: registered new interface driver snd-usb-audio Apr 04 12:36:16 volumio volumio[959]: info: Apr 04 12:36:16 volumio volumio[959]: ---------------------------- USB Audio Device Attached Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::Close All Modals sent Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 04 12:36:16 volumio volumio[959]: info: Setting mixer PCM for card Combo384 Amanero Apr 04 12:36:16 volumio vtcs[1328]: [2024-04-04 12:36:16.184] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE Apr 04 12:36:16 volumio vtcs[1328]: [2024-04-04 12:36:16.184] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected Apr 04 12:36:16 volumio sudo[1513]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 04 12:36:16 volumio sudo[1513]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 04 12:36:16 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 04 12:36:16 volumio systemd[1]: vtcs.service: Succeeded. Apr 04 12:36:16 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::volumioUpdateVolumeSettings Apr 04 12:36:16 volumio sudo[1513]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:16 volumio volumio[959]: info: Updating Volume Controller Parameters: Device: 5 Name: Combo384 Amanero Mixer: PCM Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume Apr 04 12:36:16 volumio volumio[959]: info: Disabling external Volume Control Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:36:16 volumio volumio[959]: info: Preparing to generate the ALSA configuration file Apr 04 12:36:16 volumio sudo[1520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 04 12:36:16 volumio sudo[1520]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio volumio[959]: info: Asound.conf file unchanged, so no further update is needed Apr 04 12:36:16 volumio volumio[959]: info: Output device has changed, restarting MPD Apr 04 12:36:16 volumio sudo[1520]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:16 volumio sudo[1525]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 04 12:36:16 volumio sudo[1525]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio volumio[959]: info: Output device has changed, restarting Shairport Sync Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 04 12:36:16 volumio sudo[1525]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:16 volumio sudo[1527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 04 12:36:16 volumio sudo[1527]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio systemd[1]: Stopping Music Player Daemon... Apr 04 12:36:16 volumio volumio[959]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 04 12:36:16 volumio sudo[1534]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 04 12:36:16 volumio sudo[1534]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio sudo[1536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 04 12:36:16 volumio sudo[1536]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio systemd[1]: mpd.service: Succeeded. Apr 04 12:36:16 volumio systemd[1]: Stopped Music Player Daemon. Apr 04 12:36:16 volumio sudo[1534]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 04 12:36:16 volumio sudo[1536]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 04 12:36:16 volumio volumio[959]: info: MPD Permissions set Apr 04 12:36:16 volumio volumio[959]: info: VolumeController:: Volume=100 Mute =false Apr 04 12:36:16 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:16 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio systemd[1]: Starting Music Player Daemon... Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 04 12:36:16 volumio volumio[959]: info: Starting Shairport Sync Apr 04 12:36:16 volumio sudo[1551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 04 12:36:16 volumio sudo[1551]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 04 12:36:16 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 04 12:36:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 04 12:36:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 04 12:36:16 volumio sudo[1551]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:16 volumio volumio[959]: info: Shairport-Sync Started Apr 04 12:36:16 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat Apr 04 12:36:17 volumio sudo[1557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 04 12:36:17 volumio sudo[1557]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:17 volumio sudo[1557]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:17 volumio sudo[1559]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 04 12:36:17 volumio sudo[1559]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:17 volumio sudo[1559]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:17 volumio volumio[959]: verbose: New Socket.io Connection to 192.168.1.246 from 192.168.1.245 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Edg/123.0.0.0 Total Clients: 5 Apr 04 12:36:17 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:17 volumio mpd[1543]: Apr 04 12:36 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 04 12:36:17 volumio systemd[1]: Started Music Player Daemon. Apr 04 12:36:17 volumio sudo[1527]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:17 volumio volumio[959]: error: updateQueue error: null Apr 04 12:36:17 volumio sudo[1565]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 04 12:36:17 volumio sudo[1565]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:17 volumio sudo[1565]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:17 volumio sudo[1567]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 04 12:36:17 volumio sudo[1567]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:17 volumio sudo[1567]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:17 volumio volumio[959]: verbose: New Socket.io Connection to 192.168.1.246 from 192.168.1.245 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/123.0.0.0 Safari/537.36 Edg/123.0.0.0 Total Clients: 6 Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Apr 04 12:36:17 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::volumioGetVisibleSources Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 04 12:36:17 volumio volumio[959]: info: Listing playlists Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 04 12:36:17 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 04 12:36:18 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:19 volumio volumio[959]: info: TidalConnect service stoped! Apr 04 12:36:19 volumio volumio[959]: info: TidalConnect service stoped! Apr 04 12:36:19 volumio volumio[959]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 04 12:36:19 volumio volumio[959]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 04 12:36:19 volumio sudo[1579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 04 12:36:19 volumio sudo[1579]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:19 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 04 12:36:19 volumio sudo[1579]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:19 volumio volumio[959]: info: TidalConnect service stoped! Apr 04 12:36:19 volumio volumio[959]: info: TidalConnect service stoped! Apr 04 12:36:19 volumio volumio[959]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 04 12:36:19 volumio volumio[959]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 04 12:36:19 volumio sudo[1593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 04 12:36:19 volumio sudo[1593]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:36:19 volumio sudo[1593]: pam_unix(sudo:session): session closed for user root Apr 04 12:36:19 volumio volumio[959]: info: Executing endpoint tc_getconfig Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 04 12:36:19 volumio vtcs[1581]: STARTING TidalConnect services, version: 1.3.0.19 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 04 12:36:19 volumio vtcs[1581]: STARTED TidalConnect services. Apr 04 12:36:19 volumio volumio[959]: info: Executing endpoint tc_connect Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 04 12:36:19 volumio volumio[959]: info: Connecting to TidalConnect Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::servicePushState Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: 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} Apr 04 12:36:19 volumio volumio[959]: verbose: CURRENT POSITION 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::syncState stateService stop Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::syncState currentStatus stop Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:19 volumio volumio[959]: info: No code Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::servicePushState Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: 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} Apr 04 12:36:19 volumio volumio[959]: verbose: CURRENT POSITION 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::syncState stateService stop Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::syncState currentStatus stop Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:19 volumio volumio[959]: info: No code Apr 04 12:36:19 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:19 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:19 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:20 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:20 volumio volumio[959]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Apr 04 12:36:20 volumio volumio[959]: info: CoreStateMachine::getcurrentVolume Apr 04 12:36:20 volumio volumio[959]: info: CoreCommandRouter::volumioRetrievevolume Apr 04 12:36:20 volumio volumio[959]: info: VolumeController:: Volume=100 Mute =false Apr 04 12:36:20 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:20 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:20 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:20 volumio volumio[959]: info: CoreStateMachine::updateTrackBlock Apr 04 12:36:20 volumio volumio[959]: info: CorePlayQueue::getTrackBlock Apr 04 12:36:20 volumio volumio[959]: info: CoreCommandRouter::volumioRetrievevolume Apr 04 12:36:20 volumio volumio[959]: info: VolumeController:: Volume=100 Mute =false Apr 04 12:36:20 volumio volumio[959]: info: CoreStateMachine::pushState Apr 04 12:36:20 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:20 volumio volumio[959]: info: CoreCommandRouter::volumioPushState Apr 04 12:36:21 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:22 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:22 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:22 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 04 12:36:22 volumio volumio[959]: info: TidalConnect service started! Apr 04 12:36:22 volumio volumio[959]: info: TidalConnect service started! Apr 04 12:36:24 volumio ntpd[704]: Soliciting pool server 2001:da8:9000::81 Apr 04 12:36:32 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:34 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:35 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:37 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 04 12:36:38 volumio volumio[959]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 04 12:36:38 volumio volumio[959]: info: Received Get System Version Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 04 12:36:38 volumio volumio[959]: info: Received Get System Info Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 04 12:36:38 volumio volumio[959]: info: Discovery: Getting this device information Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::volumioGetState Apr 04 12:36:38 volumio volumio[959]: info: CorePlayQueue::getTrack 0 Apr 04 12:36:38 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 04 12:36:52 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:53 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:54 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:56 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:36:57 volumio wpa_supplicant[842]: RRM: Ignoring radio measurement request: Not RRM network Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:37:02 volumio volumio[959]: info: Retrieving Cloud Streaming UI Apr 04 12:37:02 volumio volumio[959]: info: Getting Tidal Cloud Configuration Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:37:02 volumio volumio[959]: info: Getting Qobuz Cloud Configuration Apr 04 12:37:02 volumio volumio[959]: info: Asking plugin for UI Config Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:37:02 volumio volumio[959]: info: Getting Spotify Cloud Configuration Apr 04 12:37:02 volumio volumio[959]: info: Asking plugin for UI Config Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:37:02 volumio volumio[959]: info: Saving Spotify Acccount Apr 04 12:37:02 volumio volumio[959]: info: Got it Apr 04 12:37:02 volumio volumio[959]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 04 12:37:02 volumio volumio[959]: info: Got Tidal Cloud Configuration Apr 04 12:37:02 volumio volumio[959]: info: Got it Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 04 12:37:02 volumio volumio[959]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::volumioGetBrowseSources Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::volumioGetBrowseSources Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::volumioGetBrowseSources Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 04 12:37:02 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 04 12:37:03 volumio volumio[959]: info: Disabling MyMusic plugin upnp Apr 04 12:37:03 volumio sudo[1658]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Apr 04 12:37:03 volumio sudo[1658]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 04 12:37:03 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Apr 04 12:37:03 volumio volumio[959]: error: Upnp client error: Error: This socket has been ended by the other party Apr 04 12:37:06 volumio volumio[959]: info: Enabling MyMusic plugin upnp Apr 04 12:37:06 volumio volumio[959]: info: Enabling plugin upnp Apr 04 12:37:06 volumio volumio[959]: info: Loading plugin "upnp"... Apr 04 12:37:06 volumio volumio[959]: info: [1712209026377] Starting Upmpd Daemon Apr 04 12:37:06 volumio volumio[959]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 04 12:37:06 volumio volumio[959]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 04 12:37:06 volumio volumio[959]: Error: listen EADDRINUSE: address already in use :::6599 Apr 04 12:37:06 volumio volumio[959]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Apr 04 12:37:06 volumio volumio[959]: at listenInCluster (net.js:1366:12) Apr 04 12:37:06 volumio volumio[959]: at Server.listen (net.js:1452:7) Apr 04 12:37:06 volumio volumio[959]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Apr 04 12:37:06 volumio volumio[959]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Apr 04 12:37:06 volumio volumio[959]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Apr 04 12:37:06 volumio volumio[959]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Apr 04 12:37:06 volumio volumio[959]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Apr 04 12:37:06 volumio volumio[959]: code: 'EADDRINUSE', Apr 04 12:37:06 volumio volumio[959]: errno: -98, Apr 04 12:37:06 volumio volumio[959]: syscall: 'listen', Apr 04 12:37:06 volumio volumio[959]: address: '::', Apr 04 12:37:06 volumio volumio[959]: port: 6599 Apr 04 12:37:06 volumio volumio[959]: } Apr 04 12:37:06 volumio volumio[959]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 04 12:37:06 volumio sudo[1670]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-04 12:36 Apr 04 12:37:06 volumio sudo[1670]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="2b7a7c18d8591801cb9a773fe2f236fe4cb50d69" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 27 Feb 2024 10:33:17 AM CET" VOLUMIO_VERSION="3.632" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="0277bfc84aeeec6af8f081972462eb10"