ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

bulazhang
Posts: 16
Joined: Wed Mar 25, 2020 2:31 pm

ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby bulazhang » Fri Jun 05, 2020 3:04 pm

近期在进行一些代码工程从ADF 1.5迁移到2.0环境,感觉task相关的处理似乎有了一些问题,好像有一些task被挂起了。

今天,一天都在研究与DuerOS例程,但DingDing.wav都不出声了。

Code: Select all

I (16093) AUDIO_WRAPPER: duer_dcs_get_speaker_state
E (16099) DUEROS: event: DUER_EVENT_STARTED
I (15992,tid:3ffc3f60) lightduer_connagent.c( 212):add resource successfully!!
I (15993,tid:3ffc3f60) lightduer_connagent.c( 212):add resource successfully!!
W (15993,tid:3ffc3f60) lightduer_engine.c( 634):data cache has not sent, pending..., dcache_len:1, qcache_len:4
I (16105) DUEROS: Dueros DUER_CMD_CONNECTED, duer_state:2
W (15997,tid:3ffc3f60) W (16106) DUEROS: duer_callback: type:0, source:0x3f807b68 data:3, data_len:0
lightduer_system_info.c( 306):Undefined memory type, 0
E (15999,tid:3ffc3f60) lightduer_system_info.c( 389):Sys Info: Get disk info failed
I (24212) DUEROS: PERIPH_NOTIFY_KEY_REC
I (24212) REC_ENG: Recorder trigger start
I (24230) REC_ENG: WAKEUP timer started
I (24230) DUEROS: rec_engine_cb - REC_EVENT_WAKEUP_START
I (24230) DUEROS: rec_engine_cb - Play tone
I (24231) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:0, Available:5, que:0x3ffca91c
I (24231) ESP_AUDIO_CTRL: Func:_ctrl_play, Line:659, MEM Total:4194524 Bytes, Inter:121872 Bytes, Dram:107280 Bytes

I (24232) ESP_AUDIO_TASK: It's a decoder
I (24233) ESP_AUDIO_TASK: 1.CUR IN:[IN_file],CODEC:[DEC_wav],RESAMPLE:[48000],OUT:[OUT_iis],rate:0, ch:0
I (24235) ESP_AUDIO_TASK: 2.Handles,IN:0x3f806d58,CODEC:0x3f8074ec,FILTER:0x3f818dbc,OUT:0x3f807a78
I (24236) ESP_AUDIO_TASK: 2.2 Update all pipeline
I (24237) ESP_AUDIO_TASK: 2.3 Linked new pipeline
I (24238) AUDIO_PIPELINE: link el->rb, el:0x3f806d58, tag:IN_file, rb:0x3f80f040
I (24239) AUDIO_PIPELINE: link el->rb, el:0x3f8074ec, tag:DEC_wav, rb:0x3f80f07c
I (24240) AUDIO_PIPELINE: link el->rb, el:0x3f818dbc, tag:resample, rb:0x3f80f248
I (24241) ESP_AUDIO_TASK: 3. Previous starting...
I (24243) AUDIO_ELEMENT: [IN_file-0x3f806d58] Element task created
W (24243) AUDIO_ELEMENT: [IN_file] RESUME timeout
I (24243) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:579, MEM Total:4165716 Bytes, Inter:116780 Bytes, Dram:102188 Bytes

I (24245) AUDIO_ELEMENT: [IN_file] AEL_MSG_CMD_RESUME,state:1
I (24251) FATFS_STREAM: File size is 12024 byte,pos:0
I (34230) REC_ENG: Wakeup time is out
用pipeline_http_mp3例程,是可以工作的,很正常地通过http_stream下载了mp3并pipeline到i2s_stream,证明整个ADF框架应该没问题,而DuerOS不出声,通过修改一个task运行在Core 0或Core 1,明显有不同的差别。

从上面的例程来看,AUDIO_ELEMENT task创建后,似乎BLOCK了,不能被resume.
超喜欢嵌入式的70后老猿人

jason.mao
Posts: 96
Joined: Mon Nov 19, 2018 2:05 am

Re: ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby jason.mao » Fri Jun 12, 2020 12:29 pm

Hi bulazhang,

请帮用最新的 master 试一下

bulazhang
Posts: 16
Joined: Wed Mar 25, 2020 2:31 pm

Re: ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby bulazhang » Fri Jun 12, 2020 3:20 pm

更新至commit 20130f4,重新进行了SDKCONFIG

已能正常运行DuerOS,日志如下:

Code: Select all

I (40) boot: ESP-IDF v3.3.1-211-g6f9a7264c-dirty 2nd stage bootloader
I (40) boot: compile time 23:11:17
I (49) boot: Enabling RNG early entropy source...
I (49) boot: SPI Speed      : 80MHz
I (49) boot: SPI Mode       : DIO
I (49) boot: SPI Flash Size : 4MB
I (50) boot: Partition Table:
I (50) boot: ## Label            Usage          Type ST Offset   Length
I (51) boot:  0 nvs              WiFi data        01 02 00009000 00006000
I (52) boot:  1 phy_init         RF data          01 01 0000f000 00001000
I (53) boot:  2 factory          factory app      00 00 00010000 00300000
I (54) boot: End of partition table
I (55) boot_comm: chip revision: 1, min. application chip revision: 0
I (55) esp_image: segment 0: paddr=0x00010020 vaddr=0x3f400020 size=0x76aa8 (486056) map
I (192) esp_image: segment 1: paddr=0x00086ad0 vaddr=0x3ffb0000 size=0x0421c ( 16924) load
I (197) esp_image: segment 2: paddr=0x0008acf4 vaddr=0x40080000 size=0x00400 (  1024) load
I (198) esp_image: segment 3: paddr=0x0008b0fc vaddr=0x40080400 size=0x04f14 ( 20244) load
I (205) esp_image: segment 4: paddr=0x00090018 vaddr=0x400d0018 size=0x136790 (1271696) map
I (559) esp_image: segment 5: paddr=0x001c67b0 vaddr=0x40085314 size=0x17384 ( 95108) load
I (608) boot: Loaded app from partition at offset 0x10000
I (608) boot: Disabling RNG early entropy source...
I (609) psram: This chip is ESP32-D0WD
I (609) spiram: Found 64MBit SPI RAM device
I (609) spiram: SPI RAM mode: flash 80m sram 80m
I (610) spiram: PSRAM initialized, cache is in low/high (2-core) mode.
I (611) cpu_start: Pro cpu up.
I (611) cpu_start: Application information:
I (612) cpu_start: Project name:     esp_dueros
I (613) cpu_start: App version:      v2.0-122-g20130f4-dirty
I (613) cpu_start: Compile time:     Jun 12 2020 23:09:56
I (614) cpu_start: ELF file SHA256:  425f377aca2aaf41...
I (615) cpu_start: ESP-IDF:          v3.3.1-211-g6f9a7264c-dirty
I (616) cpu_start: Starting app cpu, entry point is 0x40081518
I (0) cpu_start: App cpu up.
I (1092) spiram: SPI SRAM memory test OK
I (1092) heap_init: Initializing. RAM available for dynamic allocation:
I (1093) heap_init: At 3FFAE6E0 len 00001920 (6 KiB): DRAM
I (1093) heap_init: At 3FFBB8C0 len 00024740 (145 KiB): DRAM
I (1094) heap_init: At 3FFE0440 len 00003AE0 (14 KiB): D/IRAM
I (1094) heap_init: At 3FFE4350 len 0001BCB0 (111 KiB): D/IRAM
I (1095) heap_init: At 4009C698 len 00003968 (14 KiB): IRAM
I (1096) cpu_start: Pro cpu start user code
I (1097) spiram: Adding pool of 4096K of external SPI memory to heap allocator
I (212) cpu_start: Starting scheduler on PRO CPU.
I (0) cpu_start: Starting scheduler on APP CPU.
I (212) spiram: Reserving pool of 32K of internal memory for DMA/internal allocations
I (241) DUEROS: ADF version is v2.0-122-g20130f4-dirty
I (242) gpio: GPIO[5]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (242) gpio: GPIO[13]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (243) gpio: GPIO[18]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (244) gpio: GPIO[19]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (246) gpio: GPIO[23]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (247) gpio: GPIO[36]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:3
I (258) SDCARD: Trying to mount with base path=/sdcard
I (302) SDCARD: CID name 00000!

I (748) A1S: i2c port configured!!!!
W (1749) AC101: reset succeed
I (1759) AC101: init done
I (1759) gpio: GPIO[21]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
I (1763) AUDIO_THREAD: The media_task task allocate stack on external memory
I (1764) ESP_AUDIO_TASK: media_ctrl_task running...,0x3f806e5c

----------------------------- ESP Audio Platform -----------------------------
|                                                                            |
|                               ESP_AUDIO-v1.6.1                             |
|                     Compile date: Jun  2 2020-20:07:19                     |
------------------------------------------------------------------------------
I (1768) ESP_AUDIO_CTRL: Func:media_ctrl_create, Line:310, MEM Total:4377544 Bytes, Inter:263476 Bytes, Dram:248816 Bytes

I (1770) AUDIO_HAL: Codec mode is 3, Ctrl:1
I (1886) MP3_DECODER: MP3 init
I (1887) I2S: DMA Malloc info, datalen=blocksize=1200, dma_buf_count=3
I (1887) I2S: DMA Malloc info, datalen=blocksize=1200, dma_buf_count=3
I (1889) I2S: APLL: Req RATE: 48000, real rate: 47999.961, BITS: 16, CLKM: 1, BCK_M: 8, MCLK: 12287990.000, SCLK: 1535998.750000, diva: 1, divb: 0
I (1890) A1S: i2s port configured!!!!
I (1893) AUDIO_WRAPPER: Func:setup_player, Line:161, MEM Total:4364428 Bytes, Inter:247288 Bytes, Dram:232628 Bytes

I (1894) AUDIO_WRAPPER: esp_audio instance is:0x3f806e5c
I (1911) wifi: wifi driver task: 3ffd1fd0, prio:23, stack:3584, core=0
I (1911) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (1911) system_api: Base MAC address is not set, read default base MAC address from BLK0 of EFUSE
I (1929) wifi: wifi firmware version: 85618d5
I (1929) wifi: config NVS flash: enabled
I (1929) wifi: config nano formating: disabled
I (1929) wifi: Init dynamic tx buffer num: 32
I (1930) wifi: Init data frame dynamic rx buffer num: 32
I (1930) wifi: Init management frame dynamic rx buffer num: 32
I (1931) wifi: Init management short buffer num: 32
I (1932) wifi: Init static tx buffer num: 16
I (1933) wifi: Init static rx buffer size: 1600
I (1933) wifi: Init static rx buffer num: 16
I (1933) wifi: Init dynamic rx buffer num: 32
I (2036) phy: phy_version: 4180, cb3948e, Sep 12 2019, 16:39:13, 0, 0
I (2037) wifi: mode : sta (b4:e6:2d:fc:59:51)
I (2684,tid:3ffdf820) lightduer_session.c(  44):random = 75933
I (2915) WIFI_SERV: Connect to wifi ssid: BULAM7, pwd: southeast9288216
W (2974) I2S: I2S driver already installed
I (2975) A1S: i2s port configured!!!!
I (2976) AUDIO_PIPELINE: link el->rb, el:0x3f80ab78, tag:i2s, rb:0x3f80af70
I (2976) AUDIO_PIPELINE: link el->rb, el:0x3f80ace0, tag:filter, rb:0x3f80cfb0
I (2977) AUDIO_ELEMENT: [i2s-0x3f80ab78] Element task created
I (2977) AUDIO_THREAD: The filter task allocate stack on external memory
I (2979) AUDIO_ELEMENT: [filter-0x3f80ace0] Element task created
I (2979) AUDIO_ELEMENT: [raw-0x3f80ae08] Element task created
I (2980) AUDIO_PIPELINE: Func:audio_pipeline_run, Line:358, MEM Total:4262568 Bytes, Inter:152472 Bytes, Dram:137812 Bytes

I (2981) AUDIO_ELEMENT: [i2s] AEL_MSG_CMD_RESUME,state:1
I (2982) I2S_STREAM: AUDIO_STREAM_READER,Rate:48000,ch:2
I (2982) AUDIO_ELEMENT: [filter] AEL_MSG_CMD_RESUME,state:1
I (2984) AUDIO_PIPELINE: Pipeline started
I (2984) DUEROS: Recorder has been created
I (2985) I2S: APLL: Req RATE: 48000, real rate: 47999.961, BITS: 16, CLKM: 1, BCK_M: 8, MCLK: 12287990.000, SCLK: 1535998.750000, diva: 1, divb: 0
Quantized wakeNet5: wakeNet5_v1_hilexin_5_0.95_0.90, mode:0 (Mar 30 2020 20:16:38)
I (2988) REC_ENG: ESP SR Engine, chunksize is 480, FRAME_SIZE:960, frequency:16000
E (2989) REC_ENG: Recorder Engine Running ..., vad_window=9, wakeup=10000 ms, vad_off=800 ms, threshold=90 ms, sensitivity=0
I (2990) REC_ENG: state idle
I (2992) RSP_FILTER: sample rate of source data : 48000, channel of source data : 2, sample rate of destination data : 16000, channel of destination data : 1
I (3094) wifi: new:<1,1>, old:<1,0>, ap:<255,255>, sta:<1,1>, prof:1
I (3096) wifi: state: init -> auth (b0)
I (3151) wifi: state: auth -> assoc (0)
I (3176) wifi: state: assoc -> run (10)
I (13177) wifi: state: run -> init (cc00)
I (13178) wifi: new:<1,0>, old:<1,1>, ap:<255,255>, sta:<1,1>, prof:1
I (13180) WIFI_SERV: STA Auth Error, reason:204
W (13180) WIFI_SERV: STATE type:3, pdata:0x0, len:0
W (13180) WIFI_SERV: Disconnect reason 2
I (13182) WIFI_SERV: Connect to wifi ssid: BULAM7, pwd: southeast9288216
I (13304) wifi: new:<1,1>, old:<1,0>, ap:<255,255>, sta:<1,1>, prof:1
I (13305) wifi: state: init -> auth (b0)
I (13338) wifi: state: auth -> assoc (0)
I (13358) wifi: state: assoc -> run (10)
I (13381) wifi: connected with BULAM7, aid = 4, channel 1, 40U, bssid = c0:f4:e6:f9:ce:dc
I (13381) wifi: security type: 3, phy: bgn, rssi: -20
I (13388) wifi: pm start, type: 1

I (13464) wifi: AP's beacon interval = 102400 us, DTIM period = 2
I (14272) event: sta ip: 192.168.43.18, mask: 255.255.255.0, gw: 192.168.43.1
I (14273) WIFI_SERV: Got ip:192.168.43.18
W (14273) WIFI_SERV: STATE type:2, pdata:0x0, len:0
I (14295) DUEROS: PERIPH_WIFI_CONNECTED [215]
E (14301) DUEROS: Recv Que DUER_CMD_LOGIN
I (14302) DUEROS: duer_start, len:1470
{"configures":"{}","bindToken":"36a299df19dc2fe2e90bbfbe10075cb9","coapPort":443,"token":"FNXhMgtfHegfrN1NdWKh6sQCqt7hmKtA","serverAddr":"device.iot.baidu.com","lwm2mPort":443,"uuid":"1ff4000000000f","rsaCaCrt":"-----BEGIN CERTIFICATE-----\nMIIDUDCCAjgCCQCmVPUErMYmCjANBgkqhkiG9w0BAQUFADBqMQswCQYDVQQGEwJD\nTjETMBEGA1UECAwKU29tZS1TdGF0ZTEOMAwGA1UECgwFYmFpZHUxGDAWBgNVBAMM\nDyouaW90LmJhaWR1LmNvbTEcMBoGCSqGSIb3DQEJARYNaW90QGJhaWR1LmNvbTAe\nFw0xNjAzMTEwMzMwNDlaFw0yNjAzMDkwMzMwNDlaMGoxCzAJBgNVBAYTAkNOMRMw\nEQYDVQQIDApTb21lLVN0YXRlMQ4wDAYDVQQKDAViYWlkdTEYMBYGA1UEAwwPKi5p\nb3QuYmFpZHUuY29tMRwwGgYJKoZIhvcNAQkBFg1pb3RAYmFpZHUuY29tMIIBIjAN\nBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAtbhIeiN7pznzuMwsLKQj2xB02+51\nOvCJ5d116ZFLjecp9qtllqOfN7bm+AJa5N2aAHJtsetcTHMitY4dtGmOpw4dlGqx\nluoz50kWJWQjVR+z6DLPnGE4uELOS8vbKHUoYPPQTT80eNVnl9S9h/l7DcjEAJYC\nIYJbf6+K9x+Ti9VRChvWcvgZQHMRym9j1g/7CKGMCIwkC+6ihkGD/XG40r7KRCyH\nbD53KnBjBO9FH4IL3rGlZWKWzMw3zC6RTS2ekfEsgAtYDvROKd4rNs+uDU9xaBLO\ndXTl5uxgudH2VnVzWtj09OUbBtXcQFD2IhmOl20BrckYul+HEIMR0oDibwIDAQAB\nMA0GCSqGSIb3DQEBBQUAA4IBAQCzTTH91jNh/uYBEFekSVNg1h1kPSujlwEDDf/W\npjqPJPqrZvW0w0cmYsYibNDy985JB87MJMfJVESG/v0Y/YbvcnRoi5gAenWXQNL4\nh2hf08A5wEQfLO/EaD1GTH3OIierKYZ6GItGrz4uFKHV5fTMiflABCdu37ALGjrA\nrIjwjxQG6WwLr9468hkKrWNG3dMBHKvmqO8x42sZOFRJMkqBbKzaBd1uW4xY5XwM\nS1QX56tVrgO0A3S+4dEg5uiLVN4YVP/Vqh4SMtYkL7ZZiZAxD9GtNnhRyFsWlC2r\nOVSdXs1ttZxEaEBGUl7tgsBte556BIvufZX+BXGyycVJdBu3\n-----END CERTIFICATE-----\n","macId":"","version":15043}
I (14107,tid:3ffdf820) lightduer_engine.c( 220):duer_engine_start, g_handler:3F809E7C, length:1470, profile:3F810624
W (14319) DUEROS: duer_callback: type:0, source:0x3f8090e0 data:2, data_len:0
I (14109,tid:3ffdf820) lightduer_ca_conf.c(  38):    duer_conf_get_string: uuid = 1ff4000000000f
I (14109,tid:3ffdf820) lightduer_ca_conf.c(  38):    duer_conf_get_string: serverAddr = device.iot.baidu.com
I (14135,tid:3ffdf820) baidu_ca_socket_adp.c( 134):DNS lookup succeeded. IP=220.181.107.198
I (14490,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
W (14490,tid:3ffdf820) lightduer_events.c(  80):[lightduer_ca] <== event end = 400FB148, timespent = 384
I (15619,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
W (15620,tid:3ffdf820) lightduer_events.c(  80):[lightduer_ca] <== event end = 400FB2DC, timespent = 883
I (15622,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15622,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15623,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15624,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15626,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15627,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15627,tid:3ffdf820) lightduer_engine.c( 220):duer_engine_start, g_handler:3F809E7C, length:0, profile:00000000
I (15629,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
W (15904,tid:3ffdf820) lightduer_coap.c( 532):duer_coap_nsdl_tx: sent = 0
I (15905,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15908,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15909,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15910,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (15911,tid:3ffdf820) lightduer_connagent.c( 198):will start latter(DUER_ERR_TRANS_WOULD_BLOCK)
I (16757,tid:3ffdf820) lightduer_connagent.c( 177):connect started!
I (16758,tid:3ffdf820) lightduer_voice.c( 697):Mutex initializing
I (16758,tid:3ffdf820) lightduer_ds_log_cache.c(  67):no cache report
E (16970) DUEROS: event: 0
I (16971) DUEROS: duer_dcs_init
I (16761,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.private.protocol
I (16761,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.device_interface.screen_extended_card
I (16764,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.device_interface.system
I (16765,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.device_interface.voice_input
I (16765,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.device_interface.voice_output
I (16766,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.device_interface.speaker_controller
I (16767,tid:3ffdf820) lightduer_dcs_router.c( 283):namespace: ai.dueros.device_interface.audio_player
I (16981) AUDIO_WRAPPER: duer_dcs_get_speaker_state
E (16986) DUEROS: event: DUER_EVENT_STARTED
I (16986) DUEROS: Dueros DUER_CMD_CONNECTED, duer_state:2
W (16986) DUEROS: duer_callback: type:0, source:0x3f8090e0 data:3, data_len:0
I (16775,tid:3ffdf820) lightduer_connagent.c( 212):add resource successfully!!
I (16777,tid:3ffdf820) lightduer_connagent.c( 212):add resource successfully!!
W (16777,tid:3ffdf820) lightduer_engine.c( 634):data cache has not sent, pending..., dcache_len:1, qcache_len:4
W (16780,tid:3ffdf820) lightduer_system_info.c( 306):Undefined memory type, 0
E (16782,tid:3ffdf820) lightduer_system_info.c( 389):Sys Info: Get disk info failed
I (25785) DUEROS: PERIPH_NOTIFY_KEY_REC
I (25785) REC_ENG: Recorder trigger start
I (25812) REC_ENG: WAKEUP timer started
I (25813) DUEROS: rec_engine_cb - REC_EVENT_WAKEUP_START
I (25813) DUEROS: rec_engine_cb - Play tone
I (25813) ESP_AUDIO_CTRL: Enter play procedure, src:0
I (25814) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:0, Available:5, que:0x3ffca7d8
I (25815) ESP_AUDIO_CTRL: Func:_ctrl_play, Line:700, MEM Total:4190168 Bytes, Inter:124984 Bytes, Dram:110324 Bytes

I (25815) ESP_AUDIO_TASK: It's a decoder
I (25817) ESP_AUDIO_TASK: 1.CUR IN:[IN_file],CODEC:[DEC_wav],RESAMPLE:[48000],OUT:[OUT_iis],rate:0, ch:0
I (25819) ESP_AUDIO_TASK: 2.Handles,IN:0x3f80805c,CODEC:0x3f808924,FILTER:0x3f81afac,OUT:0x3f808fb0
I (25819) ESP_AUDIO_TASK: 2.2 Update all pipeline
I (25820) ESP_AUDIO_TASK: 2.3 Linked new pipeline
I (25821) AUDIO_PIPELINE: link el->rb, el:0x3f80805c, tag:IN_file, rb:0x3f810ab8
I (25822) AUDIO_PIPELINE: link el->rb, el:0x3f808924, tag:DEC_wav, rb:0x3f81a58c
I (25823) AUDIO_PIPELINE: link el->rb, el:0x3f81afac, tag:resample, rb:0x3f81a5b4
I (25824) ESP_AUDIO_TASK: 3. Previous starting...
I (25826) AUDIO_ELEMENT: [IN_file-0x3f80805c] Element task created
I (25826) AUDIO_ELEMENT: [IN_file] AEL_MSG_CMD_RESUME,state:1
I (25827) AUDIO_THREAD: The DEC_wav task allocate stack on external memory
I (25828) AUDIO_ELEMENT: [DEC_wav-0x3f808924] Element task created
I (25828) AUDIO_ELEMENT: [DEC_wav] AEL_MSG_CMD_RESUME,state:1
I (25833) FATFS_STREAM: File size is 12024 byte,pos:0
I (25837) RSP_FILTER: reset sample rate of source data : 16000, reset channel of source data : 1
I (25838) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:1, Available:5, que:0x3ffca7d8
I (25839) ESP_AUDIO_TASK: Received muisc info then send MEDIA_CTRL_EVT_PLAY
I (25840) ESP_AUDIO_TASK: MEDIA_CTRL_EVT_PLAY, status:UNKNOWN, 0
I (25841) AUDIO_THREAD: The resample task allocate stack on external memory
I (25842) AUDIO_ELEMENT: [resample-0x3f81afac] Element task created
I (25842) AUDIO_ELEMENT: [resample] AEL_MSG_CMD_RESUME,state:1
I (25843) AUDIO_ELEMENT: [OUT_iis-0x3f808fb0] Element task created
I (25844) AUDIO_ELEMENT: [OUT_iis] AEL_MSG_CMD_RESUME,state:1
I (25845) I2S_STREAM: AUDIO_STREAM_WRITER
I (25845) ESP_AUDIO_CTRL: Exit play procedure, ret:0
I (25846) ESP_AUDIO_CTRL: Sync play waiting ...
I (25847) RSP_FILTER: sample rate of source data : 16000, channel of source data : 1, sample rate of destination data : 48000, channel of destination data : 2
I (25849) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_RUNNING
I (25850) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:800, MEM Total:4140888 Bytes, Inter:114040 Bytes, Dram:99380 Bytes

W (25869) FATFS_STREAM: No more data,ret:0
I (25869) AUDIO_ELEMENT: IN-[IN_file] AEL_IO_DONE,0
I (25875) AUDIO_ELEMENT: IN-[DEC_wav] AEL_IO_DONE,-2
I (25905) DEC_WAV: Closed
I (25906) ESP_AUDIO_TASK: Received last pos: 11874 bytes
I (26168) AUDIO_ELEMENT: IN-[resample] AEL_IO_DONE,-2
I (26224) AUDIO_ELEMENT: IN-[OUT_iis] AEL_IO_DONE,-2
I (26261) ESP_AUDIO_TASK: Received last time: 384 ms
I (26261) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_FINISHED
I (26262) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:800, MEM Total:4146044 Bytes, Inter:115132 Bytes, Dram:100472 Bytes

W (26263) ESP_AUDIO_TASK: Destroy the old pipeline
W (26264) AUDIO_ELEMENT: [IN_file] Element already stopped
W (26265) AUDIO_ELEMENT: [DEC_wav] Element already stopped
W (26265) AUDIO_ELEMENT: [OUT_iis] Element already stopped
W (26266) AUDIO_ELEMENT: [resample] Element already stopped
I (26268) AUDIO_PIPELINE: audio_pipeline_unlinked
W (26268) AUDIO_PIPELINE: There are no listener registered
I (26274) DUEROS: rec_engine_cb - REC_EVENT_VAD_START
I (26275) DUEROS: Recv Que DUER_CMD_START
I (26279) AUDIO_WRAPPER: duer_dcs_get_speaker_state
I (26069,tid:3ffce6f8) lightduer_dcs_local.c( 188):Current dialog id: 1ff4000000000f40b18ccf000065d400000004
W (26285) DUEROS: duer_callback: type:0, source:0x3f8090e0 data:4, data_len:0
I (29662,tid:3ffdf820) lightduer_dcs_router.c( 407):Directive name: StopListen
I (29874) AUDIO_WRAPPER: stop_listen, close mic
I (29875) REC_ENG: Recorder trigger stop
I (29896) DUEROS: rec_engine_cb - REC_EVENT_VAD_STOP, state:4
W (29896) REC_ENG: state VAD_END, wakeup_time_out REC_STATE_VAD_END
W (29897) REC_ENG: State WAKEUP_END
I (29897) DUEROS: rec_engine_cb - REC_EVENT_WAKEUP_END
I (29898) REC_ENG: state idle
I (29729,tid:3ffdf820) lightduer_dcs_router.c( 407):Directive name: Speak
I (29944) AUDIO_WRAPPER: Playing speak: http://res.iot.baidu.com:80/api/v1/tts/Fo5Bli2kxSKpzNzqDRsUac6vsC9JEeQdnLUau8g7i18OxCle7Oh5cZa6BmCzdmD5rNIzk6cJF-KBSXTdG1ggBLzFnRJgIFI2TkMmWO2wsuQ.mp3
I (29945) ESP_AUDIO_CTRL: Enter play procedure, src:0
I (29947) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:0, Available:5, que:0x3ffca7d8
I (29947) ESP_AUDIO_TASK: It's a decoder
I (29948) ESP_AUDIO_TASK: 1.CUR IN:[IN_http],CODEC:[DEC_mp3],RESAMPLE:[48000],OUT:[OUT_iis],rate:0, ch:0
I (29949) ESP_AUDIO_TASK: 2.Handles,IN:0x3f80861c,CODEC:0x3f808aac,FILTER:0x3f81afac,OUT:0x3f808fb0
W (29951) AUDIO_PIPELINE: Without stop, st:1
W (29951) AUDIO_PIPELINE: Without wait stop, st:1
I (29951) ESP_AUDIO_TASK: 2.2 Update all pipeline
I (29952) ESP_AUDIO_TASK: 2.3 Linked new pipeline
I (29953) AUDIO_PIPELINE: link el->rb, el:0x3f80861c, tag:IN_http, rb:0x3f81b1e0
I (29954) AUDIO_PIPELINE: link el->rb, el:0x3f808aac, tag:DEC_mp3, rb:0x3f81c498
I (29955) AUDIO_PIPELINE: link el->rb, el:0x3f81afac, tag:resample, rb:0x3f81c4c0
I (29957) ESP_AUDIO_TASK: 3. Previous starting...
I (29957) AUDIO_THREAD: The IN_http task allocate stack on external memory
I (29959) ESP_AUDIO_CTRL: Func:_ctrl_play, Line:700, MEM Total:4132284 Bytes, Inter:122876 Bytes, Dram:108216 Bytes

I (29959) AUDIO_ELEMENT: [IN_http-0x3f80861c] Element task created
I (29960) AUDIO_ELEMENT: [IN_http] AEL_MSG_CMD_RESUME,state:1
I (29961) AUDIO_THREAD: The DEC_mp3 task allocate stack on external memory
I (29963) AUDIO_ELEMENT: [DEC_mp3-0x3f808aac] Element task created
I (29964) AUDIO_ELEMENT: [DEC_mp3] AEL_MSG_CMD_RESUME,state:1
I (29964) MP3_DECODER: MP3 opened
I (29972) DUEROS: Dueros DUER_CMD_STOP
W (29975) DUEROS: duer_callback: type:0, source:0x3f8090e0 data:5, data_len:0
I (29975) DUEROS: Dueros DUER_CMD_STOP
W (29976) DUEROS: duer_callback: type:0, source:0x3f8090e0 data:5, data_len:0
I (30118) HTTP_STREAM: total_bytes=0
I (30131) ESP_AUDIO_CTRL: Request_CMD_Queue CMD:1, Available:5, que:0x3ffca7d8
I (30132) ESP_AUDIO_TASK: Received muisc info then send MEDIA_CTRL_EVT_PLAY
I (30133) ESP_AUDIO_TASK: MEDIA_CTRL_EVT_PLAY, status:UNKNOWN, 0
I (30133) AUDIO_THREAD: The resample task allocate stack on external memory
I (30135) AUDIO_ELEMENT: [resample-0x3f81afac] Element task created
I (30136) AUDIO_ELEMENT: [resample] AEL_MSG_CMD_RESUME,state:1
I (30136) AUDIO_ELEMENT: [OUT_iis-0x3f808fb0] Element task created
I (30137) AUDIO_ELEMENT: [OUT_iis] AEL_MSG_CMD_RESUME,state:1
I (30138) I2S_STREAM: AUDIO_STREAM_WRITER
I (30149) RSP_FILTER: sample rate of source data : 16000, channel of source data : 1, sample rate of destination data : 48000, channel of destination data : 2
I (30151) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_RUNNING
I (30152) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:800, MEM Total:4082564 Bytes, Inter:111860 Bytes, Dram:97200 Bytes

I (30154) ESP_AUDIO_CTRL: Exit play procedure, ret:0
W (29945,tid:3ffdf820) lightduer_events.c(  80):[lightduer_ca] <== event end = 400F3B70, timespent = 213
I (29979,tid:3ffdf820) lightduer_dcs_router.c( 407):Directive name: RenderVoiceInputText
E (29979,tid:3ffdf820) lightduer_dcs_router.c( 433):unrecognized directive: RenderVoiceInputText, namespace: ai.dueros.device_interface.screen

I (30194) AUDIO_WRAPPER: duer_dcs_get_speaker_state
W (30208) HTTP_STREAM: No more data,errno:0, total_bytes:7922, rlen = 0
I (30208) AUDIO_ELEMENT: IN-[IN_http] AEL_IO_DONE,0
I (30210) AUDIO_WRAPPER: esp_auido status:1,err:0,state:1
W (29999,tid:3ffdf820) lightduer_events.c(  80):[lightduer_ca] <== event end = 400FB2DC, timespent = 53
I (32702) AUDIO_ELEMENT: IN-[DEC_mp3] AEL_IO_DONE,-2
I (33787) MP3_DECODER: Closed
I (33787) ESP_AUDIO_TASK: Received last pos: 7920 bytes
I (34055) AUDIO_ELEMENT: IN-[resample] AEL_IO_DONE,-2
I (34111) AUDIO_ELEMENT: IN-[OUT_iis] AEL_IO_DONE,-2
I (34150) ESP_AUDIO_TASK: Received last time: 3978 ms
I (34150) ESP_AUDIO_TASK: ESP_AUDIO status is AEL_STATUS_STATE_FINISHED
I (34150) ESP_AUDIO_TASK: Func:media_ctrl_task, Line:800, MEM Total:4136588 Bytes, Inter:117960 Bytes, Dram:103300 Bytes

W (34152) ESP_AUDIO_TASK: Destroy the old pipeline
W (34153) AUDIO_ELEMENT: [IN_http] Element already stopped
W (34153) AUDIO_ELEMENT: [DEC_mp3] Element already stopped
W (34154) AUDIO_ELEMENT: [OUT_iis] Element already stopped
W (34155) AUDIO_ELEMENT: [resample] Element already stopped
I (34163) AUDIO_PIPELINE: audio_pipeline_unlinked
W (34163) AUDIO_PIPELINE: There are no listener registered
I (34164) AUDIO_WRAPPER: esp_auido status:4,err:0,state:1
I (33953,tid:3ffdf820) lightduer_dcs_router.c( 407):Directive name: DialogueFinished
E (34167) AUDIO_WRAPPER: duer_dcs_speech_on_finished,0, wakeup:0
超喜欢嵌入式的70后老猿人

bulazhang
Posts: 16
Joined: Wed Mar 25, 2020 2:31 pm

Re: ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby bulazhang » Fri Jun 12, 2020 3:23 pm

AUDIO_THREAD: The DEC_mp3 task allocate stack on external memory

看来,涉及到SPI RAM的问题解决了
超喜欢嵌入式的70后老猿人

liuyongliuyong
Posts: 12
Joined: Tue May 26, 2020 5:01 am

Re: ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby liuyongliuyong » Mon Jun 15, 2020 7:49 am

请问大神,“更新至commit 20130f4,重新进行了SDKCONFIG”什么命令更新至commit 20130f4呢?我现在也遇到了和你一样的问题,一点声音都没有。

bulazhang
Posts: 16
Joined: Wed Mar 25, 2020 2:31 pm

Re: ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby bulazhang » Mon Jun 15, 2020 12:31 pm

liuyongliuyong wrote:
Mon Jun 15, 2020 7:49 am
请问大神,“更新至commit 20130f4,重新进行了SDKCONFIG”什么命令更新至commit 20130f4呢?我现在也遇到了和你一样的问题,一点声音都没有。
git命令啊
超喜欢嵌入式的70后老猿人

ESP_William
Posts: 103
Joined: Tue Apr 24, 2018 5:54 am

Re: ADF 2.0 DuerOS例程,连DingDing.wav都不播放了

Postby ESP_William » Wed Jul 15, 2020 11:25 am

建议可以尝试新推出来的 Krovo-DU1906 方案,后台支持 DuHome , 模组中集成了端云一体操作,详情见:

https://www.espressif.com/zh-hans/produ ... rvo-du1906

Who is online

Users browsing this forum: No registered users and 6 guests