USB was properly connected. RSSI was able to connect properly. When USB sets esp_modem to data mode, there is a problem.
ESP_IDF Version: 5.0.2
Code: Select all
I (25) boot: ESP-IDF v5.0.2-dirty 2nd stage bootloader
I (25) boot: compile time 17:18:37
I (25) boot: chip revision: v0.0
I (27) boot.esp32s3: Boot SPI Speed : 80MHz
I (32) boot.esp32s3: SPI Mode : DIO
I (37) boot.esp32s3: SPI Flash Size : 2MB
I (41) boot: Enabling RNG early entropy source...
I (47) boot: Partition Table:
I (50) boot: ## Label Usage Type ST Offset Length
I (58) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (65) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (73) boot: 2 factory factory app 00 00 00010000 00100000
I (80) boot: End of partition table
I (84) esp_image: segment 0: paddr=00010020 vaddr=3c080020 size=2fbd4h (195540) map
I (128) esp_image: segment 1: paddr=0003fbfc vaddr=3fc92a00 size=0041ch ( 1052) load
I (128) esp_image: segment 2: paddr=00040020 vaddr=42000020 size=7aa98h (502424) map
I (224) esp_image: segment 3: paddr=000baac0 vaddr=3fc92e1c size=02324h ( 8996) load
I (226) esp_image: segment 4: paddr=000bcdec vaddr=40374000 size=0e99ch ( 59804) load
I (248) boot: Loaded app from partition at offset 0x10000
I (249) boot: Disabling RNG early entropy source...
D (260) flash HPM: HPM with dummy, status is 3
I (260) cpu_start: Pro cpu up.
I (260) cpu_start: Starting app cpu, entry point is 0x40375398
0x40375398: call_start_cpu1 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_system/port/cpu_start.c:141
) efcpe:_startU E_pp cp_ up.A_0mG
V CAsHE 2ERit: illegal wrror0initr clr D e2a ) sku i::In0x3fS
_BCKACHEATE4_RE core 1 ac8 ss erroar intr clr & na mask
is:27x1fefuse: In EFUSE_BLK1__DATA4_REG is used 7 bits starting with 20 bit
D (285) efuse: In EFUSE_BLK1__DATA5_REG is used 8 bits starting with 3 bit
D (292) efuse: In EFUSE_BLK1__DATA5_REG is used 5 bits starting with 11 bit
D (299) efuse: In EFUSE_BLK1__DATA4_REG is used 7 bits starting with 13 bit
D (306) efuse: In EFUSE_BLK1__DATA4_REG is used 7 bits starting with 20 bit
D (313) efuse: In EFUSE_BLK1__DATA4_REG is used 5 bits starting with 27 bit
D (320) efuse: In EFUSE_BLK1__DATA5_REG is used 3 bits starting with 0 bit
D (327) efuse: In EFUSE_BLK1__DATA5_REG is used 8 bits starting with 3 bit
D (334) efuse: In EFUSE_BLK1__DATA4_REG is used 7 bits starting with 13 bit
D (341) efuse: In EFUSE_BLK1__DATA4_REG is used 7 bits starting with 20 bit
D (348) efuse: In EFUSE_BLK1__DATA4_REG is used 5 bits starting with 27 bit
D (355) efuse: In EFUSE_BLK1__DATA5_REG is used 3 bits starting with 0 bit
D (362) efuse: In EFUSE_BLK1__DATA5_REG is used 8 bits starting with 3 bit
D (377) clk: RTC_SLOW_CLK calibration value: 3799578
V CACHE_ERR: illegal error intr clr & ena mask is: 0x3f
V CACHE_ERR: core 0 access error intr clr & ena mask is: 0x1f
I (386) cpu_start: Pro cpu start user code
I (389) cpu_start: cpu freq: 160000000 Hz
I (394) cpu_start: Application information:
I (399) cpu_start: Project name: pppos_client
I (404) cpu_start: App version: modem-v1.0.1-dirty
I (410) cpu_start: Compile time: Jun 23 2023 17:19:02
I (416) cpu_start: ELF file SHA256: 39da953c5781f2e3...
I (422) cpu_start: ESP-IDF: v5.0.2-dirty
I (428) cpu_start: Min chip rev: v0.0
I (432) cpu_start: Max chip rev: v0.99
I (437) cpu_start: Chip rev: v0.0
V (442) memory_layout: reserved range is 0x3c0afbc4 - 0x3c0afbe4
D (448) memory_layout: Checking 5 reserved memory ranges:
D (453) memory_layout: Reserved memory range 0x3fc84000 - 0x3fc92a00
D (460) memory_layout: Reserved memory range 0x3fc92a00 - 0x3fc96cb8
D (466) memory_layout: Reserved memory range 0x3fceee34 - 0x3fcf0000
D (473) memory_layout: Reserved memory range 0x40374000 - 0x40382a00
0x40374000: _WindowOverflow4 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:1743
D (479) memory_layout: Reserved memory range 0x600fe000 - 0x600fe010
D (486) memory_layout: Building list of available memory regions:
V (492) memory_layout: Examining memory region 0x40374000 - 0x40378000
0x40374000: _WindowOverflow4 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:1743
0x40378000: mmu_ll_read_entry at C:/Espressif/frameworks/esp-idf-v5.0.2/components/hal/esp32s3/include/hal/mmu_ll.h:160
(inlined by) spi_flash_protected_read_mmu_entry at C:/Espressif/frameworks/esp-idf-v5.0.2/components/spi_flash/flash_mmap.c:324
V (498) memory_layout: Region 0x40374000 - 0x40378000 inside of reserved 0x40374000 - 0x40382a00
0x40374000: _WindowOverflow4 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:1743
0x40378000: mmu_ll_read_entry at C:/Espressif/frameworks/esp-idf-v5.0.2/components/hal/esp32s3/include/hal/mmu_ll.h:160
(inlined by) spi_flash_protected_read_mmu_entry at C:/Espressif/frameworks/esp-idf-v5.0.2/components/spi_flash/flash_mmap.c:324
0x40374000: _WindowOverflow4 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:1743
V (507) memory_layout: Examining memory region 0x3fc88000 - 0x3fc90000
V (514) memory_layout: Region 0x3fc88000 - 0x3fc90000 inside of reserved 0x3fc84000 - 0x3fc92a00
V (523) memory_layout: Examining memory region 0x3fc90000 - 0x3fca0000
V (529) memory_layout: Start of region 0x3fc90000 - 0x3fca0000 overlaps reserved 0x3fc84000 - 0x3fc92a00
V (539) memory_layout: Start of region 0x3fc92a00 - 0x3fca0000 overlaps reserved 0x3fc92a00 - 0x3fc96cb8
D (548) memory_layout: Available memory region 0x3fc96cb8 - 0x3fca0000
V (555) memory_layout: Examining memory region 0x3fca0000 - 0x3fcb0000
D (562) memory_layout: Available memory region 0x3fca0000 - 0x3fcb0000
V (568) memory_layout: Examining memory region 0x3fcb0000 - 0x3fcc0000
D (575) memory_layout: Available memory region 0x3fcb0000 - 0x3fcc0000
V (581) memory_layout: Examining memory region 0x3fcc0000 - 0x3fcd0000
D (588) memory_layout: Available memory region 0x3fcc0000 - 0x3fcd0000
V (594) memory_layout: Examining memory region 0x3fcd0000 - 0x3fce0000
D (601) memory_layout: Available memory region 0x3fcd0000 - 0x3fce0000
V (608) memory_layout: Examining memory region 0x3fce0000 - 0x3fce9710
D (614) memory_layout: Available memory region 0x3fce0000 - 0x3fce9710
V (621) memory_layout: Examining memory region 0x3fce9710 - 0x3fcf0000
V (627) memory_layout: End of region 0x3fce9710 - 0x3fcf0000 overlaps reserved 0x3fceee34 - 0x3fcf0000
D (637) memory_layout: Available memory region 0x3fce9710 - 0x3fceee34
V (643) memory_layout: Examining memory region 0x3fcf0000 - 0x3fcf8000
D (650) memory_layout: Available memory region 0x3fcf0000 - 0x3fcf8000
V (657) memory_layout: Examining memory region 0x600fe000 - 0x60100000
V (663) memory_layout: Start of region 0x600fe000 - 0x60100000 overlaps reserved 0x600fe000 - 0x600fe010
D (673) memory_layout: Available memory region 0x600fe010 - 0x60100000
I (679) heap_init: Initializing. RAM available for dynamic allocation:
D (687) heap_init: New heap initialised at 0x3fc96cb8
I (692) heap_init: At 3FC96CB8 len 00052A58 (330 KiB): DRAM
I (698) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DRAM
D (705) heap_init: New heap initialised at 0x3fcf0000
I (710) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
D (716) heap_init: New heap initialised at 0x600fe010
I (721) heap_init: At 600FE010 len 00001FF0 (7 KiB): RTCRAM
V (727) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (734) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x40E
D (742) intr_alloc: Connected src 39 to int 2 (cpu 0)
V (747) memspi: raw_chip_id: 174020
V (751) memspi: chip_id: 204017
V (754) memspi: raw_chip_id: 174020
V (758) memspi: chip_id: 204017
D (761) spi_flash: trying chip: issi
D (765) spi_flash: trying chip: gd
D (768) spi_flash: trying chip: mxic
D (772) spi_flash: trying chip: winbond
D (776) spi_flash: trying chip: boya
D (780) spi_flash: trying chip: th
D (783) spi_flash: trying chip: mxic (opi)
D (787) spi_flash: trying chip: generic
I (791) spi_flash: detected chip: generic
I (796) spi_flash: flash io: dio
W (800) spi_flash: Detected size(8192k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
D (813) cpu_start: calling init function: 0x420666dc
0x420666dc: _GLOBAL__sub_I___cxa_get_globals_fast at eh_globals.cc:?
D (818) cpu_start: calling init function: 0x42066530
0x42066530: _GLOBAL__sub_I__ZN9__gnu_cxx9__freeresEv at eh_alloc.cc:?
D (823) cpu_start: calling init function: 0x4203b4d0
0x4203b4d0: esp_ds_conn_lock at C:/Espressif/frameworks/esp-idf-v5.0.2/components/mbedtls/port/esp_ds/esp_rsa_sign_alt.c:47
D (828) cpu_start: calling init function: 0x42022fa8
0x42022fa8: esp_ipc_init at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_system/esp_ipc.c:115
D (833) cpu_start: calling init function: 0x42003ffc0x42003ffc: esp_reset_reason_init at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_system/port/soc/esp32s3/reset_reason.c:67
D (838) cpu_start: calling init function: 0x42002f80
0x42002f80: esp_init_app_elf_sha256 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_app_format/esp_app_desc.c:69
D (843) cpu_start: calling init function: 0x42008504 on core: 0
0x42008504: __esp_system_init_fn_esp_timer_startup_init at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_timer/src/esp_timer.c:509
V (849) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (855) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xC02
D (863) intr_alloc: Connected src 59 to int 3 (cpu 0)
D (869) cpu_start: calling init function: 0x42003ccc on core: 0
0x42003ccc: __esp_system_init_fn_init_components0 at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_system/startup.c:484
V (875) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (881) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x40E
D (889) intr_alloc: Connected src 79 to int 9 (cpu 0)
I (894) cpu_start: Starting scheduler on PRO CPU.
V (900) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (900) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x402
D (900) intr_alloc: Connected src 57 to int 12 (cpu 0)
V (900) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args
V (910) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0x40E
D (910) intr_alloc: Connected src 80 to int 2 (cpu 1)
I (920) cpu_start: Starting scheduler on APP CPU.
V (920) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args
V (930) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0x402
D (940) intr_alloc: Connected src 58 to int 3 (cpu 1)
D (940) heap_init: New heap initialised at 0x3fce9710
V (950) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (960) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE
D (960) intr_alloc: Connected src 52 to int 13 (cpu 0)
I (970) pppos_example: [APP] Free memory: 379768 bytes
I (980) gpio: GPIO[12]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
I (980) gpio: GPIO[13]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
D (4990) esp_netif_lwip: LwIP stack has been initialized
D (4990) esp_netif_lwip: check: remote, if=0x0 fn=0x420250fc
0x420250fc: alloc_client_data_id at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_netif/lwip/esp_netif_lwip.c:137
D (4990) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (4990) esp_netif_lwip: esp-netif has been successfully initialized
D (5000) event: running task for loop 0x3fc9d2f0
D (5000) event: created task for loop 0x3fc9d2f0
D (5010) event: created event loop 0x3fc9d2f0
D (5010) esp_netif_objects: esp_netif_add_to_list 0x3fc9e294
D (5020) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 1)
ppp phase changed[1]: phase=0
D (5030) esp-netif_lwip-ppp: esp_netif_new_ppp: PPP connection created: 0x3fc9e5ac
D (5040) esp-netif_lwip-ppp: Phase Dead
D (5040) esp_netif_lwip: check: remote, if=0x0 fn=0x4202510c
0x4202510c: set_lwip_netif_callback at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_netif/lwip/esp_netif_lwip.c:145
D (5050) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (5050) pppos_example: Initializing esp_modem for the A7670 module...
I (10060) pppos_example: Waiting for USB device connection...
V (10110) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (10110) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x802
D (10110) intr_alloc: Connected src 38 to int 17 (cpu 0)
D (10140) usb_terminal: USB Host installed
D (10140) cdc_acm: Checking list of opened USB devices
D (10140) cdc_acm: Checking list of connected USB devices
D (10190) cdc_acm: Checking list of connected USB devices
D (10240) cdc_acm: Checking list of connected USB devices
D (10290) cdc_acm: Checking list of connected USB devices
D (10340) cdc_acm: Checking list of connected USB devices
D (10390) cdc_acm: Checking list of connected USB devices
D (10440) cdc_acm: Checking list of connected USB devices
D (10490) cdc_acm: Checking list of connected USB devices
D (10540) cdc_acm: Checking list of connected USB devices
D (10590) cdc_acm: Checking list of connected USB devices
D (10640) cdc_acm: Checking list of connected USB devices
D (10690) cdc_acm: Checking list of connected USB devices
D (10740) cdc_acm: Checking list of connected USB devices
D (10790) cdc_acm: Checking list of connected USB devices
D (10840) cdc_acm: Checking list of connected USB devices
D (10890) cdc_acm: Checking list of connected USB devices
D (10940) cdc_acm: Checking list of connected USB devices
D (10990) cdc_acm: Checking list of connected USB devices
D (11040) cdc_acm: Checking list of connected USB devices
D (11090) cdc_acm: Checking list of connected USB devices
D (11140) cdc_acm: Checking list of connected USB devices
D (11190) cdc_acm: Checking list of connected USB devices
D (11240) cdc_acm: Checking list of connected USB devices
D (11290) cdc_acm: Checking list of connected USB devices
D (11340) cdc_acm: Checking list of connected USB devices
D (11390) cdc_acm: Checking list of connected USB devices
D (11440) HUB: Root port reset
D (11440) HUB: Stage done: START
D (11440) HUB: Stage done: GET_SHORT_DEV_DESC
D (11440) HUB: Stage done: CHECK_SHORT_DEV_DESC
D (11440) cdc_acm: Checking list of connected USB devices
D (11500) HUB: Stage done: SECOND_RESET
D (11500) HUB: Stage done: SET_ADDR
D (11500) HUB: Stage done: CHECK_ADDR
D (11500) cdc_acm: Checking list of connected USB devices
D (11510) HUB: Stage done: SET_ADDR_RECOVERY
D (11510) HUB: Stage done: GET_FULL_DEV_DESC
D (11510) HUB: Stage done: CHECK_FULL_DEV_DESC
D (11510) HUB: Stage done: GET_SHORT_CONFIG_DESC
D (11520) HUB: Stage done: CHECK_SHORT_CONFIG_DESC
D (11520) HUB: Stage done: GET_FULL_CONFIG_DESC
D (11530) HUB: Stage done: CHECK_FULL_CONFIG_DESC
D (11530) HUB: Stage done: SET_CONFIG
D (11540) HUB: Stage done: CHECK_CONFIG
D (11540) HUB: Stage done: GET_SHORT_LANGID_TABLE
D (11550) HUB: Stage done: CHECK_SHORT_LANGID_TABLE
D (11550) HUB: Stage done: GET_FULL_LANGID_TABLE
D (11550) HUB: Stage done: CHECK_FULL_LANGID_TABLE
D (11560) HUB: Stage done: GET_SHORT_MANU_STR_DESC
D (11560) HUB: Stage done: CHECK_SHORT_MANU_STR_DESC
D (11570) HUB: Stage done: GET_FULL_MANU_STR_DESC
D (11570) HUB: Stage done: CHECK_FULL_MANU_STR_DESC
D (11580) HUB: Stage done: GET_SHORT_PROD_STR_DESC
D (11580) HUB: Stage done: CHECK_SHORT_PROD_STR_DESC
D (11590) HUB: Stage done: GET_FULL_PROD_STR_DESC
D (11590) HUB: Stage done: CHECK_FULL_PROD_STR_DESC
D (11600) HUB: Stage done: GET_SHORT_SER_STR_DESC
D (11600) HUB: Stage done: CHECK_SHORT_SER_STR_DESC
D (11610) HUB: Stage done: GET_FULL_SER_STR_DESC
D (11610) HUB: Stage done: CHECK_FULL_SER_STR_DESC
D (11620) HUB: Stage done: CLEANUP
D (11620) USBH: Processing actions 0x100
D (11630) USBH: New device 1
D (11630) cdc_acm: New device connected
D (11630) cdc_acm: Checking list of connected USB devices
D (11640) CDC_ACM: Submitting poll for BULK IN transfer
D (11640) CDC_ACM: in xfer cb
D (11650) usb_terminal: 0x3fca281c 0d 0a 2a 41 54 52 45 41 44 59 3a 20 31 0d 0a |..*ATREADY: 1..|
D (11660) usb_terminal: Unhandled RX data
D (11660) CDC_ACM: Submitting poll for BULK IN transfer
D (11670) CDC_ACM: Submitting poll for INTR IN transfer
D (11670) cdc_acm: Checking list of opened USB devices
D (11680) CDC_ACM: Submitting poll for BULK IN transfer
D (11680) CDC_ACM: Submitting poll for INTR IN transfer
I (11690) pppos_example: Modem connected, waiting 10 seconds for boot...
D (13300) CDC_ACM: in xfer cb
D (13300) usb_terminal: 0x3fca281c 0d 0a 2b 43 50 49 4e 3a 20 52 45 41 44 59 0d 0a |..+CPIN: READY..|
D (13300) usb_terminal: Unhandled RX data
D (13310) CDC_ACM: Submitting poll for BULK IN transfer
D (14650) CDC_ACM: in xfer cb
D (14650) usb_terminal: 0x3fca281c 0d 0a 53 4d 53 20 44 4f 4e 45 0d 0a |..SMS DONE..|
D (14650) usb_terminal: Unhandled RX data
D (14660) CDC_ACM: Submitting poll for BULK IN transfer
V (21690) command_lib: get_signal_quality
V (21690) command_lib: generic_get_string
D (21690) usb_terminal: 0x3fc9a728 41 54 2b 43 53 51 0d |AT+CSQ.|
D (21690) CDC_ACM: Submitting BULK OUT transfer
D (21700) CDC_ACM: out/ctrl xfer cb
D (21700) CDC_ACM: in xfer cb
D (21700) usb_terminal: 0x3fca281c 41 54 2b 43 53 51 0d |AT+CSQ.|
D (21710) CDC_ACM: Submitting poll for BULK IN transfer
D (21720) CDC_ACM: in xfer cb
D (21720) usb_terminal: 0x3fca2823 0d 0a 2b 43 53 51 3a 20 39 39 2c 39 39 0d 0a |..+CSQ: 99,99..|
} (21730) command_lib: Token: {
V (21730) command_lib: Token: {+CSQ: 99,99}
D (21740) CDC_ACM: Submitting poll for BULK IN transfer
D (21740) CDC_ACM: in xfer cb
D (21750) usb_terminal: 0x3fca2832 0d 0a 4f 4b 0d 0a |..OK..|
} (21750) command_lib: Token: {
V (21760) command_lib: Token: {OK}
D (21760) CDC_ACM: Submitting poll for BULK IN transfer
W (21770) pppos_example: Signal quality: rssi=19, ber=99
V (21770) command_lib: set_echo
V (21780) command_lib: generic_command_common
V (21780) command_lib: generic_command
D (21780) command_lib: generic_command command ATE0
D (21790) usb_terminal: 0x3fc9a698 41 54 45 30 0d |ATE0.|
D (21800) CDC_ACM: Submitting BULK OUT transfer
D (21800) CDC_ACM: out/ctrl xfer cb
D (21810) CDC_ACM: in xfer cb
D (21810) usb_terminal: 0x3fca281c 41 54 45 30 0d |ATE0.|
D (21820) CDC_ACM: Submitting poll for BULK IN transfer
D (21820) CDC_ACM: in xfer cb
D (21830) usb_terminal: 0x3fca2821 0d 0a 4f 4b 0d 0a |..OK..|
D (21840) command_lib: Response:
OK
D (21840) CDC_ACM: Submitting poll for BULK IN transfer
V (21840) command_lib: set_pdp_context
V (21850) command_lib: generic_command_common
V (21850) command_lib: generic_command
D (21860) command_lib: generic_command command AT+CGDCONT=1,"IP","M2MISAFE"
D (21860) usb_terminal: 0x3fca3e4c 41 54 2b 43 47 44 43 4f 4e 54 3d 31 2c 22 49 50 |AT+CGDCONT=1,"IP|
D (21870) usb_terminal: 0x3fca3e5c 22 2c 22 4d 32 4d 49 53 41 46 45 22 0d |","M2MISAFE".|
D (21880) CDC_ACM: Submitting BULK OUT transfer
D (21890) CDC_ACM: out/ctrl xfer cb
D (22030) CDC_ACM: in xfer cb
D (22030) usb_terminal: 0x3fca281c 0d 0a 4f 4b 0d 0a |..OK..|
D (22030) command_lib: Response:
OK
D (22030) CDC_ACM: Submitting poll for BULK IN transfer
V (22040) command_lib: set_data_mode
V (22040) command_lib: generic_command
D (22040) command_lib: generic_command command ATD*99##
D (22050) usb_terminal: 0x3fc9a6a8 41 54 44 2a 39 39 23 23 0d |ATD*99##.|
D (22060) CDC_ACM: Submitting BULK OUT transfer
D (22060) CDC_ACM: out/ctrl xfer cb
D (22100) CDC_ACM: in xfer cb
D (22100) usb_terminal: 0x3fca281c 0d 0a 43 4f 4e 4e 45 43 54 0d 0a |..CONNECT..|
D (22100) command_lib: Response:
CONNECT
D (22110) CDC_ACM: Submitting poll for BULK IN transfer
D (22110) esp_netif_handlers: esp_netif action has started with netif0x3fc9e294 from event_id=0
D (22120) esp-netif_lwip-ppp: esp_netif_start_ppp: Starting PPP connection: 0x3fc9e5ac
ppp_connect[1]: holdoff=0
ppp phase changed[1]: phase=3
D (22130) esp-netif_lwip-ppp: Phase Start
pppos_connect: unit 1: connecting
ppp_start[1]
ppp phase changed[1]: phase=6
D (22150) esp-netif_lwip-ppp: Phase Establish
pppos_send_config[1]: out_accm=FF FF FF FF
ppp_send_config[1]
pppos_recv_config[1]: in_accm=FF FF FF FF
ppp_recv_config[1]
ppp: auth protocols: PAP=0
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xd35d2133> <pcomp> <accomp>]
pppos_write[1]: output failed len=24
ppp_start[1]: finished
D (22180) esp_netif_lwip: check: remote, if=0x3fc9e294 fn=0x42026730
0x42026730: esp_netif_update_default_netif_lwip at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_netif/lwip/esp_netif_lwip.c:309
D (22180) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3fc9e294
V (22190) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3fc9e294
D (22200) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (22200) pppos_example: Waiting for IP address
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xd35d2133> <pcomp> <accomp>]
D (28170) usb_terminal: 0x3fca5228 7e ff 7d 23 c0 21 7d 21 7d 21 7d 20 7d 34 7d 22 |~.}#.!}!}!} }4}"|
D (28170) usb_terminal: 0x3fca5238 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 d3 5d |}&} } } } }%}&.]|
D (28180) usb_terminal: 0x3fca5248 21 33 7d 27 7d 22 7d 28 7d 22 42 7a 7e |!3}'}"}(}"Bz~|
D (28190) CDC_ACM: Submitting BULK OUT transfer
D (28190) CDC_ACM: out/ctrl xfer cb
pppos_write[1]: len=24
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xd35d2133> <pcomp> <accomp>]
D (34200) usb_terminal: 0x3fca5228 7e ff 7d 23 c0 21 7d 21 7d 21 7d 20 7d 34 7d 22 |~.}#.!}!}!} }4}"|
D (34200) usb_terminal: 0x3fca5238 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 d3 5d |}&} } } } }%}&.]|
D (34210) usb_terminal: 0x3fca5248 21 33 7d 27 7d 22 7d 28 7d 22 42 7a 7e |!3}'}"}(}"Bz~|
D (34220) CDC_ACM: Submitting BULK OUT transfer
D (34220) CDC_ACM: out/ctrl xfer cb
pppos_write[1]: len=24
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xd35d2133> <pcomp> <accomp>]
D (40230) usb_terminal: 0x3fca5228 7e ff 7d 23 c0 21 7d 21 7d 21 7d 20 7d 34 7d 22 |~.}#.!}!}!} }4}"|
D (40230) usb_terminal: 0x3fca5238 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 d3 5d |}&} } } } }%}&.]|
D (40240) usb_terminal: 0x3fca5248 21 33 7d 27 7d 22 7d 28 7d 22 42 7a 7e |!3}'}"}(}"Bz~|
D (40250) CDC_ACM: Submitting BULK OUT transfer
D (40250) CDC_ACM: out/ctrl xfer cb
pppos_write[1]: len=24
D (45440) USBH: Processing actions 0x17
D (45440) USBH: Default pipe device 1
E (45440) USBH: Device 1 gone
D (45440) CDC_ACM: in xfer cb
D (45440) CDC_ACM: in xfer cb
D (45440) CDC_ACM: notif xfer cb
D (45450) CDC_ACM: notif xfer cb
D (45450) cdc_acm: Device suddenly disconnected
W (45450) usb_terminal: USB terminal disconnected
I (45460) pppos_example: USB modem disconnected
W (45460) usb_terminal: USB terminal disconnected
I (45470) pppos_example: USB modem disconnected
D (45480) USBH: Processing actions 0x40
D (45480) USBH: Freeing device 1
D (45480) USBH: Device all free
D (45490) HUB: Recovering root port
D (45490) esp_netif_handlers: esp_netif action stopped with netif0x3fc9e294 from event_id=0
D (45500) esp-netif_lwip-ppp: esp_netif_stop_ppp: Stopped PPP connection: 0x3fc9e5ac
ppp_close[1]: kill_link -> lcp_close
ppp phase changed[1]: phase=11
D (45510) esp-netif_lwip-ppp: Phase Terminate
sent [LCP TermReq id=0x2 "User request"]
D (45520) usb_terminal: 0x3fca3610 7e ff 7d 23 c0 21 7d 25 7d 22 7d 20 7d 30 55 73 |~.}#.!}%}"} }0Us|
D (45530) usb_terminal: 0x3fca3620 65 72 20 72 65 71 75 65 73 74 53 33 7e |er requestS3~|
pppos_write[1]: output failed len=20
D (45540) esp_netif_lwip: check: remote, if=0x3fc9e294 fn=0x42026730
0x42026730: esp_netif_update_default_netif_lwip at C:/Espressif/frameworks/esp-idf-v5.0.2/components/esp_netif/lwip/esp_netif_lwip.c:309
D (45550) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3fc9e294
V (45550) esp_netif_objects: esp_netif_next_unsafe 0x0
V (45560) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3fc9e294
V (45570) esp_netif_objects: esp_netif_next_unsafe 0x3fc9e294
D (45570) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (47720) HUB: Root port reset
D (47720) HUB: Stage done: START
D (47720) HUB: Stage done: GET_SHORT_DEV_DESC
[Codebox=text file=Untitled.txt][/Codebox]