Internal call with tonality ok but no ring

We actually do not have internal calls available. We have 3 extensions 1001-1003 and a fax.
When an extension X phones extension Y, tonality is ok. but Y doesn’t ring.

A bit lost actually,

Here is a complete call resumed in cdr report under

2012-10-24 11:01:25 1351069285.20 SIP 1002 Dial 1001 SIP NO ANSWER 00:05

== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [1001@Userout:1] Macro(“SIP/1002-00000014”, “user-callerid,LIMIT,”) in new stack
– Executing [s@macro-user-callerid:1] Set(“SIP/1002-00000014”, “AMPUSER=1002”) in new stack
– Executing [s@macro-user-callerid:2] GotoIf(“SIP/1002-00000014”, “0?report”) in new stack
– Executing [s@macro-user-callerid:3] ExecIf(“SIP/1002-00000014”, “1?Set(REALCALLERIDNUM=1002)”) in new stack
– Executing [s@macro-user-callerid:4] Set(“SIP/1002-00000014”, “AMPUSER=1002”) in new stack
– Executing [s@macro-user-callerid:5] Set(“SIP/1002-00000014”, “AMPUSERCIDNAME=1002”) in new stack
– Executing [s@macro-user-callerid:6] GotoIf(“SIP/1002-00000014”, “0?report”) in new stack
– Executing [s@macro-user-callerid:7] Set(“SIP/1002-00000014”, “AMPUSERCID=1002”) in new stack
– Executing [s@macro-user-callerid:8] Set(“SIP/1002-00000014”, “CALLERID(all)=“1002” <1002>”) in new stack
– Executing [s@macro-user-callerid:9] GotoIf(“SIP/1002-00000014”, “0?limit”) in new stack
– Executing [s@macro-user-callerid:10] ExecIf(“SIP/1002-00000014”, “1?Set(GROUP(concurrency_limit)=1002)”) in new stack
– Executing [s@macro-user-callerid:11] ExecIf(“SIP/1002-00000014”, “1?Set(CHANNEL(language)=fr)”) in new stack
– Executing [s@macro-user-callerid:12] GotoIf(“SIP/1002-00000014”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,25)
– Executing [s@macro-user-callerid:25] Set(“SIP/1002-00000014”, “CALLERID(number)=1002”) in new stack
– Executing [s@macro-user-callerid:26] Set(“SIP/1002-00000014”, “CALLERID(name)=1002”) in new stack
– Executing [s@macro-user-callerid:27] Set(“SIP/1002-00000014”, “CHANNEL(language)=fr”) in new stack
– Executing [1001@Userout:2] Set(“SIP/1002-00000014”, “MOHCLASS=default”) in new stack
– Executing [1001@Userout:3] ExecIf(“SIP/1002-00000014”, “0?Set(TRUNKCIDOVERRIDE=“123456789” <024613576>)”) in new stack
– Executing [1001@Userout:4] Set(“SIP/1002-00000014”, “_NODEST=”) in new stack
– Executing [1001@Userout:5] Gosub(“SIP/1002-00000014”, “sub-record-check,s,1(out,1001,)”) in new stack
– Executing [s@sub-record-check:1] GotoIf(“SIP/1002-00000014”, “1?check”) in new stack
– Goto (sub-record-check,s,3)
– Executing [s@sub-record-check:3] Set(“SIP/1002-00000014”, “MON_FMT=wav”) in new stack
– Executing [s@sub-record-check:4] GotoIf(“SIP/1002-00000014”, “1?next”) in new stack
– Goto (sub-record-check,s,7)
– Executing [s@sub-record-check:7] ExecIf(“SIP/1002-00000014”, “0?Return()”) in new stack
– Executing [s@sub-record-check:8] GotoIf(“SIP/1002-00000014”, “0?out,1”) in new stack
– Executing [s@sub-record-check:9] Set(“SIP/1002-00000014”, “__REC_STATUS=INITIALIZED”) in new stack
– Executing [s@sub-record-check:10] ExecIf(“SIP/1002-00000014”, “0?Set(__REC_POLICY_MODE=)”) in new stack
– Executing [s@sub-record-check:11] Set(“SIP/1002-00000014”, “NOW=1351069285”) in new stack
– Executing [s@sub-record-check:12] Set(“SIP/1002-00000014”, “__DAY=24”) in new stack
– Executing [s@sub-record-check:13] Set(“SIP/1002-00000014”, “__MONTH=10”) in new stack
– Executing [s@sub-record-check:14] Set(“SIP/1002-00000014”, “__YEAR=2012”) in new stack
– Executing [s@sub-record-check:15] Set(“SIP/1002-00000014”, “__TIMESTR=20121024-110125”) in new stack
– Executing [s@sub-record-check:16] Set(“SIP/1002-00000014”, “__FROMEXTEN=1002”) in new stack
– Executing [s@sub-record-check:17] Set(“SIP/1002-00000014”, “__CALLFILENAME=out-1001-1002-20121024-110125-1351069285.20”) in new stack
– Executing [s@sub-record-check:18] Goto(“SIP/1002-00000014”, “out,1”) in new stack
– Goto (sub-record-check,out,1)
– Executing [out@sub-record-check:1] ExecIf(“SIP/1002-00000014”, “1?Set(__REC_POLICY_MODE=dontcare)”) in new stack
– Executing [out@sub-record-check:2] GosubIf(“SIP/1002-00000014”, “0?record,1(exten,1001,1002)”) in new stack
– Executing [out@sub-record-check:3] Return(“SIP/1002-00000014”, “”) in new stack
– Executing [1001@Userout:6] Macro(“SIP/1002-00000014”, “dialout-trunk,1,1001,”) in new stack
– Executing [s@macro-dialout-trunk:1] Set(“SIP/1002-00000014”, “DIAL_TRUNK=1”) in new stack
– Executing [s@macro-dialout-trunk:2] GosubIf(“SIP/1002-00000014”, “0?sub-pincheck,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:3] GotoIf(“SIP/1002-00000014”, “0?disabletrunk,1”) in new stack
– Executing [s@macro-dialout-trunk:4] Set(“SIP/1002-00000014”, “DIAL_NUMBER=1001”) in new stack
– Executing [s@macro-dialout-trunk:5] Set(“SIP/1002-00000014”, “DIAL_TRUNK_OPTIONS=tr”) in new stack
– Executing [s@macro-dialout-trunk:6] Set(“SIP/1002-00000014”, “OUTBOUND_GROUP=OUT_1”) in new stack
– Executing [s@macro-dialout-trunk:7] GotoIf(“SIP/1002-00000014”, “0?nomax”) in new stack
– Executing [s@macro-dialout-trunk:8] GotoIf(“SIP/1002-00000014”, “0?chanfull”) in new stack
– Executing [s@macro-dialout-trunk:9] GotoIf(“SIP/1002-00000014”, “0?skipoutcid”) in new stack
– Executing [s@macro-dialout-trunk:10] Set(“SIP/1002-00000014”, “DIAL_TRUNK_OPTIONS=”) in new stack
– Executing [s@macro-dialout-trunk:11] Macro(“SIP/1002-00000014”, “outbound-callerid,1”) in new stack
– Executing [s@macro-outbound-callerid:1] ExecIf(“SIP/1002-00000014”, “0?Set(CALLERPRES()=)”) in new stack
– Executing [s@macro-outbound-callerid:2] ExecIf(“SIP/1002-00000014”, “0?Set(REALCALLERIDNUM=1002)”) in new stack
– Executing [s@macro-outbound-callerid:3] GotoIf(“SIP/1002-00000014”, “1?normcid”) in new stack
– Goto (macro-outbound-callerid,s,6)
– Executing [s@macro-outbound-callerid:6] Set(“SIP/1002-00000014”, “USEROUTCID=“123456789” <024613577>”) in new stack
– Executing [s@macro-outbound-callerid:7] Set(“SIP/1002-00000014”, “EMERGENCYCID=”) in new stack
– Executing [s@macro-outbound-callerid:8] Set(“SIP/1002-00000014”, “TRUNKOUTCID=”) in new stack
– Executing [s@macro-outbound-callerid:9] GotoIf(“SIP/1002-00000014”, “1?trunkcid”) in new stack
– Goto (macro-outbound-callerid,s,12)
– Executing [s@macro-outbound-callerid:12] ExecIf(“SIP/1002-00000014”, “0?Set(CALLERID(all)=)”) in new stack
– Executing [s@macro-outbound-callerid:13] ExecIf(“SIP/1002-00000014”, “1?Set(CALLERID(all)=“123456789” <024613577>)”) in new stack
– Executing [s@macro-outbound-callerid:14] ExecIf(“SIP/1002-00000014”, “0?Set(CALLERID(all)=)”) in new stack
– Executing [s@macro-outbound-callerid:15] ExecIf(“SIP/1002-00000014”, “0?Set(CALLERPRES()=prohib_passed_screen)”) in new stack
– Executing [s@macro-dialout-trunk:12] GosubIf(“SIP/1002-00000014”, “0?sub-flp-1,s,1()”) in new stack
– Executing [s@macro-dialout-trunk:13] Set(“SIP/1002-00000014”, “OUTNUM=1001”) in new stack
– Executing [s@macro-dialout-trunk:14] Set(“SIP/1002-00000014”, “custom=SIP/MyDivert”) in new stack
– Executing [s@macro-dialout-trunk:15] ExecIf(“SIP/1002-00000014”, “0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^default))”) in new stack
– Executing [s@macro-dialout-trunk:16] ExecIf(“SIP/1002-00000014”, “0?Set(DIAL_TRUNK_OPTIONS=M(confirm))”) in new stack
– Executing [s@macro-dialout-trunk:17] Macro(“SIP/1002-00000014”, “dialout-trunk-predial-hook,”) in new stack
– Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/1002-00000014”, “”) in new stack
– Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/1002-00000014”, “0?bypass,1”) in new stack
– Executing [s@macro-dialout-trunk:19] ExecIf(“SIP/1002-00000014”, “1?Set(CONNECTEDLINE(num,i)=1001)”) in new stack
– Executing [s@macro-dialout-trunk:20] ExecIf(“SIP/1002-00000014”, “1?Set(CONNECTEDLINE(name,i)=CID:024613577)”) in new stack
– Executing [s@macro-dialout-trunk:21] GotoIf(“SIP/1002-00000014”, “0?customtrunk”) in new stack
– Executing [s@macro-dialout-trunk:22] Dial(“SIP/1002-00000014”, “SIP/MyDivert/1001,300,”) in new stack

Hi again,
Any Idea about this problem ?
I saw related problems in the forum but it does not seem to correspond exactly to the problem on my pbx box.
For info we use freepbx 2.10 and custom contexts 2.9, but you guys might have already noticed it.

Thanks.