Re: [hylafax-users] Faxes appear to send, but receiver never gets a printout.

[John Wythe <john.wythe@xxxxxxxxxxxx>]

Hi Lee

Attached are 4 more logs. These one have ERROR lines.  The first (64) printed out the two pages, the second (65) only printed 1 page and the third (66) printed none.  All were from the same fax job, as it tried 3 times, on the third the entry disappeared from the queue.

I did manage to get one successful send, but it still had an ERROR line log c56.txt.

There appears to be some problem with the FCS command.  Any ideas?

John

-----Original Message-----
From: hylafax-users-bounce@xxxxxxxxxxx [mailto:hylafax-users-bounce@xxxxxxxxxxx] On Behalf Of John Wythe
Sent: Wednesday, December 01, 2010 12:24 AM
To: Lee Howard
Cc: lucas@xxxxxxxxxxxxxxxxxxxxxxx; hylafax-users@xxxxxxxxxxx
Subject: Re: [hylafax-users] Faxes appear to send, but receiver never gets a printout.

Lee

The problem occurs with more than one receiver.  Seems the problem is with the sender.  Another site with the same version of HylaFAX works with the same receiver.  It is running RHEL5.5 with ghostscript 8.15.2-9.12.el5_5.
Maybe I should try upgrading ghostscript.

John

-----Original Message-----
From: Lee Howard [mailto:faxguy@xxxxxxxxxxxxxxxx] 
Sent: Tuesday, November 30, 2010 11:47 PM
To: John Wythe
Cc: lucas@xxxxxxxxxxxxxxxxxxxxxxx; hylafax-users@xxxxxxxxxxx
Subject: Re: [hylafax-users] Faxes appear to send, but receiver never gets a printout.

John Wythe wrote:
> Hi Lucas
>
> Here is a log file.
>
> John
>
> Nov 30 15:59:41.07: [ 8605]: SESSION BEGIN 000000054 +16044681667
> Nov 30 15:59:41.07: [ 8605]: HylaFAX (tm) Version 5.2.9
> .....
> Nov 30 16:00:14.51: [ 8605]: SEND send frame number 14
> Nov 30 16:00:14.51: [ 8605]: SEND send frame number 15
> Nov 30 16:00:14.51: [ 8605]: SEND send frame number 16
> Nov 30 16:00:14.51: [ 8605]: <-- [10:AT+FTM=96\r]
> Nov 30 16:00:14.57: [ 8605]: --> [7:CONNECT]
> .....
> Nov 30 16:00:25.06: [ 8605]: SEND send PPS (partial page signal)
> Nov 30 16:00:25.06: [ 8605]: SEND send EOP (no more pages or documents)
> Nov 30 16:00:25.06: [ 8605]: <-- [9:AT+FRH=3\r]
> Nov 30 16:00:25.44: [ 8605]: --> [7:CONNECT]
> Nov 30 16:00:26.27: [ 8605]: --> HDLC<5:FF C8 31 45 8F>
> Nov 30 16:00:26.27: [ 8605]: --> [2:OK]
> Nov 30 16:00:26.27: [ 8605]: SEND recv MCF (message confirmation)
> .....
>
> ________________________________
> From: Lucas Burdick [mailto:lucas@xxxxxxxxxxxxxxxxxxxxxxx]
> Sent: Thursday, November 25, 2010 7:28 AM
> To: John Wythe
> Cc: hylafax-users@xxxxxxxxxxx
> Subject: Re: [hylafax-users] Faxes appear to send, but receiver never gets a printout.
>
> John
>
> Please provide a sample log.  This sounds sort of like the issue I'm having
>   

John,

Firstly, the receiver has confirmed page receipt with the MCF signal.  
So if the receiver is not printing-out anything at all then it (the 
receiver) has signaled MCF in error and there is at least a serious bug 
in the receiver's programming.

That said... you're only sending 16 frames.  This is a relatively small 
set of fax data.  I'm slightly concerned that maybe you're bumping into 
a job-data preparation problem with Ghostscript 8.71.  Furthermore, 
you're using HylaFAX+ 5.2.9, and while that was a solid release which 
many people still use, and while I cannot pinpoint any change since 
5.2.9 which could account for a bug in 5.2.9 that has since been 
fixed... I would suggest that you first try to reproduce the problem 
with HylaFAX+ 5.4.3.

Lastly, please comment on whether or not this problem is unique to this 
receiver or whether this happens with all receivers.

Thanks,

Lee.




____________________ 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@xxxxxxxxxxx < /dev/null
  *To learn about commercial HylaFAX(tm) support, mail sales@xxxxxxxxx*


Dec 02 18:45:22.10: [ 2912]: SESSION BEGIN 000000066 +16044681667
Dec 02 18:45:22.10: [ 2912]: HylaFAX (tm) Version 5.2.9
Dec 02 18:45:22.10: [ 2912]: SEND FAX: JOB 33 DEST 6044681667 COMMID 000000066 DEVICE '/dev/ttyS1' FROM 'silk <silk@xxxxxxxxxxxxxxxxxxxxxxxxx>' USER silk
Dec 02 18:45:22.10: [ 2912]: STATE CHANGE: RUNNING -> SENDING
Dec 02 18:45:22.10: [ 2912]: <-- [12:AT+FCLASS=1\r]
Dec 02 18:45:22.12: [ 2912]: --> [2:OK]
Dec 02 18:45:22.15: [ 2912]: DIAL 16044681667
Dec 02 18:45:22.15: [ 2912]: <-- [16:ATDT16044681667\r]
Dec 02 18:45:39.41: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:40.61: [ 2912]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:45:40.62: [ 2912]: --> [2:OK]
Dec 02 18:45:40.62: [ 2912]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:45:40.62: [ 2912]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:45:40.62: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:45:40.63: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:41.04: [ 2912]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:45:41.05: [ 2912]: --> [2:OK]
Dec 02 18:45:41.05: [ 2912]: REMOTE best rate 33600 bit/s
Dec 02 18:45:41.05: [ 2912]: REMOTE max A4 page width (215 mm)
Dec 02 18:45:41.05: [ 2912]: REMOTE max unlimited page length
Dec 02 18:45:41.05: [ 2912]: REMOTE best vres 15.4 line/mm
Dec 02 18:45:41.05: [ 2912]: REMOTE format support: MH, MR, MMR, JBIG
Dec 02 18:45:41.05: [ 2912]: REMOTE supports T.30 Annex A, 256-byte ECM
Dec 02 18:45:41.05: [ 2912]: REMOTE best 10 ms/scanline
Dec 02 18:45:41.05: [ 2912]: USE 9600 bit/s
Dec 02 18:45:41.05: [ 2912]: USE error correction mode
Dec 02 18:45:41.05: [ 2912]: SEND file "docq/cover33;31"
Dec 02 18:45:41.05: [ 2912]: USE A4 page width (215 mm)
Dec 02 18:45:41.05: [ 2912]: USE unlimited page length
Dec 02 18:45:41.05: [ 2912]: USE 7.7 line/mm
Dec 02 18:45:41.05: [ 2912]: USE 2-D MMR
Dec 02 18:45:41.05: [ 2912]: USE 0 ms/scanline
Dec 02 18:45:41.05: [ 2912]: SEND training at v.29 9600 bit/s
Dec 02 18:45:41.05: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:45:41.17: [ 2912]: --> [2:OK]
Dec 02 18:45:41.17: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:45:41.22: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:41.22: [ 2912]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:45:41.22: [ 2912]: <-- data [23]
Dec 02 18:45:41.22: [ 2912]: <-- data [2]
Dec 02 18:45:43.00: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:43.00: [ 2912]: <-- HDLC<7:FF C8 C1 00 62 1F 22>
Dec 02 18:45:43.00: [ 2912]: <-- data [7]
Dec 02 18:45:43.00: [ 2912]: <-- data [2]
Dec 02 18:45:43.47: [ 2912]: --> [2:OK]
Dec 02 18:45:43.47: [ 2912]: <-- [9:AT+FTS=7\r]
Dec 02 18:45:43.56: [ 2912]: --> [2:OK]
Dec 02 18:45:43.56: [ 2912]: <-- [10:AT+FTM=96\r]
Dec 02 18:45:43.62: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:43.62: [ 2912]: <-- data [1024]
Dec 02 18:45:44.01: [ 2912]: <-- data [776]
Dec 02 18:45:44.41: [ 2912]: <-- data [2]
Dec 02 18:45:45.57: [ 2912]: --> [2:OK]
Dec 02 18:45:45.57: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:45:48.67: [ 2912]: --> [0:]
Dec 02 18:45:48.67: [ 2912]: MODEM <Empty line>
Dec 02 18:45:48.67: [ 2912]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:45:48.67: [ 2912]: <-- data [1]
Dec 02 18:45:48.72: [ 2912]: --> [2:OK]
Dec 02 18:45:48.72: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:45:48.84: [ 2912]: --> [2:OK]
Dec 02 18:45:48.84: [ 2912]: SEND training at v.29 7200 bit/s
Dec 02 18:45:48.84: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:45:48.89: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:48.89: [ 2912]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:45:48.89: [ 2912]: <-- data [23]
Dec 02 18:45:48.89: [ 2912]: <-- data [2]
Dec 02 18:45:50.67: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:50.67: [ 2912]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:45:50.67: [ 2912]: <-- data [7]
Dec 02 18:45:50.67: [ 2912]: <-- data [2]
Dec 02 18:45:51.14: [ 2912]: --> [2:OK]
Dec 02 18:45:51.14: [ 2912]: <-- [9:AT+FTS=7\r]
Dec 02 18:45:51.23: [ 2912]: --> [2:OK]
Dec 02 18:45:51.23: [ 2912]: <-- [10:AT+FTM=72\r]
Dec 02 18:45:51.28: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:51.28: [ 2912]: <-- data [1024]
Dec 02 18:45:51.67: [ 2912]: <-- data [326]
Dec 02 18:45:51.67: [ 2912]: <-- data [2]
Dec 02 18:45:53.24: [ 2912]: --> [2:OK]
Dec 02 18:45:53.24: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:45:56.34: [ 2912]: --> [0:]
Dec 02 18:45:56.34: [ 2912]: MODEM <Empty line>
Dec 02 18:45:56.34: [ 2912]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:45:56.34: [ 2912]: <-- data [1]
Dec 02 18:45:56.39: [ 2912]: --> [2:OK]
Dec 02 18:45:56.39: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:45:56.51: [ 2912]: --> [2:OK]
Dec 02 18:45:56.51: [ 2912]: SEND training at v.27ter 4800 bit/s
Dec 02 18:45:56.51: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:45:56.56: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:56.56: [ 2912]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:45:56.56: [ 2912]: <-- data [23]
Dec 02 18:45:56.56: [ 2912]: <-- data [2]
Dec 02 18:45:58.34: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:58.34: [ 2912]: <-- HDLC<7:FF C8 C1 00 52 1F 22>
Dec 02 18:45:58.34: [ 2912]: <-- data [7]
Dec 02 18:45:58.34: [ 2912]: <-- data [2]
Dec 02 18:45:58.81: [ 2912]: --> [2:OK]
Dec 02 18:45:58.81: [ 2912]: <-- [9:AT+FTS=7\r]
Dec 02 18:45:58.90: [ 2912]: --> [2:OK]
Dec 02 18:45:58.90: [ 2912]: <-- [10:AT+FTM=48\r]
Dec 02 18:45:58.93: [ 2912]: --> [7:CONNECT]
Dec 02 18:45:58.93: [ 2912]: <-- data [900]
Dec 02 18:45:58.93: [ 2912]: <-- data [2]
Dec 02 18:46:01.36: [ 2912]: --> [2:OK]
Dec 02 18:46:01.36: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:46:01.86: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:02.78: [ 2912]: --> HDLC<5:FF C0 04 BD F3>
Dec 02 18:46:02.79: [ 2912]: --> [5:ERROR]
Dec 02 18:46:02.79: [ 2912]: MODEM Command error
Dec 02 18:46:02.79: [ 2912]: FCS error
Dec 02 18:46:02.79: [ 2912]: <-- [10:AT+FRS=21\r]
Dec 02 18:46:03.26: [ 2912]: --> [2:OK]
Dec 02 18:46:03.26: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:46:03.31: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:03.31: [ 2912]: <-- HDLC<3:FF C8 D8>
Dec 02 18:46:03.31: [ 2912]: <-- data [3]
Dec 02 18:46:03.31: [ 2912]: <-- data [2]
Dec 02 18:46:04.62: [ 2912]: --> [2:OK]
Dec 02 18:46:04.62: [ 2912]: SEND send CRP (command repeat)
Dec 02 18:46:04.62: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:46:07.72: [ 2912]: --> [0:]
Dec 02 18:46:07.72: [ 2912]: MODEM <Empty line>
Dec 02 18:46:07.72: [ 2912]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:46:07.72: [ 2912]: <-- data [1]
Dec 02 18:46:07.77: [ 2912]: --> [2:OK]
Dec 02 18:46:07.77: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:46:07.89: [ 2912]: --> [2:OK]
Dec 02 18:46:07.89: [ 2912]: SEND training at v.27ter fallback mode 2400 bit/s
Dec 02 18:46:07.89: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:46:07.94: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:07.94: [ 2912]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:46:07.94: [ 2912]: <-- data [23]
Dec 02 18:46:07.94: [ 2912]: <-- data [2]
Dec 02 18:46:09.72: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:09.72: [ 2912]: <-- HDLC<7:FF C8 C1 00 42 1F 22>
Dec 02 18:46:09.72: [ 2912]: <-- data [7]
Dec 02 18:46:09.72: [ 2912]: <-- data [2]
Dec 02 18:46:10.19: [ 2912]: --> [2:OK]
Dec 02 18:46:10.19: [ 2912]: <-- [9:AT+FTS=7\r]
Dec 02 18:46:10.28: [ 2912]: --> [2:OK]
Dec 02 18:46:10.28: [ 2912]: <-- [10:AT+FTM=24\r]
Dec 02 18:46:10.32: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:10.32: [ 2912]: <-- data [450]
Dec 02 18:46:10.32: [ 2912]: <-- data [2]
Dec 02 18:46:12.99: [ 2912]: --> [2:OK]
Dec 02 18:46:12.99: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:46:13.53: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:14.42: [ 2912]: --> HDLC<5:FF C8 21 57 BE>
Dec 02 18:46:14.42: [ 2912]: --> [2:OK]
Dec 02 18:46:14.42: [ 2912]: TRAINING succeeded
Dec 02 18:46:14.42: [ 2912]: SEND begin page
Dec 02 18:46:14.42: [ 2912]: Reading MH-compressed image file
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 0
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 1
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 2
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 3
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 4
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 5
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 6
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 7
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 8
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 9
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 10
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 11
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 12
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 13
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 14
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 15
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 16
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 17
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 18
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 19
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 20
Dec 02 18:46:14.42: [ 2912]: SEND send frame number 21
Dec 02 18:46:14.42: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:46:14.54: [ 2912]: --> [2:OK]
Dec 02 18:46:14.54: [ 2912]: <-- [10:AT+FTM=24\r]
Dec 02 18:46:14.58: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:14.58: [ 2912]: <-- data [1031]
Dec 02 18:46:14.97: [ 2912]: <-- data [1034]
Dec 02 18:46:17.10: [ 2912]: <-- data [1032]
Dec 02 18:46:20.27: [ 2912]: <-- data [1036]
Dec 02 18:46:23.45: [ 2912]: <-- data [1032]
Dec 02 18:46:26.72: [ 2912]: <-- data [1015]
Dec 02 18:46:31.53: [ 2912]: <-- data [2]
Dec 02 18:46:36.19: [ 2912]: --> [2:OK]
Dec 02 18:46:36.19: [ 2912]: <-- [9:AT+FTS=7\r]
Dec 02 18:46:36.28: [ 2912]: --> [2:OK]
Dec 02 18:46:36.28: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:46:36.33: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:36.33: [ 2912]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:46:36.33: [ 2912]: <-- data [7]
Dec 02 18:46:36.33: [ 2912]: <-- data [2]
Dec 02 18:46:37.75: [ 2912]: --> [2:OK]
Dec 02 18:46:37.75: [ 2912]: SEND send PPS (partial page signal)
Dec 02 18:46:37.75: [ 2912]: SEND send MPS (more pages, same document)
Dec 02 18:46:37.75: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:46:38.13: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:38.94: [ 2912]: --> HDLC<5:FF C8 31 45 8F>
Dec 02 18:46:38.94: [ 2912]: --> [2:OK]
Dec 02 18:46:38.94: [ 2912]: SEND recv MCF (message confirmation)
Dec 02 18:46:38.94: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:46:39.06: [ 2912]: --> [2:OK]
Dec 02 18:46:39.06: [ 2912]: SEND end page
Dec 02 18:46:39.06: [ 2912]: SEND FAX (000000066): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (page 1 of 2 sent in 0:00:58)
Dec 02 18:46:39.06: [ 2912]: SEND FAX (000000066): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (docq/cover33;31 sent in 0:00:58)
Dec 02 18:46:40.06: [ 2912]: SEND file "docq/doc39.ps;31"
Dec 02 18:46:40.06: [ 2912]: SEND begin page
Dec 02 18:46:40.06: [ 2912]: Reading MH-compressed image file
Dec 02 18:46:40.06: [ 2912]: SEND send frame number 0
Dec 02 18:46:40.06: [ 2912]: SEND send frame number 1
Dec 02 18:46:40.06: [ 2912]: SEND send frame number 2
Dec 02 18:46:40.06: [ 2912]: SEND send frame number 3
Dec 02 18:46:40.06: [ 2912]: SEND send frame number 4
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 5
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 6
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 7
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 8
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 9
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 10
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 11
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 12
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 13
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 14
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 15
Dec 02 18:46:40.07: [ 2912]: SEND send frame number 16
Dec 02 18:46:40.07: [ 2912]: <-- [10:AT+FTM=24\r]
Dec 02 18:46:40.11: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:40.11: [ 2912]: <-- data [1029]
Dec 02 18:46:40.50: [ 2912]: <-- data [1044]
Dec 02 18:46:42.62: [ 2912]: <-- data [1031]
Dec 02 18:46:45.88: [ 2912]: <-- data [1031]
Dec 02 18:46:49.11: [ 2912]: <-- data [576]
Dec 02 18:46:50.71: [ 2912]: <-- data [2]
Dec 02 18:46:56.85: [ 2912]: --> [2:OK]
Dec 02 18:46:56.85: [ 2912]: <-- [9:AT+FTS=9\r]
Dec 02 18:46:56.96: [ 2912]: --> [2:OK]
Dec 02 18:46:56.96: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:46:57.01: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:57.01: [ 2912]: <-- HDLC<7:FF C8 FD F4 80 00 08>
Dec 02 18:46:57.01: [ 2912]: <-- data [8]
Dec 02 18:46:57.01: [ 2912]: <-- data [2]
Dec 02 18:46:58.43: [ 2912]: --> [2:OK]
Dec 02 18:46:58.43: [ 2912]: SEND send PPS (partial page signal)
Dec 02 18:46:58.43: [ 2912]: SEND send EOP (no more pages or documents)
Dec 02 18:46:58.43: [ 2912]: <-- [9:AT+FRH=3\r]
Dec 02 18:46:58.78: [ 2912]: --> [7:CONNECT]
Dec 02 18:46:59.62: [ 2912]: --> HDLC<5:FF C8 31 45 8F>
Dec 02 18:46:59.62: [ 2912]: --> [2:OK]
Dec 02 18:46:59.62: [ 2912]: SEND recv MCF (message confirmation)
Dec 02 18:46:59.62: [ 2912]: <-- [9:AT+FRS=7\r]
Dec 02 18:46:59.74: [ 2912]: --> [2:OK]
Dec 02 18:46:59.74: [ 2912]: SEND end page
Dec 02 18:46:59.74: [ 2912]: SEND FAX (000000066): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (page 2 of 2 sent in 0:00:19)
Dec 02 18:46:59.74: [ 2912]: SEND FAX (000000066): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (docq/doc39.ps;31 sent in 0:00:19)
Dec 02 18:47:00.74: [ 2912]: <-- [9:AT+FTH=3\r]
Dec 02 18:47:00.79: [ 2912]: --> [7:CONNECT]
Dec 02 18:47:00.79: [ 2912]: <-- HDLC<3:FF C8 DF>
Dec 02 18:47:00.79: [ 2912]: <-- data [3]
Dec 02 18:47:00.79: [ 2912]: <-- data [2]
Dec 02 18:47:02.11: [ 2912]: --> [2:OK]
Dec 02 18:47:02.11: [ 2912]: MODEM input buffering enabled
Dec 02 18:47:03.11: [ 2912]: <-- [5:ATH0\r]
Dec 02 18:47:04.66: [ 2912]: --> [2:OK]
Dec 02 18:47:04.66: [ 2912]: MODEM set DTR OFF
Dec 02 18:47:04.66: [ 2912]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Dec 02 18:47:04.66: [ 2912]: SESSION END

Dec 02 18:41:34.70: [ 2726]: SESSION BEGIN 000000064 +16044681667
Dec 02 18:41:34.70: [ 2726]: HylaFAX (tm) Version 5.2.9
Dec 02 18:41:34.70: [ 2726]: SEND FAX: JOB 32 DEST 6044681667 COMMID 000000064 DEVICE '/dev/ttyS1' FROM 'silk <silk@xxxxxxxxxxxxxxxxxxxxxxxxx>' USER silk
Dec 02 18:41:34.70: [ 2726]: STATE CHANGE: RUNNING -> SENDING
Dec 02 18:41:34.70: [ 2726]: <-- [12:AT+FCLASS=1\r]
Dec 02 18:41:34.71: [ 2726]: --> [2:OK]
Dec 02 18:41:34.74: [ 2726]: DIAL 16044681667
Dec 02 18:41:34.74: [ 2726]: <-- [16:ATDT16044681667\r]
Dec 02 18:41:51.97: [ 2726]: --> [7:CONNECT]
Dec 02 18:41:53.15: [ 2726]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:41:53.16: [ 2726]: --> [2:OK]
Dec 02 18:41:53.16: [ 2726]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:41:53.16: [ 2726]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:41:53.16: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:41:53.17: [ 2726]: --> [7:CONNECT]
Dec 02 18:41:53.60: [ 2726]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:41:53.60: [ 2726]: --> [2:OK]
Dec 02 18:41:53.60: [ 2726]: REMOTE best rate 33600 bit/s
Dec 02 18:41:53.60: [ 2726]: REMOTE max A4 page width (215 mm)
Dec 02 18:41:53.60: [ 2726]: REMOTE max unlimited page length
Dec 02 18:41:53.60: [ 2726]: REMOTE best vres 15.4 line/mm
Dec 02 18:41:53.60: [ 2726]: REMOTE format support: MH, MR, MMR, JBIG
Dec 02 18:41:53.60: [ 2726]: REMOTE supports T.30 Annex A, 256-byte ECM
Dec 02 18:41:53.60: [ 2726]: REMOTE best 10 ms/scanline
Dec 02 18:41:53.60: [ 2726]: USE 9600 bit/s
Dec 02 18:41:53.60: [ 2726]: USE error correction mode
Dec 02 18:41:53.60: [ 2726]: SEND file "docq/cover32;31"
Dec 02 18:41:53.60: [ 2726]: USE A4 page width (215 mm)
Dec 02 18:41:53.60: [ 2726]: USE unlimited page length
Dec 02 18:41:53.60: [ 2726]: USE 7.7 line/mm
Dec 02 18:41:53.60: [ 2726]: USE 2-D MMR
Dec 02 18:41:53.60: [ 2726]: USE 0 ms/scanline
Dec 02 18:41:53.60: [ 2726]: SEND training at v.29 9600 bit/s
Dec 02 18:41:53.60: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:41:53.73: [ 2726]: --> [2:OK]
Dec 02 18:41:53.73: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:41:53.77: [ 2726]: --> [7:CONNECT]
Dec 02 18:41:53.77: [ 2726]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:41:53.77: [ 2726]: <-- data [23]
Dec 02 18:41:53.77: [ 2726]: <-- data [2]
Dec 02 18:41:55.56: [ 2726]: --> [7:CONNECT]
Dec 02 18:41:55.56: [ 2726]: <-- HDLC<7:FF C8 C1 00 62 1F 22>
Dec 02 18:41:55.56: [ 2726]: <-- data [7]
Dec 02 18:41:55.56: [ 2726]: <-- data [2]
Dec 02 18:41:56.02: [ 2726]: --> [2:OK]
Dec 02 18:41:56.02: [ 2726]: <-- [9:AT+FTS=7\r]
Dec 02 18:41:56.12: [ 2726]: --> [2:OK]
Dec 02 18:41:56.12: [ 2726]: <-- [10:AT+FTM=96\r]
Dec 02 18:41:56.17: [ 2726]: --> [7:CONNECT]
Dec 02 18:41:56.17: [ 2726]: <-- data [1024]
Dec 02 18:41:56.56: [ 2726]: <-- data [776]
Dec 02 18:41:56.96: [ 2726]: <-- data [2]
Dec 02 18:41:58.13: [ 2726]: --> [2:OK]
Dec 02 18:41:58.13: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:01.23: [ 2726]: --> [0:]
Dec 02 18:42:01.23: [ 2726]: MODEM <Empty line>
Dec 02 18:42:01.23: [ 2726]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:42:01.23: [ 2726]: <-- data [1]
Dec 02 18:42:01.28: [ 2726]: --> [2:OK]
Dec 02 18:42:01.28: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:42:01.40: [ 2726]: --> [2:OK]
Dec 02 18:42:01.40: [ 2726]: SEND training at v.29 7200 bit/s
Dec 02 18:42:01.40: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:01.44: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:01.44: [ 2726]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:42:01.44: [ 2726]: <-- data [23]
Dec 02 18:42:01.44: [ 2726]: <-- data [2]
Dec 02 18:42:03.23: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:03.23: [ 2726]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:42:03.23: [ 2726]: <-- data [7]
Dec 02 18:42:03.23: [ 2726]: <-- data [2]
Dec 02 18:42:03.70: [ 2726]: --> [2:OK]
Dec 02 18:42:03.70: [ 2726]: <-- [9:AT+FTS=7\r]
Dec 02 18:42:03.79: [ 2726]: --> [2:OK]
Dec 02 18:42:03.79: [ 2726]: <-- [10:AT+FTM=72\r]
Dec 02 18:42:03.84: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:03.84: [ 2726]: <-- data [1024]
Dec 02 18:42:04.23: [ 2726]: <-- data [326]
Dec 02 18:42:04.23: [ 2726]: <-- data [2]
Dec 02 18:42:05.80: [ 2726]: --> [2:OK]
Dec 02 18:42:05.80: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:06.64: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:07.84: [ 2726]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:42:07.84: [ 2726]: --> [2:OK]
Dec 02 18:42:07.84: [ 2726]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:42:07.84: [ 2726]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:42:07.84: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:07.86: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:08.27: [ 2726]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:42:08.28: [ 2726]: --> [2:OK]
Dec 02 18:42:08.28: [ 2726]: SEND training at v.29 7200 bit/s
Dec 02 18:42:08.28: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:42:08.40: [ 2726]: --> [2:OK]
Dec 02 18:42:08.40: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:08.44: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:08.44: [ 2726]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:42:08.44: [ 2726]: <-- data [23]
Dec 02 18:42:08.44: [ 2726]: <-- data [2]
Dec 02 18:42:10.23: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:10.23: [ 2726]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:42:10.23: [ 2726]: <-- data [7]
Dec 02 18:42:10.23: [ 2726]: <-- data [2]
Dec 02 18:42:10.69: [ 2726]: --> [2:OK]
Dec 02 18:42:10.69: [ 2726]: <-- [9:AT+FTS=7\r]
Dec 02 18:42:10.78: [ 2726]: --> [2:OK]
Dec 02 18:42:10.78: [ 2726]: <-- [10:AT+FTM=72\r]
Dec 02 18:42:10.83: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:10.83: [ 2726]: <-- data [1024]
Dec 02 18:42:11.22: [ 2726]: <-- data [326]
Dec 02 18:42:11.22: [ 2726]: <-- data [2]
Dec 02 18:42:12.79: [ 2726]: --> [2:OK]
Dec 02 18:42:12.79: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:13.31: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:14.19: [ 2726]: --> HDLC<4:FF C0 42 AF>
Dec 02 18:42:14.20: [ 2726]: --> [5:ERROR]
Dec 02 18:42:14.20: [ 2726]: MODEM Command error
Dec 02 18:42:14.20: [ 2726]: FCS error
Dec 02 18:42:14.20: [ 2726]: <-- [10:AT+FRS=21\r]
Dec 02 18:42:14.67: [ 2726]: --> [2:OK]
Dec 02 18:42:14.67: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:14.71: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:14.71: [ 2726]: <-- HDLC<3:FF C8 D8>
Dec 02 18:42:14.71: [ 2726]: <-- data [3]
Dec 02 18:42:14.72: [ 2726]: <-- data [2]
Dec 02 18:42:16.02: [ 2726]: --> [2:OK]
Dec 02 18:42:16.02: [ 2726]: SEND send CRP (command repeat)
Dec 02 18:42:16.02: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:19.12: [ 2726]: --> [0:]
Dec 02 18:42:19.12: [ 2726]: MODEM <Empty line>
Dec 02 18:42:19.12: [ 2726]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:42:19.12: [ 2726]: <-- data [1]
Dec 02 18:42:19.18: [ 2726]: --> [2:OK]
Dec 02 18:42:19.18: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:42:19.30: [ 2726]: --> [2:OK]
Dec 02 18:42:19.30: [ 2726]: SEND training at v.27ter 4800 bit/s
Dec 02 18:42:19.30: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:19.34: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:19.34: [ 2726]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:42:19.34: [ 2726]: <-- data [23]
Dec 02 18:42:19.34: [ 2726]: <-- data [2]
Dec 02 18:42:21.13: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:21.13: [ 2726]: <-- HDLC<7:FF C8 C1 00 52 1F 22>
Dec 02 18:42:21.13: [ 2726]: <-- data [7]
Dec 02 18:42:21.13: [ 2726]: <-- data [2]
Dec 02 18:42:21.59: [ 2726]: --> [2:OK]
Dec 02 18:42:21.59: [ 2726]: <-- [9:AT+FTS=7\r]
Dec 02 18:42:21.69: [ 2726]: --> [2:OK]
Dec 02 18:42:21.69: [ 2726]: <-- [10:AT+FTM=48\r]
Dec 02 18:42:21.72: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:21.72: [ 2726]: <-- data [900]
Dec 02 18:42:21.72: [ 2726]: <-- data [2]
Dec 02 18:42:24.16: [ 2726]: --> [2:OK]
Dec 02 18:42:24.16: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:24.67: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:25.58: [ 2726]: --> HDLC<5:FF C8 21 57 BE>
Dec 02 18:42:25.59: [ 2726]: --> [2:OK]
Dec 02 18:42:25.59: [ 2726]: TRAINING succeeded
Dec 02 18:42:25.59: [ 2726]: SEND begin page
Dec 02 18:42:25.59: [ 2726]: Reading MH-compressed image file
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 0
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 1
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 2
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 3
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 4
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 5
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 6
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 7
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 8
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 9
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 10
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 11
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 12
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 13
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 14
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 15
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 16
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 17
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 18
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 19
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 20
Dec 02 18:42:25.59: [ 2726]: SEND send frame number 21
Dec 02 18:42:25.59: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:42:25.91: [ 2726]: --> [2:OK]
Dec 02 18:42:25.91: [ 2726]: <-- [10:AT+FTM=48\r]
Dec 02 18:42:25.94: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:25.94: [ 2726]: <-- data [1028]
Dec 02 18:42:26.33: [ 2726]: <-- data [1032]
Dec 02 18:42:27.54: [ 2726]: <-- data [1034]
Dec 02 18:42:29.50: [ 2726]: <-- data [1036]
Dec 02 18:42:31.45: [ 2726]: <-- data [1039]
Dec 02 18:42:32.43: [ 2726]: <-- data [1031]
Dec 02 18:42:34.40: [ 2726]: <-- data [47]
Dec 02 18:42:34.40: [ 2726]: <-- data [2]
Dec 02 18:42:37.20: [ 2726]: --> [2:OK]
Dec 02 18:42:37.20: [ 2726]: <-- [9:AT+FTS=7\r]
Dec 02 18:42:37.29: [ 2726]: --> [2:OK]
Dec 02 18:42:37.29: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:37.33: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:37.33: [ 2726]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:42:37.33: [ 2726]: <-- data [7]
Dec 02 18:42:37.33: [ 2726]: <-- data [2]
Dec 02 18:42:38.76: [ 2726]: --> [2:OK]
Dec 02 18:42:38.76: [ 2726]: SEND send PPS (partial page signal)
Dec 02 18:42:38.76: [ 2726]: SEND send MPS (more pages, same document)
Dec 02 18:42:38.76: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:39.12: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:39.95: [ 2726]: --> HDLC<5:FF C8 31 4B 1E>
Dec 02 18:42:39.96: [ 2726]: --> [5:ERROR]
Dec 02 18:42:39.96: [ 2726]: MODEM Command error
Dec 02 18:42:39.96: [ 2726]: FCS error
Dec 02 18:42:39.96: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:40.01: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:40.01: [ 2726]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:42:40.01: [ 2726]: <-- data [7]
Dec 02 18:42:40.01: [ 2726]: <-- data [2]
Dec 02 18:42:41.42: [ 2726]: --> [2:OK]
Dec 02 18:42:41.42: [ 2726]: SEND send PPS (partial page signal)
Dec 02 18:42:41.42: [ 2726]: SEND send MPS (more pages, same document)
Dec 02 18:42:41.42: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:41.81: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:42.61: [ 2726]: --> HDLC<5:FF C8 31 45 8F>
Dec 02 18:42:42.61: [ 2726]: --> [2:OK]
Dec 02 18:42:42.61: [ 2726]: SEND recv MCF (message confirmation)
Dec 02 18:42:42.61: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:42:42.97: [ 2726]: --> [2:OK]
Dec 02 18:42:42.97: [ 2726]: SEND end page
Dec 02 18:42:42.97: [ 2726]: SEND FAX (000000064): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (page 1 of 2 sent in 0:00:49)
Dec 02 18:42:42.97: [ 2726]: SEND FAX (000000064): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (docq/cover32;31 sent in 0:00:49)
Dec 02 18:42:43.97: [ 2726]: SEND file "docq/doc37.ps;31"
Dec 02 18:42:43.97: [ 2726]: SEND begin page
Dec 02 18:42:43.97: [ 2726]: Reading MH-compressed image file
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 0
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 1
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 2
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 3
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 4
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 5
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 6
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 7
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 8
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 9
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 10
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 11
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 12
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 13
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 14
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 15
Dec 02 18:42:43.97: [ 2726]: SEND send frame number 16
Dec 02 18:42:43.97: [ 2726]: <-- [10:AT+FTM=48\r]
Dec 02 18:42:44.01: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:44.01: [ 2726]: <-- data [1028]
Dec 02 18:42:44.40: [ 2726]: <-- data [1041]
Dec 02 18:42:45.61: [ 2726]: <-- data [1036]
Dec 02 18:42:47.60: [ 2726]: <-- data [1030]
Dec 02 18:42:49.55: [ 2726]: <-- data [640]
Dec 02 18:42:50.54: [ 2726]: <-- data [2]
Dec 02 18:42:52.83: [ 2726]: --> [2:OK]
Dec 02 18:42:52.83: [ 2726]: <-- [9:AT+FTS=9\r]
Dec 02 18:42:52.94: [ 2726]: --> [2:OK]
Dec 02 18:42:52.94: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:52.98: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:52.98: [ 2726]: <-- HDLC<7:FF C8 FD F4 80 00 08>
Dec 02 18:42:52.98: [ 2726]: <-- data [8]
Dec 02 18:42:52.99: [ 2726]: <-- data [2]
Dec 02 18:42:54.40: [ 2726]: --> [2:OK]
Dec 02 18:42:54.40: [ 2726]: SEND send PPS (partial page signal)
Dec 02 18:42:54.40: [ 2726]: SEND send EOP (no more pages or documents)
Dec 02 18:42:54.40: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:54.79: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:55.63: [ 2726]: --> HDLC<5:FF C8 32 86 3D>
Dec 02 18:42:55.64: [ 2726]: --> [5:ERROR]
Dec 02 18:42:55.64: [ 2726]: MODEM Command error
Dec 02 18:42:55.64: [ 2726]: FCS error
Dec 02 18:42:55.64: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:55.69: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:55.69: [ 2726]: <-- HDLC<7:FF C8 FD F4 80 00 08>
Dec 02 18:42:55.69: [ 2726]: <-- data [8]
Dec 02 18:42:55.69: [ 2726]: <-- data [2]
Dec 02 18:42:57.11: [ 2726]: --> [2:OK]
Dec 02 18:42:57.11: [ 2726]: SEND send PPS (partial page signal)
Dec 02 18:42:57.11: [ 2726]: SEND send EOP (no more pages or documents)
Dec 02 18:42:57.11: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:42:57.47: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:58.32: [ 2726]: --> HDLC<5:FF C8 32 8B 1E>
Dec 02 18:42:58.34: [ 2726]: --> [5:ERROR]
Dec 02 18:42:58.34: [ 2726]: MODEM Command error
Dec 02 18:42:58.34: [ 2726]: FCS error
Dec 02 18:42:58.34: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:42:58.39: [ 2726]: --> [7:CONNECT]
Dec 02 18:42:58.39: [ 2726]: <-- HDLC<7:FF C8 FD F4 80 00 08>
Dec 02 18:42:58.39: [ 2726]: <-- data [8]
Dec 02 18:42:58.39: [ 2726]: <-- data [2]
Dec 02 18:42:59.80: [ 2726]: --> [2:OK]
Dec 02 18:42:59.80: [ 2726]: SEND send PPS (partial page signal)
Dec 02 18:42:59.80: [ 2726]: SEND send EOP (no more pages or documents)
Dec 02 18:42:59.80: [ 2726]: <-- [9:AT+FRH=3\r]
Dec 02 18:43:00.19: [ 2726]: --> [7:CONNECT]
Dec 02 18:43:01.02: [ 2726]: --> HDLC<5:FF C8 31 45 8F>
Dec 02 18:43:01.02: [ 2726]: --> [2:OK]
Dec 02 18:43:01.02: [ 2726]: SEND recv MCF (message confirmation)
Dec 02 18:43:01.02: [ 2726]: <-- [9:AT+FRS=7\r]
Dec 02 18:43:01.35: [ 2726]: --> [2:OK]
Dec 02 18:43:01.35: [ 2726]: SEND end page
Dec 02 18:43:01.35: [ 2726]: SEND FAX (000000064): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (page 2 of 2 sent in 0:00:18)
Dec 02 18:43:01.35: [ 2726]: SEND FAX (000000064): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (docq/doc37.ps;31 sent in 0:00:18)
Dec 02 18:43:02.35: [ 2726]: <-- [9:AT+FTH=3\r]
Dec 02 18:43:02.40: [ 2726]: --> [7:CONNECT]
Dec 02 18:43:02.40: [ 2726]: <-- HDLC<3:FF C8 DF>
Dec 02 18:43:02.40: [ 2726]: <-- data [3]
Dec 02 18:43:02.40: [ 2726]: <-- data [2]
Dec 02 18:43:03.72: [ 2726]: --> [2:OK]
Dec 02 18:43:03.72: [ 2726]: MODEM input buffering enabled
Dec 02 18:43:04.72: [ 2726]: <-- [5:ATH0\r]
Dec 02 18:43:06.27: [ 2726]: --> [2:OK]
Dec 02 18:43:06.27: [ 2726]: MODEM set DTR OFF
Dec 02 18:43:06.27: [ 2726]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Dec 02 18:43:06.27: [ 2726]: SESSION END

Dec 02 18:43:17.17: [ 2889]: SESSION BEGIN 000000065 +16044681667
Dec 02 18:43:17.17: [ 2889]: HylaFAX (tm) Version 5.2.9
Dec 02 18:43:17.18: [ 2889]: SEND FAX: JOB 33 DEST 6044681667 COMMID 000000065 DEVICE '/dev/ttyS1' FROM 'silk <silk@xxxxxxxxxxxxxxxxxxxxxxxxx>' USER silk
Dec 02 18:43:17.18: [ 2889]: STATE CHANGE: RUNNING -> SENDING
Dec 02 18:43:17.18: [ 2889]: <-- [12:AT+FCLASS=1\r]
Dec 02 18:43:17.19: [ 2889]: --> [2:OK]
Dec 02 18:43:17.22: [ 2889]: DIAL 16044681667
Dec 02 18:43:17.22: [ 2889]: <-- [16:ATDT16044681667\r]
Dec 02 18:43:34.43: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:35.61: [ 2889]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:43:35.62: [ 2889]: --> [2:OK]
Dec 02 18:43:35.62: [ 2889]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:43:35.62: [ 2889]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:43:35.62: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:43:35.63: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:36.06: [ 2889]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:43:36.07: [ 2889]: --> [2:OK]
Dec 02 18:43:36.07: [ 2889]: REMOTE best rate 33600 bit/s
Dec 02 18:43:36.07: [ 2889]: REMOTE max A4 page width (215 mm)
Dec 02 18:43:36.07: [ 2889]: REMOTE max unlimited page length
Dec 02 18:43:36.07: [ 2889]: REMOTE best vres 15.4 line/mm
Dec 02 18:43:36.07: [ 2889]: REMOTE format support: MH, MR, MMR, JBIG
Dec 02 18:43:36.07: [ 2889]: REMOTE supports T.30 Annex A, 256-byte ECM
Dec 02 18:43:36.07: [ 2889]: REMOTE best 10 ms/scanline
Dec 02 18:43:36.07: [ 2889]: USE 9600 bit/s
Dec 02 18:43:36.07: [ 2889]: USE error correction mode
Dec 02 18:43:36.07: [ 2889]: SEND file "docq/cover33;31"
Dec 02 18:43:36.07: [ 2889]: USE A4 page width (215 mm)
Dec 02 18:43:36.07: [ 2889]: USE unlimited page length
Dec 02 18:43:36.07: [ 2889]: USE 7.7 line/mm
Dec 02 18:43:36.07: [ 2889]: USE 2-D MMR
Dec 02 18:43:36.07: [ 2889]: USE 0 ms/scanline
Dec 02 18:43:36.07: [ 2889]: SEND training at v.29 9600 bit/s
Dec 02 18:43:36.07: [ 2889]: <-- [9:AT+FRS=7\r]
Dec 02 18:43:36.19: [ 2889]: --> [2:OK]
Dec 02 18:43:36.19: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:43:36.23: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:36.23: [ 2889]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:43:36.23: [ 2889]: <-- data [23]
Dec 02 18:43:36.24: [ 2889]: <-- data [2]
Dec 02 18:43:38.02: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:38.02: [ 2889]: <-- HDLC<7:FF C8 C1 00 62 1F 22>
Dec 02 18:43:38.02: [ 2889]: <-- data [7]
Dec 02 18:43:38.02: [ 2889]: <-- data [2]
Dec 02 18:43:38.49: [ 2889]: --> [2:OK]
Dec 02 18:43:38.49: [ 2889]: <-- [9:AT+FTS=7\r]
Dec 02 18:43:38.58: [ 2889]: --> [2:OK]
Dec 02 18:43:38.58: [ 2889]: <-- [10:AT+FTM=96\r]
Dec 02 18:43:38.64: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:38.64: [ 2889]: <-- data [1024]
Dec 02 18:43:39.03: [ 2889]: <-- data [776]
Dec 02 18:43:39.42: [ 2889]: <-- data [2]
Dec 02 18:43:40.59: [ 2889]: --> [2:OK]
Dec 02 18:43:40.59: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:43:43.69: [ 2889]: --> [0:]
Dec 02 18:43:43.69: [ 2889]: MODEM <Empty line>
Dec 02 18:43:43.69: [ 2889]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:43:43.69: [ 2889]: <-- data [1]
Dec 02 18:43:43.74: [ 2889]: --> [2:OK]
Dec 02 18:43:43.74: [ 2889]: <-- [9:AT+FRS=7\r]
Dec 02 18:43:43.86: [ 2889]: --> [2:OK]
Dec 02 18:43:43.86: [ 2889]: SEND training at v.29 7200 bit/s
Dec 02 18:43:43.86: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:43:43.90: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:43.90: [ 2889]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:43:43.90: [ 2889]: <-- data [23]
Dec 02 18:43:43.90: [ 2889]: <-- data [2]
Dec 02 18:43:45.69: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:45.69: [ 2889]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:43:45.69: [ 2889]: <-- data [7]
Dec 02 18:43:45.69: [ 2889]: <-- data [2]
Dec 02 18:43:46.16: [ 2889]: --> [2:OK]
Dec 02 18:43:46.16: [ 2889]: <-- [9:AT+FTS=7\r]
Dec 02 18:43:46.25: [ 2889]: --> [2:OK]
Dec 02 18:43:46.25: [ 2889]: <-- [10:AT+FTM=72\r]
Dec 02 18:43:46.30: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:46.30: [ 2889]: <-- data [1024]
Dec 02 18:43:46.69: [ 2889]: <-- data [326]
Dec 02 18:43:46.69: [ 2889]: <-- data [2]
Dec 02 18:43:48.26: [ 2889]: --> [2:OK]
Dec 02 18:43:48.26: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:43:48.85: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:49.36: [ 2889]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:43:49.37: [ 2889]: --> [2:OK]
Dec 02 18:43:49.37: [ 2889]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:43:49.37: [ 2889]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:43:49.37: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:43:49.38: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:49.79: [ 2889]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:43:49.80: [ 2889]: --> [2:OK]
Dec 02 18:43:49.80: [ 2889]: SEND training at v.29 7200 bit/s
Dec 02 18:43:49.80: [ 2889]: <-- [9:AT+FRS=7\r]
Dec 02 18:43:49.92: [ 2889]: --> [2:OK]
Dec 02 18:43:49.92: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:43:49.97: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:49.97: [ 2889]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:43:49.97: [ 2889]: <-- data [23]
Dec 02 18:43:49.97: [ 2889]: <-- data [2]
Dec 02 18:43:51.75: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:51.75: [ 2889]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:43:51.75: [ 2889]: <-- data [7]
Dec 02 18:43:51.75: [ 2889]: <-- data [2]
Dec 02 18:43:52.22: [ 2889]: --> [2:OK]
Dec 02 18:43:52.22: [ 2889]: <-- [9:AT+FTS=7\r]
Dec 02 18:43:52.31: [ 2889]: --> [2:OK]
Dec 02 18:43:52.31: [ 2889]: <-- [10:AT+FTM=72\r]
Dec 02 18:43:52.36: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:52.36: [ 2889]: <-- data [1024]
Dec 02 18:43:52.75: [ 2889]: <-- data [326]
Dec 02 18:43:52.75: [ 2889]: <-- data [2]
Dec 02 18:43:54.32: [ 2889]: --> [2:OK]
Dec 02 18:43:54.32: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:43:54.84: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:55.73: [ 2889]: --> HDLC<5:FF C8 21 57 BE>
Dec 02 18:43:55.73: [ 2889]: --> [2:OK]
Dec 02 18:43:55.73: [ 2889]: TRAINING succeeded
Dec 02 18:43:55.73: [ 2889]: SEND begin page
Dec 02 18:43:55.73: [ 2889]: Reading MH-compressed image file
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 0
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 1
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 2
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 3
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 4
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 5
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 6
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 7
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 8
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 9
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 10
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 11
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 12
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 13
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 14
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 15
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 16
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 17
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 18
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 19
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 20
Dec 02 18:43:55.73: [ 2889]: SEND send frame number 21
Dec 02 18:43:55.73: [ 2889]: <-- [9:AT+FRS=7\r]
Dec 02 18:43:55.85: [ 2889]: --> [2:OK]
Dec 02 18:43:55.85: [ 2889]: <-- [10:AT+FTM=72\r]
Dec 02 18:43:55.90: [ 2889]: --> [7:CONNECT]
Dec 02 18:43:55.90: [ 2889]: <-- data [1028]
Dec 02 18:43:56.29: [ 2889]: <-- data [1035]
Dec 02 18:43:56.69: [ 2889]: <-- data [1035]
Dec 02 18:43:57.58: [ 2889]: <-- data [1029]
Dec 02 18:43:58.44: [ 2889]: <-- data [1033]
Dec 02 18:44:00.61: [ 2889]: <-- data [1027]
Dec 02 18:44:01.45: [ 2889]: <-- data [108]
Dec 02 18:44:01.45: [ 2889]: <-- data [2]
Dec 02 18:44:03.31: [ 2889]: --> [2:OK]
Dec 02 18:44:03.31: [ 2889]: <-- [9:AT+FTS=7\r]
Dec 02 18:44:03.40: [ 2889]: --> [2:OK]
Dec 02 18:44:03.40: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:44:03.45: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:03.45: [ 2889]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:44:03.45: [ 2889]: <-- data [7]
Dec 02 18:44:03.45: [ 2889]: <-- data [2]
Dec 02 18:44:04.87: [ 2889]: --> [2:OK]
Dec 02 18:44:04.87: [ 2889]: SEND send PPS (partial page signal)
Dec 02 18:44:04.87: [ 2889]: SEND send MPS (more pages, same document)
Dec 02 18:44:04.87: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:44:05.26: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:06.07: [ 2889]: --> HDLC<5:FF C0 61 14 7B>
Dec 02 18:44:06.07: [ 2889]: --> [5:ERROR]
Dec 02 18:44:06.07: [ 2889]: MODEM Command error
Dec 02 18:44:06.07: [ 2889]: FCS error
Dec 02 18:44:06.07: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:44:06.12: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:06.12: [ 2889]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:44:06.12: [ 2889]: <-- data [7]
Dec 02 18:44:06.12: [ 2889]: <-- data [2]
Dec 02 18:44:07.54: [ 2889]: --> [2:OK]
Dec 02 18:44:07.54: [ 2889]: SEND send PPS (partial page signal)
Dec 02 18:44:07.54: [ 2889]: SEND send MPS (more pages, same document)
Dec 02 18:44:07.54: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:44:07.92: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:08.74: [ 2889]: --> HDLC<5:FF 88 32 86 3D>
Dec 02 18:44:08.75: [ 2889]: --> [5:ERROR]
Dec 02 18:44:08.75: [ 2889]: MODEM Command error
Dec 02 18:44:08.75: [ 2889]: FCS error
Dec 02 18:44:08.75: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:44:08.80: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:08.80: [ 2889]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:44:08.80: [ 2889]: <-- data [7]
Dec 02 18:44:08.80: [ 2889]: <-- data [2]
Dec 02 18:44:10.22: [ 2889]: --> [2:OK]
Dec 02 18:44:10.22: [ 2889]: SEND send PPS (partial page signal)
Dec 02 18:44:10.22: [ 2889]: SEND send MPS (more pages, same document)
Dec 02 18:44:10.22: [ 2889]: <-- [9:AT+FRH=3\r]
Dec 02 18:44:10.60: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:11.41: [ 2889]: --> HDLC<5:FF C8 33 16 3D>
Dec 02 18:44:11.42: [ 2889]: --> [5:ERROR]
Dec 02 18:44:11.42: [ 2889]: MODEM Command error
Dec 02 18:44:11.42: [ 2889]: FCS error
Dec 02 18:44:11.42: [ 2889]: No response to PPS repeated 3 times. {E147}
Dec 02 18:44:11.42: [ 2889]: SEND end page
Dec 02 18:44:11.42: [ 2889]: <-- [9:AT+FRS=7\r]
Dec 02 18:44:11.54: [ 2889]: --> [2:OK]
Dec 02 18:44:11.54: [ 2889]: <-- [9:AT+FTH=3\r]
Dec 02 18:44:11.58: [ 2889]: --> [7:CONNECT]
Dec 02 18:44:11.59: [ 2889]: <-- HDLC<3:FF C8 DF>
Dec 02 18:44:11.59: [ 2889]: <-- data [3]
Dec 02 18:44:11.59: [ 2889]: <-- data [2]
Dec 02 18:44:12.90: [ 2889]: --> [2:OK]
Dec 02 18:44:12.90: [ 2889]: MODEM input buffering enabled
Dec 02 18:44:13.90: [ 2889]: <-- [5:ATH0\r]
Dec 02 18:44:15.44: [ 2889]: --> [2:OK]
Dec 02 18:44:15.45: [ 2889]: MODEM set DTR OFF
Dec 02 18:44:15.45: [ 2889]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Dec 02 18:44:15.45: [ 2889]: SESSION END

Dec 02 18:17:35.46: [ 1801]: SESSION BEGIN 000000056 +16044681667
Dec 02 18:17:35.46: [ 1801]: HylaFAX (tm) Version 5.2.9
Dec 02 18:17:35.46: [ 1801]: SEND FAX: JOB 25 DEST 6044681667 COMMID 000000056 DEVICE '/dev/ttyS1' FROM 'silk <silk@xxxxxxxxxxxxxxxxxxxxxxxxx>' USER silk
Dec 02 18:17:35.46: [ 1801]: STATE CHANGE: RUNNING -> SENDING
Dec 02 18:17:35.46: [ 1801]: <-- [12:AT+FCLASS=1\r]
Dec 02 18:17:35.47: [ 1801]: --> [2:OK]
Dec 02 18:17:35.55: [ 1801]: DIAL 16044681667
Dec 02 18:17:35.55: [ 1801]: <-- [16:ATDT16044681667\r]
Dec 02 18:17:52.80: [ 1801]: --> [7:CONNECT]
Dec 02 18:17:54.00: [ 1801]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:17:54.00: [ 1801]: --> [2:OK]
Dec 02 18:17:54.00: [ 1801]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:17:54.00: [ 1801]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:17:54.00: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:17:54.02: [ 1801]: --> [7:CONNECT]
Dec 02 18:17:54.43: [ 1801]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:17:54.44: [ 1801]: --> [2:OK]
Dec 02 18:17:54.44: [ 1801]: REMOTE best rate 33600 bit/s
Dec 02 18:17:54.44: [ 1801]: REMOTE max A4 page width (215 mm)
Dec 02 18:17:54.44: [ 1801]: REMOTE max unlimited page length
Dec 02 18:17:54.44: [ 1801]: REMOTE best vres 15.4 line/mm
Dec 02 18:17:54.44: [ 1801]: REMOTE format support: MH, MR, MMR, JBIG
Dec 02 18:17:54.44: [ 1801]: REMOTE supports T.30 Annex A, 256-byte ECM
Dec 02 18:17:54.44: [ 1801]: REMOTE best 10 ms/scanline
Dec 02 18:17:54.44: [ 1801]: USE 9600 bit/s
Dec 02 18:17:54.44: [ 1801]: USE error correction mode
Dec 02 18:17:54.44: [ 1801]: SEND file "docq/cover25;31"
Dec 02 18:17:54.44: [ 1801]: USE A4 page width (215 mm)
Dec 02 18:17:54.44: [ 1801]: USE unlimited page length
Dec 02 18:17:54.44: [ 1801]: USE 7.7 line/mm
Dec 02 18:17:54.44: [ 1801]: USE 2-D MMR
Dec 02 18:17:54.44: [ 1801]: USE 0 ms/scanline
Dec 02 18:17:54.44: [ 1801]: SEND training at v.29 9600 bit/s
Dec 02 18:17:54.44: [ 1801]: <-- [9:AT+FRS=7\r]
Dec 02 18:17:54.56: [ 1801]: --> [2:OK]
Dec 02 18:17:54.56: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:17:54.60: [ 1801]: --> [7:CONNECT]
Dec 02 18:17:54.60: [ 1801]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:17:54.60: [ 1801]: <-- data [23]
Dec 02 18:17:54.60: [ 1801]: <-- data [2]
Dec 02 18:17:56.39: [ 1801]: --> [7:CONNECT]
Dec 02 18:17:56.39: [ 1801]: <-- HDLC<7:FF C8 C1 00 62 1F 22>
Dec 02 18:17:56.39: [ 1801]: <-- data [7]
Dec 02 18:17:56.39: [ 1801]: <-- data [2]
Dec 02 18:17:56.86: [ 1801]: --> [2:OK]
Dec 02 18:17:56.86: [ 1801]: <-- [9:AT+FTS=7\r]
Dec 02 18:17:56.95: [ 1801]: --> [2:OK]
Dec 02 18:17:56.95: [ 1801]: <-- [10:AT+FTM=96\r]
Dec 02 18:17:57.00: [ 1801]: --> [7:CONNECT]
Dec 02 18:17:57.00: [ 1801]: <-- data [1024]
Dec 02 18:17:57.39: [ 1801]: <-- data [776]
Dec 02 18:17:57.79: [ 1801]: <-- data [2]
Dec 02 18:17:58.96: [ 1801]: --> [2:OK]
Dec 02 18:17:58.96: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:02.06: [ 1801]: --> [0:]
Dec 02 18:18:02.06: [ 1801]: MODEM <Empty line>
Dec 02 18:18:02.06: [ 1801]: MODEM TIMEOUT: waiting for v.21 carrier
Dec 02 18:18:02.06: [ 1801]: <-- data [1]
Dec 02 18:18:02.11: [ 1801]: --> [2:OK]
Dec 02 18:18:02.11: [ 1801]: <-- [9:AT+FRS=7\r]
Dec 02 18:18:02.23: [ 1801]: --> [2:OK]
Dec 02 18:18:02.23: [ 1801]: SEND training at v.29 7200 bit/s
Dec 02 18:18:02.23: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:18:02.27: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:02.27: [ 1801]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:18:02.27: [ 1801]: <-- data [23]
Dec 02 18:18:02.27: [ 1801]: <-- data [2]
Dec 02 18:18:04.06: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:04.06: [ 1801]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:18:04.06: [ 1801]: <-- data [7]
Dec 02 18:18:04.06: [ 1801]: <-- data [2]
Dec 02 18:18:04.52: [ 1801]: --> [2:OK]
Dec 02 18:18:04.52: [ 1801]: <-- [9:AT+FTS=7\r]
Dec 02 18:18:04.62: [ 1801]: --> [2:OK]
Dec 02 18:18:04.62: [ 1801]: <-- [10:AT+FTM=72\r]
Dec 02 18:18:04.68: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:04.68: [ 1801]: <-- data [1024]
Dec 02 18:18:05.07: [ 1801]: <-- data [326]
Dec 02 18:18:05.07: [ 1801]: <-- data [2]
Dec 02 18:18:06.63: [ 1801]: --> [2:OK]
Dec 02 18:18:06.63: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:07.73: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:08.96: [ 1801]: --> HDLC<16:FF C0 04 00 00 6A AA AA 00 31 09 01 5E 08 F0 8C>
Dec 02 18:18:08.96: [ 1801]: --> [2:OK]
Dec 02 18:18:08.97: [ 1801]: REMOTE NSF "00 00 56 55 55 00 8C 90 80 7A 10"
Dec 02 18:18:08.97: [ 1801]: NSF remote fax equipment: Brother MFC-3100C/MFC-8600
Dec 02 18:18:08.97: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:08.98: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:09.38: [ 1801]: --> HDLC<15:FF C8 01 04 77 15 23 01 89 01 01 01 04 FF 0B>
Dec 02 18:18:09.39: [ 1801]: --> [2:OK]
Dec 02 18:18:09.40: [ 1801]: SEND training at v.29 7200 bit/s
Dec 02 18:18:09.40: [ 1801]: <-- [9:AT+FRS=7\r]
Dec 02 18:18:09.51: [ 1801]: --> [2:OK]
Dec 02 18:18:09.52: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:18:09.56: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:09.56: [ 1801]: <-- HDLC<23:FF C0 C2 2E 36 86 CA 04 26 F6 F6 EE 9E 36 0A 04 4E F6 CE 26 76 96 EA>
Dec 02 18:18:09.56: [ 1801]: <-- data [23]
Dec 02 18:18:09.56: [ 1801]: <-- data [2]
Dec 02 18:18:11.35: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:11.35: [ 1801]: <-- HDLC<7:FF C8 C1 00 72 1F 22>
Dec 02 18:18:11.35: [ 1801]: <-- data [7]
Dec 02 18:18:11.35: [ 1801]: <-- data [2]
Dec 02 18:18:11.81: [ 1801]: --> [2:OK]
Dec 02 18:18:11.81: [ 1801]: <-- [9:AT+FTS=7\r]
Dec 02 18:18:11.90: [ 1801]: --> [2:OK]
Dec 02 18:18:11.90: [ 1801]: <-- [10:AT+FTM=72\r]
Dec 02 18:18:11.95: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:11.95: [ 1801]: <-- data [1024]
Dec 02 18:18:12.34: [ 1801]: <-- data [326]
Dec 02 18:18:12.34: [ 1801]: <-- data [2]
Dec 02 18:18:13.91: [ 1801]: --> [2:OK]
Dec 02 18:18:13.91: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:14.43: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:15.31: [ 1801]: --> HDLC<5:FF C8 21 57 BE>
Dec 02 18:18:15.31: [ 1801]: --> [2:OK]
Dec 02 18:18:15.31: [ 1801]: TRAINING succeeded
Dec 02 18:18:15.31: [ 1801]: SEND begin page
Dec 02 18:18:15.32: [ 1801]: Reading MH-compressed image file
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 0
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 1
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 2
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 3
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 4
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 5
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 6
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 7
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 8
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 9
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 10
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 11
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 12
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 13
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 14
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 15
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 16
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 17
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 18
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 19
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 20
Dec 02 18:18:15.32: [ 1801]: SEND send frame number 21
Dec 02 18:18:15.32: [ 1801]: <-- [9:AT+FRS=7\r]
Dec 02 18:18:15.44: [ 1801]: --> [2:OK]
Dec 02 18:18:15.44: [ 1801]: <-- [10:AT+FTM=72\r]
Dec 02 18:18:15.50: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:15.50: [ 1801]: <-- data [1030]
Dec 02 18:18:15.89: [ 1801]: <-- data [1039]
Dec 02 18:18:16.28: [ 1801]: <-- data [1030]
Dec 02 18:18:17.19: [ 1801]: <-- data [1034]
Dec 02 18:18:18.50: [ 1801]: <-- data [1036]
Dec 02 18:18:20.21: [ 1801]: <-- data [1033]
Dec 02 18:18:20.61: [ 1801]: <-- data [107]
Dec 02 18:18:20.61: [ 1801]: <-- data [2]
Dec 02 18:18:22.90: [ 1801]: --> [2:OK]
Dec 02 18:18:22.90: [ 1801]: <-- [9:AT+FTS=7\r]
Dec 02 18:18:22.99: [ 1801]: --> [2:OK]
Dec 02 18:18:22.99: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:18:23.04: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:23.04: [ 1801]: <-- HDLC<7:FF C8 FD F2 00 00 A8>
Dec 02 18:18:23.04: [ 1801]: <-- data [7]
Dec 02 18:18:23.04: [ 1801]: <-- data [2]
Dec 02 18:18:24.46: [ 1801]: --> [2:OK]
Dec 02 18:18:24.46: [ 1801]: SEND send PPS (partial page signal)
Dec 02 18:18:24.46: [ 1801]: SEND send MPS (more pages, same document)
Dec 02 18:18:24.46: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:24.84: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:25.65: [ 1801]: --> HDLC<5:FF C8 31 45 8F>
Dec 02 18:18:25.67: [ 1801]: --> [2:OK]
Dec 02 18:18:25.67: [ 1801]: SEND recv MCF (message confirmation)
Dec 02 18:18:25.67: [ 1801]: <-- [9:AT+FRS=7\r]
Dec 02 18:18:25.79: [ 1801]: --> [2:OK]
Dec 02 18:18:25.79: [ 1801]: SEND end page
Dec 02 18:18:25.79: [ 1801]: SEND FAX (000000056): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (page 1 of 2 sent in 0:00:31)
Dec 02 18:18:25.79: [ 1801]: SEND FAX (000000056): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (docq/cover25;31 sent in 0:00:31)
Dec 02 18:18:26.79: [ 1801]: SEND file "docq/doc26.ps;31"
Dec 02 18:18:26.79: [ 1801]: SEND begin page
Dec 02 18:18:26.79: [ 1801]: Reading MH-compressed image file
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 0
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 1
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 2
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 3
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 4
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 5
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 6
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 7
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 8
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 9
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 10
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 11
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 12
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 13
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 14
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 15
Dec 02 18:18:26.79: [ 1801]: SEND send frame number 16
Dec 02 18:18:26.79: [ 1801]: <-- [10:AT+FTM=72\r]
Dec 02 18:18:26.85: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:26.85: [ 1801]: <-- data [1028]
Dec 02 18:18:27.24: [ 1801]: <-- data [1039]
Dec 02 18:18:27.64: [ 1801]: <-- data [1035]
Dec 02 18:18:28.54: [ 1801]: <-- data [1027]
Dec 02 18:18:29.85: [ 1801]: <-- data [699]
Dec 02 18:18:30.70: [ 1801]: <-- data [2]
Dec 02 18:18:32.63: [ 1801]: --> [2:OK]
Dec 02 18:18:32.63: [ 1801]: <-- [9:AT+FTS=9\r]
Dec 02 18:18:32.74: [ 1801]: --> [2:OK]
Dec 02 18:18:32.74: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:18:32.78: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:32.78: [ 1801]: <-- HDLC<7:FF C8 FD F4 80 00 08>
Dec 02 18:18:32.78: [ 1801]: <-- data [8]
Dec 02 18:18:32.78: [ 1801]: <-- data [2]
Dec 02 18:18:34.21: [ 1801]: --> [2:OK]
Dec 02 18:18:34.21: [ 1801]: SEND send PPS (partial page signal)
Dec 02 18:18:34.21: [ 1801]: SEND send EOP (no more pages or documents)
Dec 02 18:18:34.21: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:34.59: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:35.37: [ 1801]: --> HDLC<4:FF C8 31 4B>
Dec 02 18:18:35.38: [ 1801]: --> [5:ERROR]
Dec 02 18:18:35.38: [ 1801]: MODEM Command error
Dec 02 18:18:35.38: [ 1801]: FCS error
Dec 02 18:18:35.38: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:18:35.43: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:35.43: [ 1801]: <-- HDLC<7:FF C8 FD F4 80 00 08>
Dec 02 18:18:35.43: [ 1801]: <-- data [8]
Dec 02 18:18:35.43: [ 1801]: <-- data [2]
Dec 02 18:18:36.85: [ 1801]: --> [2:OK]
Dec 02 18:18:36.85: [ 1801]: SEND send PPS (partial page signal)
Dec 02 18:18:36.85: [ 1801]: SEND send EOP (no more pages or documents)
Dec 02 18:18:36.85: [ 1801]: <-- [9:AT+FRH=3\r]
Dec 02 18:18:37.20: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:38.06: [ 1801]: --> HDLC<5:FF C8 31 45 8F>
Dec 02 18:18:38.06: [ 1801]: --> [2:OK]
Dec 02 18:18:38.06: [ 1801]: SEND recv MCF (message confirmation)
Dec 02 18:18:38.06: [ 1801]: <-- [9:AT+FRS=7\r]
Dec 02 18:18:38.19: [ 1801]: --> [2:OK]
Dec 02 18:18:38.19: [ 1801]: SEND end page
Dec 02 18:18:38.19: [ 1801]: SEND FAX (000000056): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (page 2 of 2 sent in 0:00:12)
Dec 02 18:18:38.19: [ 1801]: SEND FAX (000000056): FROM silk@xxxxxxxxxxxxxxxxxxxxxxxxx TO 6044681667 (docq/doc26.ps;31 sent in 0:00:12)
Dec 02 18:18:39.19: [ 1801]: <-- [9:AT+FTH=3\r]
Dec 02 18:18:39.24: [ 1801]: --> [7:CONNECT]
Dec 02 18:18:39.24: [ 1801]: <-- HDLC<3:FF C8 DF>
Dec 02 18:18:39.24: [ 1801]: <-- data [3]
Dec 02 18:18:39.24: [ 1801]: <-- data [2]
Dec 02 18:18:40.55: [ 1801]: --> [2:OK]
Dec 02 18:18:40.55: [ 1801]: MODEM input buffering enabled
Dec 02 18:18:41.56: [ 1801]: <-- [5:ATH0\r]
Dec 02 18:18:43.11: [ 1801]: --> [2:OK]
Dec 02 18:18:43.11: [ 1801]: MODEM set DTR OFF
Dec 02 18:18:43.11: [ 1801]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Dec 02 18:18:43.11: [ 1801]: SESSION END