-- Logs begin at Thu 2019-02-14 03:11:59 MST, end at Wed 2024-08-21 15:15:20 MDT. -- Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:00 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:00 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:00 volumiopi2 volumio[933]: verbose: New Socket.io Connection to 192.168.0.186:3000 from 192.168.0.102 UA: Dart/3.4 (dart:io) Total Clients: 5 Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:00 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 21 15:14:00 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 21 15:14:03 volumiopi2 sudo[13174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 21 15:14:03 volumiopi2 sudo[13174]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:14:03 volumiopi2 sudo[13174]: pam_unix(sudo:session): session closed for user root Aug 21 15:14:03 volumiopi2 sudo[13177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 21 15:14:03 volumiopi2 sudo[13177]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:14:03 volumiopi2 sudo[13177]: pam_unix(sudo:session): session closed for user root Aug 21 15:14:03 volumiopi2 volumio[933]: verbose: New Socket.io Connection to 192.168.0.186 from 192.168.0.102 UA: Mozilla/5.0 (Linux; Android 11; GM1915 Build/RKQ1.201022.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Total Clients: 6 Aug 21 15:14:04 volumiopi2 sudo[13180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 21 15:14:04 volumiopi2 sudo[13180]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:14:04 volumiopi2 sudo[13180]: pam_unix(sudo:session): session closed for user root Aug 21 15:14:04 volumiopi2 sudo[13183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 21 15:14:04 volumiopi2 sudo[13183]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:14:04 volumiopi2 sudo[13183]: pam_unix(sudo:session): session closed for user root Aug 21 15:14:04 volumiopi2 volumio[933]: verbose: New Socket.io Connection to 192.168.0.186 from 192.168.0.102 UA: Mozilla/5.0 (Linux; Android 11; GM1915 Build/RKQ1.201022.002; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/127.0.6533.103 Mobile Safari/537.36 Total Clients: 7 Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetVisibleSources Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:04 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 21 15:14:04 volumiopi2 volumio[933]: info: Received Get System Info Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:04 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:04 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:04 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:04 volumiopi2 volumio[933]: info: Listing playlists Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 21 15:14:04 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:05 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:05 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:05 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:05 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:05 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:05 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:06 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 21 15:14:06 volumiopi2 volumio[933]: info: Received Get System Info Aug 21 15:14:06 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:06 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:06 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:06 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:06 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:06 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:07 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 21 15:14:07 volumiopi2 volumio[933]: info: Received Get System Info Aug 21 15:14:07 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:07 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:07 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:07 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:07 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:07 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 21 15:14:23 volumiopi2 volumio[933]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 21 15:14:23 volumiopi2 volumio[933]: info: Received Get System Version Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 21 15:14:23 volumiopi2 volumio[933]: info: Received Get System Info Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:23 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:23 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:23 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:29 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:29 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:29 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:29 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:29 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:29 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:14:30 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:30 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Aug 21 15:14:31 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:41 volumiopi2 volumio[933]: info: Retrieving Cloud Streaming UI Aug 21 15:14:41 volumiopi2 volumio[933]: info: Getting Tidal Cloud Configuration Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:41 volumiopi2 volumio[933]: info: Getting Qobuz Cloud Configuration Aug 21 15:14:41 volumiopi2 volumio[933]: info: Asking plugin for UI Config Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:41 volumiopi2 volumio[933]: info: Getting Spotify Cloud Configuration Aug 21 15:14:41 volumiopi2 volumio[933]: info: Asking plugin for UI Config Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:41 volumiopi2 volumio[933]: info: Saving Spotify Acccount Aug 21 15:14:41 volumiopi2 volumio[933]: info: Got Tidal Cloud Configuration Aug 21 15:14:41 volumiopi2 volumio[933]: info: Got it Aug 21 15:14:41 volumiopi2 volumio[933]: info: Got it Aug 21 15:14:41 volumiopi2 volumio[933]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:41 volumiopi2 volumio[933]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetBrowseSources Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 21 15:14:41 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand update Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:14:43 volumiopi2 volumio[933]: info: Aug 21 15:14:43 volumiopi2 volumio[933]: ---------------------------- MPD announces state update: update Aug 21 15:14:43 volumiopi2 volumio[933]: info: sendMpdCommand update took 6 milliseconds Aug 21 15:14:43 volumiopi2 volumio[933]: info: ControllerMpd::getState Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:14:43 volumiopi2 volumio[933]: info: Aug 21 15:14:43 volumiopi2 volumio[933]: ---------------------------- MPD announces state update: update Aug 21 15:14:43 volumiopi2 volumio[933]: info: ControllerMpd::getState Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:14:43 volumiopi2 volumio[933]: info: sendMpdCommand status took 10 milliseconds Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:14:43 volumiopi2 volumio[933]: info: Command Router : Notfying DB Updatetrue Aug 21 15:14:43 volumiopi2 volumio[933]: info: sendMpdCommand status took 55 milliseconds Aug 21 15:14:43 volumiopi2 volumio[933]: info: sendMpdCommand status took 55 milliseconds Aug 21 15:14:43 volumiopi2 volumio[933]: info: sendMpdCommand status took 54 milliseconds Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:14:43 volumiopi2 volumio[933]: info: Command Router : Notfying DB Updatetrue Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::Close All Modals sent Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:14:43 volumiopi2 volumio[933]: info: ControllerMpd::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::servicePushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: CURRENT POSITION 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::syncState stateService stop Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::syncState currentStatus stop Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: No code Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: ControllerMpd::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::servicePushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 21 15:14:43 volumiopi2 volumio[933]: verbose: CURRENT POSITION 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::syncState stateService stop Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::syncState currentStatus stop Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: No code Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:43 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:14:43 volumiopi2 volumio[933]: info: ------------------------------ 116ms Aug 21 15:14:43 volumiopi2 volumio[933]: info: ------------------------------ 125ms Aug 21 15:14:45 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 21 15:14:49 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 21 15:14:55 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 21 15:14:55 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 21 15:14:55 volumiopi2 volumio[933]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 21 15:14:59 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 21 15:14:59 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 21 15:14:59 volumiopi2 volumio[933]: info: Discovery: Getting this device information Aug 21 15:14:59 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioGetState Aug 21 15:14:59 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:14:59 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 21 15:15:06 volumiopi2 volumio[933]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Aug 21 15:15:08 volumiopi2 volumio[933]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Aug 21 15:15:08 volumiopi2 volumio[933]: info: FusionDsp - Stopping FusionDsp service Aug 21 15:15:08 volumiopi2 volumio[933]: info: camilladsp stopping service pid 13079... Aug 21 15:15:08 volumiopi2 volumio[933]: info: camilladsp service terminated, instance 1 Aug 21 15:15:08 volumiopi2 sudo[13243]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Aug 21 15:15:08 volumiopi2 sudo[13243]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:15:08 volumiopi2 systemd[1]: Stopping FusionDsp Daemon... Aug 21 15:15:08 volumiopi2 volumio[1167]: Backend configuration: Aug 21 15:15:08 volumiopi2 volumio[1167]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Aug 21 15:15:08 volumiopi2 volumio[1167]: active_config_txt: null Aug 21 15:15:08 volumiopi2 volumio[1167]: camilla_host: 127.0.0.1 Aug 21 15:15:08 volumiopi2 volumio[1167]: camilla_port: 9876 Aug 21 15:15:08 volumiopi2 volumio[1167]: coeff_dir: /data/INTERNAL/FusionDsp/filters Aug 21 15:15:08 volumiopi2 volumio[1167]: config_dir: /data/configuration/audio_interface/fusiondsp Aug 21 15:15:08 volumiopi2 volumio[1167]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Aug 21 15:15:08 volumiopi2 volumio[1167]: log_file: /tmp/camilladsp.log Aug 21 15:15:08 volumiopi2 volumio[1167]: on_get_active_config: null Aug 21 15:15:08 volumiopi2 volumio[1167]: on_set_active_config: null Aug 21 15:15:08 volumiopi2 volumio[1167]: port: 5011 Aug 21 15:15:08 volumiopi2 volumio[1167]: supported_capture_types: null Aug 21 15:15:08 volumiopi2 volumio[1167]: supported_playback_types: null Aug 21 15:15:08 volumiopi2 volumio[1167]: update_config_symlink: false Aug 21 15:15:08 volumiopi2 volumio[1167]: update_config_txt: false Aug 21 15:15:08 volumiopi2 volumio[1167]: ======== Running on http://0.0.0.0:5011 ======== Aug 21 15:15:08 volumiopi2 volumio[1167]: (Press CTRL+C to quit) Aug 21 15:15:08 volumiopi2 systemd[1]: fusiondsp.service: Succeeded. Aug 21 15:15:08 volumiopi2 systemd[1]: Stopped FusionDsp Daemon. Aug 21 15:15:08 volumiopi2 sudo[13243]: pam_unix(sudo:session): session closed for user root Aug 21 15:15:08 volumiopi2 volumio[933]: info: FusionDsp - Reporting Fusion DSP Disabled Aug 21 15:15:08 volumiopi2 volumio[933]: info: Removing fusiondspeq DSP Signal Path Element Aug 21 15:15:08 volumiopi2 volumio[933]: info: Check plugin dependencies Aug 21 15:15:08 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 21 15:15:08 volumiopi2 volumio[933]: info: Rename folder Aug 21 15:15:08 volumiopi2 volumio[933]: info: Folder /tmp/downloaded_plugin.zip removed Aug 21 15:15:08 volumiopi2 volumio[933]: info: Move to category Aug 21 15:15:09 volumiopi2 volumio[933]: info: Checking if install.sh is present Aug 21 15:15:09 volumiopi2 volumio[933]: info: Executing install.sh Aug 21 15:15:09 volumiopi2 sudo[13257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Aug 21 15:15:09 volumiopi2 sudo[13257]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:15:09 volumiopi2 volumio[933]: info: creating filters folder and copying demo filters Aug 21 15:15:09 volumiopi2 volumio[933]: info: copying demo flters Aug 21 15:15:09 volumiopi2 volumio[933]: info: Installing/fusiondsp dependencies Aug 21 15:15:09 volumiopi2 sudo[13278]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt update Aug 21 15:15:09 volumiopi2 sudo[13278]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 21 15:15:09 volumiopi2 volumio[933]: info: Hit:1 https://deb.nodesource.com/node_14.x buster InRelease Aug 21 15:15:10 volumiopi2 volumio[933]: info: Get:2 http://raspbian.raspberrypi.org/raspbian buster InRelease [15.0 kB] Aug 21 15:15:10 volumiopi2 volumio[933]: info: MPD Database updated - AlbumList cache refreshed Aug 21 15:15:10 volumiopi2 volumio[933]: info: Aug 21 15:15:10 volumiopi2 volumio[933]: ---------------------------- MPD announces state update: database Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:15:10 volumiopi2 volumio[933]: info: Aug 21 15:15:10 volumiopi2 volumio[933]: ---------------------------- MPD announces state update: update Aug 21 15:15:10 volumiopi2 volumio[933]: info: ControllerMpd::getState Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:15:10 volumiopi2 volumio[933]: info: ControllerMpd::getState Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:15:10 volumiopi2 volumio[933]: info: MPD Database updated - AlbumList cache refreshed Aug 21 15:15:10 volumiopi2 volumio[933]: info: Aug 21 15:15:10 volumiopi2 volumio[933]: ---------------------------- MPD announces state update: database Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:15:10 volumiopi2 volumio[933]: info: Aug 21 15:15:10 volumiopi2 volumio[933]: ---------------------------- MPD announces state update: update Aug 21 15:15:10 volumiopi2 volumio[933]: info: ControllerMpd::getState Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:15:10 volumiopi2 volumio[933]: info: ControllerMpd::getState Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::sendMpdCommand status Aug 21 15:15:10 volumiopi2 volumio[933]: info: Get:3 http://archive.raspberrypi.org/debian buster InRelease [54.2 kB] Aug 21 15:15:10 volumiopi2 volumio[933]: info: sendMpdCommand status took 751 milliseconds Aug 21 15:15:10 volumiopi2 volumio[933]: info: sendMpdCommand status took 751 milliseconds Aug 21 15:15:10 volumiopi2 volumio[933]: info: sendMpdCommand status took 750 milliseconds Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:15:10 volumiopi2 volumio[933]: info: Command Router : Notfying DB Updatefalse Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::Close All Modals sent Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:15:10 volumiopi2 volumio[933]: info: ControllerMpd::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::servicePushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: CURRENT POSITION 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::syncState stateService stop Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::syncState currentStatus stop Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: No code Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: ControllerMpd::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::servicePushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 21 15:15:10 volumiopi2 volumio[933]: verbose: CURRENT POSITION 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::syncState stateService stop Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::syncState currentStatus stop Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: No code Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:10 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:10 volumiopi2 volumio[933]: info: ------------------------------ 868ms Aug 21 15:15:10 volumiopi2 volumio[933]: info: ------------------------------ 868ms Aug 21 15:15:11 volumiopi2 volumio[933]: info: sendMpdCommand status took 1398 milliseconds Aug 21 15:15:11 volumiopi2 volumio[933]: info: sendMpdCommand status took 1398 milliseconds Aug 21 15:15:11 volumiopi2 volumio[933]: info: sendMpdCommand status took 1392 milliseconds Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:15:11 volumiopi2 volumio[933]: info: Command Router : Notfying DB Updatefalse Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::Close All Modals sent Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: ControllerMpd::parseState Aug 21 15:15:11 volumiopi2 volumio[933]: info: ControllerMpd::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::servicePushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: CURRENT POSITION 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::syncState stateService stop Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::syncState currentStatus stop Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: No code Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: ControllerMpd::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::servicePushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Aug 21 15:15:11 volumiopi2 volumio[933]: verbose: CURRENT POSITION 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::syncState stateService stop Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::syncState currentStatus stop Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: No code Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreStateMachine::pushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: CorePlayQueue::getTrack 0 Aug 21 15:15:11 volumiopi2 volumio[933]: info: CoreCommandRouter::volumioPushState Aug 21 15:15:11 volumiopi2 volumio[933]: info: ------------------------------ 1526ms Aug 21 15:15:11 volumiopi2 volumio[933]: info: ------------------------------ 1527ms Aug 21 15:15:11 volumiopi2 volumio[933]: info: Get:4 http://raspbian.raspberrypi.org/raspbian buster/main armhf Packages [13.0 MB] Aug 21 15:15:11 volumiopi2 volumio[933]: info: Get:5 http://archive.raspberrypi.org/debian buster/main armhf Packages [400 kB] Aug 21 15:15:14 volumiopi2 volumio[933]: info: Get:6 http://raspbian.raspberrypi.org/raspbian buster/contrib armhf Packages [58.8 kB] Aug 21 15:15:18 volumiopi2 volumio[933]: info: Fetched 13.5 MB in 9s (1577 kB/s) Aug 21 15:15:18 volumiopi2 volumio[933]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Aug 21 15:15:20 volumiopi2 volumio[933]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Aug 21 15:15:20 volumiopi2 volumio[933]: info: FusionDsp - Stopping FusionDsp service Aug 21 15:15:20 volumiopi2 volumio[933]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 21 15:15:20 volumiopi2 volumio[933]: TypeError: Cannot read property 'stop' of null Aug 21 15:15:20 volumiopi2 volumio[933]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:108:23) Aug 21 15:15:20 volumiopi2 volumio[933]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Aug 21 15:15:20 volumiopi2 volumio[933]: at /volumio/app/pluginmanager.js:956:12 Aug 21 15:15:20 volumiopi2 volumio[933]: at ChildProcess.exithandler (child_process.js:299:7) Aug 21 15:15:20 volumiopi2 volumio[933]: at ChildProcess.emit (events.js:315:20) Aug 21 15:15:20 volumiopi2 volumio[933]: at maybeClose (internal/child_process.js:1048:16) Aug 21 15:15:20 volumiopi2 volumio[933]: at Process.ChildProcess._handle.onexit (internal/child_process.js:288:5) Aug 21 15:15:20 volumiopi2 volumio[933]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 21 15:15:20 volumiopi2 sudo[13496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-21 15:14 Aug 21 15:15:20 volumiopi2 sudo[13496]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:10:14 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5bdefd4af4423fd17aacb83a8538bf1f"