-- Logs begin at Thu 2019-02-14 10:11:59 UTC, end at Thu 2023-03-23 11:32:29 UTC. -- Mar 23 11:31:22 volumio-phong-khach fake-hwclock[184]: Thu Mar 23 11:31:22 UTC 2023 Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Restore / save the current clock. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Load/Save Random Seed. Mar 23 11:31:22 volumio-phong-khach systemd[1]: dynamicswap.service: Succeeded. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Create System Users. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Starting Create Static Device Nodes in /dev... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Create Static Device Nodes in /dev. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Reached target Local File Systems (Pre). Mar 23 11:31:22 volumio-phong-khach systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounting /tmp... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounting /var/spool/cups... Mar 23 11:31:22 volumio-phong-khach systemd[1]: var-log.mount: Directory /var/log to mount over is not empty, mounting anyway. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounting /var/log... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Starting udev Kernel Device Manager... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounted /tmp. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounted /var/spool/cups. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounting /var/spool/cups/tmp... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started udev Coldplug all Devices. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounted /var/log. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Starting Flush Journal to Persistent Storage... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Starting Helper to synchronize boot up for ifupdown... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Mounted /var/spool/cups/tmp. Mar 23 11:31:22 volumio-phong-khach systemd-udevd[206]: Network interface NamePolicy= disabled on kernel command line, ignoring. Mar 23 11:31:22 volumio-phong-khach systemd-journald[176]: Runtime journal (/run/log/journal/03837a839dbf02e377dd5ba761c0a77e) is 7.5M, max 30.0M, 22.5M free. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Flush Journal to Persistent Storage. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started udev Kernel Device Manager. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Starting Show Plymouth Boot Screen... Mar 23 11:31:22 volumio-phong-khach systemd[1]: Received SIGRTMIN+20 from PID 224 (plymouthd). Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Show Plymouth Boot Screen. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Reached target Local Encrypted Volumes. Mar 23 11:31:22 volumio-phong-khach systemd[1]: Reached target Paths. Mar 23 11:31:22 volumio-phong-khach kernel: vc_sm_cma: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:22 volumio-phong-khach kernel: bcm2835_vc_sm_cma_probe: Videocore shared memory driver Mar 23 11:31:22 volumio-phong-khach kernel: [vc_sm_connected_init]: start Mar 23 11:31:22 volumio-phong-khach kernel: mc: Linux media interface: v0.10 Mar 23 11:31:22 volumio-phong-khach kernel: [vc_sm_connected_init]: installed successfully Mar 23 11:31:22 volumio-phong-khach kernel: videodev: Linux video capture interface: v2.00 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_mmal_vchiq: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_isp: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Device node output[0] registered as /dev/video13 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Device node capture[0] registered as /dev/video14 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Device node capture[1] registered as /dev/video15 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Device node stats[2] registered as /dev/video16 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Register output node 0 with media controller Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Register capture node 1 with media controller Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Register capture node 2 with media controller Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Register capture node 3 with media controller Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-isp bcm2835-isp: Loaded V4L2 bcm2835-isp Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_codec: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video10 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 decode Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video11 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 encode Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-codec bcm2835-codec: Device registered as /dev/video12 Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835-codec bcm2835-codec: Loaded V4L2 isp Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_v4l2: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: snd_bcm2835: module is from the staging directory, the quality is unknown, you have been warned. Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 23 11:31:23 volumio-phong-khach kernel: bcm2835_audio bcm2835_audio: card created with 4 channels Mar 23 11:31:23 volumio-phong-khach systemd-udevd[220]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 23 11:31:24 volumio-phong-khach kernel: cfg80211: Loading compiled-in X.509 certificates for regulatory database Mar 23 11:31:24 volumio-phong-khach systemd-udevd[214]: Using default interface naming scheme 'v240'. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Found device /dev/mmcblk0p1. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Condition check resulted in Dispatch Password Requests to Console Directory Watch being skipped. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Condition check resulted in Set Up Additional Binary Formats being skipped. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Starting File System Check on /dev/mmcblk0p1... Mar 23 11:31:24 volumio-phong-khach systemd[1]: Condition check resulted in Rebuild Hardware Database being skipped. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Condition check resulted in FUSE Control File System being skipped. Mar 23 11:31:24 volumio-phong-khach systemd[1]: Condition check resulted in Huge Pages File System being skipped. Mar 23 11:31:24 volumio-phong-khach kernel: cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' Mar 23 11:31:24 volumio-phong-khach systemd[1]: Started File System Check Daemon to report status. Mar 23 11:31:25 volumio-phong-khach systemd-udevd[214]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 23 11:31:25 volumio-phong-khach systemd-fsck[328]: fsck.fat 4.1 (2017-01-24) Mar 23 11:31:25 volumio-phong-khach systemd-fsck[328]: 0x25: Dirty bit is set. Fs was not properly unmounted and some data may be corrupt. Mar 23 11:31:25 volumio-phong-khach systemd-fsck[328]: Automatically removing dirty bit. Mar 23 11:31:25 volumio-phong-khach systemd-fsck[328]: Performing changes. Mar 23 11:31:25 volumio-phong-khach systemd-fsck[328]: /dev/mmcblk0p1: 257 files, 26172/46774 clusters Mar 23 11:31:25 volumio-phong-khach kernel: Under-voltage detected! (0x00050005) Mar 23 11:31:25 volumio-phong-khach kernel: brcmfmac: F1 signature read @0x18000000=0x1541a9a6 Mar 23 11:31:25 volumio-phong-khach systemd[1]: Started File System Check on /dev/mmcblk0p1. Mar 23 11:31:25 volumio-phong-khach kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Mar 23 11:31:25 volumio-phong-khach kernel: usbcore: registered new interface driver brcmfmac Mar 23 11:31:25 volumio-phong-khach systemd[1]: Mounting /boot... Mar 23 11:31:25 volumio-phong-khach systemd[1]: Mounted /boot. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Reached target Local File Systems. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Starting Create Volatile Files and Directories... Mar 23 11:31:25 volumio-phong-khach systemd[1]: Starting Preprocess NFS configuration... Mar 23 11:31:25 volumio-phong-khach systemd[1]: Condition check resulted in Commit a transient machine-id on disk being skipped. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Mar 23 11:31:25 volumio-phong-khach kernel: brcmfmac mmc1:0001:1: Direct firmware load for brcm/brcmfmac43430-sdio.raspberrypi,3-model-b.txt failed with error -2 Mar 23 11:31:25 volumio-phong-khach systemd[1]: nfs-config.service: Succeeded. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Started Preprocess NFS configuration. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Condition check resulted in RPC security service for NFS client and server being skipped. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Condition check resulted in RPC security service for NFS server being skipped. Mar 23 11:31:25 volumio-phong-khach systemd[1]: Reached target NFS client services. Mar 23 11:31:26 volumio-phong-khach systemd[1]: Started Create Volatile Files and Directories. Mar 23 11:31:26 volumio-phong-khach systemd[1]: Condition check resulted in Network Time Synchronization being skipped. Mar 23 11:31:26 volumio-phong-khach systemd[1]: Starting Update UTMP about System Boot/Shutdown... Mar 23 11:31:26 volumio-phong-khach systemd[1]: Starting RPC bind portmap service... Mar 23 11:31:26 volumio-phong-khach systemd[1]: Started Entropy daemon using the HAVEGE algorithm. Mar 23 11:31:26 volumio-phong-khach kernel: brcmfmac: brcmf_fw_alloc_request: using brcm/brcmfmac43430-sdio for chip BCM43430/1 Mar 23 11:31:26 volumio-phong-khach kernel: brcmfmac: brcmf_c_process_clm_blob: no clm_blob available (err=-2), device may have limited channels available Mar 23 11:31:26 volumio-phong-khach kernel: brcmfmac: brcmf_c_preinit_dcmds: Firmware: BCM43430/1 wl0: Oct 22 2019 01:59:28 version 7.45.98.94 (r723000 CY) FWID 01-3b33decd Mar 23 11:31:26 volumio-phong-khach systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 23 11:31:26 volumio-phong-khach systemd-udevd[218]: Using default interface naming scheme 'v240'. Mar 23 11:31:26 volumio-phong-khach systemd-udevd[218]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Mar 23 11:31:26 volumio-phong-khach systemd[1]: Started Update UTMP about System Boot/Shutdown. Mar 23 11:31:26 volumio-phong-khach systemd[1]: Started Load/Save RF Kill Switch Status. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Found device SMSC9512/9514 Fast Ethernet Adapter. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started RPC bind portmap service. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Found device /sys/subsystem/net/devices/wlan0. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started ifup for wlan0. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target Remote File Systems (Pre). Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target Remote File Systems. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target RPC Port Mapper. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started ifup for eth0. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Helper to synchronize boot up for ifupdown. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting Raise network interfaces... Mar 23 11:31:27 volumio-phong-khach kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 23 11:31:27 volumio-phong-khach kernel: 8021q: 802.1Q VLAN Support v1.8 Mar 23 11:31:27 volumio-phong-khach systemd[1]: Received SIGRTMIN+20 from PID 224 (plymouthd). Mar 23 11:31:27 volumio-phong-khach systemd[1]: plymouth-read-write.service: Succeeded. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target System Initialization. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Daily Cleanup of Temporary Directories. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Listening on triggerhappy.socket. Mar 23 11:31:27 volumio-phong-khach systemd[1]: apt-daily.timer: Not using persistent file timestamp Sun 2025-01-12 10:47:29 UTC as it is in the future. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Daily apt download activities. Mar 23 11:31:27 volumio-phong-khach systemd[1]: apt-daily-upgrade.timer: Not using persistent file timestamp Sun 2025-01-12 06:37:58 UTC as it is in the future. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Daily apt upgrade and clean activities. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target Timers. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Listening on D-Bus System Message Bus Socket. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Listening on mpd.socket. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target Sockets. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Reached target Basic System. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting Wireless Services... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started UPnP Renderer front-end to MPD. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Condition check resulted in getty on tty2-tty6 if dbus and logind are not available being skipped. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Volumio Iptables Module. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started D-Bus System Message Bus. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting WPA supplicant... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Condition check resulted in Copy user wpa_supplicant.conf being skipped. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started Manage Sound Card State (restore and store). Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting Save/Restore Sound Card State... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting dhcpcd on all interfaces... Mar 23 11:31:27 volumio-phong-khach alsactl[480]: alsactl 1.1.8 daemon started Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting triggerhappy global hotkey daemon... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Condition check resulted in Volumio SSH enabler being skipped. Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting LSB: Load kernel modules needed to enable cpufreq scaling... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting Login Service... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started volumio-remote-updater.service. Mar 23 11:31:27 volumio-phong-khach thd[483]: Unable to parse trigger line: Mar 23 11:31:27 volumio-phong-khach thd[483]: Unable to parse trigger line: KEY_MIN_INTERESTING 1 /usr/local/bin/volumio volume toggle Mar 23 11:31:27 volumio-phong-khach thd[483]: Unable to parse trigger line: Mar 23 11:31:27 volumio-phong-khach thd[483]: Found socket passed from systemd Mar 23 11:31:27 volumio-phong-khach dhcpcd[482]: Not running dhcpcd because /etc/network/interfaces Mar 23 11:31:27 volumio-phong-khach dhcpcd[482]: defines some interfaces that will use a Mar 23 11:31:27 volumio-phong-khach dhcpcd[482]: DHCP client or static address Mar 23 11:31:27 volumio-phong-khach dhcpcd[408]: eth0: waiting for carrier Mar 23 11:31:27 volumio-phong-khach sh[368]: eth0: waiting for carrier Mar 23 11:31:27 volumio-phong-khach kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup Mar 23 11:31:27 volumio-phong-khach systemd[1]: Starting Configure Bluetooth Modems connected by UART... Mar 23 11:31:27 volumio-phong-khach systemd[1]: Started triggerhappy global hotkey daemon. Mar 23 11:31:27 volumio-phong-khach systemd[1]: dhcpcd.service: Control process exited, code=exited, status=6/NOTCONFIGURED Mar 23 11:31:27 volumio-phong-khach systemd[1]: dhcpcd.service: Failed with result 'exit-code'. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Failed to start dhcpcd on all interfaces. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Found user 'avahi' (UID 110) and group 'avahi' (GID 113). Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Successfully dropped root privileges. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: avahi-daemon 0.7 starting up. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Started Save/Restore Sound Card State. Mar 23 11:31:28 volumio-phong-khach ifup[387]: ifup: waiting for lock on /run/network/ifstate.wlan0 Mar 23 11:31:28 volumio-phong-khach sh[367]: wlan0=wlan0 Mar 23 11:31:28 volumio-phong-khach systemd[1]: Reached target Sound Card. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Started Avahi mDNS/DNS-SD Stack. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Successfully called chroot(). Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Successfully dropped remaining capabilities. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Loading service file /services/volumio.service. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Started Raise network interfaces. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Network interface enumeration completed. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Server startup complete. Host name is volumio-phong-khach.local. Local service cookie is 3846729244. Mar 23 11:31:28 volumio-phong-khach avahi-daemon[472]: Service "Volumio Phong Khach" (/services/volumio.service) successfully established. Mar 23 11:31:28 volumio-phong-khach kernel: uart-pl011 3f201000.serial: no DMA platform data Mar 23 11:31:28 volumio-phong-khach loadcpufreq[484]: Loading cpufreq kernel modules...done (none). Mar 23 11:31:28 volumio-phong-khach systemd[1]: Started LSB: Load kernel modules needed to enable cpufreq scaling. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Starting LSB: set CPUFreq kernel parameters... Mar 23 11:31:28 volumio-phong-khach haveged[356]: haveged: ver: 1.9.1; arch: generic; vend: ; build: (gcc 8.2.0 CTV); collect: 128K Mar 23 11:31:28 volumio-phong-khach haveged[356]: haveged: cpu: (VC); data: 16K (D); inst: 16K (D); idx: 11/40; sz: 14768/63488 Mar 23 11:31:28 volumio-phong-khach haveged[356]: haveged: tot tests(BA8): A:1/1 B:1/1 continuous tests(B): last entropy estimate 7.99999 Mar 23 11:31:28 volumio-phong-khach haveged[356]: haveged: fills: 0, generated: 0 Mar 23 11:31:28 volumio-phong-khach kernel: random: crng init done Mar 23 11:31:28 volumio-phong-khach kernel: random: 7 urandom warning(s) missed due to ratelimiting Mar 23 11:31:28 volumio-phong-khach cpufrequtils[567]: CPUFreq Utilities: Setting performance CPUFreq governor...CPU0...CPU1...CPU2...CPU3...done. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Started LSB: set CPUFreq kernel parameters. Mar 23 11:31:28 volumio-phong-khach systemd-logind[486]: New seat seat0. Mar 23 11:31:28 volumio-phong-khach systemd[1]: Started Login Service. Mar 23 11:31:30 volumio-phong-khach systemd[1]: Started WPA supplicant. Mar 23 11:31:30 volumio-phong-khach wpa_supplicant[479]: Successfully initialized wpa_supplicant Mar 23 11:31:30 volumio-phong-khach systemd[1]: Reached target Network. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting OpenBSD Secure Shell server... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Condition check resulted in fast remote file copy program daemon being skipped. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Reached target Network is Online. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting LSB: Brings up/down network automatically... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting PM2 process manager... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting Music Player Daemon... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting /etc/rc.local Compatibility... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting Samba NMB Daemon... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting Network Time Service... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting Permit User Sessions... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started /etc/rc.local Compatibility. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started Permit User Sessions. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting Hold until boot process finishes up... Mar 23 11:31:31 volumio-phong-khach systemd[1]: Starting Terminate Plymouth Boot Screen... Mar 23 11:31:31 volumio-phong-khach systemd[1]: iptables.service: Succeeded. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Received SIGRTMIN+21 from PID 224 (plymouthd). Mar 23 11:31:31 volumio-phong-khach systemd[1]: Received SIGRTMIN+21 from PID 224 (plymouthd). Mar 23 11:31:31 volumio-phong-khach systemd[1]: plymouth-quit.service: Succeeded. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started Terminate Plymouth Boot Screen. Mar 23 11:31:31 volumio-phong-khach systemd[1]: plymouth-quit-wait.service: Succeeded. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started Hold until boot process finishes up. Mar 23 11:31:31 volumio-phong-khach systemd[1]: plymouth-start.service: Succeeded. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started Getty on tty1. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Reached target Login Prompts. Mar 23 11:31:31 volumio-phong-khach systemd[1]: systemd-rfkill.service: Succeeded. Mar 23 11:31:31 volumio-phong-khach ifplugd(eth0)[622]: ifplugd 0.28 initializing. Mar 23 11:31:31 volumio-phong-khach ifplugd(eth0)[622]: Using interface eth0/B8:27:EB:48:86:A4 with driver (version: 22-Aug-2005) Mar 23 11:31:31 volumio-phong-khach ifplugd(eth0)[622]: Using detection mode: SIOCETHTOOL Mar 23 11:31:31 volumio-phong-khach ifplugd(eth0)[622]: Initialization complete, link beat not detected. Mar 23 11:31:31 volumio-phong-khach ifplugd[589]: Network Interface Plugging Daemon...start eth0...done. Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started LSB: Brings up/down network automatically. Mar 23 11:31:31 volumio-phong-khach ntpd[597]: ntpd 4.2.8p12@1.3728-o (1): Starting Mar 23 11:31:31 volumio-phong-khach ntpd[597]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 103:103 Mar 23 11:31:31 volumio-phong-khach systemd[1]: Started Network Time Service. Mar 23 11:31:31 volumio-phong-khach ntpd[624]: proto: precision = 1.458 usec (-19) Mar 23 11:31:31 volumio-phong-khach ntpd[624]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Mar 23 11:31:31 volumio-phong-khach ntpd[624]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-06-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Mar 23 11:31:31 volumio-phong-khach ntpd[624]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 269 days ago Mar 23 11:31:31 volumio-phong-khach ntpd[624]: Listen and drop on 0 v6wildcard [::]:123 Mar 23 11:31:31 volumio-phong-khach ntpd[624]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Mar 23 11:31:31 volumio-phong-khach ntpd[624]: Listen normally on 2 lo 127.0.0.1:123 Mar 23 11:31:31 volumio-phong-khach ntpd[624]: Listening on routing socket on fd #19 for interface updates Mar 23 11:31:31 volumio-phong-khach ntpd[624]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 23 11:31:31 volumio-phong-khach ntpd[624]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 23 11:31:32 volumio-phong-khach volumio[466]: Could not open config: /tmp/upmpdcli.conf Mar 23 11:31:32 volumio-phong-khach systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 23 11:31:32 volumio-phong-khach systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 23 11:31:32 volumio-phong-khach volumio-remote-updater[487]: Error: No active session Mar 23 11:31:32 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:32] [info] asio async_connect error: system:111 (Connection refused) Mar 23 11:31:32 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 23 11:31:32 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:32] [error] handle_connect error: Underlying Transport Error Mar 23 11:31:32 volumio-phong-khach ntpd[624]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: Core ver 2.22 Mar 23 11:31:32 volumio-phong-khach kernel: NET: Registered protocol family 31 Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: HCI device and connection manager initialized Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: HCI socket layer initialized Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: L2CAP socket layer initialized Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: SCO socket layer initialized Mar 23 11:31:32 volumio-phong-khach sshd[633]: Server listening on 0.0.0.0 port 22. Mar 23 11:31:32 volumio-phong-khach sshd[633]: Server listening on :: port 22. Mar 23 11:31:32 volumio-phong-khach systemd[1]: Started OpenBSD Secure Shell server. Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: HCI UART driver ver 2.3 Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: HCI UART protocol H4 registered Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered Mar 23 11:31:32 volumio-phong-khach kernel: Bluetooth: HCI UART protocol Broadcom registered Mar 23 11:31:32 volumio-phong-khach btuart[489]: bcm43xx_init Mar 23 11:31:32 volumio-phong-khach btuart[489]: Flash firmware /lib/firmware/brcm/BCM43430A1.hcd Mar 23 11:31:32 volumio-phong-khach btuart[489]: Set BDADDR UART: b8:27:eb:e2:2c:0e Mar 23 11:31:32 volumio-phong-khach btuart[489]: Set Controller UART speed to 460800 bit/s Mar 23 11:31:32 volumio-phong-khach btuart[489]: Device setup complete Mar 23 11:31:32 volumio-phong-khach systemd[1]: Started Configure Bluetooth Modems connected by UART. Mar 23 11:31:32 volumio-phong-khach systemd[1]: Starting Load/Save RF Kill Switch Status... Mar 23 11:31:33 volumio-phong-khach systemd[1]: Started Load/Save RF Kill Switch Status. Mar 23 11:31:33 volumio-phong-khach systemd[1]: Created slice system-bthelper.slice. Mar 23 11:31:33 volumio-phong-khach systemd[1]: Starting Raspberry Pi bluetooth helper... Mar 23 11:31:33 volumio-phong-khach ntpd[624]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Mar 23 11:31:33 volumio-phong-khach bthelper[638]: Raspberry Pi BDADDR already set Mar 23 11:31:33 volumio-phong-khach systemd[1]: Started Raspberry Pi bluetooth helper. Mar 23 11:31:33 volumio-phong-khach systemd[1]: Starting Bluetooth service... Mar 23 11:31:34 volumio-phong-khach bluetoothd[648]: Bluetooth daemon 5.50 Mar 23 11:31:34 volumio-phong-khach bluetoothd[648]: Unknown key AutoConnectTimeout for group General in /etc/bluetooth/main.conf Mar 23 11:31:34 volumio-phong-khach systemd[1]: Started Bluetooth service. Mar 23 11:31:34 volumio-phong-khach systemd[1]: Reached target Bluetooth. Mar 23 11:31:34 volumio-phong-khach bluetoothd[648]: Starting SDP server Mar 23 11:31:34 volumio-phong-khach bluetoothd[648]: Excluding (cli) sap Mar 23 11:31:34 volumio-phong-khach kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3 Mar 23 11:31:34 volumio-phong-khach kernel: Bluetooth: BNEP filters: protocol multicast Mar 23 11:31:34 volumio-phong-khach kernel: Bluetooth: BNEP socket layer initialized Mar 23 11:31:34 volumio-phong-khach bluetoothd[648]: Bluetooth management interface 1.14 initialized Mar 23 11:31:34 volumio-phong-khach dbus-daemon[475]: [system] Activating via systemd: service name='org.freedesktop.hostname1' unit='dbus-org.freedesktop.hostname1.service' requested by ':1.5' (uid=0 pid=648 comm="/usr/lib/bluetooth/bluetoothd --noplugin=sap ") Mar 23 11:31:34 volumio-phong-khach systemd[1]: Starting Hostname Service... Mar 23 11:31:34 volumio-phong-khach bluetoothd[648]: Failed to set privacy: Rejected (0x0b) Mar 23 11:31:34 volumio-phong-khach nmbd[607]: [2023/03/23 11:31:34.546672, 0] ../source3/nmbd/asyncdns.c:158(start_async_dns) Mar 23 11:31:34 volumio-phong-khach nmbd[607]: started asyncdns process 661 Mar 23 11:31:34 volumio-phong-khach nmbd[607]: [2023/03/23 11:31:34.552464, 0] ../lib/util/become_daemon.c:149(daemon_status) Mar 23 11:31:34 volumio-phong-khach nmbd[607]: daemon_status: STATUS=daemon 'nmbd' : No local IPv4 non-loopback interfaces available, waiting for interface ... Mar 23 11:31:34 volumio-phong-khach nmbd[607]: [2023/03/23 11:31:34.552778, 0] ../source3/nmbd/nmbd_subnetdb.c:254(create_subnets) Mar 23 11:31:34 volumio-phong-khach nmbd[607]: NOTE: NetBIOS name resolution is not supported for Internet Protocol Version 6 (IPv6). Mar 23 11:31:34 volumio-phong-khach dbus-daemon[475]: [system] Successfully activated service 'org.freedesktop.hostname1' Mar 23 11:31:34 volumio-phong-khach systemd[1]: Started Hostname Service. Mar 23 11:31:34 volumio-phong-khach ntpd[624]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Mar 23 11:31:35 volumio-phong-khach ntpd[624]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Mar 23 11:31:36 volumio-phong-khach wireless.js[456]: WIRELESS DAEMON: start Mar 23 11:31:36 volumio-phong-khach wireless.js[456]: WIRELESS: Loaded configuration Mar 23 11:31:36 volumio-phong-khach wireless.js[456]: Cleaning previous... Mar 23 11:31:37 volumio-phong-khach sudo[667]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 23 11:31:37 volumio-phong-khach sudo[667]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:37 volumio-phong-khach sudo[667]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:37 volumio-phong-khach sudo[669]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 23 11:31:37 volumio-phong-khach sudo[669]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:37 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:37] [info] asio async_connect error: system:111 (Connection refused) Mar 23 11:31:37 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:37] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 23 11:31:37 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:37] [error] handle_connect error: Underlying Transport Error Mar 23 11:31:37 volumio-phong-khach sudo[669]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:38 volumio-phong-khach systemd[1]: systemd-rfkill.service: Succeeded. Mar 23 11:31:38 volumio-phong-khach wireless.js[456]: Stopped aP Mar 23 11:31:38 volumio-phong-khach wireless.js[456]: Start wireless flow Mar 23 11:31:38 volumio-phong-khach wireless.js[456]: Stopped hotspot (if there).. Mar 23 11:31:38 volumio-phong-khach sudo[676]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ip addr flush dev wlan0 Mar 23 11:31:38 volumio-phong-khach sudo[676]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:38 volumio-phong-khach sudo[676]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:38 volumio-phong-khach sudo[678]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 down Mar 23 11:31:38 volumio-phong-khach sudo[678]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:38 volumio-phong-khach sudo[678]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:38 volumio-phong-khach wireless.js[456]: DHCP IP Mar 23 11:31:38 volumio-phong-khach wireless.js[456]: Start ap Mar 23 11:31:38 volumio-phong-khach wpa_supplicant[680]: Successfully initialized wpa_supplicant Mar 23 11:31:38 volumio-phong-khach sudo[681]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/dhcpcd Mar 23 11:31:38 volumio-phong-khach sudo[681]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:38 volumio-phong-khach kernel: brcmfmac: brcmf_cfg80211_set_power_mgmt: power save disabled Mar 23 11:31:38 volumio-phong-khach dhcpcd[682]: dev: loaded udev Mar 23 11:31:38 volumio-phong-khach dhcpcd-run-hooks[700]: wlan0: starting wpa_supplicant Mar 23 11:31:38 volumio-phong-khach mpd[628]: Mar 23 11:31 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 23 11:31:38 volumio-phong-khach bthelper[638]: Changing power off succeeded Mar 23 11:31:38 volumio-phong-khach dhcpcd-run-hooks[706]: wlan0: failed to start wpa_supplicant Mar 23 11:31:38 volumio-phong-khach dhcpcd-run-hooks[707]: wlan0: Successfully initialized wpa_supplicant ctrl_iface exists and seems to be in use - cannot override it Delete '/var/run/wpa_supplicant/wlan0' manually if it is not used anymore Failed to initialize control interface '/var/run/wpa_supplicant'. You may have another wpa_supplicant process already running or the file was left by an unclean termination of wpa_supplicant in which case you will need to manually remove this file before starting wpa_supplicant again. nl80211: deinit ifname=wlan0 disabled_11b_rates=0 Mar 23 11:31:38 volumio-phong-khach dhcpcd[682]: wlan0: connected to Access Point `' Mar 23 11:31:39 volumio-phong-khach dhcpcd[682]: no interfaces have a carrier Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: eth0: waiting for carrier Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: wlan0: waiting for carrier Mar 23 11:31:39 volumio-phong-khach dhcpcd[682]: forked to background, child pid 717 Mar 23 11:31:39 volumio-phong-khach sudo[681]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:39 volumio-phong-khach mpd[628]: Mar 23 11:31 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Mar 23 11:31:39 volumio-phong-khach mpd[628]: Mar 23 11:31 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Mar 23 11:31:39 volumio-phong-khach wpa_supplicant[704]: wlan0: Trying to associate with SSID 'NewTech' Mar 23 11:31:39 volumio-phong-khach bthelper[638]: [CHG] Controller B8:27:EB:E2:2C:0E Class: 0x0000041c Mar 23 11:31:39 volumio-phong-khach bthelper[638]: Changing power on succeeded Mar 23 11:31:39 volumio-phong-khach bthelper[638]: [CHG] Controller B8:27:EB:E2:2C:0E Powered: yes Mar 23 11:31:39 volumio-phong-khach systemd[1]: Started Music Player Daemon. Mar 23 11:31:39 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:39 volumio-phong-khach sudo[727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:39 volumio-phong-khach sudo[727]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:39 volumio-phong-khach sudo[727]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: wlan0: carrier acquired Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: wlan0: connected to Access Point `NewTech' Mar 23 11:31:39 volumio-phong-khach wpa_supplicant[704]: wlan0: Associated with 7c:a1:07:a0:a1:f0 Mar 23 11:31:39 volumio-phong-khach wpa_supplicant[704]: wlan0: CTRL-EVENT-CONNECTED - Connection to 7c:a1:07:a0:a1:f0 completed [id=1 id_str=] Mar 23 11:31:39 volumio-phong-khach wpa_supplicant[704]: wlan0: CTRL-EVENT-SUBNET-STATUS-UPDATE status=0 Mar 23 11:31:39 volumio-phong-khach wpa_supplicant[704]: wlan0: CTRL-EVENT-REGDOM-CHANGE init=COUNTRY_IE type=COUNTRY alpha2=US Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: DUID 00:01:00:01:29:53:67:9f:b8:27:eb:2b:b8:87 Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: wlan0: IAID eb:1d:d3:f1 Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: wlan0: adding address fe80::ba27:ebff:fe1d:d3f1 Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: ipv6_addaddr1: Permission denied Mar 23 11:31:39 volumio-phong-khach dhcpcd[717]: wlan0: probing address 192.168.1.198/24 Mar 23 11:31:40 volumio-phong-khach dhcpcd[717]: wlan0: carrier lost Mar 23 11:31:40 volumio-phong-khach dhcpcd[717]: wlan0: carrier acquired Mar 23 11:31:40 volumio-phong-khach dhcpcd[717]: wlan0: IAID eb:1d:d3:f1 Mar 23 11:31:40 volumio-phong-khach dhcpcd[717]: wlan0: probing address 192.168.1.198/24 Mar 23 11:31:40 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:40 volumio-phong-khach sudo[751]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:40 volumio-phong-khach sudo[751]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:40 volumio-phong-khach sudo[751]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:40 volumio-phong-khach dhcpcd[717]: wlan0: soliciting an IPv6 router Mar 23 11:31:41 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:41 volumio-phong-khach sudo[754]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:41 volumio-phong-khach sudo[754]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:41 volumio-phong-khach sudo[754]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:42 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:42 volumio-phong-khach sudo[757]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:42 volumio-phong-khach sudo[757]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:42 volumio-phong-khach sudo[757]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:43 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:43 volumio-phong-khach sudo[760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:43 volumio-phong-khach sudo[760]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:43 volumio-phong-khach sudo[760]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:43 volumio-phong-khach pm2[590]: [PM2] Spawning PM2 daemon with pm2_home=/home/volumio/.pm2 Mar 23 11:31:44 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:44 volumio-phong-khach sudo[770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:44 volumio-phong-khach sudo[770]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:44 volumio-phong-khach sudo[770]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:45 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:45] [info] asio async_connect error: system:111 (Connection refused) Mar 23 11:31:45 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:45] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Mar 23 11:31:45 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:45] [error] handle_connect error: Underlying Transport Error Mar 23 11:31:45 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:45 volumio-phong-khach sudo[773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:45 volumio-phong-khach sudo[773]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:45 volumio-phong-khach sudo[773]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:45 volumio-phong-khach dhcpcd[717]: wlan0: using static address 192.168.1.198/24 Mar 23 11:31:45 volumio-phong-khach avahi-daemon[472]: Joining mDNS multicast group on interface wlan0.IPv4 with address 192.168.1.198. Mar 23 11:31:45 volumio-phong-khach avahi-daemon[472]: New relevant interface wlan0.IPv4 for mDNS. Mar 23 11:31:45 volumio-phong-khach avahi-daemon[472]: Registering new address record for 192.168.1.198 on wlan0.IPv4. Mar 23 11:31:45 volumio-phong-khach dhcpcd[717]: wlan0: adding route to 192.168.1.0/24 Mar 23 11:31:45 volumio-phong-khach dhcpcd[717]: wlan0: adding default route via 192.168.1.1 Mar 23 11:31:45 volumio-phong-khach pm2[590]: [PM2] PM2 Successfully daemonized Mar 23 11:31:46 volumio-phong-khach pm2[590]: [PM2] Resurrecting Mar 23 11:31:46 volumio-phong-khach pm2[590]: [PM2] Restoring processes located in /home/volumio/.pm2/dump.pm2 Mar 23 11:31:46 volumio-phong-khach pm2[590]: [PM2] Process /opt/node/volumio-mqtt/server.js restored Mar 23 11:31:46 volumio-phong-khach wireless.js[456]: trying... Mar 23 11:31:46 volumio-phong-khach sudo[807]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwgetid -r Mar 23 11:31:46 volumio-phong-khach sudo[807]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:46 volumio-phong-khach sudo[807]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:46 volumio-phong-khach wireless.js[456]: Connected to: ----NewTech Mar 23 11:31:46 volumio-phong-khach wireless.js[456]: ---- Mar 23 11:31:46 volumio-phong-khach sudo[815]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 23 11:31:46 volumio-phong-khach sudo[815]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:46 volumio-phong-khach sudo[815]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:46 volumio-phong-khach wireless.js[456]: ... joined AP, wlan0 IPv4 is 192.168.1.198, ipV6 is undefined Mar 23 11:31:46 volumio-phong-khach wireless.js[456]: It's done! AP Mar 23 11:31:46 volumio-phong-khach systemd[1]: Started Wireless Services. Mar 23 11:31:46 volumio-phong-khach systemd[1]: Started Volumio Backend Module. Mar 23 11:31:46 volumio-phong-khach systemd[1]: Started Volumio Streaming Daemon. Mar 23 11:31:46 volumio-phong-khach pm2[590]: ┌─────┬─────────────────┬─────────────┬─────────┬─────────┬──────────┬────────┬──────┬───────────┬──────────┬──────────┬──────────┬──────────┐ Mar 23 11:31:46 volumio-phong-khach pm2[590]: │ id │ name │ namespace │ version │ mode │ pid │ uptime │ ↺ │ status │ cpu │ mem │ user │ watching │ Mar 23 11:31:46 volumio-phong-khach pm2[590]: ├─────┼─────────────────┼─────────────┼─────────┼─────────┼──────────┼────────┼──────┼───────────┼──────────┼──────────┼──────────┼──────────┤ Mar 23 11:31:46 volumio-phong-khach pm2[590]: │ 0 │ volumio-mqtt │ default │ 1.0.0 │ fork │ 800 │ 0s │ 0 │ online │ 0% │ 25.2mb │ volumio │ disabled │ Mar 23 11:31:46 volumio-phong-khach pm2[590]: └─────┴─────────────────┴─────────────┴─────────┴─────────┴──────────┴────────┴──────┴───────────┴──────────┴──────────┴──────────┴──────────┘ Mar 23 11:31:46 volumio-phong-khach systemd[1]: Started PM2 process manager. Mar 23 11:31:47 volumio-phong-khach volumio-streaming-daemon[820]: ############################ Mar 23 11:31:47 volumio-phong-khach volumio-streaming-daemon[820]: # Volumio Streaming Daemon # Mar 23 11:31:47 volumio-phong-khach volumio-streaming-daemon[820]: # Running on port 7777 # Mar 23 11:31:47 volumio-phong-khach volumio-streaming-daemon[820]: ############################ Mar 23 11:31:47 volumio-phong-khach volumio-streaming-daemon[820]: Environment: production Mar 23 11:31:47 volumio-phong-khach ntpd[624]: Listen normally on 3 wlan0 192.168.1.198:123 Mar 23 11:31:47 volumio-phong-khach ntpd[624]: new interface(s) found: waking up resolver Mar 23 11:31:49 volumio-phong-khach nmbd[607]: [2023/03/23 11:31:49.560631, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 23 11:31:49 volumio-phong-khach systemd[1]: Started Samba NMB Daemon. Mar 23 11:31:49 volumio-phong-khach nmbd[607]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Mar 23 11:31:49 volumio-phong-khach systemd[1]: Starting Samba Winbind Daemon... Mar 23 11:31:50 volumio-phong-khach winbindd[840]: [2023/03/23 11:31:50.772747, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Mar 23 11:31:50 volumio-phong-khach winbindd[840]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Mar 23 11:31:51 volumio-phong-khach winbindd[840]: [2023/03/23 11:31:51.040782, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 23 11:31:51 volumio-phong-khach systemd[1]: Started Samba Winbind Daemon. Mar 23 11:31:51 volumio-phong-khach winbindd[840]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Mar 23 11:31:51 volumio-phong-khach systemd[1]: Starting Samba SMB Daemon... Mar 23 11:31:52 volumio-phong-khach winbindd[840]: [2023/03/23 11:31:52.213463, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Mar 23 11:31:52 volumio-phong-khach winbindd[840]: res_names->count = 3, expected 4 Mar 23 11:31:52 volumio-phong-khach systemd[1]: Started Samba SMB Daemon. Mar 23 11:31:52 volumio-phong-khach systemd[1]: Reached target Multi-User System. Mar 23 11:31:52 volumio-phong-khach smbd[845]: [2023/03/23 11:31:52.306694, 0] ../lib/util/become_daemon.c:138(daemon_ready) Mar 23 11:31:52 volumio-phong-khach smbd[845]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Mar 23 11:31:52 volumio-phong-khach systemd[1]: Reached target Graphical Interface. Mar 23 11:31:52 volumio-phong-khach systemd[1]: Starting Update UTMP about System Runlevel Changes... Mar 23 11:31:52 volumio-phong-khach systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Mar 23 11:31:52 volumio-phong-khach systemd[1]: Started Update UTMP about System Runlevel Changes. Mar 23 11:31:52 volumio-phong-khach systemd[1]: Startup finished in 14.477s (kernel) + 32.277s (userspace) = 46.754s. Mar 23 11:31:53 volumio-phong-khach volumio[819]: info: ------------------------------------------- Mar 23 11:31:53 volumio-phong-khach volumio[819]: info: ----- Volumio3 ---- Mar 23 11:31:53 volumio-phong-khach volumio[819]: info: ------------------------------------------- Mar 23 11:31:53 volumio-phong-khach volumio[819]: info: ----- System startup ---- Mar 23 11:31:53 volumio-phong-khach volumio[819]: info: ------------------------------------------- Mar 23 11:31:55 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:31:55] [connect] Successful connection Mar 23 11:31:55 volumio-phong-khach systemd[1]: systemd-fsckd.service: Succeeded. Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: MYVOLUMIO Environment detected Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Plugin folders cleanup Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning into folder /volumio/app/plugins/ Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category audio_interface Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category miscellanea Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category music_service Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category plugins.json Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category system_controller Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category user_interface Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning into folder /data/plugins/ Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Scanning category music_service Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Plugin folders cleanup completed Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: ------------------------------------------- Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: ----- Core plugins startup ---- Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: ------------------------------------------- Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Loading plugins from folder /volumio/app/plugins/ Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Adding plugin upnp to MyMusic Plugins Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Loading plugins from folder /data/plugins/ Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Loading plugin "system"... Mar 23 11:31:56 volumio-phong-khach volumio[819]: info: Loading plugin "appearance"... Mar 23 11:31:57 volumio-phong-khach sh[368]: timed out Mar 23 11:31:57 volumio-phong-khach dhcpcd[408]: timed out Mar 23 11:31:57 volumio-phong-khach sh[368]: dhcpcd exited Mar 23 11:31:57 volumio-phong-khach dhcpcd[408]: dhcpcd exited Mar 23 11:31:57 volumio-phong-khach sh[368]: ifup: failed to bring up eth0 Mar 23 11:31:57 volumio-phong-khach systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE Mar 23 11:31:57 volumio-phong-khach systemd[1]: ifup@eth0.service: Failed with result 'exit-code'. Mar 23 11:31:58 volumio-phong-khach volumio[819]: info: Loading plugin "network"... Mar 23 11:31:58 volumio-phong-khach volumio[819]: info: Refreshing Cached IP Addresses Mar 23 11:31:59 volumio-phong-khach sudo[866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 23 11:31:59 volumio-phong-khach sudo[866]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:59 volumio-phong-khach sudo[866]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "services"... Mar 23 11:31:59 volumio-phong-khach sudo[868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 23 11:31:59 volumio-phong-khach sudo[868]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "alsa_controller"... Mar 23 11:31:59 volumio-phong-khach sudo[868]: pam_unix(sudo:session): session closed for user root Mar 23 11:31:59 volumio-phong-khach sudo[871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 23 11:31:59 volumio-phong-khach sudo[871]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "wizard"... Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "volumio_command_line_client"... Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "upnp"... Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: [1679571119383] Starting Upmpd Daemon Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "my_music"... Mar 23 11:31:59 volumio-phong-khach volumio[819]: info: Loading plugin "mpd"... Mar 23 11:31:59 volumio-phong-khach sudo[871]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:00 volumio-phong-khach volumio[819]: info: Creating MPD Configuration file Mar 23 11:32:00 volumio-phong-khach volumio[819]: info: Loading plugin "upnp_browser"... Mar 23 11:32:00 volumio-phong-khach sudo[879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 23 11:32:00 volumio-phong-khach sudo[879]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:00 volumio-phong-khach sudo[879]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:00 volumio-phong-khach sudo[881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 23 11:32:00 volumio-phong-khach sudo[881]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:00 volumio-phong-khach systemd[1]: Stopping Music Player Daemon... Mar 23 11:32:00 volumio-phong-khach systemd[1]: mpd.service: Succeeded. Mar 23 11:32:00 volumio-phong-khach systemd[1]: Stopped Music Player Daemon. Mar 23 11:32:00 volumio-phong-khach systemd[1]: Starting Music Player Daemon... Mar 23 11:32:01 volumio-phong-khach volumio[819]: info: Loading plugin "networkfs"... Mar 23 11:32:02 volumio-phong-khach volumio[819]: info: Starting Udev Watcher for removable devices Mar 23 11:32:02 volumio-phong-khach sudo[889]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=admin,password=Hikvision2021,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.200/Disk1share/MUSIC /mnt/NAS/Nas_HIK Mar 23 11:32:02 volumio-phong-khach sudo[889]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:02 volumio-phong-khach kernel: FS-Cache: Netfs 'cifs' registered for caching Mar 23 11:32:02 volumio-phong-khach kernel: Key type cifs.spnego registered Mar 23 11:32:02 volumio-phong-khach kernel: Key type cifs.idmap registered Mar 23 11:32:02 volumio-phong-khach kernel: CIFS: Attempting to mount //192.168.1.200/Disk1share/MUSIC Mar 23 11:32:02 volumio-phong-khach 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. Mar 23 11:32:02 volumio-phong-khach volumio[819]: info: Ignoring mount for partition: boot Mar 23 11:32:02 volumio-phong-khach volumio[819]: info: Ignoring mount for partition: volumio Mar 23 11:32:02 volumio-phong-khach volumio[819]: info: Ignoring mount for partition: volumio_data Mar 23 11:32:02 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 23 11:32:02 volumio-phong-khach volumio[819]: info: Loading plugin "alarm-clock"... Mar 23 11:32:02 volumio-phong-khach sudo[889]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:02 volumio-phong-khach kernel: Status code returned 0xc000000d STATUS_INVALID_PARAMETER Mar 23 11:32:02 volumio-phong-khach kernel: CIFS VFS: \\192.168.1.200 Send error in SessSetup = -22 Mar 23 11:32:02 volumio-phong-khach kernel: CIFS VFS: cifs_mount failed w/return code = -2 Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Loading plugin "airplay_emulation"... Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Starting Shairport Sync Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Loading plugin "last_100"... Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Loading plugin "webradio"... Mar 23 11:32:03 volumio-phong-khach mpd[886]: Mar 23 11:32 : exception: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 23 11:32:03 volumio-phong-khach mpd[886]: Mar 23 11:32 : exception: Input plugin 'tidal' is unavailable: No Tidal application token configured Mar 23 11:32:03 volumio-phong-khach mpd[886]: Mar 23 11:32 : exception: Input plugin 'qobuz' is unavailable: No Qobuz app_id configured Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Loading plugin "i2s_dacs"... Mar 23 11:32:03 volumio-phong-khach systemd[1]: Started Music Player Daemon. Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: I2S DAC not set, start Auto-detection Mar 23 11:32:03 volumio-phong-khach sudo[881]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Loading plugin "volumiodiscovery"... Mar 23 11:32:03 volumio-phong-khach volumio[819]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 23 11:32:03 volumio-phong-khach volumio[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 23 11:32:03 volumio-phong-khach volumio[819]: *** WARNING *** For more information see Mar 23 11:32:03 volumio-phong-khach volumio[819]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 23 11:32:03 volumio-phong-khach volumio[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 23 11:32:03 volumio-phong-khach volumio[819]: *** WARNING *** For more information see Mar 23 11:32:03 volumio-phong-khach node[819]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 23 11:32:03 volumio-phong-khach node[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 23 11:32:03 volumio-phong-khach node[819]: *** WARNING *** For more information see Mar 23 11:32:03 volumio-phong-khach node[819]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 23 11:32:03 volumio-phong-khach node[819]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 23 11:32:03 volumio-phong-khach node[819]: *** WARNING *** For more information see Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Discovery: Started advertising with name: Volumio Phong Khach Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 23 11:32:03 volumio-phong-khach volumio[819]: info: Loading plugin "youtube2"... Mar 23 11:32:04 volumio-phong-khach systemd[1]: systemd-hostnamed.service: Succeeded. Mar 23 11:32:10 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:32:10] [connect] Successful connection Mar 23 11:32:20 volumio-phong-khach volumio[819]: info: Loading plugin "outputs"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Loading plugin "albumart"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Plugin example_plugin is not enabled Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Loading plugin "inputs"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Loading plugin "updater_comm"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Plugin mpdemulation is not enabled Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Loading plugin "rest_api"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Loading plugin "websocket"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: info: Loading plugin "minidlna"... Mar 23 11:32:21 volumio-phong-khach volumio[819]: Forking 3 albumart workers Mar 23 11:32:23 volumio-phong-khach volumio[819]: Starting albumart workers Mar 23 11:32:23 volumio-phong-khach volumio[819]: Starting albumart workers Mar 23 11:32:23 volumio-phong-khach volumio[819]: Starting albumart workers Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: Applying required configuration parameters for plugin minidlna Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: Loading i18n strings for locale en Mar 23 11:32:24 volumio-phong-khach volumio[819]: Updating browse sources language Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::initPlayerControls Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 23 11:32:24 volumio-phong-khach volumio[819]: Express server listening on port 3000 Mar 23 11:32:24 volumio-phong-khach volumio[819]: [Metrics] WebUI: 33s 361.89ms Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreStateMachine::resetVolumioState Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreStateMachine::getcurrentVolume Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioRetrievevolume Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 23 11:32:24 volumio-phong-khach sudo[980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 23 11:32:24 volumio-phong-khach sudo[980]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:24 volumio-phong-khach sudo[980]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:24 volumio-phong-khach sudo[982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 23 11:32:24 volumio-phong-khach sudo[982]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:24 volumio-phong-khach sudo[982]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: Cannot mount NAS Nas_HIK at system boot, trial number 1 ,retrying in 5 seconds Mar 23 11:32:24 volumio-phong-khach volumio[819]: info: MPD Permissions set Mar 23 11:32:25 volumio-phong-khach volumio[819]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 1 Mar 23 11:32:25 volumio-phong-khach volumio[819]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 2 Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: VolumeController:: Volume=85 Mute =false Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreStateMachine::pushState Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CorePlayQueue::getTrack 0 Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioPushState Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreStateMachine::updateTrackBlock Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CorePlayQueue::getTrackBlock Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioRetrievevolume Mar 23 11:32:25 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:32:25] [connect] Successful connection Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: MPD running with PID886 Mar 23 11:32:25 volumio-phong-khach volumio[819]: ,establishing connection Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: Reloading queue from file Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:25 volumio-phong-khach volumio[819]: error: updateQueue error: null Mar 23 11:32:25 volumio-phong-khach volumio[819]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Mar 23 11:32:25 volumio-phong-khach volumio-remote-updater[487]: [2023-03-23 11:32:25] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1679571145 101 Mar 23 11:32:25 volumio-phong-khach volumio[819]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Total Clients: 3 Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreStateMachine::setRepeat null single undefined Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreStateMachine::pushState Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CorePlayQueue::getTrack 0 Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioPushState Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreStateMachine::setRandom false Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreStateMachine::pushState Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CorePlayQueue::getTrack 0 Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioPushState Mar 23 11:32:25 volumio-phong-khach volumio[819]: info: Setting Device type: Raspberry PI Mar 23 11:32:25 volumio-phong-khach sudo[1000]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Mar 23 11:32:25 volumio-phong-khach sudo[1000]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:25 volumio-phong-khach systemd[1]: Started UPnP Renderer front-end to MPD. Mar 23 11:32:25 volumio-phong-khach sudo[1000]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:26 volumio-phong-khach volumio[819]: error: updateQueue error: null Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: VolumeController:: Volume=85 Mute =false Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CoreStateMachine::pushState Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CorePlayQueue::getTrack 0 Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioPushState Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Completed loading Core Plugins Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Preparing to generate the ALSA configuration file Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Discovery: adding 87cfa569-de37-4874-855c-27773e09849a Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: mDNS: Found device Volumio Phong Khach Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioGetState Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CorePlayQueue::getTrack 0 Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Upmpdcli Daemon Started Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Asound.conf file unchanged, so no further update is needed Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Output device has changed, restarting MPD Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: Output device has changed, restarting Shairport Sync Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:26 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 23 11:32:26 volumio-phong-khach sudo[1005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 23 11:32:26 volumio-phong-khach sudo[1005]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:26 volumio-phong-khach sudo[1005]: pam_unix(sudo:session): session closed for user root Mar 23 11:32:26 volumio-phong-khach sudo[1007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 23 11:32:26 volumio-phong-khach sudo[1007]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 23 11:32:27 volumio-phong-khach systemd[1]: Stopping Music Player Daemon... Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: ___________ START PLUGINS ___________ Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: [1679571147034] CoreMusicLibrary::Adding element Media Servers Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 23 11:32:27 volumio-phong-khach volumio[819]: Cannot find translation for sourceMedia Servers Mar 23 11:32:27 volumio-phong-khach systemd[1]: mpd.service: Succeeded. Mar 23 11:32:27 volumio-phong-khach systemd[1]: Stopped Music Player Daemon. Mar 23 11:32:27 volumio-phong-khach systemd[1]: Starting Music Player Daemon... Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: [1679571147454] CoreMusicLibrary::Adding element Last_100 Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 23 11:32:27 volumio-phong-khach volumio[819]: Cannot find translation for sourceMedia Servers Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: [1679571147464] CoreMusicLibrary::Adding element Webradio Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 23 11:32:27 volumio-phong-khach volumio[819]: Cannot find translation for sourceMedia Servers Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: [youtube2-auth] Starting auth flow... Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: [1679571147706] CoreMusicLibrary::Adding element YouTube2 Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 23 11:32:27 volumio-phong-khach volumio[819]: Cannot find translation for sourceMedia Servers Mar 23 11:32:27 volumio-phong-khach volumio[819]: Cannot find translation for sourceYouTube2 Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: Loading i18n strings for locale en Mar 23 11:32:27 volumio-phong-khach volumio[819]: info: Volumio Calling Home Mar 23 11:32:28 volumio-phong-khach volumio[819]: error: Upnp client error: Error: This socket has been ended by the other party Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: MPD Permissions set Mar 23 11:32:28 volumio-phong-khach volumio[819]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 4 Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 23 11:32:28 volumio-phong-khach volumio[819]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 23 11:32:28 volumio-phong-khach volumio[819]: ReferenceError: deferred is not defined Mar 23 11:32:28 volumio-phong-khach volumio[819]: at ClientRequest. (/data/plugins/music_service/youtube2/lib/core/gapi/auth.js:155:13) Mar 23 11:32:28 volumio-phong-khach volumio[819]: at ClientRequest.emit (events.js:315:20) Mar 23 11:32:28 volumio-phong-khach volumio[819]: at TLSSocket.socketErrorListener (_http_client.js:469:9) Mar 23 11:32:28 volumio-phong-khach volumio[819]: at TLSSocket.emit (events.js:315:20) Mar 23 11:32:28 volumio-phong-khach volumio[819]: at emitErrorNT (internal/streams/destroy.js:106:8) Mar 23 11:32:28 volumio-phong-khach volumio[819]: at emitErrorCloseNT (internal/streams/destroy.js:74:3) Mar 23 11:32:28 volumio-phong-khach volumio[819]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 23 11:32:28 volumio-phong-khach volumio[819]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 23 11:32:29 volumio-phong-khach sudo[1040]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2023-03-23 11:31 Mar 23 11:32:29 volumio-phong-khach sudo[1040]: 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="682e0b17433cee9f9da31457f545345105e06e63" VOLUMIO_FE_VERSION="fba46add594d630e1b506bc42f1beddaad53fb64" VOLUMIO_FE3_VERSION="c23fef6dba8e02db978bd39bd8d26872e60ada6e" VOLUMIO_BE_VERSION="f7885966dee9f148ddf4f5050103a7d6734e1a10" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 20 Dec 2021 04:57:50 PM CET" VOLUMIO_VERSION="3.179" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="6d5d4c489f0b1e608d9cefb791a9102d"