Vanishing Caller ID

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 [[email protected]:1] Answer("DAHDI/i2/-49", "") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:2] ExecIf("DAHDI/i2/-49", "0?Set(CALLERID(num)=0)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]: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 [[email protected]:1] Set("DAHDI/i2/-49", "__FROM_DID=s") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:2] Gosub("DAHDI/i2/-49", "app-blacklist-check,s,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:1] GotoIf("DAHDI/i2/-49", "0?blacklisted") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:2] Set("DAHDI/i2/-49", "CALLED_BLACKLIST=1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:3] Return("DAHDI/i2/-49", "") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:3] Gosub("DAHDI/i2/-49", "cidlookup,cidlookup_1,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:1] ExecIf("DAHDI/i2/-49", "0?Set(CALLERID(name)=)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:2] Return("DAHDI/i2/-49", "") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:4] ExecIf("DAHDI/i2/-49", "1 ?Set(CALLERID(name)=)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:5] Set("DAHDI/i2/-49", "__CALLINGPRES_SV=allowed_not_screened") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:6] Set("DAHDI/i2/-49", "CALLERPRES()=allowed_not_screened") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]:1] Macro("DAHDI/i2/-49", "user-callerid,") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:1] Set("DAHDI/i2/-49", "AMPUSER=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:2] GotoIf("DAHDI/i2/-49", "0?report") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:3] ExecIf("DAHDI/i2/-49", "1?Set(REALCALLERIDNUM=)") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:4] Set("DAHDI/i2/-49", "AMPUSER=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:5] Set("DAHDI/i2/-49", "AMPUSERCIDNAME=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:10] GotoIf("DAHDI/i2/-49", "0?continue") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:11] Set("DAHDI/i2/-49", "__TTL=64") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:19] Set("DAHDI/i2/-49", "CALLERID(number)=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:20] Set("DAHDI/i2/-49", "CALLERID(name)=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:21] NoOp("DAHDI/i2/-49", "Using CallerID "" <>") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:4] Set("DAHDI/i2/-49", "__NODEST=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:6] Set("DAHDI/i2/-49", "__BLKVM_BASE=600") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:8] Set("DAHDI/i2/-49", "RRNODEST=") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:9] Set("DAHDI/i2/-49", "__NODEST=600") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:10] GosubIf("DAHDI/i2/-49", "0?sub-rgsetcid,s,1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:11] Set("DAHDI/i2/-49", "RecordMethod=Group") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]:4] ExecIf("DAHDI/i2/-49", "0?MacroExit()") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:6] Set("DAHDI/i2/-49", "LOOPCNT=5") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:7] Set("DAHDI/i2/-49", "ITER=1") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]:13] Set("DAHDI/i2/-49", "ITER=2") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]:13] Set("DAHDI/i2/-49", "ITER=3") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]:13] Set("DAHDI/i2/-49", "ITER=4") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]:13] Set("DAHDI/i2/-49", "ITER=5") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]:13] Set("DAHDI/i2/-49", "ITER=6") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:14] GotoIf("DAHDI/i2/-49", "0?begin") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:15] GotoIf("DAHDI/i2/-49", "0?IN") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:16] ExecIf("DAHDI/i2/-49", "1?MacroExit()") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]:13] Set("DAHDI/i2/-49", "RingGroupMethod=ringall") in new stack [Jun 19 11:48:10] VERBOSE[992] pbx.c: -- Executing [[email protected]: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 [[email protected]: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 [[email protected]: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!

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 [[email protected]:3] Gosub(“DAHDI/i2/-49”, “cidlookup,cidlookup_1,1”) in new stack
[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [[email protected]:1] ExecIf(“DAHDI/i2/-49”, “0?Set(CALLERID(name)=)”) in new stack
[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [[email protected]:2] Return(“DAHDI/i2/-49”, “”) in new stack
[Jun 19 11:48:10] VERBOSE[992] pbx.c: – Executing [[email protected]:4] ExecIf(“DAHDI/i2/-49”, “1 ?Set(CALLERID(name)=)”) in new stack

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

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