-- Logs begin at Fri 2025-05-02 16:19:27 UTC, end at Fri 2025-05-02 16:22:08 UTC. -- May 02 16:21:01 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:04 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings May 02 16:21:04 volumio volumio[834]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined May 02 16:21:04 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates May 02 16:21:04 volumio volumio[834]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio May 02 16:21:04 volumio volumio[834]: info: Received Get System Version May 02 16:21:04 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 02 16:21:05 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare May 02 16:21:05 volumio volumio[834]: info: Share Music successfully unmounted May 02 16:21:05 volumio sudo[1285]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t nfs -o ro,soft,noauto SynologyNAS:Data\Music /mnt/NAS/Music May 02 16:21:05 volumio sudo[1285]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 16:21:05 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:09 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:13 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:16 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare May 02 16:21:17 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 02 16:21:17 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:18 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status May 02 16:21:21 volumio volumio[834]: info: May 02 16:21:21 volumio volumio[834]: ---------------------------- MPD announces state update: update May 02 16:21:21 volumio volumio[834]: info: ControllerMpd::getState May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status May 02 16:21:21 volumio volumio[834]: info: May 02 16:21:21 volumio volumio[834]: ---------------------------- MPD announces state update: update May 02 16:21:21 volumio volumio[834]: info: ControllerMpd::getState May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status May 02 16:21:21 volumio volumio[834]: info: sendMpdCommand status took 6 milliseconds May 02 16:21:21 volumio volumio[834]: info: sendMpdCommand status took 4 milliseconds May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::parseState May 02 16:21:21 volumio volumio[834]: info: Command Router : Notfying DB Updatefalse May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::Close All Modals sent May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::parseState May 02 16:21:21 volumio volumio[834]: info: ControllerMpd::pushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::servicePushState May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: 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 02 16:21:21 volumio volumio[834]: verbose: CURRENT POSITION 0 May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::syncState stateService stop May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:21 volumio volumio[834]: info: No code May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:21 volumio volumio[834]: info: ------------------------------ 131ms May 02 16:21:21 volumio volumio[834]: info: sendMpdCommand status took 128 milliseconds May 02 16:21:21 volumio volumio[834]: info: sendMpdCommand status took 127 milliseconds May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::parseState May 02 16:21:21 volumio volumio[834]: info: Command Router : Notfying DB Updatefalse May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::Close All Modals sent May 02 16:21:21 volumio volumio[834]: verbose: ControllerMpd::parseState May 02 16:21:21 volumio volumio[834]: info: ControllerMpd::pushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::servicePushState May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: 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 02 16:21:21 volumio volumio[834]: verbose: CURRENT POSITION 0 May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::syncState stateService stop May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:21 volumio volumio[834]: info: No code May 02 16:21:21 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:21 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:21 volumio volumio[834]: info: ------------------------------ 155ms May 02 16:21:21 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:25 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:29 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:33 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:37 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:41 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:44 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare May 02 16:21:44 volumio volumio[834]: info: Adding a new share May 02 16:21:44 volumio volumio[834]: info: No correspondence found in configuration for share Music on IP SynologyNAS May 02 16:21:44 volumio sudo[1396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=esfieser,password=RWN6350esf,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //SynologyNAS/Data/Music /mnt/NAS/Music May 02 16:21:44 volumio sudo[1396]: pam_unix(sudo:session): session opened for user root by (uid=0) May 02 16:21:44 volumio kernel: FS-Cache: Netfs 'cifs' registered for caching May 02 16:21:44 volumio kernel: Key type cifs.spnego registered May 02 16:21:44 volumio kernel: Key type cifs.idmap registered May 02 16:21:44 volumio kernel: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3 (or SMB2.1) specify vers=1.0 on mount. May 02 16:21:45 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:46 volumio sudo[1396]: pam_unix(sudo:session): session closed for user root May 02 16:21:46 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status May 02 16:21:46 volumio volumio[834]: info: May 02 16:21:46 volumio volumio[834]: ---------------------------- MPD announces state update: update May 02 16:21:46 volumio volumio[834]: info: ControllerMpd::getState May 02 16:21:46 volumio volumio[834]: verbose: ControllerMpd::sendMpdCommand status May 02 16:21:46 volumio volumio[834]: info: sendMpdCommand status took 3 milliseconds May 02 16:21:46 volumio volumio[834]: info: sendMpdCommand status took 1 milliseconds May 02 16:21:46 volumio volumio[834]: verbose: ControllerMpd::parseState May 02 16:21:46 volumio volumio[834]: info: Command Router : Notfying DB Updatetrue May 02 16:21:46 volumio volumio[834]: verbose: ControllerMpd::parseState May 02 16:21:46 volumio volumio[834]: info: ControllerMpd::pushState May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::servicePushState May 02 16:21:46 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:46 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:46 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:46 volumio volumio[834]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} May 02 16:21:46 volumio volumio[834]: verbose: CURRENT POSITION 0 May 02 16:21:46 volumio volumio[834]: info: CoreStateMachine::syncState stateService stop May 02 16:21:46 volumio volumio[834]: info: CoreStateMachine::syncState currentStatus stop May 02 16:21:46 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:46 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:46 volumio volumio[834]: info: No code May 02 16:21:46 volumio volumio[834]: info: CoreStateMachine::pushState May 02 16:21:46 volumio volumio[834]: info: CorePlayQueue::getTrack 0 May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::volumioPushState May 02 16:21:46 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 02 16:21:46 volumio volumio[834]: info: ------------------------------ 63ms May 02 16:21:46 volumio volumio[834]: info: [1746202906197] Database update started May 02 16:21:47 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 02 16:21:49 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:50 volumio volumio[834]: info: CoreCommandRouter::Close All Modals sent May 02 16:21:53 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:21:57 volumio volumio[834]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 02 16:22:02 volumio sudo[1166]: pam_unix(sudo:session): session closed for user root May 02 16:22:02 volumio volumio[834]: info: Cannot mount NAS Music at system boot, trial number 2 ,retrying in 5 seconds May 02 16:22:07 volumio volumio[834]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 16:22:07 volumio volumio[834]: TypeError: Cannot read property 'replace' of undefined May 02 16:22:07 volumio volumio[834]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:198:28) May 02 16:22:07 volumio volumio[834]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:251:20) May 02 16:22:07 volumio volumio[834]: at ontimeout (timers.js:482:11) May 02 16:22:07 volumio volumio[834]: at tryOnTimeout (timers.js:317:5) May 02 16:22:07 volumio volumio[834]: at Timer.listOnTimeout (timers.js:277:5) May 02 16:22:07 volumio volumio[834]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 02 16:22:08 volumio sudo[1526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-02 16:21 May 02 16:22:08 volumio sudo[1526]: 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="cd11dc738d0d82822d0aa776d0729686b82e3758" VOLUMIO_FE_VERSION="537e3f50b5a8aa9bdf42f94adc80b348609b5c47" VOLUMIO_BE_VERSION="d7e6c614214d5dc616fddcbcfefc47e1990da7b1" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed Sep 8 12:10:14 CEST 2021" VOLUMIO_VERSION="2.909" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="3aea8955ace41c92b011ae3a243c3f0d"