-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Wed 2024-05-08 19:13:42 CEST. -- May 08 19:12:00 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:00 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:00 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:01 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:01 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:02 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:02 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:03 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:03 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:04 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:04 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:04 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:05 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:05 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:06 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:06 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:07 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:07 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:08 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare May 08 19:12:08 simon volumio[906]: info: Adding a new share May 08 19:12:08 simon volumio[906]: info: No correspondence found in configuration for share Nas on IP 192.168.1.198 May 08 19:12:08 simon sudo[2508]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=rosi2011,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.198/\\\\NAS7DBEB5\\Multimedia\\Musik\\music /mnt/NAS/Nas May 08 19:12:08 simon sudo[2508]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:12:08 simon kernel: Key type cifs.spnego registered May 08 19:12:08 simon kernel: Key type cifs.idmap registered May 08 19:12:08 simon 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. May 08 19:12:08 simon kernel: CIFS: Attempting to mount \\192.168.1.198\ May 08 19:12:08 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:08 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:08 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:08 simon kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.198\ May 08 19:12:08 simon sudo[2508]: pam_unix(sudo:session): session closed for user root May 08 19:12:08 simon kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 08 19:12:08 simon volumio[906]: info: Error mounting Nas on IP 192.168.1.198 : (2): No such file or directory May 08 19:12:08 simon volumio[906]: Refer to the mount.cifs(8) manual page (e.g. man mount.cifs) May 08 19:12:09 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:09 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:09 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 08 19:12:10 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:10 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:11 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:11 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:12 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:12 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:12 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:13 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:13 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:14 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:14 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:15 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:15 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:16 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:16 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:16 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:17 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:17 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:18 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:18 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:19 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:19 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:20 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:20 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:20 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:21 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:21 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:22 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare May 08 19:12:22 simon volumio[906]: info: Share Nas successfully unmounted May 08 19:12:22 simon sudo[2542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=rosi2011,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.198/\\Multimedia\\Musik\\music /mnt/NAS/Nas May 08 19:12:22 simon sudo[2542]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:12:22 simon kernel: CIFS: Attempting to mount \\192.168.1.198\ May 08 19:12:22 simon kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.198\ May 08 19:12:22 simon sudo[2542]: pam_unix(sudo:session): session closed for user root May 08 19:12:22 simon volumio[906]: info: An error occurred mounting the new share. Rolling back configuration May 08 19:12:22 simon kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 08 19:12:22 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:22 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:23 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 08 19:12:23 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:23 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:24 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:24 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:24 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:25 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:25 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:26 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:26 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand update May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: info: May 08 19:12:27 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:27 simon volumio[906]: info: sendMpdCommand update took 5 milliseconds May 08 19:12:27 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: info: May 08 19:12:27 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:27 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: info: sendMpdCommand status took 6 milliseconds May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:27 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:27 simon volumio[906]: info: sendMpdCommand status took 57 milliseconds May 08 19:12:27 simon volumio[906]: info: sendMpdCommand status took 57 milliseconds May 08 19:12:27 simon volumio[906]: info: sendMpdCommand status took 56 milliseconds May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:27 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:27 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:27 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:27 simon volumio[906]: info: No code May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:27 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:27 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:27 simon volumio[906]: info: No code May 08 19:12:27 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:27 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:27 simon volumio[906]: info: ------------------------------ 89ms May 08 19:12:27 simon volumio[906]: info: ------------------------------ 92ms May 08 19:12:27 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:27 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand update May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: info: May 08 19:12:27 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:27 simon volumio[906]: info: sendMpdCommand update took 2 milliseconds May 08 19:12:27 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: info: May 08 19:12:27 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:27 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:27 simon volumio[906]: info: sendMpdCommand status took 1 milliseconds May 08 19:12:27 simon volumio[906]: info: sendMpdCommand status took 2 milliseconds May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:27 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:27 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:27 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:27 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:28 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: No code May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: ------------------------------ 27ms May 08 19:12:28 simon volumio[906]: info: sendMpdCommand status took 27 milliseconds May 08 19:12:28 simon volumio[906]: info: sendMpdCommand status took 27 milliseconds May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:28 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:28 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:28 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: No code May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: ------------------------------ 50ms May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand rescan May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:28 simon volumio[906]: info: May 08 19:12:28 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:28 simon volumio[906]: info: sendMpdCommand rescan took 1 milliseconds May 08 19:12:28 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:28 simon volumio[906]: info: May 08 19:12:28 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:28 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:28 simon volumio[906]: info: sendMpdCommand status took 1 milliseconds May 08 19:12:28 simon volumio[906]: info: sendMpdCommand status took 1 milliseconds May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:28 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:28 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:28 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:28 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:28 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: No code May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: ------------------------------ 27ms May 08 19:12:28 simon volumio[906]: info: sendMpdCommand status took 27 milliseconds May 08 19:12:28 simon volumio[906]: info: sendMpdCommand status took 27 milliseconds May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:28 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:28 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:28 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:28 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: No code May 08 19:12:28 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:28 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:28 simon volumio[906]: info: ------------------------------ 51ms May 08 19:12:28 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:29 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:29 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:30 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:30 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:31 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:31 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:32 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:32 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:32 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:33 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:33 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:34 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:34 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:35 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:35 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:36 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:36 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:36 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:37 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:37 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:38 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:38 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:39 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:39 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:40 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:40 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:40 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:41 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare May 08 19:12:41 simon volumio[906]: info: Share Nas successfully unmounted May 08 19:12:41 simon sudo[2569]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=Volumio,password=rosi2011,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.198/\\\\Multimedia\\Musik\\music /mnt/NAS/Nas May 08 19:12:41 simon sudo[2569]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:12:41 simon kernel: CIFS: Attempting to mount \\192.168.1.198\ May 08 19:12:41 simon kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.198\ May 08 19:12:41 simon kernel: CIFS: VFS: cifs_mount failed w/return code = -2 May 08 19:12:41 simon sudo[2569]: pam_unix(sudo:session): session closed for user root May 08 19:12:41 simon volumio[906]: info: An error occurred mounting the new share. Rolling back configuration May 08 19:12:41 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:41 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:42 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 08 19:12:42 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:42 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:43 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:43 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:44 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:44 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:44 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:45 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:45 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:46 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:46 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:47 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:47 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:48 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:48 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:48 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare May 08 19:12:48 simon volumio[906]: info: Share Nas successfully unmounted May 08 19:12:48 simon sudo[2619]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.198:\\\\NAS7DBEB5\\Multimedia\\Musik\\music /mnt/NAS/Nas May 08 19:12:48 simon sudo[2619]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:12:48 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:48 simon systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. May 08 19:12:48 simon systemd[1]: Starting Preprocess NFS configuration... May 08 19:12:48 simon systemd[1]: nfs-config.service: Succeeded. May 08 19:12:48 simon systemd[1]: Started Preprocess NFS configuration. May 08 19:12:48 simon systemd[1]: Starting Notify NFS peers of a restart... May 08 19:12:48 simon systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... May 08 19:12:48 simon sm-notify[2632]: Version 1.3.3 starting May 08 19:12:48 simon systemd[1]: rpc-statd-notify.service: Succeeded. May 08 19:12:48 simon systemd[1]: Started Notify NFS peers of a restart. May 08 19:12:48 simon rpc.statd[2634]: Version 1.3.3 starting May 08 19:12:48 simon rpc.statd[2634]: Flags: TI-RPC May 08 19:12:48 simon rpc.statd[2634]: Failed to read /var/lib/nfs/state: Success May 08 19:12:48 simon rpc.statd[2634]: Initializing NSM state May 08 19:12:48 simon systemd[1]: Started NFS status monitor for NFSv2/3 locking.. May 08 19:12:49 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:49 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:50 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:50 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:51 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:51 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:52 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:52 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand rescan May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:52 simon volumio[906]: info: May 08 19:12:52 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:52 simon volumio[906]: info: sendMpdCommand rescan took 1 milliseconds May 08 19:12:52 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:52 simon volumio[906]: info: May 08 19:12:52 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:52 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:52 simon volumio[906]: info: sendMpdCommand status took 2 milliseconds May 08 19:12:52 simon volumio[906]: info: sendMpdCommand status took 1 milliseconds May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:52 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:52 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:52 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:52 simon volumio[906]: info: No code May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:52 simon volumio[906]: info: ------------------------------ 40ms May 08 19:12:52 simon volumio[906]: info: sendMpdCommand status took 39 milliseconds May 08 19:12:52 simon volumio[906]: info: sendMpdCommand status took 39 milliseconds May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:52 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:52 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:52 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:52 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:52 simon volumio[906]: info: No code May 08 19:12:52 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:52 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:52 simon volumio[906]: info: ------------------------------ 65ms May 08 19:12:52 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:53 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:53 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand update May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:54 simon volumio[906]: info: May 08 19:12:54 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:54 simon volumio[906]: info: sendMpdCommand update took 1 milliseconds May 08 19:12:54 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:54 simon volumio[906]: info: May 08 19:12:54 simon volumio[906]: ---------------------------- MPD announces state update: update May 08 19:12:54 simon volumio[906]: info: ControllerMpd::getState May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::sendMpdCommand status May 08 19:12:54 simon volumio[906]: info: sendMpdCommand status took 1 milliseconds May 08 19:12:54 simon volumio[906]: info: sendMpdCommand status took 1 milliseconds May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:54 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:54 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:54 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:54 simon volumio[906]: info: No code May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:54 simon volumio[906]: info: ------------------------------ 27ms May 08 19:12:54 simon volumio[906]: info: sendMpdCommand status took 27 milliseconds May 08 19:12:54 simon volumio[906]: info: sendMpdCommand status took 27 milliseconds May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:54 simon volumio[906]: info: Command Router : Notfying DB Updatefalse May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::Close All Modals sent May 08 19:12:54 simon volumio[906]: verbose: ControllerMpd::parseState May 08 19:12:54 simon volumio[906]: info: ControllerMpd::pushState May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::servicePushState May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 08 19:12:54 simon volumio[906]: verbose: CURRENT POSITION 0 May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::syncState stateService stop May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::syncState currentStatus stop May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:54 simon volumio[906]: info: No code May 08 19:12:54 simon volumio[906]: info: CoreStateMachine::pushState May 08 19:12:54 simon volumio[906]: info: CorePlayQueue::getTrack 0 May 08 19:12:54 simon volumio[906]: info: CoreCommandRouter::volumioPushState May 08 19:12:54 simon volumio[906]: info: ------------------------------ 52ms May 08 19:12:54 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:54 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:55 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:55 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:56 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:56 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:56 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:12:57 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:57 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:58 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:58 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:59 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:12:59 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:00 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:00 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:00 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:01 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:01 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:02 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:02 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:03 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:03 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:04 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:04 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:04 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:05 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:05 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:06 simon ntpd[773]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized May 08 19:13:06 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:06 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:07 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:07 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:08 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:08 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:08 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:09 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:09 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:10 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:10 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:10 simon volumio[906]: info: Disabling MyMusic plugin upnp May 08 19:13:10 simon sudo[2654]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service May 08 19:13:10 simon sudo[2654]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:10 simon systemd[1]: Stopping UPnP Renderer front-end to MPD... May 08 19:13:10 simon volumio[906]: error: Upnp client error: Error: This socket has been ended by the other party May 08 19:13:11 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:11 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:12 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:12 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:12 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:12 simon volumio[906]: info: Enabling MyMusic plugin upnp May 08 19:13:12 simon volumio[906]: info: Enabling plugin upnp May 08 19:13:12 simon volumio[906]: info: Loading plugin "upnp"... May 08 19:13:12 simon volumio[906]: info: [1715188392955] Starting Upmpd Daemon May 08 19:13:12 simon volumio[906]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 08 19:13:12 simon volumio[906]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 19:13:12 simon volumio[906]: Error: listen EADDRINUSE: address already in use :::6599 May 08 19:13:12 simon volumio[906]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) May 08 19:13:12 simon volumio[906]: at listenInCluster (net.js:1366:12) May 08 19:13:12 simon volumio[906]: at Server.listen (net.js:1452:7) May 08 19:13:12 simon volumio[906]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) May 08 19:13:12 simon volumio[906]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) May 08 19:13:12 simon volumio[906]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) May 08 19:13:12 simon volumio[906]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 08 19:13:12 simon volumio[906]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 08 19:13:12 simon volumio[906]: code: 'EADDRINUSE', May 08 19:13:12 simon volumio[906]: errno: -98, May 08 19:13:12 simon volumio[906]: syscall: 'listen', May 08 19:13:12 simon volumio[906]: address: '::', May 08 19:13:12 simon volumio[906]: port: 6599 May 08 19:13:12 simon volumio[906]: } May 08 19:13:12 simon volumio[906]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 19:13:13 simon sudo[2665]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-08 19:12 May 08 19:13:13 simon sudo[2665]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:13 simon sudo[2665]: pam_unix(sudo:session): session closed for user root May 08 19:13:13 simon volumio-remote-updater[1641]: [2024-05-08 17:13:13] [error] handle_read_frame error: websocketpp.transport:7 (End of File) May 08 19:13:13 simon volumio-remote-updater[1641]: [2024-05-08 17:13:13] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] May 08 19:13:13 simon systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE May 08 19:13:13 simon systemd[1]: upmpdcli.service: Succeeded. May 08 19:13:13 simon sudo[2619]: pam_unix(sudo:session): session closed for user root May 08 19:13:13 simon systemd[1]: Stopped UPnP Renderer front-end to MPD. May 08 19:13:13 simon sudo[2654]: pam_unix(sudo:session): session closed for user root May 08 19:13:13 simon systemd[1]: volumio.service: Failed with result 'exit-code'. May 08 19:13:13 simon systemd[1]: Started dynamicswap service. May 08 19:13:13 simon systemd[1]: dynamicswap.service: Succeeded. May 08 19:13:13 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:13 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:13 simon systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. May 08 19:13:13 simon systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. May 08 19:13:13 simon systemd[1]: Started dynamicswap service. May 08 19:13:13 simon systemd[1]: Stopped Volumio Backend Module. May 08 19:13:13 simon systemd[1]: Started Volumio Backend Module. May 08 19:13:13 simon systemd[1]: dynamicswap.service: Succeeded. May 08 19:13:14 simon volumio[2680]: info: ------------------------------------------- May 08 19:13:14 simon volumio[2680]: info: ----- Volumio3 ---- May 08 19:13:14 simon volumio[2680]: info: ------------------------------------------- May 08 19:13:14 simon volumio[2680]: info: ----- System startup ---- May 08 19:13:14 simon volumio[2680]: info: ------------------------------------------- May 08 19:13:14 simon volumio[2680]: info: MYVOLUMIO Environment detected May 08 19:13:14 simon volumio[2680]: info: Plugin folders cleanup May 08 19:13:14 simon volumio[2680]: info: Scanning into folder /volumio/app/plugins/ May 08 19:13:14 simon volumio[2680]: info: Scanning category audio_interface May 08 19:13:14 simon volumio[2680]: info: Scanning category miscellanea May 08 19:13:14 simon volumio[2680]: info: Scanning category music_service May 08 19:13:14 simon volumio[2680]: info: Scanning category plugins.json May 08 19:13:14 simon volumio[2680]: info: Scanning category system_controller May 08 19:13:14 simon volumio[2680]: info: Scanning category user_interface May 08 19:13:14 simon volumio[2680]: info: Scanning into folder /data/plugins/ May 08 19:13:14 simon volumio[2680]: info: Plugin folders cleanup completed May 08 19:13:14 simon volumio[2680]: info: ------------------------------------------- May 08 19:13:14 simon volumio[2680]: info: ----- Core plugins startup ---- May 08 19:13:14 simon volumio[2680]: info: ------------------------------------------- May 08 19:13:14 simon volumio[2680]: info: Loading plugins from folder /volumio/app/plugins/ May 08 19:13:14 simon volumio[2680]: info: Adding plugin upnp to MyMusic Plugins May 08 19:13:14 simon volumio[2680]: info: Adding plugin airplay_emulation to MyMusic Plugins May 08 19:13:14 simon volumio[2680]: info: Adding plugin upnp_browser to MyMusic Plugins May 08 19:13:14 simon volumio[2680]: info: Loading plugins from folder /data/plugins/ May 08 19:13:14 simon volumio[2680]: info: Loading plugin "system"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "appearance"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "network"... May 08 19:13:14 simon volumio[2680]: info: Refreshing Cached IP Addresses May 08 19:13:14 simon sudo[2706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 08 19:13:14 simon sudo[2706]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:14 simon sudo[2706]: pam_unix(sudo:session): session closed for user root May 08 19:13:14 simon sudo[2708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 08 19:13:14 simon volumio[2680]: info: Loading plugin "services"... May 08 19:13:14 simon sudo[2708]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:14 simon volumio[2680]: info: Loading plugin "alsa_controller"... May 08 19:13:14 simon sudo[2708]: pam_unix(sudo:session): session closed for user root May 08 19:13:14 simon sudo[2711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 08 19:13:14 simon sudo[2711]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 08 19:13:14 simon volumio[2680]: info: Loading plugin "wizard"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "networkfs"... May 08 19:13:14 simon volumio[2680]: info: Starting Udev Watcher for removable devices May 08 19:13:14 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:14 simon sudo[2717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.198:\\\\NAS7DBEB5\\Multimedia\\Musik\\music /mnt/NAS/Nas May 08 19:13:14 simon sudo[2717]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:14 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:14 simon volumio[2680]: info: Ignoring mount for partition: boot May 08 19:13:14 simon volumio[2680]: info: Ignoring mount for partition: volumio May 08 19:13:14 simon volumio[2680]: info: Ignoring mount for partition: volumio_data May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 08 19:13:14 simon volumio[2680]: info: Loading plugin "volumio_command_line_client"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "upnp"... May 08 19:13:14 simon volumio[2680]: info: [1715188394567] Starting Upmpd Daemon May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 08 19:13:14 simon volumio[2680]: info: Loading plugin "my_music"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "mpd"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "upnp_browser"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "alarm-clock"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "airplay_emulation"... May 08 19:13:14 simon volumio[2680]: info: Starting Shairport Sync May 08 19:13:14 simon volumio[2680]: info: Loading plugin "last_100"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "webradio"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "i2s_dacs"... May 08 19:13:14 simon volumio[2680]: info: I2S DAC not set, start Auto-detection May 08 19:13:14 simon volumio[2680]: info: Loading plugin "volumiodiscovery"... May 08 19:13:14 simon volumio[2680]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 08 19:13:14 simon node[2680]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 08 19:13:14 simon node[2680]: *** WARNING *** Please fix your application to use the native API of Avahi! May 08 19:13:14 simon volumio[2680]: *** WARNING *** Please fix your application to use the native API of Avahi! May 08 19:13:14 simon volumio[2680]: *** WARNING *** For more information see May 08 19:13:14 simon volumio[2680]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 08 19:13:14 simon volumio[2680]: *** WARNING *** Please fix your application to use the native API of Avahi! May 08 19:13:14 simon volumio[2680]: *** WARNING *** For more information see May 08 19:13:14 simon node[2680]: *** WARNING *** For more information see May 08 19:13:14 simon node[2680]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 08 19:13:14 simon node[2680]: *** WARNING *** Please fix your application to use the native API of Avahi! May 08 19:13:14 simon node[2680]: *** WARNING *** For more information see May 08 19:13:14 simon volumio[2680]: info: Applying required configuration parameters for plugin volumiodiscovery May 08 19:13:14 simon volumio[2680]: info: Discovery: Started advertising with name: Simon May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 08 19:13:14 simon volumio[2680]: info: Loading plugin "outputs"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "albumart"... May 08 19:13:14 simon volumio[2680]: info: Plugin example_plugin is not enabled May 08 19:13:14 simon volumio[2680]: info: Loading plugin "inputs"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "updater_comm"... May 08 19:13:14 simon volumio[2680]: info: Plugin mpdemulation is not enabled May 08 19:13:14 simon volumio[2680]: info: Loading plugin "rest_api"... May 08 19:13:14 simon volumio[2680]: info: Loading plugin "websocket"... May 08 19:13:14 simon volumio[2680]: info: Loading i18n strings for locale de May 08 19:13:14 simon volumio[2680]: Updating browse sources language May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 08 19:13:14 simon volumio[2680]: Forking 3 albumart workers May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::initPlayerControls May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 08 19:13:14 simon volumio[2680]: Express server listening on port 3000 May 08 19:13:14 simon volumio[2680]: [Metrics] WebUI: 0s 890.24ms May 08 19:13:14 simon volumio[2680]: info: CoreStateMachine::resetVolumioState May 08 19:13:14 simon volumio[2680]: info: CoreStateMachine::getcurrentVolume May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::volumioRetrievevolume May 08 19:13:14 simon volumio[2680]: info: CoreStateMachine::pushState May 08 19:13:14 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::volumioPushState May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 08 19:13:14 simon volumio[2680]: info: Cannot read play queue from file May 08 19:13:14 simon volumio[2680]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.127 UA: okhttp/4.9.2 Total Clients: 1 May 08 19:13:14 simon volumio[2680]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.127 UA: okhttp/4.9.2 Total Clients: 2 May 08 19:13:14 simon volumio[2680]: info: CoreStateMachine::setRepeat null single undefined May 08 19:13:14 simon volumio[2680]: info: CoreStateMachine::pushState May 08 19:13:14 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:14 simon volumio[2680]: info: CoreCommandRouter::volumioPushState May 08 19:13:15 simon volumio[2680]: info: CoreStateMachine::setRandom null May 08 19:13:15 simon volumio[2680]: info: CoreStateMachine::pushState May 08 19:13:15 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:15 simon volumio[2680]: info: CoreCommandRouter::volumioPushState May 08 19:13:15 simon volumio[2680]: info: Setting Device type: Raspberry PI May 08 19:13:15 simon volumio[2680]: info: CoreCommandRouter::volumioGetState May 08 19:13:15 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:15 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard May 08 19:13:15 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard May 08 19:13:15 simon volumio[2680]: Starting albumart workers May 08 19:13:15 simon volumio[2680]: Starting albumart workers May 08 19:13:15 simon volumio[2680]: Starting albumart workers May 08 19:13:15 simon volumio[2680]: info: Discovery: adding 0f21c31d-7a0d-446d-9b45-38066ba509d9 May 08 19:13:15 simon volumio[2680]: info: Discovery: Found device Simon May 08 19:13:15 simon volumio[2680]: info: CoreCommandRouter::volumioGetState May 08 19:13:15 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:16 simon volumio[2680]: verbose: New Socket.io Connection to 192.168.1.28 from 192.168.1.127 UA: okhttp/4.9.2 Total Clients: 3 May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::volumioGetVisibleSources May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::volumioGetState May 08 19:13:16 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 08 19:13:16 simon volumio[2680]: info: Received Get System Info May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice May 08 19:13:16 simon volumio[2680]: info: Discovery: Getting this device information May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::volumioGetState May 08 19:13:16 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 08 19:13:16 simon volumio[2680]: info: CoreCommandRouter::volumioGetState May 08 19:13:16 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:16 simon volumio[2680]: info: Listing playlists May 08 19:13:18 simon sudo[2711]: pam_unix(sudo:session): session closed for user root May 08 19:13:18 simon volumio-remote-updater[1641]: [2024-05-08 17:13:18] [connect] Successful connection May 08 19:13:18 simon volumio-remote-updater[1641]: [2024-05-08 17:13:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1715188398 101 May 08 19:13:18 simon volumio[2680]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 4 May 08 19:13:18 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:18 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:19 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:19 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:20 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:20 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:20 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:21 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:21 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:22 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:22 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:23 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:23 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:24 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:24 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:24 simon sudo[2792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 08 19:13:24 simon sudo[2792]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:24 simon sudo[2792]: pam_unix(sudo:session): session closed for user root May 08 19:13:24 simon sudo[2794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 08 19:13:24 simon sudo[2794]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:24 simon sudo[2794]: pam_unix(sudo:session): session closed for user root May 08 19:13:24 simon sudo[2798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service May 08 19:13:24 simon sudo[2798]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:24 simon systemd[1]: Started UPnP Renderer front-end to MPD. May 08 19:13:24 simon sudo[2798]: pam_unix(sudo:session): session closed for user root May 08 19:13:24 simon volumio[2680]: info: Upmpdcli Daemon Started May 08 19:13:24 simon volumio[2800]: writing RSA key May 08 19:13:24 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:25 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:25 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:26 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:26 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:27 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:27 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:28 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:28 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:29 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:29 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:30 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:30 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:31 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:31 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:31 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:32 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:32 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:32 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:33 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:33 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:34 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:34 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:35 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:35 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:36 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare May 08 19:13:36 simon volumio[2680]: info: Share Nas successfully unmounted May 08 19:13:36 simon sudo[2836]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.198:Multimedia/Musik/music /mnt/NAS/Nas May 08 19:13:36 simon sudo[2836]: pam_unix(sudo:session): session opened for user root by (uid=0) May 08 19:13:36 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:36 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:36 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:37 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:37 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:38 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:38 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:39 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:39 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:40 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:40 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:40 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 08 19:13:40 simon volumio[2680]: info: CoreCommandRouter::volumioPlay May 08 19:13:40 simon volumio[2680]: info: CoreStateMachine::play index undefined May 08 19:13:40 simon volumio[2680]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 19:13:40 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:41 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:41 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:41 simon volumio[2680]: info: CoreCommandRouter::volumioPlay May 08 19:13:41 simon volumio[2680]: info: CoreStateMachine::play index undefined May 08 19:13:41 simon volumio[2680]: info: CoreStateMachine::setConsumeUpdateService undefined May 08 19:13:41 simon volumio[2680]: info: CorePlayQueue::getTrack 0 May 08 19:13:42 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:42 simon dnsmasq-dhcp[897]: no address range available for DHCP request via wlan0 May 08 19:13:42 simon volumio[2680]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb May 08 19:13:42 simon volumio[2680]: verbose: ControllerMpd::sendMpdCommand rescan May 08 19:13:42 simon volumio[2680]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 19:13:42 simon volumio[2680]: TypeError: Cannot read property 'then' of undefined May 08 19:13:42 simon volumio[2680]: at ControllerMpd.sendMpdCommand (/volumio/app/plugins/music_service/mpd/index.js:331:6) May 08 19:13:42 simon volumio[2680]: at ControllerMpd.rescanDb (/volumio/app/plugins/music_service/mpd/index.js:1885:15) May 08 19:13:42 simon volumio[2680]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) May 08 19:13:42 simon volumio[2680]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1045:26) May 08 19:13:42 simon volumio[2680]: at Socket.emit (events.js:315:20) May 08 19:13:42 simon volumio[2680]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 May 08 19:13:42 simon volumio[2680]: at processTicksAndRejections (internal/process/task_queues.js:75:11) May 08 19:13:42 simon volumio[2680]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 08 19:13:42 simon sudo[2852]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-08 19:12 May 08 19:13:42 simon sudo[2852]: 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"