-- Logs begin at Sun 2026-02-08 19:32:01 -03, end at Mon 2026-02-09 18:34:12 -03. -- Feb 09 18:34:09 lobby ntpd[765]: receive: Unexpected origin timestamp 0xed338df2.a4532fa7 does not match aorg 0000000000.00000000 from server@200.160.7.186 xmt 0xed34d151.9e99104c Feb 09 18:34:09 lobby ntpd[765]: receive: Unexpected origin timestamp 0xed338df2.a440ee47 does not match aorg 0000000000.00000000 from server@216.238.106.159 xmt 0xed34d151.9e925124 Feb 09 18:34:09 lobby ntpd[765]: receive: Unexpected origin timestamp 0xed338df2.a44f3d47 does not match aorg 0000000000.00000000 from server@216.238.102.201 xmt 0xed34d151.9e8e055f Feb 09 18:34:09 lobby ntpd[765]: receive: Unexpected origin timestamp 0xed338df2.a44dcbf0 does not match aorg 0000000000.00000000 from server@143.107.229.211 xmt 0xed34d151.a1c8cae8 Feb 09 18:34:09 lobby ntpd[765]: receive: Unexpected origin timestamp 0xed338df2.a4504cd8 does not match aorg 0000000000.00000000 from server@200.189.40.8 xmt 0xed34d151.a44424c4 Feb 09 18:34:09 lobby systemd[1]: Starting Daily apt download activities... Feb 09 18:34:09 lobby volumio[878]: info: Discovery: A device disappeared from network Feb 09 18:34:09 lobby volumio[878]: info: Discovery: Device lobby disappeared from network Feb 09 18:34:09 lobby go-librespot[1379]: time="2026-02-09T18:34:09-03:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 09 18:34:09 lobby go-librespot[1379]: time="2026-02-09T18:34:09-03:00" level=trace msg="emitting websocket event: volume" Feb 09 18:34:09 lobby volumio[878]: info: Discovery: A device disappeared from network Feb 09 18:34:09 lobby volumio[878]: info: Discovery: Device piscina disappeared from network Feb 09 18:34:09 lobby volumio[878]: info: Discovery: Disconnected from remote: 10.0.110.244 Feb 09 18:34:09 lobby volumio[878]: info: Discovery: A device disappeared from network Feb 09 18:34:09 lobby volumio[878]: info: Discovery: Device liberhaus disappeared from network Feb 09 18:34:09 lobby volumio[878]: info: Discovery: Disconnected from remote: 10.0.110.241 Feb 09 18:34:09 lobby volumio[878]: SPOTIFY: received: {"type":"volume","data":{"value":51,"max":100}} Feb 09 18:34:09 lobby volumio[878]: SPOTIFY: RECEIVED SPOTIFY VOLUME 51 Feb 09 18:34:09 lobby volumio[878]: info: Discovery: A device disappeared from network Feb 09 18:34:09 lobby ntpd[765]: receive: Unexpected origin timestamp 0xed338df2.a4524238 does not match aorg 0000000000.00000000 from server@192.36.143.130 xmt 0xed34d151.bcaaa91d Feb 09 18:34:09 lobby volumio[878]: error: MyVolumio Custom Token format not valid, refreshing it Feb 09 18:34:09 lobby volumio[878]: verbose: New Socket.io Connection to 10.0.110.243:3000 from 10.0.110.242 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 13 Feb 09 18:34:09 lobby volumio[878]: info: Discovery: adding b3f79d61-05a0-4915-a12b-8477d48b2e07 Feb 09 18:34:09 lobby volumio[878]: info: Discovery: Found device Lobby Feb 09 18:34:09 lobby volumio[878]: info: CoreCommandRouter::volumioGetState Feb 09 18:34:09 lobby volumio[878]: info: CorePlayQueue::getTrack 0 Feb 09 18:34:10 lobby volumio[878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket Feb 09 18:34:10 lobby volumio[878]: info: Discovery: adding 58060118-c4b9-47d7-bde1-c1098f558882 Feb 09 18:34:10 lobby volumio[878]: info: Discovery: Found device Piscina Feb 09 18:34:10 lobby volumio[878]: info: Discovery: Connecting to remote: 10.0.110.244 Feb 09 18:34:10 lobby volumio[878]: info: Discovery: adding 831d61d7-3b69-4606-8d3c-4660a26f087b Feb 09 18:34:10 lobby volumio[878]: info: Discovery: Found device LiberHaus Feb 09 18:34:10 lobby volumio[878]: info: Discovery: Connecting to remote: 10.0.110.241 Feb 09 18:34:10 lobby volumio[878]: info: Discovery: Connected to remote: 10.0.110.241 Feb 09 18:34:10 lobby volumio[878]: info: CoreCommandRouter::volumioGetState Feb 09 18:34:10 lobby volumio[878]: info: CorePlayQueue::getTrack 0 Feb 09 18:34:10 lobby volumio[878]: STREAMING PROXY: Starting server on port 3245 Feb 09 18:34:10 lobby volumio[878]: Node JS runtime: 14 Feb 09 18:34:10 lobby systemd[1]: apt-daily.service: Succeeded. Feb 09 18:34:10 lobby systemd[1]: Started Daily apt download activities. Feb 09 18:34:10 lobby systemd[1]: Starting Daily apt upgrade and clean activities... Feb 09 18:34:10 lobby volumio[878]: info: MyVolumio login type: Token Feb 09 18:34:11 lobby volumio[878]: SPOTIFY: SETTING SPOTIFY VOLUME 51 Feb 09 18:34:11 lobby volumio[878]: info: Sending Spotify command with payload to local API: /player/volume Feb 09 18:34:11 lobby go-librespot[1379]: time="2026-02-09T18:34:11-03:00" level=debug msg="update volume requested to 33422/65535" Feb 09 18:34:11 lobby go-librespot[1379]: time="2026-02-09T18:34:11-03:00" level=debug msg="put connect state because VOLUME_CHANGED" Feb 09 18:34:11 lobby go-librespot[1379]: time="2026-02-09T18:34:11-03:00" level=trace msg="emitting websocket event: volume" Feb 09 18:34:11 lobby volumio[878]: SPOTIFY: received: {"type":"volume","data":{"value":51,"max":100}} Feb 09 18:34:11 lobby volumio[878]: SPOTIFY: RECEIVED SPOTIFY VOLUME 51 Feb 09 18:34:11 lobby systemd[1]: apt-daily-upgrade.service: Succeeded. Feb 09 18:34:11 lobby systemd[1]: Started Daily apt upgrade and clean activities. Feb 09 18:34:11 lobby volumio-time-update[614]: volumio-time-update-util: Fetching time from Volumio... Feb 09 18:34:11 lobby volumio[878]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Feb 09 18:34:12 lobby volumio[878]: info: MyVolumio token set successfully Feb 09 18:34:12 lobby volumio[878]: info: MYVOLUMIO: Adding device Feb 09 18:34:12 lobby volumio[878]: info: MYVOLUMIO: Evaluating Server Feb 09 18:34:12 lobby volumio-time-update[614]: volumio-time-update-util: Setting system time to: 2026-02-09 18:34:12 Feb 09 18:34:12 lobby sudo[1608]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2026-02-09 18:34:12 Feb 09 18:34:12 lobby sudo[1608]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 09 18:34:12 lobby dbus-daemon[606]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=1609 comm="timedatectl set-time 2026-02-09 18:34:12 ") Feb 09 18:34:12 lobby systemd[1]: Starting Time & Date Service... Feb 09 18:34:12 lobby dbus-daemon[606]: [system] Successfully activated service 'org.freedesktop.timedate1' Feb 09 18:34:12 lobby systemd[1]: Started Time & Date Service. Feb 09 18:34:12 lobby systemd-timedated[1610]: Changed local time to Mon Feb 9 18:34:12 2026 Feb 09 18:34:12 lobby sudo[1608]: pam_unix(sudo:session): session closed for user root Feb 09 18:34:12 lobby volumio-time-update[614]: volumio-time-update-util: System time updated successfully. Feb 09 18:34:12 lobby systemd[1]: Started Volumio Time Update Utility. Feb 09 18:34:12 lobby systemd[1]: Reached target Multi-User System. Feb 09 18:34:12 lobby systemd[1]: Reached target Graphical Interface. Feb 09 18:34:12 lobby systemd[1]: Starting Update UTMP about System Runlevel Changes... Feb 09 18:34:12 lobby systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Feb 09 18:34:12 lobby systemd[1]: Started Update UTMP about System Runlevel Changes. Feb 09 18:34:12 lobby volumio[878]: info: MyVolumio status changed Feb 09 18:34:12 lobby systemd[1]: Startup finished in 14.451s (kernel) + 2min 30.056s (userspace) = 2min 44.508s. Feb 09 18:34:12 lobby volumio[878]: info: Streaming services startup Feb 09 18:34:12 lobby volumio[878]: info: Starting Streaming Daemon Feb 09 18:34:12 lobby volumio[878]: info: Removing browser output: myVolumio user plan is not superstar Feb 09 18:34:12 lobby volumio[878]: info: Removing audio output: Feb 09 18:34:12 lobby volumio[878]: info: Stoppping Tunnel 1 Feb 09 18:34:12 lobby sudo[1632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Feb 09 18:34:12 lobby sudo[1632]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 09 18:34:12 lobby volumio[878]: error: Failed to ping endpoint eu2.myvolumio.org : unknown error Feb 09 18:34:12 lobby volumio[878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 09 18:34:12 lobby sudo[1635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Feb 09 18:34:12 lobby sudo[1632]: pam_unix(sudo:session): session closed for user root Feb 09 18:34:12 lobby sudo[1635]: pam_unix(sudo:session): session opened for user root by (uid=0) Feb 09 18:34:12 lobby volumio[878]: Error: Unable to resolve or reject the same promise twice Feb 09 18:34:12 lobby volumio[878]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Feb 09 18:34:12 lobby volumio[878]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Feb 09 18:34:12 lobby volumio[878]: at Socket.emit (events.js:315:20) Feb 09 18:34:12 lobby volumio[878]: at addChunk (internal/streams/readable.js:309:12) Feb 09 18:34:12 lobby volumio[878]: at readableAddChunk (internal/streams/readable.js:284:9) Feb 09 18:34:12 lobby volumio[878]: at Socket.Readable.push (internal/streams/readable.js:223:10) Feb 09 18:34:12 lobby volumio[878]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Feb 09 18:34:12 lobby volumio[878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 09 18:34:12 lobby sudo[1635]: pam_unix(sudo:session): session closed for user root Feb 09 18:34:12 lobby sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-09 18:33 Feb 09 18:34:12 lobby sudo[1646]: 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="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"