Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: verbose: New Socket.io Connection to 192.168.2.119 from 192.168.2.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: Listing playlists Aug 30 12:38:02 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 12:38:03 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:03 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:05 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:38:05 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 12:38:18 wizard-demo-dynamic-solutions sudo[18923]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 12:38:18 wizard-demo-dynamic-solutions sudo[18923]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:38:18 wizard-demo-dynamic-solutions sudo[18923]: pam_unix(sudo:session): session closed for user root Aug 30 12:38:18 wizard-demo-dynamic-solutions sudo[18925]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 12:38:18 wizard-demo-dynamic-solutions sudo[18925]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:38:18 wizard-demo-dynamic-solutions sudo[18925]: pam_unix(sudo:session): session closed for user root Aug 30 12:38:18 wizard-demo-dynamic-solutions volumio[1240]: verbose: New Socket.io Connection to 192.168.2.119 from 192.168.2.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: Listing playlists Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 12:38:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 12:38:29 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Version Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:37 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:43 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:43 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions sudo[18974]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 12:38:44 wizard-demo-dynamic-solutions sudo[18974]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:38:44 wizard-demo-dynamic-solutions sudo[18974]: pam_unix(sudo:session): session closed for user root Aug 30 12:38:44 wizard-demo-dynamic-solutions sudo[18976]: volumio : PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 12:38:44 wizard-demo-dynamic-solutions sudo[18976]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:38:44 wizard-demo-dynamic-solutions sudo[18976]: pam_unix(sudo:session): session closed for user root Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: verbose: New Socket.io Connection to 192.168.2.119 from 192.168.2.53 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/152.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 11 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: Listing playlists Aug 30 12:38:44 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:38:46 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:38:49 wizard-demo-dynamic-solutions volumio[1240]: error: error Aug 30 12:38:54 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 12:39:03 wizard-demo-dynamic-solutions volumio[1240]: info: MYVolumio Device disabled Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Subscribed plan changed to free Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO LOGGED OUT Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: Removing browser output: myVolumio user plan is not superstar Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: Removing audio output: Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: Stoppping Tunnel 1 Aug 30 12:39:10 wizard-demo-dynamic-solutions sudo[19014]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 30 12:39:10 wizard-demo-dynamic-solutions sudo[19014]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:10 wizard-demo-dynamic-solutions autossh[11411]: received signal to exit (15) Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: sshtunnel.service: Deactivated successfully. Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: sshtunnel.service: Consumed 12.087s CPU time. Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:10 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:10 wizard-demo-dynamic-solutions sudo[19014]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:10 wizard-demo-dynamic-solutions volumio[1240]: info: Remote SSH Stopped Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio not started Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: Initializing device activation check Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio not started Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: Initializing device activation check Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:39:12 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:39:17 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken Aug 30 12:39:17 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio login type: Token Aug 30 12:39:17 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:39:18 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Aug 30 12:39:18 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio token set successfully Aug 30 12:39:18 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO: Adding device Aug 30 12:39:18 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO: Evaluating Server Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio Plan changed: premium Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Removing browser output: myVolumio user plan is not superstar Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Removing audio output: Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO: Adding device Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO: Evaluating Server Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Remote config written successfully Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Starting Tunnel 1 Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Starting Tunnel Connection Checker Aug 30 12:39:19 wizard-demo-dynamic-solutions sudo[19060]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Aug 30 12:39:19 wizard-demo-dynamic-solutions sudo[19060]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:19 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:19 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:19 wizard-demo-dynamic-solutions systemd[1]: Started sshtunnel.service - MyVolumio SSH Tunnel. Aug 30 12:39:19 wizard-demo-dynamic-solutions sudo[19060]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:19 wizard-demo-dynamic-solutions autossh[19070]: port set to 0, monitoring disabled Aug 30 12:39:19 wizard-demo-dynamic-solutions autossh[19070]: starting ssh (count 1) Aug 30 12:39:19 wizard-demo-dynamic-solutions autossh[19070]: ssh child pid is 19074 Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: MYVolumio Device disabled Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Setting Geolocation for MyVolumio to eu2 Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Remote SSH Started Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:39:19 wizard-demo-dynamic-solutions volumiossh-tunnel[19074]: Warning: Permanently added '[eu5.myvolumio.org]:2222' (RSA) to the list of known hosts. Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: Setting Geolocation for MyVolumio to eu2 Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:19 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: Successfully Added MyVolumio device Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: MYVolumio Device enabled Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio status changed Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: Streaming services startup Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: Starting Streaming Daemon Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19086]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19086]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: error: [MyVolumio PluginManager] Cache data is invalid! Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19086]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: error: Cannot start Volumio Streaming Daemon Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: Updating MyVolumio device info Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: Successfully Added MyVolumio device Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin bluetooth Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [FUNC] onVolumioStart Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19105]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: /usr/bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: MultiRoom plugin initialized Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: STOPPING SNAPCLIENT Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Snap server stop Aug 30 12:39:20 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: STOPPING volumioStreaming Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19124]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19124]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19126]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Aug 30 12:39:20 wizard-demo-dynamic-solutions sudo[19126]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19130]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19130]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19134]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19134]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19134]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19126]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19124]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19130]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Preparing to generate the ALSA configuration file Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Updating MyVolumio device info Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Successfully Updated MyVolumio device Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Removed streaming files Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: volumioStreaming STOPPED Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: SNAPSERVER STOPPED Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: SNAPCLIENT STOPPED Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Asound.conf file written Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19139]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19139]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19139]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:0 use case configuration -2 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:1 use case configuration -2 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:2 use case configuration -2 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: alsa-lib main.c:1541:(snd_use_case_mgr_open) error: failed to import hw:3 use case configuration -2 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Digital Playback Volume:0' : Remote I/O error Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: /usr/sbin/alsactl: set_control:1475: Cannot write control '2:0:0:Digital Playback Switch:0' : Remote I/O error Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Output device has changed, restarting MPD Aug 30 12:39:21 wizard-demo-dynamic-solutions kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000020] -121 Aug 30 12:39:21 wizard-demo-dynamic-solutions kernel: i-sabre-codec-i2c 1-0048: ASoC: error at snd_soc_component_update_bits on i-sabre-codec-i2c.1-0048 for register: [0x00000021] -121 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Output device has changed, restarting Shairport Sync Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19147]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19147]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19147]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: QobuzConnect: setDeactiveState invoked Aug 30 12:39:21 wizard-demo-dynamic-solutions systemd[1]: Stopping mpd.service - Music Player Daemon... Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [FUNC] onStart Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: Starting Volumio Bluetooth Service Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19159]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19159]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: Boot config /etc/bluetooth/volumio.conf: cache mode = tmp Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [metaCache] Directory exists and is ready. Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Pushing multiroomSync output for this device Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Pushing multiroomSync output Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding audio output: Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: error: Can't add: Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding audio output: Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: error: Can't add: Aug 30 12:39:21 wizard-demo-dynamic-solutions sudo[19159]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:21 wizard-demo-dynamic-solutions bluetoothd[937]: Path / reserved for Adv Monitor app :1.44 Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding METAVOLUMIO REST API Endpoints Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Preparing CD Folders Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Adding CD REST API Endpoints Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Updating cdPostRip REST Endpoint for plugin: music_service/cd_controller Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Starting UDEV Watcher for CD Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: Detecting CD presence with UDEV Aug 30 12:39:21 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Aug 30 12:39:21 wizard-demo-dynamic-solutions bluetoothd[937]: Adv Monitor app :1.44 disconnected from D-Bus Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: mpd.service: Deactivated successfully. Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: Stopped mpd.service - Music Player Daemon. Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: mpd.service: Consumed 10.711s CPU time. Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: mpd.socket: Deactivated successfully. Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Aug 30 12:39:23 wizard-demo-dynamic-solutions systemd[1]: Starting mpd.service - Music Player Daemon... Aug 30 12:39:23 wizard-demo-dynamic-solutions sudo[19174]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 12:39:23 wizard-demo-dynamic-solutions sudo[19174]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Aug 30 12:39:23 wizard-demo-dynamic-solutions sudo[19174]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: warn: [cd-plugin] cdspeedctl: device or media not ready Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Adding inputs REST Endpoints Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Updating scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Scanning Audio Inputs Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Checking against Known Cards name Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Adding Server instance for streaming Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: error: Hi Res Audio Failed Login: Missing Login Data Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Adding HIGHRESAUDIO REST API Endpoints Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Updating saveAccountData_hi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Updating qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19181]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19181]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: QobuzConnect: Starting Qobuz Connect socket and service Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Adding TIDAL REST API Endpoints Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Stopping AccessToken refresher cron for QOBUZ Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19188]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19188]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19181]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19188]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19191]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19191]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: AccessToken refresher cron started for QOBUZ Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Adding QOBUZ REST API Endpoints Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19194]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19194]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Getting audio outputs on start Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: MRS: Requesting all other devices output Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19202]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19202]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Successfully Updated MyVolumio device Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: Started qobuz-connect.service - Volumio Qobuz Connect Service. Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , myVolumioLogout Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Subscribed plan changed to free Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: [MyVolumio PluginManager] Device deactivated, disabling myvolumio plugins... Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: ___________ STOPPING MYVOLUMIO PLUGINS ___________ Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [FUNC] onStop Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [FUNC] btAudioOutput Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [dbus-next] Disabling Bluetooth Audio Output Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing METAVOLUMIO REST API Endpoints Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing metavolumio REST Endpoint Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing getSimilarArtists REST Endpoint Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing getSimilarAlbums REST Endpoint Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing getSimilarTracks REST Endpoint Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesAudio CD Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19191]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: Cannot find translation for source Spotify Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Stopping UDEV Watcher for CD Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removeing all smart Inputs Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesTIDAL Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: Cannot find translation for source Spotify Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Stopping AccessToken refresher cron for QOBUZ Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesQOBUZ Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: Cannot find translation for source Spotify Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: QobuzConnect: setDeactiveState invoked Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: MyVolumio status changed Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Streaming services startup Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Starting Streaming Daemon Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19202]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Received Get System Info Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Discovery: Getting this device information Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::volumioGetState Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CorePlayQueue::getTrack 0 Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19194]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: Bluetooth audio output stopped Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: [FUNC] stopBTStack Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19205]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19207]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19207]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19208]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19205]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19208]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: MYVOLUMIO LOGGED OUT Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing browser output: myVolumio user plan is not superstar Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Removing audio output: Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Stoppping Tunnel 1 Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19214]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumiobt.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19214]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19216]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19216]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: ------------------------------------ BT MESSAGE: Bluetooth adapter powered on Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19208]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: TidalConnect service stoped! Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19219]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop qobuz-connect Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19219]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: MPD Permissions set Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: error: Cannot start Volumio Streaming Daemon Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: Stopping qobuz-connect.service - Volumio Qobuz Connect Service... Aug 30 12:39:27 wizard-demo-dynamic-solutions autossh[19070]: received signal to exit (15) Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: Stopping sshtunnel.service - MyVolumio SSH Tunnel... Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19207]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: sshtunnel.service: Deactivated successfully. Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19222]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: Stopped sshtunnel.service - MyVolumio SSH Tunnel. Aug 30 12:39:27 wizard-demo-dynamic-solutions sudo[19222]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: qobuz-connect.service: Deactivated successfully. Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: Stopped qobuz-connect.service - Volumio Qobuz Connect Service. Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:27 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: Executing endpoint qc_getconfig Aug 30 12:39:27 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Aug 30 12:39:28 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:28 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19214]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19205]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:28 wizard-demo-dynamic-solutions systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether. Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19216]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19219]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: error: QobuzConnect: could not execute /bin/systemctl to restart qobuz connect process. Reason: Job for qobuz-connect.service canceled. Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: [UnhandledPromiseRejection: This error originated either by throwing inside of an async function without a catch block, or by rejecting a promise which was not handled with .catch(). The promise rejected with the reason "undefined".] { Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: code: 'ERR_UNHANDLED_REJECTION' Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: } Aug 30 12:39:28 wizard-demo-dynamic-solutions volumio[1240]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 12:39:28 wizard-demo-dynamic-solutions systemd[1]: Started volumiobt.service - Volumio Bluetooth Module. Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19222]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19245]: INFO [BTSTART] Ensuring Bluetooth directory exists... Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19246]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/mkdir -p /var/lib/bluetooth Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19246]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19246]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19248]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod -R 777 /var/lib/bluetooth Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19248]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Aug 30 12:39:28 wizard-demo-dynamic-solutions sudo[19248]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19251]: INFO [BTSTART] Powering on Bluetooth if needed... Aug 30 12:39:28 wizard-demo-dynamic-solutions bluetoothd[937]: Adv Monitor app :1.47 disconnected from D-Bus Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19254]: INFO [BTSTART] Making Bluetooth discoverable and pairable... Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [176B blob data] Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [157B blob data] Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [157B blob data] Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [157B blob data] Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [113B blob data] Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [bluetoothctl]> discoverable on Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: Warning: setting discoverable while discoverable-timeout not set(0) is not recommended Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [bluetoothctl]> pairable on Aug 30 12:39:28 wizard-demo-dynamic-solutions bluetoothd[937]: Path / reserved for Adv Monitor app :1.48 Aug 30 12:39:28 wizard-demo-dynamic-solutions bluetoothd[937]: Adv Monitor app :1.48 disconnected from D-Bus Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19255]: [bluetoothctl]> Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19256]: INFO [BTSTART] Registering Bluetooth agent... Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19257]: [NEW] Media /org/bluez/hci0 Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19257]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19257]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19257]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Aug 30 12:39:28 wizard-demo-dynamic-solutions bluetoothd[937]: Adv Monitor app :1.49 disconnected from D-Bus Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19258]: No agent is registered Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19258]: [NEW] Media /org/bluez/hci0 Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19258]: SupportedUUIDs: 0000110a-0000-1000-8000-00805f9b34fb Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19258]: SupportedUUIDs: 0000110b-0000-1000-8000-00805f9b34fb Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19258]: SupportedUUIDs: 0000FDF0-0000-1000-8000-00805f9b34fb Aug 30 12:39:28 wizard-demo-dynamic-solutions bluetoothd[937]: Adv Monitor app :1.50 disconnected from D-Bus Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19259]: INFO [BTSTART] Agent registered successfully. Aug 30 12:39:28 wizard-demo-dynamic-solutions volumiobt[19260]: INFO [BTSTART] Starting A2DP agent (a2dp-agent)... Aug 30 12:39:31 wizard-demo-dynamic-solutions mpd[19176]: decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 12:39:31 wizard-demo-dynamic-solutions mpd[19176]: output: No 'audio_output' defined in config file Aug 30 12:39:31 wizard-demo-dynamic-solutions mpd[19176]: output: Successfully detected a sndio audio device Aug 30 12:39:31 wizard-demo-dynamic-solutions mpd[19176]: zeroconf: No global port, disabling zeroconf Aug 30 12:39:31 wizard-demo-dynamic-solutions systemd[1]: Started mpd.service - Music Player Daemon. Aug 30 12:39:31 wizard-demo-dynamic-solutions sudo[19149]: pam_unix(sudo:session): session closed for user root Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Connecting to system D-Bus Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Connected to system D-Bus Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 bluezutils [INFO] Found adapter at: /org/bluez/hci0 Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Found Bluetooth adapter: /org/bluez/hci0 Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Set DiscoverableTimeout to infinite Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Enabled Discoverable mode Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Agent registered at /local/a2dpagent Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] Agent set as default Aug 30 12:39:31 wizard-demo-dynamic-solutions volumiobt[19261]: 2026-08-30 12:39:31 a2dp-agent [INFO] A2DP agent running, waiting for connections... Aug 30 12:39:32 wizard-demo-dynamic-solutions sudo[19289]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-08-30 12:38' Aug 30 12:39:32 wizard-demo-dynamic-solutions sudo[19289]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="18952480e8d8c63f22208e9007a0f47a9563eae6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026" VOLUMIO_VERSION="4.119" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"