-- Logs begin at Thu 2024-11-28 14:22:52 UTC, end at Thu 2024-11-28 14:25:47 UTC. -- Nov 28 14:24:02 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 14:24:02 volumio volumio[877]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Nov 28 14:24:02 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 28 14:24:03 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Nov 28 14:24:03 volumio sudo[1695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Nov 28 14:24:03 volumio sudo[1695]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:24:03 volumio sudo[1695]: pam_unix(sudo:session): session closed for user root Nov 28 14:24:03 volumio sudo[1701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 14:24:03 volumio sudo[1701]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:24:03 volumio sudo[1701]: pam_unix(sudo:session): session closed for user root Nov 28 14:24:03 volumio sudo[1710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 14:24:03 volumio sudo[1710]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:24:03 volumio sudo[1710]: pam_unix(sudo:session): session closed for user root Nov 28 14:24:03 volumio sudo[1720]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 14:24:03 volumio sudo[1720]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:24:03 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 28 14:24:03 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 28 14:24:03 volumio sudo[1728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 14:24:03 volumio sudo[1728]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:24:03 volumio sudo[1720]: pam_unix(sudo:session): session closed for user root Nov 28 14:24:03 volumio sudo[1728]: pam_unix(sudo:session): session closed for user root Nov 28 14:24:03 volumio sudo[1734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 14:24:03 volumio sudo[1734]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:24:03 volumio sudo[1734]: pam_unix(sudo:session): session closed for user root Nov 28 14:24:30 volumio volumio[877]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.742&uuid=8002603eef6d7fc3dbebf29b48870fd6" http://updates.volumio.org/downloader-v1/track-device Nov 28 14:24:30 volumio volumio[877]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 28 14:24:30 volumio volumio[877]: Dload Upload Total Spent Left Speed Nov 28 14:24:30 volumio volumio[877]: [2.2K blob data] Nov 28 14:24:30 volumio volumio[877]: retrying in 5 seconds, trial 1 Nov 28 14:24:30 volumio volumio[877]: info: Volumio Calling Home Nov 28 14:24:32 volumio ntpd[862]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 28 14:24:38 volumio volumio[877]: info: Discovery: adding 85385d52-311e-47a6-9a3d-27566c6cdf20 Nov 28 14:24:38 volumio volumio[877]: info: Discovery: Found device Volumio Nov 28 14:24:38 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:24:38 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:00 volumio ntpd[862]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 28 14:25:06 volumio volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Nov 28 14:25:08 volumio volumio[877]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=x86_amd64&variante=volumio&version=3.742&uuid=8002603eef6d7fc3dbebf29b48870fd6" http://updates.volumio.org/downloader-v1/track-device Nov 28 14:25:08 volumio volumio[877]: % Total % Received % Xferd Average Speed Time Time Time Current Nov 28 14:25:08 volumio volumio[877]: Dload Upload Total Spent Left Speed Nov 28 14:25:08 volumio volumio[877]: [2.2K blob data] Nov 28 14:25:08 volumio volumio[877]: retrying in 5 seconds, trial 2 Nov 28 14:25:08 volumio volumio[877]: info: Volumio Calling Home Nov 28 14:25:26 volumio volumio[877]: info: CALLMETHOD: system_controller network saveWiredNet [object Object] Nov 28 14:25:26 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , saveWiredNet Nov 28 14:25:26 volumio sudo[1792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/network/interfaces Nov 28 14:25:26 volumio sudo[1792]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:26 volumio sudo[1792]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:26 volumio sudo[1794]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/dhcpcd.conf Nov 28 14:25:26 volumio sudo[1794]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:26 volumio sudo[1794]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:26 volumio volumio[877]: info: Permissions for /etc/network/interfaces set Nov 28 14:25:26 volumio volumio[877]: info: Restarting Wired Network Nov 28 14:25:26 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , onNetworkingRestart Nov 28 14:25:26 volumio volumio[877]: info: Discovery: Restarting Advertising due to device name change Nov 28 14:25:26 volumio sudo[1798]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/ip addr flush dev eth0 Nov 28 14:25:26 volumio sudo[1798]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:26 volumio avahi-daemon[590]: Withdrawing address record for 192.168.1.255 on eth0. Nov 28 14:25:26 volumio avahi-daemon[590]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.1.255. Nov 28 14:25:26 volumio avahi-daemon[590]: Interface eth0.IPv4 no longer relevant for mDNS. Nov 28 14:25:26 volumio volumio[877]: info: Discovery: A device disappeared from network Nov 28 14:25:26 volumio volumio[877]: info: Discovery: Device volumio disappeared from network Nov 28 14:25:26 volumio sudo[1798]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:26 volumio dhcpcd[646]: eth0: pid 1799 deleted IP address 192.168.1.255/24 Nov 28 14:25:26 volumio dhcpcd[646]: eth0: deleting route to 192.168.1.0/24 Nov 28 14:25:26 volumio dhcpcd[646]: eth0: deleting default route via 192.168.1.1 Nov 28 14:25:26 volumio sudo[1800]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 down Nov 28 14:25:26 volumio sudo[1800]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:26 volumio dhcpcd[646]: eth0: probing address 192.168.1.255/24 Nov 28 14:25:26 volumio kernel: r8169 0000:01:00.0 eth0: Link is Down Nov 28 14:25:26 volumio dhcpcd[646]: eth0: carrier lost Nov 28 14:25:26 volumio sudo[1800]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:26 volumio sudo[1813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 up Nov 28 14:25:26 volumio sudo[1813]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:26 volumio kernel: Generic FE-GE Realtek PHY r8169-0-100:00: attached PHY driver (mii_bus:phy_addr=r8169-0-100:00, irq=MAC) Nov 28 14:25:26 volumio sudo[1813]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:26 volumio kernel: r8169 0000:01:00.0 eth0: Link is Down Nov 28 14:25:26 volumio ifplugd(eth0)[861]: Link beat lost. Nov 28 14:25:28 volumio ntpd[862]: Deleting interface #3 eth0, 192.168.1.255#123, interface stats: received=0, sent=0, dropped=0, active_time=142 secs Nov 28 14:25:28 volumio ntpd[862]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 28 14:25:28 volumio ntpd[862]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 28 14:25:28 volumio ntpd[862]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Nov 28 14:25:28 volumio ntpd[862]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Nov 28 14:25:28 volumio ntpd[862]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Nov 28 14:25:28 volumio ntpd[862]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Nov 28 14:25:28 volumio volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Nov 28 14:25:28 volumio volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Nov 28 14:25:28 volumio volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Nov 28 14:25:28 volumio volumio[877]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Nov 28 14:25:29 volumio dhcpcd[646]: eth0: carrier acquired Nov 28 14:25:29 volumio kernel: r8169 0000:01:00.0 eth0: Link is Up - 1Gbps/Full - flow control rx/tx Nov 28 14:25:29 volumio dhcpcd[646]: eth0: confile file changed, expiring leases Nov 28 14:25:29 volumio dhcpcd[646]: eth0: IAID 99:ed:dc:db Nov 28 14:25:29 volumio ifplugd(eth0)[861]: Link beat detected. Nov 28 14:25:30 volumio dhcpcd[646]: eth0: rebinding lease of 192.168.1.2 Nov 28 14:25:30 volumio dhcpcd[646]: eth0: NAK: wrong network from 192.168.100.1 Nov 28 14:25:30 volumio dhcpcd[646]: eth0: message: wrong network Nov 28 14:25:30 volumio dhcpcd[646]: eth0: soliciting a DHCP lease Nov 28 14:25:30 volumio dhcpcd[646]: eth0: soliciting an IPv6 router Nov 28 14:25:31 volumio volumio[877]: info: Discovery: Started advertising with name: Volumio Nov 28 14:25:33 volumio dhcpcd[646]: eth0: offered 192.168.100.175 from 192.168.100.1 Nov 28 14:25:33 volumio dhcpcd[646]: eth0: probing address 192.168.100.175/24 Nov 28 14:25:36 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: upnp , onRestart Nov 28 14:25:36 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , onNetworkingRestart Nov 28 14:25:36 volumio volumio[877]: info: Refreshing Cached IP Addresses Nov 28 14:25:36 volumio sudo[1838]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/killall upmpdcli Nov 28 14:25:36 volumio sudo[1838]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:36 volumio sudo[1840]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 14:25:36 volumio sudo[1840]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:36 volumio sudo[1838]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:36 volumio sudo[1840]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:36 volumio systemd[1]: upmpdcli.service: Succeeded. Nov 28 14:25:36 volumio sudo[1844]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 14:25:36 volumio sudo[1844]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:36 volumio sudo[1844]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:38 volumio volumio[877]: 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: 6 Nov 28 14:25:38 volumio dhcpcd[646]: eth0: leased 192.168.100.175 for 43200 seconds Nov 28 14:25:38 volumio dhcpcd[646]: eth0: adding route to 192.168.100.0/24 Nov 28 14:25:38 volumio dhcpcd[646]: eth0: adding default route via 192.168.100.1 Nov 28 14:25:38 volumio avahi-daemon[590]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.100.175. Nov 28 14:25:38 volumio avahi-daemon[590]: New relevant interface eth0.IPv4 for mDNS. Nov 28 14:25:38 volumio avahi-daemon[590]: Registering new address record for 192.168.100.175 on eth0.IPv4. Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::volumioGetVisibleSources Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:38 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Nov 28 14:25:38 volumio volumio[877]: info: Received Get System Info Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:25:38 volumio volumio[877]: info: Discovery: Getting this device information Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:38 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:38 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:38 volumio volumio[877]: info: Listing playlists Nov 28 14:25:38 volumio ntpd[862]: ntpd exiting on signal 15 (Terminated) Nov 28 14:25:38 volumio systemd[1]: Stopping Network Time Service... Nov 28 14:25:38 volumio systemd[1]: ntp.service: Succeeded. Nov 28 14:25:38 volumio systemd[1]: Stopped Network Time Service. Nov 28 14:25:38 volumio volumio[877]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Nov 28 14:25:38 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 28 14:25:38 volumio systemd[1]: Starting Network Time Service... Nov 28 14:25:39 volumio ntpd[1885]: ntpd 4.2.8p12@1.3728-o (1): Starting Nov 28 14:25:39 volumio ntpd[1885]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Nov 28 14:25:39 volumio systemd[1]: Started Network Time Service. Nov 28 14:25:39 volumio ntpd[1891]: proto: precision = 0.192 usec (-22) Nov 28 14:25:39 volumio ntpd[1891]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Nov 28 14:25:39 volumio ntpd[1891]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Nov 28 14:25:39 volumio ntpd[1891]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 702 days ago Nov 28 14:25:39 volumio ntpd[1891]: Listen and drop on 0 v6wildcard [::]:123 Nov 28 14:25:39 volumio ntpd[1891]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Nov 28 14:25:39 volumio ntpd[1891]: Listen normally on 2 lo 127.0.0.1:123 Nov 28 14:25:39 volumio ntpd[1891]: Listen normally on 3 eth0 192.168.100.175:123 Nov 28 14:25:39 volumio ntpd[1891]: Listening on routing socket on fd #20 for interface updates Nov 28 14:25:39 volumio ntpd[1891]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 28 14:25:39 volumio ntpd[1891]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Nov 28 14:25:39 volumio volumio[877]: info: Discovery: adding 85385d52-311e-47a6-9a3d-27566c6cdf20 Nov 28 14:25:39 volumio volumio[877]: info: Discovery: Found device Volumio Nov 28 14:25:39 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:39 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:39 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Nov 28 14:25:39 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Nov 28 14:25:39 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Nov 28 14:25:39 volumio sudo[1895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Nov 28 14:25:39 volumio sudo[1895]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:39 volumio sudo[1895]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:39 volumio sudo[1901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 14:25:39 volumio sudo[1901]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:39 volumio sudo[1901]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:39 volumio sudo[1910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 14:25:39 volumio sudo[1910]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:40 volumio ntpd[1891]: Soliciting pool server 115.165.161.155 Nov 28 14:25:40 volumio sudo[1910]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:40 volumio sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Nov 28 14:25:40 volumio sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:40 volumio sudo[1928]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Nov 28 14:25:40 volumio sudo[1928]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Nov 28 14:25:40 volumio sudo[1918]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:40 volumio sudo[1928]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 14:25:40 volumio volumio[877]: info: Received Get System Info Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:25:40 volumio volumio[877]: info: Discovery: Getting this device information Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:40 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:25:40 volumio sudo[1934]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 14:25:40 volumio sudo[1934]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:40 volumio sudo[1934]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:25:40 volumio volumio[877]: info: Discovery: Getting this device information Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:40 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:25:40 volumio volumio[877]: verbose: New Socket.io Connection to 192.168.100.175:3000 from 192.168.100.126 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 7 Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:40 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Nov 28 14:25:40 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Nov 28 14:25:41 volumio ntpd[1891]: Soliciting pool server 27.71.27.209 Nov 28 14:25:41 volumio ntpd[1891]: Soliciting pool server 103.184.124.23 Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Nov 28 14:25:41 volumio volumio[877]: info: Adding plugin bluetooth to MyMusic Plugins Nov 28 14:25:41 volumio volumio[877]: info: Adding plugin multiroom to MyMusic Plugins Nov 28 14:25:41 volumio volumio[877]: info: Adding plugin metavolumio to MyMusic Plugins Nov 28 14:25:41 volumio volumio[877]: info: Adding plugin cd_controller to MyMusic Plugins Nov 28 14:25:41 volumio volumio[877]: info: Adding plugin smart_inputs to MyMusic Plugins Nov 28 14:25:41 volumio volumio[877]: info: Adding plugin tidalconnect to MyMusic Plugins Nov 28 14:25:41 volumio volumio[877]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Nov 28 14:25:42 volumio ntpd[1891]: Soliciting pool server 103.130.217.41 Nov 28 14:25:42 volumio ntpd[1891]: Soliciting pool server 103.130.217.41 Nov 28 14:25:42 volumio ntpd[1891]: Soliciting pool server 103.199.19.135 Nov 28 14:25:42 volumio volumio[877]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Nov 28 14:25:42 volumio volumio[877]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Nov 28 14:25:42 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 28 14:25:42 volumio volumio[877]: info: Starting MyVolumio Remote Streaming Endpoints Nov 28 14:25:42 volumio volumio[877]: info: MyVolumio login type: Token Nov 28 14:25:42 volumio volumio[877]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Nov 28 14:25:42 volumio volumio[877]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Nov 28 14:25:43 volumio ntpd[1891]: Soliciting pool server 2400:6760:0:300::23 Nov 28 14:25:44 volumio volumio[877]: info: Starting Streaming Service Transparent Proxy Nov 28 14:25:44 volumio volumio[877]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Nov 28 14:25:44 volumio volumio[877]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Nov 28 14:25:44 volumio volumio[877]: info: Streaming services startup Nov 28 14:25:44 volumio volumio[877]: info: Starting Streaming Daemon Nov 28 14:25:44 volumio sudo[1966]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 28 14:25:44 volumio sudo[1966]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:44 volumio volumio[877]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Nov 28 14:25:44 volumio sudo[1966]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 28 14:25:44 volumio volumio[877]: info: Received Get System Info Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:25:44 volumio volumio[877]: info: Discovery: Getting this device information Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:44 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:25:44 volumio volumio[877]: error: Cannot start Volumio Streaming Daemon Nov 28 14:25:44 volumio volumio[877]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Nov 28 14:25:44 volumio volumio[877]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 28 14:25:44 volumio volumio[877]: info: Discovery: Getting this device information Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::volumioGetState Nov 28 14:25:44 volumio volumio[877]: info: CorePlayQueue::getTrack 0 Nov 28 14:25:44 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 28 14:25:44 volumio volumio[877]: error: MyVolumio Custom Token format not valid, refreshing it Nov 28 14:25:45 volumio volumio[877]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Nov 28 14:25:45 volumio volumio[877]: info: MyVolumio login type: Token Nov 28 14:25:45 volumio volumio[877]: STREAMING PROXY: Starting server on port 3245 Nov 28 14:25:45 volumio volumio[877]: Node JS runtime: 14 Nov 28 14:25:45 volumio volumio[877]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Nov 28 14:25:45 volumio volumio[877]: info: MyVolumio login type: Token Nov 28 14:25:46 volumio volumio[877]: info: MyVolumio token set successfully Nov 28 14:25:46 volumio volumio[877]: info: MYVOLUMIO: Adding device Nov 28 14:25:46 volumio volumio[877]: info: MYVOLUMIO: Evaluating Server Nov 28 14:25:46 volumio volumio[877]: info: MyVolumio status changed Nov 28 14:25:46 volumio volumio[877]: info: Streaming services startup Nov 28 14:25:46 volumio volumio[877]: info: Starting Streaming Daemon Nov 28 14:25:46 volumio volumio[877]: info: Removing browser output: myVolumio user plan is not superstar Nov 28 14:25:46 volumio volumio[877]: info: Removing audio output: Nov 28 14:25:46 volumio volumio[877]: info: Stoppping Tunnel 1 Nov 28 14:25:46 volumio sudo[1995]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Nov 28 14:25:46 volumio sudo[1995]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:46 volumio sudo[1991]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Nov 28 14:25:46 volumio sudo[1993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Nov 28 14:25:46 volumio sudo[1993]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:46 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:47 volumio sudo[1991]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:47 volumio sudo[1993]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:47 volumio sudo[1995]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:46 volumio ntpd[1891]: receive: Unexpected origin timestamp 0xeaf2fbeb.054049e4 does not match aorg 0000000000.00000000 from server@103.130.217.41 xmt 0xeaf2fbea.c68bf7a3 Nov 28 14:25:46 volumio sudo[2002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Nov 28 14:25:46 volumio sudo[2002]: pam_unix(sudo:session): session opened for user root by (uid=0) Nov 28 14:25:46 volumio volumio[877]: error: Failed to ping endpoint eu10.myvolumio.org : unknown error Nov 28 14:25:46 volumio volumio[877]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 14:25:46 volumio sudo[2002]: pam_unix(sudo:session): session closed for user root Nov 28 14:25:46 volumio volumio[877]: Error: Unable to resolve or reject the same promise twice Nov 28 14:25:46 volumio volumio[877]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Nov 28 14:25:46 volumio volumio[877]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Nov 28 14:25:46 volumio volumio[877]: at Socket.emit (events.js:412:35) Nov 28 14:25:46 volumio volumio[877]: at endReadableNT (internal/streams/readable.js:1333:12) Nov 28 14:25:46 volumio volumio[877]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Nov 28 14:25:46 volumio volumio[877]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 28 14:25:47 volumio sudo[2014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-28 14:24 Nov 28 14:25:47 volumio sudo[2014]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:48:50 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="1049be5fd382035818795b7f5c38e10d"