|
Question : all outbound calls drop after 90 seconds
|
|
Hello,
i am really new to trixbox and asterisk overall, i setup a server to run trixbox at my collocation site, is sitting behind a sonicwall tz180 on a dedicated dmz interface, everything seems to work fine, i setup 2 trunks and they both send out calls fine, but my problem is that all calls get dropped at around 90 seconds, i open the following ports on the firewall:
tcp 5060
udp 5060 - 5082
udp 10000 - 20000
all of my extensions are nated, since server is a data center and users are all remote users, they can call each other internally on their extensions and the call does not drop, it just seem to affect outgoing calls.
i am posting the end of my log after that shows when an outgoing call was dropped, and hopping to get some advice.
Thanks
[Nov 3 07:31:02] NOTICE[3710] chan_sip.c: Peer 'freepbx-rocks' is now Reachable. (80ms / 2000ms)
[Nov 3 07:31:02] NOTICE[3710] chan_sip.c: Peer '1001' is now Reachable. (119ms / 2000ms)
[Nov 3 07:31:04] NOTICE[3710] chan_sip.c: -- Registration for '[email protected][email protected]roadvoice.com' timed out, trying again (Attempt #5)
[Nov 3 07:42:43] VERBOSE[3710] logger.c: == Using SIP RTP TOS bits 184
[Nov 3 07:42:43] VERBOSE[3710] logger.c: == Using SIP RTP CoS mark 5
[Nov 3 07:42:43] VERBOSE[3710] logger.c: == Using SIP VRTP TOS bits 136
[Nov 3 07:42:43] VERBOSE[3710] logger.c: == Using SIP VRTP CoS mark 6
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [3056441119@from-internal:1] [1;36;40mMacro[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40muser-callerid,SKIPTTL,[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:1] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mAMPUSER=1001[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:2] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?report[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:3] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?Set(REALCALLERIDNUM=1001)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:4] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mAMPUSER=1001[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:5] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mAMPUSERCIDNAME=Juan Echeverry[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:6] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?report[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:7] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mAMPUSERCID=1001[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:8] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mCALLERID(all)="Juan Echeverry" <1001>[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:9] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mREALCALLERIDNUM=1001[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:10] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?Set(CHANNEL(language)=)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:11] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?continue[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Goto (macro-user-callerid,s,20)
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-user-callerid:20] [1;36;40mNoOp[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mUsing CallerID "Juan Echeverry" <1001>[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [3056441119@from-internal:2] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m_NODEST=[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [3056441119@from-internal:3] [1;36;40mMacro[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mrecord-enable,1001,OUT,[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-record-enable:1] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?check[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Goto (macro-record-enable,s,4)
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-record-enable:4] [1;36;40mAGI[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mrecordingcheck,20091103-074243,1257252163.35[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Nov 3 07:42:43] VERBOSE[7765] logger.c: recordingcheck,20091103-074243,1257252163.35: Outbound recording not enabled
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- AGI Script recordingcheck completed, returning 0
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-record-enable:5] [1;36;40mMacroExit[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [3056441119@from-internal:4] [1;36;40mMacro[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mdialout-trunk,2,3056441119,,[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:1] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mDIAL_TRUNK=2[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:2] [1;36;40mGosubIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?sub-pincheck,s,1[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:3] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?disabletrunk,1[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:4] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mDIAL_NUMBER=3056441119[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:5] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mDIAL_TRUNK_OPTIONS=tr[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:6] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mOUTBOUND_GROUP=OUT_2[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:7] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?nomax[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Goto (macro-dialout-trunk,s,9)
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:9] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?skipoutcid[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:10] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mDIAL_TRUNK_OPTIONS=[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:11] [1;36;40mMacro[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40moutbound-callerid,2[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:1] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?Set(CALLERPRES()=)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:2] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?Set(REALCALLERIDNUM=1001)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:3] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?normcid[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Goto (macro-outbound-callerid,s,6)
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:6] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mUSEROUTCID=3053493923[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:7] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mEMERGENCYCID=[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:8] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mTRUNKOUTCID=3053493919[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:9] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?trunkcid[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Goto (macro-outbound-callerid,s,12)
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:12] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?Set(CALLERID(all)=3053493919)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:13] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?Set(CALLERID(all)=3053493923)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-outbound-callerid:14] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?Set(CALLERPRES()=prohib_passed_screen)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:12] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?AGI(fixlocalprefix)[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:13] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mOUTNUM=3056441119[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:14] [1;36;40mSet[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mcustom=SIP/freepbx-rocks[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:15] [1;36;40mExecIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^))[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:16] [1;36;40mMacro[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mdialout-trunk-predial-hook,[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] [1;36;40mMacroExit[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:17] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?bypass,1[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:18] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m0?customtrunk[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Executing [s@macro-dialout-trunk:19] [1;36;40mDial[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mSIP/freepbx-rocks/3056441119,300,[0;37;40m") in new stack
[Nov 3 07:42:43] VERBOSE[7765] logger.c: == Using SIP RTP TOS bits 184
[Nov 3 07:42:43] VERBOSE[7765] logger.c: == Using SIP RTP CoS mark 5
[Nov 3 07:42:43] VERBOSE[7765] logger.c: == Using SIP VRTP TOS bits 136
[Nov 3 07:42:43] VERBOSE[7765] logger.c: == Using SIP VRTP CoS mark 6
[Nov 3 07:42:43] VERBOSE[7765] logger.c: -- Called freepbx-rocks/3056441119
[Nov 3 07:42:46] VERBOSE[7765] logger.c: -- SIP/freepbx-rocks-09f4c400 is making progress passing it to SIP/1001-0a0dcf30
[Nov 3 07:42:46] VERBOSE[7765] logger.c: -- SIP/freepbx-rocks-09f4c400 answered SIP/1001-0a0dcf30
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [h@macro-dialout-trunk:1] [1;36;40mMacro[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mhangupcall,[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [s@macro-hangupcall:1] [1;36;40mResetCDR[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40mvw[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [s@macro-hangupcall:2] [1;36;40mNoCDR[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [s@macro-hangupcall:3] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?skiprg[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Goto (macro-hangupcall,s,6)
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [s@macro-hangupcall:6] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?skipblkvm[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Goto (macro-hangupcall,s,9)
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [s@macro-hangupcall:9] [1;36;40mGotoIf[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m1?theend[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Goto (macro-hangupcall,s,11)
[Nov 3 07:44:14] VERBOSE[7765] logger.c: -- Executing [s@macro-hangupcall:11] [1;36;40mHangup[0;37;40m("[1;35;40mSIP/1001-0a0dcf30[0;37;40m", "[1;35;40m[0;37;40m") in new stack
[Nov 3 07:44:14] VERBOSE[7765] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on 'SIP/1001-0a0dcf30' in macro 'hangupcall'
[Nov 3 07:44:14] VERBOSE[7765] logger.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'SIP/1001-0a0dcf30'
[Nov 3 07:44:14] VERBOSE[7765] logger.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on 'SIP/1001-0a0dcf30' in macro 'dialout-trunk'
[Nov 3 07:44:14] VERBOSE[7765] logger.c: == Spawn extension (from-internal, 3056441119, 4) exited non-zero on 'SIP/1001-0a0dcf30'
|
Answer : all outbound calls drop after 90 seconds
|
|
You have "Nat=yes" set, correct? Try setting "qualify=30".
|
|
|
|
|
