Impossible to do an outgoing call

Get help with installing and running AsteriskNOW.

Moderators: Moderator, Support

Impossible to do an outgoing call

Postby nij » Sat Sep 12, 2015 5:54 am

Hello,

i've configured the Asterisk Now distro to do some tests.

I've a SIP line from OVH configured as the SIP trunk.

The internal calls are ok. The incoming calls from the external are OK.

But it's impossible to call to the external.

When i use my softphone, i've a blank 30-40 seconds after that, it rings. But no answer. I test to my job so i must have the IVR.

Can i have your help ?

Here the logs from the call :

Code: Select all
[2015-09-12 13:53:00] VERBOSE[13010] pbx_spool.c: -- Attempting call on Local/s@tc-maint for application NoCDR() (Retry 1)
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [s@tc-maint:1] NoCDR("Local/s@tc-maint-00000bbe;2", "") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [s@tc-maint:2] Set("Local/s@tc-maint-00000bbe;2", "TCMAINT=RETURN") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [s@tc-maint:3] Gosub("Local/s@tc-maint-00000bbe;2", "timeconditions,1,1()") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:1] Set("Local/s@tc-maint-00000bbe;2", "DB(TC/1/INUSESTATE)=INUSE") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:2] Set("Local/s@tc-maint-00000bbe;2", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000bbe;2", "20:01-07:59,mon-sun,1-31,jan-dec?truestate") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:4] GotoIf("Local/s@tc-maint-00000bbe;2", "0?truegoto") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:5] ExecIf("Local/s@tc-maint-00000bbe;2", "0?Set(DB(TC/1)=)") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:6] Set("Local/s@tc-maint-00000bbe;2", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:7] ExecIf("Local/s@tc-maint-00000bbe;2", "0?Set(NOT_INUSE)") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:8] GotoIf("Local/s@tc-maint-00000bbe;2", "0?ivr-1,s,1") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:9] Set("Local/s@tc-maint-00000bbe;2", "TCSTATE=false") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:10] Set("Local/s@tc-maint-00000bbe;2", "TCOVERRIDE=false") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [1@timeconditions:11] Return("Local/s@tc-maint-00000bbe;2", "") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [s@tc-maint:4] System("Local/s@tc-maint-00000bbe;2", "/var/lib/asterisk/bin/schedtc.php 60 /var/spool/asterisk/outgoing 1") in new stack
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: -- Executing [s@tc-maint:5] Answer("Local/s@tc-maint-00000bbe;2", "") in new stack
[2015-09-12 13:53:00] NOTICE[13010] pbx_spool.c: Call completed to Local/s@tc-maint
[2015-09-12 13:53:00] VERBOSE[13012][C-000012d2] pbx.c: == Spawn extension (tc-maint, s, 5) exited non-zero on 'Local/s@tc-maint-00000bbe;2'
[2015-09-12 13:53:03] VERBOSE[1904][C-000012d3] netsock2.c: == Using SIP RTP TOS bits 184
[2015-09-12 13:53:03] VERBOSE[1904][C-000012d3] netsock2.c: == Using SIP RTP CoS mark 5
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@from-internal:1] Macro("SIP/500-00000711", "user-callerid,LIMIT") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:1] Set("SIP/500-00000711", "TOUCH_MONITOR=1442058783.7823") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:2] Set("SIP/500-00000711", "AMPUSER=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:3] GotoIf("SIP/500-00000711", "0?report") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:4] ExecIf("SIP/500-00000711", "1?Set(REALCALLERIDNUM=500)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:5] Set("SIP/500-00000711", "AMPUSER=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/500-00000711", "0?limit") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:7] Set("SIP/500-00000711", "AMPUSERCIDNAME=nij") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:8] GotoIf("SIP/500-00000711", "0?report") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:9] Set("SIP/500-00000711", "AMPUSERCID=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:10] Set("SIP/500-00000711", "__DIAL_OPTIONS=Ttr") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:11] Set("SIP/500-00000711", "CALLERID(all)="nij" <500>") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:12] GotoIf("SIP/500-00000711", "0?limit") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:13] ExecIf("SIP/500-00000711", "1?Set(GROUP(concurrency_limit)=500)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:14] GosubIf("SIP/500-00000711", "7?sub-ccss,s,1(from-internal,081554459)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-ccss:1] ExecIf("SIP/500-00000711", "0?Return()") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-ccss:2] Set("SIP/500-00000711", "CCSS_SETUP=TRUE") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-ccss:3] GosubIf("SIP/500-00000711", "0?monitor_config,1(from-internal,081554459):monitor_default,1(from-internal,081554459)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [monitor_default@sub-ccss:1] GotoIf("SIP/500-00000711", "0?is_exten") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [monitor_default@sub-ccss:2] StackPop("SIP/500-00000711", "") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [monitor_default@sub-ccss:3] Return("SIP/500-00000711", "FALSE") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:15] ExecIf("SIP/500-00000711", "0?Set(CHANNEL(language)=)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:16] GotoIf("SIP/500-00000711", "1?continue") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (macro-user-callerid,s,30)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:30] Set("SIP/500-00000711", "CALLERID(number)=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:31] Set("SIP/500-00000711", "CALLERID(name)=nij") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:32] Set("SIP/500-00000711", "CDR(cnum)=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:33] Set("SIP/500-00000711", "CDR(cnam)=nij") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-user-callerid:34] Set("SIP/500-00000711", "CHANNEL(language)=en") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@from-internal:2] Set("SIP/500-00000711", "ROUTEUSER=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@from-internal:3] GotoIf("SIP/500-00000711", "1?notblind") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (from-internal,081554459,6)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@from-internal:6] GotoIf("SIP/500-00000711", "1?restrictedroute-c4ca4238a0b923820dcc509a6f75849b,081554459,2:outbound-allroutes,081554459,2") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (restrictedroute-c4ca4238a0b923820dcc509a6f75849b,081554459,2)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:2] Gosub("SIP/500-00000711", "sub-record-check,s,1(out,081554459,dontcare)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:1] GotoIf("SIP/500-00000711", "0?initialized") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:2] Set("SIP/500-00000711", "__REC_STATUS=INITIALIZED") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:3] Set("SIP/500-00000711", "NOW=1442058783") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:4] Set("SIP/500-00000711", "__DAY=12") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:5] Set("SIP/500-00000711", "__MONTH=09") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:6] Set("SIP/500-00000711", "__YEAR=2015") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:7] Set("SIP/500-00000711", "__TIMESTR=20150912-135303") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:8] Set("SIP/500-00000711", "__FROMEXTEN=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:9] Set("SIP/500-00000711", "__MON_FMT=wav") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:10] NoOp("SIP/500-00000711", "Recordings initialized") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:11] ExecIf("SIP/500-00000711", "0?Set(ARG3=dontcare)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:12] Set("SIP/500-00000711", "REC_POLICY_MODE_SAVE=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:13] ExecIf("SIP/500-00000711", "0?Set(REC_STATUS=NO)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:14] GotoIf("SIP/500-00000711", "3?checkaction") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,s,17)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:17] GotoIf("SIP/500-00000711", "1?sub-record-check,out,1") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,out,1)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:1] NoOp("SIP/500-00000711", "Outbound Recording Check from 500 to 081554459") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:2] Set("SIP/500-00000711", "RECMODE=dontcare") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:3] ExecIf("SIP/500-00000711", "1?Goto(routewins)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,out,7)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:7] Gosub("SIP/500-00000711", "recordcheck,1(dontcare,out,081554459)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/500-00000711", "Starting recording check against dontcare") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [recordcheck@sub-record-check:2] Goto("SIP/500-00000711", "dontcare") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,recordcheck,3)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [recordcheck@sub-record-check:3] Return("SIP/500-00000711", "") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:8] Return("SIP/500-00000711", "") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:3] ExecIf("SIP/500-00000711", "0 ?Set(CDR(accountcode)=)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:4] Set("SIP/500-00000711", "MOHCLASS=none") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:5] ExecIf("SIP/500-00000711", "1?Set(TRUNKCIDOVERRIDE=081980975)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:6] Set("SIP/500-00000711", "_NODEST=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:7] Macro("SIP/500-00000711", "dialout-trunk,2,081554459,,off") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:1] Set("SIP/500-00000711", "DIAL_TRUNK=2") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:2] GosubIf("SIP/500-00000711", "0?sub-pincheck,s,1()") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:3] GotoIf("SIP/500-00000711", "0?disabletrunk,1") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:4] Set("SIP/500-00000711", "DIAL_NUMBER=081554459") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:5] Set("SIP/500-00000711", "DIAL_TRUNK_OPTIONS=Ttr") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:6] Set("SIP/500-00000711", "OUTBOUND_GROUP=OUT_2") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:7] GotoIf("SIP/500-00000711", "1?nomax") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (macro-dialout-trunk,s,9)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:9] GotoIf("SIP/500-00000711", "0?skipoutcid") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:10] Set("SIP/500-00000711", "DIAL_TRUNK_OPTIONS=Tt") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:11] Macro("SIP/500-00000711", "outbound-callerid,2") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:1] ExecIf("SIP/500-00000711", "0?Set(CALLERPRES()=)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:2] ExecIf("SIP/500-00000711", "0?Set(REALCALLERIDNUM=500)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:3] GotoIf("SIP/500-00000711", "1?normcid") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (macro-outbound-callerid,s,6)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:6] Set("SIP/500-00000711", "USEROUTCID=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:7] Set("SIP/500-00000711", "EMERGENCYCID=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:8] Set("SIP/500-00000711", "TRUNKOUTCID=003281980975") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:9] GotoIf("SIP/500-00000711", "1?trunkcid") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (macro-outbound-callerid,s,14)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:14] ExecIf("SIP/500-00000711", "1?Set(CALLERID(all)=003281980975)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:15] ExecIf("SIP/500-00000711", "0?Set(CALLERID(all)=)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:16] ExecIf("SIP/500-00000711", "1?Set(CALLERID(all)=081980975)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:17] ExecIf("SIP/500-00000711", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:18] Set("SIP/500-00000711", "CDR(outbound_cnum)=081980975") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-outbound-callerid:19] Set("SIP/500-00000711", "CDR(outbound_cnam)=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:12] GosubIf("SIP/500-00000711", "0?sub-flp-2,s,1()") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:13] Set("SIP/500-00000711", "OUTNUM=081554459") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:14] Set("SIP/500-00000711", "custom=SIP/OVH") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:15] ExecIf("SIP/500-00000711", "1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^none)Tt)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:16] ExecIf("SIP/500-00000711", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^none)TtM(confirm))") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:17] Macro("SIP/500-00000711", "dialout-trunk-predial-hook,") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("SIP/500-00000711", "") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:18] GotoIf("SIP/500-00000711", "0?bypass,1") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:19] ExecIf("SIP/500-00000711", "1?Set(CONNECTEDLINE(num,i)=081554459)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:20] ExecIf("SIP/500-00000711", "1?Set(CONNECTEDLINE(name,i)=CID:081980975)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:21] GotoIf("SIP/500-00000711", "0?customtrunk") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@macro-dialout-trunk:22] Dial("SIP/500-00000711", "SIP/OVH/081554459,300,M(setmusic^none)Tt") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] netsock2.c: == Using SIP RTP TOS bits 184
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] netsock2.c: == Using SIP RTP CoS mark 5
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] app_dial.c: -- Called SIP/OVH/081554459
[2015-09-12 13:53:07] VERBOSE[1904][C-000012d4] netsock2.c: == Using SIP RTP TOS bits 184
[2015-09-12 13:53:07] VERBOSE[1904][C-000012d4] netsock2.c: == Using SIP RTP CoS mark 5
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [170048222084974@from-sip-external:1] NoOp("SIP/192.168.1.54-00000713", "Received incoming SIP connection from unknown peer to 170048222084974") in new stack
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [170048222084974@from-sip-external:2] Set("SIP/192.168.1.54-00000713", "DID=170048222084974") in new stack
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [170048222084974@from-sip-external:3] Goto("SIP/192.168.1.54-00000713", "s,1") in new stack
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Goto (from-sip-external,s,1)
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:1] GotoIf("SIP/192.168.1.54-00000713", "0?checklang:noanonymous") in new stack
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Goto (from-sip-external,s,5)
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:5] Set("SIP/192.168.1.54-00000713", "TIMEOUT(absolute)=15") in new stack
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] func_timeout.c: -- Channel will hangup at 2015-09-12 13:53:22.070 CEST.
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:6] Log("SIP/192.168.1.54-00000713", "WARNING,"Rejecting unknown SIP connection from 192.151.159.122"") in new stack
[2015-09-12 13:53:07] WARNING[13026][C-000012d4] Ext. s: "Rejecting unknown SIP connection from 192.151.159.122"
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:7] Answer("SIP/192.168.1.54-00000713", "") in new stack
[2015-09-12 13:53:07] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:8] Wait("SIP/192.168.1.54-00000713", "2") in new stack
[2015-09-12 13:53:09] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:9] Playback("SIP/192.168.1.54-00000713", "ss-noservice") in new stack
[2015-09-12 13:53:09] VERBOSE[13026][C-000012d4] file.c: -- <SIP/192.168.1.54-00000713> Playing 'ss-noservice.ulaw' (language 'en')
[2015-09-12 13:53:14] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:10] PlayTones("SIP/192.168.1.54-00000713", "congestion") in new stack
[2015-09-12 13:53:14] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [s@from-sip-external:11] Congestion("SIP/192.168.1.54-00000713", "5") in new stack
[2015-09-12 13:53:19] VERBOSE[13026][C-000012d4] pbx.c: == Spawn extension (from-sip-external, s, 11) exited non-zero on 'SIP/192.168.1.54-00000713'
[2015-09-12 13:53:19] VERBOSE[13026][C-000012d4] pbx.c: -- Executing [h@from-sip-external:1] Hangup("SIP/192.168.1.54-00000713", "") in new stack
[2015-09-12 13:53:19] VERBOSE[13026][C-000012d4] pbx.c: == Spawn extension (from-sip-external, h, 1) exited non-zero on 'SIP/192.168.1.54-00000713'
[2015-09-12 13:53:39] WARNING[1904] chan_sip.c: Retransmission timeout reached on transmission 610121a6e08b4f4cfc898f6b0c3d48a2 for seqno 1 (Critical Response) -- See https://wiki.asterisk.org/wiki/display/AST/SIP+Retransmissions
Packet timed out after 31999ms with no response
[2015-09-12 13:54:00] VERBOSE[13053] pbx_spool.c: -- Attempting call on Local/s@tc-maint for application NoCDR() (Retry 1)
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [s@tc-maint:1] NoCDR("Local/s@tc-maint-00000bbf;2", "") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [s@tc-maint:2] Set("Local/s@tc-maint-00000bbf;2", "TCMAINT=RETURN") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [s@tc-maint:3] Gosub("Local/s@tc-maint-00000bbf;2", "timeconditions,1,1()") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:1] Set("Local/s@tc-maint-00000bbf;2", "DB(TC/1/INUSESTATE)=INUSE") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:2] Set("Local/s@tc-maint-00000bbf;2", "DB(TC/1/NOT_INUSESTATE)=NOT_INUSE") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:3] GotoIfTime("Local/s@tc-maint-00000bbf;2", "20:01-07:59,mon-sun,1-31,jan-dec?truestate") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:4] GotoIf("Local/s@tc-maint-00000bbf;2", "0?truegoto") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:5] ExecIf("Local/s@tc-maint-00000bbf;2", "0?Set(DB(TC/1)=)") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:6] Set("Local/s@tc-maint-00000bbf;2", "DEVICE_STATE(Custom:TC1)=INUSE") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:7] ExecIf("Local/s@tc-maint-00000bbf;2", "0?Set(NOT_INUSE)") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:8] GotoIf("Local/s@tc-maint-00000bbf;2", "0?ivr-1,s,1") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:9] Set("Local/s@tc-maint-00000bbf;2", "TCSTATE=false") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:10] Set("Local/s@tc-maint-00000bbf;2", "TCOVERRIDE=false") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [1@timeconditions:11] Return("Local/s@tc-maint-00000bbf;2", "") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [s@tc-maint:4] System("Local/s@tc-maint-00000bbf;2", "/var/lib/asterisk/bin/schedtc.php 60 /var/spool/asterisk/outgoing 0") in new stack
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: -- Executing [s@tc-maint:5] Answer("Local/s@tc-maint-00000bbf;2", "") in new stack
[2015-09-12 13:54:00] NOTICE[13053] pbx_spool.c: Call completed to Local/s@tc-maint
[2015-09-12 13:54:00] VERBOSE[13054][C-000012d5] pbx.c: == Spawn extension (tc-maint, s, 5) exited non-zero on 'Local/s@tc-maint-00000bbf;2'
nij
Newsterisk
 
Posts: 2
Joined: Sat Sep 12, 2015 5:45 am

Re: Impossible to do an outgoing call

Postby omid_mohajerani » Sat Sep 12, 2015 3:22 pm

You have problem with your sip trunk , check your sip authentication with your ITSP

Log("SIP/192.168.1.54-00000713", "WARNING,"Rejecting unknown SIP connection from 192.151.159.122"") in new stack
[2015-09-12 13:53:07] WARNING[13026][C-000012d4] Ext. s: "Rejecting unknown SIP connection from 192.151.159.122"
omid_mohajerani
Oldsterisk
 
Posts: 109
Joined: Mon Mar 04, 2013 4:19 am

Re: Impossible to do an outgoing call

Postby david55 » Sun Sep 13, 2015 3:22 am

The diagnostics you have highlighted related to incoming calls, not to outgoing ones, and they appear to relate to a call from a local device.

Note that FreePBX dialplan traces of limited use here. For FreePBX expertise you want http://community.freepbx.org/
david55
Moves Like Spencer
 
Posts: 12570
Joined: Fri Sep 26, 2008 5:03 am

Re: Impossible to do an outgoing call

Postby nij » Sun Sep 13, 2015 8:16 am

I think that the log for the outbound call is :

Code: Select all
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (from-internal,081554459,6)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@from-internal:6] GotoIf("SIP/500-00000711", "1?restrictedroute-c4ca4238a0b923820dcc509a6f75849b,081554459,2:outbound-allroutes,081554459,2") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (restrictedroute-c4ca4238a0b923820dcc509a6f75849b,081554459,2)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:2] Gosub("SIP/500-00000711", "sub-record-check,s,1(out,081554459,dontcare)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:1] GotoIf("SIP/500-00000711", "0?initialized") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:2] Set("SIP/500-00000711", "__REC_STATUS=INITIALIZED") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:3] Set("SIP/500-00000711", "NOW=1442058783") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:4] Set("SIP/500-00000711", "__DAY=12") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:5] Set("SIP/500-00000711", "__MONTH=09") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:6] Set("SIP/500-00000711", "__YEAR=2015") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:7] Set("SIP/500-00000711", "__TIMESTR=20150912-135303") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:8] Set("SIP/500-00000711", "__FROMEXTEN=500") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:9] Set("SIP/500-00000711", "__MON_FMT=wav") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:10] NoOp("SIP/500-00000711", "Recordings initialized") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:11] ExecIf("SIP/500-00000711", "0?Set(ARG3=dontcare)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:12] Set("SIP/500-00000711", "REC_POLICY_MODE_SAVE=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:13] ExecIf("SIP/500-00000711", "0?Set(REC_STATUS=NO)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:14] GotoIf("SIP/500-00000711", "3?checkaction") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,s,17)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [s@sub-record-check:17] GotoIf("SIP/500-00000711", "1?sub-record-check,out,1") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,out,1)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:1] NoOp("SIP/500-00000711", "Outbound Recording Check from 500 to 081554459") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:2] Set("SIP/500-00000711", "RECMODE=dontcare") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:3] ExecIf("SIP/500-00000711", "1?Goto(routewins)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,out,7)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:7] Gosub("SIP/500-00000711", "recordcheck,1(dontcare,out,081554459)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [recordcheck@sub-record-check:1] NoOp("SIP/500-00000711", "Starting recording check against dontcare") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [recordcheck@sub-record-check:2] Goto("SIP/500-00000711", "dontcare") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Goto (sub-record-check,recordcheck,3)
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [recordcheck@sub-record-check:3] Return("SIP/500-00000711", "") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [out@sub-record-check:8] Return("SIP/500-00000711", "") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:3] ExecIf("SIP/500-00000711", "0 ?Set(CDR(accountcode)=)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:4] Set("SIP/500-00000711", "MOHCLASS=none") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:5] ExecIf("SIP/500-00000711", "1?Set(TRUNKCIDOVERRIDE=081980975)") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:6] Set("SIP/500-00000711", "_NODEST=") in new stack
[2015-09-12 13:53:03] VERBOSE[13023][C-000012d3] pbx.c: -- Executing [081554459@restrictedroute-c4ca4238a0b923820dcc509a6f75849b:7] Macro("SIP/500-00000711", "dialout-trunk,2,081554459,,off") in new stack
nij
Newsterisk
 
Posts: 2
Joined: Sat Sep 12, 2015 5:45 am

Re: Impossible to do an outgoing call

Postby david55 » Wed Sep 16, 2015 2:27 pm

That's incomplete. In any case, I think the actual dial in FreePBX is hidden in one of their AGI scripts.
david55
Moves Like Spencer
 
Posts: 12570
Joined: Fri Sep 26, 2008 5:03 am


Return to AsteriskNOW Support

Who is online

Users browsing this forum: No registered users and 1 guest