-- Logs begin at Thu 2024-07-04 08:09:10 UTC, end at Thu 2024-07-11 06:25:20 UTC. -- Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces state update: player Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::getState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand status Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces state update: player Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::getState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand status Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand status took 1 milliseconds Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::pushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::servicePushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getTrack 0 Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: 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 11 06:25:05 volumiosamadhy-tinker volumio[1165]: verbose: CURRENT POSITION 0 Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState stateService stop Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState currentStatus play Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::stPlaybackTimer Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::pushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::servicePushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getTrack 0 Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: 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 11 06:25:05 volumiosamadhy-tinker volumio[1165]: verbose: CURRENT POSITION 0 Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState stateService stop Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState currentStatus stop Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: No code Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 27ms Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 26ms Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:05 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:06 volumiosamadhy-tinker volumio[1165]: error: Upnp client error: Error: This socket has been ended by the other party Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: verbose: New Socket.io Connection to 192.168.219.42 from 192.168.219.44 UA: unknown Engine version: 3 Transport: websocket Total Clients: 5 Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: Discovery: Getting this device information Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:09 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 06:25:10 volumiosamadhy-tinker volumio[1165]: verbose: New Socket.io Connection to 192.168.219.42 from 192.168.219.44 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 6 Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Clearing queue after UPNP request Jul 11 06:25:12 volumiosamadhy-tinker sudo[4980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jul 11 06:25:12 volumiosamadhy-tinker sudo[4980]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 06:25:12 volumiosamadhy-tinker sudo[4983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jul 11 06:25:12 volumiosamadhy-tinker sudo[4980]: pam_unix(sudo:session): session closed for user root Jul 11 06:25:12 volumiosamadhy-tinker sudo[4983]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 06:25:12 volumiosamadhy-tinker sudo[4983]: pam_unix(sudo:session): session closed for user root Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: verbose: New Socket.io Connection to 192.168.219.42 from 192.168.219.44 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 17_5_1 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 7 Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetVisibleSources Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Retrieving Cloud Streaming UI Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Received Get System Info Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Discovery: Getting this device information Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Listing playlists Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Getting Tidal Cloud Configuration Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Getting Qobuz Cloud Configuration Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Asking plugin for UI Config Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Getting Spotify Cloud Configuration Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Asking plugin for UI Config Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Saving Spotify Acccount Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Got it Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Got Tidal Cloud Configuration Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Got it Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::ClearQueue Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::stop Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::clearPlayQueue Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::saveQueue Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushQueue Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: error: updateQueue error: null Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: error: updateQueue error: null Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 1ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetBrowseSources Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetBrowseSources Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Starting UPNP Playback Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Preparing playback through UPNP Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getTrack 0 Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 1ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 1ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 1ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 3ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 1ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces system playlist update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: Ignoring MPD Status Update Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 2ms Jul 11 06:25:12 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 1ms Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces state update: player Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::getState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand status Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces state update: player Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::getState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand status Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand status took 2 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces state update: player Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::getState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand status Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand status took 3 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand playlistinfo took 2 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand status took 1 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseTrackInfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::servicePushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: In UPNP mode Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Wave","artist":"Antonio Carlos Jobim","album":"Wave","uri":"http://192.168.219.44:16895/qobuz/76340680.flac","trackType":"qobuz"} Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: CURRENT POSITION 0 Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState stateService play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState currentStatus stop Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 17ms Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: ---------------------------- MPD announces state update: player Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::getState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand status Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand playlistinfo took 27 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand status took 2 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseTrackInfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseTrackInfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::servicePushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: In UPNP mode Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Wave","artist":"Antonio Carlos Jobim","album":"Wave","uri":"http://192.168.219.44:16895/qobuz/76340680.flac","trackType":"qobuz"} Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: CURRENT POSITION 0 Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState stateService play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState currentStatus play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Received an update from plugin. extracting info from payload Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::servicePushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: In UPNP mode Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":175,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Wave","artist":"Antonio Carlos Jobim","album":"Wave","uri":"http://192.168.219.44:16895/qobuz/76340680.flac","trackType":"qobuz"} Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: CURRENT POSITION 0 Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState stateService play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState currentStatus play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Received an update from plugin. extracting info from payload Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 69ms Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 68ms Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: sendMpdCommand playlistinfo took 38 milliseconds Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: ControllerMpd::parseTrackInfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ControllerMpd::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::servicePushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: In UPNP mode Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1097,"duration":175,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"2803 Kbps","isStreaming":false,"title":"Wave","artist":"Antonio Carlos Jobim","album":"Wave","uri":"http://192.168.219.44:16895/qobuz/76340680.flac","trackType":"qobuz"} Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: verbose: CURRENT POSITION 0 Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState stateService play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::syncState currentStatus play Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: Received an update from plugin. extracting info from payload Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::pushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioPushState Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output update for this device Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: MRS: Pushing multiroomSync output Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: ------------------------------ 56ms Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreStateMachine::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CorePlayQueue::getQueue Jul 11 06:25:13 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: Received Get System Info Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: Discovery: Getting this device information Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:14 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: Received Get System Info Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: Discovery: Getting this device information Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::volumioGetState Jul 11 06:25:15 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 11 06:25:16 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Jul 11 06:25:19 volumiosamadhy-tinker volumio[1165]: info: Disabling MyMusic plugin upnp Jul 11 06:25:20 volumiosamadhy-tinker sudo[5024]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop upmpdcli.service Jul 11 06:25:20 volumiosamadhy-tinker sudo[5024]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: error: Upnp client error: Error: This socket has been ended by the other party Jul 11 06:25:20 volumiosamadhy-tinker systemd[1]: Stopping UPnP Renderer front-end to MPD... Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: info: Enabling MyMusic plugin upnp Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: info: Enabling plugin upnp Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: info: Loading plugin "upnp"... Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: info: [1720679120390] Starting Upmpd Daemon Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: Error: listen EADDRINUSE: address already in use :::6599 Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at Server.setupListenHandle [as _listen2] (net.js:1331:16) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at listenInCluster (net.js:1379:12) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at Server.listen (net.js:1465:7) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at UpnpInterface.onVolumioStart (/volumio/app/plugins/audio_interface/upnp/index.js:78:17) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:255:38) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: at processTicksAndRejections (internal/process/task_queues.js:77:11) { Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: code: 'EADDRINUSE', Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: errno: -98, Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: syscall: 'listen', Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: address: '::', Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: port: 6599 Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: } Jul 11 06:25:20 volumiosamadhy-tinker volumio[1165]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 11 06:25:20 volumiosamadhy-tinker sudo[5041]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-11 06:24 Jul 11 06:25:20 volumiosamadhy-tinker sudo[5041]: 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="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:59:47 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="5afa2cba9d125c5d0103869143516973"