flexfax: Help with Session Tracing needed

[Gerd Schering <Schering@zrz.TU-Berlin.DE>]

Hi,

after installing another modem (noname) only the first fax was o.k.
All subsequent only consistet in on or more black lines.
I include one of the session logs.
Any help would be appreciated, because the log does not mean anything to me.

Gerd

-------------------------
May 21 15:05:53.03: [ 1226]: SESSION BEGIN 00000009 493021060
May 21 15:05:53.03: [ 1226]: SEND FAX: JOB 9 DEST 21060 COMMID 00000009
May 21 15:05:53.03: [ 1226]: DELAY 2600 ms
May 21 15:05:55.63: [ 1226]: <-- [15:ATE0V1Q0S0=0H0\r]
May 21 15:05:55.78: [ 1226]: --> [2:OK]
May 21 15:05:55.78: [ 1226]: <-- [12:ATS8=2S7=60\r]
May 21 15:05:55.92: [ 1226]: --> [2:OK]
May 21 15:05:55.92: [ 1226]: <-- [12:AT+FCLASS=2\r]
May 21 15:05:56.06: [ 1226]: --> [2:OK]
May 21 15:05:56.06: [ 1226]: <-- [10:AT+FTBC=0\r]
May 21 15:05:56.20: [ 1226]: --> [5:ERROR]
May 21 15:05:56.20: [ 1226]: MODEM Command error
May 21 15:05:56.20: [ 1226]: <-- [10:AT+FBOR=0\r]
May 21 15:05:56.34: [ 1226]: --> [2:OK]
May 21 15:05:56.34: [ 1226]: <-- [13:AT+FPHCTO=30\r]
May 21 15:05:56.48: [ 1226]: --> [5:ERROR]
May 21 15:05:56.48: [ 1226]: MODEM Command error
May 21 15:05:56.48: [ 1226]: <-- [24:AT+FDCC=1,5,2,2,2,0,0,0\r]
May 21 15:05:56.63: [ 1226]: --> [2:OK]
May 21 15:05:56.63: [ 1226]: <-- [7:ATL2M1\r]
May 21 15:05:56.77: [ 1226]: --> [2:OK]
May 21 15:05:56.78: [ 1226]: <-- [12:AT+FCLASS=2\r]
May 21 15:05:57.01: [ 1226]: --> [2:OK]
May 21 15:05:57.01: [ 1226]: <-- [10:AT+FTBC=0\r]
May 21 15:05:57.25: [ 1226]: --> [5:ERROR]
May 21 15:05:57.25: [ 1226]: MODEM Command error
May 21 15:05:57.25: [ 1226]: <-- [10:AT+FBOR=0\r]
May 21 15:05:57.49: [ 1226]: --> [2:OK]
May 21 15:05:57.49: [ 1226]: <-- [13:AT+FPHCTO=30\r]
May 21 15:05:57.73: [ 1226]: --> [5:ERROR]
May 21 15:05:57.73: [ 1226]: MODEM Command error
May 21 15:05:57.73: [ 1226]: <-- [24:AT+FDCC=1,5,2,2,2,0,0,0\r]
May 21 15:05:57.98: [ 1226]: --> [2:OK]
May 21 15:05:57.98: [ 1226]: <-- [23:AT+FLID="NothingSetup"\r]
May 21 15:05:58.23: [ 1226]: --> [2:OK]
May 21 15:05:58.24: [ 1226]: DIAL 21060
May 21 15:05:58.24: [ 1226]: <-- [10:ATDT21060\r]
May 21 15:06:12.89: [ 1226]: --> [3:CED]
May 21 15:06:12.89: [ 1226]: --> [5:+FCON]
May 21 15:06:12.89: [ 1226]: --> [19:+FNSF: 00 00 79 00 ]
May 21 15:06:12.90: [ 1226]: REMOTE NSF " 00 00 79 00"
May 21 15:06:12.90: [ 1226]: --> [27:+FCSI:      +49 30 31421060]
May 21 15:06:12.90: [ 1226]: REMOTE CSI "+49 30 31421060"
May 21 15:06:12.90: [ 1226]: --> [22:+FDIS: 1,5,0,2,2,2,0,0]
May 21 15:06:12.90: [ 1226]: --> [2:OK]
May 21 15:06:12.90: [ 1226]: REMOTE best rate 14400 bit/s
May 21 15:06:12.90: [ 1226]: REMOTE max page width 1728 pixels in 215 mm
May 21 15:06:12.90: [ 1226]: REMOTE max unlimited page length
May 21 15:06:12.90: [ 1226]: REMOTE best vres 7.7 line/mm
May 21 15:06:12.90: [ 1226]: REMOTE best format 2-D Uncompressed Mode      
May 21 15:06:12.90: [ 1226]: REMOTE supports T.30 Annex C, half duplex ECM
May 21 15:06:12.90: [ 1226]: REMOTE best 0 ms/scanline
May 21 15:06:12.90: [ 1226]: USE 14400 bit/s
May 21 15:06:12.90: [ 1226]: USE 0 ms/scanline
May 21 15:06:12.90: [ 1226]: SEND file "docq/doc9.cover;71"
May 21 15:06:12.90: [ 1226]: USE page width 1728 pixels in 215 mm
May 21 15:06:12.90: [ 1226]: USE unlimited page length
May 21 15:06:12.90: [ 1226]: USE 7.7 line/mm
May 21 15:06:12.90: [ 1226]: USE 2-D MR
May 21 15:06:12.90: [ 1226]: <-- [24:AT+FDIS=1,5,0,2,1,0,0,0\r]
May 21 15:06:13.11: [ 1226]: --> [2:OK]
May 21 15:06:13.11: [ 1226]: <-- [7:AT+FDT\r]
May 21 15:06:13.28: [ 1226]: --> [19:+FNSF: 00 00 79 00 ]
May 21 15:06:13.28: [ 1226]: --> [27:+FCSI:      +49 30 31421060]
May 21 15:06:13.28: [ 1226]: --> [22:+FDIS: 1,5,0,2,2,2,0,0]
May 21 15:06:20.69: [ 1226]: --> [22:+FDCS: 1,5,0,1,0,0,0,5]
May 21 15:06:22.39: [ 1226]: --> [7:CONNECT]
May 21 15:06:22.39: [ 1226]: SEND wait for XON
May 21 15:06:22.39: [ 1226]: --> [1:^Q]
May 21 15:06:22.39: [ 1226]: SEND begin page
May 21 15:06:22.40: [ 1226]: <-- data [1032]
May 21 15:06:22.40: [ 1226]: <-- data [1031]
May 21 15:06:22.40: [ 1226]: <-- data [1041]
May 21 15:06:22.40: [ 1226]: <-- data [1034]
May 21 15:06:24.39: [ 1226]: <-- data [1034]
May 21 15:06:24.39: [ 1226]: <-- data [1038]
May 21 15:06:24.39: [ 1226]: <-- data [1038]
May 21 15:06:24.39: [ 1226]: <-- data [1042]
May 21 15:06:26.39: [ 1226]: <-- data [1041]
May 21 15:06:26.39: [ 1226]: <-- data [1036]
May 21 15:06:26.39: [ 1226]: <-- data [1038]
May 21 15:06:26.39: [ 1226]: <-- data [1047]
May 21 15:06:28.39: [ 1226]: <-- data [1034]
May 21 15:06:28.39: [ 1226]: <-- data [1025]
May 21 15:06:28.39: [ 1226]: <-- data [727]
May 21 15:06:28.39: [ 1226]: SENT 15063 bytes of data
May 21 15:06:28.39: [ 1226]: <-- data [2]
May 21 15:06:28.39: [ 1226]: SEND end page
May 21 15:06:30.61: [ 1226]: --> [6:^S^Q^S^Q^S^Q]
May 21 15:06:30.61: [ 1226]: --> [2:OK]
May 21 15:06:30.61: [ 1226]: SEND send MPS (more pages, same document)
May 21 15:06:30.61: [ 1226]: <-- [9:AT+FET=0\r]
May 21 15:06:33.98: [ 1226]: --> [14:+FPTS: 2,2,0,0]
May 21 15:06:33.98: [ 1226]: --> [2:OK]
May 21 15:06:33.98: [ 1226]: SEND recv RTN (retrain negative)
May 21 15:06:33.98: [ 1226]: <-- [24:AT+FDIS=1,4,0,2,1,0,0,0\r]
May 21 15:06:34.11: [ 1226]: --> [5:ERROR]
May 21 15:06:34.11: [ 1226]: MODEM Command error
May 21 15:06:34.11: [ 1226]: <-- [6:AT+FK\r]
May 21 15:06:35.16: [ 1226]: --> [10:NO CARRIER]        
May 21 15:06:35.16: [ 1226]: MODEM No carrier
May 21 15:06:35.17: [ 1226]: SEND: Unable to set session parameters; Giving up after 3 attempts to send same page "docq/doc9.cover;71", dirnum 0
May 21 15:06:35.17: [ 1226]: <-- [5:ATH0\r]
May 21 15:06:35.41: [ 1226]: --> [2:OK]
May 21 15:06:35.42: [ 1226]: SESSION END