|
Question : Can't Hear Incoming SIP Calls
|
|
Hi,
I've setup FreePBX 2.6.0.RC2.1 (Asterisk 1.4.21.2, CentOS 5.3) on a Dell OptiPlex, and have used port forwarding to route my SIP trunks (Hostcomm) through my Netgear router. I have outgoing calls working find, and incoming calls kind of working.
If I make outgoing calls, both parties can hear each other. The problem is, when I receive a call (from a land line, or mobile), neither party can hear each other, just silence!
SIP trunk settings are: Max Channels=1 Peer details: type=peer nat=no canreinvite=no insecure=very host=194.145.189.121 allow=alaw&ulaw
Inbound route: Any DID / Any CID Everything else is as default Ring Groups: 600
I'm using ZoIPer v2.22 as a softphone on my laptop to make & receive calls.
The log entry for a call is below:
[2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [1026001159@from-trunk-sip-Contact-pro:1] Set("SIP/217.174.252.24-09302c30", "GROUP()=OUT_3") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [1026001159@from-trunk-sip-Contact-pro:2] Goto("SIP/217.174.252.24-09302c30", "from-trunk|1026001159|1") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (from-trunk,1026001159,1) [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [1026001159@from-trunk:1] NoOp("SIP/217.174.252.24-09302c30", "Catch-All DID Match - Found 1026001159 - You probably want a DID for this.") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [1026001159@from-trunk:2] Goto("SIP/217.174.252.24-09302c30", "ext-did|s|1") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (ext-did,s,1) [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@ext-did:1] Set("SIP/217.174.252.24-09302c30", "__FROM_DID=s") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@ext-did:2] Gosub("SIP/217.174.252.24-09302c30", "app-blacklist-check|s|1") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@app-blacklist-check:1] LookupBlacklist("SIP/217.174.252.24-09302c30", "") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@app-blacklist-check:2] GotoIf("SIP/217.174.252.24-09302c30", "0?blacklisted") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@app-blacklist-check:3] Set("SIP/217.174.252.24-09302c30", "CALLED_BLACKLIST=1") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@app-blacklist-check:4] Return("SIP/217.174.252.24-09302c30", "") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@ext-did:3] ExecIf("SIP/217.174.252.24-09302c30", "0 |Set|CALLERID(name)=0845xxxxxxx") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@ext-did:4] Set("SIP/217.174.252.24-09302c30", "__CALLINGPRES_SV=allowed_not_screened") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@ext-did:5] SetCallerPres("SIP/217.174.252.24-09302c30", "allowed_not_screened") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@ext-did:6] Goto("SIP/217.174.252.24-09302c30", "ext-group|600|1") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (ext-group,600,1) [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:1] Macro("SIP/217.174.252.24-09302c30", "user-callerid|") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:1] Set("SIP/217.174.252.24-09302c30", "AMPUSER=0845xxxxxxx") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: Set [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:2] GotoIf("SIP/217.174.252.24-09302c30", "0?report") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: GotoIf [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:3] ExecIf("SIP/217.174.252.24-09302c30", "1|Set|REALCALLERIDNUM=0845xxxxxxx") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: ExecIf [2009-10-02 13:10:32] DEBUG[6272] func_db.c: DB: DEVICE/0845xxxxxxx/user not found in database. [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:4] Set("SIP/217.174.252.24-09302c30", "AMPUSER=") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: Set [2009-10-02 13:10:32] DEBUG[6272] func_db.c: DB: AMPUSER//cidname not found in database. [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:5] Set("SIP/217.174.252.24-09302c30", "AMPUSERCIDNAME=") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: Set [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:6] GotoIf("SIP/217.174.252.24-09302c30", "1?report") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (macro-user-callerid,s,10) [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: GotoIf [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:10] GotoIf("SIP/217.174.252.24-09302c30", "0?continue") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: GotoIf [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:11] Set("SIP/217.174.252.24-09302c30", "__TTL=64") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: Set [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:12] GotoIf("SIP/217.174.252.24-09302c30", "1?continue") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (macro-user-callerid,s,19) [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: GotoIf [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-user-callerid:19] NoOp("SIP/217.174.252.24-09302c30", "Using CallerID "0207xxxxxx via Company Name" <0845xxxxxxx>") in new stack [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: Noop [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:2] GotoIf("SIP/217.174.252.24-09302c30", "1?skipdb") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (ext-group,600,4) [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:4] Set("SIP/217.174.252.24-09302c30", "__NODEST=") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:5] Set("SIP/217.174.252.24-09302c30", "__BLKVM_OVERRIDE=BLKVM/600/SIP/217.174.252.24-09302c30") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:6] Set("SIP/217.174.252.24-09302c30", "__BLKVM_BASE=600") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:7] Set("SIP/217.174.252.24-09302c30", "DB(BLKVM/600/SIP/217.174.252.24-09302c30)=TRUE") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:8] Set("SIP/217.174.252.24-09302c30", "RRNODEST=") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:9] Set("SIP/217.174.252.24-09302c30", "__NODEST=600") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:10] Set("SIP/217.174.252.24-09302c30", "RecordMethod=Group") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:11] Macro("SIP/217.174.252.24-09302c30", "record-enable|101-102|Group") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-record-enable:1] GotoIf("SIP/217.174.252.24-09302c30", "1?check") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (macro-record-enable,s,4) [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: GotoIf [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-record-enable:4] AGI("SIP/217.174.252.24-09302c30", "recordingcheck|20091002-131032|1254485432.32") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- AGI Script recordingcheck completed, returning 0 [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: AGI [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-record-enable:5] MacroExit("SIP/217.174.252.24-09302c30", "") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:12] Set("SIP/217.174.252.24-09302c30", "RingGroupMethod=ringall") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [600@ext-group:13] Macro("SIP/217.174.252.24-09302c30", "dial|20|tr|101-102") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-dial:1] GotoIf("SIP/217.174.252.24-09302c30", "1?dial") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Goto (macro-dial,s,3) [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: GotoIf [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-dial:3] AGI("SIP/217.174.252.24-09302c30", "dialparties.agi") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Launched AGI Script /var/lib/asterisk/agi-bin/dialparties.agi [2009-10-02 13:10:32] VERBOSE[6272] logger.c: dialparties.agi: Starting New Dialparties.agi [2009-10-02 13:10:32] VERBOSE[6275] logger.c: == Parsing '/etc/asterisk/manager.conf': [2009-10-02 13:10:32] VERBOSE[6275] logger.c: Found [2009-10-02 13:10:32] VERBOSE[6275] logger.c: == Parsing '/etc/asterisk/manager_additional.conf': [2009-10-02 13:10:32] VERBOSE[6275] logger.c: Found [2009-10-02 13:10:32] VERBOSE[6275] logger.c: == Parsing '/etc/asterisk/manager_custom.conf': [2009-10-02 13:10:32] VERBOSE[6275] logger.c: Found [2009-10-02 13:10:32] VERBOSE[6275] logger.c: == Manager 'admin' logged on from 127.0.0.1 [2009-10-02 13:10:32] VERBOSE[6272] logger.c: dialparties.agi: Caller ID name is '0207xxxxxx via Company Name' number is '0845xxxxxxx' [2009-10-02 13:10:32] VERBOSE[6272] logger.c: dialparties.agi: Methodology of ring is 'ringall' [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Added extension 101 to extension map [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Added extension 102 to extension map [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Extension 101 cf is disabled [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Extension 102 cf is disabled [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Extension 101 do not disturb is disabled [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Extension 102 do not disturb is disabled [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: dbset CALLTRACE/101 to 0845xxxxxxx [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: dbset CALLTRACE/102 to 0845xxxxxxx [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- dialparties.agi: Filtered ARG3: 101-102 [2009-10-02 13:10:32] VERBOSE[6275] logger.c: == Manager 'admin' logged off from 127.0.0.1 [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- AGI Script dialparties.agi completed, returning 0 [2009-10-02 13:10:32] DEBUG[6272] app_macro.c: Executed application: AGI [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Executing [s@macro-dial:7] Dial("SIP/217.174.252.24-09302c30", "SIP/101&SIP/102|20|trM(auto-blkvm)") in new stack [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Called 101 [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- Called 102 [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- SIP/101-0930b638 is ringing [2009-10-02 13:10:32] VERBOSE[6272] logger.c: -- SIP/102-0924bb80 is ringing [2009-10-02 13:10:34] VERBOSE[6272] logger.c: -- SIP/102-0924bb80 answered SIP/217.174.252.24-09302c30
I'd really like to get this issue sorted ASAP, as I need to start taking customer calls!
Thanks
Ben
|
Answer : Can't Hear Incoming SIP Calls
|
|
Have managed to fix the issue. After talking to the SIP supplier and testing 2 different routers/firewalls, we worked out that the Netgear router was causing some issue. Replacing it with a 2Wire 2700HGV has solved the issue.
|
|
|
|