-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Sun 2025-06-08 16:06:38 CEST. -- Jun 08 16:06:27 volumio systemd[1]: Starting Daily man-db regeneration... Jun 08 16:06:27 volumio systemd[1]: Starting Daily apt download activities... Jun 08 16:06:27 volumio systemd[1]: man-db.service: Succeeded. Jun 08 16:06:27 volumio systemd[1]: Started Daily man-db regeneration. Jun 08 16:06:27 volumio ntpd[815]: Soliciting pool server 37.59.63.125 Jun 08 16:06:27 volumio ntpd[815]: Soliciting pool server 79.143.250.33 Jun 08 16:06:27 volumio ntpd[815]: Soliciting pool server 45.132.96.81 Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin bluetooth to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin multiroom to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin metavolumio to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin cd_controller to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 08 16:06:27 volumio volumio[1015]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 08 16:06:28 volumio systemd[1]: apt-daily.service: Succeeded. Jun 08 16:06:28 volumio systemd[1]: Started Daily apt download activities. Jun 08 16:06:28 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Jun 08 16:06:28 volumio ntpd[815]: Soliciting pool server 2001:bc8:32d7:25e::42 Jun 08 16:06:28 volumio ntpd[815]: Soliciting pool server 82.67.41.119 Jun 08 16:06:29 volumio volumio[1015]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 08 16:06:29 volumio volumio[1015]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 08 16:06:29 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:29 volumio volumio[1015]: info: Starting MyVolumio Remote Streaming Endpoints Jun 08 16:06:29 volumio volumio[1015]: info: MyVolumio login type: Token Jun 08 16:06:29 volumio volumio[1015]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 08 16:06:29 volumio volumio[1015]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 08 16:06:29 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Jun 08 16:06:29 volumio systemd[1]: Started Daily apt upgrade and clean activities. Jun 08 16:06:30 volumio volumio[1015]: info: Starting Streaming Service Transparent Proxy Jun 08 16:06:30 volumio volumio[1015]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 08 16:06:30 volumio volumio[1015]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 08 16:06:30 volumio volumio[1015]: info: Streaming services startup Jun 08 16:06:30 volumio volumio[1015]: info: Starting Streaming Daemon Jun 08 16:06:30 volumio sudo[2739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 08 16:06:30 volumio sudo[2739]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 16:06:30 volumio volumio[1015]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 08 16:06:30 volumio sudo[2739]: pam_unix(sudo:session): session closed for user root Jun 08 16:06:30 volumio volumio[1015]: error: Cannot start Volumio Streaming Daemon Jun 08 16:06:30 volumio volumio[1015]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 08 16:06:30 volumio volumio[1015]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 08 16:06:30 volumio volumio[1015]: error: MyVolumio Custom Token format not valid, refreshing it Jun 08 16:06:30 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 16:06:30 volumio volumio[1015]: info: Received Get System Info Jun 08 16:06:30 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 16:06:30 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 16:06:30 volumio volumio[1015]: info: Discovery: Getting this device information Jun 08 16:06:30 volumio volumio[1015]: info: CoreCommandRouter::volumioGetState Jun 08 16:06:30 volumio volumio[1015]: info: CorePlayQueue::getTrack 0 Jun 08 16:06:30 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 16:06:30 volumio volumio[1015]: STREAMING PROXY: Starting server on port 3245 Jun 08 16:06:30 volumio volumio[1015]: Node JS runtime: 14 Jun 08 16:06:31 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jun 08 16:06:31 volumio volumio[1015]: info: MyVolumio login type: Token Jun 08 16:06:31 volumio volumio[1015]: info: MyVolumio login type: Token Jun 08 16:06:32 volumio volumio[1015]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 08 16:06:32 volumio volumio[1015]: info: MyVolumio token set successfully Jun 08 16:06:32 volumio volumio-time-update[669]: volumio-time-update-util: Date not found in response Jun 08 16:06:32 volumio volumio-time-update[669]: volumio-time-update-util: Retrying in 5 seconds... Jun 08 16:06:32 volumio volumio[1015]: info: MYVOLUMIO: Adding device Jun 08 16:06:32 volumio volumio[1015]: info: MYVOLUMIO: Evaluating Server Jun 08 16:06:33 volumio volumio[1015]: info: MyVolumio status changed Jun 08 16:06:33 volumio volumio[1015]: info: Streaming services startup Jun 08 16:06:33 volumio volumio[1015]: info: Starting Streaming Daemon Jun 08 16:06:33 volumio volumio[1015]: info: Removing browser output: myVolumio user plan is not superstar Jun 08 16:06:33 volumio volumio[1015]: info: Removing audio output: Jun 08 16:06:33 volumio volumio[1015]: info: Stoppping Tunnel 1 Jun 08 16:06:33 volumio sudo[2783]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 08 16:06:33 volumio sudo[2783]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 16:06:33 volumio sudo[2783]: pam_unix(sudo:session): session closed for user root Jun 08 16:06:33 volumio sudo[2786]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Jun 08 16:06:33 volumio volumio[1015]: error: Cannot start Volumio Streaming Daemon Jun 08 16:06:33 volumio volumio[1015]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 08 16:06:33 volumio volumio[1015]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 08 16:06:33 volumio sudo[2786]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 16:06:33 volumio sudo[2786]: pam_unix(sudo:session): session closed for user root Jun 08 16:06:33 volumio volumio[1015]: info: Remote SSH Stopped Jun 08 16:06:33 volumio volumio[1015]: info: Setting Geolocation for MyVolumio to eu2 Jun 08 16:06:33 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:33 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:33 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:33 volumio volumio[1015]: error: Failed to add MyVolumio device: {"message":"USER_NOT_FOUND"} Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 08 16:06:34 volumio volumio[1015]: info: Updating MyVolumio device info Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 08 16:06:34 volumio volumio[1015]: info: Received Get System Info Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 08 16:06:34 volumio volumio[1015]: info: Discovery: Getting this device information Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::volumioGetState Jun 08 16:06:34 volumio volumio[1015]: info: CorePlayQueue::getTrack 0 Jun 08 16:06:34 volumio volumio[1015]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 08 16:06:35 volumio volumio[1015]: error: Failed to update MyVolumio device: {"message":"DEVICE_NOT_FOUND"} Jun 08 16:06:37 volumio volumio-time-update[669]: volumio-time-update-util: Fetching time from Volumio... Jun 08 16:06:37 volumio volumio-time-update[669]: volumio-time-update-util: Setting system time to: 2025-06-08 16:06:37 Jun 08 16:06:37 volumio sudo[2793]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/timedatectl set-time 2025-06-08 16:06:37 Jun 08 16:06:37 volumio sudo[2793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 08 16:06:37 volumio volumio[1015]: info: MYVOLUMIO: Adding device Jun 08 16:06:37 volumio volumio[1015]: info: MYVOLUMIO: Evaluating Server Jun 08 16:06:37 volumio dbus-daemon[665]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.19' (uid=0 pid=2794 comm="timedatectl set-time 2025-06-08 16:06:37 ") Jun 08 16:06:37 volumio volumio[1015]: info: Discovery: A device disappeared from network Jun 08 16:06:37 volumio volumio[1015]: info: Discovery: Device volumio disappeared from network Jun 08 16:06:37 volumio systemd[1]: Starting Time & Date Service... Jun 08 16:06:38 volumio dbus-daemon[665]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 08 16:06:38 volumio systemd[1]: Started Time & Date Service. Jun 08 16:06:37 volumio systemd-timedated[2796]: Changed local time to Sun Jun 8 16:06:37 2025 Jun 08 16:06:37 volumio sudo[2793]: pam_unix(sudo:session): session closed for user root Jun 08 16:06:37 volumio volumio-time-update[669]: volumio-time-update-util: System time updated successfully. Jun 08 16:06:37 volumio systemd[1]: Started Volumio Time Update Utility. Jun 08 16:06:37 volumio systemd[1]: Reached target Multi-User System. Jun 08 16:06:37 volumio systemd[1]: Reached target Graphical Interface. Jun 08 16:06:37 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Jun 08 16:06:37 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Jun 08 16:06:37 volumio volumio[1015]: error: Failed to ping endpoint eu4.myvolumio.org : unknown error Jun 08 16:06:37 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Jun 08 16:06:37 volumio systemd[1]: Startup finished in 12.553s (kernel) + 4min 53.281s (userspace) = 5min 5.835s. Jun 08 16:06:37 volumio volumio[1015]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 16:06:37 volumio volumio[1015]: Error: Unable to resolve or reject the same promise twice Jun 08 16:06:37 volumio volumio[1015]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jun 08 16:06:37 volumio volumio[1015]: at Socket. (/myvolumio/plugins/system_controller/my_volumio/my_volumio_real:1:32367) Jun 08 16:06:37 volumio volumio[1015]: at Socket.emit (events.js:315:20) Jun 08 16:06:37 volumio volumio[1015]: at addChunk (internal/streams/readable.js:309:12) Jun 08 16:06:37 volumio volumio[1015]: at readableAddChunk (internal/streams/readable.js:284:9) Jun 08 16:06:37 volumio volumio[1015]: at Socket.Readable.push (internal/streams/readable.js:223:10) Jun 08 16:06:37 volumio volumio[1015]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Jun 08 16:06:37 volumio volumio[1015]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 08 16:06:37 volumio sudo[2823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-08 16:05 Jun 08 16:06:37 volumio sudo[2823]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"