No WDSI notification received

IoT Modules Legacy HL Series
1

I’m going through the HL78xx FOTA Guidelines (r5.pdf) to set up FOTA over AirVantage. The issue is, I’m not seeing any WDSI notifications (like +WDSI: 4, +WDSI: 7, etc.).

I’ve captured a log of all the AT commands I sent. Now I’m wondering, does the order I run these AT commands actually affect whether the WDSI indications show up?

[00:00:00.000,000] <dbg> hl78xx_dev: mdm_gpio6_callback_isr: GPIO6 ISR callback gpio@42020000 8 0
[00:00:00.000,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:00.000,000] <dbg> hl78xx_dev: hl78xx_log_event: event resume
[00:00:00.000,000] <inf> hl78xx_dev: switch from idle to await power on
*** Booting Zephyr OS build v4.2.0-3896-g39bc2584dee2 ***
[00:00:00.001,000] <inf> main: Waiting for network connection...
[00:00:01.000,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:01.000,000] <dbg> hl78xx_dev: hl78xx_log_event: event timeout
[00:00:01.000,000] <inf> hl78xx_dev: switch from await power on to run init script
[00:00:01.000,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:01.000,000] <dbg> hl78xx_dev: hl78xx_log_event: event bus opened
[00:00:01.001,000] <dbg> modem_chat: modem_chat_script_start: running script: hl78xx_init_chat_script
[00:00:01.001,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 0
[00:00:03.702,000] <dbg> hl78xx_dev: mdm_gpio6_callback_isr: GPIO6 ISR callback gpio@42020000 8 1
[00:00:03.952,000] <dbg> modem_chat: modem_chat_log_received_command: +WDSI:  0
[00:00:04.061,000] <dbg> modem_chat: modem_chat_log_received_command: +KSUP:  0
[00:00:04.061,000] <dbg> hl78xx_dev: hl78xx_on_ksup: Module status: 0
[00:00:04.061,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 1
[00:00:04.061,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KHWIOCFG=3,1,6
[00:00:04.061,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 3
[00:00:04.061,000] <inf> main: 158 HL78XX modem startup status: Module is ready to receive commands. No access code required.
[00:00:04.097,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.097,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 2
[00:00:04.097,000] <dbg> modem_chat: modem_chat_script_next: sending: ATE0
[00:00:04.131,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.131,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 3
[00:00:04.131,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGACT=0
[00:00:04.165,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.165,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 4
[00:00:04.165,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CFUN=4,0
[00:00:04.202,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.202,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 5
[00:00:04.202,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KSLEEP=2
[00:00:04.237,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.237,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 6
[00:00:04.237,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CPSMS=0
[00:00:04.272,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.272,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 7
[00:00:04.272,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CEDRXS=0
[00:00:04.308,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.308,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 8
[00:00:04.308,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KPATTERN="--EOF--Pattern--"
[00:00:04.351,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.351,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 9
[00:00:04.351,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CCID
[00:00:04.445,000] <dbg> modem_chat: modem_chat_log_received_command: +CCID:  89882390000304618096
[00:00:04.445,000] <dbg> hl78xx_dev: hl78xx_on_iccid: ICCID: +CCID:  89882390000304618096
[00:00:04.445,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 10
[00:00:04.445,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CMEE=1
[00:00:04.445,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:04.480,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.480,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 11
[00:00:04.480,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGSN
[00:00:04.515,000] <dbg> modem_chat: modem_chat_log_received_command:  351144441214500
[00:00:04.515,000] <dbg> hl78xx_dev: hl78xx_on_imei: IMEI:  351144441214500
[00:00:04.515,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 12
[00:00:04.515,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.515,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 13
[00:00:04.515,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGMM
[00:00:04.550,000] <dbg> modem_chat: modem_chat_log_received_command:  HL7812
[00:00:04.550,000] <dbg> hl78xx_dev: hl78xx_on_cgmm: cgmm:  HL7812
[00:00:04.550,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 14
[00:00:04.550,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.550,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 15
[00:00:04.550,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGMI
[00:00:04.586,000] <dbg> modem_chat: modem_chat_log_received_command:  Sierra Wireless
[00:00:04.586,000] <dbg> hl78xx_dev: hl78xx_on_cgmi: cgmi:  Sierra Wireless
[00:00:04.586,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 16
[00:00:04.586,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.586,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 17
[00:00:04.586,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGMR
[00:00:04.621,000] <dbg> modem_chat: modem_chat_log_received_command:  HL7812.5.7.3.0
[00:00:04.621,000] <dbg> hl78xx_dev: hl78xx_on_cgmr: cgmr:  HL7812.5.7.3.0
[00:00:04.621,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 18
[00:00:04.621,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.621,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 19
[00:00:04.621,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CIMI
[00:00:04.655,000] <dbg> modem_chat: modem_chat_log_received_command:  901288820006464
[00:00:04.655,000] <dbg> hl78xx_dev: hl78xx_on_imsi: IMSI:  901288820006464
[00:00:04.655,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 20
[00:00:04.655,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.655,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 21
[00:00:04.655,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KSTATEV=1
[00:00:04.689,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.689,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 22
[00:00:04.689,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGEREP=2
[00:00:04.725,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.725,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 23
[00:00:04.725,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KSELACQ?
[00:00:04.761,000] <dbg> modem_chat: modem_chat_log_received_command: +KSELACQ:  0
[00:00:04.761,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 24
[00:00:04.761,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KSRAT?
[00:00:04.761,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:04.795,000] <dbg> modem_chat: modem_chat_log_received_command: +KSRAT:  1
[00:00:04.795,000] <dbg> hl78xx_dev: hl78xx_on_ksrat: KSRAT: +KSRAT:  1
[00:00:04.796,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 25
[00:00:04.796,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KBNDCFG?
[00:00:04.796,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:04.796,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 0
[00:00:04.796,000] <inf> main: 151 HL78XX modem rat mode changed: 1
[00:00:04.838,000] <dbg> modem_chat: modem_chat_log_received_command: +KBNDCFG:  0 0000000000000000000000000000000000000000000000000000000000000814
[00:00:04.838,000] <dbg> hl78xx_dev: hl78xx_on_kbndcfg: 463 3 [+KBNDCFG: ] [0] [0000000000000000000000000000000000000000000000000000000000000814]
[00:00:04.849,000] <dbg> modem_chat: modem_chat_log_received_command: +KBNDCFG:  1 000000000000000000000000000000000000000000000000000000000808189F
[00:00:04.849,000] <dbg> hl78xx_dev: hl78xx_on_kbndcfg: 463 3 [+KBNDCFG: ] [1] [000000000000000000000000000000000000000000000000000000000808189F]
[00:00:04.849,000] <dbg> modem_chat: modem_chat_log_received_command: +KBNDCFG:  2 0
[00:00:04.849,000] <dbg> hl78xx_dev: hl78xx_on_kbndcfg: 463 3 [+KBNDCFG: ] [2] [0]
[00:00:04.882,000] <dbg> modem_chat: modem_chat_log_received_command: +KBNDCFG:  3 C000000000000000000000000000000000000000000000000000000000400000
[00:00:04.882,000] <dbg> hl78xx_dev: hl78xx_on_kbndcfg: 463 3 [+KBNDCFG: ] [3] [C000000000000000000000000000000000000000000000000000000000400000]
[00:00:04.882,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.882,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 26
[00:00:04.882,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+WDSI=4479
[00:00:04.920,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.920,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 27
[00:00:04.920,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+WDSC=0,1
[00:00:04.964,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:04.964,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 28
[00:00:04.964,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+WDSC=1,1
[00:00:06.089,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:06.089,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 29
[00:00:06.089,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+WDSC=2,1
[00:00:06.133,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:06.133,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 30
[00:00:06.133,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGACT?
[00:00:06.170,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +CGACT: 1,0
[00:00:06.170,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +CGACT: 2,0
[00:00:06.170,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:06.170,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 31
[00:00:06.170,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CREG=0
[00:00:06.877,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:06.877,000] <dbg> modem_chat: modem_chat_script_next: hl78xx_init_chat_script: step: 32
[00:00:06.877,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CEREG=5
[00:00:06.914,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:06.914,000] <dbg> modem_chat: modem_chat_script_stop: hl78xx_init_chat_script: complete
[00:00:06.914,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:06.914,000] <dbg> hl78xx_dev: hl78xx_log_event: event script success
[00:00:06.914,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:06.914,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:06.914,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KSRAT?
[00:00:06.952,000] <dbg> modem_chat: modem_chat_log_received_command: +KSRAT:  1
[00:00:06.952,000] <dbg> hl78xx_dev: hl78xx_on_ksrat: KSRAT: +KSRAT:  1
[00:00:06.952,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:06.952,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:06.952,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:06.952,000] <inf> hl78xx_dev: Default band config: 0808189F
[00:00:06.952,000] <inf> hl78xx_dev: switch from run init script to run rat cfg script
[00:00:06.952,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:06.952,000] <dbg> hl78xx_dev: hl78xx_log_event: event script success
[00:00:06.952,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 0
[00:00:06.952,000] <inf> main: 151 HL78XX modem rat mode changed: 1
[00:00:06.952,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:06.952,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:06.952,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CFUN=4,0
[00:00:06.986,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:06.986,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:06.986,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:06.986,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:06.986,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:06.986,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGDCONT=1,"IPV4V6",""
[00:00:07.028,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:07.028,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:07.028,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:07.028,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:07.028,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:07.028,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KCNXCFG=1,"GPRS","",,,"IPV4V6"
[00:00:07.080,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:07.080,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:07.080,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:07.080,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:07.080,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:07.080,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+WDSS=2,1
[00:00:08.129,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:08.129,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:08.129,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:08.129,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:08.129,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:08.129,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CFUN=1,0
[00:00:08.191,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:08.191,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:08.191,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  2
[00:00:08.191,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 2
[00:00:08.191,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:08.191,000] <inf> hl78xx_dev: switch from run rat cfg script to run enable gprs script
[00:00:08.191,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 2 events
[00:00:08.192,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:00:08.192,000] <dbg> hl78xx_dev: hl78xx_log_event: event script success
[00:00:08.192,000] <inf> hl78xx_dev: switch from run enable gprs script to await registered
[00:00:08.192,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:00:08.192,000] <inf> main: 154 HL78XX modem registration status: 2
[00:00:08.192,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  0 1
[00:00:13.505,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  0
[00:00:13.505,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 0
[00:00:13.505,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  2 1
[00:00:13.505,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem entered camped state on a suitable or acceptable cell
[00:00:13.505,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:13.505,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:00:13.505,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:00:13.506,000] <inf> main: 154 HL78XX modem registration status: 0
[00:00:13.506,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  2
[00:00:13.506,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 2
[00:00:13.506,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  3 1
[00:00:13.506,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem successfully established a connection to the network
[00:00:13.506,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:13.506,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:00:13.506,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:00:13.506,000] <inf> main: 154 HL78XX modem registration status: 2
[00:00:13.820,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  5 1
[00:00:13.820,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem has established an RRC connection with the network
[00:00:15.381,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  2       "00101000"
[00:00:15.381,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 2
[00:00:15.452,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +CGEV: ME PDN ACT 1
[00:00:15.452,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  5 "2332" "02E82221" 9    "00101000"
[00:00:15.452,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 5
[00:00:15.452,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:15.452,000] <dbg> hl78xx_dev: hl78xx_log_event: event registered
[00:00:15.452,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:00:15.452,000] <inf> main: 154 HL78XX modem registration status: 5
[00:00:15.452,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:15.452,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:15.452,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGCONTRDP=1
[00:00:15.506,000] <dbg> modem_chat: modem_chat_log_received_command: +CGCONTRDP:  1 5 "xxxxxxxxodiot.mnc028.mcc901.gprs" 10.149.141.215.255.255.255.240 10.149.141.209 141.1.1.1 195.27.1.1        
[00:00:15.506,000] <inf> hl78xx_socket: Apn="xxxxxxxxodiot.mnc028.mcc901.gprs"
[00:00:15.506,000] <inf> hl78xx_socket: Addr=10.149.141.215.255.255.255.240
[00:00:15.506,000] <inf> hl78xx_socket: Gw=10.149.141.209
[00:00:15.506,000] <inf> hl78xx_socket: DNS=141.1.1.1
[00:00:15.506,000] <dbg> hl78xx_socket: split_ipv4_and_subnet: Extracted IP: 10.149.141.215, Subnet: 255.255.255.240
[00:00:15.506,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 10.149.141.215 -> OK
[00:00:15.506,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 255.255.255.240 -> OK
[00:00:15.506,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 10.149.141.209 -> OK
[00:00:15.506,000] <dbg> hl78xx_socket: update_dns: Updating DNS (IPv4): 141.1.1.1
[00:00:15.506,000] <dbg> hl78xx_socket: update_dns: New IPv4 DNS differs from current, marking dns_ready = false
[00:00:15.506,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 141.1.1.1 -> OK
[00:00:15.506,000] <dbg> hl78xx_socket: set_iface: Setting IPv4 interface address...
[00:00:15.506,000] <dbg> hl78xx_socket: set_iface: IPv4 interface configuration complete.
[00:00:15.506,000] <dbg> hl78xx_socket: hl78xx_on_cgdcontrdp: CGCONTRDP processed, dns strings: v4=141.1.1.1 v6=<no-v6>
[00:00:15.506,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:15.506,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:15.506,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:15.506,000] <inf> hl78xx_dev: switch from await registered to carrier on
[00:00:15.506,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:15.506,000] <dbg> hl78xx_dev: hl78xx_log_event: event script success
[00:00:17.506,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:00:17.506,000] <dbg> hl78xx_dev: hl78xx_log_event: event timeout
[00:00:17.506,000] <dbg> hl78xx_socket: dns_work_cb: Resetting DNS resolver
[00:00:17.506,000] <dbg> hl78xx_socket: dns_work_cb: Refresh DNS resolver
[00:00:17.506,000] <dbg> hl78xx_socket: offload_socket: 1542 1 2 17
[00:00:17.506,000] <dbg> hl78xx_socket: offload_bind: entry for socket fd=4 id=7
[00:00:17.506,000] <dbg> hl78xx_socket: create_socket: entry fd=4 id=7
[00:00:17.506,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:17.506,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:17.506,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KUDPCFG=1,0,,2,,,0,0
[00:00:17.545,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KUDPCFG: 1
[00:00:17.593,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:00:17.593,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,1,0
[00:00:18.610,000] <dbg> modem_chat: modem_chat_log_received_command: +KUDP_IND:  1 1
[00:00:18.610,000] <dbg> hl78xx_socket: hl78xx_on_kudpsocket_create: Assigned modem socket id 1 to fd 4
[00:00:18.610,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:18.610,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:18.610,000] <dbg> hl78xx_socket: create_socket: send_udp_config returned 0
[00:00:18.610,000] <dbg> hl78xx_socket: offload_bind: create_socket returned 0
[00:00:18.610,000] <dbg> hl78xx_socket: dns_work_cb: DNS ready
[00:00:18.610,000] <inf> main: IP Up
[00:00:18.610,000] <inf> main: Connected to network
[00:00:18.610,000] <dbg> hl78xx_apis: hl78xx_api_func_get_registration_status: Requested tech: 7, current rat mode: 1 REG: 5 7
[00:00:18.610,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:18.610,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:18.610,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CESQ
[00:00:18.647,000] <dbg> modem_chat: modem_chat_log_received_command: +CESQ:  99 99 255 255 19 40
[00:00:18.647,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:18.647,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:18.647,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:18.647,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:18.647,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:18.647,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+COPS?
[00:00:18.683,000] <dbg> modem_chat: modem_chat_log_received_command: +COPS:  0 0 "Vodafone" 9
[00:00:18.683,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:18.683,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:18.683,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.

**********************************************************
********* Hello HL78XX Modem Sample Application **********
**********************************************************
[00:00:18.683,000] <inf> main: Manufacturer: Sierra Wireless
[00:00:18.683,000] <inf> main: Firmware Version: HL7812.5.7.3.0
[00:00:18.683,000] <inf> main: APN: "xxxxxxxxodiot"
[00:00:18.683,000] <inf> main: Imei: 351144441214500
[00:00:18.683,000] <inf> main: RAT: NB1
[00:00:18.683,000] <inf> main: Connection status: Roaming Network(5)
[00:00:18.683,000] <inf> main: RSRP : -100
[00:00:18.683,000] <inf> main: Operator: "Vodafone"
**********************************************************

[00:00:18.683,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:18.683,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:18.683,000] <dbg> modem_chat: modem_chat_script_next: sending: AT
[00:00:18.716,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:18.716,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:18.716,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:18.716,000] <inf> main: New APN: xxxxxxxxodiot
[00:00:18.716,000] <inf> main: Test endpoint: flake.legato.io:6000
[00:00:18.716,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:18.716,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:18.716,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KUDPSND=1,"141.1.1.1",53,33
[00:00:18.761,000] <dbg> modem_chat: modem_chat_log_received_command: CONNECT
[00:00:18.761,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:18.761,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:18.761,000] <dbg> hl78xx_socket: send_data_buffer: waiting for TX semaphore (offset=0 len=33)
[00:00:18.764,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:18.764,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:18.802,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:18.802,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:18.802,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:19.745,000] <dbg> modem_chat: modem_chat_log_received_command: +KUDP_DATA:  1 49
[00:00:19.745,000] <dbg> hl78xx_socket: hl78xx_on_socknotifydata: 335 1 49
[00:00:19.745,000] <dbg> hl78xx_socket: offload_recvfrom: 1854 socket_fd: 4, socket_id: 1, expected_data_len: 73
[00:00:19.745,000] <dbg> hl78xx_socket: offload_recvfrom: sending
                                        41 54 2b 4b 55 44 50 52  43 56 3d 31 2c 34 39 0d |AT+KUDPR CV=1,49.
                                        0a                                               |.                
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: Received bytes:
                                        0d 0a 43 4f 4e 4e 45 43  54 0d 0a 5a 38 81 80 00 |..CONNEC T..Z8...
                                        01 00 01 00 00 00 00 05  66 6c 61 6b 65 06 6c 65 |........ flake.le
[00:00:19.766,000] <dbg> hl78xx_socket: socket_process_bytes: CONNECT matched. Expecting 73 more bytes.
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: post-process state=1 recv_len=32 recv_buf.len=21 expected=50 collected=0 socket_data_received=0
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: Received bytes:
                                        67 61 74 6f 02 69 6f 00  00 01 00 01 c0 0c 00 01 |gato.io. ........
                                        00 01 00 00 01 2c 00 04  14 1d df 05 2d 2d 45 4f |.....,.. ....--EO
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: post-process state=1 recv_len=32 recv_buf.len=53 expected=18 collected=0 socket_data_received=0
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: Received bytes:
                                        46 2d 2d 50 61 74 74 65  72 6e 2d 2d 0d 0a 4f 4b |F--Patte rn--..OK
                                        0d 0a                                            |..               
[00:00:19.766,000] <dbg> hl78xx_socket: handle_eof_pattern: pushed 49 bytes to ring_buf; collected_buf_len(before)=0
[00:00:19.766,000] <dbg> hl78xx_socket: handle_eof_pattern: parser_socket_data_received=1 collected_buf_len(after)=49
[00:00:19.766,000] <dbg> hl78xx_socket: socket_process_bytes: OK matched. parser_ok_detected=1 parser_socket_data_received=1 collected=49
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: post-process state=2 recv_len=18 recv_buf.len=0 expected=2 collected=49 socket_data_received=1
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: All data received: 4 bytes
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: About to give RX semaphore (eof=1 ok=1 socket_data_received=1 collected=49)
[00:00:19.766,000] <dbg> hl78xx_socket: modem_process_handler: No more data expected
[00:00:19.766,000] <dbg> hl78xx_socket: on_cmd_sockread_common: Received Data:
                                        5a 38 81 80 00 01 00 01  00 00 00 00 05 66 6c 61 |Z8...... .....fla
                                        6b 65 06 6c 65 67 61 74  6f 02 69 6f 00 00 01 00 |ke.legat o.io....
                                        01 c0 0c 00 01 00 01 00  00 01 2c 00 04 14 1d df |........ ..,.....
                                        05                                               |.                
[00:00:19.766,000] <inf> main: Resolved: 20.29.223.5:6000
[00:00:19.766,000] <inf> main: Starting AirVantage DM session...
[00:00:19.766,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:00:19.766,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:00:19.766,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+WDSS=1,1
[00:00:19.796,000] <dbg> modem_chat: modem_chat_log_received_command: +KUDP_RCV:  "141.1.1.1" 53
[00:00:19.796,000] <dbg> hl78xx_socket: hl78xx_on_udprcv: 574 3 [+KUDP_RCV: ] ["141.1.1.1"] [53]
[00:00:48.251,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:00:48.251,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:00:48.251,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:00:48.251,000] <inf> main: Sample application finished.
[00:01:26.131,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  2 1
[00:01:26.131,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem entered camped state on a suitable or acceptable cell
[00:01:27.129,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  3 1
[00:01:27.129,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem successfully established a connection to the network
[00:01:27.415,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  5 1
2

Have you setup the APN correcy for profile 1?
How about you directly type at+wdss=1,1 after power cycle the module and module get registered to network?

3

Sorry, could you please elaborate on this? My general approach here for APN, as it seen in the log, is using a blank apn to get it from the network:

while the modem is in airplane mode: im setting:

  1. AT+CGDCONT=1,“IPV4V6”,“”

  2. AT+KCNXCFG=1,“GPRS”,“”,“IPV4V6”

and all good, I can see the correct apn (xxxxxxxxodiot.mnc028.mcc901.gprs) when I run AT+CGCONTRDP=1

my profiles:
[01:06:02.643,000] modem_chat: modem_chat_script_next: sending: AT&V
[01:06:02.713,000] modem_chat: modem_chat_log_received_command: ACTIVE PROFILE:
[01:06:02.724,000] modem_chat: modem_chat_log_received_command: E0 Q0 V1 X4 &C1 &D1 &R1 &S0 +IFC=2,2 &K3 +IPR=115200 +FCLASS0
[01:06:02.731,000] modem_chat: modem_chat_log_received_command: S00:0 S01:0 S03:13 S04:10 S05:8 S07:255 S08:0 S10:1
[01:06:02.738,000] modem_chat: modem_chat_log_received_command: STORED PROFILE 0:
[01:06:02.742,000] modem_chat: modem_chat_log_received_command: E0 Q0 V1 X4 &C1 &D1 &R1 &S0 +IFC=2,2 &K3 +IPR=115200 +FCLASS0
[01:06:02.750,000] modem_chat: modem_chat_log_received_command: S00:0 S01:0 S03:13 S04:10 S05:8 S07:255 S08:0 S10:1
[01:06:02.757,000] modem_chat: modem_chat_log_received_command: STORED PROFILE 1:
[01:06:02.761,000] modem_chat: modem_chat_log_received_command: E0 Q0 V1 X4 &C1 &D1 &R1 &S0 +IFC=2,2 &K3 +IPR=115200 +FCLASS0

Do I need to set this APN to somewhere?

I ran the command after resetting the modem. But no, I still haven’t got anything.(except the +WDSI: 0 before ksup: 0)

4

Other user does not find problem on receiving wdsi notification

Btw, you might also need to check if private network is being used:

5

Yeah, I thought this is the fix for me, but unfortunately this also didn’t work for me.

I added these IP addresses into my network allow list: UFOTA and AirVantage Platform 52.17.142.62 and 52.24.215.63 (for LWM2M bootstrap server).

Could this be a problem with HL7812.5.7.3.0 FW version? or What else I can try to debug it

Here is the list of at commands I am running sequentially:

sending: AT+WDSI=4479

sending: AT+WDSC=0,1

sending: AT+WDSC=1,1

sending: AT+WDSC=2,1

sending: AT+WDSS=2,1

sending: AT+WDSS=1,1

6

You can try the same as this user

You might also see here on how to capture wireshark log

7

it doesnt say anything about the configs he’s done, really.

BTW, something just happened; now the modem started throwing these URCs:
I switched to the RAT 3 to test ntn and then switch back to the nbiot: rat 1

now I see these URCs. Weird, could it be a coincidence?

[00:06:32.786,000\] <dbg> modem_chat: modem_chat_log_received_command: +WDSI:  7
[00:06:33.889,000\] <dbg> modem_chat: modem_chat_log_received_command: +WDSI:  8

Ill do this as a next step.

----------------------------------UPDATE-----------
Now I restarted the modem; again, its the same issue—no URCs from the modem. It worked when I had the rat switch.

8

how about AT+CFUN=0 and then AT+CFUN=1 ?

How about using the same firmware as previous user?

9

What do you mean? I am always using the same fw. Just had a rat switch.

Nice thing, I saw wdsi: 8 URC right after cfun=0, but nothing else than:

uart:~$ m> modem at AT+cfun=0
odem at AT+cfun=0
OK
[00:03:01.722,000] <dbg> modem_chat: modem_chat_script_start: running script: at_shell_script
[00:03:01.722,000] <dbg> modem_chat: modem_chat_script_next: at_shell_script: step: 0
[00:03:01.722,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+cfun=0
[00:03:02.492,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:03:02.494,000] <dbg> modem_chat: modem_chat_script_stop: at_shell_script: complete
[00:03:02.494,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  0       "00101000"
[00:03:02.494,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 0
[00:03:02.494,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +CGEV: ME DETACH
[00:03:02.494,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:02.494,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 7 in state: carrier on
[00:03:02.494,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:03:02.494,000] <inf> hl78xx_dev: switch from carrier on to await registered
[00:03:02.494,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:03:02.494,000] <inf> main: 154 HL78XX modem registration status: 0
[00:03:02.495,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  0       "00101000"
[00:03:02.495,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 0
[00:03:02.535,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KUDP_NOTIF: 1,0
[00:03:02.535,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,5,30
[00:03:02.536,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,0,1
[00:03:02.536,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,0,0
[00:03:02.628,000] <dbg> modem_chat: modem_chat_log_received_command: +WDSI:  8
uart:~$ > modem at AT+cfun=1
modem at AT+cfun=1
OK
[00:03:07.715,000] <dbg> modem_chat: modem_chat_script_start: running script: at_shell_script
[00:03:07.715,000] <dbg> modem_chat: modem_chat_script_next: at_shell_script: step: 0
[00:03:07.715,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+cfun=1
[00:03:08.361,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:03:08.363,000] <dbg> modem_chat: modem_chat_script_stop: at_shell_script: complete
[00:03:08.363,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  2       "00101000"
[00:03:08.363,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 2
[00:03:08.363,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:08.363,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 7 in state: await registered
[00:03:08.363,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:03:08.363,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:03:08.363,000] <inf> main: 154 HL78XX modem registration status: 2
[00:03:08.392,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  0 1
[00:03:11.143,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  0       "00101000"
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 0
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 7 in state: await registered
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:03:11.143,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:03:11.143,000] <inf> main: 154 HL78XX modem registration status: 0
[00:03:11.143,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  2 1
[00:03:11.143,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem entered camped state on a suitable or acceptable cell
[00:03:11.143,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  2       "00101000"
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 2
[00:03:11.143,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  3 1
[00:03:11.143,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem successfully established a connection to the network
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 7 in state: await registered
[00:03:11.143,000] <dbg> hl78xx_dev: hl78xx_log_event: event deregistered
[00:03:11.143,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:03:11.143,000] <inf> main: 154 HL78XX modem registration status: 2
[00:03:11.390,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  5 1
[00:03:11.390,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem has established an RRC connection with the network
[00:03:12.284,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +CGEV: ME PDN ACT 1
[00:03:12.284,000] <dbg> modem_chat: modem_chat_log_received_command: +CEREG:  5 "2332" "02E9F81F" 9    "00101000"
[00:03:12.284,000] <dbg> hl78xx_dev: hl78xx_on_cxreg: +CEREG: : 5
[00:03:12.284,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:12.284,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 6 in state: await registered
[00:03:12.284,000] <dbg> hl78xx_dev: hl78xx_log_event: event registered
[00:03:12.284,000] <dbg> main: evnt_listener: 146 HL78XX modem Event Received: 1
[00:03:12.284,000] <inf> main: 154 HL78XX modem registration status: 5
[00:03:12.284,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,1,0
[00:03:12.284,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:03:12.284,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:03:12.284,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+CGCONTRDP=1
[00:03:12.284,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KUDP_IND: 1,1
[00:03:12.330,000] <dbg> modem_chat: modem_chat_log_received_command: +CGCONTRDP:  1 5 "netfeasavodiot.mnc028.mcc901.gprs" 10.149.146.94.255.255.255.252 10.149.146.93 141.1.1.1 195.27.1.1        
[00:03:12.330,000] <inf> hl78xx_socket: Apn="netfeasavodiot.mnc028.mcc901.gprs"
[00:03:12.330,000] <inf> hl78xx_socket: Addr=10.149.146.94.255.255.255.252
[00:03:12.330,000] <inf> hl78xx_socket: Gw=10.149.146.93
[00:03:12.330,000] <inf> hl78xx_socket: DNS=141.1.1.1
[00:03:12.330,000] <dbg> hl78xx_socket: split_ipv4_and_subnet: Extracted IP: 10.149.146.94, Subnet: 255.255.255.252
[00:03:12.330,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 10.149.146.94 -> OK
[00:03:12.330,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 255.255.255.252 -> OK
[00:03:12.330,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 10.149.146.93 -> OK
[00:03:12.330,000] <dbg> hl78xx_socket: update_dns: Updating DNS (IPv4): 141.1.1.1
[00:03:12.331,000] <dbg> hl78xx_socket: parse_ip: Parsing IPv4 address: 141.1.1.1 -> OK
[00:03:12.331,000] <dbg> hl78xx_socket: set_iface: Setting IPv4 interface address...
[00:03:12.331,000] <dbg> hl78xx_socket: set_iface: IPv4 interface configuration complete.
[00:03:12.331,000] <dbg> hl78xx_socket: hl78xx_on_cgdcontrdp: CGCONTRDP processed, dns strings: v4=141.1.1.1 v6=<no-v6>
[00:03:12.331,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:03:12.331,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:03:12.331,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:03:12.331,000] <inf> hl78xx_dev: switch from await registered to carrier on
[00:03:12.331,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:12.331,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 2 in state: carrier on
[00:03:12.331,000] <dbg> hl78xx_dev: hl78xx_log_event: event script success
[00:03:14.331,000] <dbg> hl78xx_dev: hl78xx_event_dispatch_handler: dequeued 1 events
[00:03:14.331,000] <dbg> hl78xx_dev: hl78xx_event_handler: 1498 event: 5 in state: carrier on
[00:03:14.331,000] <dbg> hl78xx_dev: hl78xx_log_event: event timeout
[00:03:14.331,000] <dbg> hl78xx_socket: dns_work_cb: Resetting DNS resolver
[00:03:14.331,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:03:14.331,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:03:14.331,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KUDPCLOSE=1
[00:03:14.376,000] <dbg> modem_chat: modem_chat_log_received_command: OK
[00:03:14.376,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:03:14.376,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:03:14.376,000] <dbg> hl78xx_socket: dns_work_cb: Refresh DNS resolver
[00:03:14.376,000] <dbg> hl78xx_socket: offload_socket: 1542 1 2 17
[00:03:14.376,000] <dbg> hl78xx_socket: offload_bind: entry for socket fd=4 id=7
[00:03:14.376,000] <dbg> hl78xx_socket: create_socket: entry fd=4 id=7
[00:03:14.376,000] <dbg> modem_chat: modem_chat_script_start: running script: dynamic_script
[00:03:14.376,000] <dbg> modem_chat: modem_chat_script_next: dynamic_script: step: 0
[00:03:14.376,000] <dbg> modem_chat: modem_chat_script_next: sending: AT+KUDPCFG=1,0,,2,,,0,0
[00:03:14.455,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KUDPCFG: 1
[00:03:14.455,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: OK
[00:03:14.455,000] <dbg> modem_chat: modem_chat_log_received_command: +KUDP_IND:  1 1
[00:03:14.455,000] <dbg> hl78xx_socket: hl78xx_on_kudpsocket_create: Assigned modem socket id 1 to fd 4
[00:03:14.455,000] <dbg> modem_chat: modem_chat_script_stop: dynamic_script: complete
[00:03:14.455,000] <dbg> hl78xx_dev: modem_dynamic_cmd_send: Chat script executed successfully.
[00:03:14.455,000] <dbg> hl78xx_socket: create_socket: send_udp_config returned 0
[00:03:14.455,000] <dbg> hl78xx_socket: offload_bind: create_socket returned 0
[00:03:14.455,000] <dbg> hl78xx_socket: dns_work_cb: DNS ready
[00:03:14.455,000] <inf> main: IP Up
[00:03:14.455,000] <inf> main: Connected to network
[00:03:17.503,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  2 1
[00:03:17.503,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem entered camped state on a suitable or acceptable cell
[00:03:18.854,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  3 1
[00:03:18.854,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem successfully established a connection to the network
[00:03:19.065,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  5 1
[00:03:19.065,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem has established an RRC connection with the network
[00:03:32.521,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,4,1
[00:03:32.521,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,1,0
[00:03:33.843,000] <dbg> modem_chat: modem_chat_on_unknown_command_received: +KCNX_IND: 1,3
[00:03:49.174,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  2 1
[00:03:49.174,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem entered camped state on a suitable or acceptable cell
[00:03:51.934,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  3 1
[00:03:51.934,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem successfully established a connection to the network
[00:03:52.244,000] <dbg> modem_chat: modem_chat_log_received_command: +KSTATEV:  5 1
[00:03:52.244,000] <dbg> hl78xx_socket: hl78xx_on_kstatev_parser: Modem has established an RRC connection with the network
uart:~$
10

i saw this user is using older firmware:

11

FYI, I don’ see problem with my module:


at+cfun=1,1
OK

+CEREG: 0

+CREG: 0

+CEREG: 0

+CREG: 0

+WDSI: 0

+CEREG: 2

+CREG: 2

+CEREG: 0

+CREG: 0

+CEREG: 2

+CREG: 2

+CEREG: 1,"C672","0188A9DF",9

+CREG: 1,"C672","0188A9DF",9
at+cpin?
+CPIN: READY

OK
at+wdsi?
+WDSI: 8191

OK
at+wdss=1,1
OK

+WDSI: 4

at+cgpaddr=1
+CGPADDR: 1,"10.41.4.16"

OK
ati3
HL7812.5.7.3.0

OK

+WDSI: 5

+WDSI: 4

+WDSI: 6

+WDSI: 23,0

+WDSI: 4

+WDSI: 6

+WDSI: 23,1
at+ksrat?
+KSRAT: 1

OK