SubmitAsync never ends

Post Reply
aordonez
Posts: 21
Joined: Wed Jun 05, 2019 11:40 am

SubmitAsync never ends

Post by aordonez » Thu Mar 02, 2023 3:12 pm

Hi,
Our platform is using version 2.9.26 of inetlab.SMPP to maintain 100 established binds to 10 different SMPP hosts, and we are sending around 4 million messages per day. However, we are experiencing issues when submitting messages. At certain times of the day, especially when we have more traffic with paralel SubmitAsync, sometimes with just a few SubmitSm elements and sometimes with up to 500, the method never finishes as if it did not receive a response from the provider. However, we have confirmed through network capture that the submit was completed and the response was immediate from the provider.
We have checked the number of threads available and in use at all times and never exceed 60 of 32767 available. Can you help us determine the possible cause of the library not completing the submit cycle?
alt
Site Admin
Posts: 985
Joined: Tue Apr 25, 2006 9:45 am

Re: SubmitAsync never ends

Post by alt » Thu Mar 02, 2023 6:39 pm

Hi aordonez,

Is library logging is enabled in your application? Could you send me at least ERROR and WARN log records?
aordonez
Posts: 21
Joined: Wed Jun 05, 2019 11:40 am

Re: SubmitAsync never ends

Post by aordonez » Thu Mar 02, 2023 7:02 pm

No at the moment, but I can enabled it and attach the log during the problem.
aordonez
Posts: 21
Joined: Wed Jun 05, 2019 11:40 am

Re: SubmitAsync never ends

Post by aordonez » Tue Mar 07, 2023 4:17 pm

Hi, I have enabled the logs and this is what I found: the last submission was Sequence 30473 at 18:19:15, in this case the SubmitAsync never ends (After waiting for 6 minutes, it still didn't end)and the next one is Sequence 30485 at 18:25:58 (after waiting any response).

Fragment of the log

06.03.2023 18:19:15:DEBUG:197: (XXXXXXXX) Send PDU: SubmitSm, Sequence: 30471, SourceAddr: 90009, DestAddr: 54xxxxx
06.03.2023 18:19:15:TRACE:197: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=230, 000000e60000000400000000000077070004093930303039000101353432363134313934323539000000000000010000009f686f6c6120417175696c65733f204c6520706564697320612043656c65646f6e204c75636173204d617469617320444e4920333334343535303620717565206d65206c6c616d6520616c203131333938362d35383237202844722e2050617a29207820646575646120632f465241564547412e20456d626172676f20656e20546f7272657320416e746976696c6f204a617669657220416c656a616e64726f05800011313639313334373838352d343236373134
06.03.2023 18:19:15:TRACE:360: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=16, 00000010800000040000006600007707
06.03.2023 18:19:15:DEBUG:360: (XXXXXXXX) PDU Received: SubmitSmResp, Status: ESME_RX_R_APPN, Sequence: 30471, MessageId:
06.03.2023 18:19:15:DEBUG:231: (XXXXXXXX) Send PDU: SubmitSm, Sequence: 30472, SourceAddr: 90009, DestAddr: 54xxxxx
06.03.2023 18:19:15:TRACE:360: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=230, 000000e60000000400000000000077080004093930303039000101353431313230303235343637000000000000010000009f636f6d6f206573746173204d696775656c3f204c6520706564697320706f72206661766f7220612043656c656e61204e756e657a20444e4920343330393533303220717565206d65206c6c616d6520555247454e544520616c203131333938362d35383239202844722e2050617a2920706f7220756e6120646575646120636f6e20434f5050454c2e20486179206a756963696f207920656d626172676f2e05800011313639313334373839372d343236373134
06.03.2023 18:19:15:DEBUG:440: (XXXXXXXX) Send PDU: SubmitSm, Sequence: 30473, SourceAddr: 90009, DestAddr: 54xxxxx
06.03.2023 18:19:15:TRACE:440: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=207, 000000cf0000000400000000000077090004093930303039000101353431313233313935383736000000000000010000008843656c656e61204e756e657a20444e49203433303935333032206c6c616d617220555247454e544520616c203131333938362d35383239202841626f6761646f204d6172696f2050617a2920706f7220756e6120646575646120636f6e20434f5050454c2e20486179206a756963696f207920656d626172676f2e20554c54494d4f20415649534f05800011313639313334373930302d343236373134
06.03.2023 18:19:16:TRACE:360: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=16, 00000010800000040000006600007708
06.03.2023 18:19:16:DEBUG:360: (XXXXXXXX) PDU Received: SubmitSmResp, Status: ESME_RX_R_APPN, Sequence: 30472, MessageId:
06.03.2023 18:19:16:TRACE:440: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=16, 00000010800000040000006600007709
06.03.2023 18:19:16:DEBUG:440: (XXXXXXXX) PDU Received: SubmitSmResp, Status: ESME_RX_R_APPN, Sequence: 30473, MessageId:
06.03.2023 18:19:22:TRACE:478: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054780001013534323238343231383839380004093930303039000400000000000000006869643a3331333735353331373335207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138313920737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3037344532303945443700
06.03.2023 18:19:22:DEBUG:478: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21624, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:19:22:DEBUG:478: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21624
06.03.2023 18:19:22:TRACE:257: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000547800
06.03.2023 18:19:25:TRACE:418: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=173, 000000ad0000000500000000000054790001013534333531353931393237340004093930303039000400000000000000006769643a38313835373536353938207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138313920737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3031453745384242423600
06.03.2023 18:19:25:DEBUG:418: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21625, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:19:25:DEBUG:418: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21625
06.03.2023 18:19:25:TRACE:418: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000547900
06.03.2023 18:19:26:TRACE:418: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae00000005000000000000547a0001013534333431333732303330390004093930303039000400000000000000006869643a3231373130383130333634207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138313920737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3035304531304143464300
06.03.2023 18:19:26:DEBUG:418: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21626, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:19:26:DEBUG:418: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21626
06.03.2023 18:19:26:TRACE:367: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000547a00
06.03.2023 18:19:50:TRACE:478: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=79, 0000004f000000050000000000005481000101353439333531353035313239350004093930303039004000000000000000001c050003e802026a756963696f2078206f73746967616e69656e746f20
06.03.2023 18:19:50:DEBUG:478: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21633, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:19:50:DEBUG:439: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21633
06.03.2023 18:19:50:TRACE:439: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000548100
06.03.2023 18:19:52:TRACE: 17: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=210, 000000d2000000050000000000005482000101353439333531353035313239350004093930303039004000000000000000009f050003e802014120766572206e6f20736520717569056e20736f6e207961206d692064657564612063616475636f206573746120656e206d616e6f73206465206d692061626f6761646f20646963652071207961207061736f20656c207469656d706f20792073692073696775656e206d6f6c657374616e646f20766173207573746564657320717569656e2073652076616e206120636f6d657220656c20
06.03.2023 18:19:52:DEBUG: 17: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21634, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:19:52:DEBUG: 17: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21634
06.03.2023 18:19:52:TRACE: 17: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000548200
06.03.2023 18:20:16:TRACE:318: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054830001013534313136313635333635310004093930303039000400000000000000006869643a3336333639333038333630207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313820646f6e6520646174653a3233303330363138323020737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3038373743373941433800
06.03.2023 18:20:16:DEBUG:318: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21635, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:20:16:DEBUG:318: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21635
06.03.2023 18:20:16:TRACE: 52: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000548300
06.03.2023 18:20:28:TRACE: 52: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054840001013534323939353336313831350004093930303039000400000000000000006869643a3139343731383536343833207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363135323420646f6e6520646174653a3233303330363138323020737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3034383839434633363300
06.03.2023 18:20:28:DEBUG: 52: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21636, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:20:28:DEBUG: 52: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21636
06.03.2023 18:20:28:TRACE:126: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000548400
06.03.2023 18:20:53:TRACE:116: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054860001013534323937343335373033340004093930303039000400000000000000006869643a3336333639313130303736207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363136323820646f6e6520646174653a3233303330363138323020737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3038373743343934334300
06.03.2023 18:20:53:DEBUG:116: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21638, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:20:53:DEBUG:116: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21638
06.03.2023 18:20:53:TRACE:116: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000548600
06.03.2023 18:22:27:TRACE:231: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=173, 000000ad00000005000000000000548c0001013534313135343037363038350004093930303039000400000000000000006769643a38323933363733393631207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138323220737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3031454535373642453900
06.03.2023 18:22:27:DEBUG:231: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21644, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:22:27:DEBUG:291: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21644
06.03.2023 18:22:27:TRACE:291: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000548c00
06.03.2023 18:23:15:TRACE:241: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054900001013534313135363230393037310004093930303039000400000000000000006869643a3231363035363234303133207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363133343220646f6e6520646174653a3233303330363138323320737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3035303743424138434400
06.03.2023 18:23:15:DEBUG:241: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21648, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:23:15:DEBUG:241: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21648
06.03.2023 18:23:15:TRACE:290: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549000
06.03.2023 18:23:20:TRACE:140: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054910001013534323634353134353734310004093930303039000400000000000000006869643a3133353437383637363232207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138323320737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3033323738343044453600
06.03.2023 18:23:20:DEBUG:140: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21649, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:23:20:DEBUG:140: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21649
06.03.2023 18:23:20:TRACE:449: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549100
06.03.2023 18:23:24:TRACE: 36: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054920001013534323634343437313737300004093930303039000400000000000000006869643a3239313634333130353038207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138323320737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3036434135343046454300
06.03.2023 18:23:24:DEBUG: 36: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21650, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:23:24:DEBUG: 36: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21650
06.03.2023 18:23:24:TRACE:107: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549200
06.03.2023 18:23:25:TRACE:217: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae0000000500000000000054930001013534333432353236333931340004093930303039000400000000000000006869643a3133353437383638303630207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313820646f6e6520646174653a3233303330363138323320737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3033323738343046394300
06.03.2023 18:23:25:DEBUG:217: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21651, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:23:25:DEBUG:217: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21651
06.03.2023 18:23:25:TRACE:449: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549300
06.03.2023 18:23:53:DEBUG:468: (XXXXXXXX) Send PDU: EnquireLink, Sequence: 30479
06.03.2023 18:23:53:TRACE:459: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=16, 0000001000000015000000000000770f
06.03.2023 18:23:53:TRACE:459: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=16, 0000001080000015000000000000770f
06.03.2023 18:23:53:DEBUG:459: (XXXXXXXX) PDU Received: EnquireLinkResp, Status: ESME_ROK, Sequence: 30479
06.03.2023 18:24:20:TRACE:331: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=173, 000000ad0000000500000000000054960001013534313136303234333832300004093930303039000400000000000000006769643a31373336363336333439207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363137353820646f6e6520646174653a3233303330363138323420737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3030363738324637424400
06.03.2023 18:24:20:DEBUG:331: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21654, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:24:20:DEBUG:300: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21654
06.03.2023 18:24:20:TRACE:388: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549600
06.03.2023 18:24:55:TRACE:197: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=173, 000000ad00000005000000000000549a0001013534333838353730363536360004093930303039000400000000000000006769643a31383435363038343437207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138323420737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3030364530314246464600
06.03.2023 18:24:55:DEBUG:197: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21658, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:24:55:DEBUG:399: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21658
06.03.2023 18:24:55:TRACE:399: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549a00
06.03.2023 18:25:00:TRACE:480: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=174, 000000ae00000005000000000000549b0001013534313132313638383230350004093930303039000400000000000000006869643a3331333735353331393831207375623a30303120646c7672643a303031207375626d697420646174653a3233303330363138313720646f6e6520646174653a3233303330363138323420737461743a44454c49565244206572723a30303020546578743a2d0427000102001e000b3037344532303946434400
06.03.2023 18:25:00:DEBUG:480: (XXXXXXXX) PDU Received: DeliverSm, Sequence: 21659, SourceAddr: 54xxxxx, DestAddr: 90009
06.03.2023 18:25:00:DEBUG:387: (XXXXXXXX) Send PDU: DeliverSmResp, Status: ESME_ROK, Sequence: 21659
06.03.2023 18:25:00:TRACE:387: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=17, 0000001180000005000000000000549b00
06.03.2023 18:25:30:DEBUG:353: (XXXXXXXX) Send PDU: EnquireLink, Sequence: 30483
06.03.2023 18:25:30:TRACE:353: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=16, 00000010000000150000000000007713
06.03.2023 18:25:30:TRACE:387: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=16, 00000010800000150000000000007713
06.03.2023 18:25:30:DEBUG:387: (XXXXXXXX) PDU Received: EnquireLinkResp, Status: ESME_ROK, Sequence: 30483
06.03.2023 18:25:50:DEBUG:300: (XXXXXXXX) Send PDU: EnquireLink, Sequence: 30484
06.03.2023 18:25:50:TRACE: 36: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Send data: Length=16, 00000010000000150000000000007714
06.03.2023 18:25:50:TRACE:120: (XXXXXXXX.Connection21) xxx.xxx.xxx.xxx:54124 => InterNetwork/xxx.xxx.xxx.xxx:17600 Received data: Length=16, 00000010800000150000000000007714
06.03.2023 18:25:50:DEBUG:120: (XXXXXXXX) PDU Received: EnquireLinkResp, Status: ESME_ROK, Sequence: 30484
06.03.2023 18:25:58:DEBUG:300: (XXXXXXXX) Send PDU: SubmitSm, Sequence: 30485, SourceAddr: 90009, DestAddr: 54xxxxx
alt
Site Admin
Posts: 985
Joined: Tue Apr 25, 2006 9:45 am

Re: SubmitAsync never ends

Post by alt » Thu Mar 09, 2023 7:31 pm

After waiting for 6 minutes, it still didn't end
Is the ResponseTimeout longer than 6 minutes in your application? If the response is not received within this time, the library should generate a response with the status SMPPCLIENT_RCVTIMEOUT.
aordonez
Posts: 21
Joined: Wed Jun 05, 2019 11:40 am

Re: SubmitAsync never ends

Post by aordonez » Fri Mar 10, 2023 12:33 pm

Actually the response timeout is set to 60 seconds "ResponseTimeout = TimeSpan.FromSeconds(60)", but apart of that I verify, through network captures, that the response arrives corectly.
alt
Site Admin
Posts: 985
Joined: Tue Apr 25, 2006 9:45 am

Re: SubmitAsync never ends

Post by alt » Tue Mar 14, 2023 5:04 pm

Can you find the response in the library log with the same sequence?
I mean the log event starting with "PDU Received:"

Do you use Wait() or .Result for Async methods?
aordonez
Posts: 21
Joined: Wed Jun 05, 2019 11:40 am

Re: SubmitAsync never ends

Post by aordonez » Wed Mar 15, 2023 12:57 pm

Yes, as I mentioned in my previous response, I can find the response in the library log with the same sequence number.
As for how I execute the asynchronous method, I use Task.Run(). For example, I create a new task by writing 'var t = Task.Run(() => pClient.SubmitAsync(pBatch));'
alt
Site Admin
Posts: 985
Joined: Tue Apr 25, 2006 9:45 am

Re: SubmitAsync never ends

Post by alt » Wed Mar 15, 2023 4:30 pm

If all the responses are present in the library log, then they have been processed correctly.
It looks like there is a deadlock in your application. Is it a Windows Forms or an ASP.NET application?

I hope this article helps. Understanding Async, Avoiding Deadlocks in C#
Post Reply