-- Logs begin at Wed 2024-07-17 22:34:41 UTC, end at Wed 2024-07-17 22:47:42 UTC. -- Jul 17 22:46:01 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:46:01 hsvolumio volumio[1740]: info: CURURI: genres:// Jul 17 22:46:01 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:46:14 hsvolumio volumio[1740]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jul 17 22:46:14 hsvolumio ntpd[1576]: Soliciting pool server 162.159.200.123 Jul 17 22:46:14 hsvolumio ntpd[1576]: Soliciting pool server 84.16.67.12 Jul 17 22:46:15 hsvolumio ntpd[1576]: Soliciting pool server 211.68.71.26 Jul 17 22:46:15 hsvolumio ntpd[1576]: Soliciting pool server 95.111.202.5 Jul 17 22:46:16 hsvolumio ntpd[1576]: Soliciting pool server 193.182.111.14 Jul 17 22:46:16 hsvolumio ntpd[1576]: Soliciting pool server 193.182.111.12 Jul 17 22:46:17 hsvolumio volumio[1740]: verbose: New Socket.io Connection to 192.168.50.232 from 192.168.50.65 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:46:17 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:46:17 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 22:46:17 hsvolumio volumio[1740]: info: Received Get System Info Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 22:46:17 hsvolumio volumio[1740]: info: Discovery: Getting this device information Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:46:17 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:46:17 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:17 hsvolumio volumio[1740]: info: Listing playlists Jul 17 22:46:17 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 22:46:34 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:46:34 hsvolumio volumio[1740]: info: CURURI: music-library Jul 17 22:46:34 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:46:34 hsvolumio ntpd[1576]: Soliciting pool server 2a03:8600::ff Jul 17 22:46:35 hsvolumio ntpd[1576]: 193.182.111.142 local addr 192.168.50.232 -> Jul 17 22:46:35 hsvolumio ntpd[1576]: 202.118.1.81 local addr 192.168.50.232 -> Jul 17 22:46:36 hsvolumio ntpd[1576]: 162.159.200.1 local addr 192.168.50.232 -> Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , updateDb Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand update Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: update Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand update took 3 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: update Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: update Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 13 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:36 hsvolumio volumio[1740]: info: Command Router : Notfying DB Updatetrue Jul 17 22:46:36 hsvolumio volumio[1740]: info: MPD Database updated - AlbumList cache refreshed Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: database Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: update Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 162 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 162 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 161 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 161 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 162 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:36 hsvolumio volumio[1740]: info: Command Router : Notfying DB Updatefalse Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::Close All Modals sent Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:36 hsvolumio volumio[1740]: info: Command Router : Notfying DB Updatefalse Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::Close All Modals sent Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: 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} Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: No code Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: 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} Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: No code Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: 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} Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: No code Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:36 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:36 hsvolumio volumio[1740]: info: ------------------------------ 339ms Jul 17 22:46:36 hsvolumio volumio[1740]: info: ------------------------------ 358ms Jul 17 22:46:36 hsvolumio volumio[1740]: info: ------------------------------ 359ms Jul 17 22:46:36 hsvolumio volumio[1740]: info: MPD Database updated - AlbumList cache refreshed Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: database Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: update Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: MPD Database updated - AlbumList cache refreshed Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: database Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: Jul 17 22:46:36 hsvolumio volumio[1740]: ---------------------------- MPD announces state update: update Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: ControllerMpd::getState Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::sendMpdCommand status Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 215 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 215 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 215 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 15 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 16 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 16 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 15 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 10 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: info: sendMpdCommand status took 9 milliseconds Jul 17 22:46:36 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: info: Command Router : Notfying DB Updatefalse Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::Close All Modals sent Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: info: Command Router : Notfying DB Updatefalse Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::Close All Modals sent Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: info: Command Router : Notfying DB Updatefalse Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::Close All Modals sent Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: ControllerMpd::parseState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: 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} Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: No code Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: 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} Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: No code Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: 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} Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: No code Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: 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} Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: No code Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: 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} Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: No code Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ControllerMpd::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::servicePushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: 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} Jul 17 22:46:37 hsvolumio volumio[1740]: verbose: CURRENT POSITION 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState stateService stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::syncState currentStatus stop Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: No code Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreStateMachine::pushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:46:37 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioPushState Jul 17 22:46:37 hsvolumio volumio[1740]: info: ------------------------------ 425ms Jul 17 22:46:37 hsvolumio volumio[1740]: info: ------------------------------ 426ms Jul 17 22:46:37 hsvolumio volumio[1740]: info: ------------------------------ 226ms Jul 17 22:46:37 hsvolumio volumio[1740]: info: ------------------------------ 226ms Jul 17 22:46:37 hsvolumio volumio[1740]: info: ------------------------------ 226ms Jul 17 22:46:37 hsvolumio volumio[1740]: info: ------------------------------ 226ms Jul 17 22:46:40 hsvolumio ntpd[1576]: 193.182.111.143 local addr 192.168.50.232 -> Jul 17 22:47:06 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:47:06 hsvolumio volumio[1740]: info: CURURI: albums:// Jul 17 22:47:06 hsvolumio volumio[1740]: info: listAlbums - loading Albums from cache Jul 17 22:47:06 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:47:13 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:47:13 hsvolumio volumio[1740]: info: CURURI: music-library Jul 17 22:47:13 hsvolumio volumio[1740]: error: Failed LSINFO: null Jul 17 22:47:13 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:47:21 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:47:21 hsvolumio volumio[1740]: info: CURURI: playlists Jul 17 22:47:21 hsvolumio volumio[1740]: info: Listing playlists Jul 17 22:47:21 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:47:24 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:47:24 hsvolumio volumio[1740]: info: CURURI: music-library Jul 17 22:47:24 hsvolumio volumio[1740]: error: Failed LSINFO: null Jul 17 22:47:24 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:47:24 hsvolumio ntpd[1576]: Soliciting pool server 202.118.1.81 Jul 17 22:47:24 hsvolumio ntpd[1576]: Soliciting pool server 193.182.111.143 Jul 17 22:47:24 hsvolumio ntpd[1576]: Soliciting pool server 162.159.200.1 Jul 17 22:47:25 hsvolumio ntpd[1576]: Soliciting pool server 193.182.111.142 Jul 17 22:47:27 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jul 17 22:47:27 hsvolumio volumio[1740]: info: CURURI: albums:// Jul 17 22:47:27 hsvolumio volumio[1740]: info: listAlbums - loading Albums from cache Jul 17 22:47:27 hsvolumio volumio[1740]: info: Preload queue cleared Jul 17 22:47:28 hsvolumio volumio[1740]: verbose: New Socket.io Connection to 192.168.50.232 from 192.168.50.65 UA: Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/605.1.15 (KHTML, like Gecko) Version/17.5 Safari/605.1.15 Engine version: 3 Transport: polling Total Clients: 7 Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetVisibleSources Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:47:28 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:47:28 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 17 22:47:28 hsvolumio volumio[1740]: info: Received Get System Info Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 17 22:47:28 hsvolumio volumio[1740]: info: Discovery: Getting this device information Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:47:28 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::volumioGetState Jul 17 22:47:28 hsvolumio volumio[1740]: info: CorePlayQueue::getTrack 0 Jul 17 22:47:28 hsvolumio volumio[1740]: info: Listing playlists Jul 17 22:47:28 hsvolumio volumio[1740]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 17 22:47:40 hsvolumio ntpd[1576]: Soliciting pool server 2606:4700:f1::1 Jul 17 22:47:42 hsvolumio volumio[1740]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 22:47:42 hsvolumio volumio[1740]: Error: connect ETIMEDOUT 108.160.170.39:443 Jul 17 22:47:42 hsvolumio volumio[1740]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jul 17 22:47:42 hsvolumio volumio[1740]: errno: -110, Jul 17 22:47:42 hsvolumio volumio[1740]: code: 'ETIMEDOUT', Jul 17 22:47:42 hsvolumio volumio[1740]: syscall: 'connect', Jul 17 22:47:42 hsvolumio volumio[1740]: address: '108.160.170.39', Jul 17 22:47:42 hsvolumio volumio[1740]: port: 443 Jul 17 22:47:42 hsvolumio volumio[1740]: } Jul 17 22:47:42 hsvolumio volumio[1740]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 17 22:47:42 hsvolumio sudo[2526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-17 22:46 Jul 17 22:47:42 hsvolumio sudo[2526]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"