I’ve got exactly the same problem.
Fax detection works fine and redirects normally voice calls to the setted extension. Then the extension rings and the voice call goes on normelly.
Instead the fax incoming calls are redirected to the setted “Fax Recipient” (Extension 448 in my case) and ended up with a busy (or congestion - not sure) tone.
Here is the log (to avoid confusion in reading the log: the fax starts from an analog fax connected, through an ATA, to my extension 445 and calls, through my provider, my trunk 0302077007. The inbound route (DID 0302077007) answers the call, detects the fax tone, redirects the call to to the “Fax Recipient” 448 and it gets dropped):
[Nov 12 01:37:22] VERBOSE[18809] pbx.c: – Executing [s@macro-dialout-trunk:16] Macro(“SIP/445-0000004a”, “dialout-trunk-predial-hook,”) in new stack
[Nov 12 01:37:22] VERBOSE[18809] pbx.c: – Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit(“SIP/445-0000004a”, “”) in new stack
[Nov 12 01:37:22] VERBOSE[18809] pbx.c: – Executing [s@macro-dialout-trunk:17] GotoIf(“SIP/445-0000004a”, “0?bypass,1”) in new stack
[Nov 12 01:37:22] VERBOSE[18809] pbx.c: – Executing [s@macro-dialout-trunk:18] GotoIf(“SIP/445-0000004a”, “0?customtrunk”) in new stack
[Nov 12 01:37:22] VERBOSE[18809] pbx.c: – Executing [s@macro-dialout-trunk:19] Dial(“SIP/445-0000004a”, “SIP/LamFax/0302077007,300,Tt”) in new stack
[Nov 12 01:37:22] VERBOSE[18809] netsock2.c: == Using SIP RTP TOS bits 184
[Nov 12 01:37:22] VERBOSE[18809] netsock2.c: == Using SIP RTP CoS mark 5
[Nov 12 01:37:22] VERBOSE[18809] app_dial.c: – Called LamFax/0302077007
[Nov 12 01:37:22] VERBOSE[5121] netsock2.c: == Using SIP RTP TOS bits 184
[Nov 12 01:37:22] VERBOSE[5121] netsock2.c: == Using SIP RTP CoS mark 5
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-sip-external:1] NoOp(“SIP/0302056783-0000004c”, “Received incoming SIP connection from unknown peer to 0302077007”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-sip-external:2] Set(“SIP/0302056783-0000004c”, “DID=0302077007”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-sip-external:3] Goto(“SIP/0302056783-0000004c”, “s,1”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Goto (from-sip-external,s,1)
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [s@from-sip-external:1] GotoIf(“SIP/0302056783-0000004c”, “1?checklang:noanonymous”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Goto (from-sip-external,s,2)
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [s@from-sip-external:2] GotoIf(“SIP/0302056783-0000004c”, “0?setlanguage:from-trunk,0302077007,1”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Goto (from-trunk,0302077007,1)
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:1] Set(“SIP/0302056783-0000004c”, “__FROM_DID=0302077007”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:2] Gosub(“SIP/0302056783-0000004c”, “app-blacklist-check,s,1”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [s@app-blacklist-check:1] GotoIf(“SIP/0302056783-0000004c”, “0?blacklisted”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [s@app-blacklist-check:2] Set(“SIP/0302056783-0000004c”, “CALLED_BLACKLIST=1”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [s@app-blacklist-check:3] Return(“SIP/0302056783-0000004c”, “”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:3] ExecIf(“SIP/0302056783-0000004c”, “0 ?Set(CALLERID(name)=0302056783)”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:4] Set(“SIP/0302056783-0000004c”, “__CALLINGPRES_SV=allowed_not_screened”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:5] Set(“SIP/0302056783-0000004c”, “CALLERPRES()=allowed_not_screened”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:6] Set(“SIP/0302056783-0000004c”, “FAX_DEST=ext-fax^448^1”) in new stack
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:7] Answer(“SIP/0302056783-0000004c”, “”) in new stack
[Nov 12 01:37:22] VERBOSE[18809] app_dial.c: – SIP/LamFax-0000004b answered SIP/445-0000004a
[Nov 12 01:37:22] VERBOSE[18810] pbx.c: – Executing [0302077007@from-trunk:8] Wait(“SIP/0302056783-0000004c”, “4”) in new stack
[Nov 12 01:37:23] VERBOSE[18811] manager.c: == Manager ‘admin’ logged on from 127.0.0.1
[Nov 12 01:37:23] VERBOSE[18811] manager.c: == Manager ‘admin’ logged off from 127.0.0.1
[Nov 12 01:37:25] VERBOSE[18810] chan_sip.c: == Redirecting ‘SIP/0302056783-0000004c’ to fax extension due to CNG detection
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: == Spawn extension (from-trunk, fax, 1) exited non-zero on ‘SIP/0302056783-0000004c’
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Executing [h@from-trunk:1] Macro(“SIP/0302056783-0000004c”, “hangupcall,”) in new stack
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/0302056783-0000004c”, “1?skiprg”) in new stack
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Goto (macro-hangupcall,s,4)
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/0302056783-0000004c”, “1?skipblkvm”) in new stack
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Goto (macro-hangupcall,s,7)
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/0302056783-0000004c”, “1?theend”) in new stack
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Goto (macro-hangupcall,s,9)
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: – Executing [s@macro-hangupcall:9] Hangup(“SIP/0302056783-0000004c”, “”) in new stack
[Nov 12 01:37:25] VERBOSE[18810] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/0302056783-0000004c’ in macro ‘hangupcall’
[Nov 12 01:37:25] VERBOSE[18810] pbx.c: == Spawn extension (from-trunk, h, 1) exited non-zero on ‘SIP/0302056783-0000004c’
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [h@macro-dialout-trunk:1] Macro(“SIP/445-0000004a”, “hangupcall,”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/445-0000004a”, “1?skiprg”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Goto (macro-hangupcall,s,4)
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/445-0000004a”, “1?skipblkvm”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Goto (macro-hangupcall,s,7)
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/445-0000004a”, “1?theend”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Goto (macro-hangupcall,s,9)
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:9] Hangup(“SIP/445-0000004a”, “”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/445-0000004a’ in macro ‘hangupcall’
[Nov 12 01:37:25] VERBOSE[18809] features.c: == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on ‘SIP/445-0000004a’
[Nov 12 01:37:25] VERBOSE[18809] app_macro.c: == Spawn extension (macro-dialout-trunk, s, 19) exited non-zero on ‘SIP/445-0000004a’ in macro ‘dialout-trunk’
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: == Spawn extension (SipFax, 0302077007, 5) exited non-zero on ‘SIP/445-0000004a’
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [h@SipFax:1] Macro(“SIP/445-0000004a”, “hangupcall,”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:1] GotoIf(“SIP/445-0000004a”, “1?skiprg”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Goto (macro-hangupcall,s,4)
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:4] GotoIf(“SIP/445-0000004a”, “1?skipblkvm”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Goto (macro-hangupcall,s,7)
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:7] GotoIf(“SIP/445-0000004a”, “1?theend”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Goto (macro-hangupcall,s,9)
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: – Executing [s@macro-hangupcall:9] Hangup(“SIP/445-0000004a”, “”) in new stack
[Nov 12 01:37:25] VERBOSE[18809] app_macro.c: == Spawn extension (macro-hangupcall, s, 9) exited non-zero on ‘SIP/445-0000004a’ in macro ‘hangupcall’
[Nov 12 01:37:25] VERBOSE[18809] pbx.c: == Spawn extension (SipFax, h, 1) exited non-zero on ‘SIP/445-0000004a’
Does anybody have any idea?
Thanks a lot.