-- Logs begin at Thu 2024-10-17 07:31:13 CST, end at Thu 2024-10-24 22:27:20 CST. -- Oct 24 22:26:02 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Oct 24 22:26:02 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Oct 24 22:26:02 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:04 volumio-pi volumio[993]: info: Error browsing device OpenWrt-2 for shares : Error: Command failed: echo volumio | smbclient -L OpenWrt-2.local. Oct 24 22:26:04 volumio-pi volumio[993]: Unable to initialize messaging context Oct 24 22:26:04 volumio-pi volumio[993]: do_connect: Connection to OpenWrt-2.local. failed (Error NT_STATUS_CONNECTION_REFUSED) Oct 24 22:26:06 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:09 volumio-pi kernel: hwmon hwmon1: Voltage normalised Oct 24 22:26:10 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:11 volumio-pi kernel: hwmon hwmon1: Undervoltage detected! Oct 24 22:26:14 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:18 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:22 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:26 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:30 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:34 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:38 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:42 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:46 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Oct 24 22:26:46 volumio-pi volumio[993]: info: Adding a new share Oct 24 22:26:46 volumio-pi volumio[993]: info: No correspondence found in configuration for share Nas on IP 192.168.3.90 Oct 24 22:26:46 volumio-pi sudo[1554]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=sharemovie,password=movieshare,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.3.90/music /mnt/NAS/Nas Oct 24 22:26:46 volumio-pi sudo[1554]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 22:26:46 volumio-pi kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Oct 24 22:26:46 volumio-pi kernel: CIFS: Attempting to mount \\192.168.3.90\music Oct 24 22:26:46 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:46 volumio-pi sudo[1554]: pam_unix(sudo:session): session closed for user root Oct 24 22:26:47 volumio-pi volumio[993]: verbose: ControllerMpd::sendMpdCommand status Oct 24 22:26:47 volumio-pi volumio[993]: info: Oct 24 22:26:47 volumio-pi volumio[993]: ---------------------------- MPD announces state update: update Oct 24 22:26:47 volumio-pi volumio[993]: info: ControllerMpd::getState Oct 24 22:26:47 volumio-pi volumio[993]: verbose: ControllerMpd::sendMpdCommand status Oct 24 22:26:47 volumio-pi volumio[993]: verbose: ControllerMpd::sendMpdCommand status Oct 24 22:26:47 volumio-pi volumio[993]: info: Oct 24 22:26:47 volumio-pi volumio[993]: ---------------------------- MPD announces state update: update Oct 24 22:26:47 volumio-pi volumio[993]: info: ControllerMpd::getState Oct 24 22:26:47 volumio-pi volumio[993]: verbose: ControllerMpd::sendMpdCommand status Oct 24 22:26:47 volumio-pi volumio[993]: verbose: ControllerMpd::sendMpdCommand status Oct 24 22:26:47 volumio-pi volumio[993]: info: Oct 24 22:26:47 volumio-pi volumio[993]: ---------------------------- MPD announces state update: update Oct 24 22:26:47 volumio-pi volumio[993]: info: ControllerMpd::getState Oct 24 22:26:47 volumio-pi volumio[993]: verbose: ControllerMpd::sendMpdCommand status Oct 24 22:26:47 volumio-pi volumio[993]: info: [1729780007193] Database update started Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 24 22:26:48 volumio-pi volumio[993]: info: sendMpdCommand status took 1488 milliseconds Oct 24 22:26:48 volumio-pi volumio[993]: info: sendMpdCommand status took 1480 milliseconds Oct 24 22:26:48 volumio-pi volumio[993]: info: sendMpdCommand status took 1477 milliseconds Oct 24 22:26:48 volumio-pi volumio[993]: info: sendMpdCommand status took 1475 milliseconds Oct 24 22:26:48 volumio-pi volumio[993]: info: sendMpdCommand status took 1473 milliseconds Oct 24 22:26:48 volumio-pi volumio[993]: info: sendMpdCommand status took 1470 milliseconds Oct 24 22:26:48 volumio-pi volumio[993]: verbose: ControllerMpd::parseState Oct 24 22:26:48 volumio-pi volumio[993]: info: Command Router : Notfying DB Updatetrue Oct 24 22:26:48 volumio-pi volumio[993]: verbose: ControllerMpd::parseState Oct 24 22:26:48 volumio-pi volumio[993]: verbose: ControllerMpd::parseState Oct 24 22:26:48 volumio-pi volumio[993]: info: Command Router : Notfying DB Updatetrue Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::Close All Modals sent Oct 24 22:26:48 volumio-pi volumio[993]: verbose: ControllerMpd::parseState Oct 24 22:26:48 volumio-pi volumio[993]: verbose: ControllerMpd::parseState Oct 24 22:26:48 volumio-pi volumio[993]: info: Command Router : Notfying DB Updatetrue Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::Close All Modals sent Oct 24 22:26:48 volumio-pi volumio[993]: verbose: ControllerMpd::parseState Oct 24 22:26:48 volumio-pi volumio[993]: info: ControllerMpd::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::servicePushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: 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} Oct 24 22:26:48 volumio-pi volumio[993]: verbose: CURRENT POSITION 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::syncState stateService stop Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::syncState currentStatus stop Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: No code Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: ControllerMpd::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::servicePushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: 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} Oct 24 22:26:48 volumio-pi volumio[993]: verbose: CURRENT POSITION 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::syncState stateService stop Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::syncState currentStatus stop Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: No code Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: ControllerMpd::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::servicePushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: 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} Oct 24 22:26:48 volumio-pi volumio[993]: verbose: CURRENT POSITION 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::syncState stateService stop Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::syncState currentStatus stop Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:48 volumio-pi volumio[993]: info: No code Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreStateMachine::pushState Oct 24 22:26:48 volumio-pi volumio[993]: info: CorePlayQueue::getTrack 0 Oct 24 22:26:48 volumio-pi volumio[993]: info: CoreCommandRouter::volumioPushState Oct 24 22:26:49 volumio-pi volumio[993]: info: ------------------------------ 1896ms Oct 24 22:26:49 volumio-pi volumio[993]: info: ------------------------------ 1887ms Oct 24 22:26:49 volumio-pi volumio[993]: info: ------------------------------ 1885ms Oct 24 22:26:50 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 24 22:26:57 volumio-pi volumio[993]: info: CoreCommandRouter::volumioGetQueue Oct 24 22:26:57 volumio-pi volumio[993]: info: CoreStateMachine::getQueue Oct 24 22:26:57 volumio-pi volumio[993]: info: CorePlayQueue::getQueue Oct 24 22:26:58 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 24 22:26:58 volumio-pi volumio[993]: info: CURURI: music-library Oct 24 22:26:58 volumio-pi volumio[993]: info: Preload queue cleared Oct 24 22:27:00 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 24 22:27:00 volumio-pi volumio[993]: info: CURURI: music-library/NAS Oct 24 22:27:00 volumio-pi volumio[993]: info: Preload queue cleared Oct 24 22:27:02 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 24 22:27:02 volumio-pi volumio[993]: info: CURURI: music-library/NAS/Nas Oct 24 22:27:02 volumio-pi volumio[993]: info: Preload queue cleared Oct 24 22:27:03 volumio-pi volumio[993]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Oct 24 22:27:03 volumio-pi volumio[993]: info: CURURI: music-library/NAS/Nas/SACD Oct 24 22:27:03 volumio-pi volumio[993]: info: Preload queue cleared Oct 24 22:27:19 volumio-pi volumio[993]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 22:27:19 volumio-pi volumio[993]: Error: connect ETIMEDOUT 199.96.58.105:443 Oct 24 22:27:19 volumio-pi volumio[993]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Oct 24 22:27:19 volumio-pi volumio[993]: errno: -110, Oct 24 22:27:19 volumio-pi volumio[993]: code: 'ETIMEDOUT', Oct 24 22:27:19 volumio-pi volumio[993]: syscall: 'connect', Oct 24 22:27:19 volumio-pi volumio[993]: address: '199.96.58.105', Oct 24 22:27:19 volumio-pi volumio[993]: port: 443 Oct 24 22:27:19 volumio-pi volumio[993]: } Oct 24 22:27:19 volumio-pi volumio[993]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 22:27:20 volumio-pi sudo[1594]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-24 22:26 Oct 24 22:27:20 volumio-pi sudo[1594]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"