Mantis Bugtracker

Viewing Issue Simple Details Jump to Notes ] View Advanced ] Issue History ] Print ]
ID Category Severity Reproducibility Date Submitted Last Update
0000380 [Yate - Yet Another Telephony Engine] module major always 2015-02-13 05:51 2015-02-25 11:30
Reporter schorpp View Status public  
Assigned To
Priority normal Resolution open  
Status new   Product Version SVN
Summary 0000380: FAX module fails with several CW proven (T.38) FAX capable provider PSTN-gateways (e.g. Huawei SoftX3000) "488" Q.850;cause=58
Description 1. FAX module fails with several proven T.38 capable provider PSTN-gateways (e.g. Huawei SoftX3000)
called from modified MTA called shellscript email2fax 1.2 with telnet pipe:

{ echo "call fax/transmit//$DATADIR/$ATTNAME.tif $FAXNUM"; sleep 5; kill -9 `pidof -s telnet`; } | telnet localhost 5038

${id}^fax/=if ^0\(.*\)$=line/\0;line=qsc_de;caller=0...
${id}^fax/=if ^3\(.*\)$=line/\1;line=fritz_box;caller=...
${id}^fax/=if ^5\(.*\)$=line/\1;line=dus_fax;caller=...
${id}^fax/=if ^8\(.*\)$=line/\1;line=netvoip_ch;caller=...

But lines 0,5 are OK with latest CallWeaver.

2. Fails internal loopback test, too, calling with call cmd nnnnnnnn from rmanager from docs:

^nnnnnnnn$=fax/receive//var/spool/yate/fax/in/rx-${caller}-$(message,time).tiff

Host internal calls CW <-> YATE are OK, too.

Looks like early seq or T.38 switchover fails by mis"guess"ing by the module.
TIFF G4 input. Or is "TIFF/F" required?

y
tom
Additional Information Logs:
Trying dus.net "DUS_FAX-Gateway" (Special dus.net T.38 FAX subaccount required), <- SIP 488:

------
2015-02-13_03:54:57.747290 <sip:INFO> 'udp:0.0.0.0:5060' sending 'INVITE sip:07211335009@proxy.dus.net' 0x7ffd1402e190 to 83.125.8.71:5060 [0x26ef450]
------
INVITE sip:07211335009@proxy.dus.net SIP/2.0
Max-Forwards: 20
Via: SIP/2.0/UDP **********:61270;rport;branch=z9hG4bK1207848259
From: "000**********" <sip:000**********@**********:61270>;tag=2076313604
To: <sip:07211335009@proxy.dus.net>
Call-ID: 1460418580@**********:61270
User-Agent: YATE/5.4.1
Contact: <sip:000**********@**********:61270>
Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO
CSeq: 9 INVITE
Proxy-Authorization: Digest username="000**********", realm="dus.net", nonce="*****", uri="sip:07211335009@proxy.dus.net", response="***", algorithm=MD5
Content-Type: application/sdp
Content-Length: 318

v=0
o=yate 1423796097 1423796097 IN IP4 **********
s=SIP Call
c=IN IP4 **********
t=0 0
m=audio 17938 RTP/AVP 8 0 101
a=rtpmap:8 PCMA/8000
a=rtpmap:0 PCMU/8000
a=rtpmap:101 telephone-event/8000
a=crypto:1 AES_CM_128_HMAC_SHA1_32 inline:YCrgU2Wn/9z7zO3woegrE9iLOBse7JcU80LFHtot
a=encryption:optional
------
2015-02-13_03:54:57.791293 <sip:INFO> 'udp:0.0.0.0:5060' received 373 bytes SIP message from 83.125.8.71:5060 [0x26ef450]
------
SIP/2.0 100 Call will be processed now...
Via: SIP/2.0/UDP **********:61270;rport=61271;branch=z9hG4bK1207848259;received=**********
From: "000**********" <sip:000**********@**********:61270>;tag=2076313604
To: <sip:07211335009@proxy.dus.net>
Call-ID: 1460418580@**********:61270
CSeq: 9 INVITE
Server: DUS.NET TERM-SIP-ENGINE 2.1
Content-Length: 0

------
2015-02-13_03:54:57.806747 <sip:INFO> 'udp:0.0.0.0:5060' received 382 bytes SIP message from 83.125.8.71:5060 [0x26ef450]
------
SIP/2.0 100 trying -- your call is important to us
Via: SIP/2.0/UDP **********:61270;rport=61271;branch=z9hG4bK1207848259;received=**********
From: "000**********" <sip:000**********@**********:61270>;tag=2076313604
To: <sip:07211335009@proxy.dus.net>
Call-ID: 1460418580@**********:61270
CSeq: 9 INVITE
Server: DUS.NET TERM-SIP-ENGINE 2.1
Content-Length: 0

------
2015-02-13_03:54:57.835597 <sip:INFO> 'udp:0.0.0.0:5060' received 494 bytes SIP message from 83.125.8.71:5060 [0x26ef450]
------
SIP/2.0 488 Not acceptable here
Via: SIP/2.0/UDP **********:61270;received=**********;rport=61271;branch=z9hG4bK1207848259
From: "000**********" <sip:000**********@**********:61270>;tag=2076313604
To: <sip:07211335009@proxy.dus.net>;tag=as3f1c0ba2
Call-ID: 1460418580@**********:61270
CSeq: 9 INVITE
Server: DUS_FAX-Gateway
Allow: INVITE, ACK, CANCEL, OPTIONS, BYE, REFER, SUBSCRIBE, NOTIFY, INFO, PUBLISH
Supported: replaces
Reason: Q.850;cause=58
Content-Length: 0
...
------
2015-02-13_03:54:57.845655 <ALL> FaxChan::~FaxChan() [0x27d6f10]

Trying qsc.de Huawei:

-Attached-
Tags No tags attached.
Attached Files log file icon yate-t38bug-qsc.de-huawei-fail.01.log [^] (40,225 bytes) 2015-02-13 05:51
? file icon email2fax.php [^] (3,223 bytes) 2015-02-14 11:11
log file icon yate-t38bug-loopback-test-callee.01.log [^] (81,437 bytes) 2015-02-25 11:30

- Relationships

-  Notes
(0000572)
schorpp (reporter)
2015-02-14 11:09
edited on: 2015-02-25 15:09

Test with the attached external script fails, too, no outcome difference.

(0000581)
schorpp (reporter)
2015-02-18 12:32
edited on: 2015-02-20 07:57

PART CLOSED for issue with provider dus.net, enforces *non- modem signalling capable* compressing G.726 codec in setup for T.38 "digital" fax calls, nonsense, avoid.

(0000583)
schorpp (reporter)
2015-02-22 12:23

RESOLVED: FIXED

Resolution see 0000390, Note 0000004:
http://yate.null.ro/mantis/view.php?id=390&nbn=4#bugnotes [^]
(0000584)
schorpp (reporter)
2015-02-22 12:26

2015-02-22_11:18:05.739079 <fax/1:INFO> Fax startup succeeded in analog mode [0x1571320]
2015-02-22_11:18:12.935389 <fax/1:INFO> Phase B code 0x80: DIS [0x7f4fa412cf90]
2015-02-22_11:18:28.213043 <fax/1:INFO> Phase D code 0x8C: ??? [0x7f4fa412cf90]
2015-02-22_11:18:28.213232 <fax/1:ALL> bit rate 14400
2015-02-22_11:18:28.213276 <fax/1:ALL> error correction 1
2015-02-22_11:18:28.213297 <fax/1:ALL> pages transferred 1
2015-02-22_11:18:28.213322 <fax/1:ALL> image size 1728 x 2292
2015-02-22_11:18:28.213343 <fax/1:ALL> image resolution 8031 x 7700
2015-02-22_11:18:28.213365 <fax/1:ALL> bad rows 0
2015-02-22_11:18:28.213384 <fax/1:ALL> longest bad row run 0
2015-02-22_11:18:28.213416 <fax/1:ALL> compression type 3
2015-02-22_11:18:28.213435 <fax/1:ALL> image size 10255
2015-02-22_11:18:28.213468 <fax/1:ALL> local ident '(null)'
2015-02-22_11:18:28.213488 <fax/1:ALL> remote ident '+49721133******'
2015-02-22_11:18:30.419369 <fax/1:INFO> Phase E code 0x0: OK [0x7f4fa412cf90]
2015-02-22_11:18:30.419649 <fax/1:ALL> bit rate 14400
2015-02-22_11:18:30.419762 <fax/1:ALL> error correction 1
2015-02-22_11:18:30.419786 <fax/1:ALL> pages transferred 1
2015-02-22_11:18:30.419806 <fax/1:ALL> image size 1728 x 2292
2015-02-22_11:18:30.419825 <fax/1:ALL> image resolution 8031 x 7700
2015-02-22_11:18:30.419846 <fax/1:ALL> bad rows 0
2015-02-22_11:18:30.419865 <fax/1:ALL> longest bad row run 0
2015-02-22_11:18:30.419896 <fax/1:ALL> compression type 3
2015-02-22_11:18:30.419915 <fax/1:ALL> image size 10255
2015-02-22_11:18:30.419961 <fax/1:ALL> local ident '(null)'
2015-02-22_11:18:30.419983 <fax/1:ALL> remote ident '+49721133******'
2015-02-22_11:18:30.439912 <ALL> FaxChan::~FaxChan() [0x1571320]
2015-02-22_11:18:30.439956 <fax/1:ALL> FaxTerminal::~FaxTerminal() [0x7f4fa412cf90]
(0000587)
schorpp (reporter)
2015-02-22 15:11
edited on: 2015-02-25 15:11

REOPEN: UNREPRODUCIBLE RESOLUTION or broken by resolution for 0000390
...*analog* fax above, still no T.38 handshake with provider qsc.de, still SIP/488 from dus.net T.38 GW,
nearly always reproducible faxchan autodetection failure:

2015-02-22_13:51:49.937904 <fax/4:INFO> Fax startup succeeded in autodetect mode [0x154df80]
2015-02-22_13:51:49.938488 <sip:INFO> 'udp:0.0.0.0:5060' sending code 200 0x7f2d04117830 to 213.148.136.218:5060 [0x7f2d04017220]
------
SIP/2.0 200 OK
Via: SIP/2.0/UDP 213.148.136.218:5060;branch=z9hG4bKle0tgp004gg1sevqo3v1.1;received=213.148.136.218
From: <sip:0721133******@qsc.de>;tag=SD6o9k299-521he7rl-CC-42
To: "0721******" <sip:0721*****@qsc.de:61552>;tag=359115781
Call-ID: 1742794778@109.192.118.31:61552
CSeq: 1 INVITE
Server: YATE/5.4.1
Contact: <sip:0721*****@109.192.118.31:61552>
Allow: ACK, INVITE, BYE, CANCEL, REGISTER, REFER, OPTIONS, INFO
Content-Type: application/sdp
Content-Length: 354

v=0
o=yate 1424609491 1424609492 IN IP4 109.192.118.31
s=SIP Call
c=IN IP4 109.192.118.31
t=0 0
m=image 31736 udptl t38
a=T38FaxVersion:0
a=T38MaxBitRate:14400
a=T38FaxRateManagement:transferredTCF
a=T38FaxUdpEC:t38UDPRedundancy
a=T38FaxMaxDatagram:250
m=audio 24380 RTP/AVP 103 101
a=rtpmap:103 PCMA/8000
a=rtpmap:101 telephone-event/8000
------

<--- Huawei: BYE.

2015-02-22_13:51:49.952378 <fax/4:ALL> FaxTerminal::~FaxTerminal() [0x7f2d04149e90]
2015-02-22_13:51:50.019962 <WARN> Receiving RTP instead of UDPTL [0x7f2d0411b110]

(0000588)
schorpp (reporter)
2015-02-25 11:30
edited on: 2015-02-25 15:07

Loopback test calling internally from rmanager telnet

^0721********$=fax/receive//var/spool/yate/fax/in/rx-${caller}-$(message,time).tiff;faxcaller=false

succeeds, but still no T.38 switchover, log -attached-.

---

^1$=fax/transmit/path/to/tx-file.tiff from docs does not work, goes in callee state if called, not yet figured out how to route call to line and apply faxchan target, faxcaller parameters.


- Issue History
Date Modified Username Field Change
2015-02-13 05:51 schorpp New Issue
2015-02-13 05:51 schorpp File Added: yate-t38bug-qsc.de-huawei-fail.01.log
2015-02-14 11:09 schorpp Note Added: 0000572
2015-02-14 11:11 schorpp File Added: email2fax.php
2015-02-18 12:32 schorpp Note Added: 0000581
2015-02-20 07:57 schorpp Note Edited: 0000581
2015-02-22 12:23 schorpp Note Added: 0000583
2015-02-22 12:26 schorpp Note Added: 0000584
2015-02-22 15:11 schorpp Note Added: 0000587
2015-02-25 11:30 schorpp Note Added: 0000588
2015-02-25 11:30 schorpp File Added: yate-t38bug-loopback-test-callee.01.log
2015-02-25 15:07 schorpp Note Edited: 0000588
2015-02-25 15:09 schorpp Note Edited: 0000572
2015-02-25 15:11 schorpp Note Edited: 0000587


Copyright © 2000 - 2008 Mantis Group
Powered by Mantis Bugtracker