Hangup After 10 seconds

[jhonedyl]

Hello everyone, I am newbie here. I have a problem during my testing, I am not able to make inbound calls it will auto hangup after 10 seconds or less. Any help or response is appreciated.

Here is my Asterisk Logs
[Apr 13 15:22:13] == Using SIP RTP CoS mark 5
[Apr 13 15:22:13] -- Called 1001
[Apr 13 15:22:13] -- SIP/1001-00000030 is ringing
[Apr 13 15:22:14] > 0x7f8fc002cd90 -- Strict RTP learning after remote address set to: 192.168.1.92:9118
[Apr 13 15:22:14] -- SIP/1001-00000030 answered
[Apr 13 15:22:14] -- Executing [8600051@default:1] MeetMe("SIP/1001-00000030", "8600051,F") in new stack
[Apr 13 15:22:14] -- Created MeetMe conference 1023 for conference '8600051'
[Apr 13 15:22:14] -- <SIP/1001-00000030> Playing 'conf-onlyperson.slin' (language 'en')
[Apr 13 15:22:14] > 0x7f8fc002cd90 -- Strict RTP switching to RTP target address 192.168.1.92:9118 as source
[Apr 13 15:22:15] == Manager 'sendcron' logged off from 127.0.0.1
[Apr 13 15:22:20] > 0x7f8fc002cd90 -- Strict RTP learning complete - Locking on source address 192.168.1.92:9118
[Apr 13 15:22:28] == Using SIP RTP CoS mark 5
[Apr 13 15:22:28] > 0x7f8f9005b750 -- Strict RTP learning after remote address set to: 35.244.127.15:52714
[Apr 13 15:22:28] -- Executing [61870041014@trunkinbound:1] AGI("SIP/Novanet-00000031", "agi-DID_route.agi") in new stack
[Apr 13 15:22:28] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-DID_route.agi
[Apr 13 15:22:28] -- <SIP/Novanet-00000031>AGI Script agi-DID_route.agi completed, returning 0
[Apr 13 15:22:28] -- Executing [99909*8***DID@default:1] Answer("SIP/Novanet-00000031", "") in new stack
[Apr 13 15:22:28] -- Executing [99909*8***DID@default:2] AGI("SIP/Novanet-00000031", "agi-VDAD_ALL_inbound.agi") in new stack
[Apr 13 15:22:28] -- Launched AGI Script /usr/share/asterisk/agi-bin/agi-VDAD_ALL_inbound.agi
[Apr 13 15:22:28] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:28] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:29] == Manager 'sendcron' logged on from 127.0.0.1
[Apr 13 15:22:29] -- Called 192*168*001*191*78600051@default
[Apr 13 15:22:29] -- Executing [192*168*001*191*78600051@default:1] Goto("Local/192*168*001*191*78600051@default-00000027;2", "default,78600051,1") in new stack
[Apr 13 15:22:29] -- Goto (default,78600051,1)
[Apr 13 15:22:29] -- Executing [78600051@default:1] MeetMe("Local/192*168*001*191*78600051@default-00000027;2", "8600051,Fq") in new stack
[Apr 13 15:22:29] -- Local/192*168*001*191*78600051@default-00000027;1 answered
[Apr 13 15:22:29] -- Executing [83047777777777@vicidial-auto:1] Answer("Local/192*168*001*191*78600051@default-00000027;1", "") in new stack
[Apr 13 15:22:29] -- Executing [83047777777777@vicidial-auto:2] Playback("Local/192*168*001*191*78600051@default-00000027;1", "ding") in new stack
[Apr 13 15:22:29] -- <Local/192*168*001*191*78600051@default-00000027;1> Playing 'ding.gsm' (language 'en')
[Apr 13 15:22:29] -- Executing [83047777777777@vicidial-auto:3] Hangup("Local/192*168*001*191*78600051@default-00000027;1", "") in new stack
[Apr 13 15:22:29] == Spawn extension (vicidial-auto, 83047777777777, 3) exited non-zero on 'Local/192*168*001*191*78600051@default-00000027;1'
[Apr 13 15:22:29] WARNING[18372][C-0000009f]: func_hangupcause.c:140 hangupcause_read: Unable to find information for channel
[Apr 13 15:22:29] -- Executing [h@vicidial-auto:1] AGI("Local/192*168*001*191*78600051@default-00000027;1", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[Apr 13 15:22:29] -- <Local/192*168*001*191*78600051@default-00000027;1>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ----------) completed, returning 0
[Apr 13 15:22:29] == Spawn extension (default, 78600051, 1) exited non-zero on 'Local/192*168*001*191*78600051@default-00000027;2'
[Apr 13 15:22:29] WARNING[18373][C-0000009e]: func_hangupcause.c:140 hangupcause_read: Unable to find information for channel
[Apr 13 15:22:29] -- Executing [h@default:1] AGI("Local/192*168*001*191*78600051@default-00000027;2", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----16--------------------)") in new stack
[Apr 13 15:22:29] -- <Local/192*168*001*191*78600051@default-00000027;2>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ----------) completed, returning 0
[Apr 13 15:22:30] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:30] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:30] == Manager 'sendcron' logged off from 127.0.0.1
[Apr 13 15:22:30] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:30] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:30] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:30] -- <SIP/Novanet-00000031> Playing 'sip-silence.gsm' (escape_digits=) (sample_offset 0) (language 'en')
[Apr 13 15:22:30] -- <SIP/Novanet-00000031>AGI Script agi-VDAD_ALL_inbound.agi completed, returning 0
[Apr 13 15:22:30] -- Executing [192*168*001*191*8600051@default:1] Goto("SIP/Novanet-00000031", "default,8600051,1") in new stack
[Apr 13 15:22:30] -- Goto (default,8600051,1)
[Apr 13 15:22:30] -- Executing [8600051@default:1] MeetMe("SIP/Novanet-00000031", "8600051,F") in new stack
[Apr 13 15:22:37] WARNING[2503]: chan_sip.c:4069 retrans_pkt: Retransmission timeout reached on transmission ac23e4-1e47-313202172227-bn03-nsy1-0-202.169.183.68 for seqno 699001 (Critical Response) -- See https://wiki.asterisk.org/wiki/display/ ... nsmissions
Packet timed out after 9473ms with no response
[Apr 13 15:22:37] WARNING[2503]: chan_sip.c:4093 retrans_pkt: Hanging up call ac23e4-1e47-313202172227-bn03-nsy1-0-202.169.183.68 - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/ ... nsmissions).
[Apr 13 15:22:37] == Spawn extension (default, 8600051, 1) exited non-zero on 'SIP/Novanet-00000031'
[Apr 13 15:22:37] WARNING[18365][C-0000009d]: func_hangupcause.c:140 hangupcause_read: Unable to find information for channel
[Apr 13 15:22:37] -- Executing [h@default:1] AGI("SIP/Novanet-00000031", "agi://127.0.0.1:4577/call_log--HVcauses--PRI-----NODEBUG-----18--------------------)") in new stack
[Apr 13 15:22:37] -- <SIP/Novanet-00000031>AGI Script agi://127.0.0.1:4577/call_log--HVcauses ... ----------) completed, returning 0


Here is my TCPDUMP
15:22:13.494611 IP 192.168.1.191.sip > 192.168.1.92.9117: SIP: INVITE sip:1001@192.168.1.92:9117 SIP/2.0
15:22:13.500554 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP: SIP/2.0 180 Ringing
15:22:14.619256 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP: SIP/2.0 200 OK
15:22:14.619810 IP 192.168.1.191.sip > 192.168.1.92.9117: SIP: ACK sip:1001@192.168.1.92:9117 SIP/2.0
15:22:15.565900 IP sip.mvoice.com.au.sip > 192.168.1.191.sip: SIP: OPTIONS sip:pass@43.226.7.34:5060 SIP/2.0
15:22:15.566293 IP 192.168.1.191.sip > sip.mvoice.com.au.sip: SIP: SIP/2.0 404 Not Found
15:22:15.601846 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP
15:22:24.604709 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP
15:22:28.089675 IP 15.127.244.35.bc.googleusercontent.com.sip > 192.168.1.191.sip: SIP: INVITE sip:61870041014@43.226.7.34:58033 SIP/2.0
15:22:28.091159 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 100 Trying
15:22:28.135620 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:28.282887 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:28.579292 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:29.171985 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:30.355528 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:32.723147 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:33.606374 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP
15:22:36.723130 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: SIP/2.0 200 OK
15:22:37.623379 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: BYE sip:35.244.127.15;thinfo=VG9ybzAdIFthY2dBYVpwWmVSfWJgXWsLKhBtU2Qwel4zXiYXYVNHUyELIFVyRH5QZmF6X35edk5lUWVj SIP/2.0
15:22:37.770978 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: BYE sip:35.244.127.15;thinfo=VG9ybzAdIFthY2dBYVpwWmVSfWJgXWsLKhBtU2Qwel4zXiYXYVNHUyELIFVyRH5QZmF6X35edk5lUWVj SIP/2.0
15:22:38.067383 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: BYE sip:35.244.127.15;thinfo=VG9ybzAdIFthY2dBYVpwWmVSfWJgXWsLKhBtU2Qwel4zXiYXYVNHUyELIFVyRH5QZmF6X35edk5lUWVj SIP/2.0
15:22:38.163661 IP 15.127.244.35.bc.googleusercontent.com.sip > 192.168.1.191.sip: SIP: SIP/2.0 200 OK
15:22:38.216089 IP 15.127.244.35.bc.googleusercontent.com.sip > 192.168.1.191.sip: SIP: SIP/2.0 200 OK
15:22:38.867266 IP 192.168.1.191.sip > 192.168.1.92.9117: SIP: OPTIONS sip:1001@192.168.1.92:9117 SIP/2.0
15:22:38.869568 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP: SIP/2.0 200 OK
15:22:39.111388 IP 192.168.1.191.sip > sip.mvoice.com.au.sip: SIP: OPTIONS sip:sip02.mvoice.com.au SIP/2.0
15:22:39.213897 IP 192.168.1.191.sip > 15.127.244.35.bc.googleusercontent.com.sip: SIP: OPTIONS sip:35.244.127.15 SIP/2.0
15:22:39.257861 IP sip.mvoice.com.au.sip > 192.168.1.191.sip: SIP: SIP/2.0 200 OK
15:22:39.362126 IP 15.127.244.35.bc.googleusercontent.com.sip > 192.168.1.191.sip: SIP: SIP/2.0 200 OK
15:22:42.609428 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP
15:22:51.611101 IP 192.168.1.92.9117 > 192.168.1.191.sip: SIP

[carpenox]

This kind of thing is hard to debug over the forum. Msg me on Skype, I'll help you figure it oit then you can report the solution back here