-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2025-06-05 18:56:14 CEST. -- Jun 05 18:55:00 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:04 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:12 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:16 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:20 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:24 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:28 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:32 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:36 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:40 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:44 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:48 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:48 volumio sudo[2254]: pam_unix(sudo:session): session closed for user root Jun 05 18:55:48 volumio volumio[972]: info: An error occurred mounting the new share. Rolling back configuration Jun 05 18:55:49 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 05 18:55:52 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:55:55 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Jun 05 18:55:55 volumio volumio[972]: info: Share Music successfully unmounted Jun 05 18:55:55 volumio sudo[2717]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto 192.168.1.30:music /mnt/NAS/Music Jun 05 18:55:55 volumio sudo[2717]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 05 18:55:56 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:56:00 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand rescan Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: Jun 05 18:56:04 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand rescan took 4 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::getState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: Jun 05 18:56:04 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::getState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: Jun 05 18:56:04 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::getState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: Jun 05 18:56:04 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::getState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 14 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 12 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 11 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 11 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 10 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 9 milliseconds Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::pushState Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: 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} Jun 05 18:56:04 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: No code Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::pushState Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: 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} Jun 05 18:56:04 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: No code Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::pushState Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: 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} Jun 05 18:56:04 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: No code Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: ------------------------------ 223ms Jun 05 18:56:04 volumio volumio[972]: info: ------------------------------ 221ms Jun 05 18:56:04 volumio volumio[972]: info: ------------------------------ 221ms Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: Jun 05 18:56:04 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::getState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: Jun 05 18:56:04 volumio volumio[972]: ---------------------------- MPD announces state update: update Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::getState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::sendMpdCommand status Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 223 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 222 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 7 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 6 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 5 milliseconds Jun 05 18:56:04 volumio volumio[972]: info: sendMpdCommand status took 4 milliseconds Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: Command Router : Notfying DB Updatefalse Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::Close All Modals sent Jun 05 18:56:04 volumio volumio[972]: verbose: ControllerMpd::parseState Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::pushState Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: 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} Jun 05 18:56:04 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: No code Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::pushState Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: 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} Jun 05 18:56:04 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: No code Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: ControllerMpd::pushState Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::servicePushState Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: 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} Jun 05 18:56:04 volumio volumio[972]: verbose: CURRENT POSITION 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState stateService stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::syncState currentStatus stop Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:04 volumio volumio[972]: info: No code Jun 05 18:56:04 volumio volumio[972]: info: CoreStateMachine::pushState Jun 05 18:56:04 volumio volumio[972]: info: CorePlayQueue::getTrack 0 Jun 05 18:56:04 volumio volumio[972]: info: CoreCommandRouter::volumioPushState Jun 05 18:56:05 volumio volumio[972]: info: ------------------------------ 379ms Jun 05 18:56:05 volumio volumio[972]: info: ------------------------------ 166ms Jun 05 18:56:05 volumio volumio[972]: info: ------------------------------ 166ms Jun 05 18:56:08 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:56:08 volumio sudo[2295]: pam_unix(sudo:session): session closed for user root Jun 05 18:56:08 volumio volumio[972]: info: Cannot mount NAS Music at system boot, trial number 3 ,retrying in 5 seconds Jun 05 18:56:12 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Jun 05 18:56:12 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jun 05 18:56:13 volumio volumio[972]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jun 05 18:56:13 volumio volumio[972]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 18:56:13 volumio volumio[972]: TypeError: Cannot read property 'replace' of undefined Jun 05 18:56:13 volumio volumio[972]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Jun 05 18:56:13 volumio volumio[972]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Jun 05 18:56:13 volumio volumio[972]: at listOnTimeout (internal/timers.js:554:17) Jun 05 18:56:13 volumio volumio[972]: at processTimers (internal/timers.js:497:7) Jun 05 18:56:13 volumio volumio[972]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 18:56:14 volumio sudo[2781]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-05 18:55 Jun 05 18:56:14 volumio sudo[2781]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"