[hylafax-users] IAXModem + Asterisk + Hylafax

["Art Tarsha" <atarsha@xxxxxxxxxxx>]

I’ve been browsing through the mailing list for hours, and see that many others are experiencing a similar issue. When I attempt to send a fax to hylafax it is never received, it errors out.

 

 

My config is as follows:

 

PRI(PSTN) -> TE120P -> Asterisk -> IAXMODEM -> Hylafax

 

IAXMODEM Config:

device          /dev/ttyIAX

owner           uucp:uucp

mode            660

port            4570

refresh         300

server          x.x.x.x

peername        198

secret          xxxxx

cidname         John Doe

cidnumber       0000000000

codec           ulaw

 

Asterisk IAX Config:

[198]

type=friend

username=198

secret=xxxxx

qualify=yes

host=dynamic

disallow=all

allow=ulaw

trunk=yes

context=internal

 

Asterisk extensions.conf Config:

exten => 7882,1,Ringing

exten => 7882,2,Wait,2

exten => 7882,3,Dial(IAX2/198/${EXTEN},10,r)

 

 

/var/spool/hylafax/etc/config.ttyIAX Config:

CountryCode:            1

AreaCode:               480

FAXNumber:              +1.480.374.8828

LongDistancePrefix:     1

InternationalPrefix:    011

DialStringRules:        etc/dialrules

ServerTracing:          1

SessionTracing:         11

#ServerTracing:         0xFFF

#SessionTracing:                0xFFF

RecvFileMode:           0660

LogFileMode:            0600

DeviceMode:             0600

RingsBeforeAnswer:      2

SpeakerVolume:          on

GettyArgs:              "-h %l dx_%s"

LocalIdentifier:        "IAXmodem"

TagLineFont:            etc/lutRS18.pcf

TagLineFormat:          "From %%l|%c|Page %%P of %%T"

MaxRecvPages:           25

#added

ModemRate: 19200

ModemNoFlowCmd: AT&H0&I0&R1 # setup modem for no flow control

ModemHardFlowCmd: AT&H1&I0&R2 # setup modem for hardware flow control

ModemSoftFlowCmd: AT&H2&I2&R1 # setup modem for software flow control

ModemSetupDTRCmd: ATS13=1&D2 # setup so DTR drop resets modem

ModemSetupDCDCmd: AT&C1 # setup so DCD reflects carrier (or not)

ModemResultCodesCmd: ATQ0X4 # enable extended result codes

ModemDialCmd: "ATX3DT%s"

ModemSetupAACmd: AT+FAA=1

ModemSetVolumeCmd: "ATM0 ATM1 ATM1 ATM1 ATM1"

Class2BUGCmd: AT+FBU=0

Class2CQQueryCmd: !(0),(0) # override modem response

Class2NRCmd: AT+FNR=1,1,1,0

Class2SendRTC: yes

Class2APQueryCmd: none

#

#

# Modem-related stuff: should reflect modem command interface

# and hardware connection/cabling (e.g. flow control).

#

ModemType:              Class1          # use this to supply a hint

 

#

# Enabling this will use the hfaxd-protocol to set Caller*ID

#

#ModemSetOriginCmd:     AT+VSID="%s","%d"

 

#

# If "glare" during initialization becomes a problem then take

# the modem off-hook during initialization, and then place it

# back on-hook when done.

#

ModemResetCmds: "ATH1\nAT+VCID=1"       # enables CallID display

ModemReadyCmds: ATH0

 

Class1AdaptRecvCmd:     AT+FAR=1

Class1TMConnectDelay:   400             # counteract quick CONNECT response

 

#

# If you have trouble with V.17 receiving or sending,

# you may want to enable one of these, respectively.

#

Class1RMQueryCmd:      "!24,48,72,96"  # enable this to disable V.17 receiving

Class1TMQueryCmd:      "!24,48,72,96"  # enable this to disable V.17 sending

 

#

# You'll likely want Caller*ID display (also displays DID) enabled.

#

ModemResetCmds:         AT+VCID=1       # enables CallID display

 

#

# The pty does not support changing parity.

#

PagerTTYParity:         none

 

#

# If you are "missing" Caller*ID data on some calls (but not all)

# and if you do not have adequate glare protection you may want to

# not answer based on RINGs, but rather enable the CallIDAnswerLength

# for NDID, disable AT+VCID=1 and do this:

#

#RingsBeforeAnswer: 0

#ModemRingResponse: AT+VRID=1

 

# Uncomment DATE and TIME if you really want them, but you probably don't.

#CallIDPattern:          "DATE="

#CallIDPattern:          "TIME="

CallIDPattern:          "NMBR="

CallIDPattern:          "NAME="

CallIDPattern:          "ANID="

#CallIDPattern:          "USER="        # username provided by call

#CallIDPattern:          "PASS="        # password provided by call

#CallIDPattern:          "CDID="        # DID context in call

CallIDPattern:          "NDID="

#CallIDAnswerLength:    4

 

Class1PPMWaitCmd:   "<delay:7>"

Class1TCFWaitCmd:   "<delay:7>"

Class1EOPWaitCmd:   "<delay:9>"

Class1SwitchingCmd: "<delay:7>"

 

Transaction log from /var/spool/hylafax/log/c000000022:

Feb 15 12:18:54.07: [ 2529]: SESSION BEGIN 000000022 14803748828

Feb 15 12:18:54.07: [ 2529]: HylaFAX (tm) Version 4.4.4

Feb 15 12:18:54.07: [ 2529]: CallID: "4807756069" "PNI INC" "<NONE>" "7882"

Feb 15 12:18:54.07: [ 2529]: <-- [4:ATA\r]

Feb 15 12:18:57.79: [ 2529]: --> [7:CONNECT]

Feb 15 12:18:57.79: [ 2529]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyIAX'

Feb 15 12:18:57.79: [ 2529]: RECV FAX: begin

Feb 15 12:18:57.79: [ 2529]: <-- data [32]

Feb 15 12:18:57.79: [ 2529]: <-- data [2]

Feb 15 12:18:58.75: [ 2529]: --> [7:CONNECT]

Feb 15 12:18:58.75: [ 2529]: <-- data [23]

Feb 15 12:18:58.75: [ 2529]: <-- data [2]

Feb 15 12:18:59.49: [ 2529]: --> [7:CONNECT]

Feb 15 12:18:59.49: [ 2529]: <-- data [13]

Feb 15 12:18:59.49: [ 2529]: <-- data [2]

Feb 15 12:19:00.07: [ 2529]: --> [2:OK]

Feb 15 12:19:00.07: [ 2529]: <-- [9:AT+FRH=3\r]

Feb 15 12:19:07.07: [ 2529]: --> [0:]

Feb 15 12:19:07.07: [ 2529]: MODEM <Empty line>

Feb 15 12:19:07.07: [ 2529]: <-- data [1]

Feb 15 12:19:07.08: [ 2529]: --> [2:OK]

Feb 15 12:19:07.08: [ 2529]: DELAY 70 ms

Feb 15 12:19:07.15: [ 2529]: <-- [9:AT+FTH=3\r]

Feb 15 12:19:07.16: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:07.16: [ 2529]: <-- data [32]

Feb 15 12:19:07.16: [ 2529]: <-- data [2]

Feb 15 12:19:08.94: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:08.94: [ 2529]: <-- data [23]

Feb 15 12:19:08.94: [ 2529]: <-- data [2]

Feb 15 12:19:09.68: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:09.68: [ 2529]: <-- data [13]

Feb 15 12:19:09.68: [ 2529]: <-- data [2]

Feb 15 12:19:10.26: [ 2529]: --> [2:OK]

Feb 15 12:19:10.26: [ 2529]: <-- [9:AT+FRH=3\r]

Feb 15 12:19:17.26: [ 2529]: --> [0:]

Feb 15 12:19:17.26: [ 2529]: MODEM <Empty line>

Feb 15 12:19:17.26: [ 2529]: <-- data [1]

Feb 15 12:19:17.26: [ 2529]: --> [2:OK]

Feb 15 12:19:17.26: [ 2529]: DELAY 70 ms

Feb 15 12:19:17.33: [ 2529]: <-- [9:AT+FTH=3\r]

Feb 15 12:19:17.34: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:17.34: [ 2529]: <-- data [32]

Feb 15 12:19:17.34: [ 2529]: <-- data [2]

Feb 15 12:19:19.12: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:19.12: [ 2529]: <-- data [23]

Feb 15 12:19:19.12: [ 2529]: <-- data [2]

Feb 15 12:19:19.86: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:19.86: [ 2529]: <-- data [13]

Feb 15 12:19:19.86: [ 2529]: <-- data [2]

Feb 15 12:19:20.44: [ 2529]: --> [2:OK]

Feb 15 12:19:20.44: [ 2529]: <-- [9:AT+FRH=3\r]

Feb 15 12:19:27.44: [ 2529]: --> [0:]

Feb 15 12:19:27.44: [ 2529]: MODEM <Empty line>

Feb 15 12:19:27.44: [ 2529]: <-- data [1]

Feb 15 12:19:27.45: [ 2529]: --> [2:OK]

Feb 15 12:19:27.45: [ 2529]: DELAY 70 ms

Feb 15 12:19:27.52: [ 2529]: <-- [9:AT+FTH=3\r]

Feb 15 12:19:27.53: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:27.53: [ 2529]: <-- data [32]

Feb 15 12:19:27.53: [ 2529]: <-- data [2]

Feb 15 12:19:29.31: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:29.31: [ 2529]: <-- data [23]

Feb 15 12:19:29.31: [ 2529]: <-- data [2]

Feb 15 12:19:30.05: [ 2529]: --> [7:CONNECT]

Feb 15 12:19:30.05: [ 2529]: <-- data [13]

Feb 15 12:19:30.05: [ 2529]: <-- data [2]

Feb 15 12:19:30.63: [ 2529]: --> [2:OK]

Feb 15 12:19:30.63: [ 2529]: <-- [9:AT+FRH=3\r]

Feb 15 12:19:34.47: [ 2529]: --> [10:NO CARRIER]

Feb 15 12:19:34.47: [ 2529]: MODEM No carrier

Feb 15 12:19:34.47: [ 2529]: DELAY 70 ms

Feb 15 12:19:34.54: [ 2529]: <-- [9:AT+FTH=3\r]

Feb 15 12:19:34.54: [ 2529]: --> [5:ERROR]

Feb 15 12:19:34.54: [ 2529]: RECV FAX: RSPREC error/got EOT

Feb 15 12:19:34.54: [ 2529]: RECV FAX: end

Feb 15 12:19:34.54: [ 2529]: RSPREC error/got EOT

Feb 15 12:19:34.54: [ 2529]: SESSION END

 

/var/log/messages output for Spandsp:

Feb 15 12:10:16 localhost xinetd[22729]: START: tftp pid=2599 from=192.168.10.112

Feb 15 12:12:56 localhost FaxGetty[2529]: ANSWER: Call ID 1 "4807756069"

Feb 15 12:12:56 localhost FaxGetty[2529]: ANSWER: Call ID 2 "PNI INC"

Feb 15 12:12:56 localhost FaxGetty[2529]: ANSWER: Call ID 3 "<NONE>"

Feb 15 12:12:56 localhost FaxGetty[2529]: ANSWER: Call ID 4 "7882"

Feb 15 12:13:05 localhost FaxGetty[2529]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyIAX'

Feb 15 12:13:49 localhost FaxGetty[2529]: MODEM WWW.SOFT-SWITCH.ORG spandsp/

Feb 15 12:14:02 localhost FaxGetty[2529]: ANSWER: Call ID 1 "4807756069"

Feb 15 12:14:02 localhost FaxGetty[2529]: ANSWER: Call ID 2 "PNI INC"

Feb 15 12:14:02 localhost FaxGetty[2529]: ANSWER: Call ID 3 "<NONE>"

Feb 15 12:14:03 localhost FaxGetty[2529]: ANSWER: Call ID 4 "7882"

Feb 15 12:14:11 localhost FaxGetty[2529]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyIAX'

Feb 15 12:14:45 localhost FaxGetty[2529]: MODEM WWW.SOFT-SWITCH.ORG spandsp/

Feb 15 12:17:17 localhost FaxGetty[2529]: ANSWER: Call ID 1 "8013940520"

Feb 15 12:17:17 localhost FaxGetty[2529]: ANSWER: Call ID 2 "DENNIS,GEORGE"

Feb 15 12:17:17 localhost FaxGetty[2529]: ANSWER: Call ID 3 "<NONE>"

Feb 15 12:17:17 localhost FaxGetty[2529]: ANSWER: Call ID 4 "7882"

Feb 15 12:17:26 localhost FaxGetty[2529]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyIAX'

Feb 15 12:18:11 localhost FaxGetty[2529]: MODEM WWW.SOFT-SWITCH.ORG spandsp/

Feb 15 12:18:49 localhost FaxGetty[2529]: ANSWER: Call ID 1 "4807756069"

Feb 15 12:18:49 localhost FaxGetty[2529]: ANSWER: Call ID 2 "PNI INC"

Feb 15 12:18:49 localhost FaxGetty[2529]: ANSWER: Call ID 3 "<NONE>"

Feb 15 12:18:49 localhost FaxGetty[2529]: ANSWER: Call ID 4 "7882"

Feb 15 12:18:57 localhost FaxGetty[2529]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyIAX'

Feb 15 12:19:42 localhost FaxGetty[2529]: MODEM WWW.SOFT-SWITCH.ORG spandsp/\

 

Ps –aux output:

uucp      2528  0.0  0.1   3284  1132 pts/3    Ss+  12:05   0:00 /usr/bin/iaxmodem ttyIAX

uucp      2529  0.0  0.1   5012  1984 ?        Ss   12:04   0:00 /usr/local/sbin/faxgetty ttyIAX

uucp      2578  0.0  0.1   6956  1256 ?        Ss   12:07   0:00 /usr/local/sbin/faxq

uucp      2581  0.0  0.0   4548   900 ?        Ss   12:07   0:00 /usr/local/sbin/hfaxd -i hylafax

 

 

I can hear the IAXModem train but the fax does not attempt to send. Any thoughts on this would be appreciated..

 

Additionally I tried the record option and I heard stuff in the –dsp but nothing in the –iax its size is 320 (which from what I’ve read on the list essentially means there is an audio issue between the devices, though I find it bazaar that I can hear IAXmodem train yet not the fax machine itself.

 

-rw-r-----  1 uucp root 646400 2008-02-15 11:44 198-dsp.raw

-rw-r-----  1 uucp root    320 2008-02-15 11:43 198-iax.raw

 

 

Any insight would be appreciated..

 

 

Thanks!

-Art