-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2025-03-04 14:32:47 CET. -- Mar 04 14:31:00 volumio-secondo sudo[1468]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=pasquale,password=franca338elba,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.1.8/MusicFlac /mnt/NAS/MFlac Mar 04 14:31:00 volumio-secondo sudo[1468]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 14:31:00 volumio-secondo kernel: CIFS: Attempting to mount //192.168.1.8/MusicFlac Mar 04 14:31:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 14:31:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 14:31:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 04 14:31:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Mar 04 14:31:00 volumio-secondo volumio-remote-updater[633]: No test mode Mar 04 14:31:00 volumio-secondo volumio-remote-updater[633]: No alpha test mode Mar 04 14:31:00 volumio-secondo volumio[1049]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Mar 04 14:31:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 14:31:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 04 14:31:03 volumio-secondo volumio[1049]: error: MyVolumio Plugin failed to authenticate in a timely fashion Mar 04 14:31:03 volumio-secondo volumio[1049]: info: Completed starting MyVolumio Plugin Mar 04 14:31:03 volumio-secondo volumio[1049]: [Metrics] CommandRouter: 43s 666.26ms Mar 04 14:31:03 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumiosetStartupVolume Mar 04 14:31:03 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 04 14:31:03 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 04 14:31:03 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:03 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:04 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:04 volumio-secondo volumio[1326]: ..................................................................................................++++ Mar 04 14:31:04 volumio-secondo volumio[1326]: e is 65537 (0x010001) Mar 04 14:31:04 volumio-secondo volumio[1326]: writing RSA key Mar 04 14:31:04 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Mar 04 14:31:04 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Mar 04 14:31:04 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Mar 04 14:31:06 volumio-secondo sudo[1468]: pam_unix(sudo:session): session closed for user root Mar 04 14:31:06 volumio-secondo volumio[1049]: info: Cannot mount NAS MFlac at system boot, trial number 4 ,retrying in 5 seconds Mar 04 14:31:06 volumio-secondo kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 04 14:31:06 volumio-secondo kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Mar 04 14:31:08 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:10 volumio-secondo volumio[1049]: info: BOOT COMPLETED Mar 04 14:31:11 volumio-secondo sudo[1550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=pasquale,password=franca338elba,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.1.8/MusicFlac /mnt/NAS/MFlac Mar 04 14:31:11 volumio-secondo sudo[1550]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 14:31:11 volumio-secondo kernel: CIFS: Attempting to mount //192.168.1.8/MusicFlac Mar 04 14:31:12 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:13 volumio-secondo ntpd[792]: Soliciting pool server 212.45.144.3 Mar 04 14:31:14 volumio-secondo ntpd[792]: Soliciting pool server 185.157.229.254 Mar 04 14:31:14 volumio-secondo ntpd[792]: Soliciting pool server 212.45.144.206 Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Retrieving Cloud Streaming UI Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Getting Tidal Cloud Configuration Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Getting Qobuz Cloud Configuration Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Asking plugin for UI Config Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Getting Spotify Cloud Configuration Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Asking plugin for UI Config Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Saving Spotify Acccount Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Got Tidal Cloud Configuration Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Got it Mar 04 14:31:14 volumio-secondo volumio[1049]: info: Got it Mar 04 14:31:14 volumio-secondo volumio[1049]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 04 14:31:14 volumio-secondo volumio[1049]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 14:31:14 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioGetBrowseSources Mar 04 14:31:15 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:15 volumio-secondo ntpd[792]: Soliciting pool server 162.159.200.123 Mar 04 14:31:15 volumio-secondo ntpd[792]: Soliciting pool server 89.46.74.148 Mar 04 14:31:15 volumio-secondo ntpd[792]: Soliciting pool server 162.159.200.1 Mar 04 14:31:15 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 04 14:31:15 volumio-secondo ntpd[792]: Soliciting pool server 212.6.50.243 Mar 04 14:31:16 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:16 volumio-secondo ntpd[792]: Soliciting pool server 185.19.184.35 Mar 04 14:31:16 volumio-secondo ntpd[792]: Soliciting pool server 93.94.88.50 Mar 04 14:31:16 volumio-secondo ntpd[792]: Soliciting pool server 151.22.209.90 Mar 04 14:31:16 volumio-secondo ntpd[792]: Soliciting pool server 5.249.144.95 Mar 04 14:31:17 volumio-secondo ntpd[792]: Soliciting pool server 37.247.53.178 Mar 04 14:31:17 volumio-secondo ntpd[792]: Soliciting pool server 31.14.133.122 Mar 04 14:31:17 volumio-secondo ntpd[792]: Soliciting pool server 85.199.214.99 Mar 04 14:31:17 volumio-secondo sudo[1550]: pam_unix(sudo:session): session closed for user root Mar 04 14:31:17 volumio-secondo volumio[1049]: info: Cannot mount NAS at system boot, trial number 4 ,stopping Mar 04 14:31:17 volumio-secondo kernel: CIFS: VFS: Error connecting to socket. Aborting operation. Mar 04 14:31:17 volumio-secondo kernel: CIFS: VFS: cifs_mount failed w/return code = -113 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand update Mar 04 14:31:18 volumio-secondo ntpd[792]: Soliciting pool server 45.135.69.197 Mar 04 14:31:18 volumio-secondo ntpd[792]: Soliciting pool server 2a00:6d41:10:1194::5 Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Mar 04 14:31:18 volumio-secondo volumio[1049]: ---------------------------- MPD announces state update: update Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand update took 8 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::getState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Mar 04 14:31:18 volumio-secondo volumio[1049]: ---------------------------- MPD announces state update: update Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::getState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Mar 04 14:31:18 volumio-secondo volumio[1049]: ---------------------------- MPD announces state update: update Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::getState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 17 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 12 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 11 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 9 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 7 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 6 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Command Router : Notfying DB Updatetrue Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Command Router : Notfying DB Updatetrue Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Command Router : Notfying DB Updatetrue Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::servicePushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: 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} Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: CURRENT POSITION 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState stateService stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState currentStatus stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: No code Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::servicePushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: 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} Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: CURRENT POSITION 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState stateService stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState currentStatus stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: No code Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::servicePushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: 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} Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: CURRENT POSITION 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState stateService stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState currentStatus stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: No code Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ------------------------------ 273ms Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ------------------------------ 268ms Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ------------------------------ 265ms Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Mar 04 14:31:18 volumio-secondo volumio[1049]: ---------------------------- MPD announces state update: update Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::getState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Mar 04 14:31:18 volumio-secondo volumio[1049]: ---------------------------- MPD announces state update: update Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::getState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Mar 04 14:31:18 volumio-secondo volumio[1049]: ---------------------------- MPD announces state update: update Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::getState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::sendMpdCommand status Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 10 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 8 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 8 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 6 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 6 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: info: sendMpdCommand status took 4 milliseconds Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Command Router : Notfying DB Updatefalse Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Command Router : Notfying DB Updatefalse Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: Command Router : Notfying DB Updatefalse Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::Close All Modals sent Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: ControllerMpd::parseState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::servicePushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: 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} Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: CURRENT POSITION 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState stateService stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState currentStatus stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: No code Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::servicePushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: 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} Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: CURRENT POSITION 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState stateService stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState currentStatus stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: No code Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ControllerMpd::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::servicePushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: 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} Mar 04 14:31:18 volumio-secondo volumio[1049]: verbose: CURRENT POSITION 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState stateService stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::syncState currentStatus stop Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: No code Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreStateMachine::pushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CorePlayQueue::getTrack 0 Mar 04 14:31:18 volumio-secondo volumio[1049]: info: CoreCommandRouter::volumioPushState Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ------------------------------ 199ms Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ------------------------------ 197ms Mar 04 14:31:18 volumio-secondo volumio[1049]: info: ------------------------------ 198ms Mar 04 14:31:19 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:20 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:21 volumio-secondo ntpd[792]: receive: Unexpected origin timestamp 0xeb717f28.5f66f3a0 does not match aorg 0000000000.00000000 from server@212.6.50.243 xmt 0xeb717f29.47479f7d Mar 04 14:31:24 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:25 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:28 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:29 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:32 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:33 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:36 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:37 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:40 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:41 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:44 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:45 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:48 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:49 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:52 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:53 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:56 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:31:57 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:00 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:01 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:04 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:05 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:08 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:09 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:12 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:13 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:16 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:17 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:20 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:21 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:24 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:25 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:28 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:29 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:31 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: networkfs , editShare Mar 04 14:32:31 volumio-secondo volumio[1049]: info: Share MusicaMP3 successfully unmounted Mar 04 14:32:31 volumio-secondo sudo[1748]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=pasquale,password=franca338elba,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft,vers=2.0 //192.168.1.4/MusicaMP3 /mnt/NAS/MusicaMP3 Mar 04 14:32:31 volumio-secondo sudo[1748]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 04 14:32:31 volumio-secondo kernel: CIFS: Attempting to mount //192.168.1.4/MusicaMP3 Mar 04 14:32:31 volumio-secondo smbd[1753]: [2025/03/04 14:32:31.718293, 0] ../source3/param/loadparm.c:3362(process_usershare_file) Mar 04 14:32:31 volumio-secondo smbd[1753]: process_usershare_file: stat of /var/lib/samba/usershares/musicamp3 failed. Permission denied Mar 04 14:32:31 volumio-secondo smbd[1753]: [2025/03/04 14:32:31.719373, 0] ../source3/param/loadparm.c:3362(process_usershare_file) Mar 04 14:32:31 volumio-secondo smbd[1753]: process_usershare_file: stat of /var/lib/samba/usershares/musicamp3 failed. No such file or directory Mar 04 14:32:31 volumio-secondo sudo[1748]: pam_unix(sudo:session): session closed for user root Mar 04 14:32:31 volumio-secondo volumio[1049]: info: An error occurred mounting the new share. Rolling back configuration Mar 04 14:32:31 volumio-secondo kernel: CIFS: VFS: BAD_NETWORK_NAME: \\192.168.1.4\MusicaMP3 Mar 04 14:32:31 volumio-secondo kernel: CIFS: VFS: cifs_mount failed w/return code = -2 Mar 04 14:32:32 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:32 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 04 14:32:33 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:36 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:37 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:40 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:41 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:41 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Mar 04 14:32:42 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Mar 04 14:32:44 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:45 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Mar 04 14:32:46 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Mar 04 14:32:46 volumio-secondo volumio[1049]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Mar 04 14:32:46 volumio-secondo volumio[1049]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 14:32:46 volumio-secondo volumio[1049]: Error: getaddrinfo -3007 Mar 04 14:32:46 volumio-secondo volumio[1049]: at errnoException (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:199:11) Mar 04 14:32:46 volumio-secondo volumio[1049]: at getaddrinfo_complete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:112:10) Mar 04 14:32:46 volumio-secondo volumio[1049]: at GetAddrInfoReqWrap.oncomplete (/volumio/node_modules/mdns/lib/resolver_sequence_tasks.js:120:9) { Mar 04 14:32:46 volumio-secondo volumio[1049]: code: -3007, Mar 04 14:32:46 volumio-secondo volumio[1049]: errno: -3007, Mar 04 14:32:46 volumio-secondo volumio[1049]: syscall: 'getaddrinfo' Mar 04 14:32:46 volumio-secondo volumio[1049]: } Mar 04 14:32:46 volumio-secondo volumio[1049]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 04 14:32:47 volumio-secondo sudo[1809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-04 14:31 Mar 04 14:32:47 volumio-secondo sudo[1809]: 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="f6610a1100d2380eef33bd3004af43153c786f96" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="1c0e5daee99fe3a72cc38b0d1fe6cd78d7f001fe" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 16 Dec 2024 09:30:04 AM CET" VOLUMIO_VERSION="3.785" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fe0ac4b79aed19ccde4b5bd83d468193"