inbound calls hangup on pickup, can't outbound

Hello , dear Gurus

This is the first time we have this issue, we have several dozen installs with the same OpenVox cards, with great success

Our scenarioFresh Elastix 1.6237 install2 OpenVox cards with 4 FXO modulesInbound calls are detected, sent to the ext, and as soon as the call phone gets answered the call hang-up, .. rings again, pickup, hangs up, we have tried it sending it to SIP and IAX2 endpoints to discard the endpoint issue.

It also won't let us place a call, with the regular all circuits are busy now.
Intra ext calls work fineSo its card<->software related.

I setup sip debug to save the CLI for you.
Im out of ideas.
All help or pointers are appreciated.thanks

pbx*CLI> help sip debugUsage: sip set debug Enables dumping of SIP packets for debugging purposes sip set debug ip Enables dumping of SIP packets to and from host. sip set debug peer Enables dumping of SIP packets to and from host. Require peer to be registered.pbx*CLI> sip set debug peer 3026SIP Debugging Enabled for IP: 192.168.0.165:5060 -- Starting simple switch on 'DAHDI/5-1' -- Executing [s@from-pstn:1] Set("DAHDI/5-1", "__FROM_DID=s") in new stack -- Executing [s@from-pstn:2] Gosub("DAHDI/5-1", "app-blacklist-check|s|1") in new stack -- Executing [s@app-blacklist-check:1] LookupBlacklist("DAHDI/5-1", "") in new stack -- Executing [s@app-blacklist-check:2] GotoIf("DAHDI/5-1", "0?blacklisted") in new stack -- Executing [s@app-blacklist-check:3] Return("DAHDI/5-1", "") in new stack -- Executing [s@from-pstn:3] ExecIf("DAHDI/5-1", "1 |Set|CALLERID(name)=") in new stack -- Executing [s@from-pstn:4] Set("DAHDI/5-1", "__CALLINGPRES_SV=allowed_not_screened") in new stack -- Executing [s@from-pstn:5] SetCallerPres("DAHDI/5-1", "allowed_not_screened") in new stack -- Executing [s@from-pstn:6] Goto("DAHDI/5-1", "from-did-direct|3026|1") in new stack -- Goto (from-did-direct,3026,1) -- Executing [3026@from-did-direct:1] Macro("DAHDI/5-1", "exten-vm|novm|3026") in new stack -- Executing [s@macro-exten-vm:1] Macro("DAHDI/5-1", "user-callerid") in new stack -- Executing [s@macro-user-callerid:1] Set("DAHDI/5-1", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:2] GotoIf("DAHDI/5-1", "0?report") in new stack -- Executing [s@macro-user-callerid:3] ExecIf("DAHDI/5-1", "1|Set|REALCALLERIDNUM=") in new stack -- Executing [s@macro-user-callerid:4] Set("DAHDI/5-1", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:5] Set("DAHDI/5-1", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("DAHDI/5-1", "1?report") in new stack -- Goto (macro-user-callerid,s,10) -- Executing [s@macro-user-callerid:10] GotoIf("DAHDI/5-1", "0?continue") in new stack -- Executing [s@macro-user-callerid:11] Set("DAHDI/5-1", "__TTL=64") in new stack -- Executing [s@macro-user-callerid:12] GotoIf("DAHDI/5-1", "1?continue") in new stack -- Goto (macro-user-callerid,s,19) -- Executing [s@macro-user-callerid:19] NoOp("DAHDI/5-1", "Using CallerID "" <>") in new stack -- Executing [s@macro-exten-vm:2] Set("DAHDI/5-1", "RingGroupMethod=none") in new stack -- Executing [s@macro-exten-vm:3] Set("DAHDI/5-1", "VMBOX=novm") in new stack -- Executing [s@macro-exten-vm:4] Set("DAHDI/5-1", "EXTTOCALL=3026") in new stack -- Executing [s@macro-exten-vm:5] Set("DAHDI/5-1", "CFUEXT=") in new stack -- Executing [s@macro-exten-vm:6] Set("DAHDI/5-1", "CFBEXT=") in new stack -- Executing [s@macro-exten-vm:7] Set("DAHDI/5-1", "RT=""") in new stack -- Executing [s@macro-exten-vm:8] Macro("DAHDI/5-1", "record-enable|3026|IN") in new stack -- Executing [s@macro-record-enable:1] GotoIf("DAHDI/5-1", "1?check") in new stack -- Goto (macro-record-enable,s,4) -- Executing [s@macro-record-enable:4] AGI("DAHDI/5-1", "recordingcheck|20120421-150257|1335038576.6") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck recordingcheck|20120421-150257|1335038576.6: Inbound recording not enabled -- AGI Script recordingcheck completed, returning 0 -- Executing [s@macro-record-enable:5] MacroExit("DAHDI/5-1", "") in new stack -- Executing [s@macro-exten-vm:9] Macro("DAHDI/5-1", "dial||tr|3026") in new stack -- Executing [s@macro-dial:1] GotoIf("DAHDI/5-1", "1?dial") in new stack -- Goto (macro-dial,s,3) -- Executing [s@macro-dial:3] AGI("DAHDI/5-1", "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 == Manager 'admin' logged on from 127.0.0.1 dialparties.agi: Caller ID name is 'unknown' number is 'unknown' dialparties.agi: USE_CONFIRMATION: 'FALSE' dialparties.agi: RINGGROUP_INDEX: '' dialparties.agi: Methodology of ring is 'none' -- dialparties.agi: Added extension 3026 to extension map > dialparties.agi: Extension 3026 has call screening off -- dialparties.agi: Extension 3026 cf is disabled -- dialparties.agi: Extension 3026 do not disturb is disabled > dialparties.agi: extnum 3026 has: cw: 1; hascfb: 0 [] hascfu: 0 [] dialparties.agi: ExtensionState: 0 -- dialparties.agi: DbDel CALLTRACE/3026 - Caller ID is not defined -- dialparties.agi: Filtered ARG3: 3026 == Manager 'admin' logged off from 127.0.0.1 -- AGI Script dialparties.agi completed, returning 0 -- Executing [s@macro-dial:7] Dial("DAHDI/5-1", "SIP/3026||tr") in new stackAudio is at 192.168.0.54 port 15630Adding codec 0x4 (ulaw) to SDPAdding codec 0x8 (alaw) to SDPAdding codec 0x2 (gsm) to SDPAdding codec 0x10 (g726aal2) to SDPAdding codec 0x20 (adpcm) to SDPAdding codec 0x40 (slin) to SDPAdding codec 0x80 (lpc10) to SDPAdding codec 0x100 (g729) to SDPAdding codec 0x200 (speex) to SDPAdding codec 0x800 (g726) to SDPAdding codec 0x1000 (g722) to SDPAdding non-codec 0x1 (telephone-event) to SDPReliably Transmitting (NAT) to 192.168.0.165:5060:INVITE sip:[email protected]:5060 SIP/2.0Via: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK774dd7de;rportFrom: "Unknown" ;tag=as57f4abd4To: Contact: Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 102 INVITEUser-Agent: Asterisk PBXMax-Forwards: 70Date: Sat, 21 Apr 2012 20:02:57 GMTAllow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFOSupported: replacesContent-Type: application/sdpContent-Length: 524v=0o=root 2843 2843 IN IP4 192.168.0.54s=sessionc=IN IP4 192.168.0.54t=0 0m=audio 15630 RTP/AVP 0 8 3 112 5 10 7 18 110 111 9 101a=rtpmap:0 PCMU/8000a=rtpmap:8 PCMA/8000a=rtpmap:3 GSM/8000a=rtpmap:112 AAL2-G726-32/8000a=rtpmap:5 DVI4/8000a=rtpmap:10 L16/8000a=rtpmap:7 LPC/8000a=rtpmap:18 G729/8000a=fmtp:18 annexb=noa=rtpmap:110 speex/8000a=rtpmap:111 G726-32/8000a=rtpmap:9 G722/8000a=rtpmap:101 telephone-event/8000a=fmtp:101 0-16a=silenceSupp:off - - - -a=ptime:20a=sendrecv--- -- Called 3026pbx*CLI> <--- SIP read from 192.168.0.165:5060 --->SIP/2.0 100 TryingTo: From: "Unknown" ;tag=as57f4abd4Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 102 INVITEVia: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK774dd7deServer: Cisco/SPA502G-7.4.8aContent-Length: 0<

---

>--- (8 headers 0 lines) ---pbx*CLI> <--- SIP read from 192.168.0.165:5060 --->SIP/2.0 180 RingingTo: ;tag=9a4186c5fb451902i0From: "Unknown" ;tag=as57f4abd4Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 102 INVITEVia: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK774dd7deContact: "3026" Server: Cisco/SPA502G-7.4.8aContent-Length: 0<

---

>--- (9 headers 0 lines) --- -- SIP/3026-08e9f270 is ringingpbx*CLI> <--- SIP read from 192.168.0.165:5060 --->SIP/2.0 200 OKTo: ;tag=9a4186c5fb451902i0From: "Unknown" ;tag=as57f4abd4Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 102 INVITEVia: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK774dd7deContact: "3026" Server: Cisco/SPA502G-7.4.8aContent-Length: 210Allow: ACK, BYE, CANCEL, INFO, INVITE, NOTIFY, OPTIONS, REFER, UPDATESupported: replacesContent-Type: application/sdpv=0o=- 7849604 7849604 IN IP4 192.168.0.165s=-c=IN IP4 192.168.0.165t=0 0m=audio 16512 RTP/AVP 0 101a=rtpmap:0 PCMU/8000a=rtpmap:101 telephone-event/8000a=fmtp:101 0-15a=ptime:30a=sendrecv<

---

>--- (12 headers 11 lines) ---Found RTP audio format 0Found RTP audio format 101Peer audio RTP is at port 192.168.0.165:16512Found audio description format PCMU for ID 0Found audio description format telephone-event for ID 101Capabilities: us - 0x3f1fff (g723|gsm|ulaw|alaw|g726|adpcm|slin|lpc10|g729|speex|ilbc|g726aal2|g722|jpeg|png|h261|h263|h263p|h264), peer - audio=0x4 (ulaw)/video=0x0 (nothing), combined - 0x4 (ulaw)Non-codec capabilities (dtmf): us - 0x1 (telephone-event), peer - 0x1 (telephone-event), combined - 0x1 (telephone-event)Peer audio RTP is at port 192.168.0.165:16512list_route: hop: set_destination: Parsing for address/port to send toset_destination: set destination to 192.168.0.165, port 5060Transmitting (NAT) to 192.168.0.165:5060:ACK sip:[email protected]:5060 SIP/2.0Via: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK63e4c840;rportFrom: "Unknown" ;tag=as57f4abd4To: ;tag=9a4186c5fb451902i0Contact: Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 102 ACKUser-Agent: Asterisk PBXMax-Forwards: 70Content-Length: 0--- -- SIP/3026-08e9f270 answered DAHDI/5-1 -- Executing [h@macro-dial:1] Macro("DAHDI/5-1", "hangupcall") in new stack -- Executing [s@macro-hangupcall:1] GotoIf("DAHDI/5-1", "1?endmixmoncheck") in new stack -- Goto (macro-hangupcall,s,9) -- Executing [s@macro-hangupcall:9] NoOp("DAHDI/5-1", "End of MIXMON check") in new stack -- Executing [s@macro-hangupcall:10] GotoIf("DAHDI/5-1", "1?nomeetmemon") in new stack -- Goto (macro-hangupcall,s,12) -- Executing [s@macro-hangupcall:12] NoOp("DAHDI/5-1", "MEETME_RECORDINGFILE=") in new stack -- Executing [s@macro-hangupcall:13] GotoIf("DAHDI/5-1", "1?noautomon") in new stack -- Goto (macro-hangupcall,s,15) -- Executing [s@macro-hangupcall:15] NoOp("DAHDI/5-1", "TOUCH_MONITOR_OUTPUT=") in new stack -- Executing [s@macro-hangupcall:16] GotoIf("DAHDI/5-1", "1?noautomon2") in new stack -- Goto (macro-hangupcall,s,18) -- Executing [s@macro-hangupcall:18] NoOp("DAHDI/5-1", "MONITOR_FILENAME=") in new stack -- Executing [s@macro-hangupcall:19] GotoIf("DAHDI/5-1", "1?skiprg") in new stack -- Goto (macro-hangupcall,s,22) -- Executing [s@macro-hangupcall:22] GotoIf("DAHDI/5-1", "1?skipblkvm") in new stack -- Goto (macro-hangupcall,s,25) -- Executing [s@macro-hangupcall:25] GotoIf("DAHDI/5-1", "1?theend") in new stack -- Goto (macro-hangupcall,s,27) -- Executing [s@macro-hangupcall:27] Hangup("DAHDI/5-1", "") in new stack == Spawn extension (macro-hangupcall, s, 27) exited non-zero on 'DAHDI/5-1' in macro 'hangupcall' == Spawn h extension (macro-dial, h, 1) exited non-zero on 'DAHDI/5-1'Scheduling destruction of SIP dialog 'This email address is being protected from spambots. You need JavaScript enabled to view it.' in 6400 ms (Method: INVITE)set_destination: Parsing for address/port to send toset_destination: set destination to 192.168.0.165, port 5060Reliably Transmitting (NAT) to 192.168.0.165:5060:BYE sip:[email protected]:5060 SIP/2.0Via: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK14955437;rportFrom: "Unknown" ;tag=as57f4abd4To: ;tag=9a4186c5fb451902i0Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 103 BYEUser-Agent: Asterisk PBXMax-Forwards: 70X-Asterisk-HangupCause: Normal ClearingX-Asterisk-HangupCauseCode: 16Content-Length: 0--- == Spawn extension (macro-dial, s, 7) exited non-zero on 'DAHDI/5-1' in macro 'dial' == Spawn extension (macro-exten-vm, s, 9) exited non-zero on 'DAHDI/5-1' in macro 'exten-vm' == Spawn extension (from-did-direct, 3026, 1) exited non-zero on 'DAHDI/5-1' -- Hungup 'DAHDI/5-1'pbx*CLI> <--- SIP read from 192.168.0.165:5060 --->SIP/2.0 200 OKTo: ;tag=9a4186c5fb451902i0From: "Unknown" ;tag=as57f4abd4Call-ID: This email address is being protected from spambots. You need JavaScript enabled to view it.CSeq: 103 BYEVia: SIP/2.0/UDP 192.168.0.54:5060;branch=z9hG4bK14955437Server: Cisco/SPA502G-7.4.8aContent-Length: 0<

---

>--- (8 headers 0 lines) ---Really destroying SIP dialog 'This email address is being protected from spambots. You need JavaScript enabled to view it.' Method: INVITE -- Starting simple switch on 'DAHDI/5-1' -- Executing [s@from-pstn:1] Set("DAHDI/5-1", "__FROM_DID=s") in new stack -- Executing [s@from-pstn:2] Gosub("DAHDI/5-1", "app-blacklist-check|s|1") in new stack -- Executing [s@app-blacklist-check:1] LookupBlacklist("DAHDI/5-1", "") in new stack -- Executing [s@app-blacklist-check:2] GotoIf("DAHDI/5-1", "0?blacklisted") in new stack -- Executing [s@app-blacklist-check:3] Return("DAHDI/5-1", "") in new stack -- Executing [s@from-pstn:3] ExecIf("DAHDI/5-1", "1 |Set|CALLERID(name)=") in new stack -- Executing [s@from-pstn:4] Set("DAHDI/5-1", "__CALLINGPRES_SV=allowed_not_screened") in new stack -- Executing [s@from-pstn:5] SetCallerPres("DAHDI/5-1", "allowed_not_screened") in new stack -- Executing [s@from-pstn:6] Goto("DAHDI/5-1", "from-did-direct|3026|1") in new stack -- Goto (from-did-direct,3026,1) -- Executing [3026@from-did-direct:1] Macro("DAHDI/5-1", "exten-vm|novm|3026") in new stack -- Executing [s@macro-exten-vm:1] Macro("DAHDI/5-1", "user-callerid") in new stack -- Executing [s@macro-user-callerid:1] Set("DAHDI/5-1", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:2] GotoIf("DAHDI/5-1", "0?report") in new stack -- Executing [s@macro-user-callerid:3] ExecIf("DAHDI/5-1", "1|Set|REALCALLERIDNUM=") in new stack -- Executing [s@macro-user-callerid:4] Set("DAHDI/5-1", "AMPUSER=") in new stack -- Executing [s@macro-user-callerid:5] Set("DAHDI/5-1", "AMPUSERCIDNAME=") in new stack -- Executing [s@macro-user-callerid:6] GotoIf("DAHDI/5-1", "1?report") in new stack -- Goto (macro-user-callerid,s,10) -- Executing [s@macro-user-callerid:10] GotoIf("DAHDI/5-1", "0?continue") in new stack -- Executing [s@macro-user-callerid:11] Set("DAHDI/5-1", "__TTL=64") in new stack -- Executing [s@macro-user-callerid:12] GotoIf("DAHDI/5-1", "1?continue") in new stack -- Goto (macro-user-callerid,s,19) -- Executing [s@macro-user-callerid:19] NoOp("DAHDI/5-1", "Using CallerID "" <>") in new stack -- Executing [s@macro-exten-vm:2] Set("DAHDI/5-1", "RingGroupMethod=none") in new stack -- Executing [s@macro-exten-vm:3] Set("DAHDI/5-1", "VMBOX=novm") in new stack -- Executing [s@macro-exten-vm:4] Set("DAHDI/5-1", "EXTTOCALL=3026") in new stack -- Executing [s@macro-exten-vm:5] Set("DAHDI/5-1", "CFUEXT=") in new stack -- Executing [s@macro-exten-vm:6] Set("DAHDI/5-1", "CFBEXT=") in new stack -- Executing [s@macro-exten-vm:7] Set("DAHDI/5-1", "RT=""") in new stack -- Executing [s@macro-exten-vm:8] Macro("DAHDI/5-1", "record-enable|3026|IN") in new stack -- Executing [s@macro-record-enable:1] GotoIf("DAHDI/5-1", "1?check") in new stack -- Goto (macro-record-enable,s,4) -- Executing [s@macro-record-enable:4] AGI("DAHDI/5-1", "recordingcheck|20120421-150307|1335038586.8") in new stack -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck recordingcheck|20120421-150307|1335038586.8: Inbound recording not enabled -- AGI Script recordingcheck completed, returning 0 -- Executing [s@macro-record-enable:5] MacroExit("DAHDI/5-1", "") in new stack -- Executing [s@macro-exten-vm:9] Macro("DAHDI/5-1", "dial||tr|3026") in new stack -- Executing [s@macro-dial:1] GotoIf("DAHDI/5-1", "1?dial") in new stack -- Goto (macro-dial,s,3) -- Executing [s@macro-dial:3] AGI("DAHDI/5-1", "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 == Manager 'admin' logged on from 127.0.0.1 dialparties.agi: Caller ID name is 'unknown' number is 'unknown' dialparties.agi: USE_CONFIRMATION: 'FALSE' dialparties.agi: RINGGROUP_INDEX: '' dialparties.agi: Methodology of ring is 'none' -- dialparties.agi: Added extension 3026 to extension map > dialparties.agi: Extension 3026 has call screening off -- dialparties.agi: Extension 3026 cf is disabled -- dialparties.agi: Extension 3026 do not disturb is disabled > dialparties.agi: extnum 3026 has: cw: 1; hascfb: 0 [] hascfu: 0 [] dialparties.agi: ExtensionState: 0 -- dialparties.agi: DbDel CALLTRACE/3026 - Caller ID is not defined -- dialparties.agi: Filtered ARG3: 3026 == Manager 'admin' logged off from 127.0.0.1 -- AGI Script dialparties.agi completed, returning 0 -- Executing [s@macro-dial:7] Dial("DAHDI/5-1", "SIP/3026||tr") in new stack

The log message was messed up, pls send me ssh info, i can check for you remotely!
My Mail: This email address is being protected from spambots. You need JavaScript enabled to view it.
MSN: This email address is being protected from spambots. You need JavaScript enabled to view it.
Skype: tim.jjune
Add me with the info above, call me when you are online!

Regards,
tim.june