asterisk users - Aug 2004 - SpanDSP - Training failed (convergence failed) error

I am having a problem with SpanDSP.  What happens is when I send a fax
to SpanDSP the fax message seems to fail in the training phase.  I think
it's a timing error, however I have no idea about how to rectify the
problem. I have included a copy of the log below.  I am using a Digium
TDM-400P card with 2 x FXO ports and 2 x FXS ports.  The fax is
connected to one of the FXS ports (Zap3).  The outgoing call dials out
on Zap2 and is received by SpanDSP on Zap1. If anyone has any ideas I'd
be very appreciative of your assistance.

Many thanks,
Stephen.

 [1;30;40m    --  [0;37;40mStarting simple switch on 'Zap/3-1'

 [1;30;40m    --  [0;37;40mExecuting  [1;36;40mDial [0;37;40m("
[1;35;40mZap/3-1 [0;37;40m", " [1;35;40mZap/2/98824928
[0;37;40m") in
new stack

 [1;30;40m    --  [0;37;40mCalled 2/98824928

 [1;30;40m    --  [0;37;40mZap/2-1 answered Zap/3-1

 [1;30;40m    --  [0;37;40mAttempting native bridge of Zap/3-1 and
Zap/2-1

 [1;30;40m    --  [0;37;40mStarting simple switch on 'Zap/1-1'
Aug 13 09:17:37  [1;33;40mNOTICE [0;37;40m[131088]:  [1;37;40mchan_zap.c
[0;37;40m: [1;37;40m4998 [0;37;40m  [1;37;40mss_thread [0;37;40m: Got
event 2 (Ring/Answered)... Aug 13 09:17:40  [1;33;40mNOTICE
[0;37;40m[131088]:  [1;37;40mchan_zap.c [0;37;40m: [1;37;40m4998
[0;37;40m  [1;37;40mss_thread [0;37;40m: Got event 2 (Ring/Answered)...

 [1;30;40m    --  [0;37;40mExecuting  [1;36;40mRxFAX [0;37;40m("
[1;35;40mZap/1-1 [0;37;40m", "
[1;35;40m/var/spool/asterisk/incoming/test.tif [0;37;40m") in new stack
Changed from phase 0 to 1
Slow carrier up
Slow carrier down
Slow carrier up
Slow carrier down
Start receiving document
Changed from phase 1 to 4
Sending ident
>>> CSI: 40 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20
DIS:
Preferred octets: 256
Can receive fax
Supported data signalling rates: V.27ter and V.29 R8x7.7lines/mm and/or
200x200pels/25.4mm OK 2D coding OK Scan line length: 215mm Recording
length: A4 (297mm) Receiver's minimum scan line time: 0ms at 3.85 l/mm:
T7.7 = T3.85 R8x15.4lines/mm OK Minimum scan line time for higher
resolutions: T15.4 = T7.7
>>> DIS: 80 00 ce f0 80 80 01
HDLC underflow in state 9
Changed from phase 4 to 3
Slow carrier up
Slow carrier down
Slow carrier up
<<< TSI: 43 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 78 61 46
TSI without final frame tag
Remote fax gave TSI as: "Fax                 "
<<< DCS: 83 00 c6 70
DCS with final frame tag
In state 9
DCS:
Can receive fax
Selected data signalling rate: V.29, 9600bps
R8x7.7lines/mm and/or 200x200pels/25.4mm OK
2D coding OK
Scan line length: 215mm
Recording length: A4 (297mm)
Minimum scan line time: 0ms
Get at 9600
Changed from phase 3 to 5
Slow carrier down
Fast carrier up
Coarse carrier frequency 1750.11 (4)
Training error 671.593615
Training failed (convergence failed)
Fast carrier training failed
Fast carrier down
Fast carrier up
Coarse carrier frequency 1697.08 (4)
Training error 727.219883
Training failed (convergence failed)
Fast carrier training failed
Fast carrier down
Fast carrier up
Coarse carrier frequency 1740.73 (4)
Training error 739.282219
Training failed (convergence failed)
Fast carrier training failed
Fast carrier down
Fast carrier up
Fast carrier down

 [1;30;40m    --  [0;37;40mHungup 'Zap/2-1'

 [1;30;40m  ==  [0;37;40mSpawn extension (fax-out, 98824928, 1) exited
non-zero on 'Zap/3-1'

 [1;30;40m    --  [0;37;40mExecuting  [1;36;40mDial [0;37;40m("
[1;35;40mZap/3-1 [0;37;40m", " [1;35;40mZap/2/h [0;37;40m") in
new stack
Aug 13 09:18:11  [1;33;40mNOTICE [0;37;40m[122895]:  [1;37;40mapp_dial.c
[0;37;40m: [1;37;40m689 [0;37;40m  [1;37;40mdial_exec [0;37;40m: Unable
to create channel of type 'Zap'

 [1;30;40m  ==  [0;37;40mEveryone is busy/congested at this time

 [1;30;40m    --  [0;37;40mExecuting  [1;36;40mHangup [0;37;40m("
[1;35;40mZap/3-1 [0;37;40m", " [1;35;40m [0;37;40m") in new stack

 [1;30;40m  ==  [0;37;40mSpawn extension (fax-out, h, 102) exited
non-zero on 'Zap/3-1'

 [1;30;40m    --  [0;37;40mHungup 'Zap/3-1'

Just a tip, not related to your problem:

when you call asterisk with -n, e.g. asterisk -vvvvvnc, then you won't get 
color codes and your post wouldn't look like
> [1;30;40m    --  [0;37;40mStarting simple switch on 'Zap/3-1'
but instead be much cleaner:
>    --  Starting simple switch on 'Zap/3-1'

Especially something like this is very hard to read:
> [1;30;40m    --  [0;37;40mStarting simple switch on 'Zap/1-1'
> Aug 13 09:17:37  [1;33;40mNOTICE [0;37;40m[131088]:  [1;37;40mchan_zap.c
> [0;37;40m: [1;37;40m4998 [0;37;40m  [1;37;40mss_thread [0;37;40m: Got
> event 2 (Ring/Answered)... Aug 13 09:17:40  [1;33;40mNOTICE
> [0;37;40m[131088]:  [1;37;40mchan_zap.c [0;37;40m: [1;37;40m4998
> [0;37;40m  [1;37;40mss_thread [0;37;40m: Got event 2 (Ring/Answered)...