-- Logs begin at Fri 2026-10-02 12:57:30 UTC, end at Fri 2026-10-02 13:03:40 UTC. --
Oct 02 13:02:00 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:04 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:08 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:12 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:16 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:20 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:24 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:28 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:29 volumiorasp kernel: CIFS VFS: failed to connect to IPC (rc=-13)
Oct 02 13:02:32 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand rescan
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:02:35 volumiorasp volumio[1017]: info:
Oct 02 13:02:35 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: update
Oct 02 13:02:35 volumiorasp volumio[1017]: info: sendMpdCommand rescan took 4 milliseconds
Oct 02 13:02:35 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:02:35 volumiorasp volumio[1017]: info:
Oct 02 13:02:35 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: update
Oct 02 13:02:35 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:02:35 volumiorasp volumio[1017]: info: sendMpdCommand status took 5 milliseconds
Oct 02 13:02:35 volumiorasp volumio[1017]: info: sendMpdCommand status took 3 milliseconds
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: Command Router : Notfying DB Updatefalse
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::Close All Modals sent
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:02:35 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:02:35 volumiorasp volumio[1017]: info: ------------------------------ 53ms
Oct 02 13:02:35 volumiorasp volumio[1017]: info: sendMpdCommand status took 51 milliseconds
Oct 02 13:02:35 volumiorasp volumio[1017]: info: sendMpdCommand status took 51 milliseconds
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: Command Router : Notfying DB Updatefalse
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::Close All Modals sent
Oct 02 13:02:35 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:02:35 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:02:35 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:02:35 volumiorasp volumio[1017]: info: ------------------------------ 80ms
Oct 02 13:02:36 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:40 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:44 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:46 volumiorasp volumio[1017]: error: error
Oct 02 13:02:48 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:52 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:02:56 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:00 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:04 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:08 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:13 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:17 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:21 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:25 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare
Oct 02 13:03:25 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:26 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares
Oct 02 13:03:28 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Oct 02 13:03:29 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:30 volumiorasp volumio[1017]: info:
Oct 02 13:03:30 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: update
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:30 volumiorasp volumio[1017]: info: sendMpdCommand status took 3 milliseconds
Oct 02 13:03:30 volumiorasp volumio[1017]: info: sendMpdCommand status took 2 milliseconds
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: Command Router : Notfying DB Updatetrue
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:30 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ------------------------------ 56ms
Oct 02 13:03:30 volumiorasp volumio[1017]: info: MPD Database updated - AlbumList cache refreshed
Oct 02 13:03:30 volumiorasp volumio[1017]: info:
Oct 02 13:03:30 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: database
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:30 volumiorasp volumio[1017]: info:
Oct 02 13:03:30 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: update
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:30 volumiorasp volumio[1017]: info: sendMpdCommand status took 9 milliseconds
Oct 02 13:03:30 volumiorasp volumio[1017]: info: sendMpdCommand status took 9 milliseconds
Oct 02 13:03:30 volumiorasp volumio[1017]: info: sendMpdCommand status took 8 milliseconds
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: Command Router : Notfying DB Updatefalse
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::Close All Modals sent
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:30 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:30 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:03:30 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:30 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ------------------------------ 44ms
Oct 02 13:03:30 volumiorasp volumio[1017]: info: ------------------------------ 45ms
Oct 02 13:03:33 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares
Oct 02 13:03:34 volumiorasp kernel: CIFS VFS: cifs_mount failed w/return code = -13
Oct 02 13:03:34 volumiorasp sudo[1776]: pam_unix(sudo:session): session closed for user root
Oct 02 13:03:34 volumiorasp volumio[1017]: info: Cannot mount NAS NAS at system boot, trial number 2 ,retrying in 5 seconds
Oct 02 13:03:34 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand update
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:36 volumiorasp volumio[1017]: info:
Oct 02 13:03:36 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: update
Oct 02 13:03:36 volumiorasp volumio[1017]: info: sendMpdCommand update took 6 milliseconds
Oct 02 13:03:36 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:36 volumiorasp volumio[1017]: info:
Oct 02 13:03:36 volumiorasp volumio[1017]: ---------------------------- MPD announces state update: update
Oct 02 13:03:36 volumiorasp volumio[1017]: info: ControllerMpd::getState
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::sendMpdCommand status
Oct 02 13:03:36 volumiorasp volumio[1017]: info: sendMpdCommand status took 13 milliseconds
Oct 02 13:03:36 volumiorasp volumio[1017]: info: sendMpdCommand status took 9 milliseconds
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: Command Router : Notfying DB Updatefalse
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::Close All Modals sent
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:36 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:03:36 volumiorasp volumio[1017]: info: ------------------------------ 66ms
Oct 02 13:03:36 volumiorasp volumio[1017]: info: sendMpdCommand status took 61 milliseconds
Oct 02 13:03:36 volumiorasp volumio[1017]: info: sendMpdCommand status took 57 milliseconds
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: Command Router : Notfying DB Updatefalse
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::Close All Modals sent
Oct 02 13:03:36 volumiorasp volumio[1017]: verbose: ControllerMpd::parseState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: ControllerMpd::pushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::servicePushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreStateMachine::pushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::volumioPushState
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 02 13:03:36 volumiorasp volumio[1017]: info: CorePlayQueue::getTrack 0
Oct 02 13:03:36 volumiorasp volumio[1017]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current radio_paradise Received mpd
Oct 02 13:03:36 volumiorasp volumio[1017]: info: ------------------------------ 117ms
Oct 02 13:03:37 volumiorasp volumio[1017]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats
Oct 02 13:03:39 volumiorasp volumio[1017]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 02 13:03:39 volumiorasp volumio[1017]: TypeError: Cannot read property 'replace' of undefined
Oct 02 13:03:39 volumiorasp volumio[1017]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:198:28)
Oct 02 13:03:39 volumiorasp volumio[1017]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:251:20)
Oct 02 13:03:39 volumiorasp volumio[1017]: at ontimeout (timers.js:482:11)
Oct 02 13:03:39 volumiorasp volumio[1017]: at tryOnTimeout (timers.js:317:5)
Oct 02 13:03:39 volumiorasp volumio[1017]: at Timer.listOnTimeout (timers.js:277:5)
Oct 02 13:03:39 volumiorasp volumio[1017]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 02 13:03:40 volumiorasp sudo[2116]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-10-02 13:02
Oct 02 13:03:40 volumiorasp sudo[2116]: 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"