-- Logs begin at Wed 2024-10-23 22:19:38 CDT, end at Wed 2024-10-23 22:31:43 CDT. -- Oct 23 22:30:01 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:05 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:09 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:10 volumio nmbd[797]: [2024/10/23 22:30:10.034924, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Oct 23 22:30:10 volumio nmbd[797]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.227 for name WORKGROUP<1d>. Oct 23 22:30:10 volumio nmbd[797]: This response was from IP 192.168.1.10, reporting an IP address of 192.168.1.10. Oct 23 22:30:13 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:17 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:21 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:25 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:26 volumio volumio[859]: info: MPD Database updated - AlbumList cache refreshed Oct 23 22:30:26 volumio volumio[859]: info: Oct 23 22:30:26 volumio volumio[859]: ---------------------------- MPD announces state update: database Oct 23 22:30:26 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Oct 23 22:30:26 volumio volumio[859]: info: Oct 23 22:30:26 volumio volumio[859]: ---------------------------- MPD announces state update: update Oct 23 22:30:26 volumio volumio[859]: info: ControllerMpd::getState Oct 23 22:30:26 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Oct 23 22:30:26 volumio volumio[859]: info: ControllerMpd::getState Oct 23 22:30:26 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Oct 23 22:30:27 volumio volumio[859]: Cannot compose Albumart path Oct 23 22:30:27 volumio volumio[859]: Cannot compose Albumart path Oct 23 22:30:27 volumio volumio[859]: Cannot compose Albumart path Oct 23 22:30:27 volumio volumio[859]: Cannot compose Albumart path Oct 23 22:30:27 volumio volumio[859]: Cannot compose Albumart path Oct 23 22:30:27 volumio volumio[859]: info: sendMpdCommand status took 1517 milliseconds Oct 23 22:30:27 volumio volumio[859]: info: sendMpdCommand status took 1519 milliseconds Oct 23 22:30:27 volumio volumio[859]: info: sendMpdCommand status took 1519 milliseconds Oct 23 22:30:27 volumio volumio[859]: verbose: ControllerMpd::parseState Oct 23 22:30:27 volumio volumio[859]: info: Command Router : Notfying DB Updatefalse Oct 23 22:30:27 volumio volumio[859]: info: CoreCommandRouter::Close All Modals sent Oct 23 22:30:27 volumio volumio[859]: verbose: ControllerMpd::parseState Oct 23 22:30:27 volumio volumio[859]: info: ControllerMpd::pushState Oct 23 22:30:27 volumio volumio[859]: info: CoreCommandRouter::servicePushState Oct 23 22:30:27 volumio volumio[859]: info: CoreStateMachine::pushState Oct 23 22:30:27 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Oct 23 22:30:27 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Oct 23 22:30:27 volumio volumio[859]: info: ControllerMpd::pushState Oct 23 22:30:27 volumio volumio[859]: info: CoreCommandRouter::servicePushState Oct 23 22:30:27 volumio volumio[859]: info: CoreStateMachine::pushState Oct 23 22:30:27 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Oct 23 22:30:27 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Oct 23 22:30:27 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'pushState' of null Oct 23 22:30:27 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'pushState' of null Oct 23 22:30:27 volumio volumio[859]: info: ------------------------------ 1549ms Oct 23 22:30:27 volumio volumio[859]: info: ------------------------------ 1548ms Oct 23 22:30:29 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:33 volumio ntpd[1521]: 137.190.2.4 local addr 192.168.1.227 -> Oct 23 22:30:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:37 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:43 volumio volumio[859]: info: CALLMETHOD: miscellanea my_music updateMusicLibraryBrowseSourcesVisibility [object Object] Oct 23 22:30:43 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , updateMusicLibraryBrowseSourcesVisibility Oct 23 22:30:43 volumio volumio[859]: error: Failed callmethod call: TypeError: Cannot read property 'printToastMessage' of null Oct 23 22:30:45 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:49 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:30:50 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Oct 23 22:30:50 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Oct 23 22:30:51 volumio volumio[859]: info: CoreCommandRouter::volumioGetQueue Oct 23 22:30:51 volumio volumio[859]: info: CoreStateMachine::getQueue Oct 23 22:30:51 volumio volumio[859]: info: CorePlayQueue::getQueue Oct 23 22:30:54 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 23 22:30:54 volumio volumio[859]: info: CURURI: music-library Oct 23 22:30:54 volumio volumio[859]: info: Preload queue cleared Oct 23 22:31:04 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 23 22:31:04 volumio volumio[859]: info: CURURI: albums:// Oct 23 22:31:04 volumio volumio[859]: info: listAlbums - loading Albums from cache Oct 23 22:31:04 volumio volumio[859]: info: Preload queue cleared Oct 23 22:31:31 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Oct 23 22:31:31 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 22:31:33 volumio volumio[859]: info: Retrieving Cloud Streaming UI Oct 23 22:31:33 volumio volumio[859]: info: Getting Tidal Cloud Configuration Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 22:31:33 volumio volumio[859]: info: Getting Qobuz Cloud Configuration Oct 23 22:31:33 volumio volumio[859]: info: Asking plugin for UI Config Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 22:31:33 volumio volumio[859]: info: Getting Spotify Cloud Configuration Oct 23 22:31:33 volumio volumio[859]: info: Asking plugin for UI Config Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 22:31:33 volumio volumio[859]: info: Saving Spotify Acccount Oct 23 22:31:33 volumio volumio[859]: info: Got Tidal Cloud Configuration Oct 23 22:31:33 volumio volumio[859]: info: Got it Oct 23 22:31:33 volumio volumio[859]: info: Got it Oct 23 22:31:33 volumio volumio[859]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 23 22:31:33 volumio volumio[859]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:31:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 23 22:31:37 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:31:40 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Oct 23 22:31:40 volumio sudo[3169]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/Music Oct 23 22:31:40 volumio sudo[3169]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 23 22:31:40 volumio systemd[1]: mnt-NAS-Music.mount: Succeeded. Oct 23 22:31:40 volumio sudo[3169]: pam_unix(sudo:session): session closed for user root Oct 23 22:31:40 volumio volumio[859]: info: Share Music successfully unmounted Oct 23 22:31:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 23 22:31:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 23 22:31:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Oct 23 22:31:43 volumio volumio[859]: info: Oct 23 22:31:43 volumio volumio[859]: ---------------------------- MPD announces state update: update Oct 23 22:31:43 volumio volumio[859]: info: ControllerMpd::getState Oct 23 22:31:43 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Oct 23 22:31:43 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Oct 23 22:31:43 volumio volumio[859]: info: sendMpdCommand status took 1 milliseconds Oct 23 22:31:43 volumio volumio[859]: verbose: ControllerMpd::parseState Oct 23 22:31:43 volumio volumio[859]: info: Command Router : Notfying DB Updatetrue Oct 23 22:31:43 volumio volumio[859]: info: CoreCommandRouter::Close All Modals sent Oct 23 22:31:43 volumio volumio[859]: verbose: ControllerMpd::parseState Oct 23 22:31:43 volumio volumio[859]: info: ControllerMpd::pushState Oct 23 22:31:43 volumio volumio[859]: info: CoreCommandRouter::servicePushState Oct 23 22:31:43 volumio volumio[859]: info: CoreStateMachine::pushState Oct 23 22:31:43 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Oct 23 22:31:43 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Oct 23 22:31:43 volumio volumio[859]: error: ControllerMpd::pushError: TypeError: Cannot read property 'pushState' of null Oct 23 22:31:43 volumio volumio[859]: info: ------------------------------ 38ms Oct 23 22:31:43 volumio volumio[859]: info: [1729740703478] Database update started Oct 23 22:31:43 volumio volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 22:31:43 volumio volumio[859]: TypeError: Cannot read property 'printToastMessage' of null Oct 23 22:31:43 volumio volumio[859]: at /volumio/app/index.js:1201:32 Oct 23 22:31:43 volumio volumio[859]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Oct 23 22:31:43 volumio volumio[859]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Oct 23 22:31:43 volumio volumio[859]: at CoreCommandRouter.pushToastMessage (/volumio/app/index.js:1199:13) Oct 23 22:31:43 volumio volumio[859]: at /volumio/app/plugins/system_controller/networkfs/index.js:306:26 Oct 23 22:31:43 volumio volumio[859]: at ChildProcess.exithandler (child_process.js:374:7) Oct 23 22:31:43 volumio volumio[859]: at ChildProcess.emit (events.js:400:28) Oct 23 22:31:43 volumio volumio[859]: at maybeClose (internal/child_process.js:1088:16) Oct 23 22:31:43 volumio volumio[859]: at Socket. (internal/child_process.js:446:11) Oct 23 22:31:43 volumio volumio[859]: at Socket.emit (events.js:400:28) Oct 23 22:31:43 volumio volumio[859]: at Pipe. (net.js:686:12) Oct 23 22:31:43 volumio volumio[859]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 22:31:43 volumio sudo[3186]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-23 22:30 Oct 23 22:31:43 volumio sudo[3186]: 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"