It takes about 30 seconds for osmocom-analog to terminate SIP call #7

Closed
opened 2022-07-29 15:48:12 +00:00 by shadowcaster3 · 2 comments
Collaborator

When mobile subscriber initiates call termination (hangup), it takes about 30 seconds for osmocom-analog to send this signal to osmo-cc and terminate SIP call. Tested with AMPS and NMT.

2022-07-29 18:41:02.026 frame.c 3698 dsp-info   : (chan 353) RX Level: 76% Quality: 71% Polarity: POSITIVE
2022-07-29 18:41:02.026 frame.c 3654 frame-notice : (chan 353) Seems we RX FOCC frame due to loopback, ignoring!
2022-07-29 18:41:02.028 dsp.c  761 dsp-notice : (chan 356) SAT level 97.46% quality 100%
2022-07-29 18:41:02.061 amps.c  708 amps-info   : (chan 356) Detected Signaling Tone with quality=100.
2022-07-29 18:41:02.061 call.c  566 call-info   : Call has been released with cause=16
2022-07-29 18:41:02.061 transaction.c  163 transaction-info   : Destroying transaction for subscriber '4169867983'
2022-07-29 18:41:02.061 transaction.c  245 transaction-info   : Transaction state CALL -> IDLE
2022-07-29 18:41:02.061 amps.c  668 amps-info   : (chan 356) Entering IDLE state (sending silence / no RF) on voice channel.
2022-07-29 18:41:02.061 dsp.c  940 dsp-info   : (chan 356) Change mode from FVC to OFF
2022-07-29 18:41:19.027 frame.c 3698 dsp-info   : (chan 353) RX Level: 208% Quality: 33% Polarity: POSITIVE
2022-07-29 18:41:25.081 frame.c 3698 dsp-info   : (chan 353) RX Level: 178% Quality: 37% Polarity: POSITIVE
2022-07-29 18:41:32.061 call.c  495 call-info   : Indicated OSMO-CC release towards fixed network
2022-07-29 18:41:32.061 endpoint.c  931 cc-info   : Handle message CC-REL-IND at state ACTIVE (callref 4)
2022-07-29 18:41:32.061 message.c  565 cc-info   :   IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset)
2022-07-29 18:41:32.061 endpoint.c  749 cc-info   : Changing message to CC-DISC-IND.
2022-07-29 18:41:32.062 endpoint.c  931 cc-info   : Handle message CC-REL-REQ at state DISCONNECTING-IN (callref 4)
2022-07-29 18:41:32.062 message.c  565 cc-info   :   IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset)
2022-07-29 18:41:34.060 frame.c 3698 dsp-info   : (chan 353) RX Level: 173% Quality: 38% Polarity: NEGATIVE
2022-07-29 18:41:39.065 frame.c 3698 dsp-info   : (chan 353) RX Level: 183% Quality: 36% Polarity: NEGATIVE

2022-07-29 18:40:53.095 endpoint.c: 931 info   : Handle message CC-SETUP-REQ at state IDLE (callref 13)
2022-07-29 18:40:53.095 message.c: 522 info   :   IE_CALLING_NETWORK type=133(amps) id='3585471892'
2022-07-29 18:40:53.095 message.c: 498 info   :   IE_CALLING type=4(subscriber) plan=1(telephony), presentation=0(allowed), screening=3(network provided), number='4169867983'
2022-07-29 18:40:53.095 message.c: 468 info   :   IE_CALLED type=0(unknown) plan=1(telephony) number='611'
2022-07-29 18:40:53.095 message.c: 528 info   :   IE_BEARER coding=0(ITU-T) capability=16(audio) mode=0(circuit)
2022-07-29 18:40:53.095 message.c: 582 info   :   IE_SDP payload=v=0\no=- 3868098053 3868098053 IN IP4 192.168.168.107\ns=-\nc=IN IP4 192.168.168.107\nt=0 0\nm=audio 5072 RTP/AVP 96 8 0\na=rtpmap:96 L16/8000\na=rtpmap:8 PCMA/8000\na=rtpmap:0 PCMU/8000\n
2022-07-29 18:40:53.095 message.c: 516 info   :   IE_CALLING_INTERFACE name='amps'
2022-07-29 18:40:53.095 sip.c: 484 info   : Sending INVITE (callref 13)
2022-07-29 18:40:53.095 endpoint.c: 931 info   : Handle message CC-PROC-IND at state INIT-OUT (callref 13)
2022-07-29 18:40:54.006 sip.c:1212 info   : Received INVITE response: 180 Ringing (callref 13)
2022-07-29 18:40:54.006 endpoint.c: 931 info   : Handle message CC-ALERT-IND at state PROCEEDING-OUT (callref 13)
2022-07-29 18:40:58.037 sip.c:1212 info   : Received INVITE response: 200 OK (callref 13)
2022-07-29 18:40:58.037 endpoint.c: 931 info   : Handle message CC-SETUP-CNF at state ALERTING-OUT (callref 13)
2022-07-29 18:40:58.037 message.c: 582 info   :   IE_SDP payload=v=0\no=- 3868098053 3868098055 IN IP4 192.168.168.173\ns=Asterisk\nc=IN IP4 192.168.168.173\nt=0 0\nm=audio 19846 RTP/AVP 8 0\na=rtpmap:8 PCMA/8000\na=rtpmap:0 PCMU/8000\na=ptime:20\na=maxptime:150\na=sendrecv\n
2022-07-29 18:40:58.037 endpoint.c: 931 info   : Handle message CC-SETUP-COMP-REQ at state CONNECTING-OUT (callref 13)
2022-07-29 18:41:32.061 endpoint.c: 931 info   : Handle message CC-DISC-REQ at state ACTIVE (callref 13)
2022-07-29 18:41:32.061 message.c: 564 info   :   IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset)
2022-07-29 18:41:32.061 endpoint.c: 931 info   : Handle message CC-REL-IND at state DISCONNECTING-OUT (callref 13)
2022-07-29 18:41:32.061 message.c: 564 info   :   IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset)
2022-07-29 18:41:32.061 sip.c: 441 info   : Sending BYE (callref 13)
2022-07-29 18:41:32.062 sip.c:1446 info   : Received BYE response: 200 OK (callref 13)

When mobile subscriber initiates call termination (hangup), it takes about 30 seconds for osmocom-analog to send this signal to osmo-cc and terminate SIP call. Tested with AMPS and NMT. ``` 2022-07-29 18:41:02.026 frame.c 3698 dsp-info : (chan 353) RX Level: 76% Quality: 71% Polarity: POSITIVE 2022-07-29 18:41:02.026 frame.c 3654 frame-notice : (chan 353) Seems we RX FOCC frame due to loopback, ignoring! 2022-07-29 18:41:02.028 dsp.c 761 dsp-notice : (chan 356) SAT level 97.46% quality 100% 2022-07-29 18:41:02.061 amps.c 708 amps-info : (chan 356) Detected Signaling Tone with quality=100. 2022-07-29 18:41:02.061 call.c 566 call-info : Call has been released with cause=16 2022-07-29 18:41:02.061 transaction.c 163 transaction-info : Destroying transaction for subscriber '4169867983' 2022-07-29 18:41:02.061 transaction.c 245 transaction-info : Transaction state CALL -> IDLE 2022-07-29 18:41:02.061 amps.c 668 amps-info : (chan 356) Entering IDLE state (sending silence / no RF) on voice channel. 2022-07-29 18:41:02.061 dsp.c 940 dsp-info : (chan 356) Change mode from FVC to OFF 2022-07-29 18:41:19.027 frame.c 3698 dsp-info : (chan 353) RX Level: 208% Quality: 33% Polarity: POSITIVE 2022-07-29 18:41:25.081 frame.c 3698 dsp-info : (chan 353) RX Level: 178% Quality: 37% Polarity: POSITIVE 2022-07-29 18:41:32.061 call.c 495 call-info : Indicated OSMO-CC release towards fixed network 2022-07-29 18:41:32.061 endpoint.c 931 cc-info : Handle message CC-REL-IND at state ACTIVE (callref 4) 2022-07-29 18:41:32.061 message.c 565 cc-info : IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset) 2022-07-29 18:41:32.061 endpoint.c 749 cc-info : Changing message to CC-DISC-IND. 2022-07-29 18:41:32.062 endpoint.c 931 cc-info : Handle message CC-REL-REQ at state DISCONNECTING-IN (callref 4) 2022-07-29 18:41:32.062 message.c 565 cc-info : IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset) 2022-07-29 18:41:34.060 frame.c 3698 dsp-info : (chan 353) RX Level: 173% Quality: 38% Polarity: NEGATIVE 2022-07-29 18:41:39.065 frame.c 3698 dsp-info : (chan 353) RX Level: 183% Quality: 36% Polarity: NEGATIVE ``` ``` 2022-07-29 18:40:53.095 endpoint.c: 931 info : Handle message CC-SETUP-REQ at state IDLE (callref 13) 2022-07-29 18:40:53.095 message.c: 522 info : IE_CALLING_NETWORK type=133(amps) id='3585471892' 2022-07-29 18:40:53.095 message.c: 498 info : IE_CALLING type=4(subscriber) plan=1(telephony), presentation=0(allowed), screening=3(network provided), number='4169867983' 2022-07-29 18:40:53.095 message.c: 468 info : IE_CALLED type=0(unknown) plan=1(telephony) number='611' 2022-07-29 18:40:53.095 message.c: 528 info : IE_BEARER coding=0(ITU-T) capability=16(audio) mode=0(circuit) 2022-07-29 18:40:53.095 message.c: 582 info : IE_SDP payload=v=0\no=- 3868098053 3868098053 IN IP4 192.168.168.107\ns=-\nc=IN IP4 192.168.168.107\nt=0 0\nm=audio 5072 RTP/AVP 96 8 0\na=rtpmap:96 L16/8000\na=rtpmap:8 PCMA/8000\na=rtpmap:0 PCMU/8000\n 2022-07-29 18:40:53.095 message.c: 516 info : IE_CALLING_INTERFACE name='amps' 2022-07-29 18:40:53.095 sip.c: 484 info : Sending INVITE (callref 13) 2022-07-29 18:40:53.095 endpoint.c: 931 info : Handle message CC-PROC-IND at state INIT-OUT (callref 13) 2022-07-29 18:40:54.006 sip.c:1212 info : Received INVITE response: 180 Ringing (callref 13) 2022-07-29 18:40:54.006 endpoint.c: 931 info : Handle message CC-ALERT-IND at state PROCEEDING-OUT (callref 13) 2022-07-29 18:40:58.037 sip.c:1212 info : Received INVITE response: 200 OK (callref 13) 2022-07-29 18:40:58.037 endpoint.c: 931 info : Handle message CC-SETUP-CNF at state ALERTING-OUT (callref 13) 2022-07-29 18:40:58.037 message.c: 582 info : IE_SDP payload=v=0\no=- 3868098053 3868098055 IN IP4 192.168.168.173\ns=Asterisk\nc=IN IP4 192.168.168.173\nt=0 0\nm=audio 19846 RTP/AVP 8 0\na=rtpmap:8 PCMA/8000\na=rtpmap:0 PCMU/8000\na=ptime:20\na=maxptime:150\na=sendrecv\n 2022-07-29 18:40:58.037 endpoint.c: 931 info : Handle message CC-SETUP-COMP-REQ at state CONNECTING-OUT (callref 13) 2022-07-29 18:41:32.061 endpoint.c: 931 info : Handle message CC-DISC-REQ at state ACTIVE (callref 13) 2022-07-29 18:41:32.061 message.c: 564 info : IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset) 2022-07-29 18:41:32.061 endpoint.c: 931 info : Handle message CC-REL-IND at state DISCONNECTING-OUT (callref 13) 2022-07-29 18:41:32.061 message.c: 564 info : IE_CAUSE location=1(private network serving local user) isdn_cause=16(normal call clearing) sip_cause=468 socket_cause=0(unset) 2022-07-29 18:41:32.061 sip.c: 441 info : Sending BYE (callref 13) 2022-07-29 18:41:32.062 sip.c:1446 info : Received BYE response: 200 OK (callref 13) ```

Use the '-t 0' option on osmocom-analog. If this is not set, it will send reorder on the channel for 30 seconds after the mobile hangs up.

Use the '-t 0' option on osmocom-analog. If this is not set, it will send reorder on the channel for 30 seconds after the mobile hangs up.
Author
Collaborator

You are correct. Completly missed that option. Thank you.

You are correct. Completly missed that option. Thank you.
Sign in to join this conversation.
No Label
No Milestone
No project
No Assignees
2 Participants
Notifications
Due Date
The due date is invalid or out of range. Please use the format 'yyyy-mm-dd'.

No due date set.

Dependencies

No dependencies set.

Reference: cellular-infrastructure/osmocom-analog#7
No description provided.