Vanishing Caller ID

General Help
1

Hi All,

I am having an issue with a Sangoma ISDN BRI Card, the inbound caller ID appears to be removed somewhere in my call routing. Here are the logs from an inbound call from 01279800101:

[Jun 19 11:48:10] VERBOSE[26601] sig_pri.c: -- Accepting call from '01279800101' to '658002' on channel 0/1, span 2 [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [658002@custom-inbound:1] Answer("DAHDI/i2/-49", "") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [658002@custom-inbound:2] ExecIf("DAHDI/i2/-49", "0?Set(CALLERID(num)=0)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [658002@custom-inbound:3] Goto("DAHDI/i2/-49", "from-pstn,658002,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (from-pstn,658002,1) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [658002@from-pstn:1] NoOp("DAHDI/i2/-49", "Catch-All DID Match - Found 658002 - You probably want a DID for this.") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [658002@from-pstn:2] Goto("DAHDI/i2/-49", "ext-did,s,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (ext-did,s,1) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:1] Set("DAHDI/i2/-49", "__FROM_DID=s") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:2] Gosub("DAHDI/i2/-49", "app-blacklist-check,s,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@app-blacklist-check:1] GotoIf("DAHDI/i2/-49", "0?blacklisted") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@app-blacklist-check:2] Set("DAHDI/i2/-49", "CALLED_BLACKLIST=1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@app-blacklist-check:3] Return("DAHDI/i2/-49", "") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:3] Gosub("DAHDI/i2/-49", "cidlookup,cidlookup_1,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [cidlookup_1@cidlookup:1] ExecIf("DAHDI/i2/-49", "0?Set(CALLERID(name)=)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [cidlookup_1@cidlookup:2] Return("DAHDI/i2/-49", "") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:4] ExecIf("DAHDI/i2/-49", "1 ?Set(CALLERID(name)=)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:5] Set("DAHDI/i2/-49", "__CALLINGPRES_SV=allowed_not_screened") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:6] Set("DAHDI/i2/-49", "CALLERPRES()=allowed_not_screened") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@ext-did:7] Goto("DAHDI/i2/-49", "app-daynight,0,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (app-daynight,0,1) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [0@app-daynight:1] GotoIf("DAHDI/i2/-49", "0?ext-local,vmu103,1:ext-group,600,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (ext-group,600,1) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:1] Macro("DAHDI/i2/-49", "user-callerid,") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:1] Set("DAHDI/i2/-49", "AMPUSER=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:2] GotoIf("DAHDI/i2/-49", "0?report") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:3] ExecIf("DAHDI/i2/-49", "1?Set(REALCALLERIDNUM=)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:4] Set("DAHDI/i2/-49", "AMPUSER=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:5] Set("DAHDI/i2/-49", "AMPUSERCIDNAME=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:6] GotoIf("DAHDI/i2/-49", "1?report") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-user-callerid,s,10) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:10] GotoIf("DAHDI/i2/-49", "0?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:11] Set("DAHDI/i2/-49", "__TTL=64") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:12] GotoIf("DAHDI/i2/-49", "1?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-user-callerid,s,19) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:19] Set("DAHDI/i2/-49", "CALLERID(number)=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:20] Set("DAHDI/i2/-49", "CALLERID(name)=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-user-callerid:21] NoOp("DAHDI/i2/-49", "Using CallerID "" <>") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:2] GotoIf("DAHDI/i2/-49", "1?skipdb") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (ext-group,600,4) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:4] Set("DAHDI/i2/-49", "__NODEST=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:5] Set("DAHDI/i2/-49", "__BLKVM_OVERRIDE=BLKVM/600/DAHDI/i2/-49") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:6] Set("DAHDI/i2/-49", "__BLKVM_BASE=600") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:7] Set("DAHDI/i2/-49", "DB(BLKVM/600/DAHDI/i2/-49)=TRUE") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:8] Set("DAHDI/i2/-49", "RRNODEST=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:9] Set("DAHDI/i2/-49", "__NODEST=600") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:10] GosubIf("DAHDI/i2/-49", "0?sub-rgsetcid,s,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:11] Set("DAHDI/i2/-49", "RecordMethod=Group") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:12] Macro("DAHDI/i2/-49", "record-enable,101-102-103-104-105,Group") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:1] GotoIf("DAHDI/i2/-49", "1?check") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,4) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:4] ExecIf("DAHDI/i2/-49", "0?MacroExit()") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:5] GotoIf("DAHDI/i2/-49", "1?Group:OUT") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,6) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:6] Set("DAHDI/i2/-49", "LOOPCNT=5") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:7] Set("DAHDI/i2/-49", "ITER=1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:8] GotoIf("DAHDI/i2/-49", "1?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,13) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:13] Set("DAHDI/i2/-49", "ITER=2") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("DAHDI/i2/-49", "1?begin") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,8) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:8] GotoIf("DAHDI/i2/-49", "1?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,13) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:13] Set("DAHDI/i2/-49", "ITER=3") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("DAHDI/i2/-49", "1?begin") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,8) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:8] GotoIf("DAHDI/i2/-49", "1?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,13) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:13] Set("DAHDI/i2/-49", "ITER=4") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("DAHDI/i2/-49", "1?begin") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,8) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:8] GotoIf("DAHDI/i2/-49", "1?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,13) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:13] Set("DAHDI/i2/-49", "ITER=5") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("DAHDI/i2/-49", "1?begin") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,8) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:8] GotoIf("DAHDI/i2/-49", "1?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-record-enable,s,13) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:13] Set("DAHDI/i2/-49", "ITER=6") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:14] GotoIf("DAHDI/i2/-49", "0?begin") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:15] GotoIf("DAHDI/i2/-49", "0?IN") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-record-enable:16] ExecIf("DAHDI/i2/-49", "1?MacroExit()") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:13] Set("DAHDI/i2/-49", "RingGroupMethod=ringall") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [600@ext-group:14] Macro("DAHDI/i2/-49", "dial,15,tr,101-102-103-104-105") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-dial:1] GotoIf("DAHDI/i2/-49", "1?dial") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Goto (macro-dial,s,3) [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [s@macro-dial:3] AGI("DAHDI/i2/-49", "dialparties.agi") in new stack [Jun 19 11:48:10] VERBOSE[992] res_agi.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi [Jun 19 11:48:10] VERBOSE[992] res_agi.c: dialparties.agi: Starting New Dialparties.agi [Jun 19 11:48:10] VERBOSE[992] res_agi.c: dialparties.agi: Caller ID name is 'unknown' number is 'unknown' [Jun 19 11:48:10] VERBOSE[992] res_agi.c: dialparties.agi: Methodology of ring is 'ringall'

Can anyone tell why/where it is being removed?

Thanks!

2

Are you using the CID lookup module? If not, I’d disable it and see what happens.

[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [s@ext-did:3] Gosub(“DAHDI/i2/-49”, “cidlookup,cidlookup_1,1”) in new stack
[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [cidlookup_1@cidlookup:1] ExecIf(“DAHDI/i2/-49”, “0?Set(CALLERID(name)=)”) in new stack
[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [cidlookup_1@cidlookup:2] Return(“DAHDI/i2/-49”, “”) in new stack
[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [s@ext-did:4] ExecIf(“DAHDI/i2/-49”, “1 ?Set(CALLERID(name)=)”) in new stack

3

I have disabled the CID lookup module, however the caller ID is still being removed.

4

Found the issue, I had usecallerid=no inside chan_dahdi.conf