Can't receive inbound calls

I’m trying to set up FreePBX for the first time. I can’t receive inbound calls (outbound is fine) from a DID, nor can I seem to receive calls from internal extensions. Here is my log. Can anyone tell me what is wrong? From what I can tell, everything looks fine until it tries to reach the extensions (I have 3 extensions in the ring group as you can see), but it is unsuccessful.

== Using SIP RTP TOS bits 184
== Using SIP RTP CoS mark 5
– Executing [[email protected]:1] Set(“SIP/freephoneline-00000021”, “GROUP()=OUT_1”) in new stack
– Executing [[email protected]:2] Goto(“SIP/freephoneline-00000021”, “from-trunk,16135551234,1”) in new stack
– Goto (from-trunk,16135551234,1)
– Executing [[email protected]:1] NoOp(“SIP/freephoneline-00000021”, “Catch-All DID Match - Found 16135551234 - You probably want a DID for this.”) in new stack
– Executing [[email protected]:2] Goto(“SIP/freephoneline-00000021”, “ext-did,s,1”) in new stack
– Goto (ext-did,s,1)
– Executing [[email protected]:1] Set(“SIP/freephoneline-00000021”, “__FROM_DID=s”) in new stack
– Executing [[email protected]:2] Gosub(“SIP/freephoneline-00000021”, “app-blacklist-check,s,1”) in new stack
– Executing [[email protected]:1] GotoIf(“SIP/freephoneline-00000021”, “0?blacklisted”) in new stack
– Executing [[email protected]:2] Set(“SIP/freephoneline-00000021”, “CALLED_BLACKLIST=1”) in new stack
– Executing [[email protected]:3] Return(“SIP/freephoneline-00000021”, “”) in new stack
– Executing [[email protected]:3] ExecIf(“SIP/freephoneline-00000021”, “0 ?Set(CALLERID(name)=4255556789)”) in new stack
– Executing [[email protected]:4] Set(“SIP/freephoneline-00000021”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
– Executing [[email protected]:5] Set(“SIP/freephoneline-00000021”, “CALLERPRES()=allowed_not_screened”) in new stack
– Executing [[email protected]:6] Goto(“SIP/freephoneline-00000021”, “ext-group,600,1”) in new stack
– Goto (ext-group,600,1)
– Executing [[email protected]:1] Macro(“SIP/freephoneline-00000021”, “user-callerid,”) in new stack
– Executing [[email protected]:1] Set(“SIP/freephoneline-00000021”, “AMPUSER=4255556789”) in new stack
– Executing [[email protected]:2] GotoIf(“SIP/freephoneline-00000021”, “0?report”) in new stack
– Executing [[email protected]:3] ExecIf(“SIP/freephoneline-00000021”, “1?Set(REALCALLERIDNUM=4255556789)”) in new stack
– Executing [[email protected]:4] Set(“SIP/freephoneline-00000021”, “AMPUSER=”) in new stack
– Executing [[email protected]:5] Set(“SIP/freephoneline-00000021”, “AMPUSERCIDNAME=”) in new stack
– Executing [[email protected]:6] GotoIf(“SIP/freephoneline-00000021”, “1?report”) in new stack
– Goto (macro-user-callerid,s,10)
– Executing [[email protected]:10] GotoIf(“SIP/freephoneline-00000021”, “0?continue”) in new stack
– Executing [[email protected]:11] Set(“SIP/freephoneline-00000021”, “__TTL=64”) in new stack
– Executing [[email protected]:12] GotoIf(“SIP/freephoneline-00000021”, “1?continue”) in new stack
– Goto (macro-user-callerid,s,19)
– Executing [[email protected]:19] Set(“SIP/freephoneline-00000021”, “CALLERID(number)=4255556789”) in new stack
– Executing [[email protected]:20] Set(“SIP/freephoneline-00000021”, “CALLERID(name)=SMITH JOHN”) in new stack
– Executing [[email protected]:21] NoOp(“SIP/freephoneline-00000021”, “Using CallerID “SMITH JOHN” <4255556789>”) in new stack
– Executing [[email protected]:2] GotoIf(“SIP/freephoneline-00000021”, “1?skipdb”) in new stack
– Goto (ext-group,600,4)
– Executing [[email protected]:4] Set(“SIP/freephoneline-00000021”, “__NODEST=”) in new stack
– Executing [[email protected]:5] Set(“SIP/freephoneline-00000021”, “__BLKVM_OVERRIDE=BLKVM/600/SIP/freephoneline-00000021”) in new stack
– Executing [[email protected]:6] Set(“SIP/freephoneline-00000021”, “__BLKVM_BASE=600”) in new stack
– Executing [[email protected]:7] Set(“SIP/freephoneline-00000021”, “DB(BLKVM/600/SIP/freephoneline-00000021)=TRUE”) in new stack
– Executing [[email protected]:8] Set(“SIP/freephoneline-00000021”, “RRNODEST=”) in new stack
– Executing [[email protected]:9] Set(“SIP/freephoneline-00000021”, “__NODEST=600”) in new stack
– Executing [[email protected]:10] Set(“SIP/freephoneline-00000021”, “RecordMethod=Group”) in new stack
– Executing [[email protected]:11] Macro(“SIP/freephoneline-00000021”, “record-enable,101-102-109,Group”) in new stack
– Executing [[email protected]acro-record-enable:1] GotoIf(“SIP/freephoneline-00000021”, “1?check”) in new stack
– Goto (macro-record-enable,s,4)
– Executing [[email protected]:4] AGI(“SIP/freephoneline-00000021”, “recordingcheck,20110320-054708,1300600021.33”) in new stack
– Executing [[email protected]:5] MacroExit(“SIP/freephoneline-00000021”, “”) in new stack
– Executing [[email protected]:12] Set(“SIP/freephoneline-00000021”, “RingGroupMethod=ringall”) in new stack
– Executing [[email protected]:13] Macro(“SIP/freephoneline-00000021”, “dial,30,tr,101-102-109”) in new stack
– Executing [[email protected]:1] GotoIf(“SIP/freephoneline-00000021”, “1?dial”) in new stack

-- Goto (macro-dial,s,3)
-- Executing [[email protected]:3] AGI("SIP/freephoneline-00000021", "dialparties.agi") in new stack
-- Executing [[email protected]:4] NoOp("SIP/freephoneline-00000021", "Returned from dialparties with no extensions to call and DIALSTATUS: ") in new stack
-- Executing [[email protected]:14] Set("SIP/freephoneline-00000021", "RingGroupMethod=") in new stack
-- Executing [[email protected]:15] GotoIf("SIP/freephoneline-00000021", "0?nodest") in new stack
-- Executing [[email protected]:16] Set("SIP/freephoneline-00000021", "__NODEST=") in new stack
-- Executing [[email protected]:17] NoOp("SIP/freephoneline-00000021", "Deleting: BLKVM/600/SIP/freephoneline-00000021 TRUE") in new stack
-- Executing [[email protected]:18] Goto("SIP/freephoneline-00000021", "app-blackhole,hangup,1") in new stack
-- Goto (app-blackhole,hangup,1)
-- Executing [[email protected]:1] NoOp("SIP/freephoneline-00000021", "Blackhole Dest: Hangup") in new stack
-- Executing [[email protected]:2] Hangup("SIP/freephoneline-00000021", "") in new stack

== Spawn extension (app-blackhole, hangup, 2) exited non-zero on ‘SIP/freephoneline-00000021’

That’s what I’ve done. I tried it with and without a DID number. Right now, it’s set to Any DID/CID. I’ve tried setting it to the DID from the provider with the same result. I’ve also tried configuring the extension with an assigned DID (no inboud route necessary).

I’ve tried this with just one extension, and with a ring group (PAP2T and softphone). I’ve also tried this with two providers (freephoneline.ca and voip.ms). I get the same result. I can register the phones directly with the provider wih no problems.

I can see the phones are registered on both the FreePBX status page, and on the devices themselves. I’ve done a ‘sip show peers’ in the CLI to verify the incoming trunk is OK.

My FreePBX box and phones are both behind a router, but I have NAT enabled to the provider using the recommended trunk configurations. "sip show peers’ has an ‘N’ under the Nat column, which I can’t figure out. I have nat=yes in the user details of both trunks. Is it possibly overridden?

I’m thinking I must be missing something basic, but I’m at a loss to find it.

Looks like you need to add an inbound route for 16135551234. That will tell the system what to do with calls to that number. If you want all phones to ring, create a ring group with them in it and point that inbound route to the ring group.