-- Logs begin at Sun 2024-04-28 07:22:12 UTC, end at Sun 2024-04-28 07:24:44 UTC. -- Apr 28 07:23:06 volumio systemd[1]: Time has been changed Apr 28 07:23:07 volumio volumio[859]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Apr 28 07:23:07 volumio volumio[859]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Apr 28 07:23:07 volumio volumio[859]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Apr 28 07:23:07 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:23:07 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:23:07 volumio volumio[859]: info: Starting MyVolumio Remote Streaming Endpoints Apr 28 07:23:07 volumio volumio[859]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Apr 28 07:23:07 volumio volumio[859]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Apr 28 07:23:07 volumio volumio[859]: info: Streaming services startup Apr 28 07:23:07 volumio volumio[859]: info: Starting Streaming Daemon Apr 28 07:23:07 volumio sudo[1388]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Apr 28 07:23:07 volumio sudo[1388]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:23:07 volumio volumio[859]: info: MyVolumio not started Apr 28 07:23:07 volumio volumio[859]: info: Initializing device activation check Apr 28 07:23:07 volumio volumio[859]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Apr 28 07:23:07 volumio systemd[1]: Stopping Volumio Streaming Daemon... Apr 28 07:23:07 volumio systemd[1]: Starting Volumio Streaming Daemon... Apr 28 07:23:07 volumio systemd[1]: Started Volumio Streaming Daemon. Apr 28 07:23:07 volumio sudo[1388]: pam_unix(sudo:session): session closed for user root Apr 28 07:23:07 volumio volumio-streaming-daemon[1398]: ############################ Apr 28 07:23:07 volumio volumio-streaming-daemon[1398]: # Volumio Streaming Daemon # Apr 28 07:23:07 volumio volumio-streaming-daemon[1398]: # Running on port 7777 # Apr 28 07:23:07 volumio volumio-streaming-daemon[1398]: ############################ Apr 28 07:23:07 volumio volumio-streaming-daemon[1398]: Environment: production Apr 28 07:23:10 volumio volumio-streaming-daemon[1398]: Environment: production Apr 28 07:23:10 volumio volumio[859]: info: Fetching Streaming Services browse cache Apr 28 07:23:11 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Apr 28 07:23:11 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 07:23:12 volumio volumio[859]: info: Listing playlists Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 28 07:23:12 volumio volumio[859]: info: Discovery: Getting this device information Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Apr 28 07:23:12 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: network , getCachedPAddresses Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConf Apr 28 07:23:12 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConf Apr 28 07:23:14 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 28 07:23:17 volumio volumio[859]: info: CoreCommandRouter::volumioGetState Apr 28 07:23:17 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:23:18 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Apr 28 07:23:18 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Apr 28 07:23:24 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:24 volumio volumio[859]: info: CURURI: music-library/NAS Apr 28 07:23:25 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:25 volumio volumio[859]: info: CURURI: music-library/NAS/daphile Apr 28 07:23:27 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:27 volumio volumio[859]: info: CURURI: music-library/NAS/daphile/第一辑 Apr 28 07:23:28 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 07:23:28 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:23:29 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 28 07:23:29 volumio volumio[859]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Apr 28 07:23:29 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Apr 28 07:23:29 volumio volumio[859]: info: Error : CoreCommandRouter::executeOnPlugin: No method [retreiveBackendEventStates] in plugin my_volumio Apr 28 07:23:29 volumio volumio[859]: info: Received Get System Version Apr 28 07:23:29 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 07:23:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:33 volumio volumio[859]: info: CURURI: music-library/INTERNAL Apr 28 07:23:33 volumio volumio[859]: error: Failed LSINFO: Error: [50@0] {} No such directory Apr 28 07:23:40 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:40 volumio volumio[859]: info: CURURI: music-library Apr 28 07:23:41 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:41 volumio volumio[859]: info: CURURI: music-library/NAS Apr 28 07:23:42 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Apr 28 07:23:42 volumio volumio[859]: info: CURURI: music-library/NAS/daphile Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 28 07:23:48 volumio volumio[859]: info: Getting Alsa Cards List without I2S DAC Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Apr 28 07:23:48 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:51 volumio volumio[859]: info: Retrieving Cloud Streaming UI Apr 28 07:23:51 volumio volumio[859]: info: Getting Tidal Cloud Configuration Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:51 volumio volumio[859]: info: Getting Qobuz Cloud Configuration Apr 28 07:23:51 volumio volumio[859]: info: Asking plugin for UI Config Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:51 volumio volumio[859]: info: Getting Spotify Cloud Configuration Apr 28 07:23:51 volumio volumio[859]: info: Asking plugin for UI Config Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:51 volumio volumio[859]: info: Saving Spotify Acccount Apr 28 07:23:51 volumio volumio[859]: info: Got Tidal Cloud Configuration Apr 28 07:23:51 volumio volumio[859]: info: Got it Apr 28 07:23:51 volumio volumio[859]: info: Got it Apr 28 07:23:51 volumio volumio[859]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 28 07:23:51 volumio volumio[859]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::volumioGetBrowseSources Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:23:51 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 28 07:23:55 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:23:59 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:03 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:07 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:11 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Apr 28 07:24:15 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand rescan Apr 28 07:24:15 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Apr 28 07:24:15 volumio volumio[859]: info: Apr 28 07:24:15 volumio volumio[859]: ---------------------------- MPD announces state update: update Apr 28 07:24:15 volumio volumio[859]: info: sendMpdCommand rescan took 8 milliseconds Apr 28 07:24:15 volumio volumio[859]: info: ControllerMpd::getState Apr 28 07:24:15 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Apr 28 07:24:15 volumio volumio[859]: info: sendMpdCommand status took 92 milliseconds Apr 28 07:24:15 volumio volumio[859]: info: sendMpdCommand status took 87 milliseconds Apr 28 07:24:15 volumio volumio[859]: verbose: ControllerMpd::parseState Apr 28 07:24:15 volumio volumio[859]: info: Command Router : Notfying DB Updatetrue Apr 28 07:24:15 volumio volumio[859]: verbose: ControllerMpd::parseState Apr 28 07:24:15 volumio volumio[859]: info: ControllerMpd::pushState Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::servicePushState Apr 28 07:24:15 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:15 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:15 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:15 volumio volumio[859]: 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} Apr 28 07:24:15 volumio volumio[859]: verbose: CURRENT POSITION 0 Apr 28 07:24:15 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Apr 28 07:24:15 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Apr 28 07:24:15 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:15 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:15 volumio volumio[859]: info: No code Apr 28 07:24:15 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:15 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:15 volumio volumio[859]: info: ------------------------------ 169ms Apr 28 07:24:15 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::Close All Modals sent Apr 28 07:24:16 volumio volumio[859]: info: MPD Database updated - AlbumList cache refreshed Apr 28 07:24:16 volumio volumio[859]: info: Apr 28 07:24:16 volumio volumio[859]: ---------------------------- MPD announces state update: database Apr 28 07:24:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Apr 28 07:24:16 volumio volumio[859]: info: Apr 28 07:24:16 volumio volumio[859]: ---------------------------- MPD announces state update: update Apr 28 07:24:16 volumio volumio[859]: info: ControllerMpd::getState Apr 28 07:24:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Apr 28 07:24:16 volumio volumio[859]: info: ControllerMpd::getState Apr 28 07:24:16 volumio volumio[859]: verbose: ControllerMpd::sendMpdCommand status Apr 28 07:24:16 volumio volumio[859]: info: sendMpdCommand status took 37 milliseconds Apr 28 07:24:16 volumio volumio[859]: info: sendMpdCommand status took 36 milliseconds Apr 28 07:24:16 volumio volumio[859]: info: sendMpdCommand status took 36 milliseconds Apr 28 07:24:16 volumio volumio[859]: verbose: ControllerMpd::parseState Apr 28 07:24:16 volumio volumio[859]: info: Command Router : Notfying DB Updatefalse Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::Close All Modals sent Apr 28 07:24:16 volumio volumio[859]: verbose: ControllerMpd::parseState Apr 28 07:24:16 volumio volumio[859]: verbose: ControllerMpd::parseState Apr 28 07:24:16 volumio volumio[859]: info: ControllerMpd::pushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::servicePushState Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: 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} Apr 28 07:24:16 volumio volumio[859]: verbose: CURRENT POSITION 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:16 volumio volumio[859]: info: No code Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:16 volumio volumio[859]: info: ControllerMpd::pushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::servicePushState Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: 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} Apr 28 07:24:16 volumio volumio[859]: verbose: CURRENT POSITION 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::syncState stateService stop Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::syncState currentStatus stop Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:16 volumio volumio[859]: info: No code Apr 28 07:24:16 volumio volumio[859]: info: CoreStateMachine::pushState Apr 28 07:24:16 volumio volumio[859]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:16 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:16 volumio volumio[859]: info: ------------------------------ 120ms Apr 28 07:24:16 volumio volumio[859]: info: ------------------------------ 120ms Apr 28 07:24:19 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:23 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:27 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:31 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:33 volumio volumio[859]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Apr 28 07:24:33 volumio sudo[1484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/daphile Apr 28 07:24:33 volumio sudo[1484]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:33 volumio sudo[1484]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:33 volumio volumio[859]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 07:24:33 volumio volumio[859]: { Error: EBUSY: resource busy or locked, rmdir '/mnt/NAS/daphile' Apr 28 07:24:33 volumio volumio[859]: at Object.fs.rmdirSync (fs.js:846:18) Apr 28 07:24:33 volumio volumio[859]: at /volumio/node_modules/linux-mountutils/mountutils.js:178:12 Apr 28 07:24:33 volumio volumio[859]: at ChildProcess.exithandler (child_process.js:267:7) Apr 28 07:24:33 volumio volumio[859]: at emitTwo (events.js:126:13) Apr 28 07:24:33 volumio volumio[859]: at ChildProcess.emit (events.js:214:7) Apr 28 07:24:33 volumio volumio[859]: at maybeClose (internal/child_process.js:925:16) Apr 28 07:24:33 volumio volumio[859]: at Process.ChildProcess._handle.onexit (internal/child_process.js:209:5) Apr 28 07:24:33 volumio volumio[859]: errno: -16, Apr 28 07:24:33 volumio volumio[859]: code: 'EBUSY', Apr 28 07:24:33 volumio volumio[859]: syscall: 'rmdir', Apr 28 07:24:33 volumio volumio[859]: path: '/mnt/NAS/daphile' } Apr 28 07:24:33 volumio volumio[859]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 07:24:34 volumio sudo[1501]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 07:23 Apr 28 07:24:34 volumio sudo[1501]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:34 volumio sudo[1501]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:35 volumio volumio-remote-updater[586]: [2024-04-28 07:24:35] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Apr 28 07:24:35 volumio volumio-remote-updater[586]: [2024-04-28 07:24:35] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Apr 28 07:24:35 volumio systemd[1]: volumio.service: main process exited, code=exited, status=1/FAILURE Apr 28 07:24:35 volumio systemd[1]: Unit volumio.service entered failed state. Apr 28 07:24:35 volumio systemd[1]: Starting dynamicswap service... Apr 28 07:24:35 volumio systemd[1]: Started dynamicswap service. Apr 28 07:24:35 volumio systemd[1]: volumio.service holdoff time over, scheduling restart. Apr 28 07:24:35 volumio systemd[1]: Starting dynamicswap service... Apr 28 07:24:35 volumio systemd[1]: Started dynamicswap service. Apr 28 07:24:35 volumio systemd[1]: Stopping Volumio Backend Module... Apr 28 07:24:35 volumio systemd[1]: Starting Volumio Backend Module... Apr 28 07:24:35 volumio systemd[1]: Started Volumio Backend Module. Apr 28 07:24:36 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:36 volumio volumio[1525]: info: ----- Volumio2 ---- Apr 28 07:24:36 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:36 volumio volumio[1525]: info: ----- System startup ---- Apr 28 07:24:36 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:37 volumio volumio[1525]: info: MYVOLUMIO Environment detected Apr 28 07:24:37 volumio volumio[1525]: info: Plugin folders cleanup Apr 28 07:24:37 volumio volumio[1525]: info: Scanning into folder /volumio/app/plugins/ Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category audio_interface Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category miscellanea Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category music_service Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category plugins.json Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category system_controller Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category user_interface Apr 28 07:24:37 volumio volumio[1525]: info: Scanning into folder /data/plugins/ Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category accessory Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category miscellanea Apr 28 07:24:37 volumio volumio[1525]: info: Scanning category system_controller Apr 28 07:24:37 volumio volumio[1525]: info: Plugin folders cleanup completed Apr 28 07:24:37 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:37 volumio volumio[1525]: info: ----- Core plugins startup ---- Apr 28 07:24:37 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:37 volumio volumio[1525]: info: Loading plugins from folder /volumio/app/plugins/ Apr 28 07:24:37 volumio volumio[1525]: info: Adding plugin upnp to MyMusic Plugins Apr 28 07:24:37 volumio volumio[1525]: info: Adding plugin airplay_emulation to MyMusic Plugins Apr 28 07:24:37 volumio volumio[1525]: info: Adding plugin upnp_browser to MyMusic Plugins Apr 28 07:24:37 volumio volumio[1525]: info: Loading plugins from folder /data/plugins/ Apr 28 07:24:37 volumio volumio[1525]: info: Loading plugin "system"... Apr 28 07:24:37 volumio volumio[1525]: info: Loading plugin "appearance"... Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "network"... Apr 28 07:24:38 volumio volumio[1525]: info: Refreshing Cached IP Addresses Apr 28 07:24:38 volumio sudo[1550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "touch_display"... Apr 28 07:24:38 volumio sudo[1550]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:38 volumio sudo[1553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Apr 28 07:24:38 volumio sudo[1550]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:38 volumio sudo[1553]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:38 volumio sudo[1553]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:38 volumio volumio[1525]: info: Applying required configuration parameters for plugin touch_display Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "services"... Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "alsa_controller"... Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "wizard"... Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "volumio_command_line_client"... Apr 28 07:24:38 volumio volumio[1525]: info: Plugin upnp is not enabled Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "my_music"... Apr 28 07:24:38 volumio volumio[1525]: info: Loading plugin "mpd"... Apr 28 07:24:39 volumio volumio[1525]: info: Plugin upnp_browser is not enabled Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "networkfs"... Apr 28 07:24:39 volumio volumio[1525]: info: Cannot mount NAS daphile at system boot, trial number 1 ,retrying in 5 seconds Apr 28 07:24:39 volumio volumio[1525]: info: Cannot mount NAS daphile at system boot, trial number 1 ,retrying in 5 seconds Apr 28 07:24:39 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "alarm-clock"... Apr 28 07:24:39 volumio volumio[1525]: info: Plugin airplay_emulation is not enabled Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "last_100"... Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "webradio"... Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "i2s_dacs"... Apr 28 07:24:39 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "volumiodiscovery"... Apr 28 07:24:39 volumio volumio[1525]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 28 07:24:39 volumio node[1525]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Apr 28 07:24:39 volumio volumio[1525]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 07:24:39 volumio node[1525]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 07:24:39 volumio volumio[1525]: *** WARNING *** For more information see Apr 28 07:24:39 volumio node[1525]: *** WARNING *** For more information see Apr 28 07:24:39 volumio volumio[1525]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 28 07:24:39 volumio node[1525]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Apr 28 07:24:39 volumio volumio[1525]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 07:24:39 volumio node[1525]: *** WARNING *** Please fix your application to use the native API of Avahi! Apr 28 07:24:39 volumio volumio[1525]: *** WARNING *** For more information see Apr 28 07:24:39 volumio node[1525]: *** WARNING *** For more information see Apr 28 07:24:39 volumio volumio[1525]: info: Applying required configuration parameters for plugin volumiodiscovery Apr 28 07:24:39 volumio volumio[1525]: Discovery: StartAdv! undefined Apr 28 07:24:39 volumio volumio[1525]: Discovery: Started advertising... Volumio - undefined Apr 28 07:24:39 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "gpio-buttons"... Apr 28 07:24:39 volumio volumio[1525]: info: GPIO-Buttons initialized Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "outputs"... Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "albumart"... Apr 28 07:24:39 volumio volumio[1525]: info: Plugin example_plugin is not enabled Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "inputs"... Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "updater_comm"... Apr 28 07:24:39 volumio volumio[1525]: info: Plugin mpdemulation is not enabled Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "rest_api"... Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "websocket"... Apr 28 07:24:39 volumio volumio[1525]: info: Plugin ir_controller is not enabled Apr 28 07:24:39 volumio volumio[1525]: info: Loading plugin "503_hta_tube_amp"... Apr 28 07:24:39 volumio volumio[1525]: error: !!!! WARNING !!!! Apr 28 07:24:39 volumio volumio[1525]: error: The plugin miscellanea/503_hta_tube_amp failed to load, setting it to stopped. Error: Error: The module '/data/plugins/miscellanea/503_hta_tube_amp/node_modules/epoll/build/Release/epoll.node' Apr 28 07:24:39 volumio volumio[1525]: was compiled against a different Node.js version using Apr 28 07:24:39 volumio volumio[1525]: NODE_MODULE_VERSION 48. This version of Node.js requires Apr 28 07:24:39 volumio volumio[1525]: NODE_MODULE_VERSION 57. Please try re-compiling or re-installing Apr 28 07:24:39 volumio volumio[1525]: the module (for instance, using `npm rebuild` or `npm install`). Apr 28 07:24:39 volumio volumio[1525]: error: Stack trace: Error: The module '/data/plugins/miscellanea/503_hta_tube_amp/node_modules/epoll/build/Release/epoll.node' Apr 28 07:24:39 volumio volumio[1525]: was compiled against a different Node.js version using Apr 28 07:24:39 volumio volumio[1525]: NODE_MODULE_VERSION 48. This version of Node.js requires Apr 28 07:24:39 volumio volumio[1525]: NODE_MODULE_VERSION 57. Please try re-compiling or re-installing Apr 28 07:24:39 volumio volumio[1525]: the module (for instance, using `npm rebuild` or `npm install`). Apr 28 07:24:39 volumio volumio[1525]: at Object.Module._extensions..node (module.js:681:18) Apr 28 07:24:39 volumio volumio[1525]: at Module.load (module.js:565:32) Apr 28 07:24:39 volumio volumio[1525]: at tryModuleLoad (module.js:505:12) Apr 28 07:24:39 volumio volumio[1525]: at Function.Module._load (module.js:497:3) Apr 28 07:24:39 volumio volumio[1525]: at Module.require (module.js:596:17) Apr 28 07:24:39 volumio volumio[1525]: at require (internal/module.js:11:18) Apr 28 07:24:39 volumio volumio[1525]: at bindings (/data/plugins/miscellanea/503_hta_tube_amp/node_modules/bindings/bindings.js:76:44) Apr 28 07:24:39 volumio volumio[1525]: at Object. (/data/plugins/miscellanea/503_hta_tube_amp/node_modules/epoll/epoll.js:1:99) Apr 28 07:24:39 volumio volumio[1525]: at Module._compile (module.js:652:30) Apr 28 07:24:39 volumio volumio[1525]: at Object.Module._extensions..js (module.js:663:10) Apr 28 07:24:39 volumio volumio[1525]: error: !!!! WARNING !!!! Apr 28 07:24:39 volumio volumio[1525]: info: ___________ START PLUGINS ___________ Apr 28 07:24:40 volumio volumio[1525]: info: Loading i18n strings for locale zh Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 07:24:40 volumio volumio[1525]: info: [1714289080028] CoreMusicLibrary::Adding element Last_100 Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 28 07:24:40 volumio volumio[1525]: info: [1714289080034] CoreMusicLibrary::Adding element Webradio Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 07:24:40 volumio sudo[1583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 28 07:24:40 volumio volumio[1525]: Forking 3 albumart workers Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons: Reading config and creating triggers... Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons: playPause on pin 4 Apr 28 07:24:40 volumio sudo[1583]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons: volumeUp on pin 5 Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons: volumeDown on pin 7 Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons: previous on pin 8 Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons: next on pin 6 Apr 28 07:24:40 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:40 volumio volumio[1525]: info: ----- MyVolumio plugins startup ---- Apr 28 07:24:40 volumio volumio[1525]: info: ------------------------------------------- Apr 28 07:24:40 volumio volumio[1525]: info: [MyVolumio PluginManager] Fetching plans data.... Apr 28 07:24:40 volumio systemd[1]: Reloading. Apr 28 07:24:40 volumio volumio[1525]: info: Loading i18n strings for locale zh Apr 28 07:24:40 volumio volumio[1525]: Updating browse sources language Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::initPlayerControls Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Apr 28 07:24:40 volumio systemd[1]: [/lib/systemd/system/mpd.service:18] Unknown lvalue 'ProtectKernelTunables' in section 'Service' Apr 28 07:24:40 volumio systemd[1]: [/lib/systemd/system/mpd.service:19] Unknown lvalue 'ProtectControlGroups' in section 'Service' Apr 28 07:24:40 volumio systemd[1]: [/lib/systemd/system/mpd.service:20] Unknown lvalue 'ProtectKernelModules' in section 'Service' Apr 28 07:24:40 volumio systemd[1]: [/lib/systemd/system/mpd.service:23] Unknown lvalue 'RestrictNamespaces' in section 'Service' Apr 28 07:24:40 volumio sudo[1583]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: BOOT COMPLETED Apr 28 07:24:40 volumio volumio[1525]: [Metrics] CommandRouter: 3s 300.31ms Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::Close All Modals sent Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::Close All Modals sent Apr 28 07:24:40 volumio volumio[1525]: Express server listening on port 3000 Apr 28 07:24:40 volumio volumio[1525]: [Metrics] WebUI: 3s 585.06ms Apr 28 07:24:40 volumio volumio[1525]: Volumio Calling Home Apr 28 07:24:40 volumio volumio[1525]: info: GPIO-Buttons started Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::resetVolumioState Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::getcurrentVolume Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioRetrievevolume Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::pushState Apr 28 07:24:40 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:40 volumio volumio[1525]: info: Setting Device type: Raspberry PI Apr 28 07:24:40 volumio volumio[1525]: info: touch_display: systemctl daemon-reload succeeded. Apr 28 07:24:40 volumio volumio[1525]: info: MPD running with PID655 Apr 28 07:24:40 volumio volumio[1525]: ,establishing connection Apr 28 07:24:40 volumio sudo[1629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 28 07:24:40 volumio volumio[1525]: Starting albumart workers Apr 28 07:24:40 volumio volumio[1525]: Starting albumart workers Apr 28 07:24:40 volumio volumio[1525]: Starting albumart workers Apr 28 07:24:40 volumio sudo[1629]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:40 volumio systemd[1]: Started Volumio Kiosk. Apr 28 07:24:40 volumio sudo[1629]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:40 volumio volumio-remote-updater[586]: [2024-04-28 07:24:40] [connect] Successful connection Apr 28 07:24:40 volumio volumio[1525]: info: Reloading queue from file Apr 28 07:24:40 volumio volumio[1525]: error: updateQueue error: null Apr 28 07:24:40 volumio volumio[1525]: error: Failed LSINFO: Error: [50@0] {} No such directory Apr 28 07:24:40 volumio volumio[1525]: info: touch_display: systemctl start volumio-kiosk.service succeeded. Apr 28 07:24:40 volumio volumio[1525]: info: touch_display: Volumio Kiosk started Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioGetState Apr 28 07:24:40 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::setRepeat true single undefined Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::pushState Apr 28 07:24:40 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::setRandom true Apr 28 07:24:40 volumio volumio[1525]: info: CoreStateMachine::pushState Apr 28 07:24:40 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:40 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:41 volumio volumio-remote-updater[586]: [2024-04-28 07:24:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1714289080 101 Apr 28 07:24:41 volumio volumio[1525]: info: Volumio called home Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: Raspberry Pi Foundation touch screen detected. Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: Backlight module of a Raspberry Pi Foundation touch screen detected. Apr 28 07:24:41 volumio volumio[1525]: Discovery: adding 6bd8bba3-f981-4f0c-81e8-5e3f30c20c8f Apr 28 07:24:41 volumio volumio[1525]: info: mDNS: Found device Volumio Apr 28 07:24:41 volumio volumio[1525]: info: CoreCommandRouter::volumioGetState Apr 28 07:24:41 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:41 volumio sudo[1668]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sed -i -e /Option "TransformationMatrix"/d /etc/X11/xorg.conf.d/95-touch_display-plugin.conf Apr 28 07:24:41 volumio sudo[1668]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Apr 28 07:24:41 volumio sudo[1668]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:41 volumio volumio[1525]: info: CoreCommandRouter::volumioGetState Apr 28 07:24:41 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: Setting screensaver timeout to 0 seconds. Apr 28 07:24:41 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 28 07:24:41 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 28 07:24:41 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: Touchscreen transformation matrix removed. Apr 28 07:24:41 volumio sudo[1683]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+w /sys/devices/platform/rpi_backlight/backlight/rpi_backlight/brightness Apr 28 07:24:41 volumio sudo[1683]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:41 volumio sudo[1683]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:41 volumio volumio[1525]: info: touch_display: File permissions for backlight brightness control set. Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::volumioGetState Apr 28 07:24:42 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:42 volumio sudo[1693]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/umount /mnt/NAS/daphile Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 28 07:24:42 volumio volumio[1525]: info: Listing playlists Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::volumioGetVisibleSources Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 28 07:24:42 volumio sudo[1693]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24:42 volumio volumio[1525]: info: CoreCommandRouter::volumioGetQueue Apr 28 07:24:42 volumio volumio[1525]: info: CoreStateMachine::getQueue Apr 28 07:24:42 volumio volumio[1525]: info: CorePlayQueue::getQueue Apr 28 07:24:42 volumio sudo[1693]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:42 volumio volumio[1525]: info: Share daphile successfully unmounted Apr 28 07:24:43 volumio volumio[1525]: info: CoreCommandRouter::volumioGetState Apr 28 07:24:43 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:43 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 28 07:24:43 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 28 07:24:43 volumio volumio[1525]: info: Apr 28 07:24:43 volumio volumio[1525]: ---------------------------- Client requests Volume 100 Apr 28 07:24:43 volumio volumio[1525]: info: VolumeController::SetAlsaVolume100 Apr 28 07:24:43 volumio volumio[1525]: info: CoreStateMachine::pushState Apr 28 07:24:43 volumio volumio[1525]: info: CorePlayQueue::getTrack 0 Apr 28 07:24:43 volumio volumio[1525]: info: CoreCommandRouter::volumioPushState Apr 28 07:24:43 volumio volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 28 07:24:44 volumio volumio[1525]: info: Setting volume on startup at 100 Apr 28 07:24:44 volumio volumio[1525]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 07:24:44 volumio volumio[1525]: TypeError: Cannot read property 'replace' of undefined Apr 28 07:24:44 volumio volumio[1525]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:198:28) Apr 28 07:24:44 volumio volumio[1525]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:251:20) Apr 28 07:24:44 volumio volumio[1525]: at ontimeout (timers.js:482:11) Apr 28 07:24:44 volumio volumio[1525]: at tryOnTimeout (timers.js:317:5) Apr 28 07:24:44 volumio volumio[1525]: at Timer.listOnTimeout (timers.js:277:5) Apr 28 07:24:44 volumio sudo[1708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.19/044E1A594E1A43B8 /mnt/NAS/daphile Apr 28 07:24:44 volumio volumio[1525]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 28 07:24:44 volumio sudo[1708]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 28 07:24: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. Apr 28 07:24:44 volumio sudo[1708]: pam_unix(sudo:session): session closed for user root Apr 28 07:24:44 volumio kernel: CIFS VFS: parse_server_interfaces: malformed interface info Apr 28 07:24:44 volumio sudo[1727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-28 07:23 Apr 28 07:24:44 volumio sudo[1727]: 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="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Sep 30 22:42:09 CEST 2021" VOLUMIO_VERSION="2.915" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="02ee61bb422c79b6e5c0b6d1847a78d9"