-- Logs begin at Sun 2024-11-03 08:49:33 +07, end at Sun 2024-11-03 08:51:51 +07. -- Nov 03 08:49:59 volumio--tun-an sudo[1331]: pam_unix(sudo:session): session closed for user root Nov 03 08:50:00 volumio--tun-an volumio[839]: info: Upmpdcli Daemon Started Nov 03 08:50:00 volumio--tun-an volumio[839]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/90.0.4430.212 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetVisibleSources Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 03 08:50:00 volumio--tun-an volumio[839]: info: Received Get System Info Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 08:50:00 volumio--tun-an volumio[839]: info: Discovery: Getting this device information Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:50:00 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:50:00 volumio--tun-an volumio[839]: info: Listing playlists Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 08:50:01 volumio--tun-an volumio[839]: info: Received Get System Info Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 08:50:01 volumio--tun-an volumio[839]: info: Discovery: Getting this device information Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:50:01 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: Cannot compose Albumart path Nov 03 08:50:02 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 03 08:50:05 volumio--tun-an volumio[839]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.757&uuid=fa2a6834961d810b7b5924843a4b5f1c" http://updates.volumio.org/downloader-v1/track-device Nov 03 08:50:05 volumio--tun-an volumio[839]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 03 08:50:05 volumio--tun-an volumio[839]: Dload Upload Total Spent Left Speed Nov 03 08:50:05 volumio--tun-an volumio[839]: [132B blob data] Nov 03 08:50:05 volumio--tun-an volumio[839]: retrying in 5 seconds, trial 0 Nov 03 08:50:05 volumio--tun-an volumio[839]: info: Volumio Calling Home Nov 03 08:50:06 volumio--tun-an systemd[1]: systemd-fsckd.service: Succeeded. Nov 03 08:50:10 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 03 08:50:11 volumio--tun-an dhcpcd[728]: eth0: carrier acquired Nov 03 08:50:11 volumio--tun-an kernel: Generic FE-GE Realtek PHY r8169-0-100:00: Downshift occurred from negotiated speed 1Gbps to actual speed 10Mbps, check cabling! Nov 03 08:50:11 volumio--tun-an kernel: r8169 0000:01:00.0 eth0: Link is Up - 10Mbps/Full (downshifted) - flow control off Nov 03 08:50:11 volumio--tun-an dhcpcd[728]: eth0: IAID 34:34:27:44 Nov 03 08:50:12 volumio--tun-an dhcpcd[728]: eth0: soliciting a DHCP lease Nov 03 08:50:12 volumio--tun-an ifplugd(eth0)[809]: Link beat detected. Nov 03 08:50:12 volumio--tun-an ifplugd(eth0)[809]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 03 08:50:12 volumio--tun-an ifplugd(eth0)[809]: client: ifup: interface eth0 already configured Nov 03 08:50:12 volumio--tun-an dhcpcd[728]: eth0: soliciting an IPv6 router Nov 03 08:50:12 volumio--tun-an ifplugd(eth0)[809]: Program executed successfully. Nov 03 08:50:15 volumio--tun-an volumio[839]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.757&uuid=fa2a6834961d810b7b5924843a4b5f1c" http://updates.volumio.org/downloader-v1/track-device Nov 03 08:50:15 volumio--tun-an volumio[839]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 03 08:50:15 volumio--tun-an volumio[839]: Dload Upload Total Spent Left Speed Nov 03 08:50:15 volumio--tun-an volumio[839]: [132B blob data] Nov 03 08:50:15 volumio--tun-an volumio[839]: retrying in 5 seconds, trial 1 Nov 03 08:50:15 volumio--tun-an volumio[839]: info: Volumio Calling Home Nov 03 08:50:17 volumio--tun-an dhcpcd[728]: eth0: probing for an IPv4LL address Nov 03 08:50:17 volumio--tun-an volumio[839]: error: MyVolumio Plugin failed to start in a timely fashion Nov 03 08:50:17 volumio--tun-an volumio[839]: info: BOOT COMPLETED Nov 03 08:50:17 volumio--tun-an volumio[839]: [Metrics] CommandRouter: 34s 806.94ms Nov 03 08:50:17 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumiosetStartupVolume Nov 03 08:50:17 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Nov 03 08:50:17 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 08:50:17 volumio--tun-an volumio[839]: info: CoreCommandRouter::Close All Modals sent Nov 03 08:50:17 volumio--tun-an volumio[839]: info: CoreCommandRouter::Close All Modals sent Nov 03 08:50:18 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Nov 03 08:50:18 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 03 08:50:18 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Nov 03 08:50:20 volumio--tun-an systemd[1]: systemd-hostnamed.service: Succeeded. Nov 03 08:50:22 volumio--tun-an dhcpcd[728]: eth0: using IPv4LL address 169.254.133.116 Nov 03 08:50:22 volumio--tun-an avahi-daemon[610]: Joining mDNS multicast group on interface eth0.IPv4 with address 169.254.133.116. Nov 03 08:50:22 volumio--tun-an avahi-daemon[610]: New relevant interface eth0.IPv4 for mDNS. Nov 03 08:50:22 volumio--tun-an avahi-daemon[610]: Registering new address record for 169.254.133.116 on eth0.IPv4. Nov 03 08:50:22 volumio--tun-an dhcpcd[728]: eth0: adding route to 169.254.0.0/16 Nov 03 08:50:22 volumio--tun-an dhcpcd[728]: eth0: adding default route Nov 03 08:50:23 volumio--tun-an ntpd[814]: Listen normally on 3 eth0 169.254.133.116:123 Nov 03 08:50:23 volumio--tun-an ntpd[814]: new interface(s) found: waking up resolver Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.171245, 0] ../source3/nmbd/nmbd_nameregister.c:554(register_name) Nov 03 08:50:24 volumio--tun-an nmbd[777]: register_name: NetBIOS name VOLUMIO- TUẤN cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.171511, 0] ../source3/nmbd/nmbd_nameregister.c:554(register_name) Nov 03 08:50:24 volumio--tun-an nmbd[777]: register_name: NetBIOS name VOLUMIO- TUẤN cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.171600, 0] ../source3/nmbd/nmbd_nameregister.c:554(register_name) Nov 03 08:50:24 volumio--tun-an nmbd[777]: register_name: NetBIOS name VOLUMIO- TUẤN cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.171988, 0] ../source3/nmbd/nmbd_nameregister.c:554(register_name) Nov 03 08:50:24 volumio--tun-an nmbd[777]: register_name: NetBIOS name VOLUMIO- TUẤN cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.172185, 0] ../source3/nmbd/nmbd_nameregister.c:554(register_name) Nov 03 08:50:24 volumio--tun-an nmbd[777]: register_name: NetBIOS name VOLUMIO- TUẤN cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.172269, 0] ../source3/nmbd/nmbd_nameregister.c:554(register_name) Nov 03 08:50:24 volumio--tun-an nmbd[777]: register_name: NetBIOS name VOLUMIO- TUẤN cannot be converted (Invalid or incomplete multibyte or wide character). Failing to register name. Nov 03 08:50:24 volumio--tun-an nmbd[777]: [2024/11/03 08:50:24.172828, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 03 08:50:24 volumio--tun-an nmbd[777]: daemon_ready: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Nov 03 08:50:24 volumio--tun-an systemd[1]: Started Samba NMB Daemon. Nov 03 08:50:24 volumio--tun-an systemd[1]: Starting Samba Winbind Daemon... Nov 03 08:50:24 volumio--tun-an winbindd[1556]: [2024/11/03 08:50:24.437338, 0] ../source3/winbindd/winbindd_cache.c:3160(initialize_winbindd_cache) Nov 03 08:50:24 volumio--tun-an winbindd[1556]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Nov 03 08:50:24 volumio--tun-an winbindd[1556]: [2024/11/03 08:50:24.456168, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 03 08:50:24 volumio--tun-an systemd[1]: Started Samba Winbind Daemon. Nov 03 08:50:24 volumio--tun-an winbindd[1556]: daemon_ready: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Nov 03 08:50:24 volumio--tun-an systemd[1]: Starting Samba SMB Daemon... Nov 03 08:50:24 volumio--tun-an winbindd[1556]: [2024/11/03 08:50:24.835888, 0] ../source3/winbindd/wb_lookupsids.c:659(wb_lookupsids_recv) Nov 03 08:50:24 volumio--tun-an winbindd[1556]: res_names->count = 3, expected 4 Nov 03 08:50:24 volumio--tun-an smbd[1561]: [2024/11/03 08:50:24.859069, 0] ../lib/util/become_daemon.c:138(daemon_ready) Nov 03 08:50:24 volumio--tun-an systemd[1]: Started Samba SMB Daemon. Nov 03 08:50:24 volumio--tun-an smbd[1561]: daemon_ready: STATUS=daemon 'smbd' finished starting up and ready to serve connections Nov 03 08:50:24 volumio--tun-an systemd[1]: Reached target Multi-User System. Nov 03 08:50:24 volumio--tun-an systemd[1]: Reached target Graphical Interface. Nov 03 08:50:24 volumio--tun-an systemd[1]: Starting Update UTMP about System Runlevel Changes... Nov 03 08:50:24 volumio--tun-an systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Nov 03 08:50:24 volumio--tun-an systemd[1]: Started Update UTMP about System Runlevel Changes. Nov 03 08:50:24 volumio--tun-an systemd[1]: Startup finished in 8.978s (firmware) + 2.865s (loader) + 20.772s (kernel) + 52.046s (userspace) = 1min 24.662s. Nov 03 08:50:25 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 03 08:50:25 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 08:50:25 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 03 08:50:25 volumio--tun-an volumio[839]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.757&uuid=fa2a6834961d810b7b5924843a4b5f1c" http://updates.volumio.org/downloader-v1/track-device Nov 03 08:50:25 volumio--tun-an volumio[839]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 03 08:50:25 volumio--tun-an volumio[839]: Dload Upload Total Spent Left Speed Nov 03 08:50:25 volumio--tun-an volumio[839]: [132B blob data] Nov 03 08:50:25 volumio--tun-an volumio[839]: retrying in 5 seconds, trial 2 Nov 03 08:50:25 volumio--tun-an volumio[839]: info: Volumio Calling Home Nov 03 08:50:26 volumio--tun-an volumio[1333]: Generating RSA private key, 4096 bit long modulus (2 primes) Nov 03 08:50:26 volumio--tun-an volumio[1333]: ...................................++++ Nov 03 08:50:37 volumio--tun-an volumiologrotate[617]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO-': No such file or directory Nov 03 08:50:37 volumio--tun-an volumiologrotate[617]: ls: cannot access 'TUẤN': No such file or directory Nov 03 08:50:37 volumio--tun-an volumiologrotate[617]: ls: cannot access 'AN': No such file or directory Nov 03 08:50:38 volumio--tun-an volumio[1333]: ...........................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................................++++ Nov 03 08:50:38 volumio--tun-an volumio[1333]: e is 65537 (0x010001) Nov 03 08:50:38 volumio--tun-an volumio[1333]: writing RSA key Nov 03 08:50:40 volumio--tun-an dhcpcd[728]: eth0: carrier lost Nov 03 08:50:40 volumio--tun-an kernel: r8169 0000:01:00.0 eth0: Link is Down Nov 03 08:50:40 volumio--tun-an dhcpcd[728]: eth0: deleting route to 169.254.0.0/16 Nov 03 08:50:40 volumio--tun-an dhcpcd[728]: eth0: deleting default route Nov 03 08:50:40 volumio--tun-an avahi-daemon[610]: Withdrawing address record for 169.254.133.116 on eth0. Nov 03 08:50:40 volumio--tun-an avahi-daemon[610]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.133.116. Nov 03 08:50:40 volumio--tun-an avahi-daemon[610]: Interface eth0.IPv4 no longer relevant for mDNS. Nov 03 08:50:40 volumio--tun-an volumio[839]: info: Discovery: A device disappeared from network Nov 03 08:50:40 volumio--tun-an volumio[839]: info: Discovery: Browse raised the following error TypeError: Cannot read property 'toLowerCase' of undefined Nov 03 08:50:40 volumio--tun-an ifplugd(eth0)[809]: Link beat lost. Nov 03 08:50:41 volumio--tun-an ntpd[814]: Deleting interface #3 eth0, 169.254.133.116#123, interface stats: received=0, sent=0, dropped=0, active_time=18 secs Nov 03 08:50:43 volumio--tun-an ntpd[814]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 03 08:50:46 volumio--tun-an ntpd[814]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 03 08:50:46 volumio--tun-an ntpd[814]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 03 08:50:48 volumio--tun-an volumio[839]: info: Discovery: Browse raised the following error Error: getaddrinfo -3008 Nov 03 08:50:48 volumio--tun-an ntpd[814]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 03 08:50:50 volumio--tun-an ifplugd(eth0)[809]: Executing '/etc/ifplugd/ifplugd.action eth0 down'. Nov 03 08:50:51 volumio--tun-an dhcpcd[1674]: sending commands to master dhcpcd process Nov 03 08:50:51 volumio--tun-an ifplugd(eth0)[809]: client: sending commands to master dhcpcd process Nov 03 08:50:51 volumio--tun-an dhcpcd[728]: control command: /sbin/dhcpcd -k eth0 Nov 03 08:50:51 volumio--tun-an dhcpcd[728]: eth0: removing interface Nov 03 08:50:51 volumio--tun-an ifplugd(eth0)[809]: Program executed successfully. Nov 03 08:50:51 volumio--tun-an kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) Nov 03 08:50:51 volumio--tun-an kernel: r8169 0000:01:00.0 eth0: Link is Down Nov 03 08:51:15 volumio--tun-an kernel: Generic FE-GE Realtek PHY r8169-0-100:00: Downshift occurred from negotiated speed 1Gbps to actual speed 10Mbps, check cabling! Nov 03 08:51:15 volumio--tun-an kernel: r8169 0000:01:00.0 eth0: Link is Up - 10Mbps/Full (downshifted) - flow control off Nov 03 08:51:15 volumio--tun-an ifplugd(eth0)[809]: Link beat detected. Nov 03 08:51:15 volumio--tun-an ifplugd(eth0)[809]: Executing '/etc/ifplugd/ifplugd.action eth0 up'. Nov 03 08:51:15 volumio--tun-an ifplugd(eth0)[809]: client: command failed: No such device (-19) Nov 03 08:51:15 volumio--tun-an ifplugd(eth0)[809]: client: sending commands to master dhcpcd process Nov 03 08:51:15 volumio--tun-an dhcpcd[1714]: sending commands to master dhcpcd process Nov 03 08:51:15 volumio--tun-an dhcpcd[728]: control command: /sbin/dhcpcd eth0 Nov 03 08:51:15 volumio--tun-an dhcpcd[728]: eth0: carrier acquired Nov 03 08:51:15 volumio--tun-an dhcpcd[728]: eth0: IAID 34:34:27:44 Nov 03 08:51:15 volumio--tun-an ifplugd(eth0)[809]: Program executed successfully. Nov 03 08:51:16 volumio--tun-an dhcpcd[728]: eth0: soliciting a DHCP lease Nov 03 08:51:16 volumio--tun-an dhcpcd[728]: eth0: soliciting an IPv6 router Nov 03 08:51:17 volumio--tun-an dhcpcd[728]: eth0: carrier lost Nov 03 08:51:17 volumio--tun-an kernel: r8169 0000:01:00.0 eth0: Link is Down Nov 03 08:51:18 volumio--tun-an ifplugd(eth0)[809]: Link beat lost. Nov 03 08:51:27 volumio--tun-an dhcpcd[728]: eth0: carrier acquired Nov 03 08:51:27 volumio--tun-an kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control off Nov 03 08:51:27 volumio--tun-an dhcpcd[728]: eth0: IAID 34:34:27:44 Nov 03 08:51:27 volumio--tun-an dhcpcd[728]: eth0: soliciting an IPv6 router Nov 03 08:51:27 volumio--tun-an dhcpcd[728]: eth0: soliciting a DHCP lease Nov 03 08:51:27 volumio--tun-an ifplugd(eth0)[809]: Link beat detected. Nov 03 08:51:32 volumio--tun-an dhcpcd[728]: eth0: offered 192.168.2.9 from 192.168.2.253 Nov 03 08:51:32 volumio--tun-an dhcpcd[728]: eth0: probing address 192.168.2.9/24 Nov 03 08:51:36 volumio--tun-an dhcpcd[728]: eth0: leased 192.168.2.9 for 86400 seconds Nov 03 08:51:36 volumio--tun-an dhcpcd[728]: eth0: adding route to 192.168.2.0/24 Nov 03 08:51:36 volumio--tun-an dhcpcd[728]: eth0: adding default route via 192.168.2.253 Nov 03 08:51:36 volumio--tun-an avahi-daemon[610]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.2.9. Nov 03 08:51:36 volumio--tun-an avahi-daemon[610]: New relevant interface eth0.IPv4 for mDNS. Nov 03 08:51:36 volumio--tun-an avahi-daemon[610]: Registering new address record for 192.168.2.9 on eth0.IPv4. Nov 03 08:51:36 volumio--tun-an systemd[1]: Stopping Network Time Service... Nov 03 08:51:36 volumio--tun-an ntpd[814]: ntpd exiting on signal 15 (Terminated) Nov 03 08:51:36 volumio--tun-an systemd[1]: ntp.service: Succeeded. Nov 03 08:51:36 volumio--tun-an systemd[1]: Stopped Network Time Service. Nov 03 08:51:36 volumio--tun-an systemd[1]: Starting Network Time Service... Nov 03 08:51:36 volumio--tun-an ntpd[1791]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 03 08:51:36 volumio--tun-an ntpd[1791]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Nov 03 08:51:36 volumio--tun-an systemd[1]: Started Network Time Service. Nov 03 08:51:36 volumio--tun-an ntpd[1798]: proto: precision = 0.204 usec (-22) Nov 03 08:51:36 volumio--tun-an ntpd[1798]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 03 08:51:36 volumio--tun-an ntpd[1798]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 03 08:51:36 volumio--tun-an ntpd[1798]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 677 days ago Nov 03 08:51:36 volumio--tun-an ntpd[1798]: Listen and drop on 0 v6wildcard [::]:123 Nov 03 08:51:36 volumio--tun-an ntpd[1798]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 03 08:51:36 volumio--tun-an ntpd[1798]: Listen normally on 2 lo 127.0.0.1:123 Nov 03 08:51:36 volumio--tun-an ntpd[1798]: Listen normally on 3 eth0 192.168.2.9:123 Nov 03 08:51:36 volumio--tun-an ntpd[1798]: Listening on routing socket on fd #20 for interface updates Nov 03 08:51:36 volumio--tun-an ntpd[1798]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 03 08:51:36 volumio--tun-an ntpd[1798]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 03 08:51:37 volumio--tun-an volumio[839]: info: Discovery: adding 5878e4d7-058a-4fb5-9bcd-9eaff1b69f76 Nov 03 08:51:37 volumio--tun-an volumio[839]: info: Discovery: Found device Volumio- Tuấn An Nov 03 08:51:37 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:51:37 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:51:37 volumio--tun-an volumiologrotate[617]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO-': No such file or directory Nov 03 08:51:37 volumio--tun-an volumiologrotate[617]: ls: cannot access 'TUẤN': No such file or directory Nov 03 08:51:37 volumio--tun-an volumiologrotate[617]: ls: cannot access 'AN': No such file or directory Nov 03 08:51:37 volumio--tun-an ntpd[1798]: Soliciting pool server 115.165.161.155 Nov 03 08:51:38 volumio--tun-an ntpd[1798]: Soliciting pool server 203.113.174.44 Nov 03 08:51:39 volumio--tun-an ntpd[1798]: Soliciting pool server 103.199.19.135 Nov 03 08:51:39 volumio--tun-an ntpd[1798]: Soliciting pool server 27.71.27.209 Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 03 08:51:40 volumio--tun-an volumio[839]: info: Received Get System Info Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 08:51:40 volumio--tun-an volumio[839]: info: Discovery: Getting this device information Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 08:51:40 volumio--tun-an nmbd[777]: [2024/11/03 08:51:40.268603, 0] ../source3/libsmb/nmblib.c:917(send_udp) Nov 03 08:51:40 volumio--tun-an nmbd[777]: Packet send failed to 169.254.255.255(138) ERRNO=Network is unreachable Nov 03 08:51:40 volumio--tun-an ntpd[1798]: Soliciting pool server 103.130.217.41 Nov 03 08:51:40 volumio--tun-an ntpd[1798]: Soliciting pool server 115.165.161.155 Nov 03 08:51:40 volumio--tun-an ntpd[1798]: Soliciting pool server 103.184.124.23 Nov 03 08:51:40 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 03 08:51:41 volumio--tun-an ntpd[1798]: Soliciting pool server 2404:fbc0:0:2046::c Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 03 08:51:42 volumio--tun-an volumio[839]: info: Adding plugin bluetooth to MyMusic Plugins Nov 03 08:51:42 volumio--tun-an volumio[839]: info: Adding plugin multiroom to MyMusic Plugins Nov 03 08:51:42 volumio--tun-an volumio[839]: info: Adding plugin metavolumio to MyMusic Plugins Nov 03 08:51:42 volumio--tun-an volumio[839]: info: Adding plugin cd_controller to MyMusic Plugins Nov 03 08:51:42 volumio--tun-an volumio[839]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 03 08:51:42 volumio--tun-an volumio[839]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 03 08:51:42 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 03 08:51:43 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 03 08:51:43 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 03 08:51:43 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 03 08:51:43 volumio--tun-an volumio[839]: info: Starting MyVolumio Remote Streaming Endpoints Nov 03 08:51:43 volumio--tun-an volumio[839]: info: MyVolumio login type: Token Nov 03 08:51:43 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 03 08:51:43 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 03 08:51:44 volumio--tun-an volumio[839]: info: Starting Streaming Service Transparent Proxy Nov 03 08:51:44 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 03 08:51:44 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 03 08:51:44 volumio--tun-an volumio[839]: info: Streaming services startup Nov 03 08:51:44 volumio--tun-an volumio[839]: info: Starting Streaming Daemon Nov 03 08:51:44 volumio--tun-an volumio[839]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 03 08:51:45 volumio--tun-an volumio[839]: error: MyVolumio Custom Token format not valid, refreshing it Nov 03 08:51:45 volumio--tun-an volumio[839]: STREAMING PROXY: Starting server on port 3245 Nov 03 08:51:45 volumio--tun-an volumio[839]: Node JS runtime: 14 Nov 03 08:51:46 volumio--tun-an volumio[839]: info: MyVolumio login type: Token Nov 03 08:51:47 volumio--tun-an volumio[839]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 03 08:51:48 volumio--tun-an volumio[839]: info: MyVolumio token set successfully Nov 03 08:51:48 volumio--tun-an volumio[839]: info: MYVOLUMIO: Adding device Nov 03 08:51:48 volumio--tun-an volumio[839]: info: MYVOLUMIO: Evaluating Server Nov 03 08:51:48 volumio--tun-an volumio[839]: info: MyVolumio status changed Nov 03 08:51:48 volumio--tun-an volumio[839]: info: Streaming services startup Nov 03 08:51:48 volumio--tun-an volumio[839]: info: Starting Streaming Daemon Nov 03 08:51:48 volumio--tun-an volumio[839]: info: Removing browser output: myVolumio user plan is not superstar Nov 03 08:51:48 volumio--tun-an volumio[839]: info: Removing audio output: Nov 03 08:51:48 volumio--tun-an volumio[839]: info: Stoppping Tunnel 1 Nov 03 08:51:48 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 03 08:51:48 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 03 08:51:48 volumio--tun-an volumio[839]: info: Discovery: Getting this device information Nov 03 08:51:48 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:51:48 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:51:48 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 03 08:51:45 volumio--tun-an ntpd[1798]: receive: Unexpected origin timestamp 0xead155b4.de70c3d0 does not match aorg 0000000000.00000000 from server@27.71.27.209 xmt 0xead155b1.7c08aa82 Nov 03 08:51:45 volumio--tun-an volumio[839]: verbose: New Socket.io Connection to 192.168.2.9:3000 from 192.168.2.3 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Nov 03 08:51:45 volumio--tun-an volumio[839]: info: CoreCommandRouter::volumioGetState Nov 03 08:51:45 volumio--tun-an volumio[839]: info: CorePlayQueue::getTrack 0 Nov 03 08:51:45 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 03 08:51:45 volumio--tun-an volumio[839]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 03 08:51:45 volumio--tun-an volumio[839]: error: Failed to ping endpoint eu9.myvolumio.org : unknown error Nov 03 08:51:45 volumio--tun-an volumio[839]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 08:51:45 volumio--tun-an volumio[839]: Error: Unable to resolve or reject the same promise twice Nov 03 08:51:45 volumio--tun-an volumio[839]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Nov 03 08:51:45 volumio--tun-an volumio[839]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Nov 03 08:51:45 volumio--tun-an volumio[839]: at Socket.emit (events.js:412:35) Nov 03 08:51:45 volumio--tun-an volumio[839]: at endReadableNT (internal/streams/readable.js:1333:12) Nov 03 08:51:45 volumio--tun-an volumio[839]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Nov 03 08:51:45 volumio--tun-an volumio[839]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 03 08:51:47 volumio--tun-an sudo[1860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 08:51:47 volumio--tun-an sudo[1860]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 08:51:47 volumio--tun-an sudo[1860]: pam_unix(sudo:session): session closed for user root Nov 03 08:51:51 volumio--tun-an sudo[1883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 03 08:51:51 volumio--tun-an sudo[1885]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 03 08:51:51 volumio--tun-an sudo[1885]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 08:51:51 volumio--tun-an sudo[1883]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 03 08:51:51 volumio--tun-an sudo[1883]: pam_unix(sudo:session): session closed for user root Nov 03 08:51:51 volumio--tun-an sudo[1885]: pam_unix(sudo:session): session closed for user root Nov 03 08:51:51 volumio--tun-an sudo[1896]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-03 08:50 Nov 03 08:51:51 volumio--tun-an sudo[1896]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"