Skip to content

Instantly share code, notes, and snippets.

@diplfranzhoepfinger

diplfranzhoepfinger/gist:0e478bf118ab78914b6a202e7488ae67

Created October 26, 2023 07:45
Show Gist options
  • Save diplfranzhoepfinger/0e478bf118ab78914b6a202e7488ae67 to your computer and use it in GitHub Desktop.
Save diplfranzhoepfinger/0e478bf118ab78914b6a202e7488ae67 to your computer and use it in GitHub Desktop.
Download ZIP
Raw
gistfile1.txt
ESP-ROM:esp32s3-20210327
Build:Mar 27 2021
rst:0x1 (POWERON),boot:0x28 (SPI_FAST_FLASH_BOOT)
SPIWP:0xee
mode:DIO, clock div:1
load:0x3fce3818,len:0x16e0
load:0x403c9700,len:0x4
load:0x403c9704,len:0xc00
load:0x403cc700,len:0x2eb0
entry 0x403c9908
I (27) boot: ESP-IDF v5.1.1 2nd stage bootloader
I (27) boot: compile time Oct 26 2023 09:43:17
I (27) boot: Multicore bootloader
I (30) boot: chip revision: v0.1
I (34) boot.esp32s3: Boot SPI Speed : 80MHz
I (39) boot.esp32s3: SPI Mode : DIO
I (43) boot.esp32s3: SPI Flash Size : 2MB
I (48) boot: Enabling RNG early entropy source...
I (54) boot: Partition Table:
I (57) boot: ## Label Usage Type ST Offset Length
I (64) boot: 0 nvs WiFi data 01 02 00009000 00006000
I (72) boot: 1 phy_init RF data 01 01 0000f000 00001000
I (79) boot: 2 factory factory app 00 00 00010000 00177000
I (87) boot: End of partition table
I (91) esp_image: segment 0: paddr=00010020 vaddr=3c080020 size=2e594h (189844) map
I (133) esp_image: segment 1: paddr=0003e5bc vaddr=3fc92b00 size=01a5ch ( 6748) load
I (135) esp_image: segment 2: paddr=00040020 vaddr=42000020 size=74be8h (478184) map
I (225) esp_image: segment 3: paddr=000b4c10 vaddr=3fc9455c size=011b4h ( 4532) load
I (226) esp_image: segment 4: paddr=000b5dcc vaddr=40374000 size=0ea44h ( 59972) load
I (250) boot: Loaded app from partition at offset 0x10000
I (250) boot: Disabling RNG early entropy source...
I (262) cpu_start: Multicore app
D (262) flash HPM: HPM with dummy, status is 3
V (262) mmap: after coalescing, 1 regions are left
I (264) cpu_start: Pro cpu up.
I (268) cpu_start: Starting app cpu, entry point is 0x40375468
0x40375468: call_start_cpu1 at /home/franz/esp-idf-v5.1.1/components/esp_system/port/cpu_start.c:154
I (0) cpu_start: App cpu up.
V CACHE_ERR: illegal error intr clr & ena mask is: 0x3f
V CA H28E) c c: e C_ access errorbrintr clr & en4 mask8 is: 0x1f
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 (300) cpu_start: Pro cpu start user code
I (304) cpu_start: cpu freq: 160000000 Hz
I (308) cpu_start: Application information:
I (313) cpu_start: Project name: app-template
I (319) cpu_start: App version: v0.2-1-gaff2299
I (324) cpu_start: Compile time: Oct 26 2023 09:43:50
I (330) cpu_start: ELF file SHA256: 7f81adc69c5e9cdc...
I (336) cpu_start: ESP-IDF: v5.1.1
I (341) cpu_start: Min chip rev: v0.0
I (346) cpu_start: Max chip rev: v0.99
I (351) cpu_start: Chip rev: v0.1
V (355) memory_layout: reserved range is 0x3c0ae574 - 0x3c0ae59c
D (361) memory_layout: Checking 6 reserved memory ranges:
D (367) memory_layout: Reserved memory range 0x3fc84000 - 0x3fc92b00
D (373) memory_layout: Reserved memory range 0x3fc92b00 - 0x3fc97080
D (380) memory_layout: Reserved memory range 0x3fceee34 - 0x3fcf0000
D (386) memory_layout: Reserved memory range 0x40374000 - 0x40382b00
0x40374000: _WindowOverflow4 at /home/franz/esp-idf-v5.1.1/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:2023
D (393) memory_layout: Reserved memory range 0x600fe000 - 0x600fe010
D (399) memory_layout: Reserved memory range 0x600fffe8 - 0x60100000
D (405) memory_layout: Building list of available memory regions:
V (412) memory_layout: Examining memory region 0x40374000 - 0x40378000
0x40374000: _WindowOverflow4 at /home/franz/esp-idf-v5.1.1/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:2023
0x40378000: detect_spi_flash_chip at /home/franz/esp-idf-v5.1.1/components/spi_flash/esp_flash_api.c:520
V (418) memory_layout: Region 0x40374000 - 0x40378000 inside of reserved 0x40374000 - 0x40382b00
0x40374000: _WindowOverflow4 at /home/franz/esp-idf-v5.1.1/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:2023
0x40378000: detect_spi_flash_chip at /home/franz/esp-idf-v5.1.1/components/spi_flash/esp_flash_api.c:520
0x40374000: _WindowOverflow4 at /home/franz/esp-idf-v5.1.1/components/freertos/FreeRTOS-Kernel/portable/xtensa/xtensa_vectors.S:2023
V (427) memory_layout: Examining memory region 0x3fc88000 - 0x3fc90000
V (434) memory_layout: Region 0x3fc88000 - 0x3fc90000 inside of reserved 0x3fc84000 - 0x3fc92b00
V (443) memory_layout: Examining memory region 0x3fc90000 - 0x3fca0000
V (449) memory_layout: Start of region 0x3fc90000 - 0x3fca0000 overlaps reserved 0x3fc84000 - 0x3fc92b00
V (459) memory_layout: Start of region 0x3fc92b00 - 0x3fca0000 overlaps reserved 0x3fc92b00 - 0x3fc97080
D (468) memory_layout: Available memory region 0x3fc97080 - 0x3fca0000
V (475) memory_layout: Examining memory region 0x3fca0000 - 0x3fcb0000
D (481) memory_layout: Available memory region 0x3fca0000 - 0x3fcb0000
V (488) memory_layout: Examining memory region 0x3fcb0000 - 0x3fcc0000
D (495) memory_layout: Available memory region 0x3fcb0000 - 0x3fcc0000
V (501) memory_layout: Examining memory region 0x3fcc0000 - 0x3fcd0000
D (508) memory_layout: Available memory region 0x3fcc0000 - 0x3fcd0000
V (514) memory_layout: Examining memory region 0x3fcd0000 - 0x3fce0000
D (521) memory_layout: Available memory region 0x3fcd0000 - 0x3fce0000
V (528) memory_layout: Examining memory region 0x3fce0000 - 0x3fce9710
D (534) memory_layout: Available memory region 0x3fce0000 - 0x3fce9710
V (541) memory_layout: Examining memory region 0x3fce9710 - 0x3fcf0000
V (547) memory_layout: End of region 0x3fce9710 - 0x3fcf0000 overlaps reserved 0x3fceee34 - 0x3fcf0000
D (557) memory_layout: Available memory region 0x3fce9710 - 0x3fceee34
V (563) memory_layout: Examining memory region 0x3fcf0000 - 0x3fcf8000
D (570) memory_layout: Available memory region 0x3fcf0000 - 0x3fcf8000
V (577) memory_layout: Examining memory region 0x600fe000 - 0x60100000
V (583) memory_layout: Start of region 0x600fe000 - 0x60100000 overlaps reserved 0x600fe000 - 0x600fe010
V (593) memory_layout: End of region 0x600fe010 - 0x60100000 overlaps reserved 0x600fffe8 - 0x60100000
D (602) memory_layout: Available memory region 0x600fe010 - 0x600fffe8
I (609) heap_init: Initializing. RAM available for dynamic allocation:
D (616) heap_init: New heap initialised at 0x3fc97080
I (621) heap_init: At 3FC97080 len 00052690 (329 KiB): DRAM
I (627) heap_init: At 3FCE9710 len 00005724 (21 KiB): STACK/DRAM
D (634) heap_init: New heap initialised at 0x3fcf0000
I (639) heap_init: At 3FCF0000 len 00008000 (32 KiB): DRAM
D (645) heap_init: New heap initialised at 0x600fe010
I (650) heap_init: At 600FE010 len 00001FD8 (7 KiB): RTCRAM
V (657) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (663) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x40E
D (671) intr_alloc: Connected src 39 to int 2 (cpu 0)
V (677) memspi: raw_chip_id: 1840C8
V (680) memspi: chip_id: C84018
V (683) memspi: raw_chip_id: 1840C8
V (687) memspi: chip_id: C84018
D (690) spi_flash: trying chip: issi
D (694) spi_flash: trying chip: gd
I (698) spi_flash: detected chip: gd
I (702) spi_flash: flash io: dio
W (706) spi_flash: Detected size(16384k) larger than the size in the binary image header(2048k). Using the size in the binary image header.
D (719) cpu_start: calling init function: 0x42060d70
0x42060d70: _GLOBAL__sub_I__ZN17__eh_globals_init7_S_initE at /builds/idf/crosstool-NG/.build/xtensa-esp32s3-elf/src/gcc/libstdc++-v3/libsupc++/eh_globals.cc:168
D (724) cpu_start: calling init function: 0x42060bc0
0x42060bc0: _GLOBAL__sub_I__ZN9__gnu_cxx9__freeresEv at /builds/idf/crosstool-NG/.build/xtensa-esp32s3-elf/src/gcc/libstdc++-v3/libsupc++/eh_alloc.cc:342
D (729) cpu_start: calling init function: 0x42038b5c
0x42038b5c: esp_ds_conn_lock at /home/franz/esp-idf-v5.1.1/components/mbedtls/port/esp_ds/esp_rsa_sign_alt.c:49
D (734) cpu_start: calling init function: 0x420209c0
0x420209c0: esp_ipc_init at /home/franz/esp-idf-v5.1.1/components/esp_system/esp_ipc.c:114
D (739) cpu_start: calling init function: 0x4200330c
0x4200330c: esp_init_app_elf_sha256 at /home/franz/esp-idf-v5.1.1/components/esp_app_format/esp_app_desc.c:69
D (744) cpu_start: calling init function: 0x42008fa8 on core: 0
0x42008fa8: __esp_system_init_fn_esp_timer_startup_init at /home/franz/esp-idf-v5.1.1/components/esp_timer/src/esp_timer.c:575
V (750) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (756) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xC02
D (765) intr_alloc: Connected src 59 to int 3 (cpu 0)
D (770) cpu_start: calling init function: 0x42006150 on core: 0
0x42006150: __esp_system_init_fn_esp_sleep_startup_init at /home/franz/esp-idf-v5.1.1/components/esp_hw_support/sleep_gpio.c:190
I (776) sleep: Configure to isolate all GPIO pins in sleep state
I (783) sleep: Enable automatic switching of GPIO sleep configuration
D (790) cpu_start: calling init function: 0x420044a0 on core: 0
0x420044a0: __esp_system_init_fn_init_components0 at /home/franz/esp-idf-v5.1.1/components/esp_system/startup.c:486
V (796) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (802) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x40E
D (810) intr_alloc: Connected src 79 to int 9 (cpu 0)
I (815) app_start: Starting scheduler on CPU0
V (820) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (820) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x402
D (820) intr_alloc: Connected src 57 to int 12 (cpu 0)
V (820) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args
V (830) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0x40E
D (830) intr_alloc: Connected src 80 to int 2 (cpu 1)
I (840) app_start: Starting scheduler on CPU1
V (840) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): checking args
V (850) intr_alloc: esp_intr_alloc_intrstatus (cpu 1): Args okay. Resulting flags 0x402
D (860) intr_alloc: Connected src 58 to int 3 (cpu 1)
I (820) main_task: Started on CPU0
D (870) heap_init: New heap initialised at 0x3fce9710
V (870) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (880) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0xE
D (890) intr_alloc: Connected src 52 to int 13 (cpu 0)
I (890) main_task: Calling app_main()
I (900) gpio: GPIO[10]| InputEn: 1| OutputEn: 0| OpenDrain: 0| Pullup: 1| Pulldown: 0| Intr:0
I (910) gpio: GPIO[11]| InputEn: 0| OutputEn: 1| OpenDrain: 0| Pullup: 0| Pulldown: 0| Intr:0
I (2920) modem_pwkey: status = 0
I (2920) modem_pwkey: status = 0
I (3020) modem_pwkey: POWER ON
I (4020) modem_pwkey: POWER ON OK
I (5020) modem_pwkey: status = 1
D (5020) esp_netif_lwip: LwIP stack has been initialized
D (5020) esp_netif_lwip: check: remote, if=0x0 fn=0x42023098
0x42023098: alloc_client_data_id at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:166
D (5020) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (5020) esp_netif_lwip: esp-netif has been successfully initialized
D (5030) event: running task for loop 0x3fc9d688
D (5040) event: created task for loop 0x3fc9d688
D (5040) event: created event loop 0x3fc9d688
D (5050) esp_netif_objects: esp_netif_add_to_list 0x3fc9e628
D (5050) esp_netif_objects: esp_netif_add_to_list netif added successfully (total netifs: 1)
D (5060) esp-netif_lwip-ppp: esp_netif_new_ppp: PPP connection created: 0x3fc9e938
D (5070) esp-netif_lwip-ppp: Phase Dead
D (5070) esp_netif_lwip: check: remote, if=0x0 fn=0x420230a8
0x420230a8: set_lwip_netif_callback at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:174
D (5080) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (5080) pppos_example: Initializing esp_modem for the A7670 module...
I (5090) pppos_example: Waiting for USB device connection...
V (5100) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): checking args
V (5100) intr_alloc: esp_intr_alloc_intrstatus (cpu 0): Args okay. Resulting flags 0x802
D (5110) intr_alloc: Connected src 38 to int 17 (cpu 0)
D (5150) usb_terminal: USB Host installed
D (5150) cdc_acm: Checking list of opened USB devices
D (5150) cdc_acm: Checking list of connected USB devices
D (5200) cdc_acm: Checking list of connected USB devices
D (5250) cdc_acm: Checking list of connected USB devices
D (5300) cdc_acm: Checking list of connected USB devices
D (5350) cdc_acm: Checking list of connected USB devices
D (5400) cdc_acm: Checking list of connected USB devices
D (5450) cdc_acm: Checking list of connected USB devices
D (5500) cdc_acm: Checking list of connected USB devices
D (5550) cdc_acm: Checking list of connected USB devices
D (5600) cdc_acm: Checking list of connected USB devices
D (5650) cdc_acm: Checking list of connected USB devices
D (5700) cdc_acm: Checking list of connected USB devices
D (5750) cdc_acm: Checking list of connected USB devices
D (5800) cdc_acm: Checking list of connected USB devices
D (5850) cdc_acm: Checking list of connected USB devices
D (5900) cdc_acm: Checking list of connected USB devices
D (5950) cdc_acm: Checking list of connected USB devices
D (6000) cdc_acm: Checking list of connected USB devices
D (6050) cdc_acm: Checking list of connected USB devices
D (6100) cdc_acm: Checking list of connected USB devices
D (6150) cdc_acm: Checking list of connected USB devices
D (6200) cdc_acm: Checking list of connected USB devices
D (6250) cdc_acm: Checking list of connected USB devices
D (6300) cdc_acm: Checking list of connected USB devices
D (6350) cdc_acm: Checking list of connected USB devices
D (6400) cdc_acm: Checking list of connected USB devices
D (6450) cdc_acm: Checking list of connected USB devices
D (6500) cdc_acm: Checking list of connected USB devices
D (6550) cdc_acm: Checking list of connected USB devices
D (6600) cdc_acm: Checking list of connected USB devices
D (6650) cdc_acm: Checking list of connected USB devices
D (6700) cdc_acm: Checking list of connected USB devices
D (6750) cdc_acm: Checking list of connected USB devices
D (6800) cdc_acm: Checking list of connected USB devices
D (6850) cdc_acm: Checking list of connected USB devices
D (6900) cdc_acm: Checking list of connected USB devices
D (6950) cdc_acm: Checking list of connected USB devices
D (7000) cdc_acm: Checking list of connected USB devices
D (7050) cdc_acm: Checking list of connected USB devices
D (7100) cdc_acm: Checking list of connected USB devices
D (7150) cdc_acm: Checking list of connected USB devices
D (7200) cdc_acm: Checking list of connected USB devices
D (7250) cdc_acm: Checking list of connected USB devices
D (7300) cdc_acm: Checking list of connected USB devices
D (7350) cdc_acm: Checking list of connected USB devices
D (7400) cdc_acm: Checking list of connected USB devices
D (7450) cdc_acm: Checking list of connected USB devices
D (7500) cdc_acm: Checking list of connected USB devices
D (7550) cdc_acm: Checking list of connected USB devices
D (7600) cdc_acm: Checking list of connected USB devices
D (7650) cdc_acm: Checking list of connected USB devices
D (7700) cdc_acm: Checking list of connected USB devices
D (7750) cdc_acm: Checking list of connected USB devices
D (7800) cdc_acm: Checking list of connected USB devices
D (7850) cdc_acm: Checking list of connected USB devices
D (7900) cdc_acm: Checking list of connected USB devices
D (7950) cdc_acm: Checking list of connected USB devices
D (8000) cdc_acm: Checking list of connected USB devices
D (8050) cdc_acm: Checking list of connected USB devices
D (8100) cdc_acm: Checking list of connected USB devices
D (8150) cdc_acm: Checking list of connected USB devices
D (8200) cdc_acm: Checking list of connected USB devices
D (8250) cdc_acm: Checking list of connected USB devices
D (8300) cdc_acm: Checking list of connected USB devices
D (8350) cdc_acm: Checking list of connected USB devices
D (8400) cdc_acm: Checking list of connected USB devices
D (8450) cdc_acm: Checking list of connected USB devices
D (8500) cdc_acm: Checking list of connected USB devices
D (8550) cdc_acm: Checking list of connected USB devices
D (8600) cdc_acm: Checking list of connected USB devices
D (8650) cdc_acm: Checking list of connected USB devices
D (8700) cdc_acm: Checking list of connected USB devices
D (8750) cdc_acm: Checking list of connected USB devices
D (8800) cdc_acm: Checking list of connected USB devices
D (8850) cdc_acm: Checking list of connected USB devices
D (8900) cdc_acm: Checking list of connected USB devices
D (8950) cdc_acm: Checking list of connected USB devices
D (9000) cdc_acm: Checking list of connected USB devices
D (9050) cdc_acm: Checking list of connected USB devices
D (9100) cdc_acm: Checking list of connected USB devices
D (9150) cdc_acm: Checking list of connected USB devices
D (9200) cdc_acm: Checking list of connected USB devices
D (9250) cdc_acm: Checking list of connected USB devices
D (9300) cdc_acm: Checking list of connected USB devices
D (9350) cdc_acm: Checking list of connected USB devices
D (9400) cdc_acm: Checking list of connected USB devices
D (9450) cdc_acm: Checking list of connected USB devices
D (9500) cdc_acm: Checking list of connected USB devices
D (9550) cdc_acm: Checking list of connected USB devices
D (9600) cdc_acm: Checking list of connected USB devices
D (9650) HUB: Root port reset
D (9650) HUB: Stage done: START
D (9650) HUB: Stage done: GET_SHORT_DEV_DESC
D (9650) HUB: Stage done: CHECK_SHORT_DEV_DESC
D (9650) cdc_acm: Checking list of connected USB devices
D (9700) cdc_acm: Checking list of connected USB devices
D (9710) HUB: Stage done: SECOND_RESET
D (9710) HUB: Stage done: SET_ADDR
D (9710) HUB: Stage done: CHECK_ADDR
D (9720) HUB: Stage done: SET_ADDR_RECOVERY
D (9720) HUB: Stage done: GET_FULL_DEV_DESC
D (9720) HUB: Stage done: CHECK_FULL_DEV_DESC
D (9720) HUB: Stage done: GET_SHORT_CONFIG_DESC
D (9720) HUB: Stage done: CHECK_SHORT_CONFIG_DESC
D (9730) HUB: Stage done: GET_FULL_CONFIG_DESC
D (9730) HUB: Stage done: CHECK_FULL_CONFIG_DESC
D (9740) HUB: Stage done: SET_CONFIG
D (9740) HUB: Stage done: CHECK_CONFIG
D (9740) HUB: Stage done: GET_SHORT_LANGID_TABLE
D (9750) HUB: Stage done: CHECK_SHORT_LANGID_TABLE
D (9750) HUB: Stage done: GET_FULL_LANGID_TABLE
D (9760) HUB: Stage done: CHECK_FULL_LANGID_TABLE
D (9760) HUB: Stage done: GET_SHORT_MANU_STR_DESC
D (9770) HUB: Stage done: CHECK_SHORT_MANU_STR_DESC
D (9770) HUB: Stage done: GET_FULL_MANU_STR_DESC
D (9780) HUB: Stage done: CHECK_FULL_MANU_STR_DESC
D (9780) HUB: Stage done: GET_SHORT_PROD_STR_DESC
D (9790) HUB: Stage done: CHECK_SHORT_PROD_STR_DESC
D (9790) HUB: Stage done: GET_FULL_PROD_STR_DESC
D (9800) HUB: Stage done: CHECK_FULL_PROD_STR_DESC
D (9800) HUB: Stage done: GET_SHORT_SER_STR_DESC
D (9810) HUB: Stage done: CHECK_SHORT_SER_STR_DESC
D (9810) HUB: Stage done: GET_FULL_SER_STR_DESC
D (9820) HUB: Stage done: CHECK_FULL_SER_STR_DESC
D (9820) HUB: Stage done: CLEANUP
D (9820) USBH: Processing actions 0x100
D (9830) USBH: New device 1
D (9830) cdc_acm: New device connected
D (9830) cdc_acm: Checking list of connected USB devices
D (9840) CDC_ACM: Submitting poll for BULK IN transfer
D (9850) CDC_ACM: Submitting poll for INTR IN transfer
D (9850) cdc_acm: Checking list of opened USB devices
D (9860) CDC_ACM: Submitting poll for BULK IN transfer
D (9860) CDC_ACM: Submitting poll for INTR IN transfer
I (9870) pppos_example: Modem connected, waiting 10 seconds for boot...
D (10070) CDC_ACM: in xfer cb
D (10080) usb_terminal: 0x3fca3c14 0d 0a 2a 41 54 52 45 41 44 59 3a 20 31 0d 0a |..*ATREADY: 1..|
D (10080) usb_terminal: Unhandled RX data
D (10080) CDC_ACM: Submitting poll for BULK IN transfer
D (10090) CDC_ACM: in xfer cb
D (10090) usb_terminal: 0x3fca2b60 0d 0a 2a 41 54 52 45 41 44 59 3a 20 31 0d 0a |..*ATREADY: 1..|
D (10100) CDC_ACM: Submitting poll for BULK IN transfer
D (11920) CDC_ACM: in xfer cb
D (11920) usb_terminal: 0x3fca3c14 0d 0a 2b 43 50 49 4e 3a 20 52 45 41 44 59 0d 0a |..+CPIN: READY..|
D (11920) usb_terminal: Unhandled RX data
D (11920) CDC_ACM: Submitting poll for BULK IN transfer
D (11930) CDC_ACM: in xfer cb
D (11930) usb_terminal: 0x3fca2b6f 0d 0a 2b 43 50 49 4e 3a 20 52 45 41 44 59 0d 0a |..+CPIN: READY..|
D (11940) CDC_ACM: Submitting poll for BULK IN transfer
D (12490) CDC_ACM: in xfer cb
D (12490) usb_terminal: 0x3fca3c14 0d 0a 53 4d 53 20 44 4f 4e 45 0d 0a |..SMS DONE..|
D (12490) usb_terminal: Unhandled RX data
D (12500) CDC_ACM: Submitting poll for BULK IN transfer
D (12500) CDC_ACM: in xfer cb
D (12510) usb_terminal: 0x3fca2b7f 0d 0a 53 4d 53 20 44 4f 4e 45 0d 0a |..SMS DONE..|
D (12520) CDC_ACM: Submitting poll for BULK IN transfer
D (17000) CDC_ACM: in xfer cb
D (17000) usb_terminal: 0x3fca3c14 0d 0a 2b 43 47 45 56 3a 20 45 50 53 20 50 44 4e |..+CGEV: EPS PDN|
D (17000) usb_terminal: 0x3fca3c24 20 41 43 54 20 31 0d 0a | ACT 1..|
D (17010) usb_terminal: Unhandled RX data
D (17010) CDC_ACM: Submitting poll for BULK IN transfer
D (17020) CDC_ACM: in xfer cb
D (17020) usb_terminal: 0x3fca2b8b 0d 0a 2b 43 47 45 56 3a 20 45 50 53 20 50 44 4e |..+CGEV: EPS PDN|
D (17030) usb_terminal: 0x3fca2b9b 20 41 43 54 20 31 0d 0a | ACT 1..|
D (17040) CDC_ACM: Submitting poll for BULK IN transfer
V (19870) command_lib: get_signal_quality
V (19870) command_lib: generic_get_string
D (19870) usb_terminal: 0x3fc9aadc 41 54 2b 43 53 51 0d |AT+CSQ.|
D (19870) CDC_ACM: Submitting BULK OUT transfer
D (19880) CDC_ACM: out/ctrl xfer cb
D (19880) CDC_ACM: in xfer cb
D (19880) usb_terminal: 0x3fca2ba3 41 54 2b 43 53 51 0d |AT+CSQ.|
D (19890) CDC_ACM: Submitting poll for BULK IN transfer
D (19900) CDC_ACM: in xfer cb
D (19900) usb_terminal: 0x3fca2baa 0d 0a 2b 43 53 51 3a 20 32 34 2c 39 39 0d 0a |..+CSQ: 24,99..|
} (19910) command_lib: Token: {
V (19910) command_lib: Token: {+CSQ: 24,99}
D (19920) CDC_ACM: Submitting poll for BULK IN transfer
D (19920) CDC_ACM: in xfer cb
D (19930) usb_terminal: 0x3fca2bb9 0d 0a 4f 4b 0d 0a |..OK..|
} (19930) command_lib: Token: {
V (19940) command_lib: Token: {OK}
D (19940) CDC_ACM: Submitting poll for BULK IN transfer
I (19950) pppos_example: Signal quality: rssi=24, ber=99
V (19950) command_lib: set_echo
V (19960) command_lib: generic_command_common
V (19960) command_lib: generic_command
D (19960) command_lib: generic_command command ATE0
D (19970) usb_terminal: 0x3fc9aa2c 41 54 45 30 0d |ATE0.|
D (19980) CDC_ACM: Submitting BULK OUT transfer
D (19980) CDC_ACM: out/ctrl xfer cb
D (19990) CDC_ACM: in xfer cb
D (19990) usb_terminal: 0x3fca2b60 41 54 45 30 0d |ATE0.|
D (20000) CDC_ACM: Submitting poll for BULK IN transfer
D (20000) CDC_ACM: in xfer cb
D (20010) usb_terminal: 0x3fca2b65 0d 0a 4f 4b 0d 0a |..OK..|
D (20020) command_lib: Response:
OK
D (20020) CDC_ACM: Submitting poll for BULK IN transfer
V (20020) command_lib: set_pdp_context
V (20030) command_lib: generic_command_common
V (20030) command_lib: generic_command
D (20040) command_lib: generic_command command AT+CGDCONT=1,"IP","nbiot.global-m2m.net"
D (20050) usb_terminal: 0x3fca4a48 41 54 2b 43 47 44 43 4f 4e 54 3d 31 2c 22 49 50 |AT+CGDCONT=1,"IP|
D (20050) usb_terminal: 0x3fca4a58 22 2c 22 6e 62 69 6f 74 2e 67 6c 6f 62 61 6c 2d |","nbiot.global-|
D (20060) usb_terminal: 0x3fca4a68 6d 32 6d 2e 6e 65 74 22 0d |m2m.net".|
D (20070) CDC_ACM: Submitting BULK OUT transfer
D (20080) CDC_ACM: out/ctrl xfer cb
D (20080) CDC_ACM: in xfer cb
D (20080) usb_terminal: 0x3fca2b60 0d 0a 4f 4b 0d 0a |..OK..|
D (20090) command_lib: Response:
OK
D (20100) CDC_ACM: Submitting poll for BULK IN transfer
V (20100) command_lib: set_data_mode
V (20110) command_lib: generic_command
D (20110) command_lib: generic_command command ATD*99##
D (20120) usb_terminal: 0x3fc9aa44 41 54 44 2a 39 39 23 23 0d |ATD*99##.|
D (20120) CDC_ACM: Submitting BULK OUT transfer
D (20130) CDC_ACM: out/ctrl xfer cb
D (20180) CDC_ACM: in xfer cb
D (20180) usb_terminal: 0x3fca2b60 0d 0a 43 4f 4e 4e 45 43 54 0d 0a |..CONNECT..|
D (20180) command_lib: Response:
CONNECT
D (20180) CDC_ACM: Submitting poll for BULK IN transfer
D (20190) esp_netif_handlers: esp_netif action has started with netif0x3fc9e628 from event_id=0
D (20200) esp-netif_lwip-ppp: esp_netif_start_ppp: Starting PPP connection: 0x3fc9e938
D (20210) esp-netif_lwip-ppp: Phase Start
D (20210) esp-netif_lwip-ppp: Phase Establish
D (20220) usb_terminal: 0x3fca5428 7e ff 7d 23 c0 21 7d 21 7d 21 7d 20 7d 34 7d 22 |~.}#.!}!}!} }4}"|
D (20220) usb_terminal: 0x3fca5438 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 9e d9 |}&} } } } }%}&..|
D (20230) usb_terminal: 0x3fca5448 40 de 7d 27 7d 22 7d 28 7d 22 7d 2d 98 7e |@.}'}"}(}"}-.~|
D (20240) CDC_ACM: Submitting BULK OUT transfer
D (20250) CDC_ACM: out/ctrl xfer cb
D (20250) CDC_ACM: in xfer cb
D (20260) usb_terminal: 0x3fca2b60 7e ff 7d 23 c0 21 7d 21 7d 21 7d 20 7d 38 7d 22 |~.}#.!}!}!} }8}"|
D (20260) usb_terminal: 0x3fca2b70 7d 26 7d 20 7d 20 7d 20 7d 20 7d 23 7d 24 c0 23 |}&} } } } }#}$.#|
D (20270) usb_terminal: 0x3fca2b80 7d 25 7d 26 4d ae df 22 7d 27 7d 22 7d 28 7d 22 |}%}&M.."}'}"}(}"|
D (20280) usb_terminal: 0x3fca2b90 7d 38 89 7e |}8.~|
D (20290) usb_terminal: 0x3fca6028 7e ff 7d 23 c0 21 7d 24 7d 21 7d 20 7d 28 7d 23 |~.}#.!}$}!} }(}#|
D (20300) usb_terminal: 0x3fca6038 7d 24 c0 23 2c d4 7e |}$.#,.~|
D (20310) CDC_ACM: Submitting BULK OUT transfer
D (20320) CDC_ACM: Submitting poll for BULK IN transfer
D (20320) CDC_ACM: out/ctrl xfer cb
D (20320) CDC_ACM: in xfer cb
D (20330) usb_terminal: 0x3fca2b60 7e ff 7d 23 c0 21 7d 22 7d 21 7d 20 7d 34 7d 22 |~.}#.!}"}!} }4}"|
D (20340) usb_terminal: 0x3fca2b70 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 9e d9 |}&} } } } }%}&..|
D (20350) usb_terminal: 0x3fca2b80 40 de 7d 27 7d 22 7d 28 7d 22 e6 f1 7e |@.}'}"}(}"..~|
D (20360) CDC_ACM: Submitting poll for BULK IN transfer
D (20360) CDC_ACM: in xfer cb
D (20360) usb_terminal: 0x3fca2b60 7e ff 7d 23 c0 21 7d 21 7d 22 7d 20 7d 34 7d 22 |~.}#.!}!}"} }4}"|
D (20370) usb_terminal: 0x3fca2b70 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 54 a1 |}&} } } } }%}&T.|
D (20380) usb_terminal: 0x3fca2b80 79 5b 7d 27 7d 22 7d 28 7d 22 7d 25 2c 7e |y[}'}"}(}"}%,~|
D (20390) usb_terminal: 0x3fca6028 7e ff 7d 23 c0 21 7d 22 7d 22 7d 20 7d 34 7d 22 |~.}#.!}"}"} }4}"|
D (20400) usb_terminal: 0x3fca6038 7d 26 7d 20 7d 20 7d 20 7d 20 7d 25 7d 26 54 a1 |}&} } } } }%}&T.|
D (20410) usb_terminal: 0x3fca6048 79 5b 7d 27 7d 22 7d 28 7d 22 ee 45 7e |y[}'}"}(}".E~|
D (20420) CDC_ACM: Submitting BULK OUT transfer
D (20430) CDC_ACM: Submitting poll for BULK IN transfer
D (20430) CDC_ACM: out/ctrl xfer cb
D (20440) esp-netif_lwip-ppp: Phase Authenticate
D (20440) esp-netif_lwip-ppp: Phase Network
D (20440) usb_terminal: 0x3fca6028 7e ff 03 80 21 01 01 00 1c 02 06 00 2d 0f 01 03 |~...!.......-...|
D (20450) usb_terminal: 0x3fca6038 06 00 00 00 00 81 06 00 00 00 00 83 06 00 00 00 |................|
D (20460) usb_terminal: 0x3fca6048 00 55 15 7e |.U.~|
D (20470) CDC_ACM: Submitting BULK OUT transfer
D (20480) CDC_ACM: out/ctrl xfer cb
D (20480) CDC_ACM: in xfer cb
D (20480) usb_terminal: 0x3fca2b60 7e 80 21 01 00 00 04 67 c3 7e |~.!....g.~|
D (20490) usb_terminal: 0x3fca6028 7e ff 03 80 21 03 00 00 0a 03 06 00 00 00 00 a0 |~...!...........|
D (20500) usb_terminal: 0x3fca6038 3d 7e |=~|
D (20510) CDC_ACM: Submitting BULK OUT transfer
D (20520) CDC_ACM: Submitting poll for BULK IN transfer
D (20520) CDC_ACM: out/ctrl xfer cb
D (20520) CDC_ACM: in xfer cb
D (20530) usb_terminal: 0x3fca2b60 7e 80 21 04 01 00 0a 02 06 00 2d 0f 01 f8 30 7e |~.!.......-...0~|
D (20540) usb_terminal: 0x3fca6028 7e ff 03 80 21 01 02 00 16 03 06 00 00 00 00 81 |~...!...........|
D (20550) usb_terminal: 0x3fca6038 06 00 00 00 00 83 06 00 00 00 00 da 82 7e |.............~|
D (20560) CDC_ACM: Submitting BULK OUT transfer
D (20560) CDC_ACM: Submitting poll for BULK IN transfer
D (20570) CDC_ACM: out/ctrl xfer cb
D (20570) CDC_ACM: in xfer cb
D (20570) usb_terminal: 0x3fca2b60 7e 80 21 01 01 00 04 bb 99 7e |~.!......~|
D (20580) usb_terminal: 0x3fca6028 7e ff 03 80 21 02 01 00 04 cd 92 7e |~...!......~|
D (20590) CDC_ACM: Submitting BULK OUT transfer
D (20600) CDC_ACM: Submitting poll for BULK IN transfer
D (20600) CDC_ACM: out/ctrl xfer cb
D (20600) CDC_ACM: in xfer cb
D (20610) usb_terminal: 0x3fca2b60 7e 80 21 03 02 00 16 03 06 64 52 4f 77 81 06 d9 |~.!......dROw...|
D (20620) usb_terminal: 0x3fca2b70 0e a0 82 83 06 d9 0e a4 23 2d e5 7e |........#-.~|
D (20630) usb_terminal: 0x3fca6028 7e ff 03 80 21 01 03 00 16 03 06 64 52 4f 77 81 |~...!......dROw.|
D (20640) usb_terminal: 0x3fca6038 06 d9 0e a0 82 83 06 d9 0e a4 23 8a 18 7e |..........#..~|
D (20650) CDC_ACM: Submitting BULK OUT transfer
D (20650) CDC_ACM: Submitting poll for BULK IN transfer
D (20660) CDC_ACM: out/ctrl xfer cb
D (20660) CDC_ACM: in xfer cb
D (20660) usb_terminal: 0x3fca2b60 7e 80 21 02 03 00 16 03 06 64 52 4f 77 81 06 d9 |~.!......dROw...|
D (20670) usb_terminal: 0x3fca2b70 0e a0 82 83 06 d9 0e a4 23 1c 7b 7e |........#.{~|
D (20680) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3fc9e6ac
D (20690) esp_netif_lwip: if0x3fc9e628 ip changed=1
D (20690) event: running post IP_EVENT:6 with handler 0x4200b800 and context 0x3fc9e5d4 on loop 0x3fc9d688
0x4200b800: on_ip_event at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:116
I (20700) esp-netif_lwip-ppp: Connected
D (20700) pppos_example: IP event! 6
D (20710) esp-netif_lwip-ppp: Phase Running
I (20710) pppos_example: Modem Connect to PPP Server
I (20720) pppos_example: ~~~~~~~~~~~~~~
I (20720) pppos_example: IP : 100.82.79.119
I (20730) pppos_example: Netmask : 255.255.255.255
I (20740) pppos_example: Gateway : 10.64.64.64
D (20740) esp_netif_lwip: check: remote, if=0x3fc9e628 fn=0x42023c30
0x42023c30: esp_netif_get_dns_info_api at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:1913
D (20700) CDC_ACM: Submitting poll for BULK IN transfer
D (20750) esp_netif_lwip: esp_netif_get_dns_info: esp_netif=0x3fc9e628 type=0
D (20760) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (20770) pppos_example: Name Server1: 217.14.160.130
D (20770) esp_netif_lwip: check: remote, if=0x3fc9e628 fn=0x42023c30
0x42023c30: esp_netif_get_dns_info_api at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:1913
D (20780) esp_netif_lwip: esp_netif_get_dns_info: esp_netif=0x3fc9e628 type=1
D (20700) esp_netif_lwip: check: remote, if=0x3fc9e628 fn=0x420241d8
0x420241d8: esp_netif_update_default_netif_lwip at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:327
D (20790) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (20800) pppos_example: Name Server2: 217.14.164.35
I (20800) pppos_example: ~~~~~~~~~~~~~~
I (20810) pppos_example: GOT ip event!!!
D (20810) event: running post IP_EVENT:6 with handler 0x42022a90 and context 0x3fca41bc on loop 0x3fc9d688
0x42022a90: esp_netif_action_connected at /home/franz/esp-idf-v5.1.1/components/esp_netif/esp_netif_handlers.c:36
D (20820) esp_netif_handlers: esp_netif action connected with netif0x3fc9e628 from event_id=6
D (20830) esp_netif_lwip: check: remote, if=0x3fc9e628 fn=0x42023b1c
0x42023b1c: esp_netif_up_api at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:1612
D (20840) esp_netif_lwip: esp_netif_up_api esp_netif:0x3fc9e628
D (20840) esp_netif_lwip: check: local, if=0x3fc9e628 fn=0x420241d8
0x420241d8: esp_netif_update_default_netif_lwip at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:327
D (20850) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3fc9e628
V (20860) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3fc9e628
D (20860) esp_netif_lwip: call api in lwip: ret=0x0, give sem
D (20870) event: running post NETIF_PPP_STATUS:0 with handler 0x4200b5cc and context 0x3fc9e608 on loop 0x3fc9d688
0x4200b5cc: on_ppp_changed at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:104
I (20880) pppos_example: PPP state changed event 0
D (20890) event: running post NETIF_PPP_STATUS:0 with handler 0x420112fc and context 0x3fca31f0 on loop 0x3fc9d688
0x420112fc: esp_modem::Netif::on_ppp_changed(void*, char const*, long, void*) at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/esp_modem/src/esp_modem_netif.cpp:22
D (20900) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3fc9e628
V (20900) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3fc9e628
V (20910) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3fc9e628
D (20920) esp_netif_lwip: call api in lwip: ret=0x0, give sem
I (20920) pppos_example: Waiting for IP address
D (20930) efuse: In EFUSE_BLK1__DATA1_REG is used 8 bits starting with 8 bit
D (20930) efuse: In EFUSE_BLK1__DATA1_REG is used 8 bits starting with 0 bit
D (20940) efuse: In EFUSE_BLK1__DATA0_REG is used 8 bits starting with 24 bit
D (20950) efuse: In EFUSE_BLK1__DATA0_REG is used 8 bits starting with 16 bit
D (20960) efuse: In EFUSE_BLK1__DATA0_REG is used 8 bits starting with 8 bit
D (20960) efuse: In EFUSE_BLK1__DATA0_REG is used 8 bits starting with 0 bit
D (20970) mqtt_client: MQTT client_id=ESP32_c23F6C
D (20970) event: created event loop 0x3fca488c
D (20980) mqtt_client: Core selection disabled
D (20980) event: running post MQTT_EVENTS:7 with handler 0x4200b608 and context 0x3fca49c4 on loop 0x3fca488c
0x4200b608: mqtt_event_handler at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:62
D (20990) pppos_example: Event dispatched from event loop base=MQTT_EVENTS, event_id=7
I (21000) pppos_example: MQTT other event id: 7
D (21010) esp-tls: host:mqtt.eclipseprojects.io: strlen 23
D (21010) usb_terminal: 0x3fca6e34 7e 21 45 00 00 45 00 00 00 00 ff 11 8e 4d 64 52 |~!E..E.......MdR|
D (21020) usb_terminal: 0x3fca6e44 4f 77 d9 0e a0 82 4d 91 00 35 00 31 b2 7b 20 92 |Ow....M..5.1.{ .|
D (21030) usb_terminal: 0x3fca6e54 01 00 00 01 00 00 00 00 00 00 04 6d 71 74 74 0f |...........mqtt.|
D (21040) usb_terminal: 0x3fca6e64 65 63 6c 69 70 73 65 70 72 6f 6a 65 63 74 73 02 |eclipseprojects.|
D (21050) usb_terminal: 0x3fca6e74 69 6f 00 00 01 00 01 75 19 7e |io.....u.~|
D (21060) CDC_ACM: Submitting BULK OUT transfer
I (21060) pppos_example: Waiting for MQTT data
D (21060) CDC_ACM: out/ctrl xfer cb
D (21170) CDC_ACM: in xfer cb
D (21170) usb_terminal: 0x3fca2b60 7e 21 45 00 00 55 83 b7 40 00 39 11 90 86 d9 0e |~!E..U..@.9.....|
D (21170) usb_terminal: 0x3fca2b70 a0 82 64 52 4f 77 00 35 4d 91 00 41 fd f5 20 92 |..dROw.5M..A.. .|
D (21180) usb_terminal: 0x3fca2b80 81 80 00 01 00 01 00 00 00 00 04 6d 71 74 74 0f |...........mqtt.|
D (21190) usb_terminal: 0x3fca2b90 65 63 6c 69 70 73 65 70 72 6f 6a 65 63 74 73 02 |eclipseprojects.|
D (21200) usb_terminal: 0x3fca2ba0 69 6f 00 00 01 00 01 c0 0c 00 01 00 01 00 01 46 |io.............F|
D (21210) usb_terminal: 0x3fca2bb0 bf 00 04 89 87 53 d9 19 db 7e |.....S...~|
D (21220) CDC_ACM: Submitting poll for BULK IN transfer
D (21220) esp-tls: [sock=54] Resolved IPv4 address: 137.135.83.217
D (21230) esp-tls: [sock=54] Connecting to server. HOST: mqtt.eclipseprojects.io, Port: 1883
D (21240) usb_terminal: 0x3fca6f6c 7e 21 45 00 00 2c 00 01 00 00 ff 06 2a a1 64 52 |~!E..,......*.dR|
D (21250) usb_terminal: 0x3fca6f7c 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 36 00 00 |Ow..S....[B..6..|
D (21250) usb_terminal: 0x3fca6f8c 00 00 60 02 16 70 28 3f 00 00 02 04 05 a0 7b bc |..`..p(?......{.|
D (21260) usb_terminal: 0x3fca6f9c 7e |~|
D (21270) CDC_ACM: Submitting BULK OUT transfer
D (21280) CDC_ACM: out/ctrl xfer cb
D (21480) CDC_ACM: in xfer cb
D (21480) usb_terminal: 0x3fca2b60 7e 21 45 04 00 2c 00 00 40 00 29 06 c0 9e 89 87 |~!E..,..@.).....|
D (21480) usb_terminal: 0x3fca2b70 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 30 42 1f |S.dROw.[.....0B.|
D (21490) usb_terminal: 0x3fca2b80 96 37 60 12 fa f0 ea 84 00 00 02 04 05 00 5d 25 |.7`...........]%|
D (21500) usb_terminal: 0x3fca2b90 7e |~|
D (21510) usb_terminal: 0x3fca7c08 7e 21 45 00 00 28 00 02 00 00 ff 06 2a a4 64 52 |~!E..(......*.dR|
D (21520) usb_terminal: 0x3fca7c18 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 37 d7 97 |Ow..S....[B..7..|
D (21530) usb_terminal: 0x3fca7c28 82 31 50 10 16 70 e6 0e 00 00 5d 8e 7e |.1P..p....].~|
D (21540) CDC_ACM: Submitting BULK OUT transfer
D (21540) CDC_ACM: Submitting poll for BULK IN transfer
D (21550) CDC_ACM: out/ctrl xfer cb
D (21550) mqtt_client: Transport connected to mqtt://mqtt.eclipseprojects.io:1883
D (21560) mqtt_client: Sending MQTT CONNECT message, type: 1, id: 0000
D (21560) usb_terminal: 0x3fca7468 7e 21 45 00 00 42 00 03 00 00 ff 06 2a 89 64 52 |~!E..B......*.dR|
D (21570) usb_terminal: 0x3fca7478 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 37 d7 97 |Ow..S....[B..7..|
D (21580) usb_terminal: 0x3fca7488 82 31 50 18 16 70 9b 03 00 00 10 18 00 04 4d 51 |.1P..p........MQ|
D (21590) usb_terminal: 0x3fca7498 54 54 04 02 00 78 00 0c 45 53 50 33 32 5f 63 32 |TT...x..ESP32_c2|
D (21600) usb_terminal: 0x3fca74a8 33 46 36 43 55 d7 7e |3F6CU.~|
D (21610) CDC_ACM: Submitting BULK OUT transfer
D (21620) CDC_ACM: out/ctrl xfer cb
D (21800) CDC_ACM: in xfer cb
D (21800) usb_terminal: 0x3fca2b60 7e 21 45 04 00 28 f2 1e 40 00 29 06 ce 83 89 87 |~!E..(..@.).....|
D (21810) usb_terminal: 0x3fca2b70 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 31 42 1f |S.dROw.[.....1B.|
D (21820) usb_terminal: 0x3fca2b80 96 51 50 10 fa d6 01 8e 00 00 f6 2e 7e |.QP.........~|
D (21830) CDC_ACM: Submitting poll for BULK IN transfer
D (21830) CDC_ACM: in xfer cb
D (21830) usb_terminal: 0x3fca2b60 7e 21 45 04 00 2c f2 1f 40 00 29 06 ce 7d 5e 89 |~!E..,..@.)..}^.|
D (21840) usb_terminal: 0x3fca2b70 87 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 31 42 |.S.dROw.[.....1B|
D (21850) usb_terminal: 0x3fca2b80 1f 96 51 50 18 fa d6 e1 7f 00 00 20 02 00 00 c0 |..QP....... ....|
D (21860) usb_terminal: 0x3fca2b90 f6 7e |.~|
D (21870) CDC_ACM: Submitting poll for BULK IN transfer
D (21870) mqtt_client: mqtt_message_receive: first byte: 0x20
D (21880) mqtt_client: mqtt_message_receive: read "remaining length" byte: 0x2
D (21890) mqtt_client: mqtt_message_receive: total message length: 4 (already read: 2)
D (21900) mqtt_client: mqtt_message_receive: read_len=2
D (21900) mqtt_client: mqtt_message_receive: transport_read():4 4
D (21910) mqtt_client: Connected
D (21910) event: running post MQTT_EVENTS:1 with handler 0x4200b608 and context 0x3fca49c4 on loop 0x3fca488c
0x4200b608: mqtt_event_handler at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:62
D (21920) pppos_example: Event dispatched from event loop base=MQTT_EVENTS, event_id=1
I (21930) pppos_example: MQTT_EVENT_CONNECTED
D (21930) mqtt_client: mqtt_enqueue id: 62788, type=8 successful
D (21940) outbox: ENQUEUE msgid=62788, msg_type=8, len=23, size=23
D (21950) usb_terminal: 0x3fca74e8 7e 21 45 00 00 3f 00 04 00 00 ff 06 2a 8b 64 52 |~!E..?......*.dR|
D (21960) usb_terminal: 0x3fca74f8 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 51 d7 97 |Ow..S....[B..Q..|
D (21970) usb_terminal: 0x3fca7508 82 35 50 18 16 6c b5 f9 00 00 82 15 f5 44 00 10 |.5P..l.......D..|
D (21980) usb_terminal: 0x3fca7518 2f 74 6f 70 69 63 2f 65 73 70 2d 70 70 70 6f 73 |/topic/esp-pppos|
D (21990) usb_terminal: 0x3fca7528 00 9e c9 7e |...~|
D (21990) CDC_ACM: Submitting BULK OUT transfer
D (22000) CDC_ACM: out/ctrl xfer cb
D (22000) mqtt_client: Sent subscribe topic=/topic/esp-pppos, id: 62788, type=8 successful
I (22010) pppos_example: sent subscribe successful, msg_id=62788
D (22040) CDC_ACM: in xfer cb
D (22040) usb_terminal: 0x3fca3c14 0d 0a 50 42 20 44 4f 4e 45 0d 0a |..PB DONE..|
D (22040) CDC_ACM: Submitting poll for BULK IN transfer
D (22170) CDC_ACM: in xfer cb
D (22170) usb_terminal: 0x3fca2b60 7e 21 45 04 00 28 f2 20 40 00 29 06 ce 81 89 87 |~!E..(. @.).....|
D (22170) usb_terminal: 0x3fca2b70 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 35 42 1f |S.dROw.[.....5B.|
D (22180) usb_terminal: 0x3fca2b80 96 68 50 10 fa bf 01 8a 00 00 e2 50 7e |.hP........P~|
D (22190) CDC_ACM: Submitting poll for BULK IN transfer
D (22190) CDC_ACM: in xfer cb
D (22200) usb_terminal: 0x3fca2b60 7e 21 45 04 00 2d f2 21 40 00 29 06 ce 7b 89 87 |~!E..-.!@.)..{..|
D (22210) usb_terminal: 0x3fca2b70 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 35 42 1f |S.dROw.[.....5B.|
D (22220) usb_terminal: 0x3fca2b80 96 68 50 18 fa bf 7c 34 00 00 90 03 f5 44 00 19 |.hP...|4.....D..|
D (22230) usb_terminal: 0x3fca2b90 70 7e |p~|
D (22230) CDC_ACM: Submitting poll for BULK IN transfer
D (22240) mqtt_client: mqtt_message_receive: first byte: 0x90
D (22250) usb_terminal: 0x3fca6fd4 7e 21 45 00 00 28 00 05 00 00 ff 06 2a a1 64 52 |~!E..(......*.dR|
D (22260) usb_terminal: 0x3fca6fe4 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 68 d7 97 |Ow..S....[B..h..|
D (22260) usb_terminal: 0x3fca6ff4 82 3a 50 10 16 67 e5 dd 00 00 69 cc 7e |.:P..g....i.~|
D (22270) CDC_ACM: Submitting BULK OUT transfer
D (22280) CDC_ACM: out/ctrl xfer cb
D (22280) mqtt_client: mqtt_message_receive: read "remaining length" byte: 0x3
D (22290) mqtt_client: mqtt_message_receive: total message length: 5 (already read: 2)
D (22300) mqtt_client: mqtt_message_receive: read_len=3
D (22300) mqtt_client: mqtt_message_receive: transport_read():5 5
D (22310) mqtt_client: msg_type=9, msg_id=62788
D (22310) mqtt_client: pending_id=62788, pending_msg_count = 1
D (22320) outbox: DELETED msgid=62788, msg_type=8, remain size=0
D (22330) mqtt_client: deliver_suback, message_length_read=5, message_length=5
D (22330) event: running post MQTT_EVENTS:3 with handler 0x4200b608 and context 0x3fca49c4 on loop 0x3fca488c
0x4200b608: mqtt_event_handler at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:62
D (22340) pppos_example: Event dispatched from event loop base=MQTT_EVENTS, event_id=3
I (22350) pppos_example: MQTT_EVENT_SUBSCRIBED, msg_id=62788
D (22360) usb_terminal: 0x3fca74a8 7e 21 45 00 00 47 00 06 00 00 ff 06 2a 81 64 52 |~!E..G......*.dR|
D (22370) usb_terminal: 0x3fca74b8 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 68 d7 97 |Ow..S....[B..h..|
D (22380) usb_terminal: 0x3fca74c8 82 3a 50 18 16 67 a1 63 00 00 30 1d 00 10 2f 74 |.:P..g.c..0.../t|
D (22390) usb_terminal: 0x3fca74d8 6f 70 69 63 2f 65 73 70 2d 70 70 70 6f 73 65 73 |opic/esp-ppposes|
D (22400) usb_terminal: 0x3fca74e8 70 33 32 2d 70 70 70 6f 73 fb 4d 7e |p32-pppos.M~|
D (22400) CDC_ACM: Submitting BULK OUT transfer
D (22410) CDC_ACM: out/ctrl xfer cb
I (22410) pppos_example: sent publish successful, msg_id=0
D (22610) CDC_ACM: in xfer cb
D (22610) usb_terminal: 0x3fca2b60 7e 21 45 04 00 28 f2 22 40 00 29 06 ce 7f 89 87 |~!E..(."@.).....|
D (22610) usb_terminal: 0x3fca2b70 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 3a 42 1f |S.dROw.[.....:B.|
D (22620) usb_terminal: 0x3fca2b80 96 87 50 10 fa a0 01 85 00 00 be bb 7e |..P.........~|
D (22630) CDC_ACM: Submitting poll for BULK IN transfer
D (22640) CDC_ACM: in xfer cb
D (22640) usb_terminal: 0x3fca2b60 7e 21 45 04 00 47 f2 23 40 00 29 06 ce 5f 89 87 |~!E..G.#@.).._..|
D (22650) usb_terminal: 0x3fca2b70 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 3a 42 1f |S.dROw.[.....:B.|
D (22660) usb_terminal: 0x3fca2b80 96 87 50 18 fa a0 bd 0a 00 00 30 1d 00 10 2f 74 |..P.......0.../t|
D (22670) usb_terminal: 0x3fca2b90 6f 70 69 63 2f 65 73 70 2d 70 70 70 6f 73 65 73 |opic/esp-ppposes|
D (22680) usb_terminal: 0x3fca2ba0 70 33 32 2d 70 70 70 6f 73 31 79 7e |p32-pppos1y~|
D (22690) CDC_ACM: Submitting poll for BULK IN transfer
D (22690) mqtt_client: mqtt_message_receive: first byte: 0x30
D (22700) mqtt_client: mqtt_message_receive: read "remaining length" byte: 0x1d
D (22710) mqtt_client: mqtt_message_receive: total message length: 31 (already read: 2)
D (22710) mqtt_client: mqtt_message_receive: read_len=29
D (22720) mqtt_client: mqtt_message_receive: transport_read():31 31
D (22720) mqtt_client: msg_type=3, msg_id=0
D (22730) mqtt_client: deliver_publish, message_length_read=31, message_length=31
D (22740) mqtt_client: deliver_publish: msg_topic_len=16
D (22740) mqtt_client: Get data len= 11, topic len=16, total_data: 11 offset: 0
D (22750) event: running post MQTT_EVENTS:6 with handler 0x4200b608 and context 0x3fca49c4 on loop 0x3fca488c
0x4200b608: mqtt_event_handler at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:62
D (22760) pppos_example: Event dispatched from event loop base=MQTT_EVENTS, event_id=6
I (22770) pppos_example: MQTT_EVENT_DATA
TOPIC=/topic/esp-pppos
DATA=esp32-pppos
D (22780) usb_terminal: 0x3fca6fa8 7e 21 45 00 00 28 00 07 00 00 ff 06 2a 9f 64 52 |~!E..(......*.dR|
D (22790) usb_terminal: 0x3fca6fb8 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 87 d7 97 |Ow..S....[B.....|
D (22800) usb_terminal: 0x3fca6fc8 82 59 50 10 16 48 e5 be 00 00 21 17 7e |.YP..H....!.~|
D (22800) CDC_ACM: Submitting BULK OUT transfer
D (22810) CDC_ACM: out/ctrl xfer cb
D (22810) usb_terminal: 0x3fca761c 7e 21 45 00 00 2a 00 08 00 00 ff 06 2a 9c 64 52 |~!E..*......*.dR|
D (22820) usb_terminal: 0x3fca762c 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 87 d7 97 |Ow..S....[B.....|
D (22830) usb_terminal: 0x3fca763c 82 59 50 18 16 48 05 b4 00 00 e0 00 e8 1e 7e |.YP..H........~|
D (22840) CDC_ACM: Submitting BULK OUT transfer
D (22850) CDC_ACM: out/ctrl xfer cb
D (23030) CDC_ACM: in xfer cb
D (23030) usb_terminal: 0x3fca2b60 7e 21 45 04 00 28 f2 24 40 00 29 06 ce 7d 5d 89 |~!E..(.$@.)..}].|
D (23030) usb_terminal: 0x3fca2b70 87 53 d9 64 52 4f 77 07 5b e8 b0 d7 97 82 59 42 |.S.dROw.[.....YB|
D (23040) usb_terminal: 0x3fca2b80 1f 96 89 50 11 fa 9e 01 65 00 00 95 4f 7e |...P....e...O~|
D (23050) usb_terminal: 0x3fca821c 7e 21 45 00 00 28 00 09 00 00 ff 06 2a 9d 64 52 |~!E..(......*.dR|
D (23060) usb_terminal: 0x3fca822c 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 89 d7 97 |Ow..S....[B.....|
D (23070) usb_terminal: 0x3fca823c 82 5a 50 10 16 47 e5 bc 00 00 c9 93 7e |.ZP..G......~|
D (23070) CDC_ACM: Submitting BULK OUT transfer
D (23080) CDC_ACM: Submitting poll for BULK IN transfer
D (23080) CDC_ACM: out/ctrl xfer cb
D (23090) usb_terminal: 0x3fca6f68 7e 21 45 00 00 28 00 0a 00 00 ff 06 2a 9c 64 52 |~!E..(......*.dR|
D (23100) usb_terminal: 0x3fca6f78 4f 77 89 87 53 d9 e8 b0 07 5b 42 1f 96 89 d7 97 |Ow..S....[B.....|
D (23110) usb_terminal: 0x3fca6f88 82 5a 50 11 16 47 e5 bb 00 00 63 6e 7e |.ZP..G....cn~|
D (23120) CDC_ACM: Submitting BULK OUT transfer
D (23120) CDC_ACM: out/ctrl xfer cb
D (23130) event: deleting loop 0x3fca488c
D (23130) esp_netif_handlers: esp_netif action stopped with netif0x3fc9e628 from event_id=0
D (23140) esp-netif_lwip-ppp: esp_netif_stop_ppp: Stopped PPP connection: 0x3fc9e938
D (23150) esp-netif_lwip-ppp: Phase Terminate
D (23150) esp-netif_lwip-ppp: Phase Network
D (23150) esp_netif_lwip: esp_netif_internal_dhcpc_cb lwip-netif:0x3fc9e6ac
D (23160) esp_netif_lwip: esp_netif_start_ip_lost_timer esp_netif:0x3fc9e628
D (23170) esp_netif_lwip: if0x3fc9e628 start ip lost tmr: interval=120
D (23170) esp-netif_lwip-ppp: Phase Establish
D (23180) usb_terminal: 0x3fca5428 7e ff 7d 23 c0 21 7d 25 7d 22 7d 20 7d 30 55 73 |~.}#.!}%}"} }0Us|
D (23190) usb_terminal: 0x3fca5438 65 72 20 72 65 71 75 65 73 74 53 33 7e |er requestS3~|
D (23200) CDC_ACM: Submitting BULK OUT transfer
D (23200) CDC_ACM: out/ctrl xfer cb
D (23210) CDC_ACM: in xfer cb
D (23210) usb_terminal: 0x3fca2b60 7e ff 7d 23 c0 21 7d 26 7d 22 7d 20 7d 24 94 7d |~.}#.!}&}"} }$.}|
D (23220) usb_terminal: 0x3fca2b70 2d 7e |-~|
D (23230) esp-netif_lwip-ppp: Phase Disconnect
D (23230) esp-netif_lwip-ppp: Phase Dead
I (23240) esp-netif_lwip-ppp: User interrupt
D (23240) event: running post NETIF_PPP_STATUS:5 with handler 0x4200b5cc and context 0x3fc9e608 on loop 0x3fc9d688
0x4200b5cc: on_ppp_changed at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/pppos_client/pppos_client_main.c:104
I (23250) pppos_example: PPP state changed event 5
I (23260) pppos_example: User interrupted event from netif:0x3fca3788
D (23260) event: running post NETIF_PPP_STATUS:5 with handler 0x420112fc and context 0x3fca31f0 on loop 0x3fc9d688
0x420112fc: esp_modem::Netif::on_ppp_changed(void*, char const*, long, void*) at /home/franz/git/hr/esp-protocols-tree-master-components-esp_modem-examples-pppos_client/pppos_client/components/esp_modem/src/esp_modem_netif.cpp:22
I (23270) esp_modem_netif: PPP state changed event 5
D (23280) CDC_ACM: Submitting poll for BULK IN transfer
D (23290) CDC_ACM: in xfer cb
D (23290) usb_terminal: 0x3fca3c1f 0d 0a 2b 50 50 50 44 3a 20 44 49 53 43 4f 4e 4e |..+PPPD: DISCONN|
D (23300) usb_terminal: 0x3fca3c2f 45 43 54 45 44 0d 0a |ECTED..|
D (23310) CDC_ACM: Submitting poll for BULK IN transfer
D (23310) CDC_ACM: in xfer cb
D (23320) usb_terminal: 0x3fca3c36 0d 0a 4e 4f 20 43 41 52 52 49 45 52 0d 0a |..NO CARRIER..|
D (23320) CDC_ACM: Submitting poll for BULK IN transfer
D (23330) esp_netif_lwip: check: remote, if=0x3fc9e628 fn=0x420241d8
0x420241d8: esp_netif_update_default_netif_lwip at /home/franz/esp-idf-v5.1.1/components/esp_netif/lwip/esp_netif_lwip.c:327
D (23340) esp_netif_lwip: esp_netif_update_default_netif_lwip 0x3fc9e628
V (23340) esp_netif_objects: esp_netif_next_unsafe 0x0
V (23350) esp_netif_lwip: esp_netif_is_netif_up esp_netif:0x3fc9e628
V (23350) esp_netif_objects: esp_netif_next_unsafe 0x3fc9e628
D (23360) esp_netif_lwip: call api in lwip: ret=0x0, give sem
V (26370) command_lib: set_command_mode
D (26370) command_lib: generic_command command +++
D (26370) usb_terminal: 0x3fc9a9ac 2b 2b 2b |+++|
D (26370) CDC_ACM: Submitting BULK OUT transfer
D (26380) CDC_ACM: out/ctrl xfer cb
D (26380) CDC_ACM: in xfer cb
D (26380) usb_terminal: 0x3fca3c44 2b 2b 2b |+++|
D (26390) CDC_ACM: Submitting poll for BULK IN transfer
V (32400) command_lib: sync
V (32400) command_lib: generic_command_common
V (32400) command_lib: generic_command
D (32400) command_lib: generic_command command AT
D (32400) usb_terminal: 0x3fc9a9fc 41 54 0d |AT.|
D (32410) CDC_ACM: Submitting BULK OUT transfer
D (32410) CDC_ACM: out/ctrl xfer cb
D (32420) CDC_ACM: in xfer cb
D (32420) usb_terminal: 0x3fca3c47 41 54 0d |AT.|
D (32430) CDC_ACM: Submitting poll for BULK IN transfer
D (32430) CDC_ACM: in xfer cb
D (32440) usb_terminal: 0x3fca3c4a 0d 0a 4f 4b 0d 0a |..OK..|
D (32450) command_lib: Response:
OK
D (32450) CDC_ACM: Submitting poll for BULK IN transfer
V (32460) command_lib: get_imsi
V (32460) command_lib: generic_get_string
V (32460) command_lib: generic_get_string
D (32470) usb_terminal: 0x3fc9aadc 41 54 2b 43 49 4d 49 0d |AT+CIMI.|
D (32480) CDC_ACM: Submitting BULK OUT transfer
D (32480) CDC_ACM: out/ctrl xfer cb
D (32490) CDC_ACM: in xfer cb
D (32490) usb_terminal: 0x3fca3c14 41 54 2b 43 49 4d 49 0d |AT+CIMI.|
D (32500) CDC_ACM: Submitting poll for BULK IN transfer
D (32500) CDC_ACM: in xfer cb
D (32500) usb_terminal: 0x3fca3c1c 0d 0a 39 30 31 32 38 38 30 30 35 36 38 31 39 34 |..90128800568194|
D (32510) usb_terminal: 0x3fca3c2c 37 0d 0a |7..|
} (32520) command_lib: Token: {
V (32530) command_lib: Token: {901288005681947}
D (32530) CDC_ACM: Submitting poll for BULK IN transfer
D (32540) CDC_ACM: in xfer cb
D (32540) usb_terminal: 0x3fca3c2f 0d 0a 4f 4b 0d 0a |..OK..|
} (32550) command_lib: Token: {
V (32550) command_lib: Token: {OK}
D (32550) CDC_ACM: Submitting poll for BULK IN transfer
I (32560) pppos_example: IMSI=901288005681947
I (32570) pppos_example: USB demo finished. Disconnect and connect the modem to run it again
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment