dswartz,
What were those changes for the extensions_custom.conf you mentioned? I found the following in my log file (PN’s replaced with n’s):
Mar 8 22:53:21 DEBUG[2496] chan_sip.c: Checking SIP call limits for device myloginid
Mar 8 22:53:21 DEBUG[2496] chan_sip.c: build_route: Contact hop:
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Executing SetVar(“SIP/myloginid-287e”, “FROM_DID=nnnnnnnnnn”) in new stack
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Executing PrivacyManager(“SIP/myloginid-287e”, “”) in new stack
Mar 8 22:53:21 VERBOSE[7558] logger.c: – CallerID Present: Skipping
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Executing Goto(“SIP/myloginid-287e”, “aa_1|s|1”) in new stack
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Goto (aa_1,s,1)
Mar 8 22:53:21 WARNING[7558] ast_expr2.fl: ast_yyerror(): syntax error: syntax error, unexpected TOK_EQ, expecting TOK_MINUS or TOK_COMPL or TOK_LP or TOKEN; Input:
= ANSWER
^
Mar 8 22:53:21 WARNING[7558] ast_expr2.fl: If you have questions, please refer to doc/README.variables in the asterisk source.
Mar 8 22:53:21 DEBUG[7558] pbx.c: Expression result is ‘0’
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Executing GotoIf(“SIP/myloginid-287e”, “0?4”) in new stack
Mar 8 22:53:21 DEBUG[7558] pbx.c: Not taking any branch
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Executing Answer(“SIP/myloginid-287e”, “”) in new stack
Mar 8 22:53:21 VERBOSE[7558] logger.c: – Executing Wait(“SIP/myloginid-287e”, “1”) in new stack
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Executing SetVar(“SIP/myloginid-287e”, “LOOPED=1”) in new stack
Mar 8 22:53:22 DEBUG[7558] pbx.c: Expression result is ‘0’
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Executing GotoIf(“SIP/myloginid-287e”, “0?hang|1”) in new stack
Mar 8 22:53:22 DEBUG[7558] pbx.c: Not taking any branch
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Executing SetVar(“SIP/myloginid-287e”, “DIR-CONTEXT=general”) in new stack
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Executing DigitTimeout(“SIP/myloginid-287e”, “3”) in new stack
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Set Digit Timeout to 3
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Executing ResponseTimeout(“SIP/myloginid-287e”, “7”) in new stack
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Set Response Timeout to 7
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Executing BackGround(“SIP/myloginid-287e”, “custom/aa_1”) in new stack
Mar 8 22:53:22 DEBUG[7558] channel.c: Scheduling timer at 160 sample intervals
Mar 8 22:53:22 VERBOSE[7558] logger.c: – Playing ‘custom/aa_1’ (language ‘en’)
Mar 8 22:53:24 DEBUG[2496] chan_sip.c: Auto destroying call ‘002da92109e4f5f74fc5995b7b2d956c@127.0.0.1’
Mar 8 22:53:25 DEBUG[2496] chan_sip.c: Auto destroying call ‘7124c1191419faeb36870b412bfdf518@127.0.0.1’
Mar 8 22:53:26 DEBUG[7558] channel.c: Scheduling timer at 0 sample intervals
Mar 8 22:53:26 VERBOSE[7558] logger.c: == Spawn extension (aa_1, s, 9) exited non-zero on ‘SIP/myloginid-287e’
Mar 8 22:53:26 VERBOSE[7558] logger.c: – Executing Hangup(“SIP/myloginid-287e”, “”) in new stack
Mar 8 22:53:26 VERBOSE[7558] logger.c: == Spawn extension (aa_1, h, 1) exited non-zero on ‘SIP/myloginid-287e’
Mar 8 22:53:26 DEBUG[7558] cdr_addon_mysql.c: cdr_mysql: inserting a CDR record.
Mar 8 22:53:26 DEBUG[7558] cdr_addon_mysql.c: cdr_mysql: SQL command as follows: INSERT INTO cdr (calldate,clid,src,dst,dcontext,channel,dstchannel,lastapp,lastdata,duration,billsec,disposition,amaflags,accountcode) VALUES (‘2006-03-08 22:53:21’,’“Unknown” ‘,‘Unknown’,‘s’,‘aa_1’, ‘SIP/myloginid-287e’,’’,‘Hangup’,’’,5,5,‘ANSWERED’,3,’’)
Mar 8 22:53:26 DEBUG[7558] chan_sip.c: update_call_counter(myloginid) - decrement call limit counter
So if I’m understanding this PM is looking at the call and thinks that Unknown is a good CID. That would seem to be pretty much the same as the problem you described. Sorry to be so dense! What do you think, same problem?
Tom