SendFAX - Infinite Time

Community-based Support for users of Free Fax For Asterisk

SendFAX - Infinite Time

Postby hai2k » Wed Oct 28, 2009 7:05 pm

My asterisk install is 1.6.1.2 on i686 machine.

Sometimes my box does negotiate with the other end in T.38 OK. But again fax never goes out and following is the log.

Also look at the 'fax show session' output. It shows that rcv packet count is increasing in this error state but not the tx packet count. And also the negotiated tx bit rate is 2400, even though my T.38 setting say min 9600 and max 14400. I do know that other side is offering a max of 14400. And ECM setting from extensions.conf is not honored. It is shown as off for the session.

Any help is appreciated.


ccs1020platform*CLI>
-- Attempting call on SIP/16103004048@sip.broadvoice.com for 16103004048@fax-tx:1 (Retry 1)
== Using SIP RTP CoS mark 5
== Using UDPTL CoS mark 5
> doing dnsmgr_lookup for 'sip.broadvoice.com'
> Channel SIP/sip.broadvoice.com-099c2360 was answered.
-- Executing [16103004048@fax-tx:1] NoOp("SIP/sip.broadvoice.com-099c2360", "**** SENDING FAX ****") in new stack
-- Executing [16103004048@fax-tx:2] Wait("SIP/sip.broadvoice.com-099c2360", "1") in new stack
-- Executing [16103004048@fax-tx:3] Set("SIP/sip.broadvoice.com-099c2360", "FAXFILE=/tmp/test.tif") in new stack
-- Executing [16103004048@fax-tx:4] NoOp("SIP/sip.broadvoice.com-099c2360", "**** SETTING FAXOPT ****") in new stack
-- Executing [16103004048@fax-tx:5] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(ecm)=yes") in new stack
-- Executing [16103004048@fax-tx:6] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(headerinfo)=Fax from at was received.") in new stack
-- Executing [16103004048@fax-tx:7] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(localstationid)=234567890") in new stack
-- Executing [16103004048@fax-tx:8] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(maxbuffer)=200") in new stack
[Oct 28 19:55:18] WARNING[26413]: res_fax.c:1647 acf_faxopt_write: channel 'SIP/sip.broadvoice.com-099c2360' set FAXOPT(maxbuffer) to '200' is unhandled!
-- Executing [16103004048@fax-tx:9] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(maxdatagram)=316") in new stack
[Oct 28 19:55:18] WARNING[26413]: res_fax.c:1647 acf_faxopt_write: channel 'SIP/sip.broadvoice.com-099c2360' set FAXOPT(maxdatagram) to '316' is unhandled!
-- Executing [16103004048@fax-tx:10] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(maxrate)=14400") in new stack
-- Executing [16103004048@fax-tx:11] Set("SIP/sip.broadvoice.com-099c2360", "FAXOPT(minrate)=9600") in new stack
-- Executing [16103004048@fax-tx:12] NoOp("SIP/sip.broadvoice.com-099c2360", "**** SENDING FAX : /tmp/test.tif ****") in new stack
-- Executing [16103004048@fax-tx:13] SendFAX("SIP/sip.broadvoice.com-099c2360", "/tmp/test.tif,dz") in new stack
-- Channel 'SIP/sip.broadvoice.com-099c2360' sending fax '/tmp/test.tif'
[Oct 28 19:55:18] NOTICE[26413]: res_fax.c:680 generic_fax_exec: Negotiating T.38 for send on SIP/sip.broadvoice.com-099c2360
[Oct 28 19:55:18] NOTICE[26413]: res_fax.c:709 generic_fax_exec: Negotiated T.38 for send on SIP/sip.broadvoice.com-099c2360
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0' started
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 000.002360 ], STAT_EVT_STRT_TX st: IDLE rt: IDLENSTX
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 000.002502 ], STAT_EVT_TX_HW_RDY st: WT_TX_HW_RDY rt: TRDYNHTY
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.182301 ], STAT_INFO_CSI
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542603 ], STAT_INFO_DIS
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542645 ], STAT_EVT_DIS st: WT_DIS rt: XXXXNDIS
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542671 ], STAT_EVT_REMOTE_RX st: WT_DIS rt: WDISNRRX
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542720 ], STAT_NEG_V17_14400
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542741 ], STAT_NEG_MR
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542760 ], STAT_NEG_RES_204x196
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542779 ], STAT_NEG_A4
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542798 ], STAT_INFO_TSI
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 003.542858 ], STAT_INFO_DCS
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 005.569471 ], STAT_EVT_TX_V21_DONE st: WT_DIS rt: WDISNT21
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 008.818436 ], STAT_EVT_TX_TRN_END st: WT_TRN_RESP rt: XXXXNT21
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277039 ], STAT_INFO_DIS
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277082 ], STAT_EVT_DIS st: WT_TRN_RESP rt: XXXXNDIS
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277110 ], STAT_EVT_REMOTE_RX st: WT_TRN_RESP rt: WDISNRRX
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277137 ], STAT_NEG_V17_14400
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277159 ], STAT_NEG_MR
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277182 ], STAT_NEG_RES_204x196
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277203 ], STAT_NEG_A4
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277223 ], STAT_INFO_TSI
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 009.277277 ], STAT_INFO_DCS
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 011.304370 ], STAT_EVT_TX_V21_DONE st: WT_DIS rt: WDISNT21
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 014.541759 ], STAT_EVT_TX_TRN_END st: WT_TRN_RESP rt: XXXXNT21
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 014.707039 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 014.707081 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 020.131910 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 020.131957 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 025.562042 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 025.562087 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
> doing dnsmgr_lookup for 'sip.broadvoice.com'
ccs1020platform*CLI> fax show stats
ccs1020platform*CLI>
Fax Statistics:
---------------

Current Sessions : 1
Transmit Attempts : 1
Receive Attempts : 0
Completed Faxes : 0
Failed Faxes : 0

Digium T.38
Licensed Channels : 1
Max Concurrent : 1
Success : 0
Canceled : 0
No Fax : 0
Partial : 0
Negotiation Failed : 0
Train Failure : 0
Protocol Error : 0
IO Partial : 0
IO Fail : 0

Digium G.711
Licensed Channels : 1
Max Concurrent : 0
Success : 0
Switched to T.38 : 0
Canceled : 0
No Fax : 0
Partial : 0
Negotiation Failed : 0
Train Failure : 0
Protocol Error : 0
IO Partial : 0
IO Fail : 0


-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 030.991779 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 030.991823 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 036.421400 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 036.421443 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
ccs1020platform*CLI> fax show ses
session sessions
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 041.854147 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 041.854194 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
ccs1020platform*CLI> fax show session 0
ccs1020platform*CLI>
Fax Session Details:
--------------------

session : 0
operation : Transmit
state : Active
handle : 0
link type : UDP
frames received : 111
frames sent : 258

minrate : 9600
maxrate : 14400
Status : FAX_TRANSMITTING
Result : RSLT_IN_PROGRESS
Error : NO_ERROR
Call Duration : 0.000
ECM Mode : no
Data Rate : 2400

Image Resolution : unknown
Image Encoding : unknown
Page Size : unknown
Document Number : 0
Page Number : 0
File Name : UNKNOWN

Data Statistics:
Tx Pages : 0
Tx Bytes : 0
Total Tx Lines : 0
Rx Pages : 0
Rx Bytes : 0
Total Rx Lines : 0
Total Bad Lines : 0

Frame Statistics:
DIS/DCS/DTC/CTC Count : 0
CFR Count : 0
FTT Count : 0
MCF Count : 0
PPR Count : 0
RTN Count : 0
DCN Count : 0
Remote StationID :




-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 047.285774 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 047.285818 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
ccs1020platform*CLI> fax show session 0
ccs1020platform*CLI>
Fax Session Details:
--------------------

session : 0
operation : Transmit
state : Active
handle : 0
link type : UDP
frames received : 117
frames sent : 258

minrate : 9600
maxrate : 14400
Status : FAX_TRANSMITTING
Result : RSLT_IN_PROGRESS
Error : NO_ERROR
Call Duration : 0.000
ECM Mode : no
Data Rate : 2400
Image Resolution : unknown
Image Encoding : unknown
Page Size : unknown
Document Number : 0
Page Number : 0
File Name : UNKNOWN

Data Statistics:
Tx Pages : 0
Tx Bytes : 0
Total Tx Lines : 0
Rx Pages : 0
Rx Bytes : 0
Total Rx Lines : 0
Total Bad Lines : 0

Frame Statistics:
DIS/DCS/DTC/CTC Count : 0
CFR Count : 0
FTT Count : 0
MCF Count : 0
PPR Count : 0
RTN Count : 0
DCN Count : 0
Remote StationID :

-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 063.570641 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 063.570684 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 069.000901 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 069.000945 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 074.436893 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 074.436936 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 079.866768 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 079.866813 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 085.296887 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 085.296929 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
> doing dnsmgr_lookup for 'sip.broadvoice.com'
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 090.722245 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 090.722287 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 096.154510 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 096.154552 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 101.581629 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 101.581674 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 107.011252 ], STAT_FRM_CRP
-- Channel 'SIP/sip.broadvoice.com-099c2360' fax session '0', [ 107.011295 ], STAT_EVT_CRP st: WT_TRN_RESP rt: UNEXPECT
hai2k
Newsterisk
 
Posts: 3
Joined: Wed Oct 28, 2009 6:36 pm

Re: SendFAX - Infinite Time

Postby hai2k » Wed Oct 28, 2009 8:19 pm

My sip.conf
==========

[general]
bindaddr=0.0.0.0
bindport=5060
context=default
t38pt_udptl=yes
t38pt_rtp=no
t38pt_tcp=no
....
....
[sip.broadvoice.com]
type=peer
user=phone
host=sip.broadvoice.com
fromdomain=sip.broadvoice.com
fromuser=2142421783
secret=******
username=2142421783
insecure=very
context=default
authname=2142421783
dtmfmode=inband
dtmf=inband
;Disable canreinvite if you are behind a NAT
canreinvite=yes
;nat=yes
disallow=all ; need to disallow=all before we can use allow=
allow=ulaw
t38pt_udptl=yes
t38pt_rtp=no
t38pt_tcp=no

My extensions.conf
================
[fax-tx]
exten => 16103004048,1,NoOp(**** SENDING FAX ****)
exten => 16103004048,n,Wait(1)
;exten => 16103004048,n,Set(GLOBAL(FAXCOUNT)=$[ ${GLOBAL(FAXCOUNT)} + 1 ])
;exten => 16103004048,n,Set(FAXCOUNT=${GLOBAL(FAXCOUNT)})
exten => 16103004048,n,Set(FAXFILE=/tmp/test.tif)
; Set FAXOPTs
exten => 16103004048,n,NoOp(**** SETTING FAXOPT ****)
exten => 16103004048,n,Set(FAXOPT(ecm)=yes)
exten => 16103004048,n,Set(FAXOPT(headerinfo)=Fax from ${GLOBAL(LASTFAXCALLERNAME)} at ${GLOBAL(LASTFAXCALLERNUM)} was received.)
exten => 16103004048,n,Set(FAXOPT(localstationid)=234567890)
exten => 16103004048,n,Set(FAXOPT(maxbuffer)=200)
exten => 16103004048,n,Set(FAXOPT(maxdatagram)=316)
exten => 16103004048,n,Set(FAXOPT(maxrate)=14400)
exten => 16103004048,n,Set(FAXOPT(minrate)=9600)
; Send the fax
exten => 16103004048,n,NoOp(**** SENDING FAX : ${FAXFILE} ****)
exten => 16103004048,n,SendFAX(${FAXFILE},dz)


My Callfile:
=========
Channel: SIP/16103004048@sip.broadvoice.com
WaitTime: 180
MaxRetries: 0
RetryTime: 300
Archive: false
Context: fax-tx
Setvar: t38pt_udptl=yes
SetVar: T38CALL=1
SetVar: ecm=yes
Extension: 16103004048
Priority: 1
hai2k
Newsterisk
 
Posts: 3
Joined: Wed Oct 28, 2009 6:36 pm


Return to Fax For Asterisk

Who is online

Users browsing this forum: No registered users and 1 guest