Caller ID name is 'unknown' number . Any ideas how to debug?

wyattbiker · December 11, 2008, 6:22pm

I have 6 analog lines coming in, but it happens on other channels. I turned off all Telco services (voicemail, forwarding and so on). It doesnt happen all the time maybe once every 1/2 hour. As soon as you pick it hangs up.

Here is log. Thank you.

[Dec 10 08:51:32] VERBOSE[10493] logger.c: – Starting simple switch on ‘Zap/4-1’
[Dec 10 08:51:34] DEBUG[10488] chan_zap.c: Ignoring Polarity switch to IDLE on channel 1, state 6
[Dec 10 08:51:34] DEBUG[10488] chan_zap.c: Polarity Reversal event occured - DEBUG 2: channel 1, state 6, pol= 0, aonp= 0, honp= 0, pdelay= 600, tv= 556447937
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Stopped music on hold on Zap/1-1
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Hungup ‘Zap/1-1’
[Dec 10 08:51:34] VERBOSE[10488] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on ‘SIP/306-b78ab738’ in macro ‘dialout-trunk’
[Dec 10 08:51:34] VERBOSE[10488] logger.c: == Spawn extension (macro-dialout-trunk, s, 20) exited non-zero on ‘SIP/306-b78ab738’
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [h@macro-dialout-trunk:1] Macro(“SIP/306-b78ab738”, “hangupcall|”) in new stack
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [s@macro-hangupcall:1] ResetCDR(“SIP/306-b78ab738”, “w”) in new stack
[Dec 10 08:51:34] DEBUG[10488] app_macro.c: Executed application: ResetCDR
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [s@macro-hangupcall:2] NoCDR(“SIP/306-b78ab738”, “”) in new stack
[Dec 10 08:51:34] DEBUG[10488] app_macro.c: Executed application: NoCDR
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [s@macro-hangupcall:3] GotoIf(“SIP/306-b78ab738”, “1?skiprg”) in new stack
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Goto (macro-hangupcall,s,6)
[Dec 10 08:51:34] DEBUG[10488] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [s@macro-hangupcall:6] GotoIf(“SIP/306-b78ab738”, “1?skipblkvm”) in new stack
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Goto (macro-hangupcall,s,9)
[Dec 10 08:51:34] DEBUG[10488] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [s@macro-hangupcall:9] GotoIf(“SIP/306-b78ab738”, “1?theend”) in new stack
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Goto (macro-hangupcall,s,11)
[Dec 10 08:51:34] DEBUG[10488] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:34] VERBOSE[10488] logger.c: – Executing [s@macro-hangupcall:11] Hangup(“SIP/306-b78ab738”, “”) in new stack
[Dec 10 08:51:34] VERBOSE[10488] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/306-b78ab738’ in macro ‘hangupcall’
[Dec 10 08:51:34] VERBOSE[10488] logger.c: == Spawn extension (macro-hangupcall, s, 11) exited non-zero on ‘SIP/306-b78ab738’
[Dec 10 08:51:36] NOTICE[10493] chan_zap.c: Got event 18 (Ring Begin)…
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:1] NoOp(“Zap/4-1”, "Entering from-zaptel with DID == ") in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:2] Ringing(“Zap/4-1”, “”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:3] Set(“Zap/4-1”, “DID=s”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:4] NoOp(“Zap/4-1”, “DID is now s”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:5] GotoIf(“Zap/4-1”, “1?zapok:notzap”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (from-zaptel,s,8)
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:8] NoOp(“Zap/4-1”, “Is a Zaptel Channel”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:9] Set(“Zap/4-1”, “CHAN=4-1”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:10] Set(“Zap/4-1”, “CHAN=4”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@from-zaptel:11] Macro(“Zap/4-1”, “from-zaptel-4|s|1”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-from-zaptel-4:1] NoOp(“Zap/4-1”, “Entering macro-from-zaptel-4 with DID = s and setting to: 364”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Noop
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-from-zaptel-4:2] Set(“Zap/4-1”, “__FROM_DID=364”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Set
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-from-zaptel-4:3] Goto(“Zap/4-1”, “from-trunk|364|1”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (from-trunk,364,1)
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Goto
[Dec 10 08:51:36] VERBOSE[10493] logger.c: == Channel ‘Zap/4-1’ jumping out of macro ‘from-zaptel-4’
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:1] Set(“Zap/4-1”, “__FROM_DID=364”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:2] Gosub(“Zap/4-1”, “app-blacklist-check|s|1”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@app-blacklist-check:1] LookupBlacklist(“Zap/4-1”, “”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@app-blacklist-check:2] GotoIf(“Zap/4-1”, “0?blacklisted”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@app-blacklist-check:3] Return(“Zap/4-1”, “”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:3] GotoIf(“Zap/4-1”, “0 ?cidok”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:4] Set(“Zap/4-1”, “CALLERID(name)=”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:5] NoOp(“Zap/4-1”, “CallerID is “” <>”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:6] Ringing(“Zap/4-1”, “”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:7] Set(“Zap/4-1”, “FAX_RX=disabled”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [364@from-trunk:8] Goto(“Zap/4-1”, “ext-group|350|1”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (ext-group,350,1)
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:1] Macro(“Zap/4-1”, “user-callerid|”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:1] NoOp(“Zap/4-1”, "user-callerid: ") in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Noop
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:2] Set(“Zap/4-1”, “AMPUSER=”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Set
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:3] GotoIf(“Zap/4-1”, “0?report”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:4] ExecIf(“Zap/4-1”, “1|Set|REALCALLERIDNUM=”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: ExecIf
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Last app: Set|REALCALLERIDNUM=
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:5] NoOp(“Zap/4-1”, "REALCALLERIDNUM is ") in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Noop
[Dec 10 08:51:36] DEBUG[10493] func_db.c: DB: DEVICE//user not found in database.
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:6] Set(“Zap/4-1”, “AMPUSER=”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Set
[Dec 10 08:51:36] DEBUG[10493] func_db.c: DB: AMPUSER//cidname not found in database.
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:7] Set(“Zap/4-1”, “AMPUSERCIDNAME=”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Set
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:8] GotoIf(“Zap/4-1”, “1?report”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (macro-user-callerid,s,13)
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:13] NoOp(“Zap/4-1”, "TTL: ARG1: ") in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Noop
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:14] GotoIf(“Zap/4-1”, “0?continue”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:15] Set(“Zap/4-1”, “__TTL=64”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Set
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:16] GotoIf(“Zap/4-1”, “1?continue”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (macro-user-callerid,s,23)
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-user-callerid:23] NoOp(“Zap/4-1”, “Using CallerID “” <>”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Noop
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:2] GotoIf(“Zap/4-1”, “1?skipdb”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (ext-group,350,4)
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:4] Set(“Zap/4-1”, “__NODEST=”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:5] Set(“Zap/4-1”, “__BLKVM_OVERRIDE=BLKVM/350/Zap/4-1”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:6] Set(“Zap/4-1”, “__BLKVM_BASE=350”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:7] Set(“Zap/4-1”, “DB(BLKVM/350/Zap/4-1)=TRUE”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:8] Set(“Zap/4-1”, “RRNODEST=”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:9] Set(“Zap/4-1”, “__NODEST=350”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:10] Set(“Zap/4-1”, “RecordMethod=Group”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:11] Macro(“Zap/4-1”, “record-enable|309-306-313-317|Group”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-record-enable:1] GotoIf(“Zap/4-1”, “0?2:4”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (macro-record-enable,s,4)
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-record-enable:4] AGI(“Zap/4-1”, “recordingcheck|20081210-085136|1228917092.13662”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – AGI Script recordingcheck completed, returning 0
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: AGI
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-record-enable:5] NoOp(“Zap/4-1”, “No recording needed”) in new stack
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: Noop
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:12] Set(“Zap/4-1”, “RingGroupMethod=ringall”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [350@ext-group:13] Macro(“Zap/4-1”, “dial|12|tr|309-306-313-317”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-dial:1] GotoIf(“Zap/4-1”, “1?dial”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Goto (macro-dial,s,3)
[Dec 10 08:51:36] DEBUG[10493] app_macro.c: Executed application: GotoIf
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Executing [s@macro-dial:3] AGI(“Zap/4-1”, “dialparties.agi”) in new stack
[Dec 10 08:51:36] VERBOSE[10493] logger.c: – Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
[Dec 10 08:51:36] VERBOSE[10493] logger.c: dialparties.agi: Starting New Dialparties.agi
[Dec 10 08:51:36] VERBOSE[10496] logger.c: == Parsing ‘/etc/asterisk/manager.conf’: [Dec 10 08:51:36] VERBOSE[10496] logger.c: Found
[Dec 10 08:51:36] VERBOSE[10496] logger.c: == Parsing ‘/etc/asterisk/manager_additional.conf’: [Dec 10 08:51:36] VERBOSE[10496] logger.c: Found
[Dec 10 08:51:36] VERBOSE[10496] logger.c: == Parsing ‘/etc/asterisk/manager_custom.conf’: [Dec 10 08:51:36] VERBOSE[10496] logger.c: Found
[Dec 10 08:51:36] VERBOSE[10496] logger.c: == Manager ‘admin’ logged on from 127.0.0.1
[Dec 10 08:51:36] VERBOSE[10493] logger.c: dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’

bwilks · December 12, 2008, 12:57pm

Maybe the caller is not sending thier CID?
Are they real calls?
What country are you in?

wyattbiker · December 12, 2008, 4:17pm

[quote=“bwilks”]Maybe the caller is not sending thier CID?
Are they real calls?
What country are you in?[/quote]

Hello bwilks. Im in the USA. Even if the caller has no CID, why does the system hangup the call as soon as one picks up?
Do you think my signaling should not be fxs_ks?

Here are my zap files. Thanks

;
; Zapata telephony interface
;
; Configuration file

[trunkgroups]

[channels]

language=en
context=from-zaptel
signalling=fxs_ks
rxwink=300		; Atlas seems to use long (250ms) winks
;
; Whether or not to do distinctive ring detection on FXO lines
;
;usedistinctiveringdetection=yes

usecallerid=yes
hidecallerid=no
callwaiting=yes
usecallingpres=yes
callwaitingcallerid=yes
threewaycalling=yes
transfer=yes
cancallforward=yes
callreturn=yes
echocancel=yes
echocancelwhenbridged=no
;echotraining=800
echotraining=0
rxgain=0.0
txgain=0.0
group=0
callgroup=1
pickupgroup=1
immediate=no

;faxdetect=both
faxdetect=incoming
;faxdetect=outgoing
;faxdetect=no

;Include genzaptelconf configs
#include zapata-auto.conf

group=1

;Include AMP configs
#include zapata_additional.conf


============================================

; Autogenerated by /usr/sbin/genzaptelconf -- do not hand edit
; Zaptel Channels Configurations (zapata.conf)
;
; This is not intended to be a complete zapata.conf. Rather, it is intended 
; to be #include-d by /etc/zapata.conf that will include the global settings
;

; Span 1: WCTDM/0 "Wildcard TDM800P Board 1" (MASTER) 
;;; line="1 WCTDM/0/0"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 1
context=default

;;; line="2 WCTDM/0/1"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 2
context=default

;;; line="3 WCTDM/0/2"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 3
context=default

;;; line="4 WCTDM/0/3"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 4
context=default

;;; line="5 WCTDM/0/4"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 5
context=default

;;; line="6 WCTDM/0/5"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 6
context=default

;;; line="7 WCTDM/0/6"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 7
context=default

;;; line="8 WCTDM/0/7"
signalling=fxs_ks
callerid=asreceived
group=0
context=from-zaptel
channel => 8
context=default