Caller ID dialparties.agi problem

Hi guys, I am running FreePBX 2.6.0 Beta 2.2
I dont have this problem on 2.5 so I can only think something has happened during the upgrade.

When a call comes in I can see that correct caller ID in asterisk,

Accepting voice call from ‘087805****’ to ‘2101’ on channel 0/22, span 2
– Executing [[email protected]:1] Set(“Zap/53-1”, “__FROM_DID=2101”) in new stack
– Executing [[email protected]:2] Gosub(“Zap/53-1”, “app-blacklist-check|s|1”) in new stack
– Executing [[email protected]:1] LookupBlacklist(“Zap/53-1”, “”) in new stack
– Executing [[email protected]:2] GotoIf(“Zap/53-1”, “0?blacklisted”) in new stack
– Executing [[email protected]app-blacklist-check:3] Set(“Zap/53-1”, “CALLED_BLACKLIST=1”) in new stack
– Executing [[email protected]:4] Return(“Zap/53-1”, “”) in new stack
– Executing [[email protected]:3] ExecIf(“Zap/53-1”, “1 |Set|CALLERID(name)=0878059398”) in new stack

Further down when the AGI script starts it seems to see the caller ID as unknown.

– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
dialparties.agi: Starting New Dialparties.agi
== Parsing ‘/etc/asterisk/manager.conf’: Found
== Parsing ‘/etc/asterisk/manager_additional.conf’: Found
== Parsing ‘/etc/asterisk/manager_custom.conf’: Found
== Manager ‘admin’ logged on from 127.0.0.1
dialparties.agi: Caller ID name is ‘unknown’ number is ‘unknown’

On the phones the caller ID is then showing as Unknown to anonymous.

Has anyone experience this yet or can help me fix this its rather urgent.
Thanks in advance.

You are going to have to provide a full trace as well as a description of how the call is coming in and where it is going along with details of that (ringgroup, follow-me, extension, etc).

And to the extent you can repro it with a simplified config, like go an extension with no callerid if possible, etc. that makes it much easier to try and determine the issue.

The problem I am having is on only the ATA186 caller id has the name but the phone number has only the first 6 digits. This happened after upgrading.

again, providing such data is of no help without some sort of trace to see what is being transmitted.

Where would I get this information for you?

you need to connect to asterisk from a terminal window:

aterisk -rvvvvvv

then run the call and past the trace. There is also data available in the log that may be of help but usually the former is better:

/var/log/asterisk/full

That is what I thought. When you said trace, I thought there was another way. I paster the information here. Hope this helps.

Verbosity is at least 10
– Executing [[email protected]:1] Set(“SIP/Calls In-b7c39778”, “__FROM_DID=9723066282”) in new stack
– Executing [[email protected]:2] Gosub(“SIP/Calls In-b7c39778”, “app-blacklist-check|s|1”) in new stack
– Executing [[email protected]:1] LookupBlacklist(“SIP/Calls In-b7c39778”, “”) in new stack
– Executing [[email protected]:2] GotoIf(“SIP/Calls In-b7c39778”, “0?blacklisted”) in new stack
– Executing [[email protected]:3] Set(“SIP/Calls In-b7c39778”, “CALLED_BLACKLIST=1”) in new stack
– Executing [[email protected]:4] Return(“SIP/Calls In-b7c39778”, “”) in new stack
– Executing [[email protected]:3] ExecIf(“SIP/Calls In-b7c39778”, “0 |Set|CALLERID(name)=2147109293”) in new stack
– Executing [[email protected]:4] Set(“SIP/Calls In-b7c39778”, “FAX_RX=disabled”) in new stack
– Executing [[email protected]:5] Set(“SIP/Calls In-b7c39778”, "[email protected]") in new stack
– Executing [[email protected]:6] Set(“SIP/Calls In-b7c39778”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
– Executing [[email protected]:7] SetCallerPres(“SIP/Calls In-b7c39778”, “allowed_not_screened”) in new stack
– Executing [[email protected]:8] Goto(“SIP/Calls In-b7c39778”, “from-did-direct|701|1”) in new stack
– Goto (from-did-direct,701,1)
– Executing [[email protected]:1] Set(“SIP/Calls In-b7c39778”, “__RINGTIMER=30”) in new stack
– Executing [[email protected]:2] Macro(“SIP/Calls In-b7c39778”, “exten-vm|701|701”) in new stack
– Executing [[email protected]:1] Macro(“SIP/Calls In-b7c39778”, “user-callerid”) in new stack
– Executing [[email protected]:1] Set(“SIP/Calls In-b7c39778”, “AMPUSER=2147109293”) in new stack
– Executing [[email protected]:2] GotoIf(“SIP/Calls In-b7c39778”, “0?report”) in new stack
– Executing [[email protected]:3] ExecIf(“SIP/Calls In-b7c39778”, “1|Set|REALCALLERIDNUM=2147109293”) in new stack
– Executing [[email protected]:4] Set(“SIP/Calls In-b7c39778”, “AMPUSER=”) in new stack
– Executing [[email protected]:5] Set(“SIP/Calls In-b7c39778”, “AMPUSERCIDNAME=”) in new stack
– Executing [[email protected]:6] GotoIf(“SIP/Calls In-b7c39778”, “1?report”) in new stack
– Goto (macro-user-callerid,s,10)
– Executing [[email protected]:10] GotoIf(“SIP/Calls In-b7c39778”, “0?continue”) in new stack
– Executing [[email protected]:11] Set(“SIP/Calls In-b7c39778”, “__TTL=64”) in new stack
– Executing [[email protected]:12] GotoIf(“SIP/Calls In-b7c39778”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [[email protected]:19] NoOp(“SIP/Calls In-b7c39778”, “Using CallerID “WINTON GARY” <2147109293>”) in new stack
– Executing [[email protected]:2] Set(“SIP/Calls In-b7c39778”, “RingGroupMethod=none”) in new stack
– Executing [[email protected]:3] Set(“SIP/Calls In-b7c39778”, “VMBOX=701”) in new stack
– Executing [[email protected]:4] Set(“SIP/Calls In-b7c39778”, “EXTTOCALL=701”) in new stack
– Executing [[email protected]:5] Set(“SIP/Calls In-b7c39778”, “CFUEXT=”) in new stack
– Executing [[email protected]:6] Set(“SIP/Calls In-b7c39778”, “CFBEXT=”) in new stack
– Executing [[email protected]:7] Set(“SIP/Calls In-b7c39778”, “RT=30”) in new stack
– Executing [[email protected]:8] Macro(“SIP/Calls In-b7c39778”, “record-enable|701|IN”) in new stack
– Executing [[email protected]:1] GotoIf(“SIP/Calls In-b7c39778”, “1?check”) in new stack
– Goto (macro-record-enable,s,4)
– Executing [[email protected]:4] AGI(“SIP/Calls In-b7c39778”, “recordingcheck|20090907-105703|1252339023.184”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
recordingcheck|20090907-105703|1252339023.184: Inbound recording enabled.
recordingcheck|20090907-105703|1252339023.184: CALLFILENAME=20090907-105703-1252339023.184
– AGI Script recordingcheck completed, returning 0
– Executing [[email protected]:999] MixMonitor(“SIP/Calls In-b7c39778”, “20090907-105703-1252339023.184.wav||”) in new stack
– Executing [[email protected]:9] Macro(“SIP/Calls In-b7c39778”, “dial|30|trwk|701”) in new stack
== Begin MixMonitor Recording SIP/Calls In-b7c39778
– Executing [[email protected]:1] GotoIf(“SIP/Calls In-b7c39778”, “1?dial”) in new stack
– Goto (macro-dial,s,3)
– Executing [[email protected]:3] AGI(“SIP/Calls In-b7c39778”, “dialparties.agi”) in new stack
– Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi
dialparties.agi: Starting New Dialparties.agi
== Parsing ‘/etc/asterisk/manager.conf’: Found
== Parsing ‘/etc/asterisk/manager_additional.conf’: Found
== Parsing ‘/etc/asterisk/manager_custom.conf’: Found
dialparties.agi: Caller ID name is ‘WINTON GARY’ number is '2147109293’
dialparties.agi: USE_CONFIRMATION: 'FALSE’
dialparties.agi: RINGGROUP_INDEX: ''
dialparties.agi: Methodology of ring is ‘none’
– dialparties.agi: Added extension 701 to extension map
> dialparties.agi: Extension 701 has call screening off
– dialparties.agi: Extension 701 cf is disabled
– dialparties.agi: Extension 701 do not disturb is disabled
> dialparties.agi: extnum 701 has: cw: 1; hascfb: 0 [] hascfu: 0 []
dialparties.agi: ExtensionState: 0
– dialparties.agi: dbset CALLTRACE/701 to 2147109293
– dialparties.agi: Filtered ARG3: 701
– AGI Script dialparties.agi completed, returning 0
– Executing [[email protected]:7] Dial(“SIP/Calls In-b7c39778”, “SIP/701|30|trwk”) in new stack
– Called 701
Extension Changed 701[ext-local] new state Ringing for Notify User 703
– SIP/701-085e7668 is ringing
== Spawn extension (macro-dial, s, 7) exited non-zero on ‘SIP/Calls In-b7c39778’ in macro ‘dial’
== Spawn extension (macro-exten-vm, s, 9) exited non-zero on ‘SIP/Calls In-b7c39778’ in macro ‘exten-vm’
== Spawn extension (from-did-direct, 701, 2) exited non-zero on ‘SIP/Calls In-b7c39778’
– Executing [[email protected]:1] Macro(“SIP/Calls In-b7c39778”, “hangupcall”) in new stack
Extension Changed 701[ext-local] new state Idle for Notify User 703
– Executing [[email protected]:1] GotoIf(“SIP/Calls In-b7c39778”, “1?skiprg”) in new stack
– Goto (macro-hangupcall,s,4)
– Executing [[email protected]:4] GotoIf(“SIP/Calls In-b7c39778”, “1?skipblkvm”) in new stack
– Goto (macro-hangupcall,s,7)
– Executing [[email protected]:7] GotoIf(“SIP/Calls In-b7c39778”, “1?theend”) in new stack
– Goto (macro-hangupcall,s,9)
– Executing [[email protected]:9] Hangup(“SIP/Calls In-b7c39778”, “”) in new stack
== Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/Calls In-b7c39778’ in macro ‘hangupcall’
== Spawn extension (macro-dial, h, 1) exited non-zero on ‘SIP/Calls In-b7c39778’
== End MixMonitor Recording SIP/Calls In-b7c39778
pbx*CLI>

everything in that trace looks find, I don’t see any issues nor dialparties.agi doing anything to mess with CID.

It does look fine. After the upgrade the Cisco ATA186 does not get the whole number on the caller id. Every other device works fine. On one of the analog phones attached to the cisco, it will show 6 square boxes a space and then the first 6 numbers of the 10 digits. Could it be sending blanks for the first 7 digits? Is there a way to see what is being sent to the cisco for caller id?

Thanks

I got it to work by deleting the extension and recreate it. All is fine now. I guess some data did not get transferred correctly.