-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sun 2024-09-08 17:16:16 CEST. -- Sep 08 17:15:06 volumiocoyote volumio-remote-updater[633]: No test mode Sep 08 17:15:06 volumiocoyote volumio-remote-updater[633]: No alpha test mode Sep 08 17:15:06 volumiocoyote volumio[922]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Sep 08 17:15:06 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Sep 08 17:15:08 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:15:22 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioGetState Sep 08 17:15:22 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:15:24 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:24 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 08 17:15:24 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Sep 08 17:15:24 volumiocoyote sudo[2459]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Sep 08 17:15:24 volumiocoyote sudo[2459]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:24 volumiocoyote sudo[2459]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:24 volumiocoyote sudo[2464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 08 17:15:24 volumiocoyote sudo[2464]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:24 volumiocoyote sudo[2464]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:24 volumiocoyote sudo[2473]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 08 17:15:24 volumiocoyote sudo[2473]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:24 volumiocoyote sudo[2473]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:24 volumiocoyote sudo[2478]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 08 17:15:24 volumiocoyote sudo[2478]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:24 volumiocoyote sudo[2478]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:24 volumiocoyote sudo[2484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 08 17:15:24 volumiocoyote sudo[2484]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:24 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 08 17:15:24 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 08 17:15:24 volumiocoyote sudo[2484]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:24 volumiocoyote sudo[2487]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 08 17:15:24 volumiocoyote sudo[2487]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:24 volumiocoyote sudo[2487]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:24 volumiocoyote sudo[2491]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 08 17:15:24 volumiocoyote sudo[2491]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:15:28 volumiocoyote sudo[2491]: pam_unix(sudo:session): session closed for user root Sep 08 17:15:29 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioGetState Sep 08 17:15:29 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:30 volumiocoyote volumio[922]: info: Retrieving Cloud Streaming UI Sep 08 17:15:30 volumiocoyote volumio[922]: info: Getting Tidal Cloud Configuration Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:30 volumiocoyote volumio[922]: info: Getting Qobuz Cloud Configuration Sep 08 17:15:30 volumiocoyote volumio[922]: info: Asking plugin for UI Config Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:30 volumiocoyote volumio[922]: info: Getting Spotify Cloud Configuration Sep 08 17:15:30 volumiocoyote volumio[922]: info: Asking plugin for UI Config Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:30 volumiocoyote volumio[922]: info: Saving Spotify Acccount Sep 08 17:15:30 volumiocoyote volumio[922]: info: Got Tidal Cloud Configuration Sep 08 17:15:30 volumiocoyote volumio[922]: info: Got it Sep 08 17:15:30 volumiocoyote volumio[922]: info: Got it Sep 08 17:15:30 volumiocoyote volumio[922]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 08 17:15:30 volumiocoyote volumio[922]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioGetBrowseSources Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:30 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Sep 08 17:15:34 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:38 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:40 volumiocoyote ntpd[774]: 95.179.212.126 local addr 192.168.1.99 -> Sep 08 17:15:42 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:46 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:50 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:54 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:15:58 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:16:02 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , rescanDb Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand rescan Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:05 volumiocoyote volumio[922]: info: Sep 08 17:16:05 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand rescan took 7 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:05 volumiocoyote volumio[922]: info: Sep 08 17:16:05 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:05 volumiocoyote volumio[922]: info: Sep 08 17:16:05 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 17 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 61 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 61 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 59 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 58 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 57 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: 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} Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: No code Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: 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} Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: No code Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: 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} Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: No code Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: ------------------------------ 176ms Sep 08 17:16:05 volumiocoyote volumio[922]: info: ------------------------------ 198ms Sep 08 17:16:05 volumiocoyote volumio[922]: info: ------------------------------ 196ms Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:05 volumiocoyote volumio[922]: info: Sep 08 17:16:05 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 15 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: info: sendMpdCommand status took 14 milliseconds Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:05 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: 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} Sep 08 17:16:05 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: No code Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:05 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:05 volumiocoyote volumio[922]: info: ------------------------------ 67ms Sep 08 17:16:06 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand update Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: info: Sep 08 17:16:08 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand update took 5 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: info: Sep 08 17:16:08 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: info: Sep 08 17:16:08 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 8 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 7 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 6 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 4 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: 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} Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: No code Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: 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} Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: No code Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: ------------------------------ 110ms Sep 08 17:16:08 volumiocoyote volumio[922]: info: ------------------------------ 108ms Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: info: Sep 08 17:16:08 volumiocoyote volumio[922]: ---------------------------- MPD announces state update: update Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::getState Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::sendMpdCommand status Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 117 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 117 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 13 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: info: sendMpdCommand status took 3 milliseconds Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: info: Command Router : Notfying DB Updatefalse Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::Close All Modals sent Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: ControllerMpd::parseState Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: 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} Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: No code Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: ControllerMpd::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::servicePushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: 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} Sep 08 17:16:08 volumiocoyote volumio[922]: verbose: CURRENT POSITION 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState stateService stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::syncState currentStatus stop Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: No code Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreStateMachine::pushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: CorePlayQueue::getTrack 0 Sep 08 17:16:08 volumiocoyote volumio[922]: info: CoreCommandRouter::volumioPushState Sep 08 17:16:08 volumiocoyote volumio[922]: info: ------------------------------ 225ms Sep 08 17:16:08 volumiocoyote volumio[922]: info: ------------------------------ 121ms Sep 08 17:16:10 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:16:14 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Sep 08 17:16:14 volumiocoyote volumio[922]: info: Disabling MyMusic plugin upnp Sep 08 17:16:14 volumiocoyote sudo[2515]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Sep 08 17:16:14 volumiocoyote sudo[2515]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 08 17:16:14 volumiocoyote systemd[1]: Stopping UPnP Renderer front-end to MPD... Sep 08 17:16:14 volumiocoyote volumio[922]: error: Upnp client error: Error: This socket has been ended by the other party Sep 08 17:16:15 volumiocoyote volumio[922]: info: Enabling MyMusic plugin upnp Sep 08 17:16:15 volumiocoyote volumio[922]: info: Enabling plugin upnp Sep 08 17:16:15 volumiocoyote volumio[922]: info: Loading plugin "upnp"... Sep 08 17:16:15 volumiocoyote volumio[922]: info: [1725808575954] Starting Upmpd Daemon Sep 08 17:16:15 volumiocoyote volumio[922]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Sep 08 17:16:15 volumiocoyote volumio[922]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 17:16:15 volumiocoyote volumio[922]: Error: listen EADDRINUSE: address already in use :::6599 Sep 08 17:16:15 volumiocoyote volumio[922]: at Server.setupListenHandle [as _listen2] (net.js:1318:16) Sep 08 17:16:15 volumiocoyote volumio[922]: at listenInCluster (net.js:1366:12) Sep 08 17:16:15 volumiocoyote volumio[922]: at Server.listen (net.js:1452:7) Sep 08 17:16:15 volumiocoyote volumio[922]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Sep 08 17:16:15 volumiocoyote volumio[922]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Sep 08 17:16:15 volumiocoyote volumio[922]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Sep 08 17:16:15 volumiocoyote volumio[922]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Sep 08 17:16:15 volumiocoyote volumio[922]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Sep 08 17:16:15 volumiocoyote volumio[922]: code: 'EADDRINUSE', Sep 08 17:16:15 volumiocoyote volumio[922]: errno: -98, Sep 08 17:16:15 volumiocoyote volumio[922]: syscall: 'listen', Sep 08 17:16:15 volumiocoyote volumio[922]: address: '::', Sep 08 17:16:15 volumiocoyote volumio[922]: port: 6599 Sep 08 17:16:15 volumiocoyote volumio[922]: } Sep 08 17:16:15 volumiocoyote volumio[922]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 08 17:16:16 volumiocoyote sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-08 17:15 Sep 08 17:16:16 volumiocoyote sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"