-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Tue 2024-11-26 12:31:22 CET. -- Nov 26 12:30:03 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:06 volumiopi3 dhcpcd[904]: eth0: deleting route to 192.168.40.0/24 Nov 26 12:30:06 volumiopi3 dhcpcd[904]: eth0: deleting default route via 192.168.40.244 Nov 26 12:30:06 volumiopi3 dhcpcd[1001]: eth0: pid 904 deleted route to 192.168.40.0/24 Nov 26 12:30:06 volumiopi3 dhcpcd[1001]: eth0: pid 904 deleted default route via 192.168.40.244 Nov 26 12:30:07 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:11 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:15 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:17 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Nov 26 12:30:17 volumiopi3 volumio[1085]: info: Adding a new share Nov 26 12:30:17 volumiopi3 volumio[1085]: info: No correspondence found in configuration for share NasMusique on IP 192.168.40.250 Nov 26 12:30:17 volumiopi3 sudo[14047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.40.250/Espace2\\Mes_Musiques /mnt/NAS/NasMusique Nov 26 12:30:17 volumiopi3 sudo[14047]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 12:30:17 volumiopi3 kernel: Key type cifs.spnego registered Nov 26 12:30:17 volumiopi3 kernel: Key type cifs.idmap registered Nov 26 12:30:17 volumiopi3 kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Nov 26 12:30:17 volumiopi3 kernel: CIFS: Attempting to mount \\192.168.40.250\Espace2 Nov 26 12:30:17 volumiopi3 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Nov 26 12:30:17 volumiopi3 sudo[14047]: pam_unix(sudo:session): session closed for user root Nov 26 12:30:17 volumiopi3 volumio[1085]: info: Permission denied for NasMusique on IP 192.168.40.250 Nov 26 12:30:18 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 26 12:30:19 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:23 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:27 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Nov 26 12:30:27 volumiopi3 volumio[1085]: info: Share NasMusique successfully unmounted Nov 26 12:30:27 volumiopi3 sudo[14100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Guppy,password=pasvois,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.40.250/Espace2\\Mes_Musiques /mnt/NAS/NasMusique Nov 26 12:30:27 volumiopi3 sudo[14100]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 26 12:30:27 volumiopi3 kernel: CIFS: Attempting to mount \\192.168.40.250\Espace2 Nov 26 12:30:27 volumiopi3 sudo[14100]: pam_unix(sudo:session): session closed for user root Nov 26 12:30:27 volumiopi3 kernel: CIFS: Status code returned 0xc000006d STATUS_LOGON_FAILURE Nov 26 12:30:27 volumiopi3 kernel: CIFS: VFS: \\192.168.40.250 Send error in SessSetup = -13 Nov 26 12:30:27 volumiopi3 kernel: CIFS: VFS: cifs_mount failed w/return code = -13 Nov 26 12:30:27 volumiopi3 volumio[1085]: info: An error occurred mounting the new share. Rolling back configuration Nov 26 12:30:27 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:31 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:35 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand update Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Nov 26 12:30:37 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand update took 7 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Nov 26 12:30:37 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Nov 26 12:30:37 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 12 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 7 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 6 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 5 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 4 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 3 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatetrue Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatetrue Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatetrue Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Nov 26 12:30:37 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 60 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 34 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100228106,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100228106,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100228106,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":true,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ------------------------------ 169ms Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ------------------------------ 163ms Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ------------------------------ 162ms Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Nov 26 12:30:37 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Nov 26 12:30:37 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 63 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 62 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 13 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 12 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 12 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand status took 10 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 58 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 32 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 5 milliseconds Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100228232,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100228358,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100228358,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:37 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:37 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ------------------------------ 184ms Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ------------------------------ 135ms Nov 26 12:30:37 volumiopi3 volumio[1085]: info: ------------------------------ 132ms Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand rescan Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Nov 26 12:30:39 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand rescan took 3 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Nov 26 12:30:39 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 4 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 3 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Nov 26 12:30:39 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Nov 26 12:30:39 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 36 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 36 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 7 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 5 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 5 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 4 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 3 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100230353,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ------------------------------ 142ms Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Nov 26 12:30:39 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Nov 26 12:30:39 volumiopi3 volumio[1085]: ---------------------------- MPD announces state update: update Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::getState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand status Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 80 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 51 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 24 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 9 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 8 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 7 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand status took 6 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Command Router : Notfying DB Updatefalse Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::Close All Modals sent Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseState Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100230353,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100230353,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100230353,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ------------------------------ 235ms Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ------------------------------ 204ms Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ------------------------------ 203ms Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 59 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: info: sendMpdCommand playlistinfo took 33 milliseconds Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: ControllerMpd::parseTrackInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100230479,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ControllerMpd::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::servicePushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: STATE SERVICE {"status":"play","position":0,"seek":100230479,"duration":0,"samplerate":"48 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"fip-midfi.mp3?ID=76zqey582k","artist":"fip-midfi.mp3","album":null,"uri":"http://direct.fipradio.fr/live/fip-midfi.mp3?ID=76zqey582k","trackType":""} Nov 26 12:30:39 volumiopi3 volumio[1085]: verbose: CURRENT POSITION 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState stateService play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::syncState currentStatus play Nov 26 12:30:39 volumiopi3 volumio[1085]: info: Received an update from plugin. extracting info from payload Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CorePlayQueue::getTrack 0 Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreStateMachine::pushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::volumioPushState Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ------------------------------ 116ms Nov 26 12:30:39 volumiopi3 volumio[1085]: info: ------------------------------ 115ms Nov 26 12:30:39 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:43 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:47 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:51 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:55 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:30:59 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:31:03 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:31:07 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 26 12:31:16 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 12:31:16 volumiopi3 volumio[1085]: info: Preload queue cleared Nov 26 12:31:17 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 12:31:18 volumiopi3 volumio[1085]: info: Preload queue cleared Nov 26 12:31:19 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 12:31:19 volumiopi3 volumio[1085]: info: Preload queue cleared Nov 26 12:31:22 volumiopi3 volumio[1085]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Nov 26 12:31:22 volumiopi3 volumio[1085]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 12:31:22 volumiopi3 volumio[1085]: TypeError: Cannot read property 'length' of undefined Nov 26 12:31:22 volumiopi3 volumio[1085]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Nov 26 12:31:22 volumiopi3 volumio[1085]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Nov 26 12:31:22 volumiopi3 volumio[1085]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Nov 26 12:31:22 volumiopi3 volumio[1085]: at Parser.emit (events.js:315:20) Nov 26 12:31:22 volumiopi3 volumio[1085]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Nov 26 12:31:22 volumiopi3 volumio[1085]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Nov 26 12:31:22 volumiopi3 volumio[1085]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Nov 26 12:31:22 volumiopi3 volumio[1085]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Nov 26 12:31:22 volumiopi3 volumio[1085]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Nov 26 12:31:22 volumiopi3 volumio[1085]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Nov 26 12:31:22 volumiopi3 volumio[1085]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Nov 26 12:31:22 volumiopi3 volumio[1085]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Nov 26 12:31:22 volumiopi3 volumio[1085]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Nov 26 12:31:22 volumiopi3 volumio[1085]: at IncomingMessage.emit (events.js:327:22) Nov 26 12:31:22 volumiopi3 volumio[1085]: at endReadableNT (internal/streams/readable.js:1327:12) Nov 26 12:31:22 volumiopi3 volumio[1085]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Nov 26 12:31:22 volumiopi3 volumio[1085]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 26 12:31:22 volumiopi3 sudo[14291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-26 12:30 Nov 26 12:31:22 volumiopi3 sudo[14291]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"