-- Logs begin at Sat 2025-06-07 22:43:20 CEST, end at Sun 2025-06-08 15:02:52 CEST. -- Jun 08 15:01:02 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:06 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:10 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:14 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:18 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:22 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:24 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:26 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:30 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:34 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:38 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:42 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:46 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:46 volumio volumio[1326]: info: [1749387706346] [RadioParadise] getMetadata started with url https://api.radioparadise.com/api/now_playing?chan=2 Jun 08 15:01:49 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Jun 08 15:01:49 volumio volumio[1326]: info: Adding a new share Jun 08 15:01:49 volumio volumio[1326]: info: No correspondence found in configuration for share Qnap on IP 198.168.178.0.2 Jun 08 15:01:49 volumio volumio[1326]: info: Executing SMB command: smbclient --debuglevel=4 -L 198.168.178.0.2 -N Jun 08 15:01:50 volumio volumio[1326]: info: Error browsing device Qnap for shares: Command failed: smbclient --debuglevel=4 -L 198.168.178.0.2 -N Jun 08 15:01:50 volumio volumio[1326]: lp_load_ex: refreshing parameters Jun 08 15:01:50 volumio volumio[1326]: Initialising global parameters Jun 08 15:01:50 volumio volumio[1326]: Processing section "[global]" Jun 08 15:01:50 volumio volumio[1326]: doing parameter netbios name = Volumio Jun 08 15:01:50 volumio volumio[1326]: doing parameter server string = Volumio Audiophile Music Player Jun 08 15:01:50 volumio volumio[1326]: doing parameter workgroup = WORKGROUP Jun 08 15:01:50 volumio volumio[1326]: doing parameter security = user Jun 08 15:01:50 volumio volumio[1326]: doing parameter map to guest = Bad User Jun 08 15:01:50 volumio volumio[1326]: doing parameter encrypt passwords = yes Jun 08 15:01:50 volumio volumio[1326]: doing parameter wins support = yes Jun 08 15:01:50 volumio volumio[1326]: doing parameter local master = no Jun 08 15:01:50 volumio volumio[1326]: doing parameter preferred master = no Jun 08 15:01:50 volumio volumio[1326]: doing parameter os level = 30 Jun 08 15:01:50 volumio volumio[1326]: doing parameter fruit:model = AirPort Jun 08 15:01:50 volumio volumio[1326]: pm_process() returned Yes Jun 08 15:01:50 volumio volumio[1326]: directory_create_or_exist_strict: invalid ownership on directory /var/run/samba/msg.lock Jun 08 15:01:50 volumio volumio[1326]: cmdline_messaging_context: Unable to initialize messaging context. Jun 08 15:01:50 volumio volumio[1326]: Unable to initialize messaging context Jun 08 15:01:50 volumio volumio[1326]: lp_load_ex: refreshing parameters Jun 08 15:01:50 volumio volumio[1326]: Initialising global parameters Jun 08 15:01:50 volumio volumio[1326]: Processing section "[global]" Jun 08 15:01:50 volumio volumio[1326]: doing parameter netbios name = Volumio Jun 08 15:01:50 volumio volumio[1326]: doing parameter server string = Volumio Audiophile Music Player Jun 08 15:01:50 volumio volumio[1326]: doing parameter workgroup = WORKGROUP Jun 08 15:01:50 volumio volumio[1326]: doing parameter security = user Jun 08 15:01:50 volumio volumio[1326]: doing parameter map to guest = Bad User Jun 08 15:01:50 volumio volumio[1326]: doing parameter encrypt passwords = yes Jun 08 15:01:50 volumio volumio[1326]: doing parameter wins support = yes Jun 08 15:01:50 volumio volumio[1326]: doing parameter local master = no Jun 08 15:01:50 volumio volumio[1326]: doing parameter preferred master = no Jun 08 15:01:50 volumio volumio[1326]: doing parameter os level = 30 Jun 08 15:01:50 volumio volumio[1326]: doing parameter fruit:model = AirPort Jun 08 15:01:50 volumio volumio[1326]: pm_process() returned Yes Jun 08 15:01:50 volumio volumio[1326]: added interface wlan0 ip=169.254.206.213 bcast=169.254.255.255 netmask=255.255.0.0 Jun 08 15:01:50 volumio volumio[1326]: added interface eth0 ip=192.168.178.3 bcast=192.168.178.255 netmask=255.255.255.0 Jun 08 15:01:50 volumio volumio[1326]: added interface wlan0 ip=192.168.211.1 bcast=192.168.211.255 netmask=255.255.255.0 Jun 08 15:01:50 volumio volumio[1326]: Client started (version 4.9.5-Debian). Jun 08 15:01:50 volumio volumio[1326]: tdb(/var/cache/samba/gencache.tdb): tdb_open_ex: could not open file /var/cache/samba/gencache.tdb: Permission denied Jun 08 15:01:50 volumio volumio[1326]: resolve_hosts: Attempting host lookup for name 198.168.178.0.2<0x20> Jun 08 15:01:50 volumio volumio[1326]: resolve_hosts: getaddrinfo failed for name 198.168.178.0.2 [Name or service not known] Jun 08 15:01:50 volumio volumio[1326]: do_connect: Connection to 198.168.178.0.2 failed (Error NT_STATUS_UNSUCCESSFUL) Jun 08 15:01:50 volumio volumio[1326]: info: Detected device Qnap with version null Jun 08 15:01:50 volumio sudo[13623]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Admin,password=lisina,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //198.168.178.0.2/Musica /mnt/NAS/Qnap Jun 08 15:01:50 volumio sudo[13623]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 15:01:50 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:50 volumio sudo[13623]: pam_unix(sudo:session): session closed for user root Jun 08 15:01:50 volumio volumio[1326]: info: Error mounting Qnap on IP 198.168.178.0.2 : : could not resolve address for 198.168.178.0.2: Unknown error Jun 08 15:01:51 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 08 15:01:52 volumio volumio[1326]: verbose: New Socket.io Connection to 192.168.178.3 from 192.168.178.37 UA: Mozilla/5.0 (Linux; Android 10; K) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/137.0.0.0 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 08 15:01:52 volumio volumio[1326]: info: CoreCommandRouter::volumioGetState Jun 08 15:01:52 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:52 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 08 15:01:52 volumio volumio[1326]: info: Listing playlists Jun 08 15:01:52 volumio volumio[1326]: info: CoreCommandRouter::volumioGetVisibleSources Jun 08 15:01:52 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 08 15:01:52 volumio volumio[1326]: info: CoreCommandRouter::volumioGetQueue Jun 08 15:01:52 volumio volumio[1326]: info: CoreStateMachine::getQueue Jun 08 15:01:52 volumio volumio[1326]: info: CorePlayQueue::getQueue Jun 08 15:01:54 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:01:57 volumio volumio[1326]: info: [1749387717142] [RadioParadise] received new metadata: {"time":449,"artist":"Tom Petty and the Heartbreakers","title":"Breakdown (Live)","album":"The Live Anthology","year":"2009","cover":"https://img.radioparadise.com/covers/l/B002P4VUNU.jpg","cover_med":"https://img.radioparadise.com/covers/m/B002P4VUNU.jpg","cover_small":"https://img.radioparadise.com/covers/s/B002P4VUNU.jpg"} Jun 08 15:01:57 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:57 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:01:57 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:57 volumio volumio[1326]: verbose: STATE SERVICE {"status":"play","service":"radio_paradise","type":"webradio","trackType":"flac","radioType":"rparadise","albumart":"https://img.radioparadise.com/covers/l/B002P4VUNU.jpg","uri":"https://stream.radioparadise.com/rock-flac","name":"Breakdown (Live)","title":"Breakdown (Live)","artist":"Tom Petty and the Heartbreakers","album":"The Live Anthology","streaming":true,"disableUiControls":true,"duration":454,"seek":0,"samplerate":"44.1 KHz","bitdepth":"16 bit","channels":2} Jun 08 15:01:57 volumio volumio[1326]: verbose: CURRENT POSITION 0 Jun 08 15:01:57 volumio volumio[1326]: info: CoreStateMachine::syncState stateService play Jun 08 15:01:57 volumio volumio[1326]: info: CoreStateMachine::syncState currentStatus play Jun 08 15:01:57 volumio volumio[1326]: info: Received an update from plugin. extracting info from payload Jun 08 15:01:57 volumio volumio[1326]: info: CoreStateMachine::pushState Jun 08 15:01:57 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:57 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 08 15:01:57 volumio volumio[1326]: info: CoreCommandRouter::volumioPushState Jun 08 15:01:57 volumio volumio[1326]: info: CoreStateMachine::pushState Jun 08 15:01:57 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:57 volumio volumio[1326]: info: CoreCommandRouter::volumioPushState Jun 08 15:01:57 volumio volumio[1326]: info: [1749387717156] [RadioParadise] setting new timer with duration of 454000 seconds. Jun 08 15:01:57 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:57 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:01:57 volumio volumio[1326]: info: Prefetching next song Jun 08 15:01:58 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:00 volumio volumio[1326]: info: Disabling MyMusic plugin airplay_emulation Jun 08 15:02:00 volumio volumio[1326]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Jun 08 15:02:00 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 08 15:02:00 volumio volumio[1326]: Cannot find translation for source Radio Paradise Jun 08 15:02:00 volumio volumio[1326]: info: Disabling plugin airplay_emulation Jun 08 15:02:00 volumio volumio[1326]: info: Done. Jun 08 15:02:00 volumio sudo[13647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Jun 08 15:02:00 volumio sudo[13647]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 15:02:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 08 15:02:00 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 08 15:02:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 08 15:02:00 volumio sudo[13647]: pam_unix(sudo:session): session closed for user root Jun 08 15:02:00 volumio volumio[1326]: info: Shairport-Sync Stopped Jun 08 15:02:02 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:06 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:07 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand rescan Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: info: Jun 08 15:02:07 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand rescan took 4 milliseconds Jun 08 15:02:07 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: info: Jun 08 15:02:07 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:07 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: info: Jun 08 15:02:07 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:07 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: info: Jun 08 15:02:07 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand status took 9 milliseconds Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:07 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:07 volumio volumio[1326]: info: sendMpdCommand status took 5 milliseconds Jun 08 15:02:07 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: info: Command Router : Notfying DB Updatetrue Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:08 volumio volumio[1326]: info: Jun 08 15:02:08 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:08 volumio volumio[1326]: info: Jun 08 15:02:08 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand status took 292 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand status took 290 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 99 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 57 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand status took 5 milliseconds Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:08 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:08 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:08 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:08 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:08 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:08 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:08 volumio volumio[1326]: info: ------------------------------ 440ms Jun 08 15:02:08 volumio volumio[1326]: info: ------------------------------ 437ms Jun 08 15:02:08 volumio volumio[1326]: info: ------------------------------ 436ms Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 100 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 57 milliseconds Jun 08 15:02:08 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:08 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:08 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:08 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:08 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:08 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:08 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:08 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:08 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:08 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:08 volumio volumio[1326]: info: ------------------------------ 448ms Jun 08 15:02:08 volumio volumio[1326]: info: ------------------------------ 162ms Jun 08 15:02:08 volumio volumio[1326]: info: ------------------------------ 161ms Jun 08 15:02:10 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:10 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand update Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: info: Jun 08 15:02:10 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:10 volumio volumio[1326]: info: sendMpdCommand update took 4 milliseconds Jun 08 15:02:10 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: info: Jun 08 15:02:10 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:10 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: info: Jun 08 15:02:10 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:10 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: info: Jun 08 15:02:10 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:10 volumio volumio[1326]: info: sendMpdCommand status took 9 milliseconds Jun 08 15:02:10 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:10 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:10 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:10 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:10 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:10 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: info: Command Router : Notfying DB Updatetrue Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: Jun 08 15:02:11 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: Jun 08 15:02:11 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 145 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 145 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 143 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 98 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:11 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:11 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:11 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:11 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:11 volumio volumio[1326]: info: ------------------------------ 263ms Jun 08 15:02:11 volumio volumio[1326]: info: ------------------------------ 260ms Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 119 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 118 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 114 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 71 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:11 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:11 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:11 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:11 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:11 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:11 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:11 volumio volumio[1326]: info: ------------------------------ 322ms Jun 08 15:02:11 volumio volumio[1326]: info: ------------------------------ 320ms Jun 08 15:02:11 volumio volumio[1326]: info: ------------------------------ 182ms Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:11 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:11 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:11 volumio volumio[1326]: info: ------------------------------ 182ms Jun 08 15:02:11 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand update Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: Jun 08 15:02:11 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand update took 4 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: Jun 08 15:02:11 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: Jun 08 15:02:11 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: Jun 08 15:02:11 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 9 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 8 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:11 volumio volumio[1326]: info: sendMpdCommand status took 6 milliseconds Jun 08 15:02:11 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: info: Command Router : Notfying DB Updatetrue Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:12 volumio volumio[1326]: info: Jun 08 15:02:12 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 141 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 139 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 138 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 93 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 52 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 5 milliseconds Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:12 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:12 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:12 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:12 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:12 volumio volumio[1326]: info: ------------------------------ 241ms Jun 08 15:02:12 volumio volumio[1326]: info: ------------------------------ 239ms Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:12 volumio volumio[1326]: info: Jun 08 15:02:12 volumio volumio[1326]: ---------------------------- MPD announces state update: update Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::getState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand status Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 103 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 100 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 56 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand status took 7 milliseconds Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: info: Command Router : Notfying DB Updatefalse Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::Close All Modals sent Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseState Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:12 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:12 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:12 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:12 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:12 volumio volumio[1326]: info: ------------------------------ 303ms Jun 08 15:02:12 volumio volumio[1326]: info: ------------------------------ 300ms Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 59 milliseconds Jun 08 15:02:12 volumio volumio[1326]: info: sendMpdCommand playlistinfo took 7 milliseconds Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:12 volumio volumio[1326]: verbose: ControllerMpd::parseTrackInfo Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:12 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:12 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:12 volumio volumio[1326]: info: ControllerMpd::pushState Jun 08 15:02:12 volumio volumio[1326]: info: CoreCommandRouter::servicePushState Jun 08 15:02:12 volumio volumio[1326]: info: CorePlayQueue::getTrack 0 Jun 08 15:02:12 volumio volumio[1326]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Jun 08 15:02:12 volumio volumio[1326]: info: ------------------------------ 168ms Jun 08 15:02:12 volumio volumio[1326]: info: ------------------------------ 70ms Jun 08 15:02:14 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:18 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:19 volumio volumio[1326]: info: Disabling MyMusic plugin upnp Jun 08 15:02:19 volumio sudo[13759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 08 15:02:19 volumio sudo[13759]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 15:02:19 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Jun 08 15:02:19 volumio volumio[1326]: error: Upnp client error: Error: This socket has been ended by the other party Jun 08 15:02:20 volumio volumio[1326]: info: Disabling MyMusic plugin upnp_browser Jun 08 15:02:20 volumio volumio[1326]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesServer multimediali Jun 08 15:02:20 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 08 15:02:20 volumio volumio[1326]: Cannot find translation for source Radio Paradise Jun 08 15:02:20 volumio volumio[1326]: info: Disabling plugin upnp_browser Jun 08 15:02:20 volumio volumio[1326]: info: Done. Jun 08 15:02:22 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:26 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:30 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:31 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jun 08 15:02:31 volumio volumio[1326]: info: Share Qnap successfully unmounted Jun 08 15:02:31 volumio sudo[13794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 198.168.178.0.2:Musica /mnt/NAS/Qnap Jun 08 15:02:31 volumio sudo[13794]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 15:02:34 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:37 volumio volumio[1326]: info: Disabling MyMusic plugin upnp Jun 08 15:02:37 volumio sudo[13798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jun 08 15:02:37 volumio sudo[13798]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 15:02:38 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:39 volumio sudo[13794]: pam_unix(sudo:session): session closed for user root Jun 08 15:02:39 volumio volumio[1326]: info: An error occurred mounting the new share. Rolling back configuration Jun 08 15:02:40 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 08 15:02:42 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:46 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:50 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 08 15:02:50 volumio volumio[1326]: info: Enabling MyMusic plugin upnp Jun 08 15:02:50 volumio volumio[1326]: info: Enabling plugin upnp Jun 08 15:02:50 volumio volumio[1326]: info: Loading plugin "upnp"... Jun 08 15:02:50 volumio volumio[1326]: info: [1749387770842] Starting Upmpd Daemon Jun 08 15:02:50 volumio volumio[1326]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 08 15:02:50 volumio volumio[1326]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 15:02:50 volumio volumio[1326]: Error: listen EADDRINUSE: address already in use :::6599 Jun 08 15:02:50 volumio volumio[1326]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Jun 08 15:02:50 volumio volumio[1326]: at listenInCluster (net.js:1366:12) Jun 08 15:02:50 volumio volumio[1326]: at Server.listen (net.js:1452:7) Jun 08 15:02:50 volumio volumio[1326]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jun 08 15:02:50 volumio volumio[1326]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jun 08 15:02:50 volumio volumio[1326]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jun 08 15:02:50 volumio volumio[1326]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jun 08 15:02:50 volumio volumio[1326]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Jun 08 15:02:50 volumio volumio[1326]: code: 'EADDRINUSE', Jun 08 15:02:50 volumio volumio[1326]: errno: -98, Jun 08 15:02:50 volumio volumio[1326]: syscall: 'listen', Jun 08 15:02:50 volumio volumio[1326]: address: '::', Jun 08 15:02:50 volumio volumio[1326]: port: 6599 Jun 08 15:02:50 volumio volumio[1326]: } Jun 08 15:02:50 volumio volumio[1326]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 15:02:52 volumio sudo[13844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-08 15:01 Jun 08 15:02:52 volumio sudo[13844]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="9ab87de061b3649c303da550e73c92d340b0f989" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 30 Apr 2025 11:47:57 AM CEST" VOLUMIO_VERSION="3.807" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fddd10196af80fdc784c726185a6abe4"