-- Logs begin at Wed 2025-08-27 01:20:58 UTC, end at Mon 2025-09-08 15:38:45 UTC. -- Sep 08 15:38:01 usbridge systemd[1]: Time has been changed Sep 08 15:38:01 usbridge systemd[1]: Started LSB: start Samba daemons for the AD DC. Sep 08 15:38:02 usbridge nmbd[493]: Starting NetBIOS name server: nmbdmkdir failed on directory /var/log/samba/cores: No such file or directory Sep 08 15:38:02 usbridge nmbd[493]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 08 15:38:02 usbridge nmbd[493]: Unable to setup corepath for nmbd: No such file or directory Sep 08 15:38:02 usbridge nmbd[765]: [2025/09/08 15:38:02.213514, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge nmbd[765]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 08 15:38:02 usbridge nmbd[493]: [2025/09/08 15:38:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge nmbd[493]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 08 15:38:02 usbridge nmbd[493]: [2025/09/08 15:38:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge nmbd[493]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 08 15:38:02 usbridge nmbd[493]: [2025/09/08 15:38:02, 0] ../source3/nmbd/nmbd.c:908(main) Sep 08 15:38:02 usbridge nmbd[493]: nmbd version 4.2.14-Debian started. Sep 08 15:38:02 usbridge nmbd[493]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Sep 08 15:38:02 usbridge nmbd[493]: [2025/09/08 15:38:02.213514, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge nmbd[493]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 08 15:38:02 usbridge nmbd[765]: [2025/09/08 15:38:02.453163, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge nmbd[765]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 08 15:38:02 usbridge nmbd[493]: [2025/09/08 15:38:02.453163, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge nmbd[493]: Unable to open new log file '/var/log/samba/log.nmbd': No such file or directory Sep 08 15:38:02 usbridge systemd[1]: Started LSB: start Samba NetBIOS nameserver (nmbd). Sep 08 15:38:02 usbridge systemd[1]: Starting LSB: start Samba SMB/CIFS daemon (smbd)... Sep 08 15:38:02 usbridge winbind[489]: Starting the Winbind daemon: winbindmkdir failed on directory /var/log/samba/cores: No such file or directory Sep 08 15:38:02 usbridge winbind[489]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 08 15:38:02 usbridge winbind[489]: Unable to setup corepath for winbindd: No such file or directory Sep 08 15:38:02 usbridge winbind[489]: mkdir failed on directory /var/log/samba/cores: No such file or directory Sep 08 15:38:02 usbridge winbind[489]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 08 15:38:02 usbridge winbind[489]: Unable to setup corepath for winbindd: No such file or directory Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge winbind[489]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge winbind[489]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02, 0] ../source3/winbindd/winbindd.c:1549(main) Sep 08 15:38:02 usbridge winbind[489]: winbindd version 4.2.14-Debian started. Sep 08 15:38:02 usbridge winbind[489]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02, 0] ../lib/util/util.c:220(directory_create_or_exist) Sep 08 15:38:02 usbridge winbind[489]: mkdir failed on directory /var/log/samba/cores: No such file or directory Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Sep 08 15:38:02 usbridge winbind[489]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Sep 08 15:38:02 usbridge winbind[489]: Unable to setup corepath for winbindd: No such file or directory Sep 08 15:38:02 usbridge winbindd[763]: [2025/09/08 15:38:02.471755, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge winbindd[763]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 08 15:38:02 usbridge winbindd[763]: [2025/09/08 15:38:02.473402, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge winbindd[763]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 08 15:38:02 usbridge nmbd[766]: [2025/09/08 15:38:02.483892, 0] ../source3/nmbd/asyncdns.c:157(start_async_dns) Sep 08 15:38:02 usbridge nmbd[766]: started asyncdns process 768 Sep 08 15:38:02 usbridge systemd[1]: Started LSB: start Winbind daemon. Sep 08 15:38:02 usbridge nmbd[493]: . Sep 08 15:38:02 usbridge winbindd[770]: [2025/09/08 15:38:02.522600, 0] ../source3/winbindd/winbindd_cache.c:3235(initialize_winbindd_cache) Sep 08 15:38:02 usbridge winbindd[770]: initialize_winbindd_cache: clearing cache and re-creating with version number 2 Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02.471755, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge winbind[489]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 08 15:38:02 usbridge winbind[489]: [2025/09/08 15:38:02.473402, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:02 usbridge winbind[489]: Unable to open new log file '/var/log/samba/log.winbindd': No such file or directory Sep 08 15:38:02 usbridge winbind[489]: . Sep 08 15:38:04 usbridge nmbd[766]: [2025/09/08 15:38:04.081722, 0] ../lib/util/become_daemon.c:124(daemon_ready) Sep 08 15:38:04 usbridge nmbd[766]: STATUS=daemon 'nmbd' finished starting up and ready to serve connections Sep 08 15:38:04 usbridge kernel: nf_conntrack: automatic helper assignment is deprecated and it will be removed soon. Use the iptables CT target to attach helpers instead. Sep 08 15:38:05 usbridge winbindd[770]: [2025/09/08 15:38:05.621432, 0] ../lib/util/become_daemon.c:124(daemon_ready) Sep 08 15:38:05 usbridge winbindd[770]: STATUS=daemon 'winbindd' finished starting up and ready to serve connections Sep 08 15:38:05 usbridge winbindd[783]: [2025/09/08 15:38:05.627595, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:05 usbridge winbindd[783]: Unable to open new log file '/var/log/samba/log.wb-USBRIDGE': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: Starting SMB/CIFS daemon: smbd[2025/09/08 15:38:06, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[767]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06, 0] ../lib/util/util.c:220(directory_create_or_exist) Sep 08 15:38:06 usbridge smbd[767]: mkdir failed on directory /var/log/samba/cores: No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06, 0] ../source3/lib/dumpcore.c:59(get_default_corepath) Sep 08 15:38:06 usbridge smbd[767]: Failed to create /var/log/samba/cores for user 0 with mode 0700 Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06, 0] ../source3/lib/dumpcore.c:250(dump_core_setup) Sep 08 15:38:06 usbridge smbd[767]: Unable to setup corepath for smbd: No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[767]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06, 0] ../source3/smbd/server.c:1241(main) Sep 08 15:38:06 usbridge smbd[767]: smbd version 4.2.14-Debian started. Sep 08 15:38:06 usbridge smbd[767]: Copyright Andrew Tridgell and the Samba Team 1992-2014 Sep 08 15:38:06 usbridge smbd[782]: [2025/09/08 15:38:06.209095, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[782]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[782]: [2025/09/08 15:38:06.211498, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[782]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[782]: [2025/09/08 15:38:06.211757, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[782]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06.209095, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[767]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06.211498, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[767]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: [2025/09/08 15:38:06.211757, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[767]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:06 usbridge smbd[767]: . Sep 08 15:38:06 usbridge systemd[1]: Started LSB: start Samba SMB/CIFS daemon (smbd). Sep 08 15:38:06 usbridge winbindd[787]: [2025/09/08 15:38:06.299496, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge winbindd[787]: Unable to open new log file '/var/log/samba/log.winbindd-idmap': No such file or directory Sep 08 15:38:06 usbridge winbindd[788]: [2025/09/08 15:38:06.364722, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge winbindd[788]: Unable to open new log file '/var/log/samba/log.wb-BUILTIN': No such file or directory Sep 08 15:38:06 usbridge smbd[784]: [2025/09/08 15:38:06.431455, 0] ../lib/util/become_daemon.c:124(daemon_ready) Sep 08 15:38:06 usbridge smbd[784]: STATUS=daemon 'smbd' finished starting up and ready to serve connections Sep 08 15:38:06 usbridge smbd[789]: [2025/09/08 15:38:06.441082, 0] ../lib/util/debug.c:603(reopen_logs_internal) Sep 08 15:38:06 usbridge smbd[789]: Unable to open new log file '/var/log/samba/log.smbd': No such file or directory Sep 08 15:38:08 usbridge kernel: ------------[ cut here ]------------ Sep 08 15:38:08 usbridge kernel: WARNING: at net/sched/sch_generic.c:255 dev_watchdog+0x260/0x26c() Sep 08 15:38:08 usbridge kernel: NETDEV WATCHDOG: eth0 (owl-ethernet): transmit queue 0 timed out Sep 08 15:38:08 usbridge kernel: Modules linked in: nfsd auth_rpcgss oid_registry nfs_acl snd_usb_audio snd_hwdep snd_usbmidi_lib pvrsrvkm drm ethernet spidev owl_camera gsensor_mir3da gsensor_stk8313 gsensor_bma222 ctp_ft5x06 atc260x_irkeypad atc260x_cap_gauge autofs4 nls_cp437 squashfs overlayfs Sep 08 15:38:08 usbridge kernel: CPU: 3 PID: 0 Comm: swapper/3 Tainted: G W 3.10.38 #4 Sep 08 15:38:08 usbridge kernel: [] (unwind_backtrace+0x0/0x134) from [] (show_stack+0x24/0x34) Sep 08 15:38:08 usbridge kernel: [] (show_stack+0x24/0x34) from [] (warn_slowpath_common+0x54/0x6c) Sep 08 15:38:08 usbridge kernel: [] (warn_slowpath_common+0x54/0x6c) from [] (warn_slowpath_fmt+0x30/0x40) Sep 08 15:38:08 usbridge kernel: [] (warn_slowpath_fmt+0x30/0x40) from [] (dev_watchdog+0x260/0x26c) Sep 08 15:38:08 usbridge kernel: [] (dev_watchdog+0x260/0x26c) from [] (call_timer_fn+0x40/0x17c) Sep 08 15:38:08 usbridge kernel: [] (call_timer_fn+0x40/0x17c) from [] (run_timer_softirq+0x1bc/0x2b8) Sep 08 15:38:08 usbridge kernel: [] (run_timer_softirq+0x1bc/0x2b8) from [] (__do_softirq+0x140/0x308) Sep 08 15:38:08 usbridge kernel: [] (__do_softirq+0x140/0x308) from [] (do_softirq+0x50/0x58) Sep 08 15:38:08 usbridge kernel: [] (do_softirq+0x50/0x58) from [] (irq_exit+0x9c/0xd0) Sep 08 15:38:08 usbridge kernel: [] (irq_exit+0x9c/0xd0) from [] (handle_IRQ+0x44/0x90) Sep 08 15:38:08 usbridge kernel: [] (handle_IRQ+0x44/0x90) from [] (gic_handle_irq+0x2c/0x5c) Sep 08 15:38:08 usbridge kernel: [] (gic_handle_irq+0x2c/0x5c) from [] (__irq_svc+0x40/0x70) Sep 08 15:38:08 usbridge kernel: Exception stack(0xe2a15f88 to 0xe2a15fd0) Sep 08 15:38:08 usbridge kernel: 5f80: 00000001 00000000 00000049 00000000 e2a14000 e2a14018 Sep 08 15:38:08 usbridge kernel: 5fa0: c0d429ac c0ca1ed4 c07eb8e0 e2a14000 00000000 e2a14000 00000001 e2a15fd0 Sep 08 15:38:08 usbridge kernel: 5fc0: c007f7b8 c007fb8c 600f0013 ffffffff Sep 08 15:38:08 usbridge kernel: [] (__irq_svc+0x40/0x70) from [] (tick_nohz_idle_enter+0x44/0x78) Sep 08 15:38:08 usbridge kernel: [] (tick_nohz_idle_enter+0x44/0x78) from [] (cpu_startup_entry+0x54/0x270) Sep 08 15:38:08 usbridge kernel: [] (cpu_startup_entry+0x54/0x270) from [<0000821c>] (0x821c) Sep 08 15:38:08 usbridge kernel: ---[ end trace 4a516d46eb8925c3 ]--- Sep 08 15:38:08 usbridge volumio-remote-updater[482]: [2025-09-08 15:38:08] [connect] Successful connection Sep 08 15:38:08 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:08 usbridge volumio[741]: info: ----- Volumio2 ---- Sep 08 15:38:08 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:08 usbridge volumio[741]: info: ----- System startup ---- Sep 08 15:38:08 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:12 usbridge volumio[741]: info: MYVOLUMIO Environment detected Sep 08 15:38:12 usbridge volumio[741]: info: Plugin folders cleanup Sep 08 15:38:12 usbridge volumio[741]: info: Scanning into folder /volumio/app/plugins/ Sep 08 15:38:12 usbridge volumio[741]: info: Scanning category audio_interface Sep 08 15:38:12 usbridge volumio[741]: info: Scanning category miscellanea Sep 08 15:38:12 usbridge volumio[741]: info: Scanning category music_service Sep 08 15:38:12 usbridge volumio[741]: info: Scanning category plugins.json Sep 08 15:38:12 usbridge volumio[741]: info: Scanning category system_controller Sep 08 15:38:12 usbridge volumio[741]: info: Scanning category user_interface Sep 08 15:38:12 usbridge volumio[741]: info: Scanning into folder /data/plugins/ Sep 08 15:38:12 usbridge volumio[741]: info: Plugin folders cleanup completed Sep 08 15:38:12 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:12 usbridge volumio[741]: info: ----- Core plugins startup ---- Sep 08 15:38:12 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:12 usbridge volumio[741]: info: Loading plugins from folder /volumio/app/plugins/ Sep 08 15:38:12 usbridge volumio[741]: info: Adding plugin upnp to MyMusic Plugins Sep 08 15:38:12 usbridge volumio[741]: info: Adding plugin airplay_emulation to MyMusic Plugins Sep 08 15:38:12 usbridge volumio[741]: info: Adding plugin upnp_browser to MyMusic Plugins Sep 08 15:38:12 usbridge volumio[741]: info: Loading plugins from folder /data/plugins/ Sep 08 15:38:12 usbridge volumio[741]: info: Loading plugin "system"... Sep 08 15:38:12 usbridge volumio[741]: info: Loading plugin "appearance"... Sep 08 15:38:15 usbridge dhcpcd[621]: eth0: carrier lost Sep 08 15:38:15 usbridge dhcpcd[621]: eth0: deleting host route to 192.168.0.179 via 127.0.0.1 Sep 08 15:38:15 usbridge dhcpcd[621]: eth0: deleting route to 192.168.0.0/24 Sep 08 15:38:15 usbridge dhcpcd[621]: eth0: deleting default route via 192.168.0.1 Sep 08 15:38:15 usbridge avahi-daemon[506]: Withdrawing address record for 192.168.0.179 on eth0. Sep 08 15:38:15 usbridge avahi-daemon[506]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.179. Sep 08 15:38:15 usbridge avahi-daemon[506]: Interface eth0.IPv4 no longer relevant for mDNS. Sep 08 15:38:15 usbridge kernel: ec_netdev_set_multicast_list 2741 Sep 08 15:38:16 usbridge ifplugd(eth0)[561]: Link beat lost. Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "network"... Sep 08 15:38:17 usbridge volumio[741]: info: Refreshing Cached IP Addresses Sep 08 15:38:17 usbridge sudo[815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 15:38:17 usbridge sudo[815]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "services"... Sep 08 15:38:17 usbridge sudo[815]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "alsa_controller"... Sep 08 15:38:17 usbridge sudo[817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 15:38:17 usbridge sudo[817]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:17 usbridge sudo[817]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "wizard"... Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "volumio_command_line_client"... Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "upnp"... Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: carrier acquired Sep 08 15:38:17 usbridge kernel: ethernet link state:disconnected Sep 08 15:38:17 usbridge kernel: exit Sep 08 15:38:17 usbridge kernel: ecp->autoneg:1 autoneg -> speed:100, duplex:full, pause: non-supported Sep 08 15:38:17 usbridge kernel: set_mac_according_aneg Sep 08 15:38:17 usbridge kernel: opmode regs old value - 0x2202 Sep 08 15:38:17 usbridge kernel: old MII_BMCR: 0x3100 Sep 08 15:38:17 usbridge kernel: new MII_BMCR: 0x3100 Sep 08 15:38:17 usbridge kernel: hw_regs->er_opmode:0x2202 Sep 08 15:38:17 usbridge kernel: link established. Sep 08 15:38:17 usbridge volumio[741]: info: [1757345897576] Starting Upmpd Daemon Sep 08 15:38:17 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "my_music"... Sep 08 15:38:17 usbridge volumio[741]: info: Loading plugin "mpd"... Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: soliciting a DHCP lease Sep 08 15:38:17 usbridge ifplugd(eth0)[561]: Link beat detected. Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: offered 192.168.0.179 from 192.168.0.1 Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: leased 192.168.0.179 for 86400 seconds Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: adding host route to 192.168.0.179 via 127.0.0.1 Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: adding route to 192.168.0.0/24 Sep 08 15:38:17 usbridge avahi-daemon[506]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.179. Sep 08 15:38:17 usbridge dhcpcd[621]: eth0: adding default route via 192.168.0.1 Sep 08 15:38:17 usbridge avahi-daemon[506]: New relevant interface eth0.IPv4 for mDNS. Sep 08 15:38:17 usbridge avahi-daemon[506]: Registering new address record for 192.168.0.179 on eth0.IPv4. Sep 08 15:38:17 usbridge kernel: ec_netdev_set_multicast_list 2741 Sep 08 15:38:18 usbridge volumio[741]: info: Loading plugin "upnp_browser"... Sep 08 15:38:20 usbridge volumio[741]: info: Loading plugin "networkfs"... Sep 08 15:38:20 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 15:38:20 usbridge volumio[741]: info: Loading plugin "alarm-clock"... Sep 08 15:38:20 usbridge volumio[741]: info: Plugin airplay_emulation is not enabled Sep 08 15:38:20 usbridge volumio[741]: info: Loading plugin "last_100"... Sep 08 15:38:20 usbridge volumio[741]: info: Loading plugin "webradio"... Sep 08 15:38:20 usbridge dhcpcd[621]: eth0: carrier lost Sep 08 15:38:20 usbridge dhcpcd[621]: eth0: deleting host route to 192.168.0.179 via 127.0.0.1 Sep 08 15:38:20 usbridge dhcpcd[621]: eth0: deleting route to 192.168.0.0/24 Sep 08 15:38:20 usbridge dhcpcd[621]: eth0: deleting default route via 192.168.0.1 Sep 08 15:38:20 usbridge avahi-daemon[506]: Withdrawing address record for 192.168.0.179 on eth0. Sep 08 15:38:20 usbridge avahi-daemon[506]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.179. Sep 08 15:38:20 usbridge avahi-daemon[506]: Interface eth0.IPv4 no longer relevant for mDNS. Sep 08 15:38:20 usbridge kernel: ec_netdev_set_multicast_list 2741 Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "i2s_dacs"... Sep 08 15:38:21 usbridge volumio[741]: info: I2S DAC not set, start Auto-detection Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "volumiodiscovery"... Sep 08 15:38:21 usbridge volumio[741]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 08 15:38:21 usbridge node[741]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Sep 08 15:38:21 usbridge node[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 15:38:21 usbridge node[741]: *** WARNING *** For more information see Sep 08 15:38:21 usbridge node[741]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 08 15:38:21 usbridge node[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 15:38:21 usbridge node[741]: *** WARNING *** For more information see Sep 08 15:38:21 usbridge volumio[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 15:38:21 usbridge volumio[741]: *** WARNING *** For more information see Sep 08 15:38:21 usbridge volumio[741]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Sep 08 15:38:21 usbridge volumio[741]: *** WARNING *** Please fix your application to use the native API of Avahi! Sep 08 15:38:21 usbridge volumio[741]: *** WARNING *** For more information see Sep 08 15:38:21 usbridge volumio[741]: info: Applying required configuration parameters for plugin volumiodiscovery Sep 08 15:38:21 usbridge volumio[741]: Discovery: StartAdv! undefined Sep 08 15:38:21 usbridge volumio[741]: Discovery: Started advertising... usbridge - undefined Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "outputs"... Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "albumart"... Sep 08 15:38:21 usbridge volumio[741]: info: Plugin example_plugin is not enabled Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "inputs"... Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "updater_comm"... Sep 08 15:38:21 usbridge volumio[741]: info: Plugin mpdemulation is not enabled Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "rest_api"... Sep 08 15:38:21 usbridge ifplugd(eth0)[561]: Link beat lost. Sep 08 15:38:21 usbridge volumio[741]: info: Loading plugin "websocket"... Sep 08 15:38:21 usbridge volumio[741]: info: ___________ START PLUGINS ___________ Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 15:38:21 usbridge volumio[741]: info: [1757345901908] CoreMusicLibrary::Adding element Media Servers Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 15:38:21 usbridge volumio[741]: info: [1757345901976] CoreMusicLibrary::Adding element Last_100 Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Sep 08 15:38:21 usbridge volumio[741]: info: [1757345901986] CoreMusicLibrary::Adding element Webradio Sep 08 15:38:21 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Sep 08 15:38:22 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:22 usbridge volumio[741]: info: ----- MyVolumio plugins startup ---- Sep 08 15:38:22 usbridge volumio[741]: info: ------------------------------------------- Sep 08 15:38:22 usbridge volumio[741]: info: [MyVolumio PluginManager] Fetching plans data.... Sep 08 15:38:22 usbridge volumio[741]: info: Loading i18n strings for locale en Sep 08 15:38:22 usbridge volumio[741]: Updating browse sources language Sep 08 15:38:22 usbridge volumio[741]: Forking 3 albumart workers Sep 08 15:38:22 usbridge volumio[741]: Cannot find translation for sourceMedia Servers Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::initPlayerControls Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getAlsaCards Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 15:38:22 usbridge dhcpcd[621]: eth0: carrier acquired Sep 08 15:38:22 usbridge volumio[741]: info: BOOT COMPLETED Sep 08 15:38:22 usbridge kernel: ethernet link state:linked ethernet link state:disconnected Sep 08 15:38:22 usbridge kernel: exit Sep 08 15:38:22 usbridge kernel: ecp->autoneg:1 autoneg -> speed:100, duplex:full, pause: non-supported Sep 08 15:38:22 usbridge kernel: set_mac_according_aneg Sep 08 15:38:22 usbridge kernel: opmode regs old value - 0x2202 Sep 08 15:38:22 usbridge kernel: old MII_BMCR: 0x3100 Sep 08 15:38:22 usbridge kernel: new MII_BMCR: 0x3100 Sep 08 15:38:22 usbridge kernel: hw_regs->er_opmode:0x2202 Sep 08 15:38:22 usbridge kernel: link established. Sep 08 15:38:22 usbridge volumio[741]: [Metrics] CommandRouter: 13s 768.33ms Sep 08 15:38:22 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:22 usbridge kernel: snd_pcm_mmap,default Sep 08 15:38:22 usbridge dhcpcd[621]: eth0: rebinding lease of 192.168.0.179 Sep 08 15:38:22 usbridge kernel: think_time:1 Sep 08 15:38:22 usbridge kernel: think_time:0x14 Sep 08 15:38:22 usbridge kernel: iso_packets:0, bInterval:1, urb_interval:1, reg_con:0x4 Sep 08 15:38:22 usbridge kernel: think_time:1 Sep 08 15:38:22 usbridge kernel: think_time:0x14 Sep 08 15:38:22 usbridge kernel: iso_packets:0, bInterval:4, urb_interval:2, reg_con:0x4 Sep 08 15:38:22 usbridge dhcpcd[621]: eth0: leased 192.168.0.179 for 86400 seconds Sep 08 15:38:22 usbridge avahi-daemon[506]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.179. Sep 08 15:38:22 usbridge dhcpcd[621]: eth0: adding host route to 192.168.0.179 via 127.0.0.1 Sep 08 15:38:22 usbridge avahi-daemon[506]: New relevant interface eth0.IPv4 for mDNS. Sep 08 15:38:22 usbridge dhcpcd[621]: eth0: adding route to 192.168.0.0/24 Sep 08 15:38:22 usbridge dhcpcd[621]: eth0: adding default route via 192.168.0.1 Sep 08 15:38:22 usbridge avahi-daemon[506]: Registering new address record for 192.168.0.179 on eth0.IPv4. Sep 08 15:38:22 usbridge kernel: ec_netdev_set_multicast_list 2741 Sep 08 15:38:22 usbridge ifplugd(eth0)[561]: Link beat detected. Sep 08 15:38:23 usbridge volumio-remote-updater[482]: [2025-09-08 15:38:23] [connect] Successful connection Sep 08 15:38:24 usbridge volumio[741]: Starting albumart workers Sep 08 15:38:24 usbridge volumio[741]: Starting albumart workers Sep 08 15:38:24 usbridge volumio[741]: Starting albumart workers Sep 08 15:38:27 usbridge kernel: irqvector:66, 0x42 Sep 08 15:38:27 usbridge kernel: hcd ep err ep_num:2, is_in:1 Sep 08 15:38:27 usbridge kernel: err_type :3 Sep 08 15:38:27 usbridge kernel: aotg_hcd aotg_hcd.0: HC IN ep 2 error [0x0F] error type [0x03], reset it... Sep 08 15:38:27 usbridge kernel: irqvector:66, 0x42 Sep 08 15:38:27 usbridge kernel: hcd ep err ep_num:2, is_in:1 Sep 08 15:38:27 usbridge kernel: err_type :3 Sep 08 15:38:27 usbridge kernel: aotg_hcd aotg_hcd.0: HC IN ep 2 error [0x0F] error type [0x03], reset it... Sep 08 15:38:27 usbridge kernel: irqvector:66, 0x42 Sep 08 15:38:27 usbridge kernel: hcd ep err ep_num:2, is_in:1 Sep 08 15:38:27 usbridge kernel: err_type :3 Sep 08 15:38:27 usbridge kernel: aotg_hcd aotg_hcd.0: HC IN ep 2 error [0x0F] error type [0x03], reset it... Sep 08 15:38:27 usbridge kernel: irqvector:66, 0x42 Sep 08 15:38:27 usbridge kernel: hcd ep err ep_num:2, is_in:1 Sep 08 15:38:27 usbridge kernel: err_type :3 Sep 08 15:38:27 usbridge kernel: aotg_hcd aotg_hcd.0: HC IN ep 2 error [0x0F] error type [0x03], reset it... Sep 08 15:38:27 usbridge kernel: irqvector:66, 0x42 Sep 08 15:38:27 usbridge kernel: hcd ep err ep_num:2, is_in:1 Sep 08 15:38:27 usbridge kernel: err_type :3 Sep 08 15:38:27 usbridge kernel: aotg_hcd aotg_hcd.0: HC IN ep 2 error [0x0F] error type [0x03], reset it... Sep 08 15:38:27 usbridge udisks-glue[479]: error: Timeout Sep 08 15:38:28 usbridge volumio[741]: Playing WAVE '/volumio/app/startup.wav' : Signed 16 bit Little Endian, Rate 44100 Hz, Stereo Sep 08 15:38:28 usbridge volumio[741]: info: CoreCommandRouter::Close All Modals sent Sep 08 15:38:28 usbridge kernel: aotg_hub_endpoint_disable Sep 08 15:38:28 usbridge kernel: aotg_hcd aotg_hcd.1: ep1 index 1 from ep [out] Sep 08 15:38:28 usbridge kernel: aotg_hub_endpoint_disable Sep 08 15:38:28 usbridge kernel: aotg_hcd aotg_hcd.1: ep1 index 2 from ep [in] Sep 08 15:38:28 usbridge volumio[741]: info: CoreCommandRouter::Close All Modals sent Sep 08 15:38:28 usbridge volumio[741]: Express server listening on port 3000 Sep 08 15:38:28 usbridge volumio[741]: [Metrics] WebUI: 20s 855.85ms Sep 08 15:38:28 usbridge volumio[741]: Volumio Calling Home Sep 08 15:38:28 usbridge volumio[741]: info: CoreStateMachine::resetVolumioState Sep 08 15:38:28 usbridge volumio[741]: info: CoreStateMachine::getcurrentVolume Sep 08 15:38:28 usbridge volumio[741]: info: CoreCommandRouter::volumioRetrievevolume Sep 08 15:38:28 usbridge volumio[741]: Unhandled rejection Error: No sockets available, cannot start. Sep 08 15:38:28 usbridge volumio[741]: at SsdpClient.SSDP._createSockets (/volumio/node_modules/node-ssdp/lib/index.js:186:11) Sep 08 15:38:28 usbridge volumio[741]: at SsdpClient.SSDP._start (/volumio/node_modules/node-ssdp/lib/index.js:229:10) Sep 08 15:38:28 usbridge volumio[741]: at /volumio/node_modules/node-ssdp/lib/client.js:60:10 Sep 08 15:38:28 usbridge volumio[741]: at Promise._execute (/volumio/node_modules/bluebird/js/release/debuggability.js:384:9) Sep 08 15:38:28 usbridge volumio[741]: at Promise._resolveFromExecutor (/volumio/node_modules/bluebird/js/release/promise.js:518:18) Sep 08 15:38:28 usbridge volumio[741]: at new Promise (/volumio/node_modules/bluebird/js/release/promise.js:103:10) Sep 08 15:38:28 usbridge volumio[741]: at SsdpClient.start (/volumio/node_modules/node-ssdp/lib/client.js:54:10) Sep 08 15:38:28 usbridge volumio[741]: at SsdpClient.search (/volumio/node_modules/node-ssdp/lib/client.js:82:17) Sep 08 15:38:28 usbridge volumio[741]: at ControllerUPNPBrowser.onStart (/volumio/app/plugins/music_service/upnp_browser/index.js:126:12) Sep 08 15:38:28 usbridge volumio[741]: at PluginManager.startCorePlugin (/volumio/app/pluginmanager.js:282:30) Sep 08 15:38:28 usbridge volumio[741]: at HashMap. (/volumio/app/pluginmanager.js:377:31) Sep 08 15:38:28 usbridge volumio[741]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Sep 08 15:38:28 usbridge volumio[741]: at HashMap.proto.(anonymous function) [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Sep 08 15:38:28 usbridge volumio[741]: at PluginManager.startCorePlugins (/volumio/app/pluginmanager.js:376:20) Sep 08 15:38:28 usbridge volumio[741]: at PluginManager.startPlugins (/volumio/app/pluginmanager.js:95:8) Sep 08 15:38:28 usbridge volumio[741]: at new CoreCommandRouter (/volumio/app/index.js:45:22) Sep 08 15:38:28 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:28 usbridge sudo[971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 15:38:28 usbridge sudo[971]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:28 usbridge sudo[971]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:28 usbridge sudo[973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 15:38:28 usbridge sudo[973]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:28 usbridge volumio[741]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Sep 08 15:38:28 usbridge sudo[973]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:28 usbridge volumio[741]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Sep 08 15:38:28 usbridge volumio[741]: info: Setting Device type: Sparky Sep 08 15:38:28 usbridge volumio[741]: info: MPD running with PID507 Sep 08 15:38:28 usbridge volumio[741]: ,establishing connection Sep 08 15:38:28 usbridge sudo[982]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/sbin/i2cdetect -y 1 Sep 08 15:38:28 usbridge sudo[982]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:28 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge kernel: owl_i2c: owl_i2c_fifo_irq(): [i2c1] no ACK, fifostat 0x3 Sep 08 15:38:29 usbridge sudo[982]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:29 usbridge volumio[741]: info: VolumeController:: Volume=undefined Mute =false Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::pushState Sep 08 15:38:29 usbridge volumio[741]: info: CorePlayQueue::getTrack 0 Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::volumioPushState Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::updateTrackBlock Sep 08 15:38:29 usbridge volumio[741]: info: CorePlayQueue::getTrackBlock Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::volumioRetrievevolume Sep 08 15:38:29 usbridge volumio[741]: info: Volumio called home Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Sep 08 15:38:29 usbridge volumio[741]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: amixer: Unable to find simple control '',0 Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:29 usbridge volumio[741]: info: Reloading queue from file Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::setRepeat null single undefined Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::pushState Sep 08 15:38:29 usbridge volumio[741]: info: CorePlayQueue::getTrack 0 Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::volumioPushState Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::setRandom false Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::pushState Sep 08 15:38:29 usbridge volumio[741]: info: CorePlayQueue::getTrack 0 Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::volumioPushState Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 15:38:29 usbridge volumio[741]: info: VolumeController:: Volume=undefined Mute =false Sep 08 15:38:29 usbridge volumio[741]: info: CoreStateMachine::pushState Sep 08 15:38:29 usbridge volumio[741]: info: CorePlayQueue::getTrack 0 Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::volumioPushState Sep 08 15:38:29 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 08 15:38:29 usbridge sudo[990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Sep 08 15:38:29 usbridge sudo[990]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:29 usbridge systemd[1]: Starting UPnP Renderer front-end to MPD... Sep 08 15:38:29 usbridge systemd[1]: Started UPnP Renderer front-end to MPD. Sep 08 15:38:29 usbridge sudo[990]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:29 usbridge volumio[741]: info: Upmpdcli Daemon Started Sep 08 15:38:30 usbridge volumio[741]: Discovery: adding 0eab1c3c-2d4b-4aaf-b363-2fcb181aafb8 Sep 08 15:38:30 usbridge volumio[741]: info: mDNS: Found device usbridge Sep 08 15:38:30 usbridge volumio[741]: info: CoreCommandRouter::volumioGetState Sep 08 15:38:30 usbridge volumio[741]: info: CorePlayQueue::getTrack 0 Sep 08 15:38:30 usbridge volumio[741]: info: CoreCommandRouter::volumioGetState Sep 08 15:38:30 usbridge volumio[741]: info: CorePlayQueue::getTrack 0 Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Sep 08 15:38:30 usbridge volumio[741]: info: Adding plugin bluetooth to MyMusic Plugins Sep 08 15:38:30 usbridge volumio[741]: info: Adding plugin cd_controller to MyMusic Plugins Sep 08 15:38:30 usbridge volumio[741]: info: Adding plugin smart_inputs to MyMusic Plugins Sep 08 15:38:30 usbridge volumio[741]: info: Adding plugin tidalconnect to MyMusic Plugins Sep 08 15:38:30 usbridge volumio[741]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Sep 08 15:38:32 usbridge volumio[741]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Sep 08 15:38:32 usbridge volumio[741]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Sep 08 15:38:32 usbridge volumio[741]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Sep 08 15:38:32 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:32 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:32 usbridge volumio[741]: info: Starting MyVolumio Remote Streaming Endpoints Sep 08 15:38:32 usbridge volumio[741]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Sep 08 15:38:32 usbridge volumio[741]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Sep 08 15:38:32 usbridge volumio[741]: info: Streaming services startup Sep 08 15:38:32 usbridge volumio[741]: info: Starting Streaming Daemon Sep 08 15:38:32 usbridge sudo[994]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Sep 08 15:38:32 usbridge sudo[994]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:32 usbridge systemd[1]: Stopping Volumio Streaming Daemon... Sep 08 15:38:32 usbridge volumio[741]: info: MyVolumio login type: Token Sep 08 15:38:32 usbridge volumio[741]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Sep 08 15:38:32 usbridge systemd[1]: Starting Volumio Streaming Daemon... Sep 08 15:38:32 usbridge systemd[1]: Started Volumio Streaming Daemon. Sep 08 15:38:32 usbridge sudo[994]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:32 usbridge volumio-streaming-daemon[1001]: ############################ Sep 08 15:38:32 usbridge volumio-streaming-daemon[1001]: # Volumio Streaming Daemon # Sep 08 15:38:32 usbridge volumio-streaming-daemon[1001]: # Running on port 7777 # Sep 08 15:38:32 usbridge volumio-streaming-daemon[1001]: ############################ Sep 08 15:38:32 usbridge volumio-streaming-daemon[1001]: Environment: production Sep 08 15:38:33 usbridge volumio[741]: error: MyVolumio Custom Token format not valid, refreshing it Sep 08 15:38:34 usbridge volumio[741]: info: MyVolumio login type: Token Sep 08 15:38:35 usbridge volumio[741]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Sep 08 15:38:35 usbridge volumio[741]: info: MYVOLUMIO: Adding device Sep 08 15:38:35 usbridge volumio[741]: info: MYVOLUMIO: Evaluating Server Sep 08 15:38:35 usbridge volumio-streaming-daemon[1001]: Environment: production Sep 08 15:38:35 usbridge volumio[741]: info: Fetching Streaming Services browse cache Sep 08 15:38:36 usbridge volumio[741]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Sep 08 15:38:36 usbridge volumio[741]: info: Removing browser output: myVolumio user plan is not superstar Sep 08 15:38:36 usbridge volumio[741]: info: Removing audio output: Sep 08 15:38:36 usbridge volumio[741]: info: MYVOLUMIO: Adding device Sep 08 15:38:36 usbridge volumio[741]: info: MYVOLUMIO: Evaluating Server Sep 08 15:38:36 usbridge volumio[741]: info: Remote config written successfully Sep 08 15:38:36 usbridge volumio[741]: info: Starting Tunnel 1 Sep 08 15:38:36 usbridge volumio[741]: info: Starting Tunnel Connection Checker Sep 08 15:38:36 usbridge volumio[741]: info: Setting Geolocation for MyVolumio to eu3 Sep 08 15:38:36 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:36 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:36 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:37 usbridge systemd[1]: Started Music Player Daemon. Sep 08 15:38:37 usbridge systemd[1]: Starting Multi-User System. Sep 08 15:38:37 usbridge systemd[1]: Reached target Multi-User System. Sep 08 15:38:37 usbridge systemd[1]: Starting Graphical Interface. Sep 08 15:38:37 usbridge systemd[1]: Reached target Graphical Interface. Sep 08 15:38:37 usbridge systemd[1]: Starting Update UTMP about System Runlevel Changes... Sep 08 15:38:37 usbridge systemd[1]: Started Update UTMP about System Runlevel Changes. Sep 08 15:38:37 usbridge systemd[1]: Startup finished in 11.320s (kernel) + 49.763s (userspace) = 1min 1.083s. Sep 08 15:38:37 usbridge volumio[741]: error: updateQueue error: null Sep 08 15:38:37 usbridge volumio[741]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Sep 08 15:38:37 usbridge volumio[741]: info: MyVolumio status changed Sep 08 15:38:37 usbridge volumio[741]: info: Streaming services startup Sep 08 15:38:37 usbridge volumio[741]: info: Re-Starting Streaming Daemon Sep 08 15:38:37 usbridge volumio-streaming-daemon[1001]: Restarting daemon Sep 08 15:38:37 usbridge volumio-streaming-daemon[1001]: Environment: production Sep 08 15:38:37 usbridge volumio[741]: info: Updating MyVolumio device info Sep 08 15:38:37 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:37 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:37 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:38 usbridge dhcpcd[621]: eth0: carrier lost Sep 08 15:38:38 usbridge dhcpcd[621]: eth0: deleting host route to 192.168.0.179 via 127.0.0.1 Sep 08 15:38:38 usbridge dhcpcd[621]: eth0: deleting route to 192.168.0.0/24 Sep 08 15:38:38 usbridge dhcpcd[621]: eth0: deleting default route via 192.168.0.1 Sep 08 15:38:38 usbridge avahi-daemon[506]: Withdrawing address record for 192.168.0.179 on eth0. Sep 08 15:38:38 usbridge avahi-daemon[506]: Leaving mDNS multicast group on interface eth0.IPv4 with address 192.168.0.179. Sep 08 15:38:38 usbridge avahi-daemon[506]: Interface eth0.IPv4 no longer relevant for mDNS. Sep 08 15:38:38 usbridge kernel: ec_netdev_set_multicast_list 2741 Sep 08 15:38:38 usbridge volumio[741]: info: mDNS: A device disapperared from network Sep 08 15:38:38 usbridge volumio[741]: info: mDNS: Device usbridge disapperared from network Sep 08 15:38:38 usbridge ifplugd(eth0)[561]: Link beat lost. Sep 08 15:38:38 usbridge volumio-remote-updater[482]: [2025-09-08 15:38:38] [connect] Successful connection Sep 08 15:38:38 usbridge volumio-remote-updater[482]: [2025-09-08 15:38:38] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.5.1" /socket.io/?EIO=4&transport=websocket&t=1757345918 101 Sep 08 15:38:39 usbridge ntpd[616]: Deleting interface #3 eth0, 192.168.0.179#123, interface stats: received=27, sent=32, dropped=0, active_time=45 secs Sep 08 15:38:39 usbridge ntpd[616]: 195.171.43.12 interface 192.168.0.179 -> (none) Sep 08 15:38:39 usbridge ntpd[616]: 176.58.115.34 interface 192.168.0.179 -> (none) Sep 08 15:38:39 usbridge ntpd[616]: 213.210.39.123 interface 192.168.0.179 -> (none) Sep 08 15:38:39 usbridge ntpd[616]: 130.162.173.147 interface 192.168.0.179 -> (none) Sep 08 15:38:39 usbridge ntpd[616]: peers refreshed Sep 08 15:38:39 usbridge dhcpcd[621]: eth0: carrier acquired Sep 08 15:38:39 usbridge kernel: ethernet link state:linked ethernet link state:disconnected Sep 08 15:38:39 usbridge kernel: exit Sep 08 15:38:39 usbridge kernel: ecp->autoneg:1 autoneg -> speed:100, duplex:full, pause: non-supported Sep 08 15:38:39 usbridge kernel: set_mac_according_aneg Sep 08 15:38:39 usbridge kernel: opmode regs old value - 0x2202 Sep 08 15:38:39 usbridge kernel: old MII_BMCR: 0x3100 Sep 08 15:38:39 usbridge kernel: new MII_BMCR: 0x3100 Sep 08 15:38:39 usbridge kernel: hw_regs->er_opmode:0x2202 Sep 08 15:38:39 usbridge kernel: link established. Sep 08 15:38:39 usbridge dhcpcd[621]: eth0: rebinding lease of 192.168.0.179 Sep 08 15:38:40 usbridge dhcpcd[621]: eth0: leased 192.168.0.179 for 86400 seconds Sep 08 15:38:40 usbridge dhcpcd[621]: eth0: adding host route to 192.168.0.179 via 127.0.0.1 Sep 08 15:38:40 usbridge dhcpcd[621]: eth0: adding route to 192.168.0.0/24 Sep 08 15:38:40 usbridge dhcpcd[621]: eth0: adding default route via 192.168.0.1 Sep 08 15:38:40 usbridge avahi-daemon[506]: Joining mDNS multicast group on interface eth0.IPv4 with address 192.168.0.179. Sep 08 15:38:40 usbridge avahi-daemon[506]: New relevant interface eth0.IPv4 for mDNS. Sep 08 15:38:40 usbridge avahi-daemon[506]: Registering new address record for 192.168.0.179 on eth0.IPv4. Sep 08 15:38:40 usbridge kernel: ec_netdev_set_multicast_list 2741 Sep 08 15:38:40 usbridge ifplugd(eth0)[561]: Link beat detected. Sep 08 15:38:41 usbridge volumio[741]: error: Failed to ping endpoint as2.myvolumio.org : unknown error Sep 08 15:38:41 usbridge volumio[741]: error: Failed to ping endpoint au1.myvolumio.org : unknown error Sep 08 15:38:41 usbridge volumio[741]: info: Setting Geolocation for MyVolumio to eu3 Sep 08 15:38:41 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:41 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:41 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Sep 08 15:38:41 usbridge sudo[1099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Sep 08 15:38:41 usbridge sudo[1099]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 15:38:41 usbridge volumio-streaming-daemon[1001]: Enabled services: Sep 08 15:38:41 usbridge volumio-streaming-daemon[1001]: 1) tidal Sep 08 15:38:41 usbridge volumio-streaming-daemon[1001]: 2) qobuz Sep 08 15:38:41 usbridge systemd[1]: Starting MyVolumio SSH Tunnel... Sep 08 15:38:41 usbridge systemd[1]: Started MyVolumio SSH Tunnel. Sep 08 15:38:41 usbridge ntpd[616]: Listen normally on 4 eth0 192.168.0.179 UDP 123 Sep 08 15:38:41 usbridge ntpd[616]: peers refreshed Sep 08 15:38:41 usbridge sudo[1099]: pam_unix(sudo:session): session closed for user root Sep 08 15:38:41 usbridge autossh[1102]: port set to 0, monitoring disabled Sep 08 15:38:41 usbridge autossh[1102]: starting ssh (count 1) Sep 08 15:38:41 usbridge autossh[1102]: ssh child pid is 1105 Sep 08 15:38:41 usbridge volumiossh-tunnel[1101]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[68.183.69.189]:2222' (RSA) to the list of known hosts. Sep 08 15:38:44 usbridge volumio[741]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Sep 08 15:38:44 usbridge volumio[741]: error: [MyVolumio PluginManager] Cache data is invalid! Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: error: Cannot delete local playlist /data/playlist/何雲妮 : Error: ENOENT: no such file or directory, unlink '/data/playlist/何雲妮' Sep 08 15:38:44 usbridge volumio[741]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 15:38:44 usbridge volumio[741]: Error: Unable to resolve or reject the same promise twice Sep 08 15:38:44 usbridge volumio[741]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Sep 08 15:38:44 usbridge volumio[741]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:30479) Sep 08 15:38:44 usbridge volumio[741]: at emitNone (events.js:111:20) Sep 08 15:38:44 usbridge volumio[741]: at Socket.emit (events.js:208:7) Sep 08 15:38:44 usbridge volumio[741]: at endReadableNT (_stream_readable.js:1064:12) Sep 08 15:38:44 usbridge volumio[741]: at _combinedTickCallback (internal/process/next_tick.js:138:11) Sep 08 15:38:44 usbridge volumio[741]: at process._tickCallback (internal/process/next_tick.js:180:9) Sep 08 15:38:44 usbridge volumio[741]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 15:38:45 usbridge sudo[1114]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-08 15:37 Sep 08 15:38:45 usbridge sudo[1114]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="dd2a4339faaeb892c7f467e7dc8d424aefb0bd03" VOLUMIO_FE_VERSION="958dedc0edff114f244fa9acc70cf53089d9e5ae" VOLUMIO_BE_VERSION="307f91893fca011201acba9973e1c41bd3a0ad5d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Oct 1 12:12:00 CEST 2021" VOLUMIO_VERSION="2.916" VOLUMIO_HARDWARE="sparky" VOLUMIO_HASH="1507c65028120e16c14994c066bc5dd4"