This is the asterisk log…
The problem is when I receive a call within 30 seconds it hangs up and looks like this: Does anyone know how to get started on this issue?
~ David
– Executing [s@macro-dial:8] Set(“SIP/flowroute-00000009”, “DIALSTATUS=NOANSWER”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-dial:9] GosubIf(“SIP/flowroute-00000009”, “0?NOANSWER,1”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [600@ext-group:12] Gosub(“SIP/flowroute-00000009”, “sub-record-cancel,s,1()”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:1] Set(“SIP/flowroute-00000009”, “__REC_POLICY_MODE=always”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:2] ExecIf(“SIP/flowroute-00000009”, “0?Return()”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:3] StopMixMonitor(“SIP/flowroute-00000009”, “”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] app_mixmonitor.c: == MixMonitor close filestream (mixed)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:4] Set(“SIP/flowroute-00000009”, “__REC_STATUS=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:5] Set(“SIP/flowroute-00000009”, “MON_BASE=/var/spool/asterisk/monitor/2013/06/26/”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:6] Set(“SIP/flowroute-00000009”, “__MON_FMT=wav”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:7] ExecIf(“SIP/flowroute-00000009”, “48?System(rm -f /var/spool/asterisk/monitor/2013/06/26/rg-600-+19194435574-20130626-011415-1372223647.9.wav)”) in new stack
[2013-06-26 01:14:36] VERBOSE[2206][C-00000005] app_mixmonitor.c: == End MixMonitor Recording SIP/flowroute-00000009
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:8] Set(“SIP/flowroute-00000009”, “__CALLFILENAME=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:9] Set(“SIP/flowroute-00000009”, “CDR(recordingfile)=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@sub-record-cancel:10] Return(“SIP/flowroute-00000009”, “”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [600@ext-group:13] Set(“SIP/flowroute-00000009”, “RingGroupMethod=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [600@ext-group:14] GotoIf(“SIP/flowroute-00000009”, “0?nodest”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [600@ext-group:15] Set(“SIP/flowroute-00000009”, “__NODEST=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [600@ext-group:16] Macro(“SIP/flowroute-00000009”, “blkvm-clr,”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-blkvm-clr:1] Set(“SIP/flowroute-00000009”, “SHARED(BLKVM,SIP/flowroute-00000009)=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-blkvm-clr:2] Set(“SIP/flowroute-00000009”, “GOSUB_RETVAL=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-blkvm-clr:3] MacroExit(“SIP/flowroute-00000009”, “”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [600@ext-group:17] Goto(“SIP/flowroute-00000009”, “ext-local,vmb101,1”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (ext-local,vmb101,1)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmb101@ext-local:1] Macro(“SIP/flowroute-00000009”, “vm,101,BUSY,”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-vm:1] Macro(“SIP/flowroute-00000009”, “user-callerid,SKIPTTL”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:1] Set(“SIP/flowroute-00000009”, “TOUCH_MONITOR=1372223647.9”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:2] Set(“SIP/flowroute-00000009”, “AMPUSER=+19194435574”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:3] GotoIf(“SIP/flowroute-00000009”, “0?report”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:4] ExecIf(“SIP/flowroute-00000009”, “0?Set(REALCALLERIDNUM=+19194435574)”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:5] Set(“SIP/flowroute-00000009”, “AMPUSER=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:6] Set(“SIP/flowroute-00000009”, “AMPUSERCIDNAME=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:7] GotoIf(“SIP/flowroute-00000009”, “1?report”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-user-callerid,s,15)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:15] GotoIf(“SIP/flowroute-00000009”, “1?continue”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-user-callerid,s,28)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:28] Set(“SIP/flowroute-00000009”, “CALLERID(number)=+19194435574”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:29] Set(“SIP/flowroute-00000009”, “CALLERID(name)=MAIN+19194435574”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:30] Set(“SIP/flowroute-00000009”, “CDR(cnum)=+19194435574”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:31] Set(“SIP/flowroute-00000009”, “CDR(cnam)=MAIN+19194435574”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-user-callerid:32] Set(“SIP/flowroute-00000009”, “CHANNEL(language)=en”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-vm:2] Set(“SIP/flowroute-00000009”, “VMGAIN=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-vm:3] Macro(“SIP/flowroute-00000009”, “blkvm-check,”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-blkvm-check:1] Set(“SIP/flowroute-00000009”, “GOSUB_RETVAL=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-blkvm-check:2] ExecIf(“SIP/flowroute-00000009”, “0?Set(GOSUB_RETVAL=TRUE)”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-blkvm-check:3] MacroExit(“SIP/flowroute-00000009”, “”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-vm:4] GotoIf(“SIP/flowroute-00000009”, “1?vmx,1”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-vm,vmx,1)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:1] Set(“SIP/flowroute-00000009”, “MEXTEN=101”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:2] Set(“SIP/flowroute-00000009”, “MMODE=BUSY”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:3] Set(“SIP/flowroute-00000009”, “RETVM=”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:4] Set(“SIP/flowroute-00000009”, “MODE=busy”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:5] GotoIf(“SIP/flowroute-00000009”, “1?chknomsg”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-vm,vmx,7)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:7] GotoIf(“SIP/flowroute-00000009”, “0?s-BUSY,1”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:8] GotoIf(“SIP/flowroute-00000009”, “1?notdirect”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-vm,vmx,10)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:10] NoOp(“SIP/flowroute-00000009”, "Checking if ext 101 is enabled: ") in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [vmx@macro-vm:11] GotoIf(“SIP/flowroute-00000009”, “1?s-BUSY,1”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-vm,s-BUSY,1)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s-BUSY@macro-vm:1] NoOp(“SIP/flowroute-00000009”, “BUSY voicemail”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s-BUSY@macro-vm:2] Macro(“SIP/flowroute-00000009”, “get-vmcontext,101”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-get-vmcontext:1] Set(“SIP/flowroute-00000009”, “VMCONTEXT=default”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-get-vmcontext:2] GotoIf(“SIP/flowroute-00000009”, “0?200:300”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-get-vmcontext,s,300)
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-get-vmcontext:300] NoOp(“SIP/flowroute-00000009”, “”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] pbx.c: – Executing [s-BUSY@macro-vm:3] VoiceMail(“SIP/flowroute-00000009”, “101@default,b”) in new stack
[2013-06-26 01:14:36] VERBOSE[2205][C-00000005] file.c: – <SIP/flowroute-00000009> Playing ‘vm-theperson.ulaw’ (language ‘en’)
[2013-06-26 01:14:38] VERBOSE[2205][C-00000005] file.c: – <SIP/flowroute-00000009> Playing ‘digits/1.ulaw’ (language ‘en’)
[2013-06-26 01:14:38] VERBOSE[2205][C-00000005] file.c: – <SIP/flowroute-00000009> Playing ‘digits/0.ulaw’ (language ‘en’)
[2013-06-26 01:14:39] WARNING[1806] chan_sip.c: Retransmission timeout reached on transmission SD7g56301-9efa3f868d955eb2345f395d692640ce-v3000i1 for seqno 24983 (Critical Response) – See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 31999ms with no response
[2013-06-26 01:14:39] WARNING[1806] chan_sip.c: Hanging up call SD7g56301-9efa3f868d955eb2345f395d692640ce-v3000i1 - no reply to our critical packet (see https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions).
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] app_macro.c: == Spawn extension (macro-vm, s-BUSY, 3) exited non-zero on ‘SIP/flowroute-00000009’ in macro ‘vm’
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] pbx.c: == Spawn extension (ext-local, vmb101, 1) exited non-zero on ‘SIP/flowroute-00000009’
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] pbx.c: – Executing [h@ext-local:1] Macro(“SIP/flowroute-00000009”, “hangupcall,”) in new stack
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/flowroute-00000009”, “1?theend”) in new stack
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] pbx.c: – Goto (macro-hangupcall,s,3)
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-hangupcall:3] ExecIf(“SIP/flowroute-00000009”, “0?Set(CDR(recordingfile)=)”) in new stack
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] pbx.c: – Executing [s@macro-hangupcall:4] Hangup(“SIP/flowroute-00000009”, “”) in new stack
[2013-06-26 01:14:39] VERBOSE[2205][C-00000005] app_macro.c: == Spawn extension (macro-hangupcall, s, 4) exited non-zero on ‘SIP/flowroute-00000009’ in macro ‘hangupcall’