-- Logs begin at Tue 2024-09-03 08:19:14 UTC, end at Tue 2024-09-03 08:25:01 UTC. -- Sep 03 08:23:03 volumio-transport ntpd[943]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Sep 03 08:23:17 volumio-transport volumiologrotate[681]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 03 08:23:17 volumio-transport volumiologrotate[681]: ls: cannot access 'TRANSPORT': No such file or directory Sep 03 08:23:23 volumio-transport ntpd[943]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Sep 03 08:23:43 volumio-transport ntpd[943]: error resolving pool 0.debian.pool.ntp.org: System error (-11) Sep 03 08:24:03 volumio-transport ntpd[943]: error resolving pool 3.debian.pool.ntp.org: System error (-11) Sep 03 08:24:17 volumio-transport volumiologrotate[681]: ls: cannot access '/var/log/samba/log.wb-VOLUMIO': No such file or directory Sep 03 08:24:17 volumio-transport volumiologrotate[681]: ls: cannot access 'TRANSPORT': No such file or directory Sep 03 08:24:23 volumio-transport ntpd[943]: error resolving pool 2.debian.pool.ntp.org: System error (-11) Sep 03 08:24:43 volumio-transport ntpd[943]: error resolving pool 1.debian.pool.ntp.org: System error (-11) Sep 03 08:24:47 volumio-transport dhcpcd[791]: eth0: offered 192.168.1.48 from 192.168.1.1 Sep 03 08:24:47 volumio-transport dhcpcd[791]: eth0: probing address 192.168.1.48/24 Sep 03 08:24:52 volumio-transport dhcpcd[791]: eth0: leased 192.168.1.48 for 86400 seconds Sep 03 08:24:52 volumio-transport dhcpcd[791]: eth0: adding route to 192.168.1.0/24 Sep 03 08:24:52 volumio-transport dhcpcd[791]: eth0: changing default route via 192.168.1.1 Sep 03 08:24:52 volumio-transport avahi-daemon[704]: Registering new address record for 192.168.1.48 on eth0.IPv4. Sep 03 08:24:52 volumio-transport ntpd[943]: ntpd exiting on signal 15 (Terminated) Sep 03 08:24:52 volumio-transport systemd[1]: Stopping Network Time Service... Sep 03 08:24:52 volumio-transport systemd[1]: ntp.service: Succeeded. Sep 03 08:24:52 volumio-transport systemd[1]: Stopped Network Time Service. Sep 03 08:24:52 volumio-transport systemd[1]: Starting Network Time Service... Sep 03 08:24:52 volumio-transport ntpd[2102]: ntpd 4.2.8p12@1.3728-o (1): Starting Sep 03 08:24:52 volumio-transport ntpd[2102]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 104:103 Sep 03 08:24:52 volumio-transport systemd[1]: Started Network Time Service. Sep 03 08:24:52 volumio-transport ntpd[2109]: proto: precision = 0.072 usec (-24) Sep 03 08:24:52 volumio-transport avahi-daemon[704]: Withdrawing address record for 169.254.49.49 on eth0. Sep 03 08:24:52 volumio-transport avahi-daemon[704]: Leaving mDNS multicast group on interface eth0.IPv4 with address 169.254.49.49. Sep 03 08:24:52 volumio-transport dhcpcd[791]: eth0: deleting route to 169.254.0.0/16 Sep 03 08:24:52 volumio-transport avahi-daemon[704]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.1.48. Sep 03 08:24:52 volumio-transport ntpd[2109]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): good hash signature Sep 03 08:24:52 volumio-transport ntpd[2109]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): loaded, expire=2022-12-28T00:00:00Z last=2017-01-01T00:00:00Z ofs=37 Sep 03 08:24:52 volumio-transport ntpd[2109]: leapsecond file ('/usr/share/zoneinfo/leap-seconds.list'): expired less than 616 days ago Sep 03 08:24:52 volumio-transport ntpd[2109]: Listen and drop on 0 v6wildcard [::]:123 Sep 03 08:24:52 volumio-transport ntpd[2109]: Listen and drop on 1 v4wildcard 0.0.0.0:123 Sep 03 08:24:52 volumio-transport ntpd[2109]: Listen normally on 2 lo 127.0.0.1:123 Sep 03 08:24:52 volumio-transport ntpd[2109]: Listen normally on 3 eth0 192.168.1.48:123 Sep 03 08:24:52 volumio-transport ntpd[2109]: Listening on routing socket on fd #20 for interface updates Sep 03 08:24:52 volumio-transport ntpd[2109]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 03 08:24:52 volumio-transport ntpd[2109]: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Sep 03 08:24:53 volumio-transport ntpd[2109]: Soliciting pool server 91.207.136.55 Sep 03 08:24:54 volumio-transport ntpd[2109]: Soliciting pool server 95.31.7.160 Sep 03 08:24:54 volumio-transport ntpd[2109]: Soliciting pool server 192.36.143.130 Sep 03 08:24:55 volumio-transport ntpd[2109]: Soliciting pool server 194.186.33.2 Sep 03 08:24:55 volumio-transport ntpd[2109]: Soliciting pool server 46.146.231.187 Sep 03 08:24:55 volumio-transport ntpd[2109]: Soliciting pool server 162.159.200.1 Sep 03 08:24:56 volumio-transport ntpd[2109]: Soliciting pool server 193.192.36.3 Sep 03 08:24:56 volumio-transport ntpd[2109]: Soliciting pool server 82.142.168.18 Sep 03 08:24:56 volumio-transport ntpd[2109]: Soliciting pool server 83.143.51.50 Sep 03 08:24:56 volumio-transport ntpd[2109]: Soliciting pool server 94.247.111.10 Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 03 08:24:57 volumio-transport volumio[976]: info: Adding plugin bluetooth to MyMusic Plugins Sep 03 08:24:57 volumio-transport volumio[976]: info: Adding plugin multiroom to MyMusic Plugins Sep 03 08:24:57 volumio-transport volumio[976]: info: Adding plugin metavolumio to MyMusic Plugins Sep 03 08:24:57 volumio-transport volumio[976]: info: Adding plugin cd_controller to MyMusic Plugins Sep 03 08:24:57 volumio-transport volumio[976]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 03 08:24:57 volumio-transport volumio[976]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 03 08:24:57 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 03 08:24:57 volumio-transport ntpd[2109]: Soliciting pool server 91.235.144.128 Sep 03 08:24:57 volumio-transport ntpd[2109]: Soliciting pool server 194.186.33.3 Sep 03 08:24:57 volumio-transport ntpd[2109]: Soliciting pool server 85.21.78.91 Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 03 08:24:58 volumio-transport volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 03 08:24:58 volumio-transport volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 03 08:24:58 volumio-transport volumio[976]: info: Starting MyVolumio Remote Streaming Endpoints Sep 03 08:24:58 volumio-transport volumio[976]: info: MyVolumio login type: Token Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 03 08:24:58 volumio-transport volumio[976]: info: Starting Streaming Service Transparent Proxy Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 03 08:24:58 volumio-transport volumio[976]: info: Streaming services startup Sep 03 08:24:58 volumio-transport volumio[976]: info: Starting Streaming Daemon Sep 03 08:24:58 volumio-transport sudo[2139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 03 08:24:58 volumio-transport sudo[2139]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 03 08:24:58 volumio-transport sudo[2139]: pam_unix(sudo:session): session closed for user root Sep 03 08:24:58 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Sep 03 08:24:58 volumio-transport volumio[976]: error: Cannot start Volumio Streaming Daemon Sep 03 08:24:58 volumio-transport volumio[976]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Sep 03 08:24:58 volumio-transport volumio[976]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Sep 03 08:24:58 volumio-transport volumio[976]: STREAMING PROXY: Starting server on port 3245 Sep 03 08:24:58 volumio-transport volumio[976]: Node JS runtime: 14 Sep 03 08:24:58 volumio-transport ntpd[2109]: Soliciting pool server 162.159.200.123 Sep 03 08:24:58 volumio-transport ntpd[2109]: Soliciting pool server 185.209.85.222 Sep 03 08:24:58 volumio-transport volumio[976]: error: MyVolumio Custom Token format not valid, refreshing it Sep 03 08:24:59 volumio-transport volumio[976]: info: MyVolumio login type: Token Sep 03 08:24:59 volumio-transport ntpd[2109]: Soliciting pool server 2a00:ab00:203:9::1000:5 Sep 03 08:25:00 volumio-transport volumio[976]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 03 08:25:01 volumio-transport volumio[976]: info: MyVolumio token set successfully Sep 03 08:25:01 volumio-transport volumio[976]: info: MYVOLUMIO: Adding device Sep 03 08:25:01 volumio-transport volumio[976]: info: MYVOLUMIO: Evaluating Server Sep 03 08:25:01 volumio-transport volumio[976]: info: MyVolumio Plan changed: superstar Sep 03 08:25:01 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Sep 03 08:25:01 volumio-transport volumio[976]: info: Adding audio output: Sep 03 08:25:01 volumio-transport volumio[976]: info: MYVOLUMIO: Adding device Sep 03 08:25:01 volumio-transport volumio[976]: info: MYVOLUMIO: Evaluating Server Sep 03 08:25:01 volumio-transport volumio[976]: info: Remote config written successfully Sep 03 08:25:01 volumio-transport volumio[976]: info: Starting Tunnel 1 Sep 03 08:25:01 volumio-transport volumio[976]: info: Starting Tunnel Connection Checker Sep 03 08:24:59 volumio-transport ntpd[2109]: receive: Unexpected origin timestamp 0xea81465d.c98b72db does not match aorg 0000000000.00000000 from server@82.142.168.18 xmt 0xea81465a.fcb3f424 Sep 03 08:24:59 volumio-transport ntpd[2109]: receive: Unexpected origin timestamp 0xea81465d.c98b265d does not match aorg 0000000000.00000000 from server@193.192.36.3 xmt 0xea81465b.0b585e83 Sep 03 08:24:59 volumio-transport ntpd[2109]: receive: Unexpected origin timestamp 0xea81465d.c98bfb67 does not match aorg 0000000000.00000000 from server@192.36.143.130 xmt 0xea81465a.fe2c7032 Sep 03 08:24:59 volumio-transport ntpd[2109]: receive: Unexpected origin timestamp 0xea81465d.c98c72df does not match aorg 0000000000.00000000 from server@91.207.136.55 xmt 0xea81465a.fdeb176a Sep 03 08:24:59 volumio-transport ntpd[2109]: receive: Unexpected origin timestamp 0xea81465d.c98aaba9 does not match aorg 0000000000.00000000 from server@83.143.51.50 xmt 0xea81465a.ff44d2d2 Sep 03 08:24:59 volumio-transport ntpd[2109]: receive: Unexpected origin timestamp 0xea81465d.c989e66d does not match aorg 0000000000.00000000 from server@91.235.144.128 xmt 0xea81465a.fd70ac3f Sep 03 08:24:59 volumio-transport volumio[976]: info: MYVolumio Device enabled Sep 03 08:24:59 volumio-transport volumio[976]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Sep 03 08:24:59 volumio-transport volumio[976]: info: MyVolumio status changed Sep 03 08:24:59 volumio-transport volumio[976]: info: Streaming services startup Sep 03 08:24:59 volumio-transport volumio[976]: info: Starting Streaming Daemon Sep 03 08:24:59 volumio-transport volumio[976]: error: Failed to ping endpoint us1.myvolumio.org : unknown error Sep 03 08:24:59 volumio-transport volumio[976]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 03 08:24:59 volumio-transport sudo[2181]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 03 08:24:59 volumio-transport sudo[2181]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 03 08:24:59 volumio-transport volumio[976]: Error: Unable to resolve or reject the same promise twice Sep 03 08:24:59 volumio-transport volumio[976]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 03 08:24:59 volumio-transport volumio[976]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Sep 03 08:24:59 volumio-transport volumio[976]: at Socket.emit (events.js:412:35) Sep 03 08:24:59 volumio-transport volumio[976]: at endReadableNT (internal/streams/readable.js:1333:12) Sep 03 08:24:59 volumio-transport volumio[976]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Sep 03 08:24:59 volumio-transport volumio[976]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 03 08:24:59 volumio-transport sudo[2181]: pam_unix(sudo:session): session closed for user root Sep 03 08:24:59 volumio-transport sudo[2192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-03 08:23 Sep 03 08:24:59 volumio-transport sudo[2192]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"