-- Logs begin at Thu 2019-02-14 19:12:00 JST, end at Sun 2026-04-12 13:31:30 JST. -- Apr 12 13:30:00 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:00 volumio ntpd[662]: Soliciting pool server 162.159.200.1 Apr 12 13:30:00 volumio ntpd[662]: Soliciting pool server 142.91.108.61 Apr 12 13:30:01 volumio ntpd[662]: Soliciting pool server 129.250.35.251 Apr 12 13:30:01 volumio ntpd[662]: Soliciting pool server 85.121.122.62 Apr 12 13:30:01 volumio ntpd[662]: Soliciting pool server 117.102.178.88 Apr 12 13:30:02 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: networkfs , deleteShare Apr 12 13:30:02 volumio ntpd[662]: Soliciting pool server 45.77.20.103 Apr 12 13:30:02 volumio ntpd[662]: Soliciting pool server 2001:19f0:7001:3fa1:5400:5ff:fee2:9881 Apr 12 13:30:02 volumio ntpd[662]: Soliciting pool server 64.176.59.83 Apr 12 13:30:03 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 12 13:30:03 volumio ntpd[662]: Soliciting pool server 45.76.211.39 Apr 12 13:30:04 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:04 volumio ntpd[662]: Soliciting pool server 46.250.253.227 Apr 12 13:30:33 volumio ntpd[662]: receive: Unexpected origin timestamp 0xed859e4d.90e2caa2 does not match aorg 0000000000.00000000 from server@142.91.108.61 xmt 0xed859e69.9e0b64a2 Apr 12 13:30:33 volumio ntpd[662]: receive: Unexpected origin timestamp 0xed859e4d.90e73acb does not match aorg 0000000000.00000000 from server@142.91.105.55 xmt 0xed859e69.a1d95dc8 Apr 12 13:30:33 volumio systemd[1]: Starting Daily apt download activities... Apr 12 13:30:33 volumio ntpd[662]: Soliciting pool server 208.88.66.8 Apr 12 13:30:33 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: networkfs , discoverShares Apr 12 13:30:33 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , browseForService Apr 12 13:30:34 volumio systemd[1]: apt-daily.service: Succeeded. Apr 12 13:30:34 volumio systemd[1]: Started Daily apt download activities. Apr 12 13:30:34 volumio ntpd[662]: Soliciting pool server 45.76.221.157 Apr 12 13:30:35 volumio volumio[850]: info: Error browsing device DH2300-HOME-NAS for shares : Error: Command failed: echo volumio | smbclient -L DH2300-HOME-NAS.local. Apr 12 13:30:35 volumio volumio[850]: Unable to initialize messaging context Apr 12 13:30:36 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:37 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Apr 12 13:30:37 volumio volumio[850]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 5 Apr 12 13:30:37 volumio volumio[850]: info: CoreCommandRouter::volumioGetState Apr 12 13:30:37 volumio volumio[850]: info: CorePlayQueue::getTrack 0 Apr 12 13:30:40 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:42 volumio systemd[1]: /lib/systemd/system/rpc-statd.service:13: PIDFile= references path below legacy directory /var/run/, updating /var/run/rpc.statd.pid → /run/rpc.statd.pid; please update the unit file accordingly. Apr 12 13:30:42 volumio systemd[1]: Starting Preprocess NFS configuration... Apr 12 13:30:42 volumio systemd[1]: Reached target Host and Network Name Lookups. Apr 12 13:30:42 volumio systemd[1]: nfs-config.service: Succeeded. Apr 12 13:30:42 volumio systemd[1]: Started Preprocess NFS configuration. Apr 12 13:30:42 volumio systemd[1]: Starting NFS status monitor for NFSv2/3 locking.... Apr 12 13:30:42 volumio systemd[1]: Starting Notify NFS peers of a restart... Apr 12 13:30:42 volumio sm-notify[1207]: Version 1.3.3 starting Apr 12 13:30:42 volumio systemd[1]: rpc-statd-notify.service: Succeeded. Apr 12 13:30:42 volumio systemd[1]: Started Notify NFS peers of a restart. Apr 12 13:30:42 volumio rpc.statd[1208]: Version 1.3.3 starting Apr 12 13:30:42 volumio rpc.statd[1208]: Flags: TI-RPC Apr 12 13:30:42 volumio systemd[1]: Started NFS status monitor for NFSv2/3 locking.. Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::volumioGetBrowseSources Apr 12 13:30:42 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 12 13:30:43 volumio volumio-remote-updater[499]: No test mode Apr 12 13:30:43 volumio volumio-remote-updater[499]: No alpha test mode Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 12 13:30:43 volumio volumio[850]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 12 13:30:43 volumio volumio[850]: info: Completed starting MyVolumio Plugin Apr 12 13:30:43 volumio volumio[850]: info: BOOT COMPLETED Apr 12 13:30:43 volumio volumio[850]: [Metrics] CommandRouter: 64s 764.04ms Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::volumiosetStartupVolume Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::Close All Modals sent Apr 12 13:30:43 volumio volumio[850]: info: CoreCommandRouter::Close All Modals sent Apr 12 13:30:43 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error! Apr 12 13:30:44 volumio volumio[850]: info: Update Ready: {"changeLogLink":"http://volumio.org","description":"

FIXES

\n\n

NEW ADDITIONS

\n\n","title":"Update v3.912","updateavailable":true} Apr 12 13:30:44 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 12 13:30:44 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:44 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 12 13:30:44 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 12 13:30:44 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 12 13:30:48 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:52 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:30:56 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:00 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:04 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:08 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:12 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:12 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: networkfs , addShare Apr 12 13:31:12 volumio volumio[850]: info: Adding a new share Apr 12 13:31:12 volumio volumio[850]: info: No correspondence found in configuration for share DH2300-HOME-NAS on IP DH2300-HOME-NAS Apr 12 13:31:12 volumio sudo[1215]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=takuya,password=Takuyan9,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //DH2300-HOME-NAS/MediaServer/Music /mnt/NAS/DH2300-HOME-NAS Apr 12 13:31:12 volumio sudo[1215]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 12 13:31:12 volumio sudo[1215]: pam_unix(sudo:session): session closed for user root Apr 12 13:31:12 volumio volumio[850]: info: Error mounting DH2300-HOME-NAS on IP DH2300-HOME-NAS : : could not resolve address for DH2300-HOME-NAS: Unknown error Apr 12 13:31:13 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Apr 12 13:31:16 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:20 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:24 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:24 volumio sudo[902]: pam_unix(sudo:session): session closed for user root Apr 12 13:31:24 volumio volumio[850]: info: Cannot mount NAS Music at system boot, trial number 1 ,retrying in 5 seconds Apr 12 13:31:28 volumio volumio[850]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Apr 12 13:31:29 volumio volumio[850]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 13:31:29 volumio volumio[850]: TypeError: Cannot read property 'replace' of undefined Apr 12 13:31:29 volumio volumio[850]: at ControllerNetworkfs.mountShare (/volumio/app/plugins/system_controller/networkfs/index.js:202:28) Apr 12 13:31:29 volumio volumio[850]: at Timeout._onTimeout (/volumio/app/plugins/system_controller/networkfs/index.js:255:20) Apr 12 13:31:29 volumio volumio[850]: at listOnTimeout (internal/timers.js:554:17) Apr 12 13:31:29 volumio volumio[850]: at processTimers (internal/timers.js:497:7) Apr 12 13:31:29 volumio volumio[850]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 12 13:31:30 volumio sudo[1231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-04-12 13:30 Apr 12 13:31:30 volumio sudo[1231]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST" VOLUMIO_VERSION="3.546" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"