Outbound route: on congestion freepbx doesn't go to next trunk

jeroentjed · May 25, 2023, 4:57pm

Hello all,

I’m setting up a new freepbx and I have two SIP trunks. One is a trunk with unlimited calls but only one simultaneously, the other is a prepaid trunk with unlimited simultaneous calls.
I have a outbound route with both trunks in it. When I make a call it goes thru the first trunk as it should. When I make a second simultaneous call, it doesn’t go thru And I get the voice prompt its not available.
What am I missing? Thanks in advance for having a look into it!

15611	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (from-internal,0853033033,7)	
15612	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] GotoIf("SIP/2000-0000002d", "1?restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2,0853033033,2:outbound-allroutes,0853033033,2") in new stack	
15613	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2,0853033033,2)	
15614	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] Gosub("SIP/2000-0000002d", "sub-record-check,s,1(out,0853033033,dontcare)") in new stack	
15615	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] GotoIf("SIP/2000-0000002d", "0?initialized") in new stack	
15616	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] Set("SIP/2000-0000002d", "__REC_STATUS=INITIALIZED") in new stack	
15617	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] Set("SIP/2000-0000002d", "NOW=1685032437") in new stack	
15618	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] Set("SIP/2000-0000002d", "__DAY=25") in new stack	
15619	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] Set("SIP/2000-0000002d", "__MONTH=05") in new stack	
15620	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002d", "__YEAR=2023") in new stack	
15621	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] Set("SIP/2000-0000002d", "__TIMESTR=20230525-183357") in new stack	
15622	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Set("SIP/2000-0000002d", "__FROMEXTEN=2000") in new stack	
15623	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:9] Set("SIP/2000-0000002d", "__MON_FMT=wav") in new stack	
15624	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:10] NoOp("SIP/2000-0000002d", "Recordings initialized") in new stack	
15625	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:11] ExecIf("SIP/2000-0000002d", "0?Set(ARG3=dontcare)") in new stack	
15626	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:12] Set("SIP/2000-0000002d", "REC_POLICY_MODE_SAVE=") in new stack	
15627	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:13] ExecIf("SIP/2000-0000002d", "0?Set(REC_STATUS=NO)") in new stack	
15628	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:14] GotoIf("SIP/2000-0000002d", "3?checkaction") in new stack	
15629	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (sub-record-check,s,17)	
15630	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:17] GotoIf("SIP/2000-0000002d", "1?sub-record-check,out,1") in new stack	
15631	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (sub-record-check,out,1)	
15632	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] NoOp("SIP/2000-0000002d", "Outbound Recording Check from 2000 to 0853033033") in new stack	
15633	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] Set("SIP/2000-0000002d", "RECMODE=dontcare") in new stack	
15634	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] ExecIf("SIP/2000-0000002d", "1?Goto(routewins)") in new stack	
15635	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (sub-record-check,out,7)	
15636	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] Gosub("SIP/2000-0000002d", "recordcheck,1(dontcare,out,0853033033)") in new stack	
15637	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] NoOp("SIP/2000-0000002d", "Starting recording check against dontcare") in new stack	
15638	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] Goto("SIP/2000-0000002d", "dontcare") in new stack	
15639	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (sub-record-check,recordcheck,3)	
15640	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] Return("SIP/2000-0000002d", "") in new stack	
15641	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Return("SIP/2000-0000002d", "") in new stack	
15642	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] ExecIf("SIP/2000-0000002d", "0 ?Set(CDR(accountcode)=)") in new stack	
15643	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] Set("SIP/2000-0000002d", "_ROUTEID=1") in new stack	
15644	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] Set("SIP/2000-0000002d", "_ROUTENAME=Voipstarr out") in new stack	
15645	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002d", "MOHCLASS=default") in new stack	
15646	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] ExecIf("SIP/2000-0000002d", "1?Set(TRUNKCIDOVERRIDE=<31773971761>)") in new stack	
15647	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Set("SIP/2000-0000002d", "_CALLERIDNAMEINTERNAL=Jeroen") in new stack	
15648	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:9] Set("SIP/2000-0000002d", "_CALLERIDNUMINTERNAL=2000") in new stack	
15649	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:10] Set("SIP/2000-0000002d", "_EMAILNOTIFICATION=TRUE") in new stack	
15650	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:11] Set("SIP/2000-0000002d", "_NODEST=") in new stack	
15651	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:12] Gosub("SIP/2000-0000002d", "sub-send-obroute-email,s,1(0853033033,0853033033,,1685032437,Jeroen,2000)") in new stack	
15652	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] GotoIf("SIP/2000-0000002d", "1?sendEmail") in new stack	
15653	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (sub-send-obroute-email,s,4)	
15654	[2023-05-25 18:33:57] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] AGI("SIP/2000-0000002d", "agi://127.0.0.1/outboundRouteEmail.php,0853033033,0853033033,,1685032437,Jeroen,2000,1,Voipstarr out,Jeroen,2000,1685032437.98,2000,") in new stack	
15655	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] res_agi.c: <SIP/2000-0000002d>AGI Script agi://127.0.0.1/outboundRouteEmail.php completed, returning 0	
15656	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] Return("SIP/2000-0000002d", "") in new stack	
15657	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:13] Macro("SIP/2000-0000002d", "dialout-trunk,1,0853033033,,on") in new stack	
15658	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] Set("SIP/2000-0000002d", "DIAL_TRUNK=1") in new stack	
15659	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] ExecIf("SIP/2000-0000002d", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack	
15660	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] GosubIf("SIP/2000-0000002d", "0?sub-pincheck,s,1()") in new stack	
15661	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(num)=2000)") in new stack	
15662	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] GotoIf("SIP/2000-0000002d", "0?disabletrunk,1") in new stack	
15663	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002d", "DIAL_NUMBER=0853033033") in new stack	
15664	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] Set("SIP/2000-0000002d", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack	
15665	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Set("SIP/2000-0000002d", "OUTBOUND_GROUP=OUT_1") in new stack	
15666	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:9] Set("SIP/2000-0000002d", "DIAL_TRUNK_OPTIONS=T") in new stack	
15667	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:10] GotoIf("SIP/2000-0000002d", "0?nomax") in new stack	
15668	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:11] GotoIf("SIP/2000-0000002d", "1?chanfull") in new stack	
15669	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (macro-dialout-trunk,s,46)	
15670	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:46] NoOp("SIP/2000-0000002d", "max channels used up") in new stack	
15671	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:14] Macro("SIP/2000-0000002d", "dialout-trunk,2,0853033033,,on") in new stack	
15672	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] Set("SIP/2000-0000002d", "DIAL_TRUNK=2") in new stack	
15673	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] ExecIf("SIP/2000-0000002d", "0?Set(DIAL_OPTIONS=Hhtr)") in new stack	
15674	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] GosubIf("SIP/2000-0000002d", "0?sub-pincheck,s,1()") in new stack	
15675	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(num)=2000)") in new stack	
15676	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] GotoIf("SIP/2000-0000002d", "0?disabletrunk,1") in new stack	
15677	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002d", "DIAL_NUMBER=0853033033") in new stack	
15678	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] Set("SIP/2000-0000002d", "DIAL_TRUNK_OPTIONS=HhTtr") in new stack	
15679	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Set("SIP/2000-0000002d", "OUTBOUND_GROUP=OUT_2") in new stack	
15680	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:9] Set("SIP/2000-0000002d", "DIAL_TRUNK_OPTIONS=T") in new stack	
15681	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:10] GotoIf("SIP/2000-0000002d", "0?nomax") in new stack	
15682	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:11] GotoIf("SIP/2000-0000002d", "0?chanfull") in new stack	
15683	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:12] GotoIf("SIP/2000-0000002d", "0?skipoutcid") in new stack	
15684	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:13] Macro("SIP/2000-0000002d", "outbound-callerid,2") in new stack	
15685	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] NoOp("SIP/2000-0000002d", "2000") in new stack	
15686	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] NoOp("SIP/2000-0000002d", "") in new stack	
15687	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] NoOp("SIP/2000-0000002d", "off") in new stack	
15688	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(name-pres)=)") in new stack	
15689	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(num-pres)=)") in new stack	
15690	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002d", "HOTDESCKCHAN=2000-0000002d") in new stack	
15691	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] Set("SIP/2000-0000002d", "HOTDESKEXTEN=2000") in new stack	
15692	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Set("SIP/2000-0000002d", "HOTDESKCALL=0") in new stack	
15693	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:9] ExecIf("SIP/2000-0000002d", "0?Set(HOTDESKCALL=1)") in new stack	
15694	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:10] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(name)=)") in new stack	
15695	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:11] Set("SIP/2000-0000002d", "ALLOWTHISROUTE=NO") in new stack	
15696	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:12] ExecIf("SIP/2000-0000002d", "0?Set(ALLOWTHISROUTE=YES)") in new stack	
15697	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:13] ExecIf("SIP/2000-0000002d", "0?Hangup()") in new stack	
15698	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:14] ExecIf("SIP/2000-0000002d", "0?Set(REALCALLERIDNUM=2000)") in new stack

jeroentjed · May 25, 2023, 4:57pm

Part 2

15699	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:15] ExecIf("SIP/2000-0000002d", "0?Set(AMPUSER=2000)") in new stack	
15700	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:16] GotoIf("SIP/2000-0000002d", "1?normcid") in new stack	
15701	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (macro-outbound-callerid,s,20)	
15702	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:20] Set("SIP/2000-0000002d", "USEROUTCID=") in new stack	
15703	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:21] Set("SIP/2000-0000002d", "EMERGENCYCID=") in new stack	
15704	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:22] ExecIf("SIP/2000-0000002d", "0?Set(SCDEXT=YES)") in new stack	
15705	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:23] ExecIf("SIP/2000-0000002d", "0?Set(EMERGENCYCID=)") in new stack	
15706	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:24] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(name)=)") in new stack	
15707	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:25] ExecIf("SIP/2000-0000002d", "0?Set(EMERGENCYCID=)") in new stack	
15708	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:26] Set("SIP/2000-0000002d", "TRUNKOUTCID=<31852004113>") in new stack	
15709	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:27] GotoIf("SIP/2000-0000002d", "1?trunkcid") in new stack	
15710	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (macro-outbound-callerid,s,33)	
15711	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:33] ExecIf("SIP/2000-0000002d", "1?Set(CALLERID(all)=<31852004113>)") in new stack	
15712	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:34] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(all)=)") in new stack	
15713	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]id:35] ExecIf("SIP/2000-0000002d", "1?Set(CALLERID(all)=<31773971761>)") in new stack	
15714	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:36] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(all)=2000)") in new stack	
15715	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:37] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(all)=2000)") in new stack	
15716	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:38] Set("SIP/2000-0000002d", "TIOHIDE=no") in new stack	
15717	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:39] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(name-pres)=prohib_passed_screen)") in new stack	
15718	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:40] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(num-pres)=prohib_passed_screen)") in new stack	
15719	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:41] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(name-pres)=prohib_passed_screen)") in new stack	
15720	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:42] ExecIf("SIP/2000-0000002d", "0?Set(CALLERID(num-pres)=prohib_passed_screen)") in new stack	
15721	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:43] Set("SIP/2000-0000002d", "CDR(outbound_cnum)=31773971761") in new stack	
15722	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:44] Set("SIP/2000-0000002d", "CDR(outbound_cnam)=") in new stack	
15723	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:14] GosubIf("SIP/2000-0000002d", "0?sub-flp-2,s,1()") in new stack	
15724	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:15] Set("SIP/2000-0000002d", "OUTNUM=0853033033") in new stack	
15725	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:16] Set("SIP/2000-0000002d", "custom=PJSIP") in new stack	
15726	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:17] ExecIf("SIP/2000-0000002d", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default)T)") in new stack	
15727	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:18] ExecIf("SIP/2000-0000002d", "0?Set(DIAL_TRUNK_OPTIONS=TM(confirm))") in new stack	
15728	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:19] ExecIf("SIP/2000-0000002d", "0?AGI(allowlist-autoadd.agi,)") in new stack	
15729	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:20] Macro("SIP/2000-0000002d", "dialout-trunk-predial-hook,") in new stack	
15730	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] MacroExit("SIP/2000-0000002d", "") in new stack	
15731	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:21] GotoIf("SIP/2000-0000002d", "0?skipcrm") in new stack	
15732	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:22] Set("SIP/2000-0000002d", "__CRM_DIRECTION=OUTBOUND") in new stack	
15733	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:23] Set("SIP/2000-0000002d", "__CRM_DESTINATION=0853033033") in new stack	
15734	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:24] Set("SIP/2000-0000002d", "__CRM_SOURCE=2000") in new stack	
15735	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:25] AGI("SIP/2000-0000002d", "agi://127.0.0.1/sangomacrm.agi") in new stack	
15736	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] res_agi.c: <SIP/2000-0000002d>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
15737	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:26] Set("SIP/2000-0000002d", "CHANNEL(hangup_handler_push)=crm-hangup,s,1") in new stack	
15738	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:27] NoOp("SIP/2000-0000002d", "CRM Finished") in new stack	
15739	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:28] GotoIf("SIP/2000-0000002d", "0?bypass,1") in new stack	
15740	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:29] ExecIf("SIP/2000-0000002d", "1?Set(CONNECTEDLINE(num,i)=0853033033)") in new stack	
15741	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:30] ExecIf("SIP/2000-0000002d", "1?Set(CONNECTEDLINE(name,i)=CID:31773971761)") in new stack	
15742	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:31] ExecIf("SIP/2000-0000002d", "0?Set(CONNECTEDLINE(name,i)=CID:(Hidden)31773971761)") in new stack	
15743	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:32] GotoIf("SIP/2000-0000002d", "0?customtrunk") in new stack	
15744	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:33] ExecIf("SIP/2000-0000002d", "0?Set(DIAL_TRUNK_OPTIONS=)") in new stack	
15745	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:34] Set("SIP/2000-0000002d", "HASH(__SIPHEADERS,Alert-Info)=unset") in new stack	
15746	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:35] Dial("SIP/2000-0000002d", "PJSIP/[email protected]_Prepaid,300,Tb(func-apply-sipheaders^s^1,(2))") in new stack	
15747	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] app_stack.c: PJSIP/Voipstarr_Prepaid-00000032 Internal Gosub(func-apply-sipheaders,s,1(2)) start	
15748	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "0?Set(CHANNEL(hangup_handler_push)=crm-hangup,s,1)") in new stack	
15749	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] NoOp("PJSIP/Voipstarr_Prepaid-00000032", "Applying SIP Headers to channel PJSIP/Voipstarr_Prepaid-00000032") in new stack	
15750	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] Set("PJSIP/Voipstarr_Prepaid-00000032", "localchan=Voipstarr_Prepaid-00000032") in new stack	
15751	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] Set("PJSIP/Voipstarr_Prepaid-00000032", "DialMCEXT=Voipstarr_Prepaid") in new stack	
15752	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] Set("PJSIP/Voipstarr_Prepaid-00000032", "CHANNEL(hangup_handler_push)=app-missedcall-hangup,Voipstarr_Prepaid,1") in new stack	
15753	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("PJSIP/Voipstarr_Prepaid-00000032", "TECH=PJSIP") in new stack	
15754	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] Set("PJSIP/Voipstarr_Prepaid-00000032", "SIPHEADERKEYS=Alert-Info") in new stack	
15755	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] While("PJSIP/Voipstarr_Prepaid-00000032", "1") in new stack	
15756	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:9] Set("PJSIP/Voipstarr_Prepaid-00000032", "sipheader=unset") in new stack	
15757	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:10] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "0?SIPRemoveHeader(Alert-Info:)") in new stack	
15758	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:11] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "1?Set(PJSIP_HEADER(remove,Alert-Info)=)") in new stack	
15759	[2023-05-25 18:33:58] ERROR[16928] res_pjsip_header_funcs.c: No headers had been previously added to this session.	
15760	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:12] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "0?Set(sipheader=<http://127.0.0.1>;info=unset)") in new stack	
15761	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:13] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "0?Set(sipheader=<http://127.0.0.1>unset)") in new stack	
15762	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:14] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "0?SIPAddHeader(Alert-Info:unset)") in new stack	
15763	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:15] ExecIf("PJSIP/Voipstarr_Prepaid-00000032", "0?Set(PJSIP_HEADER(add,Alert-Info)=unset)") in new stack	
15764	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:16] EndWhile("PJSIP/Voipstarr_Prepaid-00000032", "") in new stack	
15765	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] While("PJSIP/Voipstarr_Prepaid-00000032", "0") in new stack	
15766	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:17] Return("PJSIP/Voipstarr_Prepaid-00000032", "") in new stack	
15767	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] app_stack.c: Spawn extension (from-pstn, 0853033033, 1) exited non-zero on 'PJSIP/Voipstarr_Prepaid-00000032'	
15768	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] app_stack.c: PJSIP/Voipstarr_Prepaid-00000032 Internal Gosub(func-apply-sipheaders,s,1(2)) complete GOSUB_RETVAL=	
15769	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] app_dial.c: Called PJSIP/[email protected]_Prepaid	
15770	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] app_stack.c: PJSIP/Voipstarr_Prepaid-00000032 Internal Gosub(app-missedcall-hangup,Voipstarr_Prepaid,1) start	
15771	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] NoOp("PJSIP/Voipstarr_Prepaid-00000032", "Dialed: Voipstarr_Prepaid") in new stack	
15772	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] NoOp("PJSIP/Voipstarr_Prepaid-00000032", "Caller: 2000") in new stack	
15773	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] GotoIf("PJSIP/Voipstarr_Prepaid-00000032", "0?exit") in new stack	
15774	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] Set("PJSIP/Voipstarr_Prepaid-00000032", "EXTENNUM=Voipstarr_Prepaid") in new stack	
15775	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] Set("PJSIP/Voipstarr_Prepaid-00000032", "FEXTENNUM=Voipstarr_Prepaid") in new stack	
15776	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] GotoIf("PJSIP/Voipstarr_Prepaid-00000032", "0?exit") in new stack	
15777	[2023-05-25 18:33:58] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] AGI("PJSIP/Voipstarr_Prepaid-00000032", "agi://127.0.0.1/missedcallnotify.php,Voipstarr_Prepaid,,Voipstarr_Prepaid,0,,PJSIP/Voipstarr_Prepaid-00000032,,,,") in new stack	
15778	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] res_agi.c: <PJSIP/Voipstarr_Prepaid-00000032>AGI Script agi://127.0.0.1/missedcallnotify.php completed, returning 0	
15779	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Return("PJSIP/Voipstarr_Prepaid-00000032", "") in new stack	
15780	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] app_stack.c: Spawn extension (from-pstn, 0853033033, 1) exited non-zero on 'PJSIP/Voipstarr_Prepaid-00000032'	
15781	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] app_stack.c: PJSIP/Voipstarr_Prepaid-00000032 Internal Gosub(app-missedcall-hangup,Voipstarr_Prepaid,1) complete GOSUB_RETVAL=	
15782	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] app_dial.c: Everyone is busy/congested at this time (1:0/0/1)	
15783	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:36] NoOp("SIP/2000-0000002d", "Dial failed for some reason with DIALSTATUS = CHANUNAVAIL and HANGUPCAUSE = 21") in new stack	
15784	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:37] GotoIf("SIP/2000-0000002d", "1?continue,1:s-CHANUNAVAIL,1") in new stack	
15785	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx_builtins.c: Goto (macro-dialout-trunk,continue,1)	
15786	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] GotoIf("SIP/2000-0000002d", "0?noreport") in new stack	
15787	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] AGI("SIP/2000-0000002d", "agi://127.0.0.1/[email protected]") in new stack	
15788	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] res_agi.c: <SIP/2000-0000002d>AGI Script agi://127.0.0.1/[email protected] completed, returning 0	
15789	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] NoOp("SIP/2000-0000002d", "TRUNK Dial failed due to CHANUNAVAIL HANGUPCAUSE: 21 - failing through to other trunks") in new stack	
15790	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] ExecIf("SIP/2000-0000002d", "1?Set(CALLERID(number)=2000)") in new stack	
15791	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:15] Macro("SIP/2000-0000002d", "outisbusy,") in new stack	
15792	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] Progress("SIP/2000-0000002d", "") in new stack	
15793	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] GotoIf("SIP/2000-0000002d", "0?emergency,1") in new stack	
15794	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] GotoIf("SIP/2000-0000002d", "0?intracompany,1") in new stack	
15795	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] Playback("SIP/2000-0000002d", "all-circuits-busy-now&please-try-call-later, noanswer") in new stack	
15796	[2023-05-25 18:33:59] VERBOSE[20275][C-00000030] file.c: <SIP/2000-0000002d> Playing 'all-circuits-busy-now.ulaw' (language 'nl')	
15797	[2023-05-25 18:34:01] VERBOSE[20275][C-00000030] file.c: <SIP/2000-0000002d> Playing 'please-try-call-later.ulaw' (language 'nl')	
15798	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] Congestion("SIP/2000-0000002d", "20") in new stack	
15799	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] app_macro.c: Spawn extension (macro-outisbusy, s, 5) exited non-zero on 'SIP/2000-0000002d' in macro 'outisbusy'	
15800	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Spawn extension (restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2, 0853033033, 15) exited non-zero on 'SIP/2000-0000002d'	
15801	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] Hangup("SIP/2000-0000002d", "") in new stack	
15802	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Spawn extension (restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2, h, 1) exited non-zero on 'SIP/2000-0000002d'	
15803	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] app_stack.c: SIP/2000-0000002d Internal Gosub(crm-hangup,s,1) start	
15804	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:1] NoOp("SIP/2000-0000002d", "Sending Hangup to CRM") in new stack	
15805	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:2] NoOp("SIP/2000-0000002d", "HANGUP CAUSE: 34") in new stack	
15806	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:3] ExecIf("SIP/2000-0000002d", "0?Set(__CRM_VOICEMAIL=)") in new stack	
15807	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:4] NoOp("SIP/2000-0000002d", "MASTER CHANNEL: 1685032437.98 = 1685032437.98") in new stack	
15808	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:5] GotoIf("SIP/2000-0000002d", "0?return") in new stack	
15809	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002d", "__CRM_HANGUP=1") in new stack	
15810	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:7] AGI("SIP/2000-0000002d", "agi://127.0.0.1/sangomacrm.agi") in new stack	
15811	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] res_agi.c: <SIP/2000-0000002d>AGI Script agi://127.0.0.1/sangomacrm.agi completed, returning 0	
15812	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] pbx.c: Executing [[email protected]:8] Return("SIP/2000-0000002d", "") in new stack	
15813	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] app_stack.c: Spawn extension (restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2, h, 1) exited non-zero on 'SIP/2000-0000002d'	
15814	[2023-05-25 18:34:04] VERBOSE[20275][C-00000030] app_stack.c: SIP/2000-0000002d Internal Gosub(crm-hangup,s,1) complete GOSUB_RETVAL=	
15815	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] bridge_channel.c: Channel SIP/2000-0000002c left 'simple_bridge' basic-bridge <92810270-0173-4496-a018-f9be46a396a6>	
15816	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] app_macro.c: Spawn extension (macro-dialout-trunk, s, 35) exited non-zero on 'SIP/2000-0000002c' in macro 'dialout-trunk'	
15817	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Spawn extension (restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2, 0612345678, 13) exited non-zero on 'SIP/2000-0000002c'	
15818	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:1] Hangup("SIP/2000-0000002c", "") in new stack	
15819	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Spawn extension (restrictedroute-98c6f2c2287f4c73cea3d40ae7ec3ff2, h, 1) exited non-zero on 'SIP/2000-0000002c'	
15820	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] app_stack.c: SIP/2000-0000002c Internal Gosub(crm-hangup,s,1) start	
15821	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:1] NoOp("SIP/2000-0000002c", "Sending Hangup to CRM") in new stack	
15822	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:2] NoOp("SIP/2000-0000002c", "HANGUP CAUSE: 16") in new stack	
15823	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:3] ExecIf("SIP/2000-0000002c", "0?Set(__CRM_VOICEMAIL=)") in new stack	
15824	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:4] NoOp("SIP/2000-0000002c", "MASTER CHANNEL: 1685032421.96 = 1685032421.96") in new stack	
15825	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:5] GotoIf("SIP/2000-0000002c", "0?return") in new stack	
15826	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:6] Set("SIP/2000-0000002c", "__CRM_HANGUP=1") in new stack	
15827	[2023-05-25 18:34:08] VERBOSE[20188][C-0000002f] pbx.c: Executing [[email protected]:7] AGI("SIP/2000-0000002c", "agi://127.0.0.1/sangomacrm.agi") in new stack	
15828	[2023-05-25 18:34:08] VERBOSE[20226][C-0000002f] bridge_channel.c: Channel PJSIP/Voipstarr_onbeperkt-00000031 left 'simple_bridge' basic-bridge <92810270-0173-4496-a018-f9be46a396a6>

jeroentjed · May 25, 2023, 5:30pm

Strange, I just found out that when I use another trunk (from another provider) as failover trunk, it does work…