-- Logs begin at Thu 2019-02-14 10:11:58 UTC, end at Thu 2025-10-16 06:21:40 UTC. -- Oct 16 06:21:35 volumio ntpd[1407]: receive: Unexpected origin timestamp 0xec9a3e3c.dc522c71 does not match aorg 0000000000.00000000 from server@144.76.76.107 xmt 0xec9b0d6f.0d7760f0 Oct 16 06:21:35 volumio systemd[1]: Starting Daily apt download activities... Oct 16 06:21:35 volumio ntpd[1407]: receive: Unexpected origin timestamp 0xec9a3e3c.dc4fc8e3 does not match aorg 0000000000.00000000 from server@188.245.97.96 xmt 0xec9b0d6f.0d4dbc68 Oct 16 06:21:35 volumio systemd[1]: Starting Daily man-db regeneration... Oct 16 06:21:35 volumio volumio[861]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Oct 16 06:21:35 volumio volumio[861]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Oct 16 06:21:35 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 06:21:35 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 06:21:35 volumio volumio[861]: info: Starting MyVolumio Remote Streaming Endpoints Oct 16 06:21:35 volumio volumio[861]: info: MyVolumio login type: Token Oct 16 06:21:35 volumio volumio[861]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Oct 16 06:21:35 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Oct 16 06:21:35 volumio systemd[1]: man-db.service: Succeeded. Oct 16 06:21:35 volumio systemd[1]: Started Daily man-db regeneration. Oct 16 06:21:35 volumio systemd[1]: apt-daily.service: Succeeded. Oct 16 06:21:35 volumio systemd[1]: Started Daily apt download activities. Oct 16 06:21:36 volumio volumio[861]: info: Starting Streaming Service Transparent Proxy Oct 16 06:21:36 volumio volumio[861]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Oct 16 06:21:36 volumio volumio[861]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Oct 16 06:21:36 volumio volumio[861]: info: Streaming services startup Oct 16 06:21:36 volumio volumio[861]: info: Starting Streaming Daemon Oct 16 06:21:36 volumio volumio[861]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Oct 16 06:21:36 volumio sudo[1685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 06:21:36 volumio sudo[1685]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:36 volumio volumio[861]: info: Cannot call home: Error: Command failed: /usr/bin/curl -X POST --data-binary "device=tinkerboard&variante=volumio&version=3.832&uuid=abd47cccf77eca22880acbb4a862bc7d" http://updates.volumio.org/downloader-v1/track-device Oct 16 06:21:36 volumio volumio[861]: % Total % Received % Xferd Average Speed Time Time Time Current Oct 16 06:21:36 volumio volumio[861]: Dload Upload Total Spent Left Speed Oct 16 06:21:36 volumio volumio[861]: [132B blob data] Oct 16 06:21:36 volumio volumio[861]: retrying in 5 seconds, trial 0 Oct 16 06:21:36 volumio volumio[861]: info: Volumio Calling Home Oct 16 06:21:36 volumio sudo[1685]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:36 volumio volumio[861]: info: Discovery: A device disappeared from network Oct 16 06:21:36 volumio volumio[861]: info: Discovery: Device volumio disappeared from network Oct 16 06:21:36 volumio volumio[861]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 6 Oct 16 06:21:36 volumio volumio[861]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 7 Oct 16 06:21:36 volumio volumio[861]: error: Cannot start Volumio Streaming Daemon Oct 16 06:21:36 volumio volumio[861]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Oct 16 06:21:36 volumio volumio[861]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Oct 16 06:21:36 volumio volumio[861]: info: Volumio called home Oct 16 06:21:36 volumio volumio[861]: info: Discovery: adding 0f9303dd-bf97-4391-867e-ae4d58ac552e Oct 16 06:21:36 volumio volumio[861]: info: Discovery: Found device Volumio Oct 16 06:21:36 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:36 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:37 volumio volumio[861]: error: MyVolumio Custom Token format not valid, refreshing it Oct 16 06:21:37 volumio volumio[861]: STREAMING PROXY: Starting server on port 3245 Oct 16 06:21:37 volumio volumio[861]: Node JS runtime: 14 Oct 16 06:21:37 volumio volumio[861]: info: MyVolumio login type: Token Oct 16 06:21:38 volumio volumio[861]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: volumiokiosk-touch Engine version: 3 Transport: polling Total Clients: 8 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 06:21:38 volumio volumio[861]: info: Received Get System Info Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 06:21:38 volumio volumio[861]: info: Discovery: Getting this device information Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: Listing playlists Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 06:21:38 volumio volumio[861]: info: Received Get System Info Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 06:21:38 volumio volumio[861]: info: Discovery: Getting this device information Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetVisibleSources Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 16 06:21:38 volumio volumio[861]: info: Received Get System Info Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 16 06:21:38 volumio volumio[861]: info: Discovery: Getting this device information Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::volumioGetState Oct 16 06:21:38 volumio volumio[861]: info: CorePlayQueue::getTrack 0 Oct 16 06:21:38 volumio volumio[861]: info: Listing playlists Oct 16 06:21:38 volumio volumio[1608]: ...............................................................................................................++++ Oct 16 06:21:38 volumio volumio[861]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 06:21:38 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 16 06:21:39 volumio volumio[861]: info: MyVolumio token set successfully Oct 16 06:21:39 volumio volumio[861]: info: MYVOLUMIO: Adding device Oct 16 06:21:39 volumio volumio[861]: info: MYVOLUMIO: Evaluating Server Oct 16 06:21:39 volumio volumio[861]: info: MyVolumio Plan changed: superstar Oct 16 06:21:39 volumio volumio[861]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Oct 16 06:21:39 volumio volumio[861]: info: Adding audio output: Oct 16 06:21:39 volumio volumio[861]: info: MYVOLUMIO: Adding device Oct 16 06:21:39 volumio volumio[861]: info: MYVOLUMIO: Evaluating Server Oct 16 06:21:39 volumio volumio[861]: info: Remote config written successfully Oct 16 06:21:39 volumio volumio[861]: info: Starting Tunnel 1 Oct 16 06:21:39 volumio volumio[861]: info: Starting Tunnel Connection Checker Oct 16 06:21:39 volumio volumio[861]: info: Completed starting MyVolumio Plugin Oct 16 06:21:39 volumio volumio[861]: info: MYVolumio Device enabled Oct 16 06:21:39 volumio volumio[861]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Oct 16 06:21:39 volumio volumio[861]: info: MyVolumio status changed Oct 16 06:21:39 volumio volumio[861]: info: Streaming services startup Oct 16 06:21:39 volumio volumio[861]: info: Starting Streaming Daemon Oct 16 06:21:39 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Oct 16 06:21:39 volumio sudo[1760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Oct 16 06:21:39 volumio sudo[1760]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:40 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Oct 16 06:21:40 volumio sudo[1760]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:40 volumio dbus-daemon[576]: [system] Successfully activated service 'org.freedesktop.timedate1' Oct 16 06:21:40 volumio systemd[1]: Started Time & Date Service. Oct 16 06:21:31 volumio systemd-timedated[1556]: Changed local time to Thu Oct 16 06:21:31 2025 Oct 16 06:21:31 volumio sudo[1550]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:31 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Oct 16 06:21:31 volumio volumio[861]: info: [1760595691016] Starting BluetoothController Oct 16 06:21:31 volumio volumio-time-update[555]: volumio-time-update-util: System time updated successfully. Oct 16 06:21:31 volumio systemd[1]: Started Volumio Time Update Utility. Oct 16 06:21:31 volumio systemd[1]: Reached target Multi-User System. Oct 16 06:21:31 volumio systemd[1]: Reached target Graphical Interface. Oct 16 06:21:31 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Oct 16 06:21:31 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Oct 16 06:21:31 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Oct 16 06:21:31 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Oct 16 06:21:31 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Oct 16 06:21:31 volumio systemd[1]: Started Daily apt upgrade and clean activities. Oct 16 06:21:31 volumio systemd[1]: Startup finished in 14.844s (kernel) + 27.014s (userspace) = 41.859s. Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Oct 16 06:21:32 volumio sudo[1824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Oct 16 06:21:32 volumio sudo[1824]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:32 volumio sudo[1824]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:32 volumio volumio[861]: info: MRS: MultiRoom plugin initialized Oct 16 06:21:32 volumio volumio[861]: info: MRS: STOPPING SNAPCLIENT Oct 16 06:21:32 volumio volumio[861]: info: MRS: Snap server stop Oct 16 06:21:32 volumio volumio[861]: info: MRS: STOPPING volumioStreaming Oct 16 06:21:32 volumio sudo[1847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Oct 16 06:21:32 volumio sudo[1850]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Oct 16 06:21:32 volumio sudo[1847]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Oct 16 06:21:32 volumio sudo[1850]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:32 volumio sudo[1858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Oct 16 06:21:32 volumio sudo[1847]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Oct 16 06:21:32 volumio sudo[1864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Oct 16 06:21:32 volumio sudo[1858]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:32 volumio sudo[1850]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:32 volumio sudo[1864]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Oct 16 06:21:32 volumio sudo[1864]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:32 volumio sudo[1858]: pam_unix(sudo:session): session closed for user root Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Oct 16 06:21:32 volumio volumio[861]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Oct 16 06:21:32 volumio volumio[861]: info: Preparing to generate the ALSA configuration file Oct 16 06:21:32 volumio volumio[861]: info: Setting Geolocation for MyVolumio to eu10 Oct 16 06:21:32 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 06:21:32 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 06:21:32 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 06:21:32 volumio volumio[861]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 16 06:21:32 volumio volumio[861]: error: Failed to ping endpoint as2.myvolumio.org : unknown error Oct 16 06:21:32 volumio volumio[861]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 06:21:32 volumio volumio[861]: Error: Unable to resolve or reject the same promise twice Oct 16 06:21:32 volumio volumio[861]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Oct 16 06:21:32 volumio volumio[861]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32086) Oct 16 06:21:32 volumio volumio[861]: at Socket.emit (events.js:412:35) Oct 16 06:21:32 volumio volumio[861]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 16 06:21:32 volumio volumio[861]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 16 06:21:32 volumio volumio[861]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 06:21:32 volumio sudo[1910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-16 06:20 Oct 16 06:21:32 volumio sudo[1910]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:55:15 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="2f3686ade78abf3b92c180a0c5b20c6b"