-- Logs begin at Thu 2019-02-14 11:11:58 CET, end at Fri 2024-08-23 16:33:27 CEST. -- Aug 23 16:32:17 volumio nmbd[2495]: [2024/08/23 16:32:17.850182, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 23 16:32:17 volumio nmbd[2495]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.178.100 for name WORKGROUP<1d>. Aug 23 16:32:17 volumio nmbd[2495]: This response was from IP 192.168.178.31, reporting an IP address of 192.168.178.31. Aug 23 16:32:17 volumio nmbd[2495]: [2024/08/23 16:32:17.850524, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) Aug 23 16:32:17 volumio nmbd[2495]: query_name_response: Multiple (3) responses received for a query on subnet 192.168.178.100 for name WORKGROUP<1d>. Aug 23 16:32:17 volumio nmbd[2495]: This response was from IP 192.168.178.31, reporting an IP address of 192.168.178.31. Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::volumioPause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::stPlaybackTimer Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::servicePause Aug 23 16:32:20 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::servicePause Aug 23 16:32:20 volumio volumio[2584]: info: [1724423540081] ControllerTidal::pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::pause Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand pause Aug 23 16:32:20 volumio volumio[2584]: info: Aug 23 16:32:20 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:32:20 volumio kernel: asoc-aml-card auge_sound: tdm playback stop Aug 23 16:32:20 volumio kernel: tdm playback mute: 1, lane_cnt = 4 Aug 23 16:32:20 volumio kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:tdmc Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand pause took 7 milliseconds Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:32:20 volumio volumio[2584]: info: Aug 23 16:32:20 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:32:20 volumio volumio[2584]: info: Aug 23 16:32:20 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:32:20 volumio volumio[2584]: info: Aug 23 16:32:20 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand status took 8 milliseconds Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand status took 6 milliseconds Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand status took 2 milliseconds Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand status took 1 milliseconds Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand playlistinfo took 0 milliseconds Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseTrackInfo Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseTrackInfo Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:32:20 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:32:20 volumio volumio[2584]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":128607,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1054 Kbps","isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:32:20 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState stateService pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::stPlaybackTimer Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:32:20 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:32:20 volumio volumio[2584]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":128607,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1054 Kbps","isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:32:20 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState stateService pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::stPlaybackTimer Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:32:20 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:32:20 volumio volumio[2584]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":128607,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1054 Kbps","isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:32:20 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState stateService pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::stPlaybackTimer Aug 23 16:32:20 volumio volumio[2584]: info: ------------------------------ 26ms Aug 23 16:32:20 volumio volumio[2584]: info: ------------------------------ 24ms Aug 23 16:32:20 volumio volumio[2584]: info: ------------------------------ 23ms Aug 23 16:32:20 volumio volumio[2584]: info: sendMpdCommand playlistinfo took 16 milliseconds Aug 23 16:32:20 volumio volumio[2584]: verbose: ControllerMpd::parseTrackInfo Aug 23 16:32:20 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:32:20 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:32:20 volumio volumio[2584]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":128607,"duration":186,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1054 Kbps","isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:32:20 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState stateService pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus pause Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:32:20 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:32:20 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:32:20 volumio volumio[2584]: info: CoreStateMachine::stPlaybackTimer Aug 23 16:32:20 volumio volumio[2584]: info: ------------------------------ 22ms Aug 23 16:32:23 volumio volumio[2584]: info: CoreCommandRouter::volumioGetState Aug 23 16:32:25 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:25 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:25 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:25 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:26 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:26 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:26 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:29 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 16:32:29 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 16:32:29 volumio volumio[2584]: info: Discovery: Getting this device information Aug 23 16:32:29 volumio volumio[2584]: info: CoreCommandRouter::volumioGetState Aug 23 16:32:29 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: cd_controller , handleBrowseUri Aug 23 16:32:30 volumio volumio[2584]: info: Preload queue cleared Aug 23 16:32:30 volumio volumio[2584]: info: Executing endpoint getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: Executing endpoint getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: Executing endpoint getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: Executing endpoint getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getSimilarAlbums Aug 23 16:32:30 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:30 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:30 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:31 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:31 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:31 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:31 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:31 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:31 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:31 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:31 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:31 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:31 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:31 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:31 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:48 volumio volumio[2584]: info: CoreCommandRouter::volumioGetState Aug 23 16:32:50 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:50 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:50 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:50 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:50 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:32:50 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 16:32:53 volumio volumio[2584]: info: Retrieving Cloud Streaming UI Aug 23 16:32:53 volumio volumio[2584]: info: Getting Tidal Cloud Configuration Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 16:32:53 volumio volumio[2584]: info: Getting Qobuz Cloud Configuration Aug 23 16:32:53 volumio volumio[2584]: info: Asking plugin for UI Config Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 16:32:53 volumio volumio[2584]: info: Getting Spotify Cloud Configuration Aug 23 16:32:53 volumio volumio[2584]: info: Asking plugin for UI Config Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 16:32:53 volumio volumio[2584]: info: Saving Spotify Acccount Aug 23 16:32:53 volumio volumio[2584]: info: Got it Aug 23 16:32:53 volumio volumio[2584]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Aug 23 16:32:53 volumio volumio[2584]: info: Got Tidal Cloud Configuration Aug 23 16:32:53 volumio volumio[2584]: info: Got it Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 16:32:53 volumio volumio[2584]: info: CoreCommandRouter::volumioGetBrowseSources Aug 23 16:32:54 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 16:32:55 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Aug 23 16:32:58 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 16:32:59 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 23 16:32:59 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 23 16:32:59 volumio volumio[2584]: info: Discovery: Getting this device information Aug 23 16:32:59 volumio volumio[2584]: info: CoreCommandRouter::volumioGetState Aug 23 16:32:59 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 23 16:33:02 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Aug 23 16:33:07 volumio volumio[2584]: info: CoreCommandRouter::volumioGetState Aug 23 16:33:08 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:33:08 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:33:08 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:33:08 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:33:09 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:33:09 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:33:09 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:33:09 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:33:09 volumio volumio[2584]: info: Executing endpoint metavolumio Aug 23 16:33:09 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Aug 23 16:33:16 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Aug 23 16:33:16 volumio volumio[2584]: info: Preload queue cleared Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: smart_inputs , handleBrowseUri Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioStop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::updateTrackBlock Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrackBlock Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::stPlaybackTimer Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::serviceStop Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::serviceStop Aug 23 16:33:26 volumio volumio[2584]: info: [1724423606399] ControllerTidal::stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::setConsumeUpdateService mpd Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::stop Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand stop Aug 23 16:33:26 volumio volumio[2584]: error: Failed to execute browseSource, failure: TypeError: Cannot read property 'then' of undefined Aug 23 16:33:26 volumio volumio[2584]: info: Aug 23 16:33:26 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:33:26 volumio volumio[2584]: info: sendMpdCommand stop took 10 milliseconds Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:33:26 volumio volumio[2584]: info: Aug 23 16:33:26 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:33:26 volumio volumio[2584]: info: Aug 23 16:33:26 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:33:26 volumio volumio[2584]: info: Aug 23 16:33:26 volumio volumio[2584]: ---------------------------- MPD announces state update: player Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::getState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand status Aug 23 16:33:26 volumio volumio[2584]: info: sendMpdCommand status took 2 milliseconds Aug 23 16:33:26 volumio volumio[2584]: info: sendMpdCommand status took 3 milliseconds Aug 23 16:33:26 volumio volumio[2584]: info: sendMpdCommand status took 2 milliseconds Aug 23 16:33:26 volumio volumio[2584]: info: sendMpdCommand status took 2 milliseconds Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::parseState Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 23 16:33:26 volumio volumio[2584]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 23 16:33:26 volumio volumio[2584]: verbose: ControllerMpd::parseTrackInfo Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:33:26 volumio volumio[2584]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:33:26 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState stateService stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: No code Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:33:26 volumio volumio[2584]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:33:26 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState stateService stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: No code Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:33:26 volumio volumio[2584]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:33:26 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState stateService stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: No code Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: ControllerMpd::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: CorePlayQueue::getTrack 1 Aug 23 16:33:26 volumio volumio[2584]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"182432626&soundQuality=LOSSLESS","artist":null,"album":null,"uri":"http://127.0.0.1:3245?data=tidal://song/182432626&soundQuality=LOSSLESS","trackType":"tidal"} Aug 23 16:33:26 volumio volumio[2584]: verbose: CURRENT POSITION 1 Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState stateService stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::syncState currentStatus stop Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: No code Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: ------------------------------ 39ms Aug 23 16:33:26 volumio volumio[2584]: info: ------------------------------ 38ms Aug 23 16:33:26 volumio volumio[2584]: info: ------------------------------ 38ms Aug 23 16:33:26 volumio volumio[2584]: info: ------------------------------ 38ms Aug 23 16:33:26 volumio volumio[2584]: info: Enabling Audio Input 0 Aug 23 16:33:26 volumio sudo[5904]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart audioinput.service Aug 23 16:33:26 volumio sudo[5904]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 23 16:33:26 volumio systemd[1]: Started Audio Input Service. Aug 23 16:33:26 volumio sudo[5904]: pam_unix(sudo:session): session closed for user root Aug 23 16:33:26 volumio volumio[2584]: info: Successfully Started Audio Input Aug 23 16:33:26 volumio volumio[2584]: info: Notifying AUDIO INPUT Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::servicePushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreStateMachine::pushState Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumioPushState Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output update for this device Aug 23 16:33:26 volumio volumio[2584]: info: MRS: Pushing multiroomSync output Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::volumiosetSourceActiveaudio_input/0 Aug 23 16:33:26 volumio volumio[2584]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 23 16:33:26 volumio volumio[2584]: Cannot find translation for source AML-AUGESOUND Aug 23 16:33:26 volumio volumio[2584]: Cannot find translation for source TIDAL Aug 23 16:33:26 volumio volumio[2584]: Cannot find translation for source Audio CD Aug 23 16:33:26 volumio audioinput[5906]: /usr/bin/sox FAIL formats: can't open input `plughw:0,0': snd_pcm_open error: No such file or directory Aug 23 16:33:26 volumio systemd[1]: audioinput.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Aug 23 16:33:26 volumio systemd[1]: audioinput.service: Failed with result 'exit-code'. Aug 23 16:33:27 volumio volumio[2584]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 16:33:27 volumio volumio[2584]: ReferenceError: elf is not defined Aug 23 16:33:27 volumio volumio[2584]: at SmartInputs.detectInputResolution (/myvolumio/plugins/music_service/smart_inputs/smart_inputs_real:1:9620) Aug 23 16:33:27 volumio volumio[2584]: at Timeout._onTimeout (/myvolumio/plugins/music_service/smart_inputs/smart_inputs_real:1:8410) Aug 23 16:33:27 volumio volumio[2584]: at listOnTimeout (internal/timers.js:557:17) Aug 23 16:33:27 volumio volumio[2584]: at processTimers (internal/timers.js:500:7) Aug 23 16:33:27 volumio volumio[2584]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 23 16:33:27 volumio sudo[5923]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-23 16:32 Aug 23 16:33:27 volumio sudo[5923]: 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="6e682b9410d28f3874f90b2d7789db824a859264" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="7c81f20187867c3bd55475ead0f12800fe93082c" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 08 Jun 2024 11:36:21 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="odroidn2" VOLUMIO_DEVICENAME="Odroid-N2" VOLUMIO_HASH="c39fcc4e0437133fe1c7de2984ec9236"