-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2024-12-01 13:05:17 CST. -- Dec 01 13:04:01 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:05 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:08 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Dec 01 13:04:08 volumio volumio[1292]: info: Dec 01 13:04:08 volumio volumio[1292]: ---------------------------- MPD announces state update: update Dec 01 13:04:08 volumio volumio[1292]: info: ControllerMpd::getState Dec 01 13:04:08 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Dec 01 13:04:09 volumio volumio[1292]: info: Dec 01 13:04:09 volumio volumio[1292]: ---------------------------- MPD announces state update: update Dec 01 13:04:09 volumio volumio[1292]: info: ControllerMpd::getState Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Dec 01 13:04:09 volumio volumio[1292]: info: Dec 01 13:04:09 volumio volumio[1292]: ---------------------------- MPD announces state update: update Dec 01 13:04:09 volumio volumio[1292]: info: ControllerMpd::getState Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand status Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand status took 5 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand status took 5 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand status took 4 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand status took 3 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand status took 2 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand status took 2 milliseconds Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseState Dec 01 13:04:09 volumio volumio[1292]: info: Command Router : Notfying DB Updatefalse Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::Close All Modals sent Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseState Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseState Dec 01 13:04:09 volumio volumio[1292]: info: Command Router : Notfying DB Updatefalse Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::Close All Modals sent Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseState Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseState Dec 01 13:04:09 volumio volumio[1292]: info: Command Router : Notfying DB Updatefalse Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::Close All Modals sent Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseState Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 48 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 01 13:04:09 volumio volumio[1292]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Dec 01 13:04:09 volumio volumio[1292]: verbose: ControllerMpd::parseTrackInfo Dec 01 13:04:09 volumio volumio[1292]: info: ControllerMpd::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111487,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"09 故乡的雨.wav","artist":null,"album":null,"uri":"NAS/music/《香港往事》/09 故乡的雨.wav","trackType":"wav"} Dec 01 13:04:09 volumio volumio[1292]: verbose: CURRENT POSITION 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Dec 01 13:04:09 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Dec 01 13:04:09 volumio volumio[1292]: info: ControllerMpd::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111487,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"09 故乡的雨.wav","artist":null,"album":null,"uri":"NAS/music/《香港往事》/09 故乡的雨.wav","trackType":"wav"} Dec 01 13:04:09 volumio volumio[1292]: verbose: CURRENT POSITION 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Dec 01 13:04:09 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Dec 01 13:04:09 volumio volumio[1292]: info: ControllerMpd::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::servicePushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: verbose: STATE SERVICE {"status":"play","position":0,"seek":111487,"duration":247,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"09 故乡的雨.wav","artist":null,"album":null,"uri":"NAS/music/《香港往事》/09 故乡的雨.wav","trackType":"wav"} Dec 01 13:04:09 volumio volumio[1292]: verbose: CURRENT POSITION 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::syncState stateService play Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::syncState currentStatus play Dec 01 13:04:09 volumio volumio[1292]: info: Received an update from plugin. extracting info from payload Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Dec 01 13:04:09 volumio volumio[1292]: info: CoreStateMachine::pushState Dec 01 13:04:09 volumio volumio[1292]: info: CorePlayQueue::getTrack 8 Dec 01 13:04:09 volumio volumio[1292]: info: CoreCommandRouter::volumioPushState Dec 01 13:04:09 volumio volumio[1292]: info: ------------------------------ 132ms Dec 01 13:04:09 volumio volumio[1292]: info: ------------------------------ 131ms Dec 01 13:04:09 volumio volumio[1292]: info: ------------------------------ 130ms Dec 01 13:04:13 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:17 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:18 volumio ntpd[2035]: 95.111.202.5 local addr 192.168.88.187 -> Dec 01 13:04:21 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:25 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:29 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:33 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:36 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:40 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:44 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:49 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:52 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:04:56 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:05:00 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:05:04 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:05:08 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:05:12 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:05:16 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Dec 01 13:05:17 volumio volumio[1292]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Dec 01 13:05:17 volumio sudo[4103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/music Dec 01 13:05:17 volumio sudo[4103]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 01 13:05:17 volumio systemd[1]: mnt-NAS-music.mount: Succeeded. Dec 01 13:05:17 volumio sudo[4103]: pam_unix(sudo:session): session closed for user root Dec 01 13:05:17 volumio volumio[1292]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 13:05:17 volumio volumio[1292]: Error: EACCES: permission denied, rmdir '/mnt/NAS/music' Dec 01 13:05:17 volumio volumio[1292]: at Object.rmdirSync (fs.js:917:10) Dec 01 13:05:17 volumio volumio[1292]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Dec 01 13:05:17 volumio volumio[1292]: at ChildProcess.exithandler (child_process.js:374:7) Dec 01 13:05:17 volumio volumio[1292]: at ChildProcess.emit (events.js:400:28) Dec 01 13:05:17 volumio volumio[1292]: at maybeClose (internal/child_process.js:1088:16) Dec 01 13:05:17 volumio volumio[1292]: at Process.ChildProcess._handle.onexit (internal/child_process.js:296:5) { Dec 01 13:05:17 volumio volumio[1292]: errno: -13, Dec 01 13:05:17 volumio volumio[1292]: syscall: 'rmdir', Dec 01 13:05:17 volumio volumio[1292]: code: 'EACCES', Dec 01 13:05:17 volumio volumio[1292]: path: '/mnt/NAS/music' Dec 01 13:05:17 volumio volumio[1292]: } Dec 01 13:05:17 volumio volumio[1292]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 01 13:05:17 volumio sudo[4115]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-12-01 13:04 Dec 01 13:05:17 volumio sudo[4115]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"