-- Logs begin at Sun 2024-03-24 19:38:49 CET, end at Fri 2024-03-29 19:01:25 CET. -- Mar 29 19:00:02 rivo volumio[5457]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 19:00:02 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 19:00:20 rivo sudo[27728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 29 19:00:20 rivo sudo[27728]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:00:20 rivo sudo[27728]: pam_unix(sudo:session): session closed for user root Mar 29 19:00:20 rivo sudo[27731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 29 19:00:20 rivo sudo[27731]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:00:20 rivo sudo[27731]: pam_unix(sudo:session): session closed for user root Mar 29 19:00:20 rivo volumio[5457]: verbose: New Socket.io Connection to 192.168.0.253 from 192.168.0.19 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_3_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Total Clients: 10 Mar 29 19:00:20 rivo volumio[5457]: info: CoreCommandRouter::volumioGetState Mar 29 19:00:20 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 29 19:00:20 rivo volumio[5457]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Mar 29 19:00:21 rivo volumio[5457]: info: Listing playlists Mar 29 19:00:21 rivo volumio[5457]: info: CoreCommandRouter::volumioGetQueue Mar 29 19:00:21 rivo volumio[5457]: info: CoreStateMachine::getQueue Mar 29 19:00:21 rivo volumio[5457]: info: CorePlayQueue::getQueue Mar 29 19:00:21 rivo volumio[5457]: info: CoreCommandRouter::volumioGetVisibleSources Mar 29 19:00:21 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 29 19:00:22 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 19:00:26 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout Mar 29 19:00:26 rivo volumio[5457]: info: [MyVolumio PluginManager] Subscribed plan changed to free Mar 29 19:00:26 rivo volumio[5457]: info: MyVolumio status changed Mar 29 19:00:26 rivo volumio[5457]: info: Streaming services startup Mar 29 19:00:26 rivo volumio[5457]: info: Starting Streaming Daemon Mar 29 19:00:26 rivo volumio[5457]: info: [MyVolumio PluginManager] Device deactivated, disabling myvolumio plugins... Mar 29 19:00:26 rivo volumio[5457]: info: ___________ STOPPING MYVOLUMIO PLUGINS ___________ Mar 29 19:00:26 rivo volumio[5457]: info: Mar 29 19:00:26 rivo volumio[5457]: info: MYVOLUMIO LOGGED OUT Mar 29 19:00:26 rivo volumio[5457]: info: Removing browser output: myVolumio user plan is not superstar Mar 29 19:00:26 rivo sudo[27736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 29 19:00:26 rivo sudo[27736]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:00:26 rivo volumio[5457]: info: Removing audio output: Mar 29 19:00:26 rivo volumio[5457]: info: Stoppping Tunnel 1 Mar 29 19:00:26 rivo sudo[27736]: pam_unix(sudo:session): session closed for user root Mar 29 19:00:26 rivo volumio[5457]: error: Cannot start Volumio Streaming Daemon Mar 29 19:00:26 rivo volumio[5457]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 29 19:00:26 rivo volumio[5457]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 29 19:00:26 rivo sudo[27739]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Mar 29 19:00:26 rivo sudo[27739]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:00:26 rivo autossh[27591]: received signal to exit (15) Mar 29 19:00:26 rivo systemd[1]: Stopping MyVolumio SSH Tunnel... Mar 29 19:00:26 rivo systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Mar 29 19:00:26 rivo systemd[1]: sshtunnel.service: Succeeded. Mar 29 19:00:26 rivo volumio[5457]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 19:00:26 rivo systemd[1]: Stopped MyVolumio SSH Tunnel. Mar 29 19:00:26 rivo sudo[27739]: pam_unix(sudo:session): session closed for user root Mar 29 19:00:26 rivo volumio[5457]: info: Remote SSH Stopped Mar 29 19:00:28 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 19:00:28 rivo volumio[5457]: info: MyVolumio not started Mar 29 19:00:28 rivo volumio[5457]: info: Initializing device activation check Mar 29 19:00:28 rivo volumio[5457]: info: MyVolumio not started Mar 29 19:00:28 rivo volumio[5457]: info: Initializing device activation check Mar 29 19:00:28 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 29 19:01:06 rivo volumio[5457]: info: Tunnel connection is inactive, restarting it Mar 29 19:01:06 rivo volumio[5457]: info: Starting Tunnel 1 Mar 29 19:01:06 rivo volumio[5457]: info: Starting Tunnel Connection Checker Mar 29 19:01:07 rivo sudo[27816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 29 19:01:07 rivo sudo[27816]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:01:07 rivo systemd[1]: Started MyVolumio SSH Tunnel. Mar 29 19:01:07 rivo sudo[27816]: pam_unix(sudo:session): session closed for user root Mar 29 19:01:07 rivo volumio[5457]: info: Remote SSH Started Mar 29 19:01:07 rivo volumio[5457]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 9 Mar 29 19:01:07 rivo autossh[27834]: port set to 0, monitoring disabled Mar 29 19:01:07 rivo autossh[27834]: starting ssh (count 1) Mar 29 19:01:07 rivo autossh[27834]: ssh child pid is 27849 Mar 29 19:01:07 rivo volumio[5457]: info: CoreCommandRouter::volumioGetState Mar 29 19:01:11 rivo volumiossh-tunnel[27818]: Warning: Permanently added '[eu4.myvolumio.org]:2222,[167.172.103.77]:2222' (RSA) to the list of known hosts. Mar 29 19:01:21 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Mar 29 19:01:21 rivo volumio[5457]: info: MyVolumio login type: Token Mar 29 19:01:22 rivo volumio[5457]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Mar 29 19:01:22 rivo volumio[5457]: info: MyVolumio token set successfully Mar 29 19:01:22 rivo volumio[5457]: info: MYVOLUMIO: Adding device Mar 29 19:01:22 rivo volumio[5457]: info: MYVOLUMIO: Evaluating Server Mar 29 19:01:23 rivo volumio[5457]: info: MyVolumio Plan changed: premium Mar 29 19:01:23 rivo volumio[5457]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Mar 29 19:01:23 rivo volumio[5457]: info: Removing browser output: myVolumio user plan is not superstar Mar 29 19:01:23 rivo volumio[5457]: info: Removing audio output: Mar 29 19:01:23 rivo volumio[5457]: info: MYVOLUMIO: Adding device Mar 29 19:01:23 rivo volumio[5457]: info: MYVOLUMIO: Evaluating Server Mar 29 19:01:23 rivo volumio[5457]: info: Remote config written successfully Mar 29 19:01:23 rivo volumio[5457]: info: Starting Tunnel 1 Mar 29 19:01:23 rivo volumio[5457]: info: Starting Tunnel Connection Checker Mar 29 19:01:23 rivo sudo[27875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Mar 29 19:01:23 rivo sudo[27875]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:01:23 rivo autossh[27834]: received signal to exit (15) Mar 29 19:01:23 rivo systemd[1]: Stopping MyVolumio SSH Tunnel... Mar 29 19:01:23 rivo systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Mar 29 19:01:23 rivo systemd[1]: sshtunnel.service: Succeeded. Mar 29 19:01:23 rivo systemd[1]: Stopped MyVolumio SSH Tunnel. Mar 29 19:01:23 rivo systemd[1]: Started MyVolumio SSH Tunnel. Mar 29 19:01:23 rivo sudo[27875]: pam_unix(sudo:session): session closed for user root Mar 29 19:01:23 rivo autossh[27895]: port set to 0, monitoring disabled Mar 29 19:01:23 rivo autossh[27895]: starting ssh (count 1) Mar 29 19:01:23 rivo autossh[27895]: ssh child pid is 27910 Mar 29 19:01:24 rivo volumio[5457]: info: MYVolumio Device enabled Mar 29 19:01:24 rivo volumio[5457]: info: MyVolumio status changed Mar 29 19:01:24 rivo volumio[5457]: info: Streaming services startup Mar 29 19:01:24 rivo volumio[5457]: info: Starting Streaming Daemon Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Mar 29 19:01:24 rivo volumio[5457]: ------------------------------------ BT MESSAGE: BT STATUS: running Mar 29 19:01:24 rivo volumio[5457]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Mar 29 19:01:24 rivo sudo[27948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Mar 29 19:01:24 rivo sudo[27948]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 29 19:01:24 rivo volumio[5457]: info: Setting Geolocation for MyVolumio to eu4 Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 19:01:24 rivo volumio[5457]: info: Remote SSH Started Mar 29 19:01:24 rivo sudo[27948]: pam_unix(sudo:session): session closed for user root Mar 29 19:01:24 rivo volumio[5457]: error: Cannot start Volumio Streaming Daemon Mar 29 19:01:24 rivo volumio[5457]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Mar 29 19:01:24 rivo volumio[5457]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Mar 29 19:01:24 rivo volumio[5457]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Total Clients: 10 Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Mar 29 19:01:24 rivo volumio[5457]: error: [MyVolumio PluginManager] Cache data is invalid! Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::volumioGetState Mar 29 19:01:24 rivo volumio[5457]: info: Setting Geolocation for MyVolumio to eu4 Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 19:01:24 rivo volumio[5457]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 29 19:01:24 rivo volumio[5457]: info: Successfully Added MyVolumio device Mar 29 19:01:24 rivo volumio[5457]: info: Successfully Added MyVolumio device Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin audio_interface/bluetooth is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin audio_interface/multiroom is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin miscellanea/metavolumio is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin miscellanea/manifestui is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin music_service/cd_controller is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin music_service/smart_inputs is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin music_service/hi_res_audio is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin music_service/tidal is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin music_service/qobuz is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: info: [MyVolumio PluginManager] Plugin music_service/tidalconnect is enabled for this plan, but could not be found on the local filesystem! Mar 29 19:01:24 rivo volumio[5457]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 19:01:24 rivo volumio[5457]: Error: Unable to resolve or reject the same promise twice Mar 29 19:01:24 rivo volumio[5457]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 29 19:01:24 rivo volumio[5457]: at Array. (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5676) Mar 29 19:01:24 rivo volumio[5457]: at Promise.reject (/volumio/node_modules/kew/kew.js:204:26) Mar 29 19:01:24 rivo volumio[5457]: at nextTickCallback (/volumio/node_modules/kew/kew.js:49:11) Mar 29 19:01:24 rivo volumio[5457]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Mar 29 19:01:24 rivo volumio[5457]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 29 19:01:25 rivo sudo[27959]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-29 19:00 Mar 29 19:01:25 rivo sudo[27959]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="e831866afe2db61aee9333a8f5ba9d9fd36609c7" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="rivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sun 18 Feb 2024 11:41:55 AM CET" VOLUMIO_VERSION="3.629" VOLUMIO_HARDWARE="mp1" VOLUMIO_DEVICENAME="Volumio MP1" VOLUMIO_VENDOR_MODEL="Volumio Rivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Rivo" VOLUMIO_HASH="b0437c7088d6645a661a49f6d9fa596a"