-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Fri 2024-07-12 18:10:08 CEST. -- Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 18:09:52 motivo volumio[917]: info: Discovery: Getting this device information Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:09:52 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 18:09:52 motivo volumio[917]: info: Discovery: Getting this device information Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:09:52 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 18:09:52 motivo volumio[917]: info: Discovery: Getting this device information Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:09:52 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:09:52 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 18:09:56 motivo volumio[917]: verbose: New Socket.io Connection to 192.168.1.152:3000 from 192.168.1.53 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 11 Jul 12 18:09:57 motivo sudo[29894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 12 18:09:57 motivo sudo[29894]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 18:09:57 motivo sudo[29894]: pam_unix(sudo:session): session closed for user root Jul 12 18:09:57 motivo sudo[29897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 12 18:09:57 motivo sudo[29897]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 18:09:57 motivo sudo[29897]: pam_unix(sudo:session): session closed for user root Jul 12 18:09:57 motivo volumio[917]: verbose: New Socket.io Connection to 192.168.1.152 from 192.168.1.53 UA: Mozilla/5.0 (Linux; Android 14; A065 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/126.0.6478.134 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 12 18:09:57 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 12 18:09:57 motivo sudo[29900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 12 18:09:57 motivo sudo[29900]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 18:09:57 motivo sudo[29900]: pam_unix(sudo:session): session closed for user root Jul 12 18:09:57 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 12 18:09:57 motivo sudo[29903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 12 18:09:57 motivo sudo[29903]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 18:09:57 motivo sudo[29903]: pam_unix(sudo:session): session closed for user root Jul 12 18:09:58 motivo volumio[917]: verbose: New Socket.io Connection to 192.168.1.152 from 192.168.1.53 UA: Mozilla/5.0 (Linux; Android 14; A065 Build/UP1A.231005.007; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/126.0.6478.134 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetVisibleSources Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetQueue Jul 12 18:09:58 motivo volumio[917]: info: CoreStateMachine::getQueue Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getQueue Jul 12 18:09:58 motivo volumio[917]: info: Listing playlists Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 12 18:09:58 motivo volumio[917]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 12 18:09:58 motivo volumio[917]: info: Received Get System Info Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 18:09:58 motivo volumio[917]: info: Discovery: Getting this device information Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:09:58 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 12 18:09:58 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 18:10:00 motivo volumio[917]: info: Received Get System Info Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 18:10:00 motivo volumio[917]: info: Discovery: Getting this device information Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:10:00 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 18:10:00 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 12 18:10:05 motivo volumio[917]: info: Received Get System Info Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 12 18:10:05 motivo volumio[917]: info: Discovery: Getting this device information Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:10:05 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 12 18:10:05 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Jul 12 18:10:05 motivo volumio[917]: info: MyVolumio login type: Token Jul 12 18:10:06 motivo volumio[917]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jul 12 18:10:07 motivo volumio[917]: info: MyVolumio token set successfully Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Adding device Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Evaluating Server Jul 12 18:10:07 motivo volumio[917]: info: MyVolumio Plan changed: superstar Jul 12 18:10:07 motivo volumio[917]: info: [MyVolumio PluginManager] Subscribed plan changed to superstar Jul 12 18:10:07 motivo volumio[917]: info: Adding audio output: Jul 12 18:10:07 motivo volumio[917]: error: Can't add: Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Adding device Jul 12 18:10:07 motivo volumio[917]: info: MYVOLUMIO: Evaluating Server Jul 12 18:10:07 motivo volumio[917]: info: Remote config written successfully Jul 12 18:10:07 motivo volumio[917]: info: Starting Tunnel 1 Jul 12 18:10:07 motivo volumio[917]: info: Starting Tunnel Connection Checker Jul 12 18:10:07 motivo sudo[29969]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jul 12 18:10:07 motivo sudo[29969]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 18:10:07 motivo autossh[20493]: received signal to exit (15) Jul 12 18:10:07 motivo systemd[1]: Stopping MyVolumio SSH Tunnel... Jul 12 18:10:07 motivo systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Jul 12 18:10:07 motivo systemd[1]: sshtunnel.service: Succeeded. Jul 12 18:10:07 motivo systemd[1]: Stopped MyVolumio SSH Tunnel. Jul 12 18:10:07 motivo volumio[917]: ------------------------------------ BT MESSAGE: BT STATUS: running Jul 12 18:10:07 motivo volumio[917]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jul 12 18:10:07 motivo systemd[1]: Started MyVolumio SSH Tunnel. Jul 12 18:10:07 motivo sudo[29969]: pam_unix(sudo:session): session closed for user root Jul 12 18:10:07 motivo autossh[29973]: port set to 0, monitoring disabled Jul 12 18:10:07 motivo autossh[29973]: starting ssh (count 1) Jul 12 18:10:07 motivo autossh[29973]: ssh child pid is 29976 Jul 12 18:10:07 motivo volumiossh-tunnel[29972]: Warning: Permanently added '[eu6.myvolumio.org]:2222,[207.154.233.230]:2222' (RSA) to the list of known hosts. Jul 12 18:10:07 motivo volumio[917]: info: MYVolumio Device enabled Jul 12 18:10:07 motivo volumio[917]: info: MyVolumio status changed Jul 12 18:10:07 motivo volumio[917]: info: Streaming services startup Jul 12 18:10:07 motivo volumio[917]: info: Starting Streaming Daemon Jul 12 18:10:07 motivo volumio[917]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jul 12 18:10:07 motivo volumio[917]: info: Setting Geolocation for MyVolumio to eu6 Jul 12 18:10:07 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 18:10:07 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 18:10:07 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 18:10:07 motivo sudo[29993]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jul 12 18:10:07 motivo sudo[29993]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 12 18:10:07 motivo volumio[917]: info: Remote SSH Started Jul 12 18:10:07 motivo sudo[29993]: pam_unix(sudo:session): session closed for user root Jul 12 18:10:08 motivo volumio[917]: error: Cannot start Volumio Streaming Daemon Jul 12 18:10:08 motivo volumio[917]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jul 12 18:10:08 motivo volumio[917]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jul 12 18:10:08 motivo volumio[917]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 14 Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jul 12 18:10:08 motivo volumio[917]: error: [MyVolumio PluginManager] Cache data is invalid! Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::volumioGetState Jul 12 18:10:08 motivo volumio[917]: info: CorePlayQueue::getTrack 0 Jul 12 18:10:08 motivo volumio[917]: info: Setting Geolocation for MyVolumio to eu6 Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 18:10:08 motivo volumio[917]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 12 18:10:08 motivo volumio[917]: info: Successfully Added MyVolumio device Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin audio_interface/bluetooth is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin audio_interface/multiroom is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin miscellanea/metavolumio is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin miscellanea/manifestui is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/cd_controller is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/smart_inputs is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/hi_res_audio is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/tidal is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/qobuz is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: info: [MyVolumio PluginManager] Plugin music_service/tidalconnect is enabled for this plan, but could not be found on the local filesystem! Jul 12 18:10:08 motivo volumio[917]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 18:10:08 motivo volumio[917]: Error: Unable to resolve or reject the same promise twice Jul 12 18:10:08 motivo volumio[917]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jul 12 18:10:08 motivo volumio[917]: at Array. (/myvolumio/app/myvolumio-pluginmanager/myvolumio_pluginmanager_real:1:5676) Jul 12 18:10:08 motivo volumio[917]: at Promise.reject (/volumio/node_modules/kew/kew.js:204:26) Jul 12 18:10:08 motivo volumio[917]: at nextTickCallback (/volumio/node_modules/kew/kew.js:49:11) Jul 12 18:10:08 motivo volumio[917]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jul 12 18:10:08 motivo volumio[917]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 12 18:10:08 motivo sudo[30004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-12 18:09 Jul 12 18:10:08 motivo sudo[30004]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="905ee02fb5387537cfa16b84ebd7f14b7640848e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="motivo" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 10 Jul 2024 02:28:54 PM CEST" VOLUMIO_VERSION="3.736" VOLUMIO_HARDWARE="cm4" VOLUMIO_DEVICENAME="CM4" VOLUMIO_VENDOR_MODEL="Volumio Motivo" VOLUMIO_VENDOR="Volumio" VOLUMIO_MODEL="Motivo" VOLUMIO_HASH="28d513e532d28202d6c8000674492903"