-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2025-12-31 12:36:32 CST. -- Dec 31 12:35:00 home-player kernel: asoc-aml-card auge_sound: tdm playback stop Dec 31 12:35:00 home-player kernel: tdm playback mute: 1, lane_cnt = 4 Dec 31 12:35:00 home-player kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:tdmc Dec 31 12:35:00 home-player volumio[2545]: info: Dec 31 12:35:00 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:00 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:00 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:00 home-player volumio[2545]: info: Dec 31 12:35:00 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:00 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:00 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:00 home-player volumio[2545]: info: Dec 31 12:35:00 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:00 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:00 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:00 home-player volumio[2545]: info: sendMpdCommand status took 20 milliseconds Dec 31 12:35:00 home-player volumio[2545]: info: sendMpdCommand status took 16 milliseconds Dec 31 12:35:00 home-player volumio[2545]: info: sendMpdCommand status took 1 milliseconds Dec 31 12:35:00 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:00 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:00 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: CorePlayQueue::getTrack 0 Dec 31 12:35:00 home-player volumio[2545]: 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} Dec 31 12:35:00 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::syncState stateService stop Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::stPlaybackTimer Dec 31 12:35:00 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: CorePlayQueue::getTrack 0 Dec 31 12:35:00 home-player volumio[2545]: 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} Dec 31 12:35:00 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::syncState stateService stop Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus stop Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: No code Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: CorePlayQueue::getTrack 0 Dec 31 12:35:00 home-player volumio[2545]: 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} Dec 31 12:35:00 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::syncState stateService stop Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus stop Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: No code Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2545]: info: ------------------------------ 46ms Dec 31 12:35:00 home-player volumio[2545]: info: ------------------------------ 42ms Dec 31 12:35:00 home-player volumio[2545]: info: ------------------------------ 38ms Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:00 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:00 home-player volumio[2819]: 0 Dec 31 12:35:00 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:00 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:00 home-player volumio[2545]: info: Dec 31 12:35:00 home-player volumio[2545]: ---------------------------- Client requests Volume 1 Dec 31 12:35:00 home-player volumio[2545]: info: VolumeController::SetAlsaVolume1 Dec 31 12:35:00 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:00 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:00 home-player volumio[2819]: [158B blob data] Dec 31 12:35:00 home-player volumio[2819]: {"time":1767155700689,"response":"volume Success"}1 Dec 31 12:35:01 home-player volumio[2545]: info: Clearing queue after UPNP request Dec 31 12:35:02 home-player volumio[2545]: info: CoreStateMachine::ClearQueue Dec 31 12:35:02 home-player volumio[2545]: info: CoreStateMachine::stop Dec 31 12:35:02 home-player volumio[2545]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 31 12:35:02 home-player volumio[2545]: info: CorePlayQueue::clearPlayQueue Dec 31 12:35:02 home-player volumio[2545]: info: CorePlayQueue::saveQueue Dec 31 12:35:02 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:02 home-player volumio[2545]: info: CoreCommandRouter::volumioPushQueue Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: error: updateQueue error: null Dec 31 12:35:02 home-player volumio[2545]: error: updateQueue error: null Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 6ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 3ms Dec 31 12:35:02 home-player volumio[2545]: error: updateQueue error: null Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 2ms Dec 31 12:35:02 home-player volumio[2545]: info: Starting UPNP Playback Dec 31 12:35:02 home-player volumio[2545]: info: Preparing playback through UPNP Dec 31 12:35:02 home-player volumio[2545]: info: CoreCommandRouter::volumioGetState Dec 31 12:35:02 home-player volumio[2545]: info: CorePlayQueue::getTrack 0 Dec 31 12:35:02 home-player volumio[2545]: info: CoreStateMachine::setConsumeUpdateService mpd Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 9ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 7ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 5ms Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 8ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 6ms Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 6ms Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 7ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 4ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 3ms Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 1ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 0ms Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 8ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 7ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 6ms Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: Dec 31 12:35:02 home-player volumio[2545]: ---------------------------- MPD announces system playlist update Dec 31 12:35:02 home-player volumio[2545]: info: Ignoring MPD Status Update Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 3ms Dec 31 12:35:02 home-player volumio[2545]: info: ------------------------------ 0ms Dec 31 12:35:03 home-player volumio[2819]: 0 Dec 31 12:35:03 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:03 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- Client requests Volume 1 Dec 31 12:35:03 home-player volumio[2545]: info: VolumeController::SetAlsaVolume1 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2819]: [158B blob data] Dec 31 12:35:03 home-player volumio[2819]: {"time":1767155703123,"response":"volume Success"}1 Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:03 home-player kernel: aml_tdm_open Dec 31 12:35:03 home-player kernel: Not init audio effects Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:03 home-player kernel: audio_ddr_mngr: frddrs[0] registered by device ff642000.audiobus:tdmc Dec 31 12:35:03 home-player kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Dec 31 12:35:03 home-player kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Dec 31 12:35:03 home-player kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Dec 31 12:35:03 home-player kernel: asoc aml_dai_set_tdm_fmt, 0x4011, ffffffc01f8eaa18, id(2), clksel(2) Dec 31 12:35:03 home-player kernel: aml_dai_set_tdm_fmt(), fmt not change Dec 31 12:35:03 home-player kernel: dump_pcm_setting(ffffffc01f8eaa18) Dec 31 12:35:03 home-player kernel: pcm_mode(1) Dec 31 12:35:03 home-player kernel: sysclk(11289600) Dec 31 12:35:03 home-player kernel: sysclk_bclk_ratio(4) Dec 31 12:35:03 home-player kernel: bclk(2822400) Dec 31 12:35:03 home-player kernel: bclk_lrclk_ratio(64) Dec 31 12:35:03 home-player kernel: lrclk(44100) Dec 31 12:35:03 home-player kernel: tx_mask(0x3) Dec 31 12:35:03 home-player kernel: rx_mask(0x3) Dec 31 12:35:03 home-player kernel: slots(2) Dec 31 12:35:03 home-player kernel: slot_width(32) Dec 31 12:35:03 home-player kernel: lane_mask_in(0x2) Dec 31 12:35:03 home-player kernel: lane_mask_out(0x1) Dec 31 12:35:03 home-player kernel: lane_oe_mask_in(0x0) Dec 31 12:35:03 home-player kernel: lane_oe_mask_out(0x0) Dec 31 12:35:03 home-player kernel: lane_lb_mask_in(0x0) Dec 31 12:35:03 home-player kernel: aml_dai_set_tdm_sysclk(), mpll no change, keep clk Dec 31 12:35:03 home-player kernel: aml_dai_set_tdm_sysclk(), mclk no change, keep clk Dec 31 12:35:03 home-player kernel: set mclk:11289600, mpll:22579200, get mclk:11289593, mpll:22579186 Dec 31 12:35:03 home-player kernel: aml_dai_set_clkdiv, div 4, clksel(2) Dec 31 12:35:03 home-player kernel: aml_dai_set_bclk_ratio, select I2S mode Dec 31 12:35:03 home-player kernel: tdm playback mute: 0, lane_cnt = 4 Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand status took 19 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand status took 19 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand status took 19 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand status took 5 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 31 12:35:03 home-player kernel: asoc-aml-card auge_sound: tdm playback enable Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:03 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:03 home-player volumio[2545]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:03 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState stateService play Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus stop Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:03 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:03 home-player volumio[2545]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:03 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState stateService play Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:03 home-player volumio[2545]: info: Received an update from plugin. extracting info from payload Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:03 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:03 home-player volumio[2545]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:03 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState stateService play Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:03 home-player volumio[2545]: info: Received an update from plugin. extracting info from payload Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: ------------------------------ 35ms Dec 31 12:35:03 home-player volumio[2545]: info: ------------------------------ 42ms Dec 31 12:35:03 home-player volumio[2545]: info: ------------------------------ 41ms Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:03 home-player volumio[2545]: info: Dec 31 12:35:03 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand status took 1 milliseconds Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:03 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:03 home-player volumio[2545]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:03 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState stateService play Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:03 home-player volumio[2545]: info: Received an update from plugin. extracting info from payload Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: ------------------------------ 34ms Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 31 12:35:03 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 14 milliseconds Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:03 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:03 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:03 home-player volumio[2545]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:03 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState stateService play Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:03 home-player volumio[2545]: info: Received an update from plugin. extracting info from payload Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:03 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:03 home-player volumio[2545]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:03 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState stateService play Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:03 home-player volumio[2545]: info: Received an update from plugin. extracting info from payload Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:03 home-player volumio[2545]: info: ------------------------------ 29ms Dec 31 12:35:03 home-player volumio[2545]: info: ------------------------------ 28ms Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:03 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:03 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:03 home-player volumio[2545]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/nico/Love%20Mail/bd4a2d3f-9abc-4d2a-9ce4-b2f4a64e25b9.jpg' Dec 31 12:35:05 home-player volumio[2819]: 6 Dec 31 12:35:05 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:05 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:05 home-player volumio[2545]: info: Dec 31 12:35:05 home-player volumio[2545]: ---------------------------- Client requests Volume 6 Dec 31 12:35:05 home-player volumio[2545]: info: VolumeController::SetAlsaVolume6 Dec 31 12:35:05 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:05 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:05 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:05 home-player volumio[2819]: [158B blob data] Dec 31 12:35:05 home-player volumio[2819]: {"time":1767155705179,"response":"volume Success"}6 Dec 31 12:35:05 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:05 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:05 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:06 home-player volumio[2819]: 1 Dec 31 12:35:06 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:06 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:06 home-player volumio[2545]: info: Dec 31 12:35:06 home-player volumio[2545]: ---------------------------- Client requests Volume 1 Dec 31 12:35:06 home-player volumio[2545]: info: VolumeController::SetAlsaVolume1 Dec 31 12:35:06 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:06 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:06 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:06 home-player volumio[2819]: [158B blob data] Dec 31 12:35:06 home-player volumio[2819]: {"time":1767155706402,"response":"volume Success"}1 Dec 31 12:35:06 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:06 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:06 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:08 home-player volumio[2819]: 0 Dec 31 12:35:08 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:08 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:08 home-player volumio[2545]: info: Dec 31 12:35:08 home-player volumio[2545]: ---------------------------- Client requests Volume 1 Dec 31 12:35:08 home-player volumio[2545]: info: VolumeController::SetAlsaVolume1 Dec 31 12:35:08 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:08 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:08 home-player volumio[2819]: [158B blob data] Dec 31 12:35:08 home-player volumio[2819]: {"time":1767155708868,"response":"volume Success"}1 Dec 31 12:35:08 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:08 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:08 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:12 home-player volumio[2819]: 6 Dec 31 12:35:12 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:12 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:12 home-player volumio[2545]: info: Dec 31 12:35:12 home-player volumio[2545]: ---------------------------- Client requests Volume 6 Dec 31 12:35:12 home-player volumio[2545]: info: VolumeController::SetAlsaVolume6 Dec 31 12:35:12 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:12 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:12 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:12 home-player volumio[2819]: [158B blob data] Dec 31 12:35:12 home-player volumio[2819]: {"time":1767155712113,"response":"volume Success"}6 Dec 31 12:35:12 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:12 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:12 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:13 home-player volumio[2819]: 11 Dec 31 12:35:13 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:13 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:13 home-player volumio[2545]: info: Dec 31 12:35:13 home-player volumio[2545]: ---------------------------- Client requests Volume 11 Dec 31 12:35:13 home-player volumio[2545]: info: VolumeController::SetAlsaVolume11 Dec 31 12:35:13 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:13 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:13 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:13 home-player volumio[2819]: [158B blob data] Dec 31 12:35:13 home-player volumio[2819]: {"time":1767155713700,"response":"volume Success"}11 Dec 31 12:35:13 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:13 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:13 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:14 home-player volumio[2819]: 6 Dec 31 12:35:14 home-player volumio[2819]: % Total % Received % Xferd Average Speed Time Time Time Current Dec 31 12:35:14 home-player volumio[2819]: Dload Upload Total Spent Left Speed Dec 31 12:35:14 home-player volumio[2545]: info: Dec 31 12:35:14 home-player volumio[2545]: ---------------------------- Client requests Volume 6 Dec 31 12:35:14 home-player volumio[2545]: info: VolumeController::SetAlsaVolume6 Dec 31 12:35:14 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:14 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:14 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:14 home-player volumio[2819]: [158B blob data] Dec 31 12:35:14 home-player volumio[2819]: {"time":1767155714713,"response":"volume Success"}6 Dec 31 12:35:14 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:14 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:14 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:44 home-player volumio[2545]: info: Dec 31 12:35:44 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:44 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:44 home-player kernel: asoc-aml-card auge_sound: tdm playback stop Dec 31 12:35:44 home-player kernel: tdm playback mute: 1, lane_cnt = 4 Dec 31 12:35:44 home-player kernel: audio_ddr_mngr: frddrs[0] released by device ff642000.audiobus:tdmc Dec 31 12:35:44 home-player volumio[2545]: info: Dec 31 12:35:44 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:44 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:44 home-player volumio[2545]: info: Dec 31 12:35:44 home-player volumio[2545]: ---------------------------- MPD announces state update: player Dec 31 12:35:44 home-player volumio[2545]: info: ControllerMpd::getState Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand status Dec 31 12:35:44 home-player volumio[2545]: info: sendMpdCommand status took 7 milliseconds Dec 31 12:35:44 home-player volumio[2545]: info: sendMpdCommand status took 6 milliseconds Dec 31 12:35:44 home-player volumio[2545]: info: sendMpdCommand status took 4 milliseconds Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::parseState Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 31 12:35:44 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 31 12:35:44 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 31 12:35:44 home-player volumio[2545]: info: sendMpdCommand playlistinfo took 4 milliseconds Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:44 home-player volumio[2545]: verbose: ControllerMpd::parseTrackInfo Dec 31 12:35:44 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:44 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:44 home-player volumio[2545]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41737,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:44 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::syncState stateService pause Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::stPlaybackTimer Dec 31 12:35:44 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:44 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:44 home-player volumio[2545]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41737,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:44 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::syncState stateService pause Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::stPlaybackTimer Dec 31 12:35:44 home-player volumio[2545]: info: ControllerMpd::pushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::servicePushState Dec 31 12:35:44 home-player volumio[2545]: verbose: In UPNP mode Dec 31 12:35:44 home-player volumio[2545]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":41737,"duration":210,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Love Mail","artist":"nico","album":"Love Mail","uri":"http://m8.music.126.net/20251231130001/2e86094734cbe3dbe2845822023bb285/ymusic/7512/0eb5/f404/9551da12a4f812cc8a8550d9ab05c5b7.mp3?vuutv=J9xSWNkmd09Sr1RsJMXvzicy3qI2rieY89pXOjfOWDrYIC3+L85Eg9UG6j/F5AoOu+PB5GSBldqCOmoPc5bE0wCiQYdBlAbYW0a6KI+Weec=","trackType":""} Dec 31 12:35:44 home-player volumio[2545]: verbose: CURRENT POSITION 0 Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::syncState stateService pause Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::syncState currentStatus play Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::pushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::volumioPushState Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::stPlaybackTimer Dec 31 12:35:44 home-player volumio[2545]: info: ------------------------------ 38ms Dec 31 12:35:44 home-player volumio[2545]: info: ------------------------------ 36ms Dec 31 12:35:44 home-player volumio[2545]: info: ------------------------------ 34ms Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:44 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:44 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:35:44 home-player volumio[2545]: info: CoreCommandRouter::volumioGetQueue Dec 31 12:35:44 home-player volumio[2545]: info: CoreStateMachine::getQueue Dec 31 12:35:44 home-player volumio[2545]: info: CorePlayQueue::getQueue Dec 31 12:36:32 home-player volumio[2545]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 12:36:32 home-player volumio[2545]: Error: connect ETIMEDOUT 31.13.70.33:443 Dec 31 12:36:32 home-player volumio[2545]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 31 12:36:32 home-player volumio[2545]: errno: -110, Dec 31 12:36:32 home-player volumio[2545]: code: 'ETIMEDOUT', Dec 31 12:36:32 home-player volumio[2545]: syscall: 'connect', Dec 31 12:36:32 home-player volumio[2545]: address: '31.13.70.33', Dec 31 12:36:32 home-player volumio[2545]: port: 443 Dec 31 12:36:32 home-player volumio[2545]: } Dec 31 12:36:32 home-player volumio[2545]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 31 12:36:32 home-player sudo[4570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-31 12:35 Dec 31 12:36:32 home-player sudo[4570]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="811ff8312d42f9da0260be1d353081a805678820" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 07 Jul 2025 03:41:45 PM CEST" VOLUMIO_VERSION="3.819" VOLUMIO_HARDWARE="odroidn2" VOLUMIO_DEVICENAME="Odroid-N2" VOLUMIO_HASH="aa8e2111ed7ad6287fe333440aae5701"