-- Logs begin at Thu 2024-10-24 01:30:10 JST, end at Sat 2024-10-26 08:28:24 JST. -- Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:25 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:25 volumio volumio[1198]: verbose: New Socket.io Connection to 192.168.1.45:3000 from 192.168.1.34 UA: Dart/3.4 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Oct 26 08:27:25 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Oct 26 08:27:26 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:26 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:26 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:26 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:26 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:27 volumio sudo[4153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 08:27:27 volumio sudo[4155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 08:27:27 volumio sudo[4155]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:27 volumio sudo[4153]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:27 volumio sudo[4153]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:27 volumio sudo[4155]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:27 volumio volumio[1198]: verbose: New Socket.io Connection to 192.168.1.45 from 192.168.1.34 UA: Mozilla/5.0 (Linux; Android 12; L-51A Build/SKQ1.211103.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.102 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 08:27:28 volumio sudo[4159]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 08:27:28 volumio sudo[4159]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:28 volumio sudo[4159]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:28 volumio sudo[4161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 08:27:28 volumio sudo[4161]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:28 volumio sudo[4161]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:28 volumio volumio[1198]: verbose: New Socket.io Connection to 192.168.1.45 from 192.168.1.34 UA: Mozilla/5.0 (Linux; Android 12; L-51A Build/SKQ1.211103.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/129.0.6668.102 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::volumioGetVisibleSources Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::volumioGetQueue Oct 26 08:27:28 volumio volumio[1198]: info: CoreStateMachine::getQueue Oct 26 08:27:28 volumio volumio[1198]: info: CorePlayQueue::getQueue Oct 26 08:27:28 volumio volumio[1198]: info: Listing playlists Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 26 08:27:28 volumio volumio[1198]: info: Received Get System Info Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:28 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 08:27:28 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 26 08:27:30 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Oct 26 08:27:30 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 08:27:30 volumio volumio[1198]: info: Received Get System Info Oct 26 08:27:30 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:30 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:30 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:30 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:30 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:31 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 26 08:27:31 volumio volumio[1198]: info: Received Get System Info Oct 26 08:27:31 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:31 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:31 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:31 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:31 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 26 08:27:34 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 26 08:27:36 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 08:27:38 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Oct 26 08:27:42 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:27:42 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 08:27:42 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Oct 26 08:27:42 volumio sudo[4175]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Oct 26 08:27:42 volumio sudo[4180]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 26 08:27:42 volumio sudo[4175]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:42 volumio sudo[4180]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:42 volumio sudo[4175]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:42 volumio sudo[4188]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 26 08:27:42 volumio sudo[4192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Oct 26 08:27:42 volumio sudo[4192]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:42 volumio sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Oct 26 08:27:42 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Oct 26 08:27:42 volumio sudo[4180]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:42 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Oct 26 08:27:42 volumio sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:42 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:42 volumio sudo[4197]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:42 volumio sudo[4199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Oct 26 08:27:42 volumio sudo[4199]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:42 volumio sudo[4199]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:42 volumio sudo[4192]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:42 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:42 volumio sudo[4206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Oct 26 08:27:42 volumio sudo[4206]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:27:46 volumio sudo[4206]: pam_unix(sudo:session): session closed for user root Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Oct 26 08:27:47 volumio volumio[1198]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Oct 26 08:27:47 volumio volumio[1198]: info: Received Get System Version Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 26 08:27:47 volumio volumio[1198]: info: Received Get System Info Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:47 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:47 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:55 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 26 08:27:55 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 26 08:27:55 volumio volumio[1198]: info: Discovery: Getting this device information Oct 26 08:27:55 volumio volumio[1198]: info: CoreCommandRouter::volumioGetState Oct 26 08:27:55 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Oct 26 08:27:57 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:28:01 volumio volumio[1198]: info: Retrieving Cloud Streaming UI Oct 26 08:28:01 volumio volumio[1198]: info: Getting Tidal Cloud Configuration Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:28:01 volumio volumio[1198]: info: Getting Qobuz Cloud Configuration Oct 26 08:28:01 volumio volumio[1198]: info: Asking plugin for UI Config Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:28:01 volumio volumio[1198]: info: Getting Spotify Cloud Configuration Oct 26 08:28:01 volumio volumio[1198]: info: Asking plugin for UI Config Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:28:01 volumio volumio[1198]: info: Saving Spotify Acccount Oct 26 08:28:01 volumio volumio[1198]: info: Got Tidal Cloud Configuration Oct 26 08:28:01 volumio volumio[1198]: info: Got it Oct 26 08:28:01 volumio volumio[1198]: info: Got it Oct 26 08:28:01 volumio volumio[1198]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 26 08:28:01 volumio volumio[1198]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::volumioGetBrowseSources Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 08:28:01 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Oct 26 08:28:05 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 26 08:28:05 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand update Oct 26 08:28:05 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:05 volumio volumio[1198]: info: Oct 26 08:28:05 volumio volumio[1198]: ---------------------------- MPD announces state update: update Oct 26 08:28:05 volumio volumio[1198]: info: sendMpdCommand update took 1 milliseconds Oct 26 08:28:05 volumio volumio[1198]: info: ControllerMpd::getState Oct 26 08:28:05 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:05 volumio volumio[1198]: info: sendMpdCommand status took 1 milliseconds Oct 26 08:28:05 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:06 volumio volumio[1198]: info: Command Router : Notfying DB Updatetrue Oct 26 08:28:06 volumio volumio[1198]: info: MPD Database updated - AlbumList cache refreshed Oct 26 08:28:06 volumio volumio[1198]: info: Oct 26 08:28:06 volumio volumio[1198]: ---------------------------- MPD announces state update: database Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:06 volumio volumio[1198]: info: Oct 26 08:28:06 volumio volumio[1198]: ---------------------------- MPD announces state update: update Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand status took 873 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::getState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::getState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand status took 81 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand status took 80 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand status took 80 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand playlistinfo took 79 milliseconds Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:06 volumio volumio[1198]: info: Command Router : Notfying DB Updatefalse Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::Close All Modals sent Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseTrackInfo Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: CorePlayQueue::getTrack 0 Oct 26 08:28:06 volumio volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":true,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Sing Mmm","artist":"Petteri Sariola","album":"Resolution","uri":"INTERNAL/リッピング/Petteri Sariola/Resolution/06 I Sing Mmm.wav","trackType":"wav"} Oct 26 08:28:06 volumio volumio[1198]: verbose: CURRENT POSITION 0 Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::syncState stateService stop Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::syncState currentStatus play Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::play index undefined Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: CorePlayQueue::getTrack 1 Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::startPlaybackTimer Oct 26 08:28:06 volumio volumio[1198]: info: CorePlayQueue::getTrack 1 Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/リッピング/Petteri Sariola/Resolution/02 Projector (When She's Around).wav Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand stop Oct 26 08:28:06 volumio volumio[1198]: info: ------------------------------ 970ms Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand playlistinfo took 18 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand stop took 13 milliseconds Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseTrackInfo Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseTrackInfo Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand clear Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: CorePlayQueue::getTrack 1 Oct 26 08:28:06 volumio volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Sing Mmm","artist":"Petteri Sariola","album":"Resolution","uri":"INTERNAL/リッピング/Petteri Sariola/Resolution/06 I Sing Mmm.wav","trackType":"wav"} Oct 26 08:28:06 volumio volumio[1198]: verbose: CURRENT POSITION 1 Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::syncState stateService stop Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: No code Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: CorePlayQueue::getTrack 1 Oct 26 08:28:06 volumio volumio[1198]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"I Sing Mmm","artist":"Petteri Sariola","album":"Resolution","uri":"INTERNAL/リッピング/Petteri Sariola/Resolution/06 I Sing Mmm.wav","trackType":"wav"} Oct 26 08:28:06 volumio volumio[1198]: verbose: CURRENT POSITION 1 Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::syncState stateService stop Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::syncState currentStatus stop Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: No code Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: ------------------------------ 121ms Oct 26 08:28:06 volumio volumio[1198]: info: ------------------------------ 118ms Oct 26 08:28:06 volumio volumio[1198]: info: Oct 26 08:28:06 volumio volumio[1198]: ---------------------------- MPD announces system playlist update Oct 26 08:28:06 volumio volumio[1198]: info: Ignoring MPD Status Update Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand clear took 10 milliseconds Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/リッピング/Petteri Sariola/Resolution/02 Projector (When She's Around).wav" Oct 26 08:28:06 volumio volumio[1198]: error: updateQueue error: null Oct 26 08:28:06 volumio volumio[1198]: info: Oct 26 08:28:06 volumio volumio[1198]: ---------------------------- MPD announces system playlist update Oct 26 08:28:06 volumio volumio[1198]: info: Ignoring MPD Status Update Oct 26 08:28:06 volumio volumio[1198]: info: ------------------------------ 1ms Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand add "INTERNAL/リッピング/Petteri Sariola/Resolution/02 Projector (When She's Around).wav" took 1 milliseconds Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand play Oct 26 08:28:06 volumio volumio[1198]: info: ------------------------------ 1ms Oct 26 08:28:06 volumio volumio[1198]: info: Oct 26 08:28:06 volumio volumio[1198]: ---------------------------- MPD announces state update: player Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::getState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand status took 1 milliseconds Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand clearerror took 1 milliseconds Oct 26 08:28:06 volumio volumio[1198]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 26 08:28:06 volumio volumio[1198]: verbose: ControllerMpd::parseTrackInfo Oct 26 08:28:06 volumio volumio[1198]: info: ControllerMpd::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 08:28:06 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:06 volumio volumio[1198]: info: ------------------------------ 4ms Oct 26 08:28:09 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand update Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:10 volumio volumio[1198]: info: Oct 26 08:28:10 volumio volumio[1198]: ---------------------------- MPD announces state update: update Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand update took 1 milliseconds Oct 26 08:28:10 volumio volumio[1198]: info: ControllerMpd::getState Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand status took 1 milliseconds Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:10 volumio volumio[1198]: info: Command Router : Notfying DB Updatetrue Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::Close All Modals sent Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand status took 13 milliseconds Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::parseTrackInfo Oct 26 08:28:10 volumio volumio[1198]: info: ControllerMpd::pushState Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:10 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:10 volumio volumio[1198]: info: ------------------------------ 15ms Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:10 volumio volumio[1198]: info: Oct 26 08:28:10 volumio volumio[1198]: ---------------------------- MPD announces state update: update Oct 26 08:28:10 volumio volumio[1198]: info: ControllerMpd::getState Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand status Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand status took 0 milliseconds Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand status took 0 milliseconds Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:10 volumio volumio[1198]: info: Command Router : Notfying DB Updatefalse Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::Close All Modals sent Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::parseState Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 26 08:28:10 volumio volumio[1198]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 26 08:28:10 volumio volumio[1198]: verbose: ControllerMpd::parseTrackInfo Oct 26 08:28:10 volumio volumio[1198]: info: ControllerMpd::pushState Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:10 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:10 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:10 volumio volumio[1198]: info: ------------------------------ 11ms Oct 26 08:28:13 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 08:28:16 volumio volumio[1198]: info: Disabling MyMusic plugin upnp Oct 26 08:28:16 volumio sudo[4265]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 26 08:28:16 volumio sudo[4265]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:28:16 volumio systemd[1]: Stopping UPnP Renderer front-end to MPD... Oct 26 08:28:16 volumio volumio[1198]: error: Upnp client error: Error: This socket has been ended by the other party Oct 26 08:28:17 volumio volumio[1198]: info: Disabling MyMusic plugin airplay_emulation Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesShairport-Sync Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 08:28:17 volumio volumio[1198]: info: Disabling plugin airplay_emulation Oct 26 08:28:17 volumio volumio[1198]: info: Done. Oct 26 08:28:17 volumio sudo[4268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop shairport-sync Oct 26 08:28:17 volumio sudo[4268]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:28:17 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 26 08:28:17 volumio shairport-sync[26648]: {"time":1729897860271,"response":"startAirplayPlayback Success"}Execution of on-stop command failed to start Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::servicePushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreStateMachine::pushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::volumioPushState Oct 26 08:28:17 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 08:28:18 volumio volumio[1198]: info: Disabling MyMusic plugin upnp_browser Oct 26 08:28:18 volumio volumio[1198]: info: CoreCommandRouter::volumioRemoveToBrowseSourcesメディアサーバー Oct 26 08:28:18 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 08:28:18 volumio volumio[1198]: info: Disabling plugin upnp_browser Oct 26 08:28:18 volumio volumio[1198]: info: Done. Oct 26 08:28:19 volumio volumio[1198]: info: Enabling MyMusic plugin upnp_browser Oct 26 08:28:19 volumio volumio[1198]: info: Enabling plugin upnp_browser Oct 26 08:28:19 volumio volumio[1198]: info: Loading plugin "upnp_browser"... Oct 26 08:28:19 volumio volumio[1198]: info: PLUGIN START: upnp_browser Oct 26 08:28:19 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Oct 26 08:28:19 volumio volumio[1198]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Oct 26 08:28:19 volumio volumio[1198]: info: [1729898899749] CoreMusicLibrary::Adding element メディアサーバー Oct 26 08:28:19 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 26 08:28:19 volumio volumio[1198]: info: Done. Oct 26 08:28:20 volumio volumio[1198]: info: Enabling MyMusic plugin airplay_emulation Oct 26 08:28:20 volumio volumio[1198]: info: Enabling plugin airplay_emulation Oct 26 08:28:20 volumio volumio[1198]: info: Loading plugin "airplay_emulation"... Oct 26 08:28:20 volumio volumio[1198]: info: Starting Shairport Sync Oct 26 08:28:20 volumio volumio[1198]: info: PLUGIN START: airplay_emulation Oct 26 08:28:20 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 08:28:20 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 08:28:20 volumio volumio[1198]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 08:28:20 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 26 08:28:20 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 26 08:28:20 volumio volumio[1198]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 26 08:28:20 volumio volumio[1198]: info: Done. Oct 26 08:28:20 volumio volumio[1198]: info: Starting Shairport Sync Oct 26 08:28:20 volumio volumio[1198]: info: Starting Shairport Sync Oct 26 08:28:20 volumio sudo[4278]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 08:28:20 volumio sudo[4278]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:28:20 volumio sudo[4280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 26 08:28:20 volumio sudo[4280]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:28:20 volumio sudo[4268]: pam_unix(sudo:session): session closed for user root Oct 26 08:28:20 volumio volumio[1198]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl stop shairport-sync Oct 26 08:28:20 volumio volumio[1198]: Job for shairport-sync.service canceled. Oct 26 08:28:21 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Oct 26 08:28:23 volumio volumio[1198]: info: Disabling MyMusic plugin upnp Oct 26 08:28:23 volumio sudo[4284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Oct 26 08:28:23 volumio sudo[4284]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 26 08:28:23 volumio volumio[1198]: info: Enabling MyMusic plugin upnp Oct 26 08:28:23 volumio volumio[1198]: info: Enabling plugin upnp Oct 26 08:28:23 volumio volumio[1198]: info: Loading plugin "upnp"... Oct 26 08:28:23 volumio volumio[1198]: info: [1729898903961] Starting Upmpd Daemon Oct 26 08:28:23 volumio volumio[1198]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Oct 26 08:28:23 volumio volumio[1198]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 08:28:23 volumio volumio[1198]: Error: listen EADDRINUSE: address already in use :::6599 Oct 26 08:28:23 volumio volumio[1198]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Oct 26 08:28:23 volumio volumio[1198]: at listenInCluster (net.js:1366:12) Oct 26 08:28:23 volumio volumio[1198]: at Server.listen (net.js:1452:7) Oct 26 08:28:23 volumio volumio[1198]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Oct 26 08:28:23 volumio volumio[1198]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Oct 26 08:28:23 volumio volumio[1198]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Oct 26 08:28:23 volumio volumio[1198]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Oct 26 08:28:23 volumio volumio[1198]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Oct 26 08:28:23 volumio volumio[1198]: code: 'EADDRINUSE', Oct 26 08:28:23 volumio volumio[1198]: errno: -98, Oct 26 08:28:23 volumio volumio[1198]: syscall: 'listen', Oct 26 08:28:23 volumio volumio[1198]: address: '::', Oct 26 08:28:23 volumio volumio[1198]: port: 6599 Oct 26 08:28:23 volumio volumio[1198]: } Oct 26 08:28:23 volumio volumio[1198]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 26 08:28:24 volumio sudo[4295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-26 08:27 Oct 26 08:28:24 volumio sudo[4295]: 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="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:01:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="e0a6dc7e914e3fb93cbf2123f2f73eac"