-- Logs begin at Thu 2019-02-14 12:12:00 EET, end at Fri 2024-05-03 19:08:31 EEST. -- May 03 19:07:00 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonation May 03 19:07:00 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 03 19:07:00 raspivolumio volumio[633]: xcb_connection_has_error() returned true May 03 19:07:00 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: wizard , getDonationsArray May 03 19:07:00 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: wizard , getDoneMessage May 03 19:07:00 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_volumio , detectVolumioHardware May 03 19:07:00 raspivolumio volumio[633]: xcb_connection_has_error() returned true May 03 19:07:09 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: wizard , setWizardAction May 03 19:07:09 raspivolumio volumio[633]: info: CoreCommandRouter::Reload Ui May 03 19:07:09 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , setShowWizard May 03 19:07:09 raspivolumio volumio[633]: info: Wizard terminated Successfully May 03 19:07:09 raspivolumio volumio[633]: info: CoreCommandRouter::volumiosetStartupVolume May 03 19:07:09 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:07:11 raspivolumio sudo[2199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 03 19:07:11 raspivolumio sudo[2199]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:07:11 raspivolumio sudo[2199]: pam_unix(sudo:session): session closed for user root May 03 19:07:11 raspivolumio sudo[2201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 03 19:07:11 raspivolumio sudo[2201]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:07:11 raspivolumio sudo[2201]: pam_unix(sudo:session): session closed for user root May 03 19:07:11 raspivolumio volumio[633]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.105 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:126.0) Gecko/20100101 Firefox/126.0 Total Clients: 7 May 03 19:07:11 raspivolumio sudo[2207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 03 19:07:11 raspivolumio sudo[2207]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:07:11 raspivolumio sudo[2207]: pam_unix(sudo:session): session closed for user root May 03 19:07:11 raspivolumio sudo[2209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 03 19:07:11 raspivolumio sudo[2209]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:07:11 raspivolumio sudo[2209]: pam_unix(sudo:session): session closed for user root May 03 19:07:11 raspivolumio volumio[633]: verbose: New Socket.io Connection to 192.168.1.120 from 192.168.1.105 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:126.0) Gecko/20100101 Firefox/126.0 Total Clients: 8 May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetVisibleSources May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:12 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 03 19:07:12 raspivolumio volumio[633]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom May 03 19:07:12 raspivolumio volumio[633]: info: Received Get System Info May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 03 19:07:12 raspivolumio volumio[633]: info: Discovery: Getting this device information May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:12 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:12 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:12 raspivolumio volumio[633]: info: Listing playlists May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache May 03 19:07:12 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:12 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:13 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 03 19:07:13 raspivolumio volumio[633]: info: Received Get System Info May 03 19:07:13 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 03 19:07:13 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 03 19:07:13 raspivolumio volumio[633]: info: Discovery: Getting this device information May 03 19:07:13 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:13 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:13 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::Close All Modals sent May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , setTOSAccepted May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 03 19:07:14 raspivolumio volumio[633]: info: Received Get System Info May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 03 19:07:14 raspivolumio volumio[633]: info: Discovery: Getting this device information May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:14 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:14 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 03 19:07:22 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 19:07:23 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 19:07:23 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 19:07:23 raspivolumio volumio[633]: info: Received Get System Version May 03 19:07:23 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 03 19:07:29 raspivolumio volumio[633]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 03 19:07:29 raspivolumio volumio[633]: info: Received Get System Version May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 03 19:07:29 raspivolumio volumio[633]: info: Received Get System Info May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 03 19:07:29 raspivolumio volumio[633]: info: Discovery: Getting this device information May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:29 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 03 19:07:34 raspivolumio ntpd[593]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 03 19:07:43 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:43 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:45 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:45 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 19:07:45 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 19:07:45 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam May 03 19:07:45 raspivolumio volumio[633]: info: Received Get System Version May 03 19:07:45 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 03 19:07:48 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetState May 03 19:07:48 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:49 raspivolumio volumio[633]: info: Retrieving Cloud Streaming UI May 03 19:07:49 raspivolumio volumio[633]: info: Getting Tidal Cloud Configuration May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:49 raspivolumio volumio[633]: info: Getting Qobuz Cloud Configuration May 03 19:07:49 raspivolumio volumio[633]: info: Asking plugin for UI Config May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:49 raspivolumio volumio[633]: info: Getting Spotify Cloud Configuration May 03 19:07:49 raspivolumio volumio[633]: info: Asking plugin for UI Config May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:49 raspivolumio volumio[633]: info: Saving Spotify Acccount May 03 19:07:49 raspivolumio volumio[633]: info: Got it May 03 19:07:49 raspivolumio volumio[633]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 03 19:07:49 raspivolumio volumio[633]: info: Got Tidal Cloud Configuration May 03 19:07:49 raspivolumio volumio[633]: info: Got it May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::getUIConfigOnPlugin May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetBrowseSources May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetBrowseSources May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::volumioGetBrowseSources May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:07:49 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 03 19:07:53 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:07:57 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:01 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:05 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:09 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:13 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:15 raspivolumio volumio[633]: info: Disabling MyMusic plugin cd_controller May 03 19:08:15 raspivolumio volumio[633]: info: [MyVolumio PluginManager] Disabling and stopping plugin music_service cd_controller May 03 19:08:15 raspivolumio volumio[633]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD May 03 19:08:15 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 19:08:15 raspivolumio volumio[633]: info: Stopping UDEV Watcher for CD May 03 19:08:15 raspivolumio volumio[633]: info: Disabling plugin cd_controller May 03 19:08:17 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:21 raspivolumio volumio[633]: info: Disabling MyMusic plugin multiroom May 03 19:08:21 raspivolumio volumio[633]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface multiroom May 03 19:08:21 raspivolumio volumio[633]: info: Disabling plugin multiroom May 03 19:08:21 raspivolumio volumio[633]: info: Preparing to generate the ALSA configuration file May 03 19:08:21 raspivolumio volumio[633]: info: Asound.conf file written May 03 19:08:21 raspivolumio sudo[2287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf May 03 19:08:21 raspivolumio sudo[2287]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:21 raspivolumio sudo[2287]: pam_unix(sudo:session): session closed for user root May 03 19:08:21 raspivolumio volumio[633]: xcb_connection_has_error() returned true May 03 19:08:21 raspivolumio volumio[633]: No state is present for card b1 May 03 19:08:21 raspivolumio volumio[633]: /usr/share/alsa/init/bcm2835:14: control element not found May 03 19:08:21 raspivolumio volumio[633]: No state is present for card b1 May 03 19:08:21 raspivolumio volumio[633]: No state is present for card Headphones May 03 19:08:21 raspivolumio volumio[633]: /usr/share/alsa/init/bcm2835:20: control element not found May 03 19:08:21 raspivolumio volumio[633]: No state is present for card Headphones May 03 19:08:21 raspivolumio volumio[633]: info: Output device has changed, restarting MPD May 03 19:08:21 raspivolumio volumio[633]: info: Output device has changed, restarting Shairport Sync May 03 19:08:21 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:21 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 19:08:21 raspivolumio sudo[2292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 03 19:08:21 raspivolumio sudo[2292]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:21 raspivolumio sudo[2292]: pam_unix(sudo:session): session closed for user root May 03 19:08:21 raspivolumio sudo[2294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 03 19:08:21 raspivolumio sudo[2294]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:22 raspivolumio systemd[1]: Stopping Music Player Daemon... May 03 19:08:22 raspivolumio volumio[633]: xcb_connection_has_error() returned true May 03 19:08:22 raspivolumio volumio[633]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 03 19:08:22 raspivolumio volumio[633]: xcb_connection_has_error() returned true May 03 19:08:22 raspivolumio volumio[633]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio systemd[1]: mpd.service: Succeeded. May 03 19:08:22 raspivolumio systemd[1]: Stopped Music Player Daemon. May 03 19:08:22 raspivolumio vtcs[2141]: [2024-05-03 19:08:22.126] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE May 03 19:08:22 raspivolumio vtcs[2141]: [2024-05-03 19:08:22.126] [tisoc] [error] [SpkconServer.cpp:376] recv error. socket disconnected May 03 19:08:22 raspivolumio systemd[1]: Starting Music Player Daemon... May 03 19:08:22 raspivolumio sudo[2304]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 03 19:08:22 raspivolumio sudo[2304]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:22 raspivolumio sudo[2307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service May 03 19:08:22 raspivolumio sudo[2307]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:22 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:22 raspivolumio systemd[1]: Stopping Volumio Tidal Connect Service... May 03 19:08:22 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 03 19:08:22 raspivolumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM May 03 19:08:22 raspivolumio systemd[1]: vtcs.service: Succeeded. May 03 19:08:22 raspivolumio systemd[1]: Stopped Volumio Tidal Connect Service. May 03 19:08:22 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:22 raspivolumio sudo[2304]: pam_unix(sudo:session): session closed for user root May 03 19:08:22 raspivolumio volumio[633]: info: MPD Permissions set May 03 19:08:22 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:22 raspivolumio sudo[2307]: pam_unix(sudo:session): session closed for user root May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 03 19:08:22 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:22 raspivolumio volumio[633]: error: MPD error: Error: This socket has been ended by the other party May 03 19:08:22 raspivolumio volumio[633]: error: This socket has been ended by the other party {"code":"EPIPE"} May 03 19:08:22 raspivolumio volumio[633]: error: MPD error: Error: This socket has been ended by the other party May 03 19:08:22 raspivolumio volumio[633]: error: This socket has been ended by the other party {"code":"EPIPE"} May 03 19:08:22 raspivolumio volumio[633]: error: MPD error: Error: This socket has been ended by the other party May 03 19:08:22 raspivolumio volumio[633]: error: This socket has been ended by the other party {"code":"EPIPE"} May 03 19:08:22 raspivolumio volumio[633]: info: Starting Shairport Sync May 03 19:08:22 raspivolumio volumio[633]: info: Disabling MyMusic plugin bluetooth May 03 19:08:22 raspivolumio volumio[633]: info: [MyVolumio PluginManager] Disabling and stopping plugin audio_interface bluetooth May 03 19:08:22 raspivolumio sudo[2316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 03 19:08:22 raspivolumio sudo[2316]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:22 raspivolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 03 19:08:22 raspivolumio systemd[1]: shairport-sync.service: Succeeded. May 03 19:08:22 raspivolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 03 19:08:22 raspivolumio sudo[2319]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service May 03 19:08:22 raspivolumio sudo[2319]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:22 raspivolumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 03 19:08:22 raspivolumio sudo[2316]: pam_unix(sudo:session): session closed for user root May 03 19:08:22 raspivolumio systemd[1]: Stopping Volumio Bluetooth Module... May 03 19:08:22 raspivolumio volumiobt[2322]: Killing pulse May 03 19:08:22 raspivolumio volumiobt[2322]: Killing BT Pair agent May 03 19:08:22 raspivolumio volumiobt[1827]: Terminated May 03 19:08:22 raspivolumio systemd[1]: volumiobt.service: Main process exited, code=killed, status=15/TERM May 03 19:08:22 raspivolumio systemd[1]: volumiobt.service: Succeeded. May 03 19:08:22 raspivolumio systemd[1]: Stopped Volumio Bluetooth Module. May 03 19:08:22 raspivolumio sudo[2319]: pam_unix(sudo:session): session closed for user root May 03 19:08:23 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:23 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: waiting May 03 19:08:23 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:23 raspivolumio volumio[633]: info: Volumio BT Module successfully stopped May 03 19:08:23 raspivolumio volumio[633]: info: Disabling plugin bluetooth May 03 19:08:23 raspivolumio volumio[633]: info: Shairport-Sync Started May 03 19:08:24 raspivolumio mpd[2301]: May 03 19:08 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 03 19:08:24 raspivolumio systemd[1]: Started Music Player Daemon. May 03 19:08:24 raspivolumio sudo[2294]: pam_unix(sudo:session): session closed for user root May 03 19:08:24 raspivolumio volumio[633]: error: updateQueue error: null May 03 19:08:25 raspivolumio volumio[633]: info: Disabling MyMusic plugin upnp_browser May 03 19:08:25 raspivolumio volumio[633]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesMedia Servers May 03 19:08:25 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 19:08:25 raspivolumio volumio[633]: info: Disabling plugin upnp_browser May 03 19:08:25 raspivolumio volumio[633]: info: Done. May 03 19:08:25 raspivolumio volumio[633]: info: TidalConnect service stoped! May 03 19:08:25 raspivolumio volumio[633]: info: TidalConnect service stoped! May 03 19:08:25 raspivolumio volumio[633]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect May 03 19:08:25 raspivolumio volumio[633]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect May 03 19:08:25 raspivolumio sudo[2339]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service May 03 19:08:25 raspivolumio sudo[2339]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:25 raspivolumio volumio[633]: info: Disabling MyMusic plugin airplay_emulation May 03 19:08:25 raspivolumio volumio[633]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync May 03 19:08:25 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 03 19:08:25 raspivolumio volumio[633]: info: Disabling plugin airplay_emulation May 03 19:08:25 raspivolumio volumio[633]: info: Done. May 03 19:08:25 raspivolumio sudo[2342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync May 03 19:08:25 raspivolumio systemd[1]: Started Volumio Tidal Connect Service. May 03 19:08:25 raspivolumio sudo[2342]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:25 raspivolumio sudo[2339]: pam_unix(sudo:session): session closed for user root May 03 19:08:25 raspivolumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 03 19:08:25 raspivolumio systemd[1]: shairport-sync.service: Succeeded. May 03 19:08:25 raspivolumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 03 19:08:25 raspivolumio sudo[2342]: pam_unix(sudo:session): session closed for user root May 03 19:08:25 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:25 raspivolumio volumio[633]: info: Shairport-Sync Stopped May 03 19:08:25 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 03 19:08:26 raspivolumio volumio[633]: info: Disabling MyMusic plugin upnp May 03 19:08:26 raspivolumio sudo[2348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 03 19:08:26 raspivolumio sudo[2348]: pam_unix(sudo:session): session opened for user root by (uid=0) May 03 19:08:26 raspivolumio systemd[1]: Stopping UPnP Renderer front-end to MPD... May 03 19:08:26 raspivolumio volumio[633]: error: Upnp client error: Error: This socket has been ended by the other party May 03 19:08:26 raspivolumio volumio[633]: ------------------------------------ BT MESSAGE: BT STATUS: running May 03 19:08:26 raspivolumio volumio[633]: info: Executing endpoint tc_getconfig May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig May 03 19:08:26 raspivolumio vtcs[2343]: STARTING TidalConnect services, version: 1.4.0.34 May 03 19:08:26 raspivolumio vtcs[2343]: STARTED TidalConnect services. May 03 19:08:26 raspivolumio volumio[633]: info: Executing endpoint tc_connect May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect May 03 19:08:26 raspivolumio volumio[633]: info: Connecting to TidalConnect May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::servicePushState May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::pushState May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::volumioPushState May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output update for this device May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: 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} May 03 19:08:26 raspivolumio volumio[633]: verbose: CURRENT POSITION 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::syncState stateService stop May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::syncState currentStatus stop May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::pushState May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::volumioPushState May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output update for this device May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output May 03 19:08:26 raspivolumio volumio[633]: info: No code May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::pushState May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::volumioPushState May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output update for this device May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::servicePushState May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::pushState May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::volumioPushState May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output update for this device May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: 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} May 03 19:08:26 raspivolumio volumio[633]: verbose: CURRENT POSITION 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::syncState stateService stop May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::syncState currentStatus stop May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::pushState May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::volumioPushState May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output update for this device May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output May 03 19:08:26 raspivolumio volumio[633]: info: No code May 03 19:08:26 raspivolumio volumio[633]: info: CoreStateMachine::pushState May 03 19:08:26 raspivolumio volumio[633]: info: CorePlayQueue::getTrack 0 May 03 19:08:26 raspivolumio volumio[633]: info: CoreCommandRouter::volumioPushState May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output update for this device May 03 19:08:26 raspivolumio volumio[633]: info: MRS: Pushing multiroomSync output May 03 19:08:28 raspivolumio volumio[633]: info: TidalConnect service started! May 03 19:08:29 raspivolumio volumio[633]: info: Enabling MyMusic plugin upnp May 03 19:08:29 raspivolumio volumio[633]: info: Enabling plugin upnp May 03 19:08:29 raspivolumio volumio[633]: info: Loading plugin "upnp"... May 03 19:08:29 raspivolumio volumio[633]: info: [1714752509809] Starting Upmpd Daemon May 03 19:08:29 raspivolumio volumio[633]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 03 19:08:29 raspivolumio volumio[633]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 19:08:29 raspivolumio volumio[633]: Error: listen EADDRINUSE: address already in use :::6599 May 03 19:08:29 raspivolumio volumio[633]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) May 03 19:08:29 raspivolumio volumio[633]: at listenInCluster (net.js:1366:12) May 03 19:08:29 raspivolumio volumio[633]: at Server.listen (net.js:1452:7) May 03 19:08:29 raspivolumio volumio[633]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 03 19:08:29 raspivolumio volumio[633]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 03 19:08:29 raspivolumio volumio[633]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 03 19:08:29 raspivolumio volumio[633]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 03 19:08:29 raspivolumio volumio[633]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 03 19:08:29 raspivolumio volumio[633]: code: 'EADDRINUSE', May 03 19:08:29 raspivolumio volumio[633]: errno: -98, May 03 19:08:29 raspivolumio volumio[633]: syscall: 'listen', May 03 19:08:29 raspivolumio volumio[633]: address: '::', May 03 19:08:29 raspivolumio volumio[633]: port: 6599 May 03 19:08:29 raspivolumio volumio[633]: } May 03 19:08:29 raspivolumio volumio[633]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 03 19:08:31 raspivolumio sudo[2375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-03 19:07 May 03 19:08:31 raspivolumio sudo[2375]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"