You signed in with another tab or window. Reload to refresh your session.You signed out in another tab or window. Reload to refresh your session.You switched accounts on another tab or window. Reload to refresh your session.Dismiss alert
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x8 (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce3818,len:0x18e4
load:0x403c9700,len:0x4
load:0x403c9704,len:0xda4
load:0x403cc700,len:0x308c
entry 0x403c9934
I (27) boot: ESP-IDF v5.1.4-dirty 2nd stage bootloader
I (27) boot: compile time Sep 4 2024 16:14:48
I (27) boot: Multicore bootloader
I (30) boot: chip revision: v0.2
I (34) qio_mode: Enabling default flash chip QIO
I (39) boot.esp32s3: Boot SPI Speed : 80MHz
I (44) boot.esp32s3: SPI Mode : QIO
I (49) boot.esp32s3: SPI Flash Size : 4MB
I (54) boot: Enabling RNG early entropy source...
I (59) boot: Partition Table:
I (63) boot: ## Label Usage Type ST Offset Length
I (70) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (77) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (85) boot: 2 factory factory app 00 00 00010000 00200000
I (92) boot: 3 flash_tone Unknown data 01 ff 00210000 0007d000
I (100) boot: End of partition table
I (104) esp_image: segment 0: paddr=00010020 vaddr=3c150020 size=51c04h (334852) map
I (163) esp_image: segment 1: paddr=00061c2c vaddr=3fc97500 size=08e7ch ( 36476) load
I (170) esp_image: segment 2: paddr=0006aab0 vaddr=40374000 size=05568h ( 21864) load
I (175) esp_image: segment 3: paddr=00070020 vaddr=42000020 size=148ae8h (1346280) map
I (382) esp_image: segment 4: paddr=001b8b10 vaddr=40379568 size=0dec0h ( 57024) load
I (402) boot: Loaded app from partition at offset 0x10000
I (402) boot: Disabling RNG early entropy source...
I (414) cpu_start: Multicore app
I (414) octal_psram: vendor id : 0x0d (AP)
I (414) octal_psram: dev id : 0x02 (generation 3)
I (417) octal_psram: density : 0x03 (64 Mbit)
I (423) octal_psram: good-die : 0x01 (Pass)
I (428) octal_psram: Latency : 0x01 (Fixed)
I (433) octal_psram: VCC : 0x01 (3V)
I (438) octal_psram: SRF : 0x01 (Fast Refresh)
I (444) octal_psram: BurstType : 0x01 (Hybrid Wrap)
I (450) octal_psram: BurstLen : 0x01 (32 Byte)
I (456) octal_psram: Readlatency : 0x02 (10 cycles@Fixed)
I (462) octal_psram: DriveStrength: 0x00 (1/1)
I (467) MSPI Timing: PSRAM timing tuning index: 5
I (472) esp_psram: Found 8MB PSRAM device
I (477) esp_psram: Speed: 80MHz
I (586) mmu_psram: Instructions copied and mapped to SPIRAM
I (615) mmu_psram: Read only data copied and mapped to SPIRAM
I (615) cpu_start: Pro cpu up.
I (616) cpu_start: Starting app cpu, entry point is 0x403757cc
0x403757cc: call_start_cpu1 at C:/Espressif/frameworks/esp-idf-v5.1.4/components/esp_system/port/cpu_start.c:159
I (0) cpu_start: App cpu up.
I (977) esp_psram: SPI SRAM memory test OK
I (986) cpu_start: Pro cpu start user code
I (986) cpu_start: cpu freq: 240000000 Hz
I (986) cpu_start: Application information:
I (989) cpu_start: Project name: voip_app
I (994) cpu_start: App version: v2.6-167-ge27cd526-dirty
I (1001) cpu_start: Compile time: Sep 9 2024 13:44:56
I (1007) cpu_start: ELF file SHA256: b3e74ffbe637d599...
I (1013) cpu_start: ESP-IDF: v5.1.4-dirty
I (1019) cpu_start: Min chip rev: v0.0
I (1023) cpu_start: Max chip rev: v0.99
I (1028) cpu_start: Chip rev: v0.2
I (1033) heap_init: Initializing. RAM available for dynamic allocation:
I (1040) heap_init: At 3FCA1C60 len 00047AB0 (286 KiB): DRAM
I (1047) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DRAM
I (1054) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
I (1060) heap_init: At 600FE010 len 00001FD8 (7 KiB): RTCRAM
I (1066) esp_psram: Adding pool of 6450K of PSRAM memory to heap allocator
I (1074) spi_flash: detected chip: gd
I (1078) spi_flash: flash io: qio
W (1082) spi_flash: Detected size(16384k) larger than the size in the binary image header(4096k). Using the size in the binary image header.
W (1096) ADC: legacy driver is deprecated, please migrate to esp_adc/adc_oneshot.h
I (1104) sleep: Configure to isolate all GPIO pins in sleep state
I (1111) sleep: Enable automatic switching of GPIO sleep configuration
I (1118) app_start: Starting scheduler on CPU0
I (1123) app_start: Starting scheduler on CPU1
I (1123) main_task: Started on CPU0
I (1133) esp_psram: Reserving pool of 18K of internal memory for DMA/internal allocations
I (1141) main_task: Calling app_main()
I (1146) VoIP_EXAMPLE: Func:app_main, Line:149, MEM Total:6916436 Bytes, Inter:331675 Bytes, Dram:331675 Bytes, Dram largest free:249856Bytes
I (1167) VoIP_EXAMPLE: [1.0] Initialize peripherals management
I (1167) VoIP_EXAMPLE: [1.1] Initialize and start peripherals
I (1172) AUDIO_THREAD: The button_task task allocate stack on external memory
I (1181) AUDIO_THREAD: The esp_periph task allocate stack on internal memory
I (1188) VoIP_EXAMPLE: [1.2] Create and start input key service
I (1194) AUDIO_THREAD: The input_key_service task allocate stack on external memory
I (1203) VoIP_EXAMPLE: [ 2 ] Initialize av stream
I (1214) DRV8311: ES8311 in Slave mode
I (1226) gpio: GPIO[48]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
W (1231) I2C_BUS: I2C bus has been already created, [port:0]
I (1234) ES7210: ES7210 in Slave mode
I (1245) ES7210: Enable ES7210_INPUT_MIC1
I (1248) ES7210: Enable ES7210_INPUT_MIC2
I (1252) ES7210: Enable ES7210_INPUT_MIC3
W (1255) ES7210: Enable TDM mode. ES7210_SDP_INTERFACE2_REG12: 2
I (1261) ES7210: config fmt 60
I (1263) AUDIO_HAL: Codec mode is 3, Ctrl:1
I (1271) VoIP_EXAMPLE: [ 3 ] Initialize tone player
I (1272) AUDIO_THREAD: The media_task task allocate stack on external memory
I (1278) ESP_AUDIO_TASK: media_ctrl_task running...,0x3c1b68a0
I (1320) ESP_AUDIO_CTRL: Func:media_ctrl_create, Line:355, MEM Total:6885288 Bytes, Inter:309607 Bytes, Dram:309607 Bytes, Dram largest free:233472Bytes
I (1334) MP3_DECODER: MP3 init
W (1338) I2S_STREAM_IDF5.x: I2S(2) already startup
I (1343) VoIP_EXAMPLE: [ 4 ] Create Wi-Fi service instance
E (1350) DISPATCHER: exe first list: 0x0
I (1354) DISPATCHER: dispatcher_event_task is running...
I (1360) AUDIO_THREAD: The esp_dispatcher task allocate stack on internal memory
I (1370) AUDIO_THREAD: The wifi_serv task allocate stack on external memory
I (1376) pp: pp rom version: e7ae62f
I (1380) net80211: net80211 rom version: e7ae62f
I (1386) main_task: Returned from app_main()
I (1387) wifi:wifi driver task: 3fcb54d8, prio:23, stack:6656, core=0
I (1398) wifi:wifi firmware version: 3ce09e5
I (1400) wifi:wifi certification version: v7.0
I (1405) wifi:config NVS flash: enabled
I (1408) wifi:config nano formating: disabled
I (1412) wifi:Init data frame dynamic rx buffer num: 128
I (1417) wifi:Init static rx mgmt buffer num: 5
I (1421) wifi:Init management short buffer num: 32
I (1426) wifi:Init static tx buffer num: 9
I (1430) wifi:Init tx cache buffer num: 32
I (1434) wifi:Init static tx FG buffer num: 2
I (1438) wifi:Init static rx buffer size: 1600
I (1442) wifi:Init static rx buffer num: 9
I (1446) wifi:Init dynamic rx buffer num: 128
I (1451) wifi_init: rx ba win: 16
I (1454) wifi_init: tcpip mbox: 64
I (1458) wifi_init: udp mbox: 64
I (1462) wifi_init: tcp mbox: 64
I (1466) wifi_init: tcp tx win: 65535
I (1470) wifi_init: tcp rx win: 65535
I (1474) wifi_init: tcp mss: 1440
I (1478) wifi_init: WiFi/LWIP prefer SPIRAM
I (1484) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13
I (1523) wifi:mode : sta (48:27:e2:fc:5a:c4)
I (1524) wifi:enable tsf
I (1532) WIFI_SERV: Connect to wifi ssid: TOCHTECH, pwd: Smarturns2017
I (2383) wifi:new:<8,2>, old:<1,0>, ap:<255,255>, sta:<8,2>, prof:1
I (2756) wifi:state: init -> auth (b0)
I (2760) wifi:state: auth -> assoc (0)
I (2788) wifi:state: assoc -> run (10)
W (2789) wifi:[ADDBA]rx delba, code:39, delete tid:0
W (2790) wifi:[ADDBA]rx delba, code:39, delete tid:0
I (2960) wifi:connected with TOCHTECH, aid = 29, channel 8, 40D, bssid = 42:ad:00:b5:b3:46
I (2961) wifi:security: WPA2-PSK, phy: bgn, rssi: -28
I (2962) wifi:pm start, type: 1
I (2965) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (2973) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
W (2982) WIFI_SERV: WiFi Event cb, Unhandle event_base:WIFI_EVENT, event_id:4
I (3038) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (3982) esp_netif_handlers: sta ip: 192.168.68.51, mask: 255.255.252.0, gw: 192.168.68.1
I (3983) WIFI_SERV: Got ip:192.168.68.51
W (3985) WIFI_SERV: STATE type:2, pdata:0x0, len:0
I (4004) VoIP_EXAMPLE: PERIPH_WIFI_CONNECTED [104]
I (4004) VoIP_EXAMPLE: [ 5 ] Create SIP Service
I (4004) ESP_RTC_CORE: esp_rtc ver: 1.2.0 compile date: Aug 15 2024-04:10:02
I (4012) SIP: Conecting...
W (4015) SIP: CHANGE STATE FROM 0, TO 1, :func: sip_connect:1840
I (4022) SIP: [1970-01-01/00:00:01]=======WRITE 0598 bytes>>
I (4028) SIP:
I (4159) SIP: [1970-01-01/00:00:01]<<======================
I (4166) SIP: Required authentication
I (4170) SIP: [1970-01-01/00:00:01]=======WRITE 0791 bytes>>
I (4176) SIP:
I (4314) SIP: [1970-01-01/00:00:01]<<======================
I (4320) SIP: Expires = 3600
I (4324) SIP_SERVICE: ESP_RTC_EVENT_REGISTERED
I (4329) ESP_AUDIO_CTRL: Enter play procedure, src:0
I (4334) ESP_AUDIO_CTRL: Play procedure, URL is ok, src:0
I (4341) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:0, Available:5, que:0x3fcaf870
I (4348) ESP_AUDIO_CTRL: Func:_ctrl_play, Line:776, MEM Total:6743216 Bytes, Inter:256943 Bytes, Dram:256943 Bytes, Dram largest free:180224Bytes
I (4363) ESP_AUDIO_TASK: It's a decoder
I (4367) ESP_AUDIO_TASK: 1.CUR IN:[IN_flash],CODEC:[DEC_mp3],RESAMPLE:[8000],OUT:[OUT_iis],rate:0,ch:0,pos:0
I (4377) ESP_AUDIO_TASK: 2.Handles,IN:0x3c1b7b60,CODEC:0x3c1b7cf8,FILTER:0x3c1cd818,OUT:0x3c1b7fb4
I (4387) ESP_AUDIO_TASK: 2.2 Update all pipeline
I (4392) ESP_AUDIO_TASK: 2.3 Linked new pipeline
I (4398) AUDIO_PIPELINE: link el->rb, el:0x3c1b7b60, tag:IN_flash, rb:0x3c1cdc54
I (4406) AUDIO_PIPELINE: link el->rb, el:0x3c1b7cf8, tag:DEC_mp3, rb:0x3c1d049c
I (4414) AUDIO_PIPELINE: link el->rb, el:0x3c1cd818, tag:Audio_forge, rb:0x3c1d24e4
I (4422) ESP_AUDIO_TASK: 3. Previous starting...
I (4427) AUDIO_THREAD: The IN_flash task allocate stack on internal memory
I (4435) AUDIO_THREAD: The DEC_mp3 task allocate stack on external memory
I (4435) TONE_PARTITION: tone partition format 1, total 7
I (4442) MP3_DECODER: MP3 opened
I (4442) ESP_AUDIO_TASK: Blocking play until received AEL_MSG_CMD_REPORT_MUSIC_INFO
I (4452) TONE_STREAM: Tone offset:0001A92C, Tone length:21212, pos:5
I (4468) ESP_AUDIO_TASK: Recv Element[IN_flash-0x3c1b7b60] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4468) CODEC_ELEMENT_HELPER: The element is 0x3c1b7cf8. The reserve data 2 is 0x0.
I (4489) ESP_AUDIO_TASK: Recv Element[DEC_mp3-0x3c1b7cf8] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4499) ESP_AUDIO_TASK: Received muisc info then on play
I (4505) ESP_AUDIO_TASK: On event play, status:UNKNOWN, 0
I (4511) AUDIO_THREAD: The Audio_forge task allocate stack on external memory
I (4519) AUDIO_FORGE: audio_forge opened
I (4519) AUDIO_THREAD: The OUT_iis task allocate stack on external memory
I (4531) ESP_AUDIO_TASK: Recv Element[OUT_iis-0x3c1b7fb4] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4542) ESP_AUDIO_TASK: Recv Element[Audio_forge-0x3c1cd818] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4542) AUDIO_FORGE: audio_forge reopen
I (4553) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_RUNNING, 0, src:0, is_stopping:0
I (4567) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:1033, MEM Total:6634408 Bytes, Inter:250263 Bytes, Dram:250263 Bytes, Dram largest free:176128Bytes
I (4582) ESP_AUDIO_CTRL: Exit play procedure, ret:0
W (4587) SIP: CHANGE STATE FROM 1, TO 2, :func: sip_register:1868
I (4680) ESP_AUDIO_TASK: Received last time: 0 ms
I (4680) ESP_AUDIO_TASK: Recv Element[OUT_iis-0x3c1b7fb4] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_FINISHED
I (31016) VoIP_EXAMPLE: [ * ] Volume set to 85 %
I (31796) VoIP_EXAMPLE: [ * ] Volume set to 95 %
I (32196) VoIP_EXAMPLE: [ * ] Volume set to 100 %
I (33985) SIP: Sending keep-alive to server
I (36422) SIP: [1970-01-01/00:00:17]<<=====READ 1094 bytes==
I (36423) SIP:
I (36519) SIP: [1970-01-01/00:00:17]<<======================
I (36526) SIP: Remote ARTP port=10028
I (36529) SIP: Remote RTP addr=192.168.68.100
I (36534) SIP: call from 102
I (36538) SIP: [1970-01-01/00:00:17]=======WRITE 0413 bytes>>
I (36544) SIP:
I (36637) SIP: [1970-01-01/00:00:17]=======================>>
W (36644) SIP: CHANGE STATE FROM 2, TO 16, :func: _sip_uas_process_req_invite:1004
I (37662) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (37662) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (37662) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
I (38680) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (38680) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (38680) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
I (39697) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (39697) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (39697) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
I (40714) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (40714) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (40714) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
W (41192) ADC_BTN: Old ID:4, New ID:3, Cnt:0
I (41372) VoIP_EXAMPLE: [ * ] [Play] input key event
I (41372) ESP_AUDIO_CTRL: Enter media_ctrl_stop procedure, src:0, type:0, st:RUNNING, phase:4
I (41375) ESP_AUDIO_CTRL: media_ctrl_stop, type:0, st:RUNNING, block_playing:1, MEDIA_CTRL_PHASE_WAIT_RUNNING
I (41386) ESP_AUDIO_CTRL: media_ctrl_stop, src:0, type:0, st:RUNNING, phase:4
I (41394) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:2, Available:5, que:0x3fcaf870
I (41402) ESP_AUDIO_TASK: MEDIA_CTRL_EVT_STOP, status:RUNNING
W (41408) MP3_DECODER: Output aborted -3
I (41413) MP3_DECODER: Closed
I (41417) AUDIO_FORGE: audio forge closed
I (41421) ESP_AUDIO_TASK: MEDIA_CTRL_EVT_STOP Done, dat:0
I (41427) ESP_AUDIO_TASK: Recv Element[OUT_iis-0x3c1b7fb4] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41438) ESP_AUDIO_TASK: Received last pos: 8828 bytes
I (41444) ESP_AUDIO_TASK: Recv Element[DEC_mp3-0x3c1b7cf8] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41456) ESP_AUDIO_TASK: Recv Element[Audio_forge-0x3c1cd818] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41467) ESP_AUDIO_TASK: Recv Element[IN_flash-0x3c1b7b60] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41479) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_STOPPED, 0, src:0, is_stopping:1
I (41488) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:1033, MEM Total:6683576 Bytes, Inter:250831 Bytes, Dram:250831 Bytes, Dram largest free:176128Bytes
W (41503) ESP_AUDIO_TASK: Destroy the old pipeline, STOPPED
W (41509) ESP_AUDIO_TASK: The old pipeline destroyed, STOPPED
I (41515) ESP_AUDIO_TASK: Release the seeking process due to stopping
I (41522) ESP_AUDIO_CTRL: Exit media_ctrl_stop procedure, ret:0
I (41522) ESP_AUDIO_TASK: Recv Element[IN_flash-0x3c1b7b60] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41630) SIP: [1970-01-01/00:00:20]=======WRITE 0598 bytes>>
I (41630) SIP:
I (41727) SIP: [1970-01-01/00:00:20]<<======================
I (41734) SIP_SERVICE: ESP_RTC_EVENT_AUDIO_SESSION_BEGIN
I (41740) AUDIO_PIPELINE: link el->rb, el:0x3c1d49a8, tag:algo, rb:0x3c1d5308
I (41747) AUDIO_THREAD: The algo task allocate stack on external memory
I (41755) AUDIO_PIPELINE: Func:audio_pipeline_run, Line:359, MEM Total:6697328 Bytes, Inter:253051 Bytes, Dram:253051 Bytes, Dram largest free:176128Bytes
I (41769) AFE_VC: afe interface for voice communication
I (41775) AFE_VC: AFE version: VC_V220727
I (41780) AFE_VC: Initial auido front-end, total channel: 2, mic num: 1, ref num: 1
I (41789) AFE_VC: aec_init: 1, se_init: 1, vad_init: 0
I (41795) AFE_VC: wakenet_init: 0, voice_communication_agc_init: 0
I (41802) AFE_VC: ns_mode: 0
I (41815) AUDIO_PIPELINE: Pipeline started
I (41815) AUDIO_THREAD: The _audio_enc task allocate stack on external memory
I (41818) AV_STREAM: audio_enc started
I (41823) AUDIO_THREAD: The _audio_dec task allocate stack on external memory
I (41825) AFE_VC: mode: 0, (Aug 2 2024 18:12:09)
I (41836) AUDIO_THREAD: The algo_fetch task allocate stack on external memory
I (41844) AV_STREAM: _audio_enc task stoped
I (41849) AV_STREAM: audio_dec started
W (41853) SIP: CHANGE STATE FROM 16, TO 32, :func: sip_uas_process_req:1079
I (41872) ALGORITHM_STREAM: _algo_fetch_task is stopped
I (48301) SIP: [1970-01-01/00:00:23]<<=====READ 0387 bytes==
I (48301) SIP:
I (48334) SIP: [1970-01-01/00:00:23]<<======================
I (48341) SIP_SERVICE: ESP_RTC_EVENT_AUDIO_SESSION_END
W (48346) AUDIO_PIPELINE: There are no listener registered
I (48352) AUDIO_PIPELINE: audio_pipeline_unlinked
I (48359) AFE_VC: afe_se_task quit
I (48362) AFE_VC: afe task destroy finished
I (48370) AFE_VC: exit function: afe_destory
I (48372) AV_STREAM: _audio_dec task stoped
I (48377) SIP_SERVICE: ESP_RTC_EVENT_HANGUP
W (48382) SIP: CHANGE STATE FROM 32, TO 2, :func: sip_uas_process_req:1043
I (48389) SIP: [1970-01-01/00:00:23]=======WRITE 0405 bytes>>
I (48396) SIP:
I (48435) SIP: [1970-01-01/00:00:23]=======================>>
I (64400) SIP: Sending keep-alive to server
Other Items If Possible
sdkconfig file (Attach the sdkconfig file from your project folder)
elf file in the build folder (Note this may contain all the code details and symbols of your project.)
coredump (This provides stacks of tasks.)
The text was updated successfully, but these errors were encountered:
github-actionsbot
changed the title
ESP32-S3-Korvo-2 V3.0 when running VOIP example uses wrong contact, and the microphones do not pick up any audio
ESP32-S3-Korvo-2 V3.0 when running VOIP example uses wrong contact, and the microphones do not pick up any audio (AUD-5682)
Sep 9, 2024
Nathanael29
changed the title
ESP32-S3-Korvo-2 V3.0 when running VOIP example uses wrong contact, and the microphones do not pick up any audio (AUD-5682)
ESP32-S3-Korvo-2 V3.0 microphones do not pick up any audio and speaker is mute when running VOIP example (AUD-5682)
Sep 9, 2024
Environment
git describe --tags
in $IDF_PATH folder to find it):// v5.1.4
git describe --tags
in $ADF_PATH folder to find it):// master
Problem Description
Running the VOIP example on the ESP32-S3-Korvo-2 V3.0, the speakers are muted and the microphone does not pick up any audio.
SIP Server is miniSIPserver on Raspberry Pi: https://www.myvoipapp.com/
Debug Logs
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x8 (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce3818,len:0x18e4
load:0x403c9700,len:0x4
load:0x403c9704,len:0xda4
load:0x403cc700,len:0x308c
entry 0x403c9934
I (27) boot: ESP-IDF v5.1.4-dirty 2nd stage bootloader
I (27) boot: compile time Sep 4 2024 16:14:48
I (27) boot: Multicore bootloader
I (30) boot: chip revision: v0.2
I (34) qio_mode: Enabling default flash chip QIO
I (39) boot.esp32s3: Boot SPI Speed : 80MHz
I (44) boot.esp32s3: SPI Mode : QIO
I (49) boot.esp32s3: SPI Flash Size : 4MB
I (54) boot: Enabling RNG early entropy source...
I (59) boot: Partition Table:
I (63) boot: ## Label Usage Type ST Offset Length
I (70) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (77) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (85) boot: 2 factory factory app 00 00 00010000 00200000
I (92) boot: 3 flash_tone Unknown data 01 ff 00210000 0007d000
I (100) boot: End of partition table
I (104) esp_image: segment 0: paddr=00010020 vaddr=3c150020 size=51c04h (334852) map
I (163) esp_image: segment 1: paddr=00061c2c vaddr=3fc97500 size=08e7ch ( 36476) load
I (170) esp_image: segment 2: paddr=0006aab0 vaddr=40374000 size=05568h ( 21864) load
I (175) esp_image: segment 3: paddr=00070020 vaddr=42000020 size=148ae8h (1346280) map
I (382) esp_image: segment 4: paddr=001b8b10 vaddr=40379568 size=0dec0h ( 57024) load
I (402) boot: Loaded app from partition at offset 0x10000
I (402) boot: Disabling RNG early entropy source...
I (414) cpu_start: Multicore app
I (414) octal_psram: vendor id : 0x0d (AP)
I (414) octal_psram: dev id : 0x02 (generation 3)
I (417) octal_psram: density : 0x03 (64 Mbit)
I (423) octal_psram: good-die : 0x01 (Pass)
I (428) octal_psram: Latency : 0x01 (Fixed)
I (433) octal_psram: VCC : 0x01 (3V)
I (438) octal_psram: SRF : 0x01 (Fast Refresh)
I (444) octal_psram: BurstType : 0x01 (Hybrid Wrap)
I (450) octal_psram: BurstLen : 0x01 (32 Byte)
I (456) octal_psram: Readlatency : 0x02 (10 cycles@Fixed)
I (462) octal_psram: DriveStrength: 0x00 (1/1)
I (467) MSPI Timing: PSRAM timing tuning index: 5
I (472) esp_psram: Found 8MB PSRAM device
I (477) esp_psram: Speed: 80MHz
I (586) mmu_psram: Instructions copied and mapped to SPIRAM
I (615) mmu_psram: Read only data copied and mapped to SPIRAM
I (615) cpu_start: Pro cpu up.
I (616) cpu_start: Starting app cpu, entry point is 0x403757cc
0x403757cc: call_start_cpu1 at C:/Espressif/frameworks/esp-idf-v5.1.4/components/esp_system/port/cpu_start.c:159
I (0) cpu_start: App cpu up.
I (977) esp_psram: SPI SRAM memory test OK
I (986) cpu_start: Pro cpu start user code
I (986) cpu_start: cpu freq: 240000000 Hz
I (986) cpu_start: Application information:
I (989) cpu_start: Project name: voip_app
I (994) cpu_start: App version: v2.6-167-ge27cd526-dirty
I (1001) cpu_start: Compile time: Sep 9 2024 13:44:56
I (1007) cpu_start: ELF file SHA256: b3e74ffbe637d599...
I (1013) cpu_start: ESP-IDF: v5.1.4-dirty
I (1019) cpu_start: Min chip rev: v0.0
I (1023) cpu_start: Max chip rev: v0.99
I (1028) cpu_start: Chip rev: v0.2
I (1033) heap_init: Initializing. RAM available for dynamic allocation:
I (1040) heap_init: At 3FCA1C60 len 00047AB0 (286 KiB): DRAM
I (1047) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DRAM
I (1054) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
I (1060) heap_init: At 600FE010 len 00001FD8 (7 KiB): RTCRAM
I (1066) esp_psram: Adding pool of 6450K of PSRAM memory to heap allocator
I (1074) spi_flash: detected chip: gd
I (1078) spi_flash: flash io: qio
W (1082) spi_flash: Detected size(16384k) larger than the size in the binary image header(4096k). Using the size in the binary image header.
W (1096) ADC: legacy driver is deprecated, please migrate to
esp_adc/adc_oneshot.h
I (1104) sleep: Configure to isolate all GPIO pins in sleep state
I (1111) sleep: Enable automatic switching of GPIO sleep configuration
I (1118) app_start: Starting scheduler on CPU0
I (1123) app_start: Starting scheduler on CPU1
I (1123) main_task: Started on CPU0
I (1133) esp_psram: Reserving pool of 18K of internal memory for DMA/internal allocations
I (1141) main_task: Calling app_main()
I (1146) VoIP_EXAMPLE: Func:app_main, Line:149, MEM Total:6916436 Bytes, Inter:331675 Bytes, Dram:331675 Bytes, Dram largest free:249856Bytes
I (1167) VoIP_EXAMPLE: [1.0] Initialize peripherals management
I (1167) VoIP_EXAMPLE: [1.1] Initialize and start peripherals
I (1172) AUDIO_THREAD: The button_task task allocate stack on external memory
I (1181) AUDIO_THREAD: The esp_periph task allocate stack on internal memory
I (1188) VoIP_EXAMPLE: [1.2] Create and start input key service
I (1194) AUDIO_THREAD: The input_key_service task allocate stack on external memory
I (1203) VoIP_EXAMPLE: [ 2 ] Initialize av stream
I (1214) DRV8311: ES8311 in Slave mode
I (1226) gpio: GPIO[48]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
W (1231) I2C_BUS: I2C bus has been already created, [port:0]
I (1234) ES7210: ES7210 in Slave mode
I (1245) ES7210: Enable ES7210_INPUT_MIC1
I (1248) ES7210: Enable ES7210_INPUT_MIC2
I (1252) ES7210: Enable ES7210_INPUT_MIC3
W (1255) ES7210: Enable TDM mode. ES7210_SDP_INTERFACE2_REG12: 2
I (1261) ES7210: config fmt 60
I (1263) AUDIO_HAL: Codec mode is 3, Ctrl:1
I (1271) VoIP_EXAMPLE: [ 3 ] Initialize tone player
I (1272) AUDIO_THREAD: The media_task task allocate stack on external memory
I (1278) ESP_AUDIO_TASK: media_ctrl_task running...,0x3c1b68a0
----------------------------- ESP Audio Platform -----------------------------
| |
| ESP_AUDIO-v1.8.0-017893b-9815982 |
| Compile date: Aug 15 2024-04:10:00 |
I (1320) ESP_AUDIO_CTRL: Func:media_ctrl_create, Line:355, MEM Total:6885288 Bytes, Inter:309607 Bytes, Dram:309607 Bytes, Dram largest free:233472Bytes
I (1334) MP3_DECODER: MP3 init
W (1338) I2S_STREAM_IDF5.x: I2S(2) already startup
I (1343) VoIP_EXAMPLE: [ 4 ] Create Wi-Fi service instance
E (1350) DISPATCHER: exe first list: 0x0
I (1354) DISPATCHER: dispatcher_event_task is running...
I (1360) AUDIO_THREAD: The esp_dispatcher task allocate stack on internal memory
I (1370) AUDIO_THREAD: The wifi_serv task allocate stack on external memory
I (1376) pp: pp rom version: e7ae62f
I (1380) net80211: net80211 rom version: e7ae62f
I (1386) main_task: Returned from app_main()
I (1387) wifi:wifi driver task: 3fcb54d8, prio:23, stack:6656, core=0
I (1398) wifi:wifi firmware version: 3ce09e5
I (1400) wifi:wifi certification version: v7.0
I (1405) wifi:config NVS flash: enabled
I (1408) wifi:config nano formating: disabled
I (1412) wifi:Init data frame dynamic rx buffer num: 128
I (1417) wifi:Init static rx mgmt buffer num: 5
I (1421) wifi:Init management short buffer num: 32
I (1426) wifi:Init static tx buffer num: 9
I (1430) wifi:Init tx cache buffer num: 32
I (1434) wifi:Init static tx FG buffer num: 2
I (1438) wifi:Init static rx buffer size: 1600
I (1442) wifi:Init static rx buffer num: 9
I (1446) wifi:Init dynamic rx buffer num: 128
I (1451) wifi_init: rx ba win: 16
I (1454) wifi_init: tcpip mbox: 64
I (1458) wifi_init: udp mbox: 64
I (1462) wifi_init: tcp mbox: 64
I (1466) wifi_init: tcp tx win: 65535
I (1470) wifi_init: tcp rx win: 65535
I (1474) wifi_init: tcp mss: 1440
I (1478) wifi_init: WiFi/LWIP prefer SPIRAM
I (1484) phy_init: phy_version 670,b7bc9b9,Apr 30 2024,10:54:13
I (1523) wifi:mode : sta (48:27:e2:fc:5a:c4)
I (1524) wifi:enable tsf
I (1532) WIFI_SERV: Connect to wifi ssid: TOCHTECH, pwd: Smarturns2017
I (2383) wifi:new:<8,2>, old:<1,0>, ap:<255,255>, sta:<8,2>, prof:1
I (2756) wifi:state: init -> auth (b0)
I (2760) wifi:state: auth -> assoc (0)
I (2788) wifi:state: assoc -> run (10)
W (2789) wifi:[ADDBA]rx delba, code:39, delete tid:0
W (2790) wifi:[ADDBA]rx delba, code:39, delete tid:0
I (2960) wifi:connected with TOCHTECH, aid = 29, channel 8, 40D, bssid = 42:ad:00:b5:b3:46
I (2961) wifi:security: WPA2-PSK, phy: bgn, rssi: -28
I (2962) wifi:pm start, type: 1
I (2965) wifi:dp: 1, bi: 102400, li: 3, scale listen interval from 307200 us to 307200 us
I (2973) wifi:set rx beacon pti, rx_bcn_pti: 0, bcn_timeout: 25000, mt_pti: 0, mt_time: 10000
W (2982) WIFI_SERV: WiFi Event cb, Unhandle event_base:WIFI_EVENT, event_id:4
I (3038) wifi:AP's beacon interval = 102400 us, DTIM period = 1
I (3982) esp_netif_handlers: sta ip: 192.168.68.51, mask: 255.255.252.0, gw: 192.168.68.1
I (3983) WIFI_SERV: Got ip:192.168.68.51
W (3985) WIFI_SERV: STATE type:2, pdata:0x0, len:0
I (4004) VoIP_EXAMPLE: PERIPH_WIFI_CONNECTED [104]
I (4004) VoIP_EXAMPLE: [ 5 ] Create SIP Service
I (4004) ESP_RTC_CORE: esp_rtc ver: 1.2.0 compile date: Aug 15 2024-04:10:02
I (4012) SIP: Conecting...
W (4015) SIP: CHANGE STATE FROM 0, TO 1, :func: sip_connect:1840
I (4022) SIP: [1970-01-01/00:00:01]=======WRITE 0598 bytes>>
I (4028) SIP:
REGISTER sip:192.168.68.100:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.68.51:12859;branch=z9hG4bK--1903072797;rport
From: sip:[email protected]:5060;tag=-1001104020
To: sip:[email protected]:5060
Contact: sip:[email protected]:12859;transport=UDP
Max-Forwards: 70
Call-ID: 9AFFA7E1599BE6C314414F950D018616AB1953AE20AD
CSeq: 1 REGISTER
Expires: 3600
User-Agent: ESP32 SIP/2.0
Content-Length: 0
Allow: INVITE, ACK, CANCEL, BYE, UPDATE, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
Allow-Events: presence, kpml
I (4084) SIP: [1970-01-01/00:00:01]=======================>>
I (4015) ESP_RTC_CORE: esp_rtc_service_init done
I (4101) wifi:idx:0 (ifx:0, 42:ad:00:b5:b3:46), tid:0, ssn:59, winSize:64
I (4107) SIP: [1970-01-01/00:00:01]<<=====READ 0535 bytes==
I (4109) SIP:
SIP/2.0 401 Unauthorized
Via: SIP/2.0/UDP 192.168.68.51:12859;branch=z9hG4bK--1903072797;received=192.168.68.51;rport=12859
From: sip:[email protected]:5060;tag=-1001104020
To: sip:[email protected]:5060;tag=28e4aa0770731e41
CSeq: 1 REGISTER
Call-ID: 9AFFA7E1599BE6C314414F950D018616AB1953AE20AD
Allow: ACK,BYE,CANCEL,INFO,INVITE,MESSAGE,NOTIFY,OPTIONS,PRACK,REFER,REGISTER,SUBSCRIBE
WWW-Authenticate: Digest realm="myvoipapp.com", nonce="6A2027CC48A4460364B22827080FCD25", algorithm=MD5, stale=true
Content-Length: 0
I (4159) SIP: [1970-01-01/00:00:01]<<======================
I (4166) SIP: Required authentication
I (4170) SIP: [1970-01-01/00:00:01]=======WRITE 0791 bytes>>
I (4176) SIP:
REGISTER sip:192.168.68.100:5060 SIP/2.0
Via: SIP/2.0/UDP 192.168.68.51:12859;branch=z9hG4bK--1141329944;rport
From: sip:[email protected]:5060;tag=1115977176
To: sip:[email protected]:5060
Contact: sip:[email protected]:12859;transport=UDP
Max-Forwards: 70
Call-ID: 9AFFA7E1599BE6C314414F950D018616AB1953AE20AD
CSeq: 2 REGISTER
Expires: 3600
User-Agent: ESP32 SIP/2.0
Content-Length: 0
Allow: INVITE, ACK, CANCEL, BYE, UPDATE, REFER, MESSAGE, OPTIONS, INFO, SUBSCRIBE
Supported: replaces, norefersub, extended-refer, timer, X-cisco-serviceuri
Allow-Events: presence, kpml
Authorization: Digest username="100", realm="myvoipapp.com", nonce="6A2027CC48A4460364B22827080FCD25", uri="sip:192.168.68.100:5060", response="24ceef44bd2b37a85d953273f57b859c", algorithm=MD5
I (4249) SIP: [1970-01-01/00:00:01]=======================>>
I (4268) SIP: [1970-01-01/00:00:01]<<=====READ 0535 bytes==
I (4268) SIP:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.68.51:12859;branch=z9hG4bK--1141329944;received=192.168.68.51;rport=12859
From: sip:[email protected]:5060;tag=1115977176
To: sip:[email protected]:5060;tag=533d6d943cf508c0
CSeq: 2 REGISTER
Call-ID: 9AFFA7E1599BE6C314414F950D018616AB1953AE20AD
Allow: ACK,BYE,CANCEL,INFO,INVITE,MESSAGE,NOTIFY,OPTIONS,PRACK,REFER,REGISTER,SUBSCRIBE
Contact: "100"sip:[email protected]:12859;transport=UDP
Server: miniSIPServer V50 (5 clients) build 20240520
Expires: 3600
Content-Length: 0
I (4314) SIP: [1970-01-01/00:00:01]<<======================
I (4320) SIP: Expires = 3600
I (4324) SIP_SERVICE: ESP_RTC_EVENT_REGISTERED
I (4329) ESP_AUDIO_CTRL: Enter play procedure, src:0
I (4334) ESP_AUDIO_CTRL: Play procedure, URL is ok, src:0
I (4341) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:0, Available:5, que:0x3fcaf870
I (4348) ESP_AUDIO_CTRL: Func:_ctrl_play, Line:776, MEM Total:6743216 Bytes, Inter:256943 Bytes, Dram:256943 Bytes, Dram largest free:180224Bytes
I (4363) ESP_AUDIO_TASK: It's a decoder
I (4367) ESP_AUDIO_TASK: 1.CUR IN:[IN_flash],CODEC:[DEC_mp3],RESAMPLE:[8000],OUT:[OUT_iis],rate:0,ch:0,pos:0
I (4377) ESP_AUDIO_TASK: 2.Handles,IN:0x3c1b7b60,CODEC:0x3c1b7cf8,FILTER:0x3c1cd818,OUT:0x3c1b7fb4
I (4387) ESP_AUDIO_TASK: 2.2 Update all pipeline
I (4392) ESP_AUDIO_TASK: 2.3 Linked new pipeline
I (4398) AUDIO_PIPELINE: link el->rb, el:0x3c1b7b60, tag:IN_flash, rb:0x3c1cdc54
I (4406) AUDIO_PIPELINE: link el->rb, el:0x3c1b7cf8, tag:DEC_mp3, rb:0x3c1d049c
I (4414) AUDIO_PIPELINE: link el->rb, el:0x3c1cd818, tag:Audio_forge, rb:0x3c1d24e4
I (4422) ESP_AUDIO_TASK: 3. Previous starting...
I (4427) AUDIO_THREAD: The IN_flash task allocate stack on internal memory
I (4435) AUDIO_THREAD: The DEC_mp3 task allocate stack on external memory
I (4435) TONE_PARTITION: tone partition format 1, total 7
I (4442) MP3_DECODER: MP3 opened
I (4442) ESP_AUDIO_TASK: Blocking play until received AEL_MSG_CMD_REPORT_MUSIC_INFO
I (4452) TONE_STREAM: Tone offset:0001A92C, Tone length:21212, pos:5
I (4468) ESP_AUDIO_TASK: Recv Element[IN_flash-0x3c1b7b60] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4468) CODEC_ELEMENT_HELPER: The element is 0x3c1b7cf8. The reserve data 2 is 0x0.
I (4489) ESP_AUDIO_TASK: Recv Element[DEC_mp3-0x3c1b7cf8] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4499) ESP_AUDIO_TASK: Received muisc info then on play
I (4505) ESP_AUDIO_TASK: On event play, status:UNKNOWN, 0
I (4511) AUDIO_THREAD: The Audio_forge task allocate stack on external memory
I (4519) AUDIO_FORGE: audio_forge opened
I (4519) AUDIO_THREAD: The OUT_iis task allocate stack on external memory
I (4531) ESP_AUDIO_TASK: Recv Element[OUT_iis-0x3c1b7fb4] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4542) ESP_AUDIO_TASK: Recv Element[Audio_forge-0x3c1cd818] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_RUNNING
I (4542) AUDIO_FORGE: audio_forge reopen
I (4553) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_RUNNING, 0, src:0, is_stopping:0
I (4567) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:1033, MEM Total:6634408 Bytes, Inter:250263 Bytes, Dram:250263 Bytes, Dram largest free:176128Bytes
I (4582) ESP_AUDIO_CTRL: Exit play procedure, ret:0
W (4587) SIP: CHANGE STATE FROM 1, TO 2, :func: sip_register:1868
I (4680) ESP_AUDIO_TASK: Received last time: 0 ms
I (4680) ESP_AUDIO_TASK: Recv Element[OUT_iis-0x3c1b7fb4] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_FINISHED
I (31016) VoIP_EXAMPLE: [ * ] Volume set to 85 %
I (31796) VoIP_EXAMPLE: [ * ] Volume set to 95 %
I (32196) VoIP_EXAMPLE: [ * ] Volume set to 100 %
I (33985) SIP: Sending keep-alive to server
I (36422) SIP: [1970-01-01/00:00:17]<<=====READ 1094 bytes==
I (36423) SIP:
INVITE sip:[email protected];transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH3ed8eb2564d6b245;rport
Contact: sip:[email protected]
Call-ID: 28328de9-2e8693bb-20240725-022323
To: sip:[email protected]
From: sip:[email protected];tag=32617c7e4687ff99
P-Asserted-Identity: sip:[email protected]
Max-Forwards: 70
Allow: ACK,BYE,CANCEL,INFO,INVITE,MESSAGE,NOTIFY,OPTIONS,PRACK,REFER,REGISTER,SUBSCRIBE
User-Agent: miniSIPServer V50 (5 clients) build 20240520
Supported: 100rel
CSeq: 1721899404 INVITE
Content-Type: application/sdp
Content-Length: 496
v=0
o=- 1721899403 1721899403 IN IP4 192.168.68.100
s=mss
c=IN IP4 192.168.68.100
t=0 0
a=record:off
a=rtcp-xr:rcvr-rtt=all:10000 stat-summary=loss,dup,jitt,TTL voip-metrics
m=audio 10028 RTP/AVP 96 97 98 0 8 18 101 99 100
a=rtpmap:96 opus/48000/2
a=fmtp:96 useinbandfec=1
a=rtpmap:97 speex/16000
a=fmtp:97 vbr=on
a=rtpmap:98 speex/8000
a=fmtp:98 vbr=on
a=fmtp:18 annexb=yes
a=rtpmap:101 telephone-event/48000
a=rtpmap:99 telephone-event/16000
a=rtpmap:100 telephone-event/8000
I (36519) SIP: [1970-01-01/00:00:17]<<======================
I (36526) SIP: Remote ARTP port=10028
I (36529) SIP: Remote RTP addr=192.168.68.100
I (36534) SIP: call from 102
I (36538) SIP: [1970-01-01/00:00:17]=======WRITE 0413 bytes>>
I (36544) SIP:
SIP/2.0 100 Trying
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH3ed8eb2564d6b245;rport
Contact: sip:[email protected]:12859;transport=UDP
From: sip:[email protected];tag=32617c7e4687ff99
To: sip:[email protected];tag=874727774
Call-ID: 28328de9-2e8693bb-20240725-022323
CSeq: 1721899404 INVITE
Server: ESP32 SIP/2.0
Allow: ACK, INVITE, BYE, UPDATE, CANCEL, OPTIONS, INFO
Content-Length: 0
I (36584) SIP: [1970-01-01/00:00:17]=======================>>
I (36592) SIP: [1970-01-01/00:00:17]=======WRITE 0415 bytes>>
I (36597) SIP:
SIP/2.0 180 Ringing
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH3ed8eb2564d6b245;rport
Contact: sip:[email protected]:12859;transport=UDP
From: sip:[email protected];tag=32617c7e4687ff99
To: sip:[email protected];tag=-911276498
Call-ID: 28328de9-2e8693bb-20240725-022323
CSeq: 1721899404 INVITE
Server: ESP32 SIP/2.0
Allow: ACK, INVITE, BYE, UPDATE, CANCEL, OPTIONS, INFO
Content-Length: 0
I (36637) SIP: [1970-01-01/00:00:17]=======================>>
W (36644) SIP: CHANGE STATE FROM 2, TO 16, :func: _sip_uas_process_req_invite:1004
I (37662) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (37662) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (37662) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
I (38680) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (38680) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (38680) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
I (39697) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (39697) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (39697) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
I (40714) SIP_SERVICE: ESP_RTC_EVENT_INCOMING...
I (40714) ESP_AUDIO_CTRL: Enter play procedure, src:0
W (40714) ESP_AUDIO_CTRL: Pipeline is already running. Please stop it first.
W (41192) ADC_BTN: Old ID:4, New ID:3, Cnt:0
I (41372) VoIP_EXAMPLE: [ * ] [Play] input key event
I (41372) ESP_AUDIO_CTRL: Enter media_ctrl_stop procedure, src:0, type:0, st:RUNNING, phase:4
I (41375) ESP_AUDIO_CTRL: media_ctrl_stop, type:0, st:RUNNING, block_playing:1, MEDIA_CTRL_PHASE_WAIT_RUNNING
I (41386) ESP_AUDIO_CTRL: media_ctrl_stop, src:0, type:0, st:RUNNING, phase:4
I (41394) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:2, Available:5, que:0x3fcaf870
I (41402) ESP_AUDIO_TASK: MEDIA_CTRL_EVT_STOP, status:RUNNING
W (41408) MP3_DECODER: Output aborted -3
I (41413) MP3_DECODER: Closed
I (41417) AUDIO_FORGE: audio forge closed
I (41421) ESP_AUDIO_TASK: MEDIA_CTRL_EVT_STOP Done, dat:0
I (41427) ESP_AUDIO_TASK: Recv Element[OUT_iis-0x3c1b7fb4] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41438) ESP_AUDIO_TASK: Received last pos: 8828 bytes
I (41444) ESP_AUDIO_TASK: Recv Element[DEC_mp3-0x3c1b7cf8] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41456) ESP_AUDIO_TASK: Recv Element[Audio_forge-0x3c1cd818] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41467) ESP_AUDIO_TASK: Recv Element[IN_flash-0x3c1b7b60] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41479) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_STOPPED, 0, src:0, is_stopping:1
I (41488) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:1033, MEM Total:6683576 Bytes, Inter:250831 Bytes, Dram:250831 Bytes, Dram largest free:176128Bytes
W (41503) ESP_AUDIO_TASK: Destroy the old pipeline, STOPPED
W (41509) ESP_AUDIO_TASK: The old pipeline destroyed, STOPPED
I (41515) ESP_AUDIO_TASK: Release the seeking process due to stopping
I (41522) ESP_AUDIO_CTRL: Exit media_ctrl_stop procedure, ret:0
I (41522) ESP_AUDIO_TASK: Recv Element[IN_flash-0x3c1b7b60] MSG,type:20000,cmd:8,len:4,status:AEL_STATUS_STATE_STOPPED
I (41630) SIP: [1970-01-01/00:00:20]=======WRITE 0598 bytes>>
I (41630) SIP:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH3ed8eb2564d6b245;rport
Contact: sip:[email protected]:12859;transport=UDP
From: sip:[email protected];tag=32617c7e4687ff99
To: sip:[email protected];tag=-8436600
Call-ID: 28328de9-2e8693bb-20240725-022323
CSeq: 1721899404 INVITE
Server: ESP32 SIP/2.0
Allow: ACK, INVITE, BYE, UPDATE, CANCEL, OPTIONS, INFO
Content-Length: 157
Content-Type: application/sdp
v=0
o=Z 0 3 IN IP4 192.168.68.51
s=Z
t=0 0
c=IN IP4 192.168.68.51
m=audio 31946 RTP/AVP 8 101
a=rtpmap:8 PCMA/8000
a=rtpmap:101 telephone-event/8000
I (41682) SIP: [1970-01-01/00:00:20]=======================>>
I (41694) SIP: [1970-01-01/00:00:20]<<=====READ 0329 bytes==
I (41695) SIP:
ACK sip:[email protected]:12859;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH1806d5df04d7ae88;rport
To: sip:[email protected];tag=-8436600
From: sip:[email protected];tag=32617c7e4687ff99
Call-ID: 28328de9-2e8693bb-20240725-022323
CSeq: 1721899404 ACK
Max-Forwards: 70
Content-Length: 0
I (41727) SIP: [1970-01-01/00:00:20]<<======================
I (41734) SIP_SERVICE: ESP_RTC_EVENT_AUDIO_SESSION_BEGIN
I (41740) AUDIO_PIPELINE: link el->rb, el:0x3c1d49a8, tag:algo, rb:0x3c1d5308
I (41747) AUDIO_THREAD: The algo task allocate stack on external memory
I (41755) AUDIO_PIPELINE: Func:audio_pipeline_run, Line:359, MEM Total:6697328 Bytes, Inter:253051 Bytes, Dram:253051 Bytes, Dram largest free:176128Bytes
I (41769) AFE_VC: afe interface for voice communication
I (41775) AFE_VC: AFE version: VC_V220727
I (41780) AFE_VC: Initial auido front-end, total channel: 2, mic num: 1, ref num: 1
I (41789) AFE_VC: aec_init: 1, se_init: 1, vad_init: 0
I (41795) AFE_VC: wakenet_init: 0, voice_communication_agc_init: 0
I (41802) AFE_VC: ns_mode: 0
I (41815) AUDIO_PIPELINE: Pipeline started
I (41815) AUDIO_THREAD: The _audio_enc task allocate stack on external memory
I (41818) AV_STREAM: audio_enc started
I (41823) AUDIO_THREAD: The _audio_dec task allocate stack on external memory
I (41825) AFE_VC: mode: 0, (Aug 2 2024 18:12:09)
I (41836) AUDIO_THREAD: The algo_fetch task allocate stack on external memory
I (41844) AV_STREAM: _audio_enc task stoped
I (41849) AV_STREAM: audio_dec started
W (41853) SIP: CHANGE STATE FROM 16, TO 32, :func: sip_uas_process_req:1079
I (41872) ALGORITHM_STREAM: _algo_fetch_task is stopped
I (48301) SIP: [1970-01-01/00:00:23]<<=====READ 0387 bytes==
I (48301) SIP:
BYE sip:[email protected]:12859;transport=UDP SIP/2.0
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH744e5839151a12c8;rport
From: sip:[email protected];tag=32617c7e4687ff99
To: sip:[email protected];tag=-8436600
Call-ID: 28328de9-2e8693bb-20240725-022323
User-Agent: miniSIPServer V50 (5 clients) build 20240520
CSeq: 1721899405 BYE
Max-Forwards: 70
Content-Length: 0
I (48334) SIP: [1970-01-01/00:00:23]<<======================
I (48341) SIP_SERVICE: ESP_RTC_EVENT_AUDIO_SESSION_END
W (48346) AUDIO_PIPELINE: There are no listener registered
I (48352) AUDIO_PIPELINE: audio_pipeline_unlinked
I (48359) AFE_VC: afe_se_task quit
I (48362) AFE_VC: afe task destroy finished
I (48370) AFE_VC: exit function: afe_destory
I (48372) AV_STREAM: _audio_dec task stoped
I (48377) SIP_SERVICE: ESP_RTC_EVENT_HANGUP
W (48382) SIP: CHANGE STATE FROM 32, TO 2, :func: sip_uas_process_req:1043
I (48389) SIP: [1970-01-01/00:00:23]=======WRITE 0405 bytes>>
I (48396) SIP:
SIP/2.0 200 OK
Via: SIP/2.0/UDP 192.168.68.100;branch=z9hG4bKYXH744e5839151a12c8;rport
Contact: sip:[email protected]:12859;transport=UDP
From: sip:[email protected];tag=32617c7e4687ff99
To: sip:[email protected];tag=-8436600
Call-ID: 28328de9-2e8693bb-20240725-022323
CSeq: 1721899405 BYE
Server: ESP32 SIP/2.0
Allow: ACK, INVITE, BYE, UPDATE, CANCEL, OPTIONS, INFO
Content-Length: 0
I (48435) SIP: [1970-01-01/00:00:23]=======================>>
I (64400) SIP: Sending keep-alive to server
Other Items If Possible
build
folder (Note this may contain all the code details and symbols of your project.)The text was updated successfully, but these errors were encountered: