-- Logs begin at Thu 2025-09-11 22:52:12 CEST, end at Fri 2025-09-12 06:12:25 CEST. --
Sep 12 06:12:18 volumio ntpd[738]: receive: Unexpected origin timestamp 0xec6db58f.d68bdecb does not match aorg 0000000000.00000000 from server@82.64.131.93 xmt 0xec6e1c22.3739ce13
Sep 12 06:12:18 volumio ntpd[738]: receive: Unexpected origin timestamp 0xec6db58f.d6a19d0d does not match aorg 0000000000.00000000 from server@54.36.61.42 xmt 0xec6e1c22.3962383e
Sep 12 06:12:18 volumio ntpd[738]: receive: Unexpected origin timestamp 0xec6db58f.d69b63eb does not match aorg 0000000000.00000000 from server@193.52.136.2 xmt 0xec6e1c22.39e86eb2
Sep 12 06:12:18 volumio systemd[1]: Starting Daily apt download activities...
Sep 12 06:12:21 volumio volumio[855]: info: Starting Streaming Service Transparent Proxy
Sep 12 06:12:21 volumio volumio[855]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded
Sep 12 06:12:21 volumio volumio[855]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services
Sep 12 06:12:21 volumio volumio[855]: info: Streaming services startup
Sep 12 06:12:21 volumio volumio[855]: info: Starting Streaming Daemon
Sep 12 06:12:21 volumio sudo[1616]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 12 06:12:21 volumio volumio[855]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started
Sep 12 06:12:21 volumio sudo[1616]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 06:12:21 volumio sudo[1616]: pam_unix(sudo:session): session closed for user root
Sep 12 06:12:21 volumio volumio[855]: error: Cannot start Volumio Streaming Daemon
Sep 12 06:12:21 volumio volumio[855]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Sep 12 06:12:21 volumio volumio[855]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Sep 12 06:12:21 volumio volumio[855]: info: Discovery: A device disappeared from network
Sep 12 06:12:21 volumio volumio[855]: info: Discovery: Device volumio disappeared from network
Sep 12 06:12:22 volumio volumio[855]: info: Discovery: A device disappeared from network
Sep 12 06:12:22 volumio volumio[855]: info: Discovery: adding 6af2bf43-9594-47c3-88b7-b08e8893e86e
Sep 12 06:12:22 volumio volumio[855]: info: Discovery: Found device Volumio
Sep 12 06:12:22 volumio volumio[855]: info: CoreCommandRouter::volumioGetState
Sep 12 06:12:22 volumio volumio[855]: info: CorePlayQueue::getTrack 0
Sep 12 06:12:22 volumio volumio[855]: info: Discovery: this is already registered, 6af2bf43-9594-47c3-88b7-b08e8893e86e
Sep 12 06:12:22 volumio volumio[855]: info: Discovery: Found device Volumio
Sep 12 06:12:22 volumio volumio[855]: info: CoreCommandRouter::volumioGetState
Sep 12 06:12:22 volumio volumio[855]: info: CorePlayQueue::getTrack 0
Sep 12 06:12:22 volumio volumio[855]: error: MyVolumio Custom Token format not valid, refreshing it
Sep 12 06:12:23 volumio volumio[855]: info: MyVolumio login type: Token
Sep 12 06:12:23 volumio volumio[855]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
Sep 12 06:12:23 volumio systemd[1]: apt-daily.service: Succeeded.
Sep 12 06:12:23 volumio systemd[1]: Started Daily apt download activities.
Sep 12 06:12:24 volumio volumio[855]: info: MyVolumio token set successfully
Sep 12 06:12:24 volumio volumio[855]: info: MYVOLUMIO: Adding device
Sep 12 06:12:24 volumio volumio[855]: info: MYVOLUMIO: Evaluating Server
Sep 12 06:12:24 volumio volumio[855]: STREAMING PROXY: Starting server on port 3245
Sep 12 06:12:24 volumio volumio[855]: Node JS runtime: 14
Sep 12 06:12:24 volumio volumio[855]: info: MyVolumio status changed
Sep 12 06:12:24 volumio volumio[855]: info: Streaming services startup
Sep 12 06:12:24 volumio volumio[855]: info: Starting Streaming Daemon
Sep 12 06:12:24 volumio volumio[855]: info: Removing browser output: myVolumio user plan is not superstar
Sep 12 06:12:24 volumio volumio[855]: info: Removing audio output:
Sep 12 06:12:24 volumio volumio[855]: info: Stoppping Tunnel 1
Sep 12 06:12:24 volumio sudo[1676]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
Sep 12 06:12:24 volumio sudo[1676]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 06:12:24 volumio sudo[1678]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
Sep 12 06:12:24 volumio sudo[1678]: pam_unix(sudo:session): session opened for user root by (uid=0)
Sep 12 06:12:25 volumio sudo[1676]: pam_unix(sudo:session): session closed for user root
Sep 12 06:12:25 volumio volumio[855]: error: Cannot start Volumio Streaming Daemon
Sep 12 06:12:25 volumio volumio[855]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
Sep 12 06:12:25 volumio volumio[855]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
Sep 12 06:12:25 volumio sudo[1678]: pam_unix(sudo:session): session closed for user root
Sep 12 06:12:25 volumio volumio[855]: info: Remote SSH Stopped
Sep 12 06:12:25 volumio dbus-daemon[596]: [system] Successfully activated service 'org.freedesktop.timedate1'
Sep 12 06:12:25 volumio systemd[1]: Started Time & Date Service.
Sep 12 06:12:13 volumio systemd-timedated[1575]: Changed local time to Fri Sep 12 06:12:13 2025
Sep 12 06:12:13 volumio sudo[1573]: pam_unix(sudo:session): session closed for user root
Sep 12 06:12:13 volumio volumio-time-update[593]: volumio-time-update-util: System time updated successfully.
Sep 12 06:12:13 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Sep 12 06:12:13 volumio volumio[855]: error: Failed to ping endpoint au1.myvolumio.org : unknown error
Sep 12 06:12:13 volumio volumio[855]: info: Setting Geolocation for MyVolumio to eu3
Sep 12 06:12:13 volumio volumio[855]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 12 06:12:13 volumio volumio[855]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 12 06:12:13 volumio volumio[855]: Error: Unable to resolve or reject the same promise twice
Sep 12 06:12:13 volumio volumio[855]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Sep 12 06:12:13 volumio volumio[855]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086)
Sep 12 06:12:13 volumio volumio[855]: at Socket.emit (events.js:327:22)
Sep 12 06:12:13 volumio volumio[855]: at endReadableNT (internal/streams/readable.js:1327:12)
Sep 12 06:12:13 volumio volumio[855]: at processTicksAndRejections (internal/process/task_queues.js:80:21)
Sep 12 06:12:13 volumio volumio[855]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 12 06:12:13 volumio systemd[1]: Started Volumio Time Update Utility.
Sep 12 06:12:13 volumio systemd[1]: Reached target Multi-User System.
Sep 12 06:12:13 volumio systemd[1]: Reached target Graphical Interface.
Sep 12 06:12:13 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Sep 12 06:12:13 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Sep 12 06:12:13 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Sep 12 06:12:14 volumio sudo[1711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-09-12 06:11
Sep 12 06:12:14 volumio sudo[1711]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Raspbian GNU/Linux 10 (buster)"
NAME="Raspbian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="29866754e5f1d7e4d0f581c10d9f22852f6f21db"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST"
VOLUMIO_VERSION="3.832"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"