espressif / esp-idf

Espressif IoT Development Framework. Official development framework for Espressif SoCs.
Apache License 2.0
13.25k stars 7.19k forks source link

Major issue on A2DP with ESP32D0WDR2 (IDFGH-9842) #11169

Open 0x0fe opened 1 year ago

0x0fe commented 1 year ago

Answers checklist.

General issue report

So the context is a consumer product design which uses an external DAC (ES7148) and provides audio playback via different sources, MMC, wifi and bluetooth (A2DP), initial tests were conducted on ESP32D0WDQ6 and everything worked fine, the A2DP is smooth, no stuttering or anything. The A2DP firmware is based on ESP-IDF v4.4.4.

For final implementation we switched to D0WDR2 since we use both wifi and bluetooth and a relatively large application logic, additional PSRAM is required.

Sadly we found that the D0WDR2 cannot work normally for the A2DP, there is a massive stuttering, and the playback is totally abnormal. There is no playback issue when playing audio from MMC.

In order to confirm the problem we performed multiple test, at first changing compile time options such as Flash speed (40M and 80M) CPU speed (160M and 240M) PSRAM enabled/disabled, and even buffer sizes for I2S and A2DP, we found no difference at all, in all cases the stuttering was still present with the same magnitude on the D0WDR2 and no stuttering at all on D0WDQ6.

Then we decided to make comparative tests with devkit instead of the product hardware, we changed the DAC for one without master clock (MCLK) as i suspected it could be related to MCLK, so we used : -one devkit with D0WDQ6 + MAX98357A -one devkit with D0WDR2 + MAX98357A Identical pinmap, and identical firmware binary flashed in both.

We tested the same way, with an iphone as source and running a simple A2DP firmware (also tried different source such as PC): -D0WDQ6 : perfectly smooth, no stuttering at all -D0WDR2 : massive stuttering all over, unusable

With the log in verbose mode, there is absolutely no error or warning of any kind, both output exactly the same thing. So the problem lies somewhere deep and is not a simple buffer underrun or something (well unless it doesnt gets catched).

Sadly, we can now confirm the problem comes from the D0WDR2 chip itself and not the hardware, the DAC or the firmware. I have no idea yet of what causes this, nor what exactly changed in the die between D0WDQ6 and D0WDR2, both are rev 3 so i would have expected the D0WDR2 just be a D0WDQ6 with a PSRAM attached, but apparently it is not the case ,I2S block? bluetooth stack? who knows.

So please espressif have a look at that. Attached is a quick audio recording of the problem (from an iphone).

Dowdr2 a2dp stuttering.zip

wmy-espressif commented 1 year ago

Hi @0x0fe , thanks for your question. I am a Bluetooth guy and I will check the Bluetooth stack for you first.

I would like to ask some questions on how to reproduce the issue, so that I can perform some local tests:

  1. You mentioned you use a simple A2DP firmware, did you use the a2dp_sink example provided with esp-idf, or you an example in esp-adf? Do you make some changes on the example? I would like to know how I can get a minimum application to reproduce.
  2. As far as I know, DOWDR2 has embedded PSRAM(2M), compared with D0WDQ6. You have mentioned you have performed multile tests including enable/disable PSRAM. Can you provide your sdkconfig file used to reproduce this issue, both for the cases that PSRAM is enabled and disabled?
0x0fe commented 1 year ago

Hello, thank you for the return. For testing we used this implementation https://github.com/pschatzmann/ESP32-A2DP which is a direct port of the IDF example for A2DP sink. Yes it has been tested with PSRAM enabled and disabled, via the menu in arduino since the firmware was generated here. By the way, we tested on D0WD too, with external PSRAM (a wrover module) and it works fine, so the problem really only occurs on D0WDR2. IT does not occur on D0WD nor D0WDQ6.

For the firmware, i suggest you try with the same configuration we used, I can provide ready made binaries if you want, If you use a different DAC let me know the I2S mode. On our side for production we use ES7148 and for tests we used MAX98357A. In both case the pinmap is as follow.

#define MCK             3
#define WS              5
#define BCK             18
#define DAT             21
#define MUTE            4

Also relevant : here are the I2S DMA buffer size/count and A2DP buffer size/count used for these tests (we tried with different sizes too and it did not change anything).

#define I2S_BUFFER_COUNT 20
#define I2S_BUFFER_SIZE  512

#define A2DP_BUFFER_COUNT 30
#define A2DP_BUFFER_SIZE 512
0x0fe commented 1 year ago

So, PH stands for Philips and RJ for Righ Justifed, which are the I2S formats for ES1748 and MAX98357A, respectively.

BS_FB2_A2DP_PH_ES7148_PSRAM-OFF.zip BS_FB2_A2DP_RJ_MAX98357A_PSRAM-OFF.zip BS_FB2_A2DP_PH_ES7148_PSRAM-ON.zip BS_FB2_A2DP_RJ_MAX98357A_PSRAM-ON.zip

These are 4MB (32Mbit) Flash full dumps and thus are intended to be flashed at address 0.

and the project : BS_FB2_TEST_A2DP.zip

wmy-espressif commented 1 year ago

Hi @0x0fe thanks for the information. I will try to perform some test locally. According to my information, there are some espressif customers that used D0WDR2 in their audio application products.

By the way, how many pieces of D0WDR2 chips have you tested, did they all have this issue and make no differences?

0x0fe commented 1 year ago

Hi @wmy-espressif We have tested several units, so it is not a problem with one units, all D0WDR2 chips we tested shown the same problem, also, as mentioned, it is not structly an I2S problem because when we play audio from other sources, such as SD_MMC there is no problem, the audio is not stuttering. So it only occurs with the A2DP.

xiongweichao commented 1 year ago

Hi @0x0fe ,

Sorry, I don't know how to run your project. Can you test it in the following way?

#include "BluetoothA2DPSink.h"

BluetoothA2DPSink a2dp_sink;

void setup() {

    static i2s_config_t i2s_config = {
      .mode = (i2s_mode_t) (I2S_MODE_MASTER | I2S_MODE_TX),
      .sample_rate = 44100, // updated automatically by A2DP
      .bits_per_sample = (i2s_bits_per_sample_t)32,
      .channel_format = I2S_CHANNEL_FMT_RIGHT_LEFT,
      .communication_format = (i2s_comm_format_t) (I2S_COMM_FORMAT_STAND_I2S),
      .intr_alloc_flags = 0, // default interrupt priority
      .dma_buf_count = 8,
      .dma_buf_len = 64,
      .use_apll = true,
      .tx_desc_auto_clear = true // avoiding noise in case of data unavailability
    };
    i2s_pin_config_t my_pin_config = {
    .bck_io_num = 26,
    .ws_io_num = 22,
    .data_out_num = 25,
    .data_in_num = I2S_PIN_NO_CHANGE
    };
    a2dp_sink.set_pin_config(my_pin_config);

    a2dp_sink.set_i2s_config(i2s_config);
    a2dp_sink.start("MyMusic");
}

void loop() {
  // disable watchdog
}

Thanks

0x0fe commented 1 year ago

ok, let me test

0x0fe commented 1 year ago

so, i tested, same problem

#include "BluetoothA2DPSink.h"

BluetoothA2DPSink a2dp_sink;

#define MCK             3
#define WS              5
#define BCK             18
#define DAT             21
#define MUTE            4

void setup() {

    static i2s_config_t i2s_config = {
      .mode = (i2s_mode_t) (I2S_MODE_MASTER | I2S_MODE_TX),
      .sample_rate = 44100, // updated automatically by A2DP
      .bits_per_sample = (i2s_bits_per_sample_t)16,
      .channel_format = I2S_CHANNEL_FMT_RIGHT_LEFT,
      .communication_format = (i2s_comm_format_t) (I2S_COMM_FORMAT_STAND_I2S),
      //.communication_format = (i2s_comm_format_t) (I2S_PHILIPS_FORMAT),
      .intr_alloc_flags = 0, // default interrupt priority
      .dma_buf_count = 8,
      .dma_buf_len = 64,
      .use_apll = true,
      .tx_desc_auto_clear = true // avoiding noise in case of data unavailability
    };
    i2s_pin_config_t my_pin_config = {
    .mck_io_num = MCK,
    .bck_io_num = BCK,
    .ws_io_num = WS,
    .data_out_num = DAT,
    .data_in_num = I2S_PIN_NO_CHANGE
    };
    a2dp_sink.set_pin_config(my_pin_config);

    a2dp_sink.set_i2s_config(i2s_config);
    a2dp_sink.start("MyMusic");

    pinMode(MUTE,OUTPUT);
    digitalWrite(MUTE,0);
}

void loop() {
  // disable watchdog
}
0x0fe commented 1 year ago

actually, it is even worst. D0WDR2 stuttering.zip I tried from iphone (13 last IOS) and from PC (win10) and i notice that on iphone it cuts completely at regular interval of varying length (silent), on PC it doesnt cut, but in both case the stuttering is as bad as it can be.

0x0fe commented 1 year ago

please note, we use 16bit as our DAC only supports 16 and 24 bit, not 32. Also, pin mapping is different than your code, you may want to adjust your test platform to match ours, in case this isue has anything to do with the pin mapping.

xiongweichao commented 1 year ago

Hi @0x0fe ,

  1. Do you have this problem when using other mobile phones (Android system) to test?
  2. Some suggestions about the example are as follows: a. write_audio should not block. BaseType_t rc = xRingbufferSend(s_ringbuf_i2s, (void *)data, size, (portTickType)0); b. i2s_ringbuffer_size may be too small.
  3. Can you enable bluedroid log?

BTW, I hope you can provide a test log after the test.

Thanks

0x0fe commented 1 year ago

Hi @xiongweichao 1) we have tested with android too, actually on some old android even the D0WD, but on newer android and on IOS / PC it is working fine. On D0WDR2 it is failing with all platform, old android, new Android, new IOS, and PC (win10).

2 a) i am not sure what the suggestion is here, do you want me to verify wether this call is blocking inside A2DP sink queue?

2 b) as mentioned previously, we have already tested with various size and number of buffers for I2S (and for A2DP too), last time i tested with 8 buffer of 512 byte on the I2S and it was still stuttering a lot. For the sake of it i will test again.

3) ok, i will see how we can enable this log in the arduino core, hopefully this is possible with a flag, otherwise i would have to move the testing code to IDF, which will take time.

xiongweichao commented 1 year ago

Hi @0x0fe ,

2a) As you said, verify whether it is blocked. 2b) Maybe this test is not important and only test 2a is needed.

Enabling the log is to verify whether there is any packet loss in Bluetooth. If enabling bluedroid log is difficult, I suggest to use idf a2dp_sink example.

Thanks

0x0fe commented 1 year ago

@xiongweichao Okay i will run the test in IDF, can you clarify how to enable MCLK on this specific example, because the DAC i use for test here do need MCLK on GPIO3. Do i jsut need to add it to the I2S pin config structure here?

xiongweichao commented 1 year ago

@0x0fe The use of I2S is exactly the same as that of arduino, you can directly add it.

0x0fe commented 1 year ago

so, i decided to give a try to IDF 5.0.1, and i can confirm the problem is still here, however enabling the bluetooth logs indeed shows a lot of buffering undeflow issues .

0x0fe commented 1 year ago

so, here i disabled the color formatting for better clarify, i also enabled the BT driver to use external PSRAM first and allowed dynamic memory allocation, just for test, and i can say the result is even worst because it now also saturates the PA and the volume control is inoperant, that is, i can set it to 5% and it shows in the log, but the actual output on the DAC stays at maximum (and beyond). Not sure how this relates to external PSRAM and memory management, which are the only tparameters i modified, but this overloading and lost of volume control did not occur before.

I (459) boot: Loaded app from partition at offset 0x10000
I (459) boot: Disabling RNG early entropy source...
I (468) cpu_start: Pro cpu up.
I (468) cpu_start: Starting app cpu, entry point is 0x4008141c
I (0) cpu_start: App cpu up.
I (480) cpu_start: Pro cpu start user code
I (480) cpu_start: cpu freq: 160000000 Hz
I (480) cpu_start: Application information:
I (482) cpu_start: Project name:     a2dp_sink
I (486) cpu_start: App version:      v5.0.1-dirty
I (490) cpu_start: Compile time:     Apr 17 2023 23:09:49
I (495) cpu_start: ELF file SHA256:  a11fc9cde7c57745...
I (500) cpu_start: ESP-IDF:          v5.0.1-dirty
I (505) cpu_start: Min chip rev:     v0.0
I (509) cpu_start: Max chip rev:     v3.99 
I (513) cpu_start: Chip rev:         v3.0
I (517) heap_init: Initializing. RAM available for dynamic allocation:
I (523) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM
I (528) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM
I (533) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM
I (538) heap_init: At 3FFC3DF0 len 0001C210 (112 KiB): DRAM
I (543) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (549) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (554) heap_init: At 40098B78 len 00007488 (29 KiB): IRAM
I (561) spi_flash: detected chip: generic
I (563) spi_flash: flash io: dio
W (566) spi_flash: Detected size(4096k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (580) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (684) BTDM_INIT: BT controller compile version [60aae55]
I (684) system_api: Base MAC address is not set
I (684) system_api: read default base MAC address from EFUSE
I (684) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
W (1394) BT_BTC: A2DP Enable with AVRC
I (1404) BT_AV: A2DP PROF STATE: Init Complete
I (1414) BT_AV: event: 10
I (1414) BT_AV: event: 10
I (1414) BT_AV: event: 10
I (1414) BT_AV: event: 10
I (1414) BT_AV: Get delay report value: delay_value: 1200 * 1/10 ms
I (1424) BT_AV: Set delay report value: success, delay_value: 1250 * 1/10 ms
W (15084) BT_HCI: hcif conn complete: hdl 0x80, st 0x0
I (15084) BT_AV: ESP_BT_GAP_ACL_CONN_CMPL_STAT_EVT Connected to [a4:c6:f0:85:a9:9a], status: 0x100
W (15194) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 8000
W (15514) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 32000
W (15794) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 8000
E (15804) BT_APPL: bta_av_rc_create ACP handle exist for shdl:0
I (15814) BT_AV: A2DP connection state: Connecting, [a4:c6:f0:85:a9:9a]
I (15824) RC_TG: AVRC conn_state evt: state 1, [a4:c6:f0:85:a9:9a]
I (15824) RC_TG: start volume change simulation
I (15964) BT_AV: A2DP audio stream configuration, codec type: 0
I (15964) BT_AV: Configure audio player: 21-15-2-35
I (15964) BT_AV: Audio player configured, sample rate: 44100
I (15964) BT_AV: protocol service capabilities configured: 0x1 
I (15974) BT_AV: Peer device support delay reporting
I (16034) RC_TG: AVRC register event notification: 13, param: 0x0
I (16234) RC_CT: AVRC conn_state event: state 1, [a4:c6:f0:85:a9:9a]
I (16234) RC_CT: AVRC remote features 25b, TG features d1
I (16234) RC_TG: AVRC remote features: 25b, CT features: 2
W (16304) BT_APPL: new conn_srvc id:19, app_id:0
I (16304) BT_AV: A2DP connection state: Connected, [a4:c6:f0:85:a9:9a]
I (16304) BT_APP_CORE: ringbuffer data empty! mode changed: RINGBUFFER_MODE_PREFETCHING
I (16364) RC_CT: remote rn_cap: count 7, bitmask 0x1f06
I (16474) RC_CT: AVRC metadata rsp: attribute id 0x1, 
I (16474) RC_CT: AVRC metadata rsp: attribute id 0x2, 
I (16474) RC_CT: AVRC metadata rsp: attribute id 0x4, 
I (16474) RC_CT: AVRC metadata rsp: attribute id 0x20, 
I (16794) RC_CT: AVRC remote features 25b, TG features d1
I (16794) RC_TG: AVRC remote features: 25b, CT features: 2
I (19174) RC_TG: AVRC set absolute volume: 79%
I (19174) RC_TG: Volume is set by remote controller to: 79%
W (19504) BT_HCI: hci cmd send: sniff: hdl 0x80, intv(400 800)
W (19564) BT_HCI: hcif mode change: hdl 0x80, mode 2, intv 800, status 0x0
I (19564) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 2
W (24794) BT_HCI: hcif mode change: hdl 0x80, mode 0, intv 0, status 0x0
I (24794) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 0
I (24814) BT_LOG: bta_av_link_role_ok hndl:x41 role:1 conn_audio:x1 bits:1 features:x864b

W (24814) BT_APPL: new conn_srvc id:19, app_id:1
I (24824) BT_AV: A2DP audio state: Started
I (24954) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (25134) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (25184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (25334) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (25384) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (25524) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (25534) BT_HCI: reassemble_and_dispatch found unfinished packet for handle with start packet. Dropping old.

W (25534) BT_APPL: Sequence numbers error, recv:0x17, expect:0x16, recount:0x0
I (25574) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (25744) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (25764) BT_APPL: Sequence numbers error, recv:0x20, expect:0x1f, recount:0x0
I (25804) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (25824) RC_TG: Volume is set locally to: 83%
I (25984) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (26004) BT_APPL: Sequence numbers error, recv:0x2a, expect:0x28, recount:0x0
I (26044) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26244) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (26244) RC_TG: AVRC register event notification: 13, param: 0x0
I (26244) RC_TG: AVRC set absolute volume: 82%
I (26244) RC_TG: Volume is set by remote controller to: 82%
W (26264) BT_APPL: Sequence numbers error, recv:0x36, expect:0x33, recount:0x0
I (26304) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26454) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (26504) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26684) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (26704) BT_APPL: Sequence numbers error, recv:0x48, expect:0x45, recount:0x0
I (26734) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26914) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (26934) BT_APPL: Sequence numbers error, recv:0x52, expect:0x50, recount:0x0
I (26944) RC_TG: AVRC set absolute volume: 77%
I (26944) RC_TG: Volume is set by remote controller to: 77%
I (26974) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27074) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (27134) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27284) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (27334) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27514) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (27534) BT_APPL: Sequence numbers error, recv:0x6a, expect:0x66, recount:0x0
W (27544) BT_APPL: Sequence numbers error, recv:0x6d, expect:0x6c, recount:0x0
I (27574) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27744) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (27764) RC_TG: AVRC set absolute volume: 70%
I (27774) RC_TG: Volume is set by remote controller to: 70%
W (27774) BT_APPL: Sequence numbers error, recv:0x76, expect:0x73, recount:0x0
I (27784) BT_AV: Audio packet count: 100
I (27804) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27914) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (27974) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (28124) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (28144) BT_APPL: Sequence numbers error, recv:0x83, expect:0x82, recount:0x0
W (28174) BT_APPL: Sequence numbers error, recv:0x87, expect:0x86, recount:0x0
I (28194) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (28364) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (28384) BT_APPL: Sequence numbers error, recv:0x8f, expect:0x8c, recount:0x0
I (28414) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (28574) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (28624) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (28834) RC_TG: AVRC set absolute volume: 64%
I (28834) RC_TG: Volume is set by remote controller to: 64%
I (28844) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (28864) BT_APPL: Sequence numbers error, recv:0xa6, expect:0xa0, recount:0x0
I (28904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (29074) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (29094) RC_TG: AVRC set absolute volume: 58%
I (29094) RC_TG: Volume is set by remote controller to: 58%
W (29094) BT_APPL: Sequence numbers error, recv:0xb0, expect:0xae, recount:0x0
I (29134) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (29264) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (29314) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (29474) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (29524) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (29674) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (29704) BT_APPL: Sequence numbers error, recv:0xc7, expect:0xc5, recount:0x0
I (29734) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (29884) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (29934) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (29954) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (30134) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30154) BT_APPL: Sequence numbers error, recv:0xdd, expect:0xd7, recount:0x0
I (30184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (30364) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30384) BT_APPL: Sequence numbers error, recv:0xe7, expect:0xe5, recount:0x0
I (30414) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (30614) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30634) BT_APPL: Sequence numbers error, recv:0xf2, expect:0xf0, recount:0x0
I (30664) BT_AV: Audio packet count: 200
I (30674) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (30834) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30854) BT_APPL: Sequence numbers error, recv:0xfa, expect:0xf9, recount:0x0
W (30874) BT_APPL: Sequence numbers error, recv:0xfc, expect:0xfb, recount:0x0
I (30914) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31114) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31134) BT_APPL: Sequence numbers error, recv:0x107, expect:0x104, recount:0x0
I (31174) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31354) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31374) BT_APPL: Sequence numbers error, recv:0x111, expect:0x10f, recount:0x0
I (31404) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31604) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31624) BT_APPL: Sequence numbers error, recv:0x11c, expect:0x11a, recount:0x0
I (31664) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31794) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31814) BT_APPL: Sequence numbers error, recv:0x123, expect:0x122, recount:0x0
I (31844) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32004) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (32054) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32224) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (32244) BT_APPL: Sequence numbers error, recv:0x134, expect:0x132, recount:0x0
W (32264) BT_APPL: Sequence numbers error, recv:0x138, expect:0x135, recount:0x0
I (32294) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32464) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (32484) BT_APPL: Sequence numbers error, recv:0x141, expect:0x13f, recount:0x0
I (32524) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32694) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (32714) BT_APPL: Sequence numbers error, recv:0x14c, expect:0x149, recount:0x0
I (32754) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32954) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (32974) BT_APPL: Sequence numbers error, recv:0x157, expect:0x155, recount:0x0
I (33004) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (33154) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (33214) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (33234) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (33414) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33434) BT_APPL: Sequence numbers error, recv:0x16a, expect:0x168, recount:0x0
I (33474) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (33484) BT_AV: Audio packet count: 300
I (33674) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33694) BT_APPL: Sequence numbers error, recv:0x176, expect:0x173, recount:0x0
I (33734) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (33954) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33974) BT_APPL: Sequence numbers error, recv:0x182, expect:0x180, recount:0x0
I (34004) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (34184) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (34204) BT_APPL: Sequence numbers error, recv:0x18c, expect:0x18a, recount:0x0
I (34234) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (34414) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (34434) BT_APPL: Sequence numbers error, recv:0x195, expect:0x194, recount:0x0
I (34464) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (34644) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (34654) BT_APPL: Sequence numbers error, recv:0x19f, expect:0x19d, recount:0x0
I (34694) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (34824) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (34884) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (35084) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (35104) BT_APPL: Sequence numbers error, recv:0x1b2, expect:0x1ae, recount:0x0
I (35144) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (35174) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (35184) BT_APP_CORE: ringbuffer is full, drop this packet!
W (35224) BT_APP_CORE: ringbuffer is full, drop this packet!
W (35224) BT_APP_CORE: ringbuffer is full, drop this packet!
I (35224) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (35824) RC_TG: Volume is set locally to: 62%
I (35874) RC_TG: AVRC register event notification: 13, param: 0x0
I (36074) BT_AV: Audio packet count: 400
I (37114) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (37164) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (37314) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (37364) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (37544) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (37554) BT_APPL: Sequence numbers error, recv:0x21c, expect:0x21a, recount:0x0
I (37594) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (37794) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (37814) BT_APPL: Sequence numbers error, recv:0x227, expect:0x225, recount:0x0
I (37854) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (38004) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (38054) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (38234) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (38254) BT_APPL: Sequence numbers error, recv:0x239, expect:0x236, recount:0x0
W (38264) BT_APPL: Sequence numbers error, recv:0x23b, expect:0x23a, recount:0x0
I (38294) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (38444) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (38494) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (38634) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (38644) BT_APPL: Sequence numbers error, recv:0x248, expect:0x247, recount:0x0
I (38684) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (38704) BT_AV: Audio packet count: 500
I (38884) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (38904) BT_APPL: Sequence numbers error, recv:0x256, expect:0x251, recount:0x0
I (38944) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (39114) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39134) BT_APPL: Sequence numbers error, recv:0x260, expect:0x25e, recount:0x0
I (39174) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (39344) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39364) BT_APPL: Sequence numbers error, recv:0x26a, expect:0x268, recount:0x0
I (39414) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (39614) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39634) BT_APPL: Sequence numbers error, recv:0x275, expect:0x273, recount:0x0
I (39674) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (39864) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39884) BT_APPL: Sequence numbers error, recv:0x280, expect:0x27e, recount:0x0
I (39924) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40074) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40094) BT_APPL: Sequence numbers error, recv:0x288, expect:0x287, recount:0x0
I (40134) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40314) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40334) BT_APPL: Sequence numbers error, recv:0x294, expect:0x290, recount:0x0
I (40364) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40544) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40564) BT_APPL: Sequence numbers error, recv:0x29e, expect:0x29c, recount:0x0
I (40594) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40784) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40794) BT_APPL: Sequence numbers error, recv:0x2a8, expect:0x2a6, recount:0x0
I (40834) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (41014) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41024) BT_APPL: Sequence numbers error, recv:0x2b2, expect:0x2b0, recount:0x0
I (41064) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (41234) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41254) BT_APPL: Sequence numbers error, recv:0x2bb, expect:0x2ba, recount:0x0
I (41294) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (41494) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41514) BT_APPL: Sequence numbers error, recv:0x2c6, expect:0x2c4, recount:0x0
I (41544) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (41674) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (41724) BT_AV: Audio packet count: 600
I (41724) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (41854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41874) BT_APPL: Sequence numbers error, recv:0x2d3, expect:0x2d2, recount:0x0
I (41904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (41934) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (42134) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (42154) BT_APPL: Sequence numbers error, recv:0x2e2, expect:0x2de, recount:0x0
I (42194) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (42394) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (42414) BT_APPL: Sequence numbers error, recv:0x2ed, expect:0x2eb, recount:0x0
I (42444) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (42574) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (42634) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (42654) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (42664) BT_APP_CORE: ringbuffer is full, drop this packet!
I (42854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (42874) BT_APPL: Sequence numbers error, recv:0x301, expect:0x2ff, recount:0x0
I (42904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (43134) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (43154) BT_APPL: Sequence numbers error, recv:0x30d, expect:0x30b, recount:0x0
I (43184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (43384) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (43404) BT_APPL: Sequence numbers error, recv:0x318, expect:0x316, recount:0x0
I (43434) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (43594) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (43634) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (43784) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (43834) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (44014) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (44024) BT_APPL: Sequence numbers error, recv:0x330, expect:0x32e, recount:0x0
W (44044) BT_APPL: Sequence numbers error, recv:0x333, expect:0x331, recount:0x0
I (44064) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (44224) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (44274) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (44444) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (44464) BT_APPL: Sequence numbers error, recv:0x343, expect:0x341, recount:0x0
W (44474) BT_APPL: Sequence numbers error, recv:0x345, expect:0x344, recount:0x0
I (44494) BT_AV: Audio packet count: 700
I (44504) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (44674) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (44694) BT_APPL: Sequence numbers error, recv:0x34e, expect:0x34c, recount:0x0
I (44724) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (44854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (44904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45104) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (45124) BT_APPL: Sequence numbers error, recv:0x362, expect:0x35d, recount:0x0
I (45164) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45314) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (45364) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45534) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (45554) BT_APPL: Sequence numbers error, recv:0x372, expect:0x371, recount:0x0
W (45564) BT_APPL: Sequence numbers error, recv:0x375, expect:0x373, recount:0x0
I (45594) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (45624) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (45644) BT_APP_CORE: ringbuffer is full, drop this packet!
W (45644) BT_APP_CORE: ringbuffer is full, drop this packet!
W (45664) BT_APP_CORE: ringbuffer is full, drop this packet!
W (45684) BT_APP_CORE: ringbuffer is full, drop this packet!
I (45684) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45824) RC_TG: Volume is set locally to: 66%
I (45854) RC_TG: AVRC register event notification: 13, param: 0x0
I (46894) BT_AV: Audio packet count: 800
I (49224) BT_AV: Audio packet count: 900
I (51534) BT_AV: Audio packet count: 1000
I (52184) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (52224) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (52374) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (52424) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (52584) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (52634) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (52764) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (52784) BT_APPL: Sequence numbers error, recv:0x4aa, expect:0x4a9, recount:0x0
I (52814) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (52994) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53014) BT_APPL: Sequence numbers error, recv:0x4b5, expect:0x4b2, recount:0x0
I (53054) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (53214) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53224) BT_APPL: Sequence numbers error, recv:0x4bd, expect:0x4bc, recount:0x0
I (53264) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (53444) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53464) BT_APPL: Sequence numbers error, recv:0x4c9, expect:0x4c5, recount:0x0
I (53494) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (53594) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (53654) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (53674) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (53854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53874) BT_APPL: Sequence numbers error, recv:0x4db, expect:0x4d8, recount:0x0
I (53904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54034) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (54084) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54264) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (54284) BT_APPL: Sequence numbers error, recv:0x4ed, expect:0x4e9, recount:0x0
I (54314) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54314) BT_AV: Audio packet count: 1100
I (54424) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (54474) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54654) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (54664) BT_APPL: Sequence numbers error, recv:0x4fc, expect:0x4fa, recount:0x0
I (54704) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (54904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (55024) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (55044) BT_APPL: Sequence numbers error, recv:0x50a, expect:0x509, recount:0x0
I (55084) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (55264) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (55284) BT_APPL: Sequence numbers error, recv:0x516, expect:0x512, recount:0x0
W (55294) BT_APPL: Sequence numbers error, recv:0x518, expect:0x517, recount:0x0
I (55324) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (55464) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (55514) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (55664) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (55724) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (55824) RC_TG: Volume is set locally to: 70%
I (55874) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (55924) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56134) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (56144) BT_APPL: Sequence numbers error, recv:0x53c, expect:0x535, recount:0x0
I (56184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56304) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (56364) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56534) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (56554) BT_APPL: Sequence numbers error, recv:0x54c, expect:0x54a, recount:0x0
W (56564) BT_APPL: Sequence numbers error, recv:0x54f, expect:0x54d, recount:0x0
I (56584) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56744) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (56774) RC_TG: AVRC register event notification: 13, param: 0x0
I (56804) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (56824) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (57004) RC_TG: AVRC set absolute volume: 63%
I (57004) RC_TG: Volume is set by remote controller to: 63%
I (57014) RC_TG: AVRC set absolute volume: 57%
I (57014) RC_TG: Volume is set by remote controller to: 57%
I (57034) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (57044) BT_APPL: Sequence numbers error, recv:0x563, expect:0x560, recount:0x0
I (57084) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (57104) BT_AV: Audio packet count: 1200
I (57284) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (57284) RC_TG: AVRC set absolute volume: 51%
I (57284) RC_TG: Volume is set by remote controller to: 51%
I (57284) RC_TG: AVRC set absolute volume: 44%
I (57294) RC_TG: Volume is set by remote controller to: 44%
W (57304) BT_APPL: Sequence numbers error, recv:0x56e, expect:0x56c, recount:0x0
I (57334) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (57454) RC_TG: AVRC set absolute volume: 38%
I (57454) RC_TG: Volume is set by remote controller to: 38%
I (57454) RC_TG: AVRC set absolute volume: 32%
I (57454) RC_TG: Volume is set by remote controller to: 32%
I (57464) RC_TG: AVRC set absolute volume: 25%
I (57464) RC_TG: Volume is set by remote controller to: 25%
I (57474) RC_TG: AVRC set absolute volume: 19%
I (57474) RC_TG: Volume is set by remote controller to: 19%
I (57484) RC_TG: AVRC set absolute volume: 13%
I (57484) RC_TG: Volume is set by remote controller to: 13%
I (57494) RC_TG: AVRC set absolute volume: 7%
I (57494) RC_TG: Volume is set by remote controller to: 7%
I (57504) RC_TG: AVRC set absolute volume: 0%
I (57504) RC_TG: Volume is set by remote controller to: 0%
I (57514) RC_TG: AVRC set absolute volume: 0%
I (57514) RC_TG: Volume is set by remote controller to: 0%
W (57554) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (57554) BT_APP_CORE: ringbuffer is full, drop this packet!
I (57744) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (57804) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (57994) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (58014) BT_APPL: Sequence numbers error, recv:0x58d, expect:0x58b, recount:0x0
I (58054) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (58094) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (58094) BT_APP_CORE: ringbuffer is full, drop this packet!
W (58114) BT_APP_CORE: ringbuffer is full, drop this packet!
W (58134) BT_APP_CORE: ringbuffer is full, drop this packet!
W (58164) BT_APP_CORE: ringbuffer is full, drop this packet!
I (58164) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (58364) RC_TG: AVRC set absolute volume: 5%
I (58364) RC_TG: Volume is set by remote controller to: 5%
I (58584) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (58624) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (58754) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (58794) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (58904) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (58944) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (59084) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (59094) BT_APPL: Sequence numbers error, recv:0x5bb, expect:0x5ba, recount:0x0
I (59134) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (59334) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (59334) RC_TG: AVRC set absolute volume: 11%
I (59334) RC_TG: Volume is set by remote controller to: 11%
W (59354) BT_APPL: Sequence numbers error, recv:0x5c7, expect:0x5c4, recount:0x0
I (59384) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (59544) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (59564) BT_APPL: Sequence numbers error, recv:0x5cf, expect:0x5ce, recount:0x0
I (59604) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (59774) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (59794) BT_APPL: Sequence numbers error, recv:0x5da, expect:0x5d7, recount:0x0
I (59804) BT_AV: Audio packet count: 1300
I (59834) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (59994) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (60014) BT_APPL: Sequence numbers error, recv:0x5e2, expect:0x5e1, recount:0x0
I (60044) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (60174) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (60224) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (60394) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (60414) BT_APPL: Sequence numbers error, recv:0x5f4, expect:0x5f0, recount:0x0
I (60454) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (60664) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (60684) BT_APP_CORE: ringbuffer is full, drop this packet!
W (60724) BT_APP_CORE: ringbuffer is full, drop this packet!
I (60724) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (62084) BT_AV: Audio packet count: 1400
I (64444) BT_AV: Audio packet count: 1500
I (65684) RC_TG: AVRC set absolute volume: 5%
I (65684) RC_TG: Volume is set by remote controller to: 5%
I (65824) RC_TG: Volume is set locally to: 9%
I (65844) RC_TG: AVRC register event notification: 13, param: 0x0
I (66744) BT_AV: Audio packet count: 1600
I (67674) BT_AV: A2DP audio state: Suspended
I (67824) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (70874) BT_HCI: hci cmd send: sniff: hdl 0x80, intv(30 54)
W (70884) BT_HCI: hcif mode change: hdl 0x80, mode 2, intv 54, status 0x0
I (70884) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 2
W (72744) BT_HCI: hcif mode change: hdl 0x80, mode 0, intv 0, status 0x0
I (72744) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 0
I (72844) BT_LOG: bta_av_link_role_ok hndl:x41 role:1 conn_audio:x1 bits:1 features:x864b

I (72844) BT_AV: A2DP audio state: Started
I (73084) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (73254) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (73304) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (73434) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (73484) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (73624) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (73684) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (73834) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (73884) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (74024) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (74034) BT_APPL: Sequence numbers error, recv:0x24, expect:0x23, recount:0x0
I (74084) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (74104) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (74284) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (74304) BT_APPL: Sequence numbers error, recv:0x32, expect:0x2e, recount:0x0
I (74334) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (74484) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (74544) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (74564) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (74744) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (74754) BT_APPL: Sequence numbers error, recv:0x46, expect:0x43, recount:0x0
I (74794) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (74944) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (74974) BT_APPL: Sequence numbers error, recv:0x4f, expect:0x4e, recount:0x0
I (74994) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (75184) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (75194) BT_APPL: Sequence numbers error, recv:0x58, expect:0x56, recount:0x0
I (75234) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (75384) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (75434) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (75614) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (75634) BT_APPL: Sequence numbers error, recv:0x6a, expect:0x67, recount:0x0
W (75654) BT_APPL: Sequence numbers error, recv:0x6d, expect:0x6b, recount:0x0
I (75684) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (75824) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (75824) RC_TG: Volume is set locally to: 13%
I (75864) BT_AV: Audio packet count: 100
I (75884) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (76044) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (76094) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (76114) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (76304) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (76314) BT_APPL: Sequence numbers error, recv:0x89, expect:0x84, recount:0x0
I (76354) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (76504) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (76534) RC_TG: AVRC register event notification: 13, param: 0x0
I (76554) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (76734) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (76754) BT_APPL: Sequence numbers error, recv:0x9b, expect:0x98, recount:0x0
I (76794) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (76994) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (77014) BT_APPL: Sequence numbers error, recv:0xa7, expect:0xa4, recount:0x0
I (77054) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (77184) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (77244) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (77464) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (77484) BT_APPL: Sequence numbers error, recv:0xbb, expect:0xb7, recount:0x0
I (77514) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (77724) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (77734) BT_APPL: Sequence numbers error, recv:0xc6, expect:0xc4, recount:0x0
I (77774) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (77954) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (77964) BT_APPL: Sequence numbers error, recv:0xd0, expect:0xce, recount:0x0
I (78004) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (78134) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (78184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (78334) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (78384) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (78514) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (78534) BT_APPL: Sequence numbers error, recv:0xe4, expect:0xe3, recount:0x0
I (78564) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (78744) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (78764) BT_APPL: Sequence numbers error, recv:0xef, expect:0xec, recount:0x0
I (78764) BT_AV: Audio packet count: 200
W (78774) BT_APPL: Sequence numbers error, recv:0xf1, expect:0xf0, recount:0x0
W (78784) BT_APPL: Sequence numbers error, recv:0xf3, expect:0xf2, recount:0x0
I (78814) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (78964) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (78984) BT_APPL: Sequence numbers error, recv:0xf9, expect:0xf8, recount:0x0
I (79014) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (79164) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (79224) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (79414) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (79444) BT_APPL: Sequence numbers error, recv:0x10f, expect:0x109, recount:0x0
I (79474) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (79584) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (79634) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (79854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (79874) BT_APPL: Sequence numbers error, recv:0x122, expect:0x11e, recount:0x0
I (79904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (80084) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (80104) BT_APPL: Sequence numbers error, recv:0x12c, expect:0x12a, recount:0x0
I (80134) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (80264) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (80314) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (80474) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (80524) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (80694) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (80714) BT_APPL: Sequence numbers error, recv:0x144, expect:0x141, recount:0x0
W (80734) BT_APPL: Sequence numbers error, recv:0x147, expect:0x146, recount:0x0
I (80754) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (80934) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (80954) BT_APPL: Sequence numbers error, recv:0x151, expect:0x14d, recount:0x0
I (80994) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (81144) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (81194) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (81354) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (81404) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (81554) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (81604) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (81604) BT_AV: Audio packet count: 300
I (81774) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (81794) BT_APPL: Sequence numbers error, recv:0x171, expect:0x16e, recount:0x0
W (81804) BT_APPL: Sequence numbers error, recv:0x173, expect:0x172, recount:0x0
W (81814) BT_APPL: Sequence numbers error, recv:0x176, expect:0x174, recount:0x0
I (81834) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (82014) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (82034) BT_APPL: Sequence numbers error, recv:0x17e, expect:0x17c, recount:0x0
W (82044) BT_APPL: Sequence numbers error, recv:0x180, expect:0x17f, recount:0x0
I (82074) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (82224) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (82244) BT_APPL: Sequence numbers error, recv:0x187, expect:0x186, recount:0x0
I (82284) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (82454) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (82474) BT_APPL: Sequence numbers error, recv:0x192, expect:0x18f, recount:0x0
I (82504) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (82684) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (82704) BT_APPL: Sequence numbers error, recv:0x19c, expect:0x19a, recount:0x0
I (82744) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (82964) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (82984) BT_APPL: Sequence numbers error, recv:0x1a8, expect:0x1a6, recount:0x0
I (83024) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (83174) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (83224) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (83254) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (83254) BT_APP_CORE: ringbuffer is full, drop this packet!
I (83434) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (83454) BT_APPL: Sequence numbers error, recv:0x1bc, expect:0x1ba, recount:0x0
I (83494) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (83514) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (83514) BT_APP_CORE: ringbuffer is full, drop this packet!
I (83694) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (83714) BT_APPL: Sequence numbers error, recv:0x1c8, expect:0x1c7, recount:0x0
I (83754) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (83904) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (83924) BT_APPL: Sequence numbers error, recv:0x1d0, expect:0x1cf, recount:0x0
W (83944) BT_APPL: Sequence numbers error, recv:0x1d2, expect:0x1d1, recount:0x0
I (83964) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (84104) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (84154) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (84174) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (84354) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (84374) BT_APPL: Sequence numbers error, recv:0x1e4, expect:0x1e1, recount:0x0
I (84394) BT_AV: Audio packet count: 400
I (84404) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (84554) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (84614) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (84814) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (84824) BT_APPL: Sequence numbers error, recv:0x1f8, expect:0x1f4, recount:0x0
I (84854) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (84984) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (85044) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (85064) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (85064) BT_APP_CORE: ringbuffer is full, drop this packet!
I (85244) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (85264) BT_APPL: Sequence numbers error, recv:0x20b, expect:0x209, recount:0x0
I (85294) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (85444) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (85494) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (85674) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (85694) BT_APPL: Sequence numbers error, recv:0x21d, expect:0x21a, recount:0x0
I (85734) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (85824) RC_TG: Volume is set locally to: 17%
I (85924) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (85944) BT_APPL: Sequence numbers error, recv:0x228, expect:0x226, recount:0x0
I (85984) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (86154) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (86174) RC_TG: AVRC register event notification: 13, param: 0x0
W (86184) BT_APPL: Sequence numbers error, recv:0x232, expect:0x230, recount:0x0
I (86224) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (86374) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (86404) BT_APPL: Sequence numbers error, recv:0x23b, expect:0x23a, recount:0x0
I (86434) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (86614) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (86634) BT_APPL: Sequence numbers error, recv:0x245, expect:0x242, recount:0x0
I (86674) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (86894) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (86914) BT_APPL: Sequence numbers error, recv:0x252, expect:0x24f, recount:0x0
I (86954) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (87154) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (87174) BT_APPL: Sequence numbers error, recv:0x25d, expect:0x25b, recount:0x0
I (87204) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (87204) BT_AV: Audio packet count: 500
I (87384) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (87404) BT_APPL: Sequence numbers error, recv:0x266, expect:0x265, recount:0x0
I (87434) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (87564) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (87624) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (87794) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (87814) BT_APPL: Sequence numbers error, recv:0x276, expect:0x274, recount:0x0
W (87824) BT_APPL: Sequence numbers error, recv:0x279, expect:0x277, recount:0x0
I (87854) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (88004) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (88054) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (88154) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (88154) BT_APPL: Sequence numbers error, recv:0x286, expect:0x284, recount:0x0
I (88184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (88224) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (88224) BT_APP_CORE: ringbuffer is full, drop this packet!
W (88264) BT_APP_CORE: ringbuffer is full, drop this packet!
W (88274) BT_APP_CORE: ringbuffer is full, drop this packet!
I (88274) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (89624) BT_AV: Audio packet count: 600
I (90614) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (90664) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (90844) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (90874) BT_APPL: Sequence numbers error, recv:0x2fc, expect:0x2fb, recount:0x0
I (90904) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (91084) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (91104) BT_APPL: Sequence numbers error, recv:0x306, expect:0x304, recount:0x0
I (91144) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (91344) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (91364) BT_APPL: Sequence numbers error, recv:0x311, expect:0x30f, recount:0x0
I (91394) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (91524) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (91584) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (91704) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (91724) BT_APPL: Sequence numbers error, recv:0x31e, expect:0x31d, recount:0x0
I (91764) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (91914) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (91964) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (91964) BT_APPL: Sequence numbers error, recv:0x32b, expect:0x32a, recount:0x0
I (92124) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (92164) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (92294) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (92314) BT_APPL: Sequence numbers error, recv:0x334, expect:0x333, recount:0x0
I (92344) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (92344) BT_AV: Audio packet count: 700
I (92484) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (92504) BT_APPL: Sequence numbers error, recv:0x33b, expect:0x33a, recount:0x0
I (92534) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (92544) BT_APPL: Sequence numbers error, recv:0x343, expect:0x342, recount:0x0
I (92704) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (92734) BT_APPL: Sequence numbers error, recv:0x348, expect:0x344, recount:0x0
W (92754) BT_APPL: Sequence numbers error, recv:0x34c, expect:0x34b, recount:0x0
I (92754) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (92864) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (92914) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (93114) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (93134) BT_APPL: Sequence numbers error, recv:0x35d, expect:0x357, recount:0x0
I (93164) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (93364) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (93384) BT_APPL: Sequence numbers error, recv:0x368, expect:0x366, recount:0x0
I (93424) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (93594) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (93614) BT_APPL: Sequence numbers error, recv:0x372, expect:0x370, recount:0x0
I (93654) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (93804) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (93854) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (94054) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (94074) BT_APPL: Sequence numbers error, recv:0x386, expect:0x382, recount:0x0
I (94104) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (94234) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (94284) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (94494) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (94514) BT_APPL: Sequence numbers error, recv:0x399, expect:0x395, recount:0x0
I (94544) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (94664) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (94724) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (94954) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (94974) BT_APPL: Sequence numbers error, recv:0x3ad, expect:0x3a9, recount:0x0
I (95004) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (95144) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (95184) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (95194) BT_AV: Audio packet count: 800
I (95334) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (95394) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (95574) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (95584) BT_APPL: Sequence numbers error, recv:0x3c5, expect:0x3c2, recount:0x0
W (95604) BT_APPL: Sequence numbers error, recv:0x3c8, expect:0x3c7, recount:0x0
I (95624) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (95774) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (95824) RC_TG: Volume is set locally to: 21%
I (95824) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (95984) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (96014) BT_APPL: Sequence numbers error, recv:0x3d7, expect:0x3d6, recount:0x0
W (96024) BT_APPL: Sequence numbers error, recv:0x3da, expect:0x3d8, recount:0x0
I (96044) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (96174) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (96214) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (96374) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (96424) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (96544) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (96554) BT_APP_CORE: ringbuffer is full, drop this packet!
W (96554) BT_APP_CORE: ringbuffer is full, drop this packet!
W (96564) BT_APP_CORE: ringbuffer is full, drop this packet!
W (96564) BT_APP_CORE: ringbuffer is full, drop this packet!
W (96574) BT_APP_CORE: ringbuffer is full, drop this packet!
I (96574) RC_TG: AVRC register event notification: 13, param: 0x0
W (96584) BT_APP_CORE: ringbuffer is full, drop this packet!
W (96594) BT_APP_CORE: ringbuffer is full, drop this packet!
W (96634) BT_APP_CORE: ringbuffer is full, drop this packet!
I (96634) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (97564) BT_AV: Audio packet count: 900
I (99884) BT_AV: Audio packet count: 1000
I (100454) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (100474) RC_TG: AVRC set absolute volume: 26%
I (100474) RC_TG: Volume is set by remote controller to: 26%
I (100514) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (100694) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (100714) BT_APPL: Sequence numbers error, recv:0x4a4, expect:0x4a3, recount:0x0
I (100754) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (100954) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (100974) BT_APPL: Sequence numbers error, recv:0x4af, expect:0x4ad, recount:0x0
I (101004) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (101154) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (101204) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (101374) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (101394) BT_APPL: Sequence numbers error, recv:0x4c1, expect:0x4be, recount:0x0
I (101434) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (101634) RC_TG: AVRC set absolute volume: 21%
I (101634) RC_TG: Volume is set by remote controller to: 21%
I (101654) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (101674) BT_APPL: Sequence numbers error, recv:0x4cd, expect:0x4cb, recount:0x0
I (101704) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (101844) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (101884) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (102044) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (102084) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (102214) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (102234) BT_APPL: Sequence numbers error, recv:0x4e1, expect:0x4e0, recount:0x0
I (102274) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (102404) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (102414) BT_APPL: Sequence numbers error, recv:0x4e8, expect:0x4e7, recount:0x0
I (102454) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (102604) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (102654) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (102674) BT_APPL: Sequence numbers error, recv:0x4f7, expect:0x4f6, recount:0x0
I (102674) BT_AV: Audio packet count: 1100
I (102854) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (102874) BT_APPL: Sequence numbers error, recv:0x4ff, expect:0x4f9, recount:0x0
W (102884) BT_APPL: Sequence numbers error, recv:0x501, expect:0x500, recount:0x0
I (102914) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (103044) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (103094) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (103324) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (103334) BT_APPL: Sequence numbers error, recv:0x515, expect:0x510, recount:0x0
I (103374) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (103504) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (103554) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (103584) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (103784) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (103804) BT_APPL: Sequence numbers error, recv:0x529, expect:0x526, recount:0x0
I (103834) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (104034) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (104054) BT_APPL: Sequence numbers error, recv:0x534, expect:0x532, recount:0x0
I (104094) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (104114) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (104304) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (104314) BT_APPL: Sequence numbers error, recv:0x53f, expect:0x53e, recount:0x0
I (104344) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (104504) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (104544) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (104694) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (104754) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (104934) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (104944) BT_APPL: Sequence numbers error, recv:0x559, expect:0x555, recount:0x0
I (104984) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (105124) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (105174) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (105364) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (105374) BT_APPL: Sequence numbers error, recv:0x56d, expect:0x568, recount:0x0
I (105414) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (105594) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (105604) BT_APPL: Sequence numbers error, recv:0x577, expect:0x575, recount:0x0
I (105614) BT_AV: Audio packet count: 1200
I (105634) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (105764) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (105814) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (105824) RC_TG: Volume is set locally to: 25%
I (105964) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (106014) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (106194) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (106204) BT_APPL: Sequence numbers error, recv:0x58e, expect:0x58d, recount:0x0
W (106224) BT_APPL: Sequence numbers error, recv:0x590, expect:0x58f, recount:0x0
W (106234) BT_APPL: Sequence numbers error, recv:0x592, expect:0x591, recount:0x0
I (106244) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (106294) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (106294) BT_APP_CORE: ringbuffer is full, drop this packet!
W (106304) BT_APP_CORE: ringbuffer is full, drop this packet!
I (106324) RC_TG: AVRC register event notification: 13, param: 0x0
W (106334) BT_APP_CORE: ringbuffer is full, drop this packet!
I (106334) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (107884) BT_AV: Audio packet count: 1300
I (110194) BT_AV: Audio packet count: 1400
I (112504) BT_AV: Audio packet count: 1500
I (112874) BT_AV: A2DP audio state: Suspended
I (112994) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (115824) RC_TG: Volume is set locally to: 29%
I (115924) RC_TG: AVRC register event notification: 13, param: 0x0
W (116074) BT_HCI: hci cmd send: sniff: hdl 0x80, intv(30 54)
W (116114) BT_HCI: hcif mode change: hdl 0x80, mode 2, intv 54, status 0x0
I (116114) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 2
I (125824) RC_TG: Volume is set locally to: 33%
I (125894) RC_TG: AVRC register event notification: 13, param: 0x0
I (135824) RC_TG: Volume is set locally to: 37%
I (135924) RC_TG: AVRC register event notification: 13, param: 0x0
0x0fe commented 1 year ago

more log, after i enabled in PSRAM (i forgot at first), and corrected the I2S mode to philips, overall no difference, volume control still inoperant and still as many underruns.

I (434) esp_image: segment 4: paddr=000f904c vaddr=4008025c size=1d7bch (120764) load
I (499) boot: Loaded app from partition at offset 0x10000
I (499) boot: Disabling RNG early entropy source...
I (509) quad_psram: This chip is ESP32-D0WDR2-V3
I (511) esp_psram: Found 2MB PSRAM device
I (511) esp_psram: Speed: 40MHz
I (511) esp_psram: PSRAM initialized, cache is in low/high (2-core) mode.
I (517) cpu_start: Pro cpu up.
I (520) cpu_start: Starting app cpu, entry point is 0x400816e8
I (0) cpu_start: App cpu up.
I (989) esp_psram: SPI SRAM memory test OK
I (997) cpu_start: Pro cpu start user code
I (997) cpu_start: cpu freq: 160000000 Hz
I (997) cpu_start: Application information:
I (997) cpu_start: Project name:     a2dp_sink
I (1001) cpu_start: App version:      v5.0.1-dirty
I (1006) cpu_start: Compile time:     Apr 17 2023 23:50:00
I (1011) cpu_start: ELF file SHA256:  06828950afdb6f1d...
I (1016) cpu_start: ESP-IDF:          v5.0.1-dirty
I (1021) cpu_start: Min chip rev:     v0.0
I (1024) cpu_start: Max chip rev:     v3.99 
I (1028) cpu_start: Chip rev:         v3.0
I (1033) heap_init: Initializing. RAM available for dynamic allocation:
I (1039) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM
I (1044) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM
I (1049) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM
I (1054) heap_init: At 3FFCB8F8 len 00014708 (81 KiB): DRAM
I (1060) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1065) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1071) heap_init: At 4009DA18 len 000025E8 (9 KiB): IRAM
I (1076) esp_psram: Adding pool of 2048K of PSRAM memory to heap allocator
I (1084) spi_flash: detected chip: generic
I (1086) spi_flash: flash io: dio
W (1089) spi_flash: Detected size(4096k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (1103) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (1110) esp_psram: Reserving pool of 32K of internal memory for DMA/internal allocations
I (1180) BTDM_INIT: BT controller compile version [60aae55]
I (1180) system_api: Base MAC address is not set
I (1180) system_api: read default base MAC address from EFUSE
I (1180) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
W (1900) BT_BTC: A2DP Enable with AVRC
I (1910) BT_AV: A2DP PROF STATE: Init Complete
I (1920) BT_AV: event: 10
I (1920) BT_AV: event: 10
I (1920) BT_AV: event: 10
I (1920) BT_AV: event: 10
I (1930) BT_AV: Get delay report value: delay_value: 1200 * 1/10 ms
I (1930) BT_AV: Set delay report value: success, delay_value: 1250 * 1/10 ms
W (15570) BT_HCI: hcif conn complete: hdl 0x80, st 0x0
I (15580) BT_AV: ESP_BT_GAP_ACL_CONN_CMPL_STAT_EVT Connected to [a4:c6:f0:85:a9:9a], status: 0x100
W (15670) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 8000
W (15920) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 32000
W (16010) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 8000
E (16020) BT_APPL: bta_av_rc_create ACP handle exist for shdl:0
I (16030) BT_AV: A2DP connection state: Connecting, [a4:c6:f0:85:a9:9a]
I (16060) RC_TG: AVRC conn_state evt: state 1, [a4:c6:f0:85:a9:9a]
I (16060) RC_TG: start volume change simulation
I (16230) BT_AV: A2DP audio stream configuration, codec type: 0
I (16240) BT_AV: Configure audio player: 21-15-2-35
I (16240) BT_AV: Audio player configured, sample rate: 44100
I (16240) BT_AV: protocol service capabilities configured: 0x1 
I (16240) BT_AV: Peer device support delay reporting
I (16300) RC_TG: AVRC register event notification: 13, param: 0x0
I (16500) RC_CT: AVRC conn_state event: state 1, [a4:c6:f0:85:a9:9a]
I (16500) RC_CT: AVRC remote features 25b, TG features d1
I (16500) RC_TG: AVRC remote features: 25b, CT features: 2
W (16580) BT_APPL: new conn_srvc id:19, app_id:0
I (16580) BT_AV: A2DP connection state: Connected, [a4:c6:f0:85:a9:9a]
I (16580) BT_APP_CORE: ringbuffer data empty! mode changed: RINGBUFFER_MODE_PREFETCHING
I (16620) RC_CT: remote rn_cap: count 7, bitmask 0x1f06
I (16730) RC_CT: AVRC metadata rsp: attribute id 0x1, 
I (16730) RC_CT: AVRC metadata rsp: attribute id 0x2, 
I (16730) RC_CT: AVRC metadata rsp: attribute id 0x4, 
I (16730) RC_CT: AVRC metadata rsp: attribute id 0x20, 
I (17090) RC_CT: AVRC remote features 25b, TG features d1
I (17090) RC_TG: AVRC remote features: 25b, CT features: 2
I (19140) RC_TG: AVRC set absolute volume: 24%
I (19140) RC_TG: Volume is set by remote controller to: 24%
W (19780) BT_HCI: hci cmd send: sniff: hdl 0x80, intv(400 800)
W (19790) BT_HCI: hcif mode change: hdl 0x80, mode 2, intv 800, status 0x0
I (19790) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 2
W (23800) BT_HCI: hcif mode change: hdl 0x80, mode 0, intv 0, status 0x0
I (23800) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 0
I (23860) BT_LOG: bta_av_link_role_ok hndl:x41 role:1 conn_audio:x1 bits:1 features:x864b

W (23860) BT_APPL: new conn_srvc id:19, app_id:1
I (23860) BT_AV: A2DP audio state: Started
I (24040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (24200) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (24260) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (24410) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (24470) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (24680) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (24700) BT_APPL: Sequence numbers error, recv:0x1a, expect:0x18, recount:0x0
I (24740) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (24960) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (24990) BT_APPL: Sequence numbers error, recv:0x26, expect:0x24, recount:0x0
I (25030) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (25060) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (25260) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (25290) BT_APPL: Sequence numbers error, recv:0x33, expect:0x31, recount:0x0
I (25330) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (25560) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (25570) BT_APPL: Sequence numbers error, recv:0x3f, expect:0x3d, recount:0x0
I (25620) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (25650) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (25840) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (25870) BT_APPL: Sequence numbers error, recv:0x4c, expect:0x4a, recount:0x0
I (25910) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26060) RC_TG: Volume is set locally to: 28%
I (26140) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (26160) BT_APPL: Sequence numbers error, recv:0x59, expect:0x56, recount:0x0
I (26200) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26210) RC_TG: AVRC register event notification: 13, param: 0x0
I (26430) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (26450) BT_APPL: Sequence numbers error, recv:0x65, expect:0x63, recount:0x0
I (26500) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (26530) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (26720) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (26740) BT_APPL: Sequence numbers error, recv:0x72, expect:0x70, recount:0x0
I (26770) BT_AV: Audio packet count: 100
I (26780) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (26990) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (27000) BT_APPL: Sequence numbers error, recv:0x7d, expect:0x7b, recount:0x0
I (27040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27240) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (27260) BT_APPL: Sequence numbers error, recv:0x88, expect:0x86, recount:0x0
I (27310) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (27530) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (27550) BT_APPL: Sequence numbers error, recv:0x94, expect:0x92, recount:0x0
I (27590) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (27630) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (27810) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (27840) BT_APPL: Sequence numbers error, recv:0xa1, expect:0x9f, recount:0x0
I (27880) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (28110) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (28130) BT_APPL: Sequence numbers error, recv:0xad, expect:0xab, recount:0x0
I (28170) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (28200) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (28400) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (28420) BT_APPL: Sequence numbers error, recv:0xba, expect:0xb8, recount:0x0
I (28460) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (28490) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (28680) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (28710) BT_APPL: Sequence numbers error, recv:0xc6, expect:0xc5, recount:0x0
I (28750) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (28780) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (28980) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (29000) BT_APPL: Sequence numbers error, recv:0xd3, expect:0xd1, recount:0x0
I (29040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (29270) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (29290) BT_APPL: Sequence numbers error, recv:0xdf, expect:0xdd, recount:0x0
I (29340) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (29370) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (29560) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (29580) BT_APPL: Sequence numbers error, recv:0xec, expect:0xea, recount:0x0
I (29590) BT_AV: Audio packet count: 200
I (29630) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (29660) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (29850) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (29880) BT_APPL: Sequence numbers error, recv:0xf9, expect:0xf7, recount:0x0
I (29920) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (30110) RC_TG: AVRC set absolute volume: 33%
I (30110) RC_TG: Volume is set by remote controller to: 33%
I (30120) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30140) BT_APPL: Sequence numbers error, recv:0x104, expect:0x102, recount:0x0
I (30180) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (30400) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30430) BT_APPL: Sequence numbers error, recv:0x110, expect:0x10e, recount:0x0
I (30470) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (30500) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (30700) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (30720) BT_APPL: Sequence numbers error, recv:0x11d, expect:0x11b, recount:0x0
I (30760) RC_TG: AVRC set absolute volume: 27%
I (30760) RC_TG: Volume is set by remote controller to: 27%
I (30770) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (30800) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (30990) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31010) BT_APPL: Sequence numbers error, recv:0x12a, expect:0x128, recount:0x0
I (31060) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31270) RC_TG: AVRC set absolute volume: 22%
I (31270) RC_TG: Volume is set by remote controller to: 22%
I (31290) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (31290) RC_TG: AVRC set absolute volume: 15%
I (31290) RC_TG: Volume is set by remote controller to: 15%
W (31310) BT_APPL: Sequence numbers error, recv:0x136, expect:0x134, recount:0x0
I (31360) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31370) RC_TG: AVRC set absolute volume: 9%
I (31370) RC_TG: Volume is set by remote controller to: 9%
I (31380) RC_TG: AVRC set absolute volume: 3%
I (31380) RC_TG: Volume is set by remote controller to: 3%
I (31380) RC_TG: AVRC set absolute volume: 0%
I (31390) RC_TG: Volume is set by remote controller to: 0%
W (31400) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (31590) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31610) BT_APPL: Sequence numbers error, recv:0x143, expect:0x141, recount:0x0
I (31650) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (31850) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (31870) BT_APPL: Sequence numbers error, recv:0x14e, expect:0x14c, recount:0x0
I (31920) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (31950) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (32150) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (32170) BT_APPL: Sequence numbers error, recv:0x15b, expect:0x159, recount:0x0
I (32210) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32230) BT_AV: Audio packet count: 300
W (32240) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (32440) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (32450) RC_TG: AVRC set absolute volume: 5%
I (32450) RC_TG: Volume is set by remote controller to: 5%
W (32450) BT_APPL: Sequence numbers error, recv:0x168, expect:0x166, recount:0x0
I (32510) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (32540) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (32730) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (32750) BT_APPL: Sequence numbers error, recv:0x174, expect:0x173, recount:0x0
I (32800) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (32810) RC_TG: AVRC set absolute volume: 11%
I (32810) RC_TG: Volume is set by remote controller to: 11%
W (32840) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (32840) BT_APP_CORE: ringbuffer is full, drop this packet!
I (33030) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33040) BT_APPL: Sequence numbers error, recv:0x181, expect:0x180, recount:0x0
I (33090) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (33120) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (33320) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33330) BT_APPL: Sequence numbers error, recv:0x18e, expect:0x18c, recount:0x0
I (33380) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (33550) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33570) BT_APPL: Sequence numbers error, recv:0x198, expect:0x196, recount:0x0
I (33620) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (33650) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (33840) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (33860) BT_APPL: Sequence numbers error, recv:0x1a4, expect:0x1a3, recount:0x0
I (33910) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (33920) RC_TG: AVRC set absolute volume: 5%
I (33920) RC_TG: Volume is set by remote controller to: 5%
W (33940) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (34130) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (34150) BT_APPL: Sequence numbers error, recv:0x1b1, expect:0x1af, recount:0x0
I (34200) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (34230) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (34430) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (34450) BT_APPL: Sequence numbers error, recv:0x1bd, expect:0x1bc, recount:0x0
I (34490) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (34520) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (34710) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (34740) BT_APPL: Sequence numbers error, recv:0x1ca, expect:0x1c8, recount:0x0
I (34790) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (35010) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (35030) BT_APPL: Sequence numbers error, recv:0x1d7, expect:0x1d4, recount:0x0
I (35040) BT_AV: Audio packet count: 400
I (35080) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (35300) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (35320) BT_APPL: Sequence numbers error, recv:0x1e3, expect:0x1e1, recount:0x0
I (35370) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (35400) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (35590) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (35610) BT_APPL: Sequence numbers error, recv:0x1ef, expect:0x1ee, recount:0x0
I (35650) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (35680) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (35880) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (35900) BT_APPL: Sequence numbers error, recv:0x1fc, expect:0x1fa, recount:0x0
I (35950) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (35980) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (36060) RC_TG: Volume is set locally to: 9%
I (36170) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (36190) BT_APPL: Sequence numbers error, recv:0x209, expect:0x207, recount:0x0
I (36240) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (36250) RC_TG: AVRC register event notification: 13, param: 0x0
I (36460) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (36480) BT_APPL: Sequence numbers error, recv:0x215, expect:0x213, recount:0x0
I (36530) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (36560) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (36760) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (36780) BT_APPL: Sequence numbers error, recv:0x222, expect:0x220, recount:0x0
I (36820) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (37040) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (37060) BT_APPL: Sequence numbers error, recv:0x22e, expect:0x22c, recount:0x0
I (37110) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (37140) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (37330) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (37350) BT_APPL: Sequence numbers error, recv:0x23a, expect:0x239, recount:0x0
I (37390) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (37420) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (37620) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (37640) BT_APPL: Sequence numbers error, recv:0x247, expect:0x245, recount:0x0
I (37680) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (37690) BT_AV: Audio packet count: 500
I (37910) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (37930) BT_APPL: Sequence numbers error, recv:0x253, expect:0x251, recount:0x0
I (37970) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (38000) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (38190) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (38210) BT_APPL: Sequence numbers error, recv:0x260, expect:0x25e, recount:0x0
I (38260) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (38490) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (38510) BT_APPL: Sequence numbers error, recv:0x26c, expect:0x26a, recount:0x0
I (38550) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (38580) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (38770) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (38800) BT_APPL: Sequence numbers error, recv:0x279, expect:0x277, recount:0x0
I (38840) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (38870) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (39060) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39090) BT_APPL: Sequence numbers error, recv:0x285, expect:0x284, recount:0x0
I (39130) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (39160) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (39360) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39380) BT_APPL: Sequence numbers error, recv:0x292, expect:0x290, recount:0x0
I (39420) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (39460) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (39650) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39670) BT_APPL: Sequence numbers error, recv:0x29e, expect:0x29d, recount:0x0
I (39710) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (39740) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (39930) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (39970) BT_APPL: Sequence numbers error, recv:0x2ab, expect:0x2a9, recount:0x0
I (40010) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40230) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40260) BT_APPL: Sequence numbers error, recv:0x2b8, expect:0x2b5, recount:0x0
I (40300) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40320) BT_AV: Audio packet count: 600
W (40330) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (40530) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40540) BT_APPL: Sequence numbers error, recv:0x2c4, expect:0x2c3, recount:0x0
I (40590) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (40810) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (40830) BT_APPL: Sequence numbers error, recv:0x2d1, expect:0x2ce, recount:0x0
I (40880) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (40910) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (41100) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41120) BT_APPL: Sequence numbers error, recv:0x2dd, expect:0x2dc, recount:0x0
I (41170) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (41200) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (41400) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41420) BT_APPL: Sequence numbers error, recv:0x2ea, expect:0x2e8, recount:0x0
I (41460) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (41680) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41700) BT_APPL: Sequence numbers error, recv:0x2f6, expect:0x2f4, recount:0x0
I (41750) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (41780) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (41970) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (41990) BT_APPL: Sequence numbers error, recv:0x303, expect:0x301, recount:0x0
I (42040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (42270) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (42290) BT_APPL: Sequence numbers error, recv:0x30f, expect:0x30d, recount:0x0
I (42330) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (42520) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (42540) BT_APPL: Sequence numbers error, recv:0x31a, expect:0x318, recount:0x0
I (42590) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (42620) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (42820) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (42830) BT_APPL: Sequence numbers error, recv:0x327, expect:0x325, recount:0x0
I (42880) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (42910) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (43100) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (43120) BT_APPL: Sequence numbers error, recv:0x333, expect:0x332, recount:0x0
I (43160) BT_AV: Audio packet count: 700
I (43170) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (43370) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (43390) BT_APPL: Sequence numbers error, recv:0x33f, expect:0x33c, recount:0x0
I (43440) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (43470) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (43660) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (43680) BT_APPL: Sequence numbers error, recv:0x34b, expect:0x34a, recount:0x0
I (43730) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (43760) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (43960) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (43980) BT_APPL: Sequence numbers error, recv:0x358, expect:0x356, recount:0x0
I (44020) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (44050) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (44250) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (44270) BT_APPL: Sequence numbers error, recv:0x364, expect:0x363, recount:0x0
I (44310) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (44340) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (44530) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (44550) BT_APPL: Sequence numbers error, recv:0x371, expect:0x36f, recount:0x0
I (44600) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (44830) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (44850) BT_APPL: Sequence numbers error, recv:0x37d, expect:0x37b, recount:0x0
I (44890) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45110) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (45130) BT_APPL: Sequence numbers error, recv:0x38a, expect:0x387, recount:0x0
I (45180) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45400) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (45420) BT_APPL: Sequence numbers error, recv:0x396, expect:0x394, recount:0x0
I (45460) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (45500) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (45690) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (45700) BT_APPL: Sequence numbers error, recv:0x3a2, expect:0x3a1, recount:0x0
I (45750) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (45780) BT_AV: Audio packet count: 800
W (45780) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (45980) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (46000) BT_APPL: Sequence numbers error, recv:0x3af, expect:0x3ad, recount:0x0
I (46040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (46060) RC_TG: Volume is set locally to: 13%
W (46070) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (46260) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (46280) BT_APPL: Sequence numbers error, recv:0x3bb, expect:0x3ba, recount:0x0
I (46320) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (46520) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
I (46520) RC_TG: AVRC register event notification: 13, param: 0x0
W (46540) BT_APPL: Sequence numbers error, recv:0x3c7, expect:0x3c4, recount:0x0
I (46590) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (46810) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (46830) BT_APPL: Sequence numbers error, recv:0x3d3, expect:0x3d1, recount:0x0
I (46880) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (46910) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (47100) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (47110) BT_APPL: Sequence numbers error, recv:0x3df, expect:0x3de, recount:0x0
I (47150) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (47360) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (47380) BT_APPL: Sequence numbers error, recv:0x3eb, expect:0x3e8, recount:0x0
I (47420) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (47600) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (47610) BT_APPL: Sequence numbers error, recv:0x3f5, expect:0x3f3, recount:0x0
I (47660) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (47880) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (47900) BT_APPL: Sequence numbers error, recv:0x401, expect:0x3ff, recount:0x0
I (47950) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (47980) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (48170) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (48190) BT_APPL: Sequence numbers error, recv:0x40e, expect:0x40c, recount:0x0
I (48240) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (48460) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (48480) BT_APPL: Sequence numbers error, recv:0x41a, expect:0x418, recount:0x0
I (48520) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (48550) BT_AV: Audio packet count: 900
I (48740) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (48770) BT_APPL: Sequence numbers error, recv:0x426, expect:0x424, recount:0x0
I (48810) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (48840) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (49040) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (49060) BT_APPL: Sequence numbers error, recv:0x433, expect:0x431, recount:0x0
I (49100) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (49330) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (49350) BT_APPL: Sequence numbers error, recv:0x43f, expect:0x43d, recount:0x0
I (49390) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (49420) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (49610) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (49640) BT_APPL: Sequence numbers error, recv:0x44c, expect:0x44a, recount:0x0
I (49680) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (49900) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (49930) BT_APPL: Sequence numbers error, recv:0x458, expect:0x456, recount:0x0
I (49970) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (50000) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (50200) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (50240) BT_APPL: Sequence numbers error, recv:0x466, expect:0x463, recount:0x0
I (50280) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (50500) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (50520) BT_APPL: Sequence numbers error, recv:0x472, expect:0x470, recount:0x0
I (50570) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (50790) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (50810) BT_APPL: Sequence numbers error, recv:0x47e, expect:0x47c, recount:0x0
I (50860) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (50890) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (51080) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (51110) BT_APPL: Sequence numbers error, recv:0x48b, expect:0x489, recount:0x0
I (51150) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (51180) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (51370) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (51400) BT_APPL: Sequence numbers error, recv:0x497, expect:0x496, recount:0x0
I (51450) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (51450) BT_AV: Audio packet count: 1000
W (51480) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (51670) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (51690) BT_APPL: Sequence numbers error, recv:0x4a4, expect:0x4a2, recount:0x0
I (51740) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (51770) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (51970) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (51990) BT_APPL: Sequence numbers error, recv:0x4b1, expect:0x4af, recount:0x0
I (52040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (52070) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (52250) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (52280) BT_APPL: Sequence numbers error, recv:0x4bd, expect:0x4bc, recount:0x0
I (52320) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (52350) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (52550) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (52570) BT_APPL: Sequence numbers error, recv:0x4ca, expect:0x4c8, recount:0x0
I (52610) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (52840) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (52860) BT_APPL: Sequence numbers error, recv:0x4d6, expect:0x4d4, recount:0x0
I (52900) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (52930) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (53130) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53150) BT_APPL: Sequence numbers error, recv:0x4e3, expect:0x4e1, recount:0x0
I (53190) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (53220) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (53420) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53440) BT_APPL: Sequence numbers error, recv:0x4ef, expect:0x4ee, recount:0x0
I (53480) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (53680) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53700) BT_APPL: Sequence numbers error, recv:0x4fb, expect:0x4f8, recount:0x0
I (53740) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (53970) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (53990) BT_APPL: Sequence numbers error, recv:0x507, expect:0x505, recount:0x0
I (54040) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54060) BT_AV: Audio packet count: 1100
W (54070) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (54260) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (54280) BT_APPL: Sequence numbers error, recv:0x514, expect:0x512, recount:0x0
I (54320) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54550) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (54570) BT_APPL: Sequence numbers error, recv:0x520, expect:0x51e, recount:0x0
I (54610) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (54840) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (54860) BT_APPL: Sequence numbers error, recv:0x52d, expect:0x52a, recount:0x0
I (54910) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (55130) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (55150) BT_APPL: Sequence numbers error, recv:0x539, expect:0x537, recount:0x0
I (55200) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (55230) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (55420) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (55450) BT_APPL: Sequence numbers error, recv:0x546, expect:0x544, recount:0x0
I (55490) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (55530) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (55720) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (55740) BT_APPL: Sequence numbers error, recv:0x553, expect:0x551, recount:0x0
I (55790) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56020) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (56040) BT_APPL: Sequence numbers error, recv:0x55f, expect:0x55d, recount:0x0
I (56060) RC_TG: Volume is set locally to: 17%
I (56090) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56100) RC_TG: AVRC register event notification: 13, param: 0x0
W (56120) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (56310) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (56330) BT_APPL: Sequence numbers error, recv:0x56c, expect:0x56a, recount:0x0
I (56380) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56600) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (56630) BT_APPL: Sequence numbers error, recv:0x579, expect:0x576, recount:0x0
I (56670) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (56700) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (56900) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (56920) BT_APPL: Sequence numbers error, recv:0x585, expect:0x584, recount:0x0
I (56960) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (56970) BT_AV: Audio packet count: 1200
W (56990) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (57190) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (57210) BT_APPL: Sequence numbers error, recv:0x592, expect:0x590, recount:0x0
I (57250) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (57480) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (57500) BT_APPL: Sequence numbers error, recv:0x59e, expect:0x59c, recount:0x0
I (57550) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (57580) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
I (57770) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (57790) BT_APPL: Sequence numbers error, recv:0x5ab, expect:0x5a9, recount:0x0
I (57840) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (58060) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (58080) BT_APPL: Sequence numbers error, recv:0x5b7, expect:0x5b5, recount:0x0
I (58130) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
W (58160) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (58230) BT_APP_CORE: ringbuffer is full, drop this packet!
I (58230) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
W (58270) BT_APP_CORE: ringbuffer overflowed, ready to decrease data! mode changed: RINGBUFFER_MODE_DROPPING
W (58330) BT_APP_CORE: ringbuffer is full, drop this packet!
I (58330) BT_APP_CORE: ringbuffer data decreased! mode changed: RINGBUFFER_MODE_PROCESSING
I (59360) BT_AV: Audio packet count: 1300
I (60100) BT_AV: A2DP audio state: Suspended
I (60220) BT_APP_CORE: ringbuffer underflowed! mode changed: RINGBUFFER_MODE_PREFETCHING
W (63300) BT_HCI: hci cmd send: sniff: hdl 0x80, intv(30 54)
W (63310) BT_HCI: hcif mode change: hdl 0x80, mode 2, intv 54, status 0x0
I (63320) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 2
I (66060) RC_TG: Volume is set locally to: 21%
I (66130) RC_TG: AVRC register event notification: 13, param: 0x0
0x0fe commented 1 year ago

So, i think i found a big clue, if i change the GPIOs assigned to I2S to those used by default (22,25,26), the problem instantly disappears. No more underruns. Of course i cannot check the audio, because i use our actual hardware and thee is not easy or convenient way to strap/route these GPIos to the DAC, but anyway i am quite sure there would be no stuttering. So now the questions are :

-why and how would the I2S GPIos have an impact on the buffer underruns / BT performance / PER. -how comes this is not the case on D0WD and D0WDQ6? -which mitigation?

image

ets Jul 29 2019 12:21:46
rst:0x1 (POWERON_RESET),boot:0x1b (SPI_FAST_FLASH_BOOT)
configsip: 153911750, SPIWP:0xee
clk_drv:0x00,q_drv:0x00,d_drv:0x00,cs0_drv:0x00,hd_drv:0x00,wp_drv:0x00
mode:DIO, clock div:2
load:0x3fff0030,len:6056
load:0x40078000,len:15500
ho 0 tail 12 room 4
load:0x40080400,len:3844
entry 0x4008064c
I (30) boot: ESP-IDF v5.0.1-dirty 2nd stage bootloader
I (30) boot: compile time 23:50:27
I (30) boot: chip revision: v3.0
I (30) boot.esp32: SPI Speed      : 40MHz
I (34) boot.esp32: SPI Mode       : DIO
I (38) boot.esp32: SPI Flash Size : 2MB
I (41) boot: Enabling RNG early entropy source...
I (46) boot: Partition Table:
I (48) boot: ## Label            Usage          Type ST Offset   Length
I (55) boot:  0 nvs              WiFi data        01 02 00009000 00006000
I (61) boot:  1 phy_init         RF data          01 01 0000f000 00001000
I (68) boot:  2 factory          factory app      00 00 00010000 00177000
I (74) boot: End of partition table
I (78) esp_image: segment 0: paddr=00010020 vaddr=3f400020 size=2b718h (177944) map
I (149) esp_image: segment 1: paddr=0003b740 vaddr=3ffbdb60 size=04674h ( 18036) load
I (157) esp_image: segment 2: paddr=0003fdbc vaddr=40080000 size=0025ch (   604) load
I (157) esp_image: segment 3: paddr=00040020 vaddr=400d0020 size=b9024h (757796) map
I (434) esp_image: segment 4: paddr=000f904c vaddr=4008025c size=1d7bch (120764) load
I (499) boot: Loaded app from partition at offset 0x10000
I (499) boot: Disabling RNG early entropy source...
I (509) quad_psram: This chip is ESP32-D0WDR2-V3
I (511) esp_psram: Found 2MB PSRAM device
I (511) esp_psram: Speed: 40MHz
I (511) esp_psram: PSRAM initialized, cache is in low/high (2-core) mode.
I (517) cpu_start: Pro cpu up.
I (520) cpu_start: Starting app cpu, entry point is 0x400816e8
I (0) cpu_start: App cpu up.
I (989) esp_psram: SPI SRAM memory test OK
I (997) cpu_start: Pro cpu start user code
I (997) cpu_start: cpu freq: 160000000 Hz
I (997) cpu_start: Application information:
I (997) cpu_start: Project name:     a2dp_sink
I (1001) cpu_start: App version:      v5.0.1-dirty
I (1006) cpu_start: Compile time:     Apr 17 2023 23:50:00
I (1011) cpu_start: ELF file SHA256:  ffa45bac1c783651...
I (1016) cpu_start: ESP-IDF:          v5.0.1-dirty
I (1021) cpu_start: Min chip rev:     v0.0
I (1024) cpu_start: Max chip rev:     v3.99 
I (1028) cpu_start: Chip rev:         v3.0
I (1033) heap_init: Initializing. RAM available for dynamic allocation:
I (1039) heap_init: At 3FFAFF10 len 000000F0 (0 KiB): DRAM
I (1044) heap_init: At 3FFB6388 len 00001C78 (7 KiB): DRAM
I (1049) heap_init: At 3FFB9A20 len 00004108 (16 KiB): DRAM
I (1054) heap_init: At 3FFCB8F8 len 00014708 (81 KiB): DRAM
I (1059) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1065) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1071) heap_init: At 4009DA18 len 000025E8 (9 KiB): IRAM
I (1076) esp_psram: Adding pool of 2048K of PSRAM memory to heap allocator
I (1084) spi_flash: detected chip: generic
I (1086) spi_flash: flash io: dio
W (1089) spi_flash: Detected size(4096k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
I (1103) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (1110) esp_psram: Reserving pool of 32K of internal memory for DMA/internal allocations
I (1180) BTDM_INIT: BT controller compile version [60aae55]
I (1180) system_api: Base MAC address is not set
I (1180) system_api: read default base MAC address from EFUSE
I (1180) phy_init: phy_version 4670,719f9f6,Feb 18 2021,17:07:07
W (1890) BT_BTC: A2DP Enable with AVRC
I (1900) BT_AV: A2DP PROF STATE: Init Complete
I (1900) BT_AV: event: 10
I (1910) BT_AV: event: 10
I (1910) BT_AV: event: 10
I (1910) BT_AV: event: 10
I (1910) BT_AV: Get delay report value: delay_value: 1200 * 1/10 ms
I (1910) BT_AV: Set delay report value: success, delay_value: 1250 * 1/10 ms
W (3930) BT_HCI: hcif conn complete: hdl 0x80, st 0x0
I (3940) BT_AV: ESP_BT_GAP_ACL_CONN_CMPL_STAT_EVT Connected to [a4:c6:f0:85:a9:9a], status: 0x100
W (4020) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 8000
W (4270) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 32000
W (4370) BT_HCI: hcif link supv_to changed: hdl 0x80, supv_to 8000
E (4380) BT_APPL: bta_av_rc_create ACP handle exist for shdl:0
I (4380) BT_AV: A2DP connection state: Connecting, [a4:c6:f0:85:a9:9a]
I (4400) RC_TG: AVRC conn_state evt: state 1, [a4:c6:f0:85:a9:9a]
I (4400) RC_TG: start volume change simulation
I (4540) BT_AV: A2DP audio stream configuration, codec type: 0
I (4540) BT_AV: Configure audio player: 21-15-2-35
I (4540) BT_AV: Audio player configured, sample rate: 44100
I (4540) BT_AV: protocol service capabilities configured: 0x1 
I (4550) BT_AV: Peer device support delay reporting
I (4610) RC_TG: AVRC register event notification: 13, param: 0x0
I (4810) RC_CT: AVRC conn_state event: state 1, [a4:c6:f0:85:a9:9a]
I (4810) RC_CT: AVRC remote features 25b, TG features d1
I (4810) RC_TG: AVRC remote features: 25b, CT features: 2
W (4890) BT_APPL: new conn_srvc id:19, app_id:0
I (4890) BT_AV: A2DP connection state: Connected, [a4:c6:f0:85:a9:9a]
I (4890) BT_APP_CORE: ringbuffer data empty! mode changed: RINGBUFFER_MODE_PREFETCHING
I (4920) RC_CT: remote rn_cap: count 7, bitmask 0x1f06
I (5040) RC_CT: AVRC metadata rsp: attribute id 0x1, 
I (5040) RC_CT: AVRC metadata rsp: attribute id 0x2, 
I (5040) RC_CT: AVRC metadata rsp: attribute id 0x4, 
I (5040) RC_CT: AVRC metadata rsp: attribute id 0x20, 
I (5470) RC_CT: AVRC remote features 25b, TG features d1
I (5470) RC_TG: AVRC remote features: 25b, CT features: 2
W (8090) BT_HCI: hci cmd send: sniff: hdl 0x80, intv(400 800)
W (8100) BT_HCI: hcif mode change: hdl 0x80, mode 2, intv 800, status 0x0
I (8100) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 2
I (8790) RC_TG: AVRC set absolute volume: 82%
I (8790) RC_TG: Volume is set by remote controller to: 82%
I (14400) RC_TG: Volume is set locally to: 86%
I (15280) RC_TG: AVRC register event notification: 13, param: 0x0
W (15780) BT_HCI: hcif mode change: hdl 0x80, mode 0, intv 0, status 0x0
I (15780) BT_AV: ESP_BT_GAP_MODE_CHG_EVT mode: 0
I (15790) RC_TG: AVRC set absolute volume: 85%
I (15790) RC_TG: Volume is set by remote controller to: 85%
I (15840) BT_LOG: bta_av_link_role_ok hndl:x41 role:1 conn_audio:x1 bits:1 features:x864b

W (15840) BT_APPL: new conn_srvc id:19, app_id:1
I (15850) BT_AV: A2DP audio state: Started
I (15990) BT_APP_CORE: ringbuffer data increased! mode changed: RINGBUFFER_MODE_PROCESSING
I (18210) BT_AV: Audio packet count: 100
I (20520) BT_AV: Audio packet count: 200
I (22880) BT_AV: Audio packet count: 300
I (24400) RC_TG: Volume is set locally to: 89%
I (24470) RC_TG: AVRC register event notification: 13, param: 0x0
I (24470) RC_TG: AVRC set absolute volume: 88%
I (24470) RC_TG: Volume is set by remote controller to: 88%
I (25170) BT_AV: Audio packet count: 400
I (27490) BT_AV: Audio packet count: 500
I (29810) BT_AV: Audio packet count: 600
I (32130) BT_AV: Audio packet count: 700
I (34400) RC_TG: Volume is set locally to: 92%
I (34420) RC_TG: AVRC register event notification: 13, param: 0x0
I (34420) RC_TG: AVRC set absolute volume: 92%
I (34420) RC_TG: Volume is set by remote controller to: 92%
I (34470) BT_AV: Audio packet count: 800
I (36770) BT_AV: Audio packet count: 900
I (39110) BT_AV: Audio packet count: 1000
I (41440) BT_AV: Audio packet count: 1100
I (43740) BT_AV: Audio packet count: 1200
I (44400) RC_TG: Volume is set locally to: 96%
I (44420) RC_TG: AVRC register event notification: 13, param: 0x0
I (46100) BT_AV: Audio packet count: 1300
I (48420) BT_AV: Audio packet count: 1400
I (50740) BT_AV: Audio packet count: 1500
I (53050) BT_AV: Audio packet count: 1600
I (54400) RC_TG: Volume is set locally to: 100%
I (54490) RC_TG: AVRC register event notification: 13, param: 0x0
I (55400) BT_AV: Audio packet count: 1700
I (57720) BT_AV: Audio packet count: 1800
I (60020) BT_AV: Audio packet count: 1900
I (62340) BT_AV: Audio packet count: 2000
I (64400) RC_TG: Volume is set locally to: 3%
I (64450) RC_TG: AVRC register event notification: 13, param: 0x0
0x0fe commented 1 year ago

after more test, i can be even more specific : this problem is caused by using GPIO21 for DATA, as soon as i change DATA gpio to something else, for example GPIO19, the problem of underrun disappear.

0x0fe commented 1 year ago

so, it is a little more complicated apparently, not only GPIO21 cause the issue, in fact many combination of GPIOs cause these underruns, I have tested the last pinmap and the audio is perfect. One problem remains though, the volume control is inoperant, it shows up in the log, but has no impact on the level out of the DAC.

image

0x0fe commented 1 year ago

so, to be more precise about the problem with audio control, 1) the volume change notificatiosn are working, in both directions but it does not affect eh audio level. 2) there is an horrible clipping going on, never got this clipping before and it is not coming from the PA since we use class A. This really sounds like a digital clipping.

I (1008730) BT_AV: Audio packet count: 40600
I (1009090) RC_TG: Volume is set locally to: 96%
I (1009110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1010190) BT_AV: Audio packet count: 40700
I (1011140) RC_TG: AVRC set absolute volume: 99%
I (1011140) RC_TG: Volume is set by remote controller to: 99%
I (1011640) BT_AV: Audio packet count: 40800
I (1011950) RC_TG: AVRC set absolute volume: 74%
I (1011950) RC_TG: Volume is set by remote controller to: 74%
I (1012920) RC_TG: AVRC set absolute volume: 86%
I (1012920) RC_TG: Volume is set by remote controller to: 86%
I (1013090) BT_AV: Audio packet count: 40900
I (1014540) BT_AV: Audio packet count: 41000
I (1015990) BT_AV: Audio packet count: 41100
I (1017450) BT_AV: Audio packet count: 41200
I (1018890) BT_AV: Audio packet count: 41300
I (1019090) RC_TG: Volume is set locally to: 90%
I (1019100) RC_TG: AVRC register event notification: 13, param: 0x0
I (1020340) BT_AV: Audio packet count: 41400
I (1021800) BT_AV: Audio packet count: 41500
I (1023250) BT_AV: Audio packet count: 41600
I (1024700) BT_AV: Audio packet count: 41700
I (1026150) BT_AV: Audio packet count: 41800
I (1027610) BT_AV: Audio packet count: 41900
I (1029050) BT_AV: Audio packet count: 42000
I (1029090) RC_TG: Volume is set locally to: 94%
I (1029100) RC_TG: AVRC register event notification: 13, param: 0x0
I (1030500) BT_AV: Audio packet count: 42100
I (1031950) BT_AV: Audio packet count: 42200
I (1033410) BT_AV: Audio packet count: 42300
I (1034860) BT_AV: Audio packet count: 42400
I (1036310) BT_AV: Audio packet count: 42500
I (1037760) BT_AV: Audio packet count: 42600
I (1039090) RC_TG: Volume is set locally to: 98%
I (1039130) RC_TG: AVRC register event notification: 13, param: 0x0
I (1039210) BT_AV: Audio packet count: 42700
I (1040660) BT_AV: Audio packet count: 42800
I (1042110) BT_AV: Audio packet count: 42900
I (1043560) BT_AV: Audio packet count: 43000
I (1045030) BT_AV: Audio packet count: 43100
I (1046480) BT_AV: Audio packet count: 43200
I (1047920) BT_AV: Audio packet count: 43300
I (1049090) RC_TG: Volume is set locally to: 1%
I (1049110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1049370) BT_AV: Audio packet count: 43400
I (1050820) BT_AV: Audio packet count: 43500
I (1052270) BT_AV: Audio packet count: 43600
I (1053720) BT_AV: Audio packet count: 43700
I (1055170) BT_AV: Audio packet count: 43800
I (1056630) BT_AV: Audio packet count: 43900
I (1058080) BT_AV: Audio packet count: 44000
I (1059090) RC_TG: Volume is set locally to: 5%
I (1059110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1059530) BT_AV: Audio packet count: 44100
I (1060980) BT_AV: Audio packet count: 44200
I (1062430) BT_AV: Audio packet count: 44300
I (1063880) BT_AV: Audio packet count: 44400
I (1065330) BT_AV: Audio packet count: 44500
I (1066780) BT_AV: Audio packet count: 44600
I (1068240) BT_AV: Audio packet count: 44700
I (1069090) RC_TG: Volume is set locally to: 9%
I (1069110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1069690) BT_AV: Audio packet count: 44800
I (1071140) BT_AV: Audio packet count: 44900
I (1072590) BT_AV: Audio packet count: 45000
I (1074050) BT_AV: Audio packet count: 45100
I (1075520) BT_AV: Audio packet count: 45200
I (1076940) BT_AV: Audio packet count: 45300
I (1078390) BT_AV: Audio packet count: 45400
I (1079090) RC_TG: Volume is set locally to: 13%
I (1079120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1079850) BT_AV: Audio packet count: 45500
I (1081300) BT_AV: Audio packet count: 45600
I (1082750) BT_AV: Audio packet count: 45700
I (1084200) BT_AV: Audio packet count: 45800
I (1085650) BT_AV: Audio packet count: 45900
I (1087100) BT_AV: Audio packet count: 46000
I (1088550) BT_AV: Audio packet count: 46100
I (1089090) RC_TG: Volume is set locally to: 17%
I (1089110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1090000) BT_AV: Audio packet count: 46200
I (1091460) BT_AV: Audio packet count: 46300
I (1092910) BT_AV: Audio packet count: 46400
I (1094360) BT_AV: Audio packet count: 46500
I (1095810) BT_AV: Audio packet count: 46600
I (1097260) BT_AV: Audio packet count: 46700
I (1098720) BT_AV: Audio packet count: 46800
I (1099090) RC_TG: Volume is set locally to: 21%
I (1099120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1100160) BT_AV: Audio packet count: 46900
I (1101620) BT_AV: Audio packet count: 47000
I (1103090) BT_AV: Audio packet count: 47100
I (1104520) BT_AV: Audio packet count: 47200
I (1105970) BT_AV: Audio packet count: 47300
I (1107420) BT_AV: Audio packet count: 47400
I (1108870) BT_AV: Audio packet count: 47500
I (1109090) RC_TG: Volume is set locally to: 25%
I (1109130) RC_TG: AVRC register event notification: 13, param: 0x0
I (1110320) BT_AV: Audio packet count: 47600
I (1111770) BT_AV: Audio packet count: 47700
I (1113210) BT_AV: Audio packet count: 47800
I (1114680) BT_AV: Audio packet count: 47900
I (1116130) BT_AV: Audio packet count: 48000
I (1117580) BT_AV: Audio packet count: 48100
I (1119020) BT_AV: Audio packet count: 48200
I (1119090) RC_TG: Volume is set locally to: 29%
I (1119130) RC_TG: AVRC register event notification: 13, param: 0x0
I (1120470) BT_AV: Audio packet count: 48300
I (1121920) BT_AV: Audio packet count: 48400
I (1123370) BT_AV: Audio packet count: 48500
I (1124820) BT_AV: Audio packet count: 48600
I (1126290) BT_AV: Audio packet count: 48700
I (1127740) BT_AV: Audio packet count: 48800
I (1129090) RC_TG: Volume is set locally to: 33%
I (1129100) RC_TG: AVRC register event notification: 13, param: 0x0
I (1129190) BT_AV: Audio packet count: 48900
I (1130640) BT_AV: Audio packet count: 49000
I (1132090) BT_AV: Audio packet count: 49100
I (1133530) BT_AV: Audio packet count: 49200
I (1134980) BT_AV: Audio packet count: 49300
I (1136430) BT_AV: Audio packet count: 49400
I (1137900) BT_AV: Audio packet count: 49500
I (1139090) RC_TG: Volume is set locally to: 37%
I (1139110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1139340) BT_AV: Audio packet count: 49600
I (1140790) BT_AV: Audio packet count: 49700
I (1142240) BT_AV: Audio packet count: 49800
I (1143690) BT_AV: Audio packet count: 49900
I (1145140) BT_AV: Audio packet count: 50000
I (1146590) BT_AV: Audio packet count: 50100
I (1148040) BT_AV: Audio packet count: 50200
I (1149090) RC_TG: Volume is set locally to: 40%
I (1149110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1149500) BT_AV: Audio packet count: 50300
I (1150950) BT_AV: Audio packet count: 50400
I (1152410) BT_AV: Audio packet count: 50500
I (1153860) BT_AV: Audio packet count: 50600
I (1155310) BT_AV: Audio packet count: 50700
I (1156750) BT_AV: Audio packet count: 50800
I (1158240) BT_AV: Audio packet count: 50900
I (1159090) RC_TG: Volume is set locally to: 44%
I (1159110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1159680) BT_AV: Audio packet count: 51000
I (1161140) BT_AV: Audio packet count: 51100
I (1162560) BT_AV: Audio packet count: 51200
I (1164010) BT_AV: Audio packet count: 51300
I (1165460) BT_AV: Audio packet count: 51400
I (1166920) BT_AV: Audio packet count: 51500
I (1168360) BT_AV: Audio packet count: 51600
I (1169090) RC_TG: Volume is set locally to: 48%
I (1169110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1169810) BT_AV: Audio packet count: 51700
I (1171260) BT_AV: Audio packet count: 51800
I (1172720) BT_AV: Audio packet count: 51900
I (1174180) BT_AV: Audio packet count: 52000
I (1175630) BT_AV: Audio packet count: 52100
I (1177070) BT_AV: Audio packet count: 52200
I (1178520) BT_AV: Audio packet count: 52300
I (1179090) RC_TG: Volume is set locally to: 52%
I (1179140) RC_TG: AVRC register event notification: 13, param: 0x0
I (1179980) BT_AV: Audio packet count: 52400
I (1181420) BT_AV: Audio packet count: 52500
I (1182870) BT_AV: Audio packet count: 52600
I (1184330) BT_AV: Audio packet count: 52700
I (1185780) BT_AV: Audio packet count: 52800
I (1187240) BT_AV: Audio packet count: 52900
I (1188610) RC_TG: AVRC set absolute volume: 0%
I (1188610) RC_TG: Volume is set by remote controller to: 0%
I (1188690) BT_AV: Audio packet count: 53000
I (1189090) RC_TG: Volume is set locally to: 3%
I (1189110) RC_TG: AVRC set absolute volume: 52%
I (1189110) RC_TG: Volume is set by remote controller to: 52%
I (1189120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1190130) BT_AV: Audio packet count: 53100
I (1191180) RC_TG: AVRC set absolute volume: 0%
I (1191180) RC_TG: Volume is set by remote controller to: 0%
I (1191600) BT_AV: Audio packet count: 53200
I (1193030) BT_AV: Audio packet count: 53300
I (1194480) BT_AV: Audio packet count: 53400
I (1195940) BT_AV: Audio packet count: 53500
I (1197390) BT_AV: Audio packet count: 53600
I (1198870) BT_AV: Audio packet count: 53700
I (1199090) RC_TG: Volume is set locally to: 3%
I (1199110) RC_TG: AVRC set absolute volume: 52%
I (1199110) RC_TG: Volume is set by remote controller to: 52%
I (1199140) RC_TG: AVRC register event notification: 13, param: 0x0
I (1200290) BT_AV: Audio packet count: 53800
I (1201620) RC_TG: AVRC set absolute volume: 0%
I (1201620) RC_TG: Volume is set by remote controller to: 0%
I (1201740) BT_AV: Audio packet count: 53900
I (1203190) BT_AV: Audio packet count: 54000
I (1204640) BT_AV: Audio packet count: 54100
I (1206090) BT_AV: Audio packet count: 54200
I (1207550) BT_AV: Audio packet count: 54300
I (1209000) BT_AV: Audio packet count: 54400
I (1209090) RC_TG: Volume is set locally to: 3%
I (1209120) RC_TG: AVRC set absolute volume: 52%
I (1209120) RC_TG: Volume is set by remote controller to: 52%
I (1209130) RC_TG: AVRC register event notification: 13, param: 0x0
I (1210450) BT_AV: Audio packet count: 54500
I (1211900) BT_AV: Audio packet count: 54600
I (1213350) BT_AV: Audio packet count: 54700
I (1214810) BT_AV: Audio packet count: 54800
I (1216270) BT_AV: Audio packet count: 54900
I (1216320) RC_TG: AVRC set absolute volume: 0%
I (1216320) RC_TG: Volume is set by remote controller to: 0%
I (1217710) BT_AV: Audio packet count: 55000
I (1219090) RC_TG: Volume is set locally to: 3%
I (1219110) RC_TG: AVRC set absolute volume: 52%
I (1219110) RC_TG: Volume is set by remote controller to: 52%
I (1219120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1219160) BT_AV: Audio packet count: 55100
I (1220610) BT_AV: Audio packet count: 55200
I (1222060) BT_AV: Audio packet count: 55300
I (1222770) RC_CT: AVRC event notification: 1
I (1222770) BT_AV: Playback status changed: 0x2
I (1223510) BT_AV: Audio packet count: 55400
I (1224980) BT_AV: Audio packet count: 55500
I (1226410) BT_AV: Audio packet count: 55600
I (1227860) BT_AV: Audio packet count: 55700
I (1229090) RC_TG: Volume is set locally to: 56%
I (1229110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1229310) BT_AV: Audio packet count: 55800
I (1230770) BT_AV: Audio packet count: 55900
I (1232220) BT_AV: Audio packet count: 56000
I (1233680) BT_AV: Audio packet count: 56100
I (1235120) BT_AV: Audio packet count: 56200
I (1236570) BT_AV: Audio packet count: 56300
I (1238020) BT_AV: Audio packet count: 56400
I (1239090) RC_TG: Volume is set locally to: 60%
I (1239110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1239470) BT_AV: Audio packet count: 56500
I (1240920) BT_AV: Audio packet count: 56600
I (1242380) BT_AV: Audio packet count: 56700
I (1243840) BT_AV: Audio packet count: 56800
I (1245310) BT_AV: Audio packet count: 56900
I (1246740) BT_AV: Audio packet count: 57000
I (1248180) BT_AV: Audio packet count: 57100
I (1249090) RC_TG: Volume is set locally to: 64%
I (1249110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1249630) BT_AV: Audio packet count: 57200
I (1251080) BT_AV: Audio packet count: 57300
I (1252540) BT_AV: Audio packet count: 57400
I (1253990) BT_AV: Audio packet count: 57500
I (1255440) BT_AV: Audio packet count: 57600
I (1256890) BT_AV: Audio packet count: 57700
I (1258340) BT_AV: Audio packet count: 57800
I (1259090) RC_TG: Volume is set locally to: 68%
I (1259120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1259790) BT_AV: Audio packet count: 57900
I (1261240) BT_AV: Audio packet count: 58000
I (1262690) BT_AV: Audio packet count: 58100
I (1264140) BT_AV: Audio packet count: 58200
I (1265610) BT_AV: Audio packet count: 58300
I (1267050) BT_AV: Audio packet count: 58400
I (1268500) BT_AV: Audio packet count: 58500
I (1269090) RC_TG: Volume is set locally to: 72%
I (1269120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1269950) BT_AV: Audio packet count: 58600
I (1271410) BT_AV: Audio packet count: 58700
I (1272870) BT_AV: Audio packet count: 58800
I (1274300) BT_AV: Audio packet count: 58900
I (1275750) BT_AV: Audio packet count: 59000
I (1277210) BT_AV: Audio packet count: 59100
I (1278660) BT_AV: Audio packet count: 59200
I (1279090) RC_TG: Volume is set locally to: 76%
I (1279100) RC_TG: AVRC register event notification: 13, param: 0x0
I (1280110) BT_AV: Audio packet count: 59300
I (1281560) BT_AV: Audio packet count: 59400
I (1283010) BT_AV: Audio packet count: 59500
I (1284460) BT_AV: Audio packet count: 59600
I (1285910) BT_AV: Audio packet count: 59700
I (1287360) BT_AV: Audio packet count: 59800
I (1288820) BT_AV: Audio packet count: 59900
I (1289090) RC_TG: Volume is set locally to: 80%
I (1289120) RC_TG: AVRC register event notification: 13, param: 0x0
I (1290270) BT_AV: Audio packet count: 60000
I (1291720) BT_AV: Audio packet count: 60100
I (1293170) BT_AV: Audio packet count: 60200
I (1294620) BT_AV: Audio packet count: 60300
I (1296070) BT_AV: Audio packet count: 60400
I (1297520) BT_AV: Audio packet count: 60500
I (1298970) BT_AV: Audio packet count: 60600
I (1299090) RC_TG: Volume is set locally to: 84%
I (1299110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1300430) BT_AV: Audio packet count: 60700
I (1301890) BT_AV: Audio packet count: 60800
I (1303330) BT_AV: Audio packet count: 60900
I (1304780) BT_AV: Audio packet count: 61000
I (1306230) BT_AV: Audio packet count: 61100
I (1307680) BT_AV: Audio packet count: 61200
I (1309090) RC_TG: Volume is set locally to: 88%
I (1309110) RC_TG: AVRC register event notification: 13, param: 0x0
I (1309130) BT_AV: Audio packet count: 61300
I (1310580) BT_AV: Audio packet count: 61400
I (1312040) BT_AV: Audio packet count: 61500
I (1313490) BT_AV: Audio packet count: 61600

[Uploading D0WDR2 A2DP clipping.zip…]()

0x0fe commented 1 year ago

i juste ran the ad2p library test (so, with IDF 4.4) ,

1) there is no clipping and no stuttering, everything is smooth when using GPIO19 for DOUT.

2) level is lower than IDF 5.0.1 A2DP sink example (using identical source) so it seems IDF 5.0.1 is indeed overdriving the I2S datas somehow, to the point of feeding clipped datas to the DAC.

3) the volume control works fine on the A2DP library running over IDF 4.4 so it seems this problem also relates to IDF 5.0.1.

So, it confirm the root cause of the problem is related to pin muxing or "cross bar" or maybe some other issues tightly related to the pin mapping. As far as we are concerned we will jsut use GPIO19 instead of GPIO21 to go around the issue since we already wasted a lot of time on this, but it is certainly worth investigating what causes this issue, because again it oes not occur on D0WD nor D0WDQ6, and it seriously affects the usability of I2S whenever A2DP will be used, in effect many pin conbinations will not work at all.

xiongweichao commented 1 year ago

@0x0fe May I ask if this problem still exists in the latest idf v5.0?