-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2026-01-09 15:52:35 CET. -- Jan 09 15:52:00 server2 systemd[1]: Starting Daily apt download activities... Jan 09 15:52:01 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 09 15:52:01 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jan 09 15:52:01 server2 volumio[826]: info: Received Get System Info Jan 09 15:52:01 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 15:52:01 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 15:52:01 server2 volumio[826]: info: Discovery: Getting this device information Jan 09 15:52:01 server2 volumio[826]: info: CoreCommandRouter::volumioGetState Jan 09 15:52:01 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:01 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 15:52:01 server2 ntpd[717]: Soliciting pool server 141.144.230.32 Jan 09 15:52:02 server2 systemd[1]: apt-daily.service: Succeeded. Jan 09 15:52:02 server2 systemd[1]: Started Daily apt download activities. Jan 09 15:52:02 server2 systemd[1]: Starting Daily apt upgrade and clean activities... Jan 09 15:52:02 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jan 09 15:52:02 server2 volumio[826]: info: Adding plugin bluetooth to MyMusic Plugins Jan 09 15:52:02 server2 volumio[826]: info: Adding plugin multiroom to MyMusic Plugins Jan 09 15:52:02 server2 volumio[826]: info: Adding plugin metavolumio to MyMusic Plugins Jan 09 15:52:02 server2 volumio[826]: info: Adding plugin cd_controller to MyMusic Plugins Jan 09 15:52:02 server2 volumio[826]: info: Adding plugin smart_inputs to MyMusic Plugins Jan 09 15:52:02 server2 volumio[826]: info: Adding plugin tidalconnect to MyMusic Plugins Jan 09 15:52:02 server2 volumio[826]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jan 09 15:52:02 server2 systemd[1]: apt-daily-upgrade.service: Succeeded. Jan 09 15:52:02 server2 systemd[1]: Started Daily apt upgrade and clean activities. Jan 09 15:52:03 server2 volumio[826]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jan 09 15:52:03 server2 volumio[826]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jan 09 15:52:03 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:03 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:03 server2 volumio[826]: info: Starting MyVolumio Remote Streaming Endpoints Jan 09 15:52:03 server2 volumio[826]: info: MyVolumio login type: Token Jan 09 15:52:03 server2 volumio[826]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jan 09 15:52:03 server2 volumio[826]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jan 09 15:52:04 server2 volumio[826]: info: Starting Streaming Service Transparent Proxy Jan 09 15:52:04 server2 volumio[826]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jan 09 15:52:04 server2 volumio[826]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jan 09 15:52:04 server2 volumio[826]: info: Streaming services startup Jan 09 15:52:04 server2 volumio[826]: info: Starting Streaming Daemon Jan 09 15:52:04 server2 sudo[1141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 09 15:52:04 server2 sudo[1141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:52:04 server2 sudo[1141]: pam_unix(sudo:session): session closed for user root Jan 09 15:52:04 server2 volumio[826]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jan 09 15:52:04 server2 volumio[826]: error: Cannot start Volumio Streaming Daemon Jan 09 15:52:04 server2 volumio[826]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 09 15:52:04 server2 volumio[826]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 09 15:52:04 server2 volumio[826]: error: MyVolumio Custom Token format not valid, refreshing it Jan 09 15:52:05 server2 volumio[826]: STREAMING PROXY: Starting server on port 3245 Jan 09 15:52:05 server2 volumio[826]: Node JS runtime: 14 Jan 09 15:52:05 server2 volumio[826]: info: MyVolumio login type: Token Jan 09 15:52:05 server2 volumio[826]: info: CoreCommandRouter::volumioPlay Jan 09 15:52:05 server2 volumio[826]: info: CoreStateMachine::play index undefined Jan 09 15:52:05 server2 volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 15:52:05 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:05 server2 volumio[826]: info: CoreStateMachine::startPlaybackTimer Jan 09 15:52:05 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:06 server2 volumio[826]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jan 09 15:52:06 server2 volumio[826]: info: MYVOLUMIO: Adding device Jan 09 15:52:06 server2 volumio[826]: info: MYVOLUMIO: Evaluating Server Jan 09 15:52:06 server2 volumio[826]: info: MyVolumio Plan changed: premium Jan 09 15:52:06 server2 volumio[826]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jan 09 15:52:06 server2 volumio[826]: info: Removing browser output: myVolumio user plan is not superstar Jan 09 15:52:06 server2 volumio[826]: info: Removing audio output: Jan 09 15:52:06 server2 volumio[826]: info: MYVOLUMIO: Adding device Jan 09 15:52:06 server2 volumio[826]: info: MYVOLUMIO: Evaluating Server Jan 09 15:52:06 server2 volumio[826]: info: Remote config written successfully Jan 09 15:52:06 server2 volumio[826]: info: Starting Tunnel 1 Jan 09 15:52:06 server2 volumio[826]: info: Starting Tunnel Connection Checker Jan 09 15:52:07 server2 volumio[826]: info: MYVolumio Device enabled Jan 09 15:52:07 server2 volumio[826]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jan 09 15:52:07 server2 volumio[826]: info: MyVolumio status changed Jan 09 15:52:07 server2 volumio[826]: info: Streaming services startup Jan 09 15:52:07 server2 volumio[826]: info: Starting Streaming Daemon Jan 09 15:52:07 server2 sudo[1185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jan 09 15:52:07 server2 sudo[1185]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:52:07 server2 sudo[1185]: pam_unix(sudo:session): session closed for user root Jan 09 15:52:07 server2 volumio[826]: error: Cannot start Volumio Streaming Daemon Jan 09 15:52:07 server2 volumio[826]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jan 09 15:52:07 server2 volumio[826]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jan 09 15:52:07 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jan 09 15:52:07 server2 volumio[826]: error: [MyVolumio PluginManager] Cache data is invalid! Jan 09 15:52:07 server2 volumio[826]: info: CoreCommandRouter::volumioPlay Jan 09 15:52:07 server2 volumio[826]: info: CoreStateMachine::play index undefined Jan 09 15:52:07 server2 volumio[826]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 09 15:52:07 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:07 server2 volumio[826]: info: CoreStateMachine::startPlaybackTimer Jan 09 15:52:07 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:07 server2 volumio[826]: info: Discovery: A device disappeared from network Jan 09 15:52:07 server2 volumio[826]: info: Discovery: Device server2 disappeared from network Jan 09 15:52:07 server2 volumio[826]: error: [MyVolumio PluginManager] Could not fetch plugin keys: {"success":false,"error":{"message":"Unauthenticated"}} Jan 09 15:52:07 server2 volumio[826]: info: Discovery: adding 2bd00dd8-9452-4e37-8bdf-7aeb8e4cb04a Jan 09 15:52:07 server2 volumio[826]: info: Discovery: Found device Server2 Jan 09 15:52:07 server2 volumio[826]: info: CoreCommandRouter::volumioGetState Jan 09 15:52:07 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:11 server2 volumio[826]: info: CoreCommandRouter::volumioGetQueue Jan 09 15:52:11 server2 volumio[826]: info: CoreStateMachine::getQueue Jan 09 15:52:11 server2 volumio[826]: info: CorePlayQueue::getQueue Jan 09 15:52:11 server2 sudo[1196]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jan 09 15:52:11 server2 sudo[1196]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 09 15:52:11 server2 systemd[1]: Started MyVolumio SSH Tunnel. Jan 09 15:52:11 server2 sudo[1196]: pam_unix(sudo:session): session closed for user root Jan 09 15:52:11 server2 volumio[826]: info: Remote SSH Started Jan 09 15:52:11 server2 autossh[1199]: port set to 0, monitoring disabled Jan 09 15:52:11 server2 autossh[1199]: starting ssh (count 1) Jan 09 15:52:11 server2 autossh[1199]: ssh child pid is 1202 Jan 09 15:52:11 server2 volumio[826]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 6 Jan 09 15:52:12 server2 volumio[826]: info: Setting Geolocation for MyVolumio to eu4 Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::volumioGetState Jan 09 15:52:12 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:12 server2 volumiossh-tunnel[1198]: Warning: Permanently added '[eu1.myvolumio.org]:2222,[68.183.69.189]:2222' (RSA) to the list of known hosts. Jan 09 15:52:12 server2 volumio[826]: info: Setting Geolocation for MyVolumio to eu4 Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:12 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:12 server2 volumio[826]: info: Successfully Added MyVolumio device Jan 09 15:52:13 server2 volumio[826]: info: Updating MyVolumio device info Jan 09 15:52:13 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:13 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:13 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:13 server2 volumio[826]: info: Successfully Added MyVolumio device Jan 09 15:52:13 server2 volumio[826]: info: Updating MyVolumio device info Jan 09 15:52:13 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:13 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:13 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 09 15:52:13 server2 volumio[826]: info: Successfully Updated MyVolumio device Jan 09 15:52:14 server2 volumio[826]: info: Successfully Updated MyVolumio device Jan 09 15:52:18 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 15:52:18 server2 volumio[826]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 7 Jan 09 15:52:18 server2 volumio[826]: info: CoreCommandRouter::volumioGetState Jan 09 15:52:18 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jan 09 15:52:19 server2 volumio[826]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jan 09 15:52:19 server2 volumio[826]: info: Received Get System Version Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 15:52:19 server2 volumio[826]: info: Received Get System Info Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 09 15:52:19 server2 volumio[826]: info: Discovery: Getting this device information Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::volumioGetState Jan 09 15:52:19 server2 volumio[826]: info: CorePlayQueue::getTrack 0 Jan 09 15:52:19 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::volumioGetBrowseSources Jan 09 15:52:23 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 09 15:52:35 server2 volumio[826]: info: CoreCommandRouter::executeOnPlugin: metavolumio , superSearch Jan 09 15:52:35 server2 volumio[826]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 15:52:35 server2 volumio[826]: TypeError: Cannot read property 'then' of undefined Jan 09 15:52:35 server2 volumio[826]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:470:20) Jan 09 15:52:35 server2 volumio[826]: at Socket.emit (events.js:315:20) Jan 09 15:52:35 server2 volumio[826]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Jan 09 15:52:35 server2 volumio[826]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jan 09 15:52:35 server2 volumio[826]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 09 15:52:35 server2 sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-09 15:51 Jan 09 15:52:35 server2 sudo[1212]: 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="b1c3cf61c2a0027c66bab1eb0a3795f80c1f2e95" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e3eb3ee5b16063502f3a1735e11a28cfe54a0f46" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 25 Jun 2023 07:20:58 PM CEST" VOLUMIO_VERSION="3.512" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="946a42b62509f37b5e7e2d86a2932a62"