TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 28 - failing through to other trunks

kirthGersen · January 26, 2022, 4:56pm

Buongiorno, sto impazzendo da alcuni giorni con la configurazione del mio centralino (Raspberry Pi4 con Asterisk 18 e Freepbx 16). Dopo aver smadonnato con Vodafone che non sbloccava le porte sip ed aver cambiato gestore (tornando a TIM) il centralino ha preso vita.
In ingresso funziona tutto perfettamente:

Chiamate nitide, senza interruzioni improvvise e con passaggi tra interni della chiamata.
In uscita non ne vuol sapere di far partire la chiamata buttando giù la linea ogni volta.
Spulciando il log asterisk salta sempre fuori questo errore:“TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 28 - failing through to other trunks”.
Ho verificato la Causa 28 e risulta che il numero è invalido o scorretto. Da quello che capisco il numero digitato non rispetta il formato indicato nel fascio e/o nelle rotte in uscita. In entrambe è “[0138]X.”
Ho provato anche a mettere “X.” ma senza successo.
Dove sbaglio?

danilosm · January 26, 2022, 5:37pm

Ciao @kirthGersen,
credo che il tuo problema sia di altro tipo; potrei sbagliarmi, ma ci sono pochi dettagli.
Quando effettui una chiamata in uscita alcuni operatori ti chiedono di impostare precisi valori nell’header dell’INVITE nel PAI e nel From.
Posta se ti è possibile il log di asterisk in concomitanza della chiamata in uscita o usa sngrep per tracciare la tua chiamata e verificare che codice di errore ricevi lato trunk. Io credo un 6XX
Ciao

kirthGersen · January 26, 2022, 6:01pm

Eccolo…

[2022-01-26 18:55:31] VERBOSE[2198] netsock2.c: Using SIP RTP Audio TOS bits 184
[2022-01-26 18:55:31] VERBOSE[2198] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2022-01-26 18:55:31] VERBOSE[2198] netsock2.c: Using SIP RTP Audio CoS mark 5
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:1] Macro(“PJSIP/105-0000002f”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/105-0000002f”, “TOUCH_MONITOR=1643219731.47”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/105-0000002f”, “CHANCONTEXT=”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/105-0000002f”, “CHANCONTEXT=”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/105-0000002f”, “CHANEXTENCONTEXT=105-0000002f”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/105-0000002f”, “CHANEXTEN=105-0000002f”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:6] Set(“PJSIP/105-0000002f”, “CALLERID(number)=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/105-0000002f”, “AMPUSER=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:8] Set(“PJSIP/105-0000002f”, “HOTDESCKCHAN=105-0000002f”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:9] Set(“PJSIP/105-0000002f”, “HOTDESKEXTEN=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/105-0000002f”, “HOTDESKCALL=0”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:11] ExecIf(“PJSIP/105-0000002f”, “0?Set(HOTDESKCALL=1)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:12] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(name)=)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“PJSIP/105-0000002f”, “0?report”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/105-0000002f”, “1?Set(REALCALLERIDNUM=105)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:15] Set(“PJSIP/105-0000002f”, “AMPUSER=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:16] GotoIf(“PJSIP/105-0000002f”, “0?limit”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:17] Set(“PJSIP/105-0000002f”, “AMPUSERCIDNAME=Emilio Ferrarese”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(“PJSIP/105-0000002f”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/105-0000002f”, “0?report”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:20] Set(“PJSIP/105-0000002f”, “AMPUSERCID=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:21] Set(“PJSIP/105-0000002f”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:22] Set(“PJSIP/105-0000002f”, “CALLERID(all)=“Emilio Ferrarese” <105>”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:23] ExecIf(“PJSIP/105-0000002f”, “0?Set(CUSDIAL=)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:24] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(all)=“Emilio Ferrarese” <105>)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/105-0000002f”, “0?limit”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/105-0000002f”, “1?Set(GROUP(concurrency_limit)=105)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:27] NoOp(“PJSIP/105-0000002f”, “Macro Depth is 1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/105-0000002f”, “1?report2:macroerror”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:29] GotoIf(“PJSIP/105-0000002f”, “1?continue”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (macro-user-callerid,s,47)
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/105-0000002f”, “CALLERID(number)=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/105-0000002f”, “CALLERID(name)=Emilio Ferrarese”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:49] GotoIf(“PJSIP/105-0000002f”, “0?cnum”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:50] Set(“PJSIP/105-0000002f”, “CDR(cnam)=Emilio Ferrarese”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:51] Set(“PJSIP/105-0000002f”, “CDR(cnum)=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-user-callerid:52] Set(“PJSIP/105-0000002f”, “CHANNEL(language)=it”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:2] Gosub(“PJSIP/105-0000002f”, “sub-record-check,s,1(out,190,dontcare)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/105-0000002f”, “0?initialized”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/105-0000002f”, “__REC_STATUS=INITIALIZED”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/105-0000002f”, “NOW=1643219731”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/105-0000002f”, “__DAY=26”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/105-0000002f”, “__MONTH=01”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/105-0000002f”, “__YEAR=2022”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/105-0000002f”, “__TIMESTR=20220126-185531”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/105-0000002f”, “__FROMEXTEN=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/105-0000002f”, “__MON_FMT=wav”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/105-0000002f”, “Recordings initialized”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/105-0000002f”, “0?Set(ARG3=dontcare)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/105-0000002f”, “REC_POLICY_MODE_SAVE=”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/105-0000002f”, “0?Set(REC_STATUS=NO)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/105-0000002f”, “3?checkaction”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (sub-record-check,s,17)
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/105-0000002f”, “1?sub-record-check,out,1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (sub-record-check,out,1)
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/105-0000002f”, “Outbound Recording Check from 105 to 190”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/105-0000002f”, “RECMODE=dontcare”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/105-0000002f”, “1?Goto(routewins)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (sub-record-check,out,7)
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/105-0000002f”, “recordcheck,1(dontcare,out,190)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/105-0000002f”, “Starting recording check against dontcare”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/105-0000002f”, “dontcare”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/105-0000002f”, “”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/105-0000002f”, “”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:3] Set(“PJSIP/105-0000002f”, “ROUTE_CIDSAVE=“Emilio Ferrarese” <105>”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:4] Set(“PJSIP/105-0000002f”, “_ROUTEID=1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:5] Set(“PJSIP/105-0000002f”, “_ROUTENAME=Ehiweb-uscita”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:6] Set(“PJSIP/105-0000002f”, “MOHCLASS=MusicaPersonale”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:7] Set(“PJSIP/105-0000002f”, “_CALLERIDNAMEINTERNAL=Emilio Ferrarese”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:8] Set(“PJSIP/105-0000002f”, “_CALLERIDNUMINTERNAL=105”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:9] Set(“PJSIP/105-0000002f”, “_EMAILNOTIFICATION=FALSE”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:10] Set(“PJSIP/105-0000002f”, “_NODEST=”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:11] Macro(“PJSIP/105-0000002f”, “dialout-trunk,1,190,on”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/105-0000002f”, “DIAL_TRUNK=1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/105-0000002f”, “0?Set(DIAL_OPTIONS=Hhtr)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/105-0000002f”, “0?sub-pincheck,s,1()”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(num)=105)”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf(“PJSIP/105-0000002f”, “0?disabletrunk,1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/105-0000002f”, “DIAL_NUMBER=190”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/105-0000002f”, “DIAL_TRUNK_OPTIONS=HhTtr”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/105-0000002f”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:9] Set(“PJSIP/105-0000002f”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf(“PJSIP/105-0000002f”, “0?nomax”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/105-0000002f”, “0?chanfull”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf(“PJSIP/105-0000002f”, “0?skipoutcid”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:13] Macro(“PJSIP/105-0000002f”, “outbound-callerid,1”) in new stack
[2022-01-26 18:55:31] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp(“PJSIP/105-0000002f”, “105”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp(“PJSIP/105-0000002f”, “”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp(“PJSIP/105-0000002f”, “off”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(name-pres)=)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(num-pres)=)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:6] Set(“PJSIP/105-0000002f”, “HOTDESCKCHAN=105-0000002f”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:7] Set(“PJSIP/105-0000002f”, “HOTDESKEXTEN=105”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:8] Set(“PJSIP/105-0000002f”, “HOTDESKCALL=0”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf(“PJSIP/105-0000002f”, “0?Set(HOTDESKCALL=1)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(name)=)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:11] Set(“PJSIP/105-0000002f”, “ALLOWTHISROUTE=NO”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf(“PJSIP/105-0000002f”, “0?Set(ALLOWTHISROUTE=YES)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf(“PJSIP/105-0000002f”, “0?Hangup()”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf(“PJSIP/105-0000002f”, “0?Set(REALCALLERIDNUM=105)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf(“PJSIP/105-0000002f”, “0?Set(AMPUSER=105)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf(“PJSIP/105-0000002f”, “1?normcid”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:20] Set(“PJSIP/105-0000002f”, “USEROUTCID=”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:21] Set(“PJSIP/105-0000002f”, “EMERGENCYCID=”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/105-0000002f”, “0?Set(EMERGENCYCID=)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:23] Set(“PJSIP/105-0000002f”, “TRUNKOUTCID=0426322171”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf(“PJSIP/105-0000002f”, “1?trunkcid”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf(“PJSIP/105-0000002f”, “1?Set(CALLERID(all)=0426322171)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(all)=)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(all)=)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(all)=105)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:34] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(all)=105)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:35] Set(“PJSIP/105-0000002f”, “TIOHIDE=no”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(name-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(num-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(name-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:39] ExecIf(“PJSIP/105-0000002f”, “0?Set(CALLERID(num-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:40] Set(“PJSIP/105-0000002f”, “CDR(outbound_cnum)=0426322171”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-outbound-callerid:41] Set(“PJSIP/105-0000002f”, “CDR(outbound_cnam)=”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf(“PJSIP/105-0000002f”, “1?sub-flp-1,s,1()”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@sub-flp-1:1] ExecIf(“PJSIP/105-0000002f”, “1?Return()”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/105-0000002f”, “OUTNUM=190”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:16] Set(“PJSIP/105-0000002f”, “custom=PJSIP”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/105-0000002f”, “1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^MusicaPersonale)T)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf(“PJSIP/105-0000002f”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^MusicaPersonale)TM(confirm))”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:19] Macro(“PJSIP/105-0000002f”, “dialout-trunk-predial-hook,”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/105-0000002f”, “”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf(“PJSIP/105-0000002f”, “0?bypass,1”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf(“PJSIP/105-0000002f”, “1?Set(CONNECTEDLINE(num,i)=190)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:22] ExecIf(“PJSIP/105-0000002f”, “1?Set(CONNECTEDLINE(name,i)=CID:0426322171)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:23] ExecIf(“PJSIP/105-0000002f”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)0426322171)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:24] GotoIf(“PJSIP/105-0000002f”, “0?customtrunk”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:25] ExecIf(“PJSIP/105-0000002f”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^MusicaPersonale))”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:26] Set(“PJSIP/105-0000002f”, “HASH(__SIPHEADERS,Alert-Info)=unset”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:27] Dial(“PJSIP/105-0000002f”, "PJSIP/190@Ehiweb_Voip,300,M(setmusic^MusicaPersonale)Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^190^>
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_stack.c: PJSIP/Ehiweb_Voip-00000030 Internal Gosub(func-apply-sipheaders,s,1(1)) start
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp(“PJSIP/Ehiweb_Voip-00000030”, “Applying SIP Headers to channel PJSIP/Ehiweb_Voip-00000030”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:2] Set(“PJSIP/Ehiweb_Voip-00000030”, “TECH=PJSIP”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“PJSIP/Ehiweb_Voip-00000030”, “SIPHEADERKEYS=Alert-Info”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:4] While(“PJSIP/Ehiweb_Voip-00000030”, “1”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:5] Set(“PJSIP/Ehiweb_Voip-00000030”, “sipheader=unset”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:6] ExecIf(“PJSIP/Ehiweb_Voip-00000030”, “1?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2022-01-26 18:55:32] ERROR[2198] res_pjsip_header_funcs.c: No headers had been previously added to this session.
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(“PJSIP/Ehiweb_Voip-00000030”, “0?Set(sipheader=http://127.0.0.1;info=unset)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf(“PJSIP/Ehiweb_Voip-00000030”, “0?Set(sipheader=http://127.0.0.1unset)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf(“PJSIP/Ehiweb_Voip-00000030”, “0?Set(PJSIP_HEADER(add,Alert-Info)=unset)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:10] EndWhile(“PJSIP/Ehiweb_Voip-00000030”, “”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:4] While(“PJSIP/Ehiweb_Voip-00000030”, “0”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@func-apply-sipheaders:11] Return(“PJSIP/Ehiweb_Voip-00000030”, “”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_stack.c: Spawn extension (from-pstn, 190, 1) exited non-zero on ‘PJSIP/Ehiweb_Voip-00000030’
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_stack.c: PJSIP/Ehiweb_Voip-00000030 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_dial.c: Called PJSIP/190@Ehiweb_Voip
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:28] NoOp(“PJSIP/105-0000002f”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 28”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [s@macro-dialout-trunk:29] GotoIf(“PJSIP/105-0000002f”, “1?continue,1:s-CHANUNAVAIL,1”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp(“PJSIP/105-0000002f”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 28 - failing through to other trunks”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf(“PJSIP/105-0000002f”, “1?Set(CALLERID(number)=105)”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:12] Set(“PJSIP/105-0000002f”, “CALLERID(all)=“Emilio Ferrarese” <105>”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:13] Set(“PJSIP/105-0000002f”, “_KEEPCID=TRUE”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [190@from-internal:14] Goto(“PJSIP/105-0000002f”, “app-blackhole,hangup,1”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx_builtins.c: Goto (app-blackhole,hangup,1)
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [hangup@app-blackhole:1] NoOp(“PJSIP/105-0000002f”, “Blackhole Dest: Hangup”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Executing [hangup@app-blackhole:2] Hangup(“PJSIP/105-0000002f”, “”) in new stack
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] pbx.c: Spawn extension (app-blackhole, hangup, 2) exited non-zero on ‘PJSIP/105-0000002f’

danilosm · January 26, 2022, 6:23pm

L’errore è molto probabilmente quello che ti racontavo

[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_stack.c: PJSIP/Ehiweb_Voip-00000030 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_dial.c: Called PJSIP/190@Ehiweb_Voip
[2022-01-26 18:55:32] VERBOSE[23718][C-00000018] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)

Il provider risponde qualcosa e quindi il PBX prova il trunk successivo che “non esiste”

Fai un debug SIP o usa sngrep e vedrai che ci sarà scritto anche il motivo

pjsip set logger on

Per abilitare il debug su PJSIP

david55 · January 26, 2022, 7:52pm

It’s dialling a number that isn’t a valid PSTN subscriber number. Either it is wrongly thinking that 190 is a PSTN number, or 190 is some sort of Italian special function number which isn’t recognized by the ITSP, or is used as a prefix, but the phone’s dialplan (not the Asterisk one) thinks that numbers beginning with 1 are 3 digit numbers.

kirthGersen · January 26, 2022, 7:59pm

@david55
It’s not only for 190 but from anyone number that i try to call. I use 190 as example

kirthGersen · January 26, 2022, 8:06pm

Ecco cosa sputa fuori il log con il debug attivo del PJSIP (tagliato un poco di righe all’inizio)

[2022-01-26 20:51:48] VERBOSE[2198] netsock2.c: Using SIP RTP Audio TOS bits 184
[2022-01-26 20:51:48] VERBOSE[2198] netsock2.c: Using SIP RTP Audio TOS bits 184 in TCLASS field.
[2022-01-26 20:51:48] VERBOSE[2198] netsock2.c: Using SIP RTP Audio CoS mark 5
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:1] Macro(“PJSIP/105-00000031”, “user-callerid,LIMIT,EXTERNAL,”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:1] Set(“PJSIP/105-00000031”, “TOUCH_MONITOR=1643226708.49”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:2] Set(“PJSIP/105-00000031”, “CHANCONTEXT=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:3] Set(“PJSIP/105-00000031”, “CHANCONTEXT=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:4] Set(“PJSIP/105-00000031”, “CHANEXTENCONTEXT=105-00000031”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:5] Set(“PJSIP/105-00000031”, “CHANEXTEN=105-00000031”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:6] Set(“PJSIP/105-00000031”, “CALLERID(number)=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:7] Set(“PJSIP/105-00000031”, “AMPUSER=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:8] Set(“PJSIP/105-00000031”, “HOTDESCKCHAN=105-00000031”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:9] Set(“PJSIP/105-00000031”, “HOTDESKEXTEN=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:10] Set(“PJSIP/105-00000031”, “HOTDESKCALL=0”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:11] ExecIf(“PJSIP/105-00000031”, “0?Set(HOTDESKCALL=1)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:12] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(name)=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:13] GotoIf(“PJSIP/105-00000031”, “0?report”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:14] ExecIf(“PJSIP/105-00000031”, “1?Set(REALCALLERIDNUM=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:15] Set(“PJSIP/105-00000031”, “AMPUSER=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:16] GotoIf(“PJSIP/105-00000031”, “0?limit”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:17] Set(“PJSIP/105-00000031”, “AMPUSERCIDNAME=Emilio Ferrarese”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:18] ExecIf(“PJSIP/105-00000031”, “0?Set(__CIDMASQUERADING=TRUE)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:19] GotoIf(“PJSIP/105-00000031”, “0?report”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:20] Set(“PJSIP/105-00000031”, “AMPUSERCID=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:21] Set(“PJSIP/105-00000031”, “__DIAL_OPTIONS=HhTtr”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:22] Set(“PJSIP/105-00000031”, “CALLERID(all)=“Emilio Ferrarese” <105>”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:23] ExecIf(“PJSIP/105-00000031”, “0?Set(CUSDIAL=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:24] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(all)=“Emilio Ferrarese” <105>)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:25] GotoIf(“PJSIP/105-00000031”, “0?limit”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:26] ExecIf(“PJSIP/105-00000031”, “1?Set(GROUP(concurrency_limit)=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:27] NoOp(“PJSIP/105-00000031”, “Macro Depth is 1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:28] GotoIf(“PJSIP/105-00000031”, “1?report2:macroerror”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (macro-user-callerid,s,29)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:29] GotoIf(“PJSIP/105-00000031”, “1?continue”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (macro-user-callerid,s,47)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:47] Set(“PJSIP/105-00000031”, “CALLERID(number)=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:48] Set(“PJSIP/105-00000031”, “CALLERID(name)=Emilio Ferrarese”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:49] GotoIf(“PJSIP/105-00000031”, “0?cnum”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:50] Set(“PJSIP/105-00000031”, “CDR(cnam)=Emilio Ferrarese”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:51] Set(“PJSIP/105-00000031”, “CDR(cnum)=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-user-callerid:52] Set(“PJSIP/105-00000031”, “CHANNEL(language)=it”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:2] Gosub(“PJSIP/105-00000031”, “sub-record-check,s,1(out,190,dontcare)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:1] GotoIf(“PJSIP/105-00000031”, “0?initialized”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:2] Set(“PJSIP/105-00000031”, “__REC_STATUS=INITIALIZED”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:3] Set(“PJSIP/105-00000031”, “NOW=1643226708”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:4] Set(“PJSIP/105-00000031”, “__DAY=26”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:5] Set(“PJSIP/105-00000031”, “__MONTH=01”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:6] Set(“PJSIP/105-00000031”, “__YEAR=2022”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:7] Set(“PJSIP/105-00000031”, “__TIMESTR=20220126-205148”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:8] Set(“PJSIP/105-00000031”, “__FROMEXTEN=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:9] Set(“PJSIP/105-00000031”, “__MON_FMT=wav”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:10] NoOp(“PJSIP/105-00000031”, “Recordings initialized”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:11] ExecIf(“PJSIP/105-00000031”, “0?Set(ARG3=dontcare)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:12] Set(“PJSIP/105-00000031”, “REC_POLICY_MODE_SAVE=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:13] ExecIf(“PJSIP/105-00000031”, “0?Set(REC_STATUS=NO)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:14] GotoIf(“PJSIP/105-00000031”, “3?checkaction”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (sub-record-check,s,17)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-record-check:17] GotoIf(“PJSIP/105-00000031”, “1?sub-record-check,out,1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (sub-record-check,out,1)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [out@sub-record-check:1] NoOp(“PJSIP/105-00000031”, “Outbound Recording Check from 105 to 190”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [out@sub-record-check:2] Set(“PJSIP/105-00000031”, “RECMODE=dontcare”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [out@sub-record-check:3] ExecIf(“PJSIP/105-00000031”, “1?Goto(routewins)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (sub-record-check,out,7)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [out@sub-record-check:7] Gosub(“PJSIP/105-00000031”, “recordcheck,1(dontcare,out,190)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [recordcheck@sub-record-check:1] NoOp(“PJSIP/105-00000031”, “Starting recording check against dontcare”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [recordcheck@sub-record-check:2] Goto(“PJSIP/105-00000031”, “dontcare”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [recordcheck@sub-record-check:3] Return(“PJSIP/105-00000031”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [out@sub-record-check:8] Return(“PJSIP/105-00000031”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:3] Set(“PJSIP/105-00000031”, “ROUTE_CIDSAVE=“Emilio Ferrarese” <105>”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:4] Set(“PJSIP/105-00000031”, “_ROUTEID=1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:5] Set(“PJSIP/105-00000031”, “_ROUTENAME=Ehiweb-uscita”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:6] Set(“PJSIP/105-00000031”, “MOHCLASS=MusicaPersonale”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:7] Set(“PJSIP/105-00000031”, “_CALLERIDNAMEINTERNAL=Emilio Ferrarese”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:8] Set(“PJSIP/105-00000031”, “_CALLERIDNUMINTERNAL=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:9] Set(“PJSIP/105-00000031”, “_EMAILNOTIFICATION=FALSE”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:10] Set(“PJSIP/105-00000031”, “_NODEST=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:11] Macro(“PJSIP/105-00000031”, “dialout-trunk,1,190,on”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:1] Set(“PJSIP/105-00000031”, “DIAL_TRUNK=1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:2] ExecIf(“PJSIP/105-00000031”, “0?Set(DIAL_OPTIONS=Hhtr)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:3] GosubIf(“PJSIP/105-00000031”, “0?sub-pincheck,s,1()”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:4] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(num)=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:5] GotoIf(“PJSIP/105-00000031”, “0?disabletrunk,1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:6] Set(“PJSIP/105-00000031”, “DIAL_NUMBER=190”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:7] Set(“PJSIP/105-00000031”, “DIAL_TRUNK_OPTIONS=HhTtr”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:8] Set(“PJSIP/105-00000031”, “OUTBOUND_GROUP=OUT_1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:9] Set(“PJSIP/105-00000031”, “DIAL_TRUNK_OPTIONS=T”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:10] GotoIf(“PJSIP/105-00000031”, “0?nomax”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:11] GotoIf(“PJSIP/105-00000031”, “0?chanfull”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:12] GotoIf(“PJSIP/105-00000031”, “0?skipoutcid”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:13] Macro(“PJSIP/105-00000031”, “outbound-callerid,1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:1] NoOp(“PJSIP/105-00000031”, “105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:2] NoOp(“PJSIP/105-00000031”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:3] NoOp(“PJSIP/105-00000031”, “off”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:4] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(name-pres)=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:5] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(num-pres)=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:6] Set(“PJSIP/105-00000031”, “HOTDESCKCHAN=105-00000031”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:7] Set(“PJSIP/105-00000031”, “HOTDESKEXTEN=105”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:8] Set(“PJSIP/105-00000031”, “HOTDESKCALL=0”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:9] ExecIf(“PJSIP/105-00000031”, “0?Set(HOTDESKCALL=1)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:10] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(name)=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:11] Set(“PJSIP/105-00000031”, “ALLOWTHISROUTE=NO”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:12] ExecIf(“PJSIP/105-00000031”, “0?Set(ALLOWTHISROUTE=YES)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:13] ExecIf(“PJSIP/105-00000031”, “0?Hangup()”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:14] ExecIf(“PJSIP/105-00000031”, “0?Set(REALCALLERIDNUM=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:15] ExecIf(“PJSIP/105-00000031”, “0?Set(AMPUSER=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:16] GotoIf(“PJSIP/105-00000031”, “1?normcid”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:20] Set(“PJSIP/105-00000031”, “USEROUTCID=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:21] Set(“PJSIP/105-00000031”, “EMERGENCYCID=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:22] ExecIf(“PJSIP/105-00000031”, “0?Set(EMERGENCYCID=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:23] Set(“PJSIP/105-00000031”, “TRUNKOUTCID=0426322171”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:24] GotoIf(“PJSIP/105-00000031”, “1?trunkcid”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (macro-outbound-callerid,s,30)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:30] ExecIf(“PJSIP/105-00000031”, “1?Set(CALLERID(all)=0426322171)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:31] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(all)=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:32] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(all)=)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:33] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(all)=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:34] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(all)=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:35] Set(“PJSIP/105-00000031”, “TIOHIDE=no”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:36] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(name-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:37] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(num-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:38] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(name-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:39] ExecIf(“PJSIP/105-00000031”, “0?Set(CALLERID(num-pres)=prohib_passed_screen)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:40] Set(“PJSIP/105-00000031”, “CDR(outbound_cnum)=0426322171”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-outbound-callerid:41] Set(“PJSIP/105-00000031”, “CDR(outbound_cnam)=”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:14] GosubIf(“PJSIP/105-00000031”, “1?sub-flp-1,s,1()”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@sub-flp-1:1] ExecIf(“PJSIP/105-00000031”, “1?Return()”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:15] Set(“PJSIP/105-00000031”, “OUTNUM=190”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:16] Set(“PJSIP/105-00000031”, “custom=PJSIP”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:17] ExecIf(“PJSIP/105-00000031”, “1?Set(DIAL_TRUNK_OPTIONS=M(setmusic^MusicaPersonale)T)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:18] ExecIf(“PJSIP/105-00000031”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^MusicaPersonale)TM(confirm))”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:19] Macro(“PJSIP/105-00000031”, “dialout-trunk-predial-hook,”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“PJSIP/105-00000031”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:20] GotoIf(“PJSIP/105-00000031”, “0?bypass,1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:21] ExecIf(“PJSIP/105-00000031”, “1?Set(CONNECTEDLINE(num,i)=190)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:22] ExecIf(“PJSIP/105-00000031”, “1?Set(CONNECTEDLINE(name,i)=CID:0426322171)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:23] ExecIf(“PJSIP/105-00000031”, “0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)0426322171)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:24] GotoIf(“PJSIP/105-00000031”, “0?customtrunk”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:25] ExecIf(“PJSIP/105-00000031”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^MusicaPersonale))”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:26] Set(“PJSIP/105-00000031”, “HASH(__SIPHEADERS,Alert-Info)=unset”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:27] Dial(“PJSIP/105-00000031”, “PJSIP/190@Ehiweb_Voip,300,M(setmusic^MusicaPersonale)Tb(func-apply-sipheaders^s^1,(1))U(sub-send-obroute-email^190^190^1^1643226708^^0426322171)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] app_stack.c: PJSIP/Ehiweb_Voip-00000032 Internal Gosub(func-apply-sipheaders,s,1(1)) start
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:1] NoOp(“PJSIP/Ehiweb_Voip-00000032”, “Applying SIP Headers to channel PJSIP/Ehiweb_Voip-00000032”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:2] Set(“PJSIP/Ehiweb_Voip-00000032”, “TECH=PJSIP”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:3] Set(“PJSIP/Ehiweb_Voip-00000032”, “SIPHEADERKEYS=Alert-Info”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:4] While(“PJSIP/Ehiweb_Voip-00000032”, “1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:5] Set(“PJSIP/Ehiweb_Voip-00000032”, “sipheader=unset”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:6] ExecIf(“PJSIP/Ehiweb_Voip-00000032”, “1?Set(PJSIP_HEADER(remove,Alert-Info)=)”) in new stack
[2022-01-26 20:51:48] ERROR[2198] res_pjsip_header_funcs.c: No headers had been previously added to this session.
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:7] ExecIf(“PJSIP/Ehiweb_Voip-00000032”, “0?Set(sipheader=http://127.0.0.1;info=unset)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:8] ExecIf(“PJSIP/Ehiweb_Voip-00000032”, “0?Set(sipheader=http://127.0.0.1unset)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:9] ExecIf(“PJSIP/Ehiweb_Voip-00000032”, “0?Set(PJSIP_HEADER(add,Alert-Info)=unset)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:10] EndWhile(“PJSIP/Ehiweb_Voip-00000032”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:4] While(“PJSIP/Ehiweb_Voip-00000032”, “0”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@func-apply-sipheaders:11] Return(“PJSIP/Ehiweb_Voip-00000032”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] app_stack.c: Spawn extension (from-pstn, 190, 1) exited non-zero on ‘PJSIP/Ehiweb_Voip-00000032’
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] app_stack.c: PJSIP/Ehiweb_Voip-00000032 Internal Gosub(func-apply-sipheaders,s,1(1)) complete GOSUB_RETVAL=
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] app_dial.c: Called PJSIP/190@Ehiweb_Voip
[2022-01-26 20:51:48] VERBOSE[2198] res_pjsip_logger.c: <— Transmitting SIP request (1092 bytes) to UDP:83.211.227.21:5060 —>
INVITE sip:voip.vivavox.it SIP/2.0
Via: SIP/2.0/UDP 87.26.58.142:5060;rport;branch=z9hG4bKPj67bda7f4-4604-4ad1-99db-96b471bc63bb
From: sip:[email protected];tag=a5ee957d-02a1-4fb1-ae6a-e575262de759
To: sip:[email protected]
Contact: sip:[email protected]:5060
Call-ID: 6152c56e-6ae7-4d92-b2ca-617e036afbe8
CSeq: 1987 INVITE
Allow: OPTIONS, REGISTER, SUBSCRIBE, NOTIFY, PUBLISH, INVITE, ACK, BYE, CANCEL, UPDATE, PRACK, REFER, MESSAGE
Supported: 100rel, timer, replaces, norefersub, histinfo
Session-Expires: 1800
Min-SE: 90
Route: sip:[email protected]:5060
Max-Forwards: 70
User-Agent: FPBX-16.0.10.49(18.9.0)
Content-Type: application/sdp
Content-Length: 384

v=0
o=- 542211386 542211386 IN IP4 87.26.58.142
s=Asterisk
c=IN IP4 87.26.58.142
t=0 0
m=audio 19206 RTP/AVP 0 8 111 18 3 9 101
a=rtpmap:0 PCMU/8000
a=rtpmap:8 PCMA/8000
a=rtpmap:111 G726-32/8000
a=rtpmap:18 G729/8000
a=fmtp:18 annexb=no
a=rtpmap:3 GSM/8000
a=rtpmap:9 G722/8000
a=rtpmap:101 telephone-event/8000
a=fmtp:101 0-16
a=ptime:20
a=maxptime:150
a=sendrecv

[2022-01-26 20:51:48] VERBOSE[2197] res_pjsip_logger.c: <— Received SIP response (420 bytes) from UDP:83.211.227.21:5060 —>
SIP/2.0 484 Address Incomplete
Via: SIP/2.0/UDP 87.26.58.142:5060;received=87.26.58.142;rport=5060;branch=z9hG4bKPj67bda7f4-4604-4ad1-99db-96b471bc63bb
From: sip:[email protected];tag=a5ee957d-02a1-4fb1-ae6a-e575262de759
To: sip:[email protected];tag=2285.70b4daaf5827d210088a1e5333e62054
Call-ID: 6152c56e-6ae7-4d92-b2ca-617e036afbe8
CSeq: 1987 INVITE
Server: Roma Naz SPS 03
Content-Length: 0

[2022-01-26 20:51:48] VERBOSE[2198] res_pjsip_logger.c: <— Transmitting SIP request (461 bytes) to UDP:83.211.227.21:5060 —>
ACK sip:voip.vivavox.it SIP/2.0
Via: SIP/2.0/UDP 87.26.58.142:5060;rport;branch=z9hG4bKPj67bda7f4-4604-4ad1-99db-96b471bc63bb
From: sip:[email protected];tag=a5ee957d-02a1-4fb1-ae6a-e575262de759
To: sip:[email protected];tag=2285.70b4daaf5827d210088a1e5333e62054
Call-ID: 6152c56e-6ae7-4d92-b2ca-617e036afbe8
CSeq: 1987 ACK
Route: sip:[email protected]:5060
Max-Forwards: 70
User-Agent: FPBX-16.0.10.49(18.9.0)
Content-Length: 0

[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:28] NoOp(“PJSIP/105-00000031”, “Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 28”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [s@macro-dialout-trunk:29] GotoIf(“PJSIP/105-00000031”, “1?continue,1:s-CHANUNAVAIL,1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [continue@macro-dialout-trunk:1] NoOp(“PJSIP/105-00000031”, “TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 28 - failing through to other trunks”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [continue@macro-dialout-trunk:2] ExecIf(“PJSIP/105-00000031”, “1?Set(CALLERID(number)=105)”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:12] Set(“PJSIP/105-00000031”, “CALLERID(all)=“Emilio Ferrarese” <105>”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:13] Set(“PJSIP/105-00000031”, “_KEEPCID=TRUE”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [190@from-internal:14] Goto(“PJSIP/105-00000031”, “app-blackhole,hangup,1”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx_builtins.c: Goto (app-blackhole,hangup,1)
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [hangup@app-blackhole:1] NoOp(“PJSIP/105-00000031”, “Blackhole Dest: Hangup”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Executing [hangup@app-blackhole:2] Hangup(“PJSIP/105-00000031”, “”) in new stack
[2022-01-26 20:51:48] VERBOSE[6687][C-00000019] pbx.c: Spawn extension (app-blackhole, hangup, 2) exited non-zero on ‘PJSIP/105-00000031’
[2022-01-26 20:51:48] VERBOSE[2198] res_pjsip_logger.c: <— Transmitting SIP response (469 bytes) to UDP:192.168.3.35:5060 —>
SIP/2.0 484 Address Incomplete
Via: SIP/2.0/UDP 192.168.3.35:5060;rport=5060;received=192.168.3.35;branch=z9hG4bK-e9ff3da7
Call-ID: [email protected]
From: “Emilio Ferrarese” sip:[email protected];tag=d15ef72a6b95434bo0
To: sip:[email protected];tag=28fbd854-0bef-42f6-a756-2869361bd275
CSeq: 102 INVITE
Server: FPBX-16.0.10.49(18.9.0)
Reason: Q.850;cause=28
P-Asserted-Identity: “CID:0426322171” sip:[email protected]
Content-Length: 0

[2022-01-26 20:51:48] VERBOSE[2197] res_pjsip_logger.c: <— Received SIP request (682 bytes) from UDP:192.168.3.35:5060 —>
ACK sip:[email protected] SIP/2.0
Via: SIP/2.0/UDP 192.168.3.35:5060;branch=z9hG4bK-e9ff3da7
From: “Emilio Ferrarese” sip:[email protected];tag=d15ef72a6b95434bo0
To: sip:[email protected];tag=28fbd854-0bef-42f6-a756-2869361bd275
Call-ID: [email protected]
CSeq: 102 ACK
Max-Forwards: 70
Authorization: Digest username=“105”,realm=“asterisk”,nonce=“1643226708/2ebd530aa72de5e6a347754eed24269e”,uri="sip:[email protected]",algorithm=MD5,response=“80de989f3d794c2367053e2488bc26e5”,opaque=“42fc2f614ba8cd4d”,qop=auth,nc=00000001,cnonce=“82f3f3e8”
Contact: “Emilio Ferrarese” sip:[email protected]:5060
User-Agent: Linksys/SPA922-5.2.8
Content-Length: 0

[2022-01-26 20:51:51] VERBOSE[2198] res_pjsip_logger.c: <— Transmitting SIP request (518 bytes) to UDP:83.211.227.21:5060 —>
OPTIONS sip:voip.vivavox.it SIP/2.0
Via: SIP/2.0/UDP 87.26.58.142:5060;rport;branch=z9hG4bKPjf0e14e07-b556-4097-9959-b3b995a8d2ed
From: sip:[email protected];tag=5ae60c9c-36cb-4bf8-9f34-7c4e95e06672
To: sip:[email protected]
Contact: sip:[email protected]:5060
Call-ID: e08e99bb-76af-41a3-84f7-f4574f253220
CSeq: 12233 OPTIONS
Route: sip:voip.vivavox.it
Route: sip:[email protected]:5060
Max-Forwards: 70
User-Agent: FPBX-16.0.10.49(18.9.0)
Content-Length: 0

[2022-01-26 20:51:51] VERBOSE[2197] res_pjsip_logger.c: <— Received SIP response (448 bytes) from UDP:83.211.227.21:5060 —>
SIP/2.0 200 OK
Via: SIP/2.0/UDP 87.26.58.142:5060;received=87.26.58.142;rport=5060;branch=z9hG4bKPjf0e14e07-b556-4097-9959-b3b995a8d2ed
From: sip:[email protected];tag=5ae60c9c-36cb-4bf8-9f34-7c4e95e06672
To: sip:[email protected];tag=2285.e261a0c7d6eb43983b2edf474ab06d04
Call-ID: e08e99bb-76af-41a3-84f7-f4574f253220
CSeq: 12233 OPTIONS
Accept: /
Accept-Language: en
Server: Roma Naz SPS 02
Content-Length: 0

Se ho letto bene ad un certo punto appare questa segnalazione:

[2022-01-26 20:51:48] VERBOSE[2197] res_pjsip_logger.c: <— Received SIP response (420 bytes) from UDP:83.211.227.21:5060 —>
SIP/2.0 484 Address Incomplete

Dovrebbe essere questo il problema.
Come lo risolvo?

dicko · January 26, 2022, 8:59pm

So check with voip.vivavox.it what you should be dialing to get to wherever you are currently dialing 0426046603 for, they won’t complete calls to unknown destinations.

https://networking.ringofsaturn.com/Routers/isdncausecodes.php

specifically

Cause No. 28 - invalid number format (address incomplete).

I find a reference to 0426 – Province of Rovigo – area of Adria

in

Stewart1 · January 27, 2022, 5:54am

There is a bug, or something is wrong with the trunk configuration. Assuming that you dialed 190 and that’s what should be sent on the trunk, the INVITE should read
INVITE sip:[email protected] SIP/2.0
I believe the problem is caused by the Outbound Proxy setting for the trunk. If you don’t have one (the field was left blank), I don’t know what may be wrong. If you have a setting like
Outbound Proxy: sip:voip.vivavox.it
please try deleting that and retest. If you have some other setting, for example
Outbound Proxy: sip:1.2.3.4
because you need to send the request to a specific server, try changing that to
Outbound Proxy: sip:1.2.3.4\;lr\;hide
and retest.

If you still have trouble, paste a new log (with Outbound Proxy blank or with the ;lr;hide options) and post the link here.

Also, are you sure that 190 is a valid number for Vivavox? You might try testing with a landline or mobile destination instead.

kirthGersen · January 27, 2022, 9:03am

SOLVED! You are my hero.
I left blank Outbound Proxy (before: sip:voip.vivavox.it) Freepbx show warning but all works well. Thanks

Stewart1 · January 27, 2022, 3:17pm

What is the warning? It may be a symptom of another config issue.

system · February 3, 2022, 3:18pm

This topic was automatically closed 7 days after the last reply. New replies are no longer allowed.