Faxversand mit Asterisk (Trixbox), Hylafax und IAXModem

[Roi]

Hallo zusammen,

verzweifelt mache ich nun hier einen Thread auf und hoffe, dass mir jemand weiterhelfen kann. Leider bekam ich bei Google und auch hier ueber die Suche keine passende Auskunft, und ueber Tage habe ich alles moegliche probiert.

Folgendes Problem: Wuerde gerne Faxe versenden. Die Randbedingungen sind Asterisk (Trixbox 2.8.x), Hylafax und IAXModem. Im Asterisk-Rechner befindet sich eine Fritzcard PCI, die ueber mISDN betrieben wird. Die Fritzcard haengt am ISDN eines KabelBW-Anschlusses (sollte also VoIP sein). Faxempfang sowie Voicedienste (Voicemail und Telefonie) funktionieren tadellos.

Versuche ich ein Fax zu versenden, bekomme ich immer die Meldung "No carrier detected". Ausserdem scheint sich die IAX Extension irgendwie wegzuhaengen, da bekomme ich im Asterisk Log immer die Meldung von wegen LAGGED und UNREACHABLE, nach Hangup kommt die Extension dann wieder.

Das Log schaut dann z.B. so aus (die Empfaengerfaxnummer ist 12345678):

[May 30 04:48:57] VERBOSE[2632] logger.c:     -- Accepting AUTHENTICATED call from 127.0.0.1:
       > requested format = alaw,
       > requested prefs = (),
       > actual format = alaw,
       > host prefs = (alaw),
       > priority = mine
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [12345678@from-internal:1] Macro("IAX2/300-9579", "user-callerid,SKIPTTL,") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:1] Set("IAX2/300-9579", "AMPUSER=300") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:2] GotoIf("IAX2/300-9579", "0?report") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:3] ExecIf("IAX2/300-9579", "0?Set(REALCALLERIDNUM=300)") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:4] Set("IAX2/300-9579", "AMPUSER=300") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:5] Set("IAX2/300-9579", "AMPUSERCIDNAME=IaxModem") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:6] GotoIf("IAX2/300-9579", "0?report") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:7] Set("IAX2/300-9579", "AMPUSERCID=300") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:8] Set("IAX2/300-9579", "CALLERID(all)="IaxModem" <300>") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:9] ExecIf("IAX2/300-9579", "0?Set(CHANNEL(language)=)") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:10] GotoIf("IAX2/300-9579", "1?continue") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Goto (macro-user-callerid,s,19)
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-user-callerid:19] NoOp("IAX2/300-9579", "Using CallerID "IaxModem" <300>") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [12345678@from-internal:2] Set("IAX2/300-9579", "_NODEST=") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [12345678@from-internal:3] Macro("IAX2/300-9579", "record-enable,300,OUT,") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-record-enable:1] GotoIf("IAX2/300-9579", "1?check") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Goto (macro-record-enable,s,4)
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Executing [s@macro-record-enable:4] AGI("IAX2/300-9579", "recordingcheck,20100530-044857,1275187737.68") in new stack
[May 30 04:48:57] VERBOSE[20783] logger.c:     -- Launched AGI Script /var/lib/asterisk/agi-bin/recordingcheck
[May 30 04:48:58] VERBOSE[20783] logger.c:  recordingcheck,20100530-044857,1275187737.68: Outbound recording not enabled
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- <IAX2/300-9579>AGI Script recordingcheck completed, returning 0
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-record-enable:5] MacroExit("IAX2/300-9579", "") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [12345678@from-internal:4] Macro("IAX2/300-9579", "dialout-trunk,2,12345678,,") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:1] Set("IAX2/300-9579", "DIAL_TRUNK=2") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:2] GosubIf("IAX2/300-9579", "0?sub-pincheck,s,1") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:3] GotoIf("IAX2/300-9579", "0?disabletrunk,1") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:4] Set("IAX2/300-9579", "DIAL_NUMBER=12345678") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:5] Set("IAX2/300-9579", "DIAL_TRUNK_OPTIONS=tr") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:6] Set("IAX2/300-9579", "OUTBOUND_GROUP=OUT_2") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:7] GotoIf("IAX2/300-9579", "1?nomax") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Goto (macro-dialout-trunk,s,9)
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:9] GotoIf("IAX2/300-9579", "0?skipoutcid") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:10] Set("IAX2/300-9579", "DIAL_TRUNK_OPTIONS=") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:11] Macro("IAX2/300-9579", "outbound-callerid,2") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:1] ExecIf("IAX2/300-9579", "0?Set(CALLERPRES()=)") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:2] ExecIf("IAX2/300-9579", "0?Set(REALCALLERIDNUM=300)") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:3] GotoIf("IAX2/300-9579", "1?normcid") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Goto (macro-outbound-callerid,s,6)
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:6] Set("IAX2/300-9579", "USEROUTCID=7114072910") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:7] Set("IAX2/300-9579", "EMERGENCYCID=") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:8] Set("IAX2/300-9579", "TRUNKOUTCID=7114072909") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:9] GotoIf("IAX2/300-9579", "1?trunkcid") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Goto (macro-outbound-callerid,s,12)
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:12] ExecIf("IAX2/300-9579", "1?Set(CALLERID(all)=7114072909)") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:13] ExecIf("IAX2/300-9579", "1?Set(CALLERID(all)=7114072910)") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-outbound-callerid:14] ExecIf("IAX2/300-9579", "0?Set(CALLERPRES()=prohib_passed_screen)") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:12] ExecIf("IAX2/300-9579", "0?AGI(fixlocalprefix)") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:13] Set("IAX2/300-9579", "OUTNUM=12345678") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:14] Set("IAX2/300-9579", "custom=AMP") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:15] ExecIf("IAX2/300-9579", "0?Set(DIAL_TRUNK_OPTIONS=M(setmusic^))") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:16] Macro("IAX2/300-9579", "dialout-trunk-predial-hook,") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk-predial-hook:1] MacroExit("IAX2/300-9579", "") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:17] GotoIf("IAX2/300-9579", "0?bypass,1") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:18] GotoIf("IAX2/300-9579", "1?customtrunk") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Goto (macro-dialout-trunk,s,21)
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:21] Set("IAX2/300-9579", "pre_num=AMP:mISDN/g:isdn/") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:22] Set("IAX2/300-9579", "the_num=OUTNUM") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:23] Set("IAX2/300-9579", "post_num=") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:24] GotoIf("IAX2/300-9579", "1?outnum:skipoutnum") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Goto (macro-dialout-trunk,s,25)
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:25] Set("IAX2/300-9579", "the_num=12345678") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-dialout-trunk:26] Dial("IAX2/300-9579", "mISDN/g:isdn/12345678,300,") in new stack
[May 30 04:48:58] VERBOSE[20783] logger.c:     -- Called g:isdn/12345678
[May 30 04:49:02] VERBOSE[20783] logger.c:     -- mISDN/1-u60 is proceeding passing it to IAX2/300-9579
[May 30 04:49:03] VERBOSE[20783] logger.c:     -- mISDN/1-u60 is ringing
[May 30 04:49:13] VERBOSE[20783] logger.c:     -- mISDN/1-u60 answered IAX2/300-9579
[May 30 04:49:13] DEBUG[2577] pbx.c: FONALITY: This thread has already held the conlock, skip locking
[May 30 04:49:41] NOTICE[2634] chan_iax2.c: Peer '300' is now TOO LAGGED (3670 ms)!
[May 30 04:49:41] DEBUG[2577] pbx.c: FONALITY: This thread has already held the conlock, skip locking
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [h@macro-dialout-trunk:1] Macro("IAX2/300-9579", "hangupcall,") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:1] GotoIf("IAX2/300-9579", "1?skiprg") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Goto (macro-hangupcall,s,4)
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:4] GotoIf("IAX2/300-9579", "1?skipblkvm") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Goto (macro-hangupcall,s,7)
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:7] GotoIf("IAX2/300-9579", "1?theend") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Goto (macro-hangupcall,s,9)
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:9] Hangup("IAX2/300-9579", "") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:   == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'IAX2/300-9579' in macro 'hangupcall'
[May 30 04:49:58] VERBOSE[20783] logger.c:   == Spawn extension (macro-dialout-trunk, h, 1) exited non-zero on 'IAX2/300-9579'
[May 30 04:49:58] VERBOSE[20783] logger.c:   == Spawn extension (macro-dialout-trunk, s, 26) exited non-zero on 'IAX2/300-9579' in macro 'dialout-trunk'
[May 30 04:49:58] VERBOSE[20783] logger.c:   == Spawn extension (from-internal, 12345678, 4) exited non-zero on 'IAX2/300-9579'
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [h@from-internal:1] Macro("IAX2/300-9579", "hangupcall") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:1] GotoIf("IAX2/300-9579", "1?skiprg") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Goto (macro-hangupcall,s,4)
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:4] GotoIf("IAX2/300-9579", "1?skipblkvm") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Goto (macro-hangupcall,s,7)
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:7] GotoIf("IAX2/300-9579", "1?theend") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Goto (macro-hangupcall,s,9)
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Executing [s@macro-hangupcall:9] Hangup("IAX2/300-9579", "") in new stack
[May 30 04:49:58] VERBOSE[20783] logger.c:   == Spawn extension (macro-hangupcall, s, 9) exited non-zero on 'IAX2/300-9579' in macro 'hangupcall'
[May 30 04:49:58] VERBOSE[20783] logger.c:   == Spawn extension (from-internal, h, 1) exited non-zero on 'IAX2/300-9579'
[May 30 04:49:58] VERBOSE[20783] logger.c:     -- Hungup 'IAX2/300-9579'
[May 30 04:50:05] NOTICE[2635] chan_iax2.c: Peer '300' is now REACHABLE! Time: 9
[May 30 04:50:05] DEBUG[2577] pbx.c: FONALITY: This thread has already held the conlock, skip locking

Hier noch Config Files:

/etc/iaxmodem/iaxmodem-cfg.ttyIAX

device          /dev/ttyIAX
owner           uucp:uucp
mode            660
port            4570
refresh         60
server          127.0.0.1
peername        300
secret          xxx
cidname         xxx
cidnumber       +49-711-xxx
codec           alaw

ulaw und slinear habe ich auch schon probiert...

/var/spool/hylafax/etc/config

LogFacility:            daemon
CountryCode:            49
AreaCode:               711
LongDistancePrefix:     0
InternationalPrefix:    00
DialStringRules:        etc/dialrules.europe
ServerTracing:          1

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

# $Id: iaxmodem,v 1.1 2006/04/02 23:18:30 darren Exp $

#
# prototype config for the IAXmodem softmodem which uses
# the spandsp soft-DSP library
#

#
CountryCode:            49
AreaCode:               711
FAXNumber:              +49-711-xxx
LongDistancePrefix:     0
InternationalPrefix:    00
DialStringRules:        etc/dialrules.europe
ServerTracing:          0xFFF
SessionTracing:         0xFFF
RecvFileMode:           0644
LogFileMode:            0644
DeviceMode:             0644
RingsBeforeAnswer:      2
SpeakerVolume:          off
GettyArgs:              "-h %l dx_%s"
LocalIdentifier:        "xxx"
TagLineFont:            etc/lutRS18.pcf
TagLineFormat:          "From %%l|%c|Page %%P of %%T"
MaxRecvPages:           200
#

#
#
# Modem-related stuff: should reflect modem command interface
# and hardware connection/cabling (e.g. flow control).
#
ModemType:              Class1          # use this to supply a hint

#
# The modem is taken off-hook during initialization, and then
# placed back on-hook when done to prevent glare.
#
ModemResetCmds:         "ATH1\nAT+VCID=1"       # enables CallID display
ModemReadyCmds:         ATH0

Class1AdaptRecvCmd:     AT+FAR=1
Class1TMConnectDelay:   400             # counteract quick CONNECT response
Class1RMQueryCmd:       "!24,48,72,96"  # V.17 fast-train recv doesn't work well

CallIDPattern:          "NMBR="
CallIDPattern:          "NAME="
CallIDPattern:          "ANID="
CallIDPattern:          "NDID="
# Uncomment these if you really want them, but you probably don't.
#CallIDPattern:          "DATE="
#CallIDPattern:          "TIME="

/etc/asterisk/iax_additional.conf

[300]
deny=0.0.0.0/0.0.0.0
disallow=all
type=friend
setvar=REALCALLERIDNUM=300
secret=xxx
qualify=yes
port=4570
permit=0.0.0.0/0.0.0.0
transfer=no
mailbox=300@device
host=dynamic
dial=IAX2/300
context=from-internal
callerid=device <300>
allow=alaw
accountcode=
jitterbuffer=no
forcejitterbuffer=no
calltokenoptional=0.0.0.0/0.0.0.0
calltokenignore=127.0.0.1
requirecalltoken=auto

/etc/asterisk/misdn.conf

[general]
debug = 0
bridging=no
stop_tone_after_first_digit=yes
append_digits2exten=yes
dynamic_crypt=no
crypt_prefix=**
crypt_keys=test,muh

[default]
context=misdn
method=standard
language=de
musicclass=default
senddtmf=yes
far_alerting=no
allowed_bearers=all
nationalprefix=0
internationalprefix=00
rxgain=0
txgain=0
te_choose_channel=no
pmp_l1_check=no
reject_cause=16
need_more_infos=no
nttimeout=no
method=standard
dialplan=0
localdialplan=0
cpndialplan=0
early_bconnect=yes
incoming_early_audio=no
nodialtone=no
callgroup=1
pickupgroup=1
presentation=-1
screen=-1
echocancel=yes
jitterbuffer=4000
jitterbuffer_upper_threshold=0
hdlc=no
faxdetect=no

[isdn]
ports=1
context=from-pstn
msns=*

Hoffe, ich habe nichts vergessen, ist schon spaet aeh frueh. Falls doch, ich liefere alles notwendige gerne nach, ich bin ueber jeden Input dankbar, den mir jemand geben kann.

Herzlichen Dank fuer Eure Hilfe und viele Gruesse,
Roi

 

[Roi]

Ein paar zusätzliche Infos...

So, "guten Morgen",

nachdem es nun etwas normaler ist von der Uhrzeit, fallen mir auch noch ein paar zusätzliche Informationen ein, die vielleicht hilfreich sind.

Beim Faxtestversand (ich mache das immer mit "sendfax -vv -R -d 12345678 /path/to/dateiname") nimmt das Faxgeraet, an die die Nachricht gehen soll, immer ab. Habe das geprueft weil mich daneben gesetzt im Buero. Das betreffende Faxgeraet funktioniert auch. Nur scheint es da dann eben ein Abstimmungsproblem zu geben.

Deswegen verstehe ich auch nicht so ganz diese Fehlermeldung "No carrier detected", denn gewaehlt und kommuniziert wird ja auf jeden Fall.

Wie gesagt, ich liefere gerne noch weitere Configfiles oder Auszuege aus den Logs.

Hat mir denn jemand einen Tipp?

Vielen Dank und viele Grüße,
Roi

 

[hardy88]

Problem mit Pegel beim Empfang?

Hallo,
hier hänge ich mich gern mit an. Ich habe ein ähnliches Problem.

Wenn meine Fritzbox per chan-capi die ISDN-Leitung für das IAX-Modem bereit stellt, geht das Faxen mit Hylafax in beide Richtungen. Nun wollte ich aus anderen Gründen aber die Netzwerk-capi substituieren und die Fritzbox 7170 mit der Softwareversion 29.04.80 als Brücke zwischen ISDN und VoIP-Welt nutzen. Ich hoffte also, dass die Fritzbox als Provider für Asterisk 1.4 (auf Ubuntu) fungieren könnte und das Faxprotokoll hoffentlich die 10 m Netzwerkkabel per SIP überwinden kann. Das scheint aber ein Trugschluss zu sein. Ich bekomme beim Senden und Empfangen immer "No Carrier detect". Wenn ich mit Hylafax ein Telefon "anfaxe" ist dort laut und deutlich der Calling-Ton zu höhren.

Ich vermute, dass das IAX Modem einfach mehr Pegel von der Gegenstelle erwartet um deren Calling-Ton zu akzeptieren.

Hat jemand eine Idee? Kann man das IAX-Modem dazu bewegen mit weniger Eingangspegel zufrieden zu sein oder läst sich der Pegel, bevor er an das IAX-Modem übergeben wird "per Konfiguration" anheben?

Oder bin ich da etwa auf dem "Holzweg"?

Hat jemand bereits Hylafax per internem SIP ans eigene ISDN anbinden können?

Grüße
Hardy88