zephyrproject-rtos / zephyr

Primary Git Repository for the Zephyr Project. Zephyr is a new generation, scalable, optimized, secure RTOS for multiple hardware architectures.
https://docs.zephyrproject.org
Apache License 2.0
10.04k stars 6.18k forks source link

cellular_modem: Pinnacle 100 does not work with CONFIG_UART_INTERRUPT_DRIVEN #70498

Open rerickson1 opened 3 months ago

rerickson1 commented 3 months ago

Describe the bug When running samples/net/cellular_modem with board pinnacle_100_dvk and option CONFIG_UART_INTERRUPT_DRIVEN, the sample hangs.

To Reproduce Steps to reproduce the behavior:

  1. cd samples/net/cellular_modem
  2. change boards/pinnacle_100_dvk.conf to enable CONFIG_UART_INTERRUPT_DRIVEN instead of CONFIG_UART_ASYNC_API
  3. west build -p -b pinnacle_100_dvk
  4. west flash

Expected behavior Pinnacle 100 DVK should be able to run that sample with both UART APIs.

Impact This is an annoyance at this point.

Logs and console output Sample hangs at this point:

*** Booting Zephyr OS build v3.6.0-1209-g95040f35a779 ***
Powering on modem
Bring up network interface
Waiting for L4 connected
[00:00:10.352,447] <dbg> modem_chat: modem_chat_script_start: running script: swir_hl7800_init_chat_script
[00:00:10.352,478] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 0
[00:00:10.352,508] <dbg> modem_chat: modem_chat_script_next: sending: AT
[00:00:10.372,558] <dbg> modem_chat: modem_chat_on_unknown_command_received: KSUP: 0
[00:00:10.372,589] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:10.452,697] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 1
[00:00:10.452,728] <dbg> modem_chat: modem_chat_script_next: sending: AT
[00:00:10.474,029] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:10.552,886] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 2
[00:00:10.552,917] <dbg> modem_chat: modem_chat_script_next: sending: AT
[00:00:10.574,218] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:10.653,045] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 3
[00:00:10.653,076] <dbg> modem_chat: modem_chat_script_next: sending: AT
[00:00:10.674,285] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:10.753,234] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 4
[00:00:10.753,265] <dbg> modem_chat: modem_chat_script_next: sending: ATE0
[00:00:10.776,153] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:10.776,184] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 5
[00:00:10.776,214] <dbg> modem_chat: modem_chat_script_next: sending: AT+CFUN=1
[00:00:11.223,632] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.223,663] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 6
[00:00:11.223,693] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGACT=0
[00:00:11.223,785] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  2
[00:00:11.247,528] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.247,558] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 7
[00:00:11.247,589] <dbg> modem_chat: modem_chat_script_next: sending: AT+CFUN=4
[00:00:11.738,128] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.738,189] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 8
[00:00:11.738,220] <dbg> modem_chat: modem_chat_script_next: sending: AT+CMEE=1
[00:00:11.738,311] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  0
[00:00:11.762,939] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.762,969] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 9
[00:00:11.763,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CREG=1
[00:00:11.786,590] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.786,621] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 10
[00:00:11.786,651] <dbg> modem_chat: modem_chat_script_next: sending: AT+CEREG=1
[00:00:11.810,455] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.810,485] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 11
[00:00:11.810,516] <dbg> modem_chat: modem_chat_script_next: sending: AT+CREG?
[00:00:11.833,099] <dbg> modem_chat: modem_chat_log_received_command: +CREG:  1 0
[00:00:11.833,160] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.833,190] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 12
[00:00:11.833,221] <dbg> modem_chat: modem_chat_script_next: sending: AT+CEREG?
[00:00:11.855,468] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  1 0
[00:00:11.855,529] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.855,560] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 13
[00:00:11.855,590] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGSN
[00:00:11.877,380] <dbg> modem_chat: modem_chat_log_received_command:  354616090299517
[00:00:11.877,410] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 14
[00:00:11.877,471] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.877,502] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 15
[00:00:11.877,532] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGMM
[00:00:11.899,871] <dbg> modem_chat: modem_chat_log_received_command:  HL7800
[00:00:11.899,902] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 16
[00:00:11.899,932] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.899,963] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 17
[00:00:11.899,993] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGMI
[00:00:11.922,302] <dbg> modem_chat: modem_chat_log_received_command:  Sierra Wireless
[00:00:11.922,332] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 18
[00:00:11.922,393] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.922,424] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 19
[00:00:11.922,454] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGMR
[00:00:11.944,213] <dbg> modem_chat: modem_chat_log_received_command:  HL7800.4.7.1.0
[00:00:11.944,244] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 20
[00:00:11.944,305] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.944,335] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 21
[00:00:11.944,366] <dbg> modem_chat: modem_chat_script_next: sending: AT+CIMI
[00:00:11.966,125] <dbg> modem_chat: modem_chat_log_received_command:  001010123456789
[00:00:11.966,156] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 22
[00:00:11.966,217] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:11.966,247] <dbg> modem_chat: modem_chat_script_next: swir_hl7800_init_chat_script: step: 23
[00:00:11.966,278] <dbg> modem_chat: modem_chat_script_next: sending: AT+CMUX=0,0,5,127
[00:00:11.966,339] <dbg> modem_chat: modem_chat_script_stop: swir_hl7800_init_chat_script: complete
bjarki-andreasen commented 3 months ago

Could you enable CONFIG_MODEM_LOG_LEVEL_DBG=y and run the sample? I would like to know what state the modem driver is in :)

github-actions[bot] commented 1 month ago

This issue has been marked as stale because it has been open (more than) 60 days with no activity. Remove the stale label or add a comment saying that you would like to have the label removed otherwise this issue will automatically be closed in 14 days. Note, that you can always re-open a closed issue at any time.