Sep 04 13:06:37 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:06:38 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$0 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$1 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$2 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$3 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$4 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$5 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$6 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$7 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$8 Sep 04 13:06:38 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$9 Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$0 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$1 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$2 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$3 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$4 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$5 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$6 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$7 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$8 in service upnp_browser Sep 04 13:06:38 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$1$9 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:06:58 rasptouch systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Sep 04 13:06:58 rasptouch dbus-daemon[672]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.43' (uid=0 pid=4350 comm="timedatectl show --property=NTPSynchronized --valu") Sep 04 13:06:58 rasptouch systemd[1]: Starting systemd-timedated.service - Time & Date Service... Sep 04 13:06:58 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$0 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$1 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$2 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$3 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$4 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$5 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$6 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$7 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$8 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$9 Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$A Sep 04 13:06:58 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$B Sep 04 13:06:58 rasptouch dbus-daemon[672]: [system] Successfully activated service 'org.freedesktop.timedate1' Sep 04 13:06:58 rasptouch systemd[1]: Started systemd-timedated.service - Time & Date Service. Sep 04 13:06:58 rasptouch setdatetime-helper.sh[4349]: Time is not synchronized. Attempting to sync... Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$0 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$1 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$2 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$3 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$4 in service upnp_browser Sep 04 13:06:58 rasptouch sudo[4360]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 04 Sep 2025 11:06:58 GMT#015' Sep 04 13:06:58 rasptouch sudo[4360]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Sep 04 13:06:58 rasptouch setdatetime-helper.sh[4361]: Thu Sep 4 13:06:58 CEST 2025 Sep 04 13:06:58 rasptouch sudo[4360]: pam_unix(sudo:session): session closed for user root Sep 04 13:06:58 rasptouch setdatetime-helper.sh[4349]: Time synchronized successfully. Sep 04 13:06:58 rasptouch systemd-journald[331]: Time jumped backwards, rotating. Sep 04 13:06:58 rasptouch systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Sep 04 13:06:58 rasptouch systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$5 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$6 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$7 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$8 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$9 in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$A in service upnp_browser Sep 04 13:06:58 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$13$2$B in service upnp_browser Sep 04 13:07:06 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:06 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:12 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:12 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:16 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:16 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:27 rasptouch systemd[1]: systemd-timedated.service: Deactivated successfully. Sep 04 13:07:30 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:30 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$0 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$1 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$2 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$3 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$4 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$5 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$6 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$7 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$8 Sep 04 13:07:30 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$9 Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$0 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$1 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$2 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$3 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$4 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$5 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$6 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$7 in service upnp_browser Sep 04 13:07:30 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$8 in service upnp_browser Sep 04 13:07:31 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$3$9 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:32 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$0 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$1 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$2 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$3 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$4 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$5 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$6 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$7 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$8 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$9 Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$A Sep 04 13:07:32 rasptouch volumio[1241]: info: Preloading song: upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$B Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$0 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$1 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$2 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$3 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$4 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$5 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$6 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$7 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$8 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$9 in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$A in service upnp_browser Sep 04 13:07:32 rasptouch volumio[1241]: info: Exploding uri upnp/http://192.168.0.2:8200/ctl/ContentDir@1$6$5$1$B in service upnp_browser Sep 04 13:07:35 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:35 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:36 rasptouch ntpd[995]: CLOCK: time stepped by 0.712502 Sep 04 13:07:36 rasptouch ntpd[995]: INIT: MRU 13107 entries, 13 hash bits, 32768 bytes Sep 04 13:07:39 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:39 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:40 rasptouch volumio[1241]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Sep 04 13:07:40 rasptouch volumio[1241]: info: Preload queue cleared Sep 04 13:07:55 rasptouch volumio[1241]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 13:07:55 rasptouch volumio[1241]: Error: read ETIMEDOUT Sep 04 13:07:55 rasptouch volumio[1241]: at TLSWrap.onStreamRead (node:internal/stream_base_commons:217:20) { Sep 04 13:07:55 rasptouch volumio[1241]: errno: -110, Sep 04 13:07:55 rasptouch volumio[1241]: code: 'ETIMEDOUT', Sep 04 13:07:55 rasptouch volumio[1241]: syscall: 'read' Sep 04 13:07:55 rasptouch volumio[1241]: } Sep 04 13:07:55 rasptouch volumio[1241]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 04 13:07:56 rasptouch sudo[4574]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-04 13:06' Sep 04 13:07:56 rasptouch sudo[4574]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="dfc7bb04e09bf2260691765a2340814af1fa2971" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="30d63a8c53d2826bd7f262e22b4e4511a4cc9d01" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat Aug 30 06:39:32 UTC 2025" VOLUMIO_VERSION="4.022" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e7b0bd0cb5661ea77402e5bd121ec64a"