[hylafax-users] Problem going from 4.1.5->4.1.7 for topic?

[Giulio Orsero <giulioo@pobox.com>]

In the past days I upgraded various systems (rockwell, lucent) to
4.1.6/4.1.7 with no problems.

Today I upgraded a topic chipset system (send-only system) [system A], and
did some tests sending to HylaFAX-4.1.7(rockwell) [system B].

In the past A->B was ok.
I upgraded A to 4.1.7 and did 2 tries A->B which both failed in the same
way.
I donwgraded A to 4.1.5 and did 1 test A-B which succeeded.
Couldn't do more tests since I had to make it work (but I 'l probably will
be able to test again).

Attached inline you find:
- A (4.1.7) log sending to  B (4.1.7) -> error
- B (4.1.7) log receiving from A (4.1.7) -> error
(For the 2nd try the log was identical)

- A (4.1.5) log sending to  B (4.1.7) -> ok
- B (4.1.7) log receiving from A (4.1.5) -> ok

"Spurious" XON/XOFF are normal with topic.
The config.<devid> file was not changed during upgrade.

Do you think it was just a coincidence or there may be something more?

Thanks

============ A is with 4.1.7

===== A sends to B
Jul 31 16:10:16.73: [15262]: SESSION BEGIN 00000070 390123456789
Jul 31 16:10:16.73: [15262]: HylaFAX (tm) Version 4.1.7
Jul 31 16:10:16.73: [15262]: SEND FAX: JOB 53 DEST 0123456789 COMMID 00000070 DEVICE '/dev/ttyS1'
Jul 31 16:10:16.73: [15262]: DELAY 75 ms
Jul 31 16:10:16.81: [15262]: DELAY 2600 ms
Jul 31 16:10:20.42: [15262]: DELAY 10 ms
Jul 31 16:10:20.43: [15262]: <-- [4:ATZ\r]
Jul 31 16:10:20.60: [15262]: --> [2:OK]
Jul 31 16:10:20.60: [15262]: DELAY 3000 ms
Jul 31 16:10:23.60: [15262]: <-- [8:ATX3%D0\r]
Jul 31 16:10:23.71: [15262]: --> [7:ATX3%D0]
Jul 31 16:10:23.71: [15262]: --> [2:OK]
Jul 31 16:10:23.71: [15262]: <-- [5:ATE0\r]
Jul 31 16:10:23.81: [15262]: --> [4:ATE0]
Jul 31 16:10:23.81: [15262]: --> [2:OK]
Jul 31 16:10:23.81: [15262]: <-- [5:ATV1\r]
Jul 31 16:10:23.91: [15262]: --> [2:OK]
Jul 31 16:10:23.91: [15262]: <-- [5:ATQ0\r]
Jul 31 16:10:24.01: [15262]: --> [2:OK]
Jul 31 16:10:24.01: [15262]: <-- [7:ATS0=0\r]
Jul 31 16:10:24.11: [15262]: --> [2:OK]
Jul 31 16:10:24.11: [15262]: <-- [7:ATS8=2\r]
Jul 31 16:10:24.21: [15262]: --> [2:OK]
Jul 31 16:10:24.21: [15262]: <-- [8:ATS7=60\r]
Jul 31 16:10:24.31: [15262]: --> [2:OK]
Jul 31 16:10:24.31: [15262]: <-- [6:AT&K4\r]
Jul 31 16:10:24.41: [15262]: --> [2:OK]
Jul 31 16:10:24.41: [15262]: <-- [6:AT&D2\r]
Jul 31 16:10:24.51: [15262]: --> [2:OK]
Jul 31 16:10:24.51: [15262]: <-- [6:AT&C1\r]
Jul 31 16:10:24.61: [15262]: --> [2:OK]
Jul 31 16:10:24.61: [15262]: <-- [12:AT+FCLASS=1\r]
Jul 31 16:10:24.72: [15262]: --> [2:OK]
Jul 31 16:10:24.72: [15262]: <-- [5:ATM0\r]
Jul 31 16:10:24.82: [15262]: --> [2:OK]
Jul 31 16:10:24.82: [15262]: sched policy=1, priority=1
Jul 31 16:10:24.82: [15262]: <-- [12:AT+FCLASS=1\r]
Jul 31 16:10:25.04: [15262]: --> [2:OK]
Jul 31 16:10:25.04: [15262]: DIAL 0,0123456789
Jul 31 16:10:25.04: [15262]: <-- [16:ATDT0,0123456789\r]
Jul 31 16:10:46.20: [15262]: --> [7:CONNECT]
Jul 31 16:10:47.65: [15262]: --> [2:OK]
Jul 31 16:10:47.65: [15262]: REMOTE CSI "+39 012 3456789"
Jul 31 16:10:47.65: [15262]: <-- [9:AT+FRH=3\r]
Jul 31 16:10:47.67: [15262]: --> [7:CONNECT]
Jul 31 16:10:48.21: [15262]: --> [2:OK]
Jul 31 16:10:48.21: [15262]: REMOTE best rate 14400 bit/s
Jul 31 16:10:48.21: [15262]: REMOTE max page width 2432 pixels in 303 mm
Jul 31 16:10:48.21: [15262]: REMOTE max unlimited page length
Jul 31 16:10:48.21: [15262]: REMOTE best vres 7.7 line/mm
Jul 31 16:10:48.21: [15262]: REMOTE best format 2-D MR
Jul 31 16:10:48.21: [15262]: REMOTE best 0 ms/scanline
Jul 31 16:10:48.21: [15262]: USE 14400 bit/s
Jul 31 16:10:48.21: [15262]: USE 0 ms/scanline
Jul 31 16:10:48.21: [15262]: SEND file "docq/doc53.ps;01"
Jul 31 16:10:48.21: [15262]: USE page width 1728 pixels in 215 mm
Jul 31 16:10:48.21: [15262]: USE unlimited page length
Jul 31 16:10:48.21: [15262]: USE 7.7 line/mm
Jul 31 16:10:48.21: [15262]: USE 1-D MR
Jul 31 16:10:48.21: [15262]: SEND training at v.17 14400 bit/s
Jul 31 16:10:48.21: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:48.26: [15262]: --> [7:CONNECT]
Jul 31 16:10:48.26: [15262]: <-- data [23]
Jul 31 16:10:48.26: [15262]: <-- data [2]
Jul 31 16:10:48.28: [15262]: --> [1:]
Jul 31 16:10:48.28: [15262]: Error sending T.30 prologue frames
Jul 31 16:10:48.28: [15262]: SEND training at v.17 12000 bit/s
Jul 31 16:10:48.28: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:48.29: [15262]: --> [7:CONNECT]
Jul 31 16:10:48.29: [15262]: <-- data [23]
Jul 31 16:10:48.29: [15262]: <-- data [2]
Jul 31 16:10:48.32: [15262]: --> [7:CONNECT]
Jul 31 16:10:48.32: [15262]: <-- data [6]
Jul 31 16:10:48.32: [15262]: <-- data [2]
Jul 31 16:10:50.87: [15262]: --> [0:]
Jul 31 16:10:50.87: [15262]: MODEM <Empty line>
Jul 31 16:10:50.87: [15262]: Error sending T.30 prologue frames
Jul 31 16:10:50.87: [15262]: SEND training at v.17 9600 bit/s
Jul 31 16:10:50.87: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:51.50: [15262]: --> [2:OK]
Jul 31 16:10:51.50: [15262]: Error sending T.30 prologue frames
Jul 31 16:10:51.50: [15262]: SEND training at v.17 7200 bit/s
Jul 31 16:10:51.50: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:51.55: [15262]: --> [7:CONNECT]
Jul 31 16:10:51.55: [15262]: <-- data [23]
Jul 31 16:10:51.55: [15262]: <-- data [2]
Jul 31 16:10:51.57: [15262]: --> [1:]
Jul 31 16:10:51.57: [15262]: Error sending T.30 prologue frames
Jul 31 16:10:51.57: [15262]: SEND training at v.27ter 4800 bit/s
Jul 31 16:10:51.57: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:51.58: [15262]: --> [7:CONNECT]
Jul 31 16:10:51.58: [15262]: <-- data [23]
Jul 31 16:10:51.58: [15262]: <-- data [2]
Jul 31 16:10:51.61: [15262]: --> [7:CONNECT]
Jul 31 16:10:51.61: [15262]: <-- data [6]
Jul 31 16:10:51.61: [15262]: <-- data [2]
Jul 31 16:10:54.16: [15262]: --> [0:]
Jul 31 16:10:54.16: [15262]: MODEM <Empty line>
Jul 31 16:10:54.16: [15262]: Error sending T.30 prologue frames
Jul 31 16:10:54.16: [15262]: SEND training at v.27ter fallback mode 2400 bit/s
Jul 31 16:10:54.16: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:54.79: [15262]: --> [2:OK]
Jul 31 16:10:54.79: [15262]: Error sending T.30 prologue frames
Jul 31 16:10:54.79: [15262]: TRAINING failed
Jul 31 16:10:54.79: [15262]: <-- [9:AT+FTH=3\r]
Jul 31 16:10:54.84: [15262]: --> [7:CONNECT]
Jul 31 16:10:54.84: [15262]: <-- data [3]
Jul 31 16:10:54.84: [15262]: <-- data [2]
Jul 31 16:10:56.16: [15262]: --> [1:]
Jul 31 16:10:56.16: [15262]: <-- [5:ATH0\r]
Jul 31 16:10:56.16: [15262]: --> [2:OK]
Jul 31 16:10:56.17: [15262]: sched policy=0, priority=0
Jul 31 16:10:56.17: [15262]: SESSION END

===== B receives from A
Jul 31 16:12:07.77: [29632]: SESSION BEGIN 00018334 390123456789
Jul 31 16:12:07.77: [29632]: HylaFAX (tm) Version 4.1.7
Jul 31 16:12:07.77: [29632]: <-- [4:ATA\r]
Jul 31 16:12:13.78: [29632]: --> [7:CONNECT]
Jul 31 16:12:13.78: [29632]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS2'
Jul 31 16:12:13.78: [29632]: sched policy=1, priority=1
Jul 31 16:12:13.78: [29632]: RECV FAX: begin
Jul 31 16:12:13.84: [29632]: <-- data [23]
Jul 31 16:12:13.84: [29632]: <-- data [2]
Jul 31 16:12:15.47: [29632]: --> [7:CONNECT]
Jul 31 16:12:15.47: [29632]: <-- data [10]
Jul 31 16:12:15.47: [29632]: <-- data [2]
Jul 31 16:12:16.02: [29632]: --> [2:OK]
Jul 31 16:12:16.02: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:12:16.42: [29632]: --> [7:CONNECT]
Jul 31 16:12:17.93: [29632]: --> [2:OK]
Jul 31 16:12:17.93: [29632]: REMOTE TSI "+39 111 2222222"
Jul 31 16:12:17.93: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:12:17.95: [29632]: --> [7:CONNECT]
Jul 31 16:12:18.97: [29632]: --> [2:OK]
Jul 31 16:12:18.97: [29632]: REMOTE TSI "+39 111 2222222"
Jul 31 16:12:18.97: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:12:18.99: [29632]: --> [7:CONNECT]
Jul 31 16:12:19.30: [29632]: --> [2:OK]
Jul 31 16:12:19.30: [29632]: REMOTE wants 12000 bit/s
Jul 31 16:12:19.30: [29632]: REMOTE wants page width 1728 pixels in 215 mm
Jul 31 16:12:19.30: [29632]: REMOTE wants unlimited page length
Jul 31 16:12:19.30: [29632]: REMOTE wants 7.7 line/mm
Jul 31 16:12:19.30: [29632]: REMOTE wants 1-D MR
Jul 31 16:12:19.30: [29632]: RECV training at v.17 12000 bit/s
Jul 31 16:12:19.30: [29632]: <-- [11:AT+FRM=121\r]
Jul 31 16:12:19.74: [29632]: --> [8:+FCERROR]
Jul 31 16:12:19.74: [29632]: <-- [11:AT+FRM=121\r]
Jul 31 16:12:19.76: [29632]: --> [7:CONNECT]
Jul 31 16:12:22.66: [29632]: <-- data [1]
Jul 31 16:12:22.67: [29632]: --> [10:NO CARRIER]
Jul 31 16:12:22.67: [29632]: MODEM No carrier
Jul 31 16:12:22.67: [29632]: RECV: TCF 4441 bytes, 97% non-zero, 2 zero-run
Jul 31 16:12:22.67: [29632]: RECV: reject TCF (too many non-zero, max 10%)
Jul 31 16:12:22.67: [29632]: RECV: reject TCF (zero run too short, min 1500)
Jul 31 16:12:52.68: [29632]: MODEM <Empty line>
Jul 31 16:12:52.68: [29632]: DELAY 75 ms
Jul 31 16:12:52.76: [29632]: <-- [9:AT+FTH=3\r]
Jul 31 16:12:52.81: [29632]: --> [7:CONNECT]
Jul 31 16:12:52.81: [29632]: <-- data [3]
Jul 31 16:12:52.81: [29632]: <-- data [2]
Jul 31 16:12:54.13: [29632]: --> [2:OK]
Jul 31 16:12:54.13: [29632]: TRAINING failed
Jul 31 16:12:54.13: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:13:01.13: [29632]: --> [0:]
Jul 31 16:13:01.13: [29632]: MODEM <Empty line>
Jul 31 16:13:01.13: [29632]: <-- data [1]
Jul 31 16:13:01.19: [29632]: --> [2:OK]
Jul 31 16:13:01.19: [29632]: RECV FAX: Failure to train modems
Jul 31 16:13:01.19: [29632]: RECV FAX: end
Jul 31 16:13:01.19: [29632]: SESSION END



============ A is with 4.1.5

===== A sends to B
Jul 31 16:13:27.72: [15412]: SESSION BEGIN 00000072 390123456789
Jul 31 16:13:27.72: [15412]: HylaFAX (tm) Version 4.1.5
Jul 31 16:13:27.72: [15412]: SEND FAX: JOB 53 DEST 0123456789 COMMID 00000072 DEVICE '/dev/ttyS1'
Jul 31 16:13:27.72: [15412]: DELAY 75 ms
Jul 31 16:13:27.80: [15412]: DELAY 2600 ms
Jul 31 16:13:30.40: [15412]: DELAY 10 ms
Jul 31 16:13:30.41: [15412]: <-- [4:ATZ\r]
Jul 31 16:13:30.58: [15412]: --> [2:OK]
Jul 31 16:13:30.58: [15412]: DELAY 3000 ms
Jul 31 16:13:33.58: [15412]: <-- [8:ATX3%D0\r]
Jul 31 16:13:33.69: [15412]: --> [7:ATX3%D0]
Jul 31 16:13:33.69: [15412]: --> [2:OK]
Jul 31 16:13:33.69: [15412]: <-- [5:ATE0\r]
Jul 31 16:13:33.80: [15412]: --> [4:ATE0]
Jul 31 16:13:33.80: [15412]: --> [2:OK]
Jul 31 16:13:33.80: [15412]: <-- [5:ATV1\r]
Jul 31 16:13:33.91: [15412]: --> [2:OK]
Jul 31 16:13:33.91: [15412]: <-- [5:ATQ0\r]
Jul 31 16:13:34.02: [15412]: --> [2:OK]
Jul 31 16:13:34.02: [15412]: <-- [7:ATS0=0\r]
Jul 31 16:13:34.13: [15412]: --> [2:OK]
Jul 31 16:13:34.13: [15412]: <-- [7:ATS8=2\r]
Jul 31 16:13:34.24: [15412]: --> [2:OK]
Jul 31 16:13:34.24: [15412]: <-- [8:ATS7=60\r]
Jul 31 16:13:34.35: [15412]: --> [2:OK]
Jul 31 16:13:34.35: [15412]: <-- [6:AT&K4\r]
Jul 31 16:13:34.46: [15412]: --> [2:OK]
Jul 31 16:13:34.46: [15412]: <-- [6:AT&D2\r]
Jul 31 16:13:34.57: [15412]: --> [2:OK]
Jul 31 16:13:34.57: [15412]: <-- [6:AT&C1\r]
Jul 31 16:13:34.68: [15412]: --> [2:OK]
Jul 31 16:13:34.68: [15412]: <-- [12:AT+FCLASS=1\r]
Jul 31 16:13:34.80: [15412]: --> [2:OK]
Jul 31 16:13:34.80: [15412]: <-- [5:ATM0\r]
Jul 31 16:13:34.91: [15412]: --> [2:OK]
Jul 31 16:13:34.91: [15412]: sched policy=1, priority=1
Jul 31 16:13:34.91: [15412]: <-- [12:AT+FCLASS=1\r]
Jul 31 16:13:35.12: [15412]: --> [2:OK]
Jul 31 16:13:35.12: [15412]: DIAL 0,0123456789
Jul 31 16:13:35.12: [15412]: <-- [16:ATDT0,0123456789\r]
Jul 31 16:13:56.24: [15412]: --> [7:CONNECT]
Jul 31 16:13:57.72: [15412]: --> [2:OK]
Jul 31 16:13:57.72: [15412]: REMOTE CSI "+39 012 3456789"
Jul 31 16:13:57.72: [15412]: <-- [9:AT+FRH=3\r]
Jul 31 16:13:57.74: [15412]: --> [7:CONNECT]
Jul 31 16:13:58.25: [15412]: --> [2:OK]
Jul 31 16:13:58.25: [15412]: REMOTE best rate 14400 bit/s
Jul 31 16:13:58.25: [15412]: REMOTE max page width 2432 pixels in 303 mm
Jul 31 16:13:58.25: [15412]: REMOTE max unlimited page length 
Jul 31 16:13:58.25: [15412]: REMOTE best vres 7.7 line/mm
Jul 31 16:13:58.25: [15412]: REMOTE best format 2-D MR
Jul 31 16:13:58.25: [15412]: REMOTE best 0 ms/scanline
Jul 31 16:13:58.25: [15412]: USE 14400 bit/s
Jul 31 16:13:58.25: [15412]: USE 0 ms/scanline
Jul 31 16:13:58.25: [15412]: SEND file "docq/doc53.ps;01"
Jul 31 16:13:58.25: [15412]: USE page width 1728 pixels in 215 mm
Jul 31 16:13:58.25: [15412]: USE unlimited page length 
Jul 31 16:13:58.25: [15412]: USE 7.7 line/mm
Jul 31 16:13:58.25: [15412]: USE 1-D MR
Jul 31 16:13:58.25: [15412]: SEND training at v.17 14400 bit/s
Jul 31 16:13:58.25: [15412]: <-- [9:AT+FTH=3\r]
Jul 31 16:13:58.30: [15412]: --> [7:CONNECT]
Jul 31 16:13:58.30: [15412]: <-- data [23]
Jul 31 16:13:58.30: [15412]: <-- data [2]
Jul 31 16:13:58.32: [15412]: --> [1:]
Jul 31 16:13:58.33: [15412]: --> [7:CONNECT]
Jul 31 16:13:58.33: [15412]: <-- data [6]
Jul 31 16:13:58.33: [15412]: <-- data [2]
Jul 31 16:14:00.50: [15412]: --> [2:OK]
Jul 31 16:14:00.50: [15412]: DELAY 80 ms
Jul 31 16:14:00.58: [15412]: <-- [11:AT+FTM=145\r]
Jul 31 16:14:02.26: [15412]: --> [7:CONNECT]
Jul 31 16:14:02.26: [15412]: <-- data [1024]
Jul 31 16:14:02.26: [15412]: <-- data [1024]
Jul 31 16:14:02.26: [15412]: <-- data [652]
Jul 31 16:14:02.26: [15412]: <-- data [2]
Jul 31 16:14:03.82: [15412]: --> [2:OK]
Jul 31 16:14:03.82: [15412]: <-- [9:AT+FRH=3\r]
Jul 31 16:14:04.19: [15412]: --> [7:CONNECT]
Jul 31 16:14:05.34: [15412]: --> [2:OK]
Jul 31 16:14:05.34: [15412]: TRAINING succeeded
Jul 31 16:14:05.34: [15412]: DELAY 75 ms
Jul 31 16:14:05.42: [15412]: <-- [11:AT+FTM=146\r]
Jul 31 16:14:05.92: [15412]: --> [1:]
Jul 31 16:14:05.92: [15412]: --> [7:CONNECT]
Jul 31 16:14:05.92: [15412]: SEND begin page
Jul 31 16:14:05.92: [15412]: <-- data [1026]
Jul 31 16:14:05.92: [15412]: <-- data [1025]
Jul 31 16:14:05.92: [15412]: <-- data [1024]
Jul 31 16:14:05.92: [15412]: <-- data [1024]
Jul 31 16:14:05.92: [15412]: <-- data [1024]
Jul 31 16:14:07.91: [15412]: <-- data [1024]
Jul 31 16:14:07.91: [15412]: <-- data [1024]
Jul 31 16:14:07.91: [15412]: <-- data [1024]
Jul 31 16:14:09.91: [15412]: <-- data [1024]
Jul 31 16:14:09.91: [15412]: <-- data [1024]
Jul 31 16:14:09.91: [15412]: <-- data [133]
Jul 31 16:14:09.91: [15412]: SENT 10373 bytes of data
Jul 31 16:14:09.91: [15412]: SEND 1D RTC
Jul 31 16:14:09.91: [15412]: <-- data [29]
Jul 31 16:14:09.91: [15412]: <-- data [2]
Jul 31 16:14:09.91: [15412]: SEND end page
Jul 31 16:14:11.98: [15412]: --> [2:OK]
Jul 31 16:14:11.98: [15412]: DELAY 100 ms
Jul 31 16:14:12.08: [15412]: SEND send EOP (no more pages or documents)
Jul 31 16:14:12.08: [15412]: <-- [9:AT+FTH=3\r]
Jul 31 16:14:12.13: [15412]: --> [7:CONNECT]
Jul 31 16:14:12.13: [15412]: <-- data [3]
Jul 31 16:14:12.13: [15412]: <-- data [2]
Jul 31 16:14:13.45: [15412]: --> [1:]
Jul 31 16:14:13.45: [15412]: --> [2:OK]
Jul 31 16:14:13.45: [15412]: <-- [9:AT+FRH=3\r]
Jul 31 16:14:13.77: [15412]: --> [7:CONNECT]
Jul 31 16:14:14.94: [15412]: --> [2:OK]
Jul 31 16:14:14.94: [15412]: SEND recv MCF (message confirmation)
Jul 31 16:14:14.94: [15412]: SEND FAX (00000072): FROM user@host TO 0123456789 (page 1 of 1 sent in 0:16)
Jul 31 16:14:14.94: [15412]: SEND FAX (00000072): FROM user@host TO 0123456789 (docq/doc53.ps;01 sent in 0:16)
Jul 31 16:14:14.94: [15412]: <-- [9:AT+FTH=3\r]
Jul 31 16:14:14.99: [15412]: --> [7:CONNECT]
Jul 31 16:14:14.99: [15412]: <-- data [3]
Jul 31 16:14:14.99: [15412]: <-- data [2]
Jul 31 16:14:16.31: [15412]: --> [1:]
Jul 31 16:14:16.31: [15412]: --> [2:OK]
Jul 31 16:14:16.31: [15412]: <-- [5:ATH0\r]
Jul 31 16:14:16.74: [15412]: --> [10:NO CARRIER]
Jul 31 16:14:16.74: [15412]: MODEM No carrier
Jul 31 16:14:16.74: [15412]: sched policy=0, priority=0
Jul 31 16:14:16.74: [15412]: SESSION END


===== B receives from A
Jul 31 16:15:17.78: [29632]: SESSION BEGIN 00018336 390123456789
Jul 31 16:15:17.78: [29632]: HylaFAX (tm) Version 4.1.7
Jul 31 16:15:17.78: [29632]: <-- [4:ATA\r]
Jul 31 16:15:23.88: [29632]: --> [7:CONNECT]
Jul 31 16:15:23.88: [29632]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS2'
Jul 31 16:15:23.88: [29632]: sched policy=1, priority=1
Jul 31 16:15:23.88: [29632]: RECV FAX: begin
Jul 31 16:15:23.88: [29632]: <-- data [23]
Jul 31 16:15:23.88: [29632]: <-- data [2]
Jul 31 16:15:25.57: [29632]: --> [7:CONNECT]
Jul 31 16:15:25.57: [29632]: <-- data [10]
Jul 31 16:15:25.57: [29632]: <-- data [2]
Jul 31 16:15:26.12: [29632]: --> [2:OK]
Jul 31 16:15:26.12: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:15:26.51: [29632]: --> [7:CONNECT]
Jul 31 16:15:28.02: [29632]: --> [2:OK]
Jul 31 16:15:28.02: [29632]: REMOTE TSI "+39 111 2222222"
Jul 31 16:15:28.02: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:15:28.04: [29632]: --> [7:CONNECT]
Jul 31 16:15:28.37: [29632]: --> [2:OK]
Jul 31 16:15:28.37: [29632]: REMOTE wants 14400 bit/s
Jul 31 16:15:28.37: [29632]: REMOTE wants page width 1728 pixels in 215 mm
Jul 31 16:15:28.37: [29632]: REMOTE wants unlimited page length
Jul 31 16:15:28.37: [29632]: REMOTE wants 7.7 line/mm
Jul 31 16:15:28.37: [29632]: REMOTE wants 1-D MR
Jul 31 16:15:28.37: [29632]: RECV training at v.17 14400 bit/s
Jul 31 16:15:28.37: [29632]: <-- [11:AT+FRM=145\r]
Jul 31 16:15:30.16: [29632]: --> [7:CONNECT]
Jul 31 16:15:31.74: [29632]: RECV: TCF 2809 bytes, 0% non-zero, 2774 zero-run
Jul 31 16:15:31.75: [29632]: --> [10:NO CARRIER]
Jul 31 16:15:31.75: [29632]: DELAY 75 ms
Jul 31 16:15:31.83: [29632]: TRAINING succeeded
Jul 31 16:15:31.83: [29632]: <-- [9:AT+FTH=3\r]
Jul 31 16:15:31.88: [29632]: --> [7:CONNECT]
Jul 31 16:15:31.88: [29632]: <-- data [3]
Jul 31 16:15:31.88: [29632]: <-- data [2]
Jul 31 16:15:33.20: [29632]: --> [2:OK]
Jul 31 16:15:33.20: [29632]: <-- [11:AT+FRM=146\r]
Jul 31 16:15:33.86: [29632]: --> [7:CONNECT]
Jul 31 16:15:33.86: [29632]: RECV: begin page
Jul 31 16:15:40.02: [29632]: RECV: 2291 total lines, 0 bad lines, 1 consecutive bad lines
Jul 31 16:15:40.02: [29632]: RECV: end page
Jul 31 16:15:40.02: [29632]: --> [10:NO CARRIER]
Jul 31 16:15:40.02: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:15:40.38: [29632]: --> [7:CONNECT]
Jul 31 16:15:41.31: [29632]: --> [2:OK]
Jul 31 16:15:41.31: [29632]: RECV recv EOP (no more pages or documents)
Jul 31 16:15:41.31: [29632]: <-- [9:AT+FRS=7\r]
Jul 31 16:15:41.44: [29632]: --> [2:OK]
Jul 31 16:15:41.44: [29632]: <-- [9:AT+FTH=3\r]
Jul 31 16:15:41.49: [29632]: --> [7:CONNECT]
Jul 31 16:15:41.49: [29632]: <-- data [3]
Jul 31 16:15:41.49: [29632]: <-- data [2]
Jul 31 16:15:42.81: [29632]: --> [2:OK]
Jul 31 16:15:42.81: [29632]: RECV send MCF (message confirmation)
Jul 31 16:15:42.81: [29632]: RECV FAX (00018336): from +39 111 2222222, page 1 in 0:11, INF, 7.7 line/mm, 1-D MR, 14400 bit/s
Jul 31 16:15:42.81: [29632]: RECV FAX (00018336): recvq/fax00334.tif from +39 111 2222222, route to <unspecified>, 1 pages in 0:19
Jul 31 16:15:42.84: [29632]: <-- [9:AT+FRH=3\r]
Jul 31 16:15:43.18: [29632]: --> [7:CONNECT]
Jul 31 16:15:44.18: [29632]: --> [2:OK]
Jul 31 16:15:44.18: [29632]: RECV FAX: bin/faxrcvd "recvq/fax00334.tif" "ttyS2" "00018336" "" "" ""
Jul 31 16:15:44.18: [29632]: sched policy=0, priority=0
Jul 31 16:15:44.87: [29632]: sched policy=1, priority=1
Jul 31 16:15:44.87: [29632]: RECV FAX: end
Jul 31 16:15:44.87: [29632]: SESSION END
-- 
giulioo@pobox.com

____________________ HylaFAX(tm) Users Mailing List _______________________
  To subscribe/unsubscribe, click http://lists.hylafax.org/cgi-bin/lsg2.cgi
 On UNIX: mail -s unsubscribe hylafax-users-request@hylafax.org < /dev/null
  *To learn about commercial HylaFAX(tm) support, mail sales@hylafax.org.*