-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2024-05-07 21:22:42 CEST. -- May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:05 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:05 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:05 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: unknown Total Clients: 4 May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:05 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 07 21:21:05 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 07 21:21:07 volumio sudo[24665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 21:21:07 volumio sudo[24665]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:07 volumio sudo[24665]: pam_unix(sudo:session): session closed for user root May 07 21:21:07 volumio sudo[24668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 21:21:07 volumio sudo[24668]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:08 volumio sudo[24668]: pam_unix(sudo:session): session closed for user root May 07 21:21:08 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::volumioGetVisibleSources May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:08 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 21:21:08 volumio volumio[616]: info: Received Get System Info May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:08 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:08 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:08 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:08 volumio volumio[616]: info: Listing playlists May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 21:21:08 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 21:21:09 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:21:09 volumio volumio[616]: info: Received Get System Info May 07 21:21:09 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:09 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:09 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:09 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:09 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:09 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:10 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:21:11 volumio volumio[616]: info: Received Get System Info May 07 21:21:11 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:11 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:11 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:11 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:11 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:11 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:11 volumio volumio[616]: info: CoreCommandRouter::volumioGetQueue May 07 21:21:11 volumio volumio[616]: info: CoreStateMachine::getQueue May 07 21:21:11 volumio volumio[616]: info: CorePlayQueue::getQueue May 07 21:21:14 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 07 21:21:14 volumio volumio[616]: info: CURURI: music-library/NAS/Muzyka_NAS/My/!nieznane/Oded Tzur - Here Be Dragons (2020, ECM) May 07 21:21:16 volumio volumio[616]: info: Preload queue cleared May 07 21:21:16 volumio volumio[616]: info: CoreCommandRouter::volumioReplaceandPlayItems May 07 21:21:16 volumio volumio[616]: info: CoreStateMachine::ClearQueue May 07 21:21:16 volumio volumio[616]: info: CoreStateMachine::stop May 07 21:21:16 volumio volumio[616]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 21:21:16 volumio volumio[616]: info: CorePlayQueue::clearPlayQueue May 07 21:21:16 volumio volumio[616]: info: CorePlayQueue::saveQueue May 07 21:21:16 volumio volumio[616]: info: CoreCommandRouter::volumioPushQueue May 07 21:21:16 volumio volumio[616]: info: CoreStateMachine::addQueueItems May 07 21:21:16 volumio volumio[616]: info: CorePlayQueue::addQueueItems May 07 21:21:16 volumio volumio[616]: info: Preload queue cleared May 07 21:21:16 volumio volumio[616]: info: Adding Item to queue: music-library/NAS/Muzyka_NAS/My/!nieznane/Oded Tzur - Here Be Dragons (2020, ECM) May 07 21:21:16 volumio volumio[616]: info: Exploding uri music-library/NAS/Muzyka_NAS/My/!nieznane/Oded Tzur - Here Be Dragons (2020, ECM) in service mpd May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 21:21:26 volumio volumio[616]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 07 21:21:26 volumio volumio[616]: info: Received Get System Version May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 07 21:21:26 volumio volumio[616]: info: Received Get System Info May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:26 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:26 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:33 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:33 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:33 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: unknown Total Clients: 4 May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:33 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 07 21:21:33 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 07 21:21:39 volumio kernel: usb 1-1.2.1: USB disconnect, device number 6 May 07 21:21:39 volumio volumio[616]: info: May 07 21:21:39 volumio volumio[616]: ---------------------------- USB Audio Device Detached May 07 21:21:39 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioDetach May 07 21:21:39 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 21:21:39 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: raat , onStop May 07 21:21:43 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:44 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:44 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:44 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: unknown Total Clients: 4 May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:44 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 07 21:21:44 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 07 21:21:47 volumio sudo[24682]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 21:21:47 volumio sudo[24682]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:47 volumio sudo[24682]: pam_unix(sudo:session): session closed for user root May 07 21:21:47 volumio sudo[24685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 21:21:47 volumio sudo[24685]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:47 volumio sudo[24685]: pam_unix(sudo:session): session closed for user root May 07 21:21:47 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::volumioGetVisibleSources May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:47 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 21:21:47 volumio volumio[616]: info: Received Get System Info May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:47 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:47 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:47 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:47 volumio volumio[616]: info: Listing playlists May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 21:21:47 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 21:21:48 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:21:49 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:21:49 volumio volumio[616]: info: Received Get System Info May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:49 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:49 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::volumioGetQueue May 07 21:21:49 volumio volumio[616]: info: CoreStateMachine::getQueue May 07 21:21:49 volumio volumio[616]: info: CorePlayQueue::getQueue May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:21:49 volumio volumio[616]: info: Received Get System Info May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:21:49 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:21:49 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:49 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:21:51 volumio volumio[616]: info: Preload queue cleared May 07 21:21:51 volumio volumio[616]: info: CoreCommandRouter::volumioReplaceandPlayItems May 07 21:21:51 volumio volumio[616]: info: CoreStateMachine::ClearQueue May 07 21:21:51 volumio volumio[616]: info: CoreStateMachine::stop May 07 21:21:51 volumio volumio[616]: info: CoreStateMachine::setConsumeUpdateService undefined May 07 21:21:51 volumio volumio[616]: info: CorePlayQueue::clearPlayQueue May 07 21:21:51 volumio volumio[616]: info: CorePlayQueue::saveQueue May 07 21:21:51 volumio volumio[616]: info: CoreCommandRouter::volumioPushQueue May 07 21:21:51 volumio volumio[616]: info: CoreStateMachine::addQueueItems May 07 21:21:51 volumio volumio[616]: info: CorePlayQueue::addQueueItems May 07 21:21:51 volumio volumio[616]: info: Preload queue cleared May 07 21:21:51 volumio volumio[616]: info: Adding Item to queue: music-library/NAS/Muzyka_NAS/My/!nieznane/01 - Art Ensemble of Chicago - Nice Guys (1979) May 07 21:21:51 volumio volumio[616]: info: Exploding uri music-library/NAS/Muzyka_NAS/My/!nieznane/01 - Art Ensemble of Chicago - Nice Guys (1979) in service mpd May 07 21:21:54 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:21:54 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:21:56 volumio kernel: usb 1-1.2.1: new high-speed USB device number 7 using dwc_otg May 07 21:21:56 volumio kernel: usb 1-1.2.1: New USB device found, idVendor=20b1, idProduct=2023, bcdDevice= 3.95 May 07 21:21:56 volumio kernel: usb 1-1.2.1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 May 07 21:21:56 volumio kernel: usb 1-1.2.1: Product: JLsounds Hi-Rez Audio 2.0 May 07 21:21:56 volumio kernel: usb 1-1.2.1: Manufacturer: JLsounds May 07 21:21:56 volumio kernel: usb 1-1.2.1: 1:3 : unsupported format bits 0x100000000 May 07 21:21:56 volumio volumio[616]: info: May 07 21:21:56 volumio volumio[616]: ---------------------------- USB Audio Device Attached May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , usbAudioAttach May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::Close All Modals sent May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 21:21:56 volumio volumio[616]: info: Device 5 does not have any Mixer Control Available May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::volumioUpdateVolumeSettings May 07 21:21:56 volumio volumio[616]: info: Updating Volume Controller Parameters: Device: 5 Name: JLsounds Hi-Rez Audio 2.0 Mixer: Max Vol: 100 Vol Curve; logarithmic Vol Steps: 1 May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , setExternalVolume May 07 21:21:56 volumio volumio[616]: info: Disabling external Volume Control May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:21:56 volumio volumio[616]: info: CoreStateMachine::pushState May 07 21:21:56 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::volumioPushState May 07 21:21:56 volumio volumio[616]: info: Preparing to generate the ALSA configuration file May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 21:21:56 volumio volumio[616]: info: Asound.conf file unchanged, so no further update is needed May 07 21:21:56 volumio volumio[616]: info: Output device has changed, restarting MPD May 07 21:21:56 volumio sudo[24712]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 07 21:21:56 volumio sudo[24712]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:56 volumio sudo[24712]: pam_unix(sudo:session): session closed for user root May 07 21:21:56 volumio volumio[616]: info: Output device has changed, restarting Shairport Sync May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:56 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:21:56 volumio sudo[24715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 07 21:21:56 volumio sudo[24715]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:56 volumio volumio[616]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 07 21:21:57 volumio volumio[616]: info: MPD Permissions set May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 07 21:21:57 volumio volumio[616]: info: Starting Shairport Sync May 07 21:21:57 volumio sudo[24725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 07 21:21:57 volumio sudo[24725]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:21:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 07 21:21:57 volumio systemd[1]: shairport-sync.service: Succeeded. May 07 21:21:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 07 21:21:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 07 21:21:57 volumio sudo[24725]: pam_unix(sudo:session): session closed for user root May 07 21:21:57 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: raat , restartRaat May 07 21:21:57 volumio volumio[616]: info: Shairport-Sync Started May 07 21:21:59 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:21:59 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:00 volumio volumio[616]: info: CoreCommandRouter::volumioRetrieveVolumeLevels May 07 21:22:00 volumio volumio[616]: info: CoreStateMachine::getcurrentVolume May 07 21:22:00 volumio volumio[616]: info: CoreCommandRouter::volumioRetrievevolume May 07 21:22:00 volumio volumio[616]: info: CoreStateMachine::pushState May 07 21:22:00 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:00 volumio volumio[616]: info: CoreCommandRouter::volumioPushState May 07 21:22:04 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:09 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:09 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:14 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:14 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:17 volumio systemd[1]: mpd.service: State 'stop-sigterm' timed out. Killing. May 07 21:22:17 volumio systemd[1]: mpd.service: Killing process 852 (mpd) with signal SIGKILL. May 07 21:22:17 volumio volumio[616]: error: Upnp client error: Error: read ECONNRESET May 07 21:22:17 volumio volumio[616]: error: MPD error: Error: read ECONNRESET May 07 21:22:17 volumio volumio[616]: error: read ECONNRESET {"errno":-104,"code":"ECONNRESET","syscall":"read"} May 07 21:22:17 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=9/KILL May 07 21:22:17 volumio systemd[1]: mpd.service: Failed with result 'timeout'. May 07 21:22:17 volumio systemd[1]: Stopped Music Player Daemon. May 07 21:22:17 volumio systemd[1]: Starting Music Player Daemon... May 07 21:22:18 volumio mpd[24742]: May 07 21:22 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 07 21:22:19 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:21 volumio mpd[24742]: May 07 21:22 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured May 07 21:22:21 volumio mpd[24742]: May 07 21:22 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured May 07 21:22:21 volumio systemd[1]: Started Music Player Daemon. May 07 21:22:21 volumio sudo[24715]: pam_unix(sudo:session): session closed for user root May 07 21:22:21 volumio sudo[24626]: pam_unix(sudo:session): session closed for user root May 07 21:22:22 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:22 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:22 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:22 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:22 volumio volumio[616]: error: MPD error: The expression evaluated to a falsy value: May 07 21:22:22 volumio volumio[616]: assert.ok(self.idling) May 07 21:22:22 volumio volumio[616]: error: The expression evaluated to a falsy value: May 07 21:22:22 volumio volumio[616]: assert.ok(self.idling) May 07 21:22:22 volumio volumio[616]: error: updateQueue error: null May 07 21:22:22 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:23 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:23 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:22:23 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:22:23 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:22:23 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:22:23 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:23 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:22:23 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 5 May 07 21:22:23 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:24 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:24 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:24 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:24 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:24 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:25 volumio sudo[24756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 07 21:22:25 volumio sudo[24756]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:22:25 volumio sudo[24756]: pam_unix(sudo:session): session closed for user root May 07 21:22:25 volumio sudo[24759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 07 21:22:25 volumio sudo[24759]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:22:25 volumio sudo[24759]: pam_unix(sudo:session): session closed for user root May 07 21:22:25 volumio volumio[616]: verbose: New Socket.io Connection to 192.168.0.20 from 192.168.0.2 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_4_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 6 May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::volumioGetVisibleSources May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:22:25 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::volumioGetQueue May 07 21:22:25 volumio volumio[616]: info: CoreStateMachine::getQueue May 07 21:22:25 volumio volumio[616]: info: CorePlayQueue::getQueue May 07 21:22:25 volumio volumio[616]: info: Listing playlists May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 07 21:22:25 volumio volumio[616]: info: Received Get System Info May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:22:25 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:22:25 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:22:25 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 07 21:22:25 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 07 21:22:26 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 07 21:22:26 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:27 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:27 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:22:27 volumio volumio[616]: info: Received Get System Info May 07 21:22:27 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:22:27 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:22:27 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:22:27 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:22:27 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:27 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:22:28 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:28 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 07 21:22:28 volumio volumio[616]: info: Received Get System Info May 07 21:22:28 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 07 21:22:28 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 07 21:22:28 volumio volumio[616]: info: Discovery: Getting this device information May 07 21:22:28 volumio volumio[616]: info: CoreCommandRouter::volumioGetState May 07 21:22:28 volumio volumio[616]: info: CorePlayQueue::getTrack 0 May 07 21:22:28 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 07 21:22:29 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:29 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:29 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:30 volumio volumio[616]: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:22:32 volumio volumio[616]: info: Retrieving Cloud Streaming UI May 07 21:22:32 volumio volumio[616]: info: Getting Tidal Cloud Configuration May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:22:32 volumio volumio[616]: info: Getting Qobuz Cloud Configuration May 07 21:22:32 volumio volumio[616]: info: Asking plugin for UI Config May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:22:32 volumio volumio[616]: info: Getting Spotify Cloud Configuration May 07 21:22:32 volumio volumio[616]: info: Asking plugin for UI Config May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:22:32 volumio volumio[616]: info: Saving Spotify Acccount May 07 21:22:32 volumio volumio[616]: info: Got Tidal Cloud Configuration May 07 21:22:32 volumio volumio[616]: info: Got it May 07 21:22:32 volumio volumio[616]: info: Got it May 07 21:22:32 volumio volumio[616]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::getUIConfigOnPlugin May 07 21:22:32 volumio volumio[616]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::volumioGetBrowseSources May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:22:32 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 07 21:22:35 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:35 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:35 volumio volumio[616]: info: Disabling MyMusic plugin upnp May 07 21:22:35 volumio sudo[24788]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 07 21:22:35 volumio sudo[24788]: pam_unix(sudo:session): session opened for user root by (uid=0) May 07 21:22:35 volumio volumio[616]: error: Upnp client error: Error: This socket has been ended by the other party May 07 21:22:35 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... May 07 21:22:36 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:22:40 volumio volumio[616]: error: Upnp client error: Error: connect ETIMEDOUT 127.0.0.1:6600 May 07 21:22:40 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 07 21:22:42 volumio volumio[616]: info: Enabling MyMusic plugin upnp May 07 21:22:42 volumio volumio[616]: info: Enabling plugin upnp May 07 21:22:42 volumio volumio[616]: info: Loading plugin "upnp"... May 07 21:22:42 volumio volumio[616]: info: [1715109762161] Starting Upmpd Daemon May 07 21:22:42 volumio volumio[616]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 07 21:22:42 volumio volumio[616]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 21:22:42 volumio volumio[616]: Error: listen EADDRINUSE: address already in use :::6599 May 07 21:22:42 volumio volumio[616]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) May 07 21:22:42 volumio volumio[616]: at listenInCluster (net.js:1366:12) May 07 21:22:42 volumio volumio[616]: at Server.listen (net.js:1452:7) May 07 21:22:42 volumio volumio[616]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 07 21:22:42 volumio volumio[616]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 07 21:22:42 volumio volumio[616]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 07 21:22:42 volumio volumio[616]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 07 21:22:42 volumio volumio[616]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 07 21:22:42 volumio volumio[616]: code: 'EADDRINUSE', May 07 21:22:42 volumio volumio[616]: errno: -98, May 07 21:22:42 volumio volumio[616]: syscall: 'listen', May 07 21:22:42 volumio volumio[616]: address: '::', May 07 21:22:42 volumio volumio[616]: port: 6599 May 07 21:22:42 volumio volumio[616]: } May 07 21:22:42 volumio volumio[616]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 07 21:22:42 volumio sudo[24812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-07 21:21 May 07 21:22:42 volumio sudo[24812]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"