-- Logs begin at Fri 2026-10-02 10:35:40 UTC, end at Fri 2026-10-02 10:42:12 UTC. -- Oct 02 10:41:00 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:04 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand rescan Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:07 volumiorasp volumio[1007]: info: Oct 02 10:41:07 volumiorasp volumio[1007]: ---------------------------- MPD announces state update: update Oct 02 10:41:07 volumiorasp volumio[1007]: info: sendMpdCommand rescan took 4 milliseconds Oct 02 10:41:07 volumiorasp volumio[1007]: info: ControllerMpd::getState Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:07 volumiorasp volumio[1007]: info: Oct 02 10:41:07 volumiorasp volumio[1007]: ---------------------------- MPD announces state update: update Oct 02 10:41:07 volumiorasp volumio[1007]: info: ControllerMpd::getState Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:07 volumiorasp volumio[1007]: info: sendMpdCommand status took 5 milliseconds Oct 02 10:41:07 volumiorasp volumio[1007]: info: sendMpdCommand status took 3 milliseconds Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:07 volumiorasp volumio[1007]: info: Command Router : Notfying DB Updatefalse Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::Close All Modals sent Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:07 volumiorasp volumio[1007]: info: ControllerMpd::pushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::servicePushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreStateMachine::pushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::volumioPushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 10:41:07 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:07 volumiorasp volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 10:41:07 volumiorasp volumio[1007]: info: ------------------------------ 50ms Oct 02 10:41:07 volumiorasp volumio[1007]: info: sendMpdCommand status took 49 milliseconds Oct 02 10:41:07 volumiorasp volumio[1007]: info: sendMpdCommand status took 47 milliseconds Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:07 volumiorasp volumio[1007]: info: Command Router : Notfying DB Updatefalse Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::Close All Modals sent Oct 02 10:41:07 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:07 volumiorasp volumio[1007]: info: ControllerMpd::pushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::servicePushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreStateMachine::pushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::volumioPushState Oct 02 10:41:07 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 10:41:07 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:07 volumiorasp volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 10:41:07 volumiorasp volumio[1007]: info: ------------------------------ 82ms Oct 02 10:41:08 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:12 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:16 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:20 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:24 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand update Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:26 volumiorasp volumio[1007]: info: Oct 02 10:41:26 volumiorasp volumio[1007]: ---------------------------- MPD announces state update: update Oct 02 10:41:26 volumiorasp volumio[1007]: info: sendMpdCommand update took 5 milliseconds Oct 02 10:41:26 volumiorasp volumio[1007]: info: ControllerMpd::getState Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:26 volumiorasp volumio[1007]: info: Oct 02 10:41:26 volumiorasp volumio[1007]: ---------------------------- MPD announces state update: update Oct 02 10:41:26 volumiorasp volumio[1007]: info: ControllerMpd::getState Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:26 volumiorasp volumio[1007]: info: sendMpdCommand status took 6 milliseconds Oct 02 10:41:26 volumiorasp volumio[1007]: info: sendMpdCommand status took 5 milliseconds Oct 02 10:41:26 volumiorasp volumio[1007]: info: sendMpdCommand status took 4 milliseconds Oct 02 10:41:26 volumiorasp volumio[1007]: info: sendMpdCommand status took 4 milliseconds Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:26 volumiorasp volumio[1007]: info: Command Router : Notfying DB Updatefalse Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::Close All Modals sent Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:26 volumiorasp volumio[1007]: info: Command Router : Notfying DB Updatefalse Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::Close All Modals sent Oct 02 10:41:26 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:26 volumiorasp volumio[1007]: info: ControllerMpd::pushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::servicePushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreStateMachine::pushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::volumioPushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 10:41:26 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:26 volumiorasp volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 10:41:26 volumiorasp volumio[1007]: info: ControllerMpd::pushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::servicePushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreStateMachine::pushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::volumioPushState Oct 02 10:41:26 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 10:41:26 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:26 volumiorasp volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 10:41:26 volumiorasp volumio[1007]: info: ------------------------------ 80ms Oct 02 10:41:26 volumiorasp volumio[1007]: info: ------------------------------ 78ms Oct 02 10:41:28 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:32 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand rescan Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:35 volumiorasp volumio[1007]: info: Oct 02 10:41:35 volumiorasp volumio[1007]: ---------------------------- MPD announces state update: update Oct 02 10:41:35 volumiorasp volumio[1007]: info: sendMpdCommand rescan took 4 milliseconds Oct 02 10:41:35 volumiorasp volumio[1007]: info: ControllerMpd::getState Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:35 volumiorasp volumio[1007]: info: Oct 02 10:41:35 volumiorasp volumio[1007]: ---------------------------- MPD announces state update: update Oct 02 10:41:35 volumiorasp volumio[1007]: info: ControllerMpd::getState Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::sendMpdCommand status Oct 02 10:41:35 volumiorasp volumio[1007]: info: sendMpdCommand status took 6 milliseconds Oct 02 10:41:35 volumiorasp volumio[1007]: info: sendMpdCommand status took 5 milliseconds Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:35 volumiorasp volumio[1007]: info: Command Router : Notfying DB Updatefalse Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::Close All Modals sent Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:35 volumiorasp volumio[1007]: info: ControllerMpd::pushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::servicePushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreStateMachine::pushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::volumioPushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 10:41:35 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:35 volumiorasp volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 10:41:35 volumiorasp volumio[1007]: info: ------------------------------ 36ms Oct 02 10:41:35 volumiorasp volumio[1007]: info: sendMpdCommand status took 34 milliseconds Oct 02 10:41:35 volumiorasp volumio[1007]: info: sendMpdCommand status took 32 milliseconds Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:35 volumiorasp volumio[1007]: info: Command Router : Notfying DB Updatefalse Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::Close All Modals sent Oct 02 10:41:35 volumiorasp volumio[1007]: verbose: ControllerMpd::parseState Oct 02 10:41:35 volumiorasp volumio[1007]: info: ControllerMpd::pushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::servicePushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreStateMachine::pushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::volumioPushState Oct 02 10:41:35 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 02 10:41:35 volumiorasp volumio[1007]: info: CorePlayQueue::getTrack 0 Oct 02 10:41:35 volumiorasp volumio[1007]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd Oct 02 10:41:35 volumiorasp volumio[1007]: info: ------------------------------ 63ms Oct 02 10:41:36 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:40 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:44 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:48 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:52 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:41:56 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:42:00 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:42:04 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:42:06 volumiorasp sudo[1060]: pam_unix(sudo:session): session closed for user root Oct 02 10:42:06 volumiorasp kernel: CIFS VFS: Server 192.168.3.3 has not responded in 180 seconds. Reconnecting... Oct 02 10:42:06 volumiorasp kernel: CIFS VFS: Send error in SessSetup = -11 Oct 02 10:42:06 volumiorasp kernel: CIFS VFS: cifs_mount failed w/return code = -11 Oct 02 10:42:06 volumiorasp volumio[1007]: info: Cannot mount NAS NAS at system boot, trial number 1 ,retrying in 5 seconds Oct 02 10:42:08 volumiorasp volumio[1007]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 02 10:42:11 volumiorasp volumio[1007]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 10:42:11 volumiorasp volumio[1007]: TypeError: Cannot read property 'replace' of undefined Oct 02 10:42:11 volumiorasp volumio[1007]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:198:28) Oct 02 10:42:11 volumiorasp volumio[1007]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:251:20) Oct 02 10:42:11 volumiorasp volumio[1007]: at ontimeout (timers.js:482:11) Oct 02 10:42:11 volumiorasp volumio[1007]: at tryOnTimeout (timers.js:317:5) Oct 02 10:42:11 volumiorasp volumio[1007]: at Timer.listOnTimeout (timers.js:277:5) Oct 02 10:42:11 volumiorasp volumio[1007]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 02 10:42:12 volumiorasp sudo[2200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-02 10:41 Oct 02 10:42:12 volumiorasp sudo[2200]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="fd3e37ffec12db034ec93f94dbc26e5495d5b91a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Oct 6 12:34:49 CEST 2021" VOLUMIO_VERSION="2.917" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="98c8f08c531a6f0456f17ab17795e35f"