Re: [hylafax-users] No response to EOP repeated three tries

["DHARMESH PATEL" <dharmeshpatel81@xxxxxxxxxxxxxx>]

DHARMESH PATEL wrote:

When i am sending fax by using Hylafax server i am getting error:NO RESPONSE TO EOP REPEATED THREE TRIES:GIVING UP AFTER ATTEMPTING THREE TIMES TO SEND SAME FAX.

While i am being able to send fax on the same fax number by using a Nornmal Fax Machine.

On Mon, 12 Jun 2006 Lee Howard wrote :

Please send me the session log from /var/spool/hylafax/log/

>Lee.

Dear Mr Lee ,
I am sending some session log files regarding that session.kindly check it and suggest me the Appropriate solution.


Regard
Dharmesh

Jun 12 10:21:49.66: [ 4187]: SESSION BEGIN 000000254 913612630200
Jun 12 10:21:49.66: [ 4187]: HylaFAX (tm) Version 4.3.0.2
Jun 12 10:21:49.66: [ 4187]: SEND FAX: JOB 89 DEST 03612630200 COMMID 000000254 DEVICE '/dev/ttyS0' FROM 'corpfin2 <isit@xxxxxxxxxxx>' USER isit
Jun 12 10:21:49.66: [ 4187]: STATE CHANGE: RUNNING -> SENDING
Jun 12 10:21:49.66: [ 4187]: <-- [12:AT+FCLASS=1\r]
Jun 12 10:21:49.68: [ 4187]: --> [2:OK]
Jun 12 10:21:49.68: [ 4187]: DIAL 03612630200
Jun 12 10:21:49.68: [ 4187]: <-- [16:ATDT03612630200\r]
Jun 12 10:22:10.25: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:11.35: [ 4187]: --> HDLC<11:FF C0 04 61 02 02 FF 60 42 BE BB>
Jun 12 10:22:11.36: [ 4187]: --> [2:OK]
Jun 12 10:22:11.36: [ 4187]: REMOTE NSF "86 40 40 FF 06 42"
Jun 12 10:22:11.36: [ 4187]: NSF remote fax equipment: unknown 
Jun 12 10:22:11.36: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:22:11.38: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:12.60: [ 4187]: --> HDLC<44:FF C0 04 61 02 02 73 0D 00 04 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 F4 77>
Jun 12 10:22:12.61: [ 4187]: --> [2:OK]
Jun 12 10:22:12.61: [ 4187]: REMOTE NSF "86 40 40 CE B0 00 20 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04"
Jun 12 10:22:12.61: [ 4187]: NSF remote fax equipment: unknown 
Jun 12 10:22:12.61: [ 4187]: NSF possible remote station ID: "                                "
Jun 12 10:22:12.61: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:22:12.63: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:13.37: [ 4187]: --> HDLC<25:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 A4 F3>
Jun 12 10:22:13.38: [ 4187]: --> [2:OK]
Jun 12 10:22:13.38: [ 4187]: REMOTE CSI ""
Jun 12 10:22:13.38: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:22:13.40: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:13.69: [ 4187]: --> HDLC<9:FF C8 01 00 73 0D 00 45 67>
Jun 12 10:22:13.70: [ 4187]: --> [2:OK]
Jun 12 10:22:13.70: [ 4187]: REMOTE best rate 9600 bit/s
Jun 12 10:22:13.70: [ 4187]: REMOTE max A4 page width (215 mm)
Jun 12 10:22:13.70: [ 4187]: REMOTE max A4 page length (297 mm)
Jun 12 10:22:13.70: [ 4187]: REMOTE best vres 7.7 line/mm
Jun 12 10:22:13.70: [ 4187]: REMOTE format support: MH, MR
Jun 12 10:22:13.70: [ 4187]: REMOTE best 20 ms, 10 ms/scanline
Jun 12 10:22:13.70: [ 4187]: USE 9600 bit/s
Jun 12 10:22:13.70: [ 4187]: SEND file "docq/doc177.ps;40"
Jun 12 10:22:13.70: [ 4187]: USE A4 page width (215 mm)
Jun 12 10:22:13.70: [ 4187]: USE A4 page length (297 mm)
Jun 12 10:22:13.70: [ 4187]: USE 3.85 line/mm
Jun 12 10:22:13.70: [ 4187]: USE 2-D MR
Jun 12 10:22:13.70: [ 4187]: USE 20 ms/scanline
Jun 12 10:22:13.70: [ 4187]: SEND training at v.29 9600 bit/s
Jun 12 10:22:13.70: [ 4187]: <-- [9:AT+FRS=7\r]
Jun 12 10:22:13.82: [ 4187]: --> [2:OK]
Jun 12 10:22:13.82: [ 4187]: <-- [9:AT+FTH=3\r]
Jun 12 10:22:13.86: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:13.86: [ 4187]: <-- HDLC<23:FF C0 C2 CC CC AC 0C 6C 6C AC 4C 0C 1C 0C 8C 9C D4 04 04 04 04 04 04>
Jun 12 10:22:13.86: [ 4187]: <-- data [23]
Jun 12 10:22:13.86: [ 4187]: <-- data [2]
Jun 12 10:22:15.65: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:15.65: [ 4187]: <-- HDLC<6:FF C8 C1 00 60 00>
Jun 12 10:22:15.65: [ 4187]: <-- data [6]
Jun 12 10:22:15.65: [ 4187]: <-- data [2]
Jun 12 10:22:16.09: [ 4187]: --> [2:OK]
Jun 12 10:22:16.09: [ 4187]: <-- [9:AT+FTS=7\r]
Jun 12 10:22:16.18: [ 4187]: --> [2:OK]
Jun 12 10:22:16.18: [ 4187]: <-- [10:AT+FTM=96\r]
Jun 12 10:22:16.25: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:16.25: [ 4187]: <-- data [1024]
Jun 12 10:22:16.25: [ 4187]: <-- data [776]
Jun 12 10:22:16.25: [ 4187]: <-- data [2]
Jun 12 10:22:18.20: [ 4187]: --> [2:OK]
Jun 12 10:22:18.20: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:22:19.07: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:20.07: [ 4187]: --> HDLC<5:FF C8 21 57 BE>
Jun 12 10:22:20.07: [ 4187]: --> [2:OK]
Jun 12 10:22:20.07: [ 4187]: TRAINING succeeded
Jun 12 10:22:20.07: [ 4187]: <-- [9:AT+FRS=7\r]
Jun 12 10:22:20.18: [ 4187]: --> [2:OK]
Jun 12 10:22:20.18: [ 4187]: <-- [10:AT+FTM=96\r]
Jun 12 10:22:20.25: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:20.25: [ 4187]: SEND begin page
Jun 12 10:22:20.25: [ 4187]: <-- data [1030]
Jun 12 10:22:20.25: [ 4187]: <-- data [1024]
Jun 12 10:22:20.25: [ 4187]: <-- data [1024]
Jun 12 10:22:20.25: [ 4187]: <-- data [1025]
Jun 12 10:22:20.25: [ 4187]: <-- data [1026]
Jun 12 10:22:21.59: [ 4187]: <-- data [1047]
Jun 12 10:22:22.48: [ 4187]: <-- data [1061]
Jun 12 10:22:23.38: [ 4187]: <-- data [1051]
Jun 12 10:22:24.27: [ 4187]: <-- data [1047]
Jun 12 10:22:25.21: [ 4187]: <-- data [1039]
Jun 12 10:22:25.21: [ 4187]: <-- data [1037]
Jun 12 10:22:26.15: [ 4187]: <-- data [1037]
Jun 12 10:22:27.08: [ 4187]: <-- data [1027]
Jun 12 10:22:28.01: [ 4187]: <-- data [1028]
Jun 12 10:22:28.92: [ 4187]: <-- data [1031]
Jun 12 10:22:29.83: [ 4187]: <-- data [1031]
Jun 12 10:22:30.74: [ 4187]: <-- data [1029]
Jun 12 10:22:31.64: [ 4187]: <-- data [1026]
Jun 12 10:22:32.55: [ 4187]: <-- data [1027]
Jun 12 10:22:33.45: [ 4187]: <-- data [1037]
Jun 12 10:22:34.35: [ 4187]: <-- data [1031]
Jun 12 10:22:35.24: [ 4187]: <-- data [1031]
Jun 12 10:22:36.13: [ 4187]: <-- data [1031]
Jun 12 10:22:37.04: [ 4187]: <-- data [1030]
Jun 12 10:22:37.94: [ 4187]: <-- data [1026]
Jun 12 10:22:37.94: [ 4187]: <-- data [1029]
Jun 12 10:22:38.84: [ 4187]: <-- data [857]
Jun 12 10:22:39.74: [ 4187]: SENT 27476 bytes of data
Jun 12 10:22:39.74: [ 4187]: <-- data [1033]
Jun 12 10:22:40.64: [ 4187]: <-- data [1025]
Jun 12 10:22:41.53: [ 4187]: <-- data [1036]
Jun 12 10:22:42.44: [ 4187]: <-- data [1032]
Jun 12 10:22:43.34: [ 4187]: <-- data [1033]
Jun 12 10:22:44.24: [ 4187]: <-- data [1037]
Jun 12 10:22:45.15: [ 4187]: <-- data [1032]
Jun 12 10:22:46.05: [ 4187]: <-- data [1024]
Jun 12 10:22:46.97: [ 4187]: <-- data [1024]
Jun 12 10:22:47.87: [ 4187]: <-- data [1045]
Jun 12 10:22:48.78: [ 4187]: <-- data [1036]
Jun 12 10:22:49.67: [ 4187]: <-- data [1037]
Jun 12 10:22:50.57: [ 4187]: <-- data [1027]
Jun 12 10:22:51.50: [ 4187]: <-- data [1024]
Jun 12 10:22:51.50: [ 4187]: <-- data [110]
Jun 12 10:22:52.40: [ 4187]: SENT 14446 bytes of data
Jun 12 10:22:52.40: [ 4187]: SEND 2D RTC
Jun 12 10:22:52.40: [ 4187]: <-- data [30]
Jun 12 10:22:52.40: [ 4187]: <-- data [2]
Jun 12 10:22:52.40: [ 4187]: SEND end page
Jun 12 10:22:55.66: [ 4187]: --> [2:OK]
Jun 12 10:22:55.66: [ 4187]: <-- [9:AT+FTS=7\r]
Jun 12 10:22:55.75: [ 4187]: --> [2:OK]
Jun 12 10:22:55.75: [ 4187]: SEND send MPS (more pages, same document)
Jun 12 10:22:55.75: [ 4187]: <-- [9:AT+FTH=3\r]
Jun 12 10:22:55.79: [ 4187]: --> [7:CONNECT]
Jun 12 10:22:55.79: [ 4187]: <-- HDLC<3:FF C8 F2>
Jun 12 10:22:55.79: [ 4187]: <-- data [3]
Jun 12 10:22:55.79: [ 4187]: <-- data [2]
Jun 12 10:22:57.11: [ 4187]: --> [2:OK]
Jun 12 10:22:57.11: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:23:00.21: [ 4187]: --> [0:]
Jun 12 10:23:00.21: [ 4187]: MODEM <Empty line>
Jun 12 10:23:00.21: [ 4187]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 10:23:00.21: [ 4187]: <-- data [1]
Jun 12 10:23:00.27: [ 4187]: --> [2:OK]
Jun 12 10:23:00.27: [ 4187]: SEND send MPS (more pages, same document)
Jun 12 10:23:00.27: [ 4187]: <-- [9:AT+FTH=3\r]
Jun 12 10:23:00.31: [ 4187]: --> [7:CONNECT]
Jun 12 10:23:00.31: [ 4187]: <-- HDLC<3:FF C8 F2>
Jun 12 10:23:00.31: [ 4187]: <-- data [3]
Jun 12 10:23:00.31: [ 4187]: <-- data [2]
Jun 12 10:23:01.63: [ 4187]: --> [2:OK]
Jun 12 10:23:01.63: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:23:04.73: [ 4187]: --> [0:]
Jun 12 10:23:04.73: [ 4187]: MODEM <Empty line>
Jun 12 10:23:04.73: [ 4187]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 10:23:04.73: [ 4187]: <-- data [1]
Jun 12 10:23:04.79: [ 4187]: --> [2:OK]
Jun 12 10:23:04.79: [ 4187]: SEND send MPS (more pages, same document)
Jun 12 10:23:04.79: [ 4187]: <-- [9:AT+FTH=3\r]
Jun 12 10:23:04.83: [ 4187]: --> [7:CONNECT]
Jun 12 10:23:04.83: [ 4187]: <-- HDLC<3:FF C8 F2>
Jun 12 10:23:04.83: [ 4187]: <-- data [3]
Jun 12 10:23:04.83: [ 4187]: <-- data [2]
Jun 12 10:23:06.15: [ 4187]: --> [2:OK]
Jun 12 10:23:06.15: [ 4187]: <-- [9:AT+FRH=3\r]
Jun 12 10:23:09.25: [ 4187]: --> [0:]
Jun 12 10:23:09.25: [ 4187]: MODEM <Empty line>
Jun 12 10:23:09.25: [ 4187]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 10:23:09.25: [ 4187]: <-- data [1]
Jun 12 10:23:09.31: [ 4187]: --> [2:OK]
Jun 12 10:23:09.31: [ 4187]: No response to MPS repeated 3 tries
Jun 12 10:23:09.31: [ 4187]: SEND: No response to MPS repeated 3 tries; Giving up after 3 attempts to send same page "docq/doc177.ps;40", dirnum 0
Jun 12 10:23:09.31: [ 4187]: <-- [9:AT+FTH=3\r]
Jun 12 10:23:09.35: [ 4187]: --> [7:CONNECT]
Jun 12 10:23:09.35: [ 4187]: <-- HDLC<3:FF C8 DF>
Jun 12 10:23:09.35: [ 4187]: <-- data [3]
Jun 12 10:23:09.35: [ 4187]: <-- data [2]
Jun 12 10:23:10.67: [ 4187]: --> [2:OK]
Jun 12 10:23:10.67: [ 4187]: MODEM input buffering enabled
Jun 12 10:23:10.67: [ 4187]: <-- [5:ATH0\r]
Jun 12 10:23:11.42: [ 4187]: --> [2:OK]
Jun 12 10:23:11.42: [ 4187]: MODEM set DTR OFF
Jun 12 10:23:11.42: [ 4187]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jun 12 10:23:11.42: [ 4187]: SESSION END

Jun 12 11:50:23.40: [19520]: SESSION BEGIN 000000255 913612630200
Jun 12 11:50:23.40: [19520]: HylaFAX (tm) Version 4.3.0.2
Jun 12 11:50:23.40: [19520]: SEND FAX: JOB 90 DEST 03612630200 COMMID 000000255 DEVICE '/dev/ttyS0' FROM 'corpfin2 <isit@xxxxxxxxxxx>' USER isit
Jun 12 11:50:23.40: [19520]: STATE CHANGE: RUNNING -> SENDING
Jun 12 11:50:23.40: [19520]: <-- [12:AT+FCLASS=1\r]
Jun 12 11:50:23.42: [19520]: --> [2:OK]
Jun 12 11:50:23.43: [19520]: DIAL 03612630200
Jun 12 11:50:23.43: [19520]: <-- [16:ATDT03612630200\r]
Jun 12 11:50:44.33: [19520]: --> [7:CONNECT]
Jun 12 11:50:45.42: [19520]: --> HDLC<11:FF C0 04 61 02 02 FF 60 42 BE BB>
Jun 12 11:50:45.43: [19520]: --> [2:OK]
Jun 12 11:50:45.43: [19520]: REMOTE NSF "86 40 40 FF 06 42"
Jun 12 11:50:45.43: [19520]: NSF remote fax equipment: unknown 
Jun 12 11:50:45.43: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:50:45.45: [19520]: --> [7:CONNECT]
Jun 12 11:50:46.68: [19520]: --> HDLC<44:FF C0 04 61 02 02 73 0D 00 04 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 F4 77>
Jun 12 11:50:46.69: [19520]: --> [2:OK]
Jun 12 11:50:46.69: [19520]: REMOTE NSF "86 40 40 CE B0 00 20 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04"
Jun 12 11:50:46.69: [19520]: NSF remote fax equipment: unknown 
Jun 12 11:50:46.69: [19520]: NSF possible remote station ID: "                                "
Jun 12 11:50:46.69: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:50:46.71: [19520]: --> [7:CONNECT]
Jun 12 11:50:47.45: [19520]: --> HDLC<25:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 A4 F3>
Jun 12 11:50:47.46: [19520]: --> [2:OK]
Jun 12 11:50:47.46: [19520]: REMOTE CSI ""
Jun 12 11:50:47.46: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:50:47.48: [19520]: --> [7:CONNECT]
Jun 12 11:50:47.77: [19520]: --> HDLC<9:FF C8 01 00 F3 0D 00 7E 3D>
Jun 12 11:50:47.78: [19520]: --> [2:OK]
Jun 12 11:50:47.78: [19520]: REMOTE best rate 9600 bit/s
Jun 12 11:50:47.78: [19520]: REMOTE max A4 page width (215 mm)
Jun 12 11:50:47.78: [19520]: REMOTE max A4 page length (297 mm)
Jun 12 11:50:47.78: [19520]: REMOTE best vres 7.7 line/mm
Jun 12 11:50:47.78: [19520]: REMOTE format support: MH, MR
Jun 12 11:50:47.78: [19520]: REMOTE best 20 ms, 10 ms/scanline
Jun 12 11:50:47.78: [19520]: USE 9600 bit/s
Jun 12 11:50:47.78: [19520]: SEND file "docq/doc180.ps;40"
Jun 12 11:50:47.78: [19520]: USE A4 page width (215 mm)
Jun 12 11:50:47.78: [19520]: USE A4 page length (297 mm)
Jun 12 11:50:47.78: [19520]: USE 3.85 line/mm
Jun 12 11:50:47.78: [19520]: USE 2-D MR
Jun 12 11:50:47.78: [19520]: USE 20 ms/scanline
Jun 12 11:50:47.80: [19520]: SEND training at v.29 9600 bit/s
Jun 12 11:50:47.80: [19520]: <-- [9:AT+FRS=7\r]
Jun 12 11:50:47.92: [19520]: --> [2:OK]
Jun 12 11:50:47.92: [19520]: <-- [9:AT+FTH=3\r]
Jun 12 11:50:47.96: [19520]: --> [7:CONNECT]
Jun 12 11:50:47.96: [19520]: <-- HDLC<23:FF C0 C2 CC CC AC 0C 6C 6C AC 4C 0C 1C 0C 8C 9C D4 04 04 04 04 04 04>
Jun 12 11:50:47.96: [19520]: <-- data [23]
Jun 12 11:50:47.96: [19520]: <-- data [2]
Jun 12 11:50:49.75: [19520]: --> [7:CONNECT]
Jun 12 11:50:49.75: [19520]: <-- HDLC<6:FF C8 C1 00 60 00>
Jun 12 11:50:49.75: [19520]: <-- data [6]
Jun 12 11:50:49.75: [19520]: <-- data [2]
Jun 12 11:50:50.19: [19520]: --> [2:OK]
Jun 12 11:50:50.19: [19520]: <-- [9:AT+FTS=7\r]
Jun 12 11:50:50.28: [19520]: --> [2:OK]
Jun 12 11:50:50.28: [19520]: <-- [10:AT+FTM=96\r]
Jun 12 11:50:50.35: [19520]: --> [7:CONNECT]
Jun 12 11:50:50.35: [19520]: <-- data [1024]
Jun 12 11:50:50.35: [19520]: <-- data [776]
Jun 12 11:50:50.35: [19520]: <-- data [2]
Jun 12 11:50:52.30: [19520]: --> [2:OK]
Jun 12 11:50:52.30: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:50:53.22: [19520]: --> [7:CONNECT]
Jun 12 11:50:54.16: [19520]: --> HDLC<5:FF C8 21 57 BE>
Jun 12 11:50:54.17: [19520]: --> [2:OK]
Jun 12 11:50:54.17: [19520]: TRAINING succeeded
Jun 12 11:50:54.17: [19520]: <-- [9:AT+FRS=7\r]
Jun 12 11:50:54.29: [19520]: --> [2:OK]
Jun 12 11:50:54.29: [19520]: <-- [10:AT+FTM=96\r]
Jun 12 11:50:54.36: [19520]: --> [7:CONNECT]
Jun 12 11:50:54.36: [19520]: SEND begin page
Jun 12 11:50:54.39: [19520]: <-- data [1032]
Jun 12 11:50:54.39: [19520]: <-- data [1024]
Jun 12 11:50:54.39: [19520]: <-- data [1024]
Jun 12 11:50:54.39: [19520]: <-- data [1025]
Jun 12 11:50:54.39: [19520]: <-- data [1026]
Jun 12 11:50:55.79: [19520]: <-- data [1047]
Jun 12 11:50:56.69: [19520]: <-- data [1061]
Jun 12 11:50:57.58: [19520]: <-- data [1052]
Jun 12 11:50:57.58: [19520]: <-- data [1046]
Jun 12 11:50:58.48: [19520]: <-- data [1039]
Jun 12 11:50:59.42: [19520]: <-- data [1037]
Jun 12 11:51:00.36: [19520]: <-- data [1037]
Jun 12 11:51:01.29: [19520]: <-- data [1027]
Jun 12 11:51:02.21: [19520]: <-- data [1028]
Jun 12 11:51:03.13: [19520]: <-- data [1031]
Jun 12 11:51:04.04: [19520]: <-- data [1031]
Jun 12 11:51:04.94: [19520]: <-- data [1029]
Jun 12 11:51:05.84: [19520]: <-- data [1026]
Jun 12 11:51:06.75: [19520]: <-- data [1027]
Jun 12 11:51:07.65: [19520]: <-- data [1037]
Jun 12 11:51:08.55: [19520]: <-- data [1031]
Jun 12 11:51:09.44: [19520]: <-- data [1032]
Jun 12 11:51:10.34: [19520]: <-- data [1030]
Jun 12 11:51:10.34: [19520]: <-- data [1030]
Jun 12 11:51:11.26: [19520]: <-- data [1026]
Jun 12 11:51:12.17: [19520]: <-- data [1029]
Jun 12 11:51:13.08: [19520]: <-- data [850]
Jun 12 11:51:13.97: [19520]: SENT 27469 bytes of data
Jun 12 11:51:13.97: [19520]: <-- data [1033]
Jun 12 11:51:14.87: [19520]: <-- data [1025]
Jun 12 11:51:15.76: [19520]: <-- data [1036]
Jun 12 11:51:16.66: [19520]: <-- data [1032]
Jun 12 11:51:17.56: [19520]: <-- data [1033]
Jun 12 11:51:18.47: [19520]: <-- data [1037]
Jun 12 11:51:19.38: [19520]: <-- data [1032]
Jun 12 11:51:20.28: [19520]: <-- data [1024]
Jun 12 11:51:21.19: [19520]: <-- data [1024]
Jun 12 11:51:22.10: [19520]: <-- data [1045]
Jun 12 11:51:23.00: [19520]: <-- data [1036]
Jun 12 11:51:23.00: [19520]: <-- data [1037]
Jun 12 11:51:23.89: [19520]: <-- data [1027]
Jun 12 11:51:24.78: [19520]: <-- data [1024]
Jun 12 11:51:25.71: [19520]: <-- data [110]
Jun 12 11:51:25.71: [19520]: SENT 14446 bytes of data
Jun 12 11:51:25.71: [19520]: SEND 2D RTC
Jun 12 11:51:25.71: [19520]: <-- data [30]
Jun 12 11:51:25.71: [19520]: <-- data [2]
Jun 12 11:51:25.71: [19520]: SEND end page
Jun 12 11:51:29.76: [19520]: --> [2:OK]
Jun 12 11:51:29.76: [19520]: <-- [9:AT+FTS=9\r]
Jun 12 11:51:29.87: [19520]: --> [2:OK]
Jun 12 11:51:29.87: [19520]: SEND send EOP (no more pages or documents)
Jun 12 11:51:29.87: [19520]: <-- [9:AT+FTH=3\r]
Jun 12 11:51:29.91: [19520]: --> [7:CONNECT]
Jun 12 11:51:29.91: [19520]: <-- HDLC<3:FF C8 F4>
Jun 12 11:51:29.91: [19520]: <-- data [3]
Jun 12 11:51:29.91: [19520]: <-- data [2]
Jun 12 11:51:31.23: [19520]: --> [2:OK]
Jun 12 11:51:31.23: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:51:34.33: [19520]: --> [0:]
Jun 12 11:51:34.33: [19520]: MODEM <Empty line>
Jun 12 11:51:34.33: [19520]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:51:34.33: [19520]: <-- data [1]
Jun 12 11:51:34.39: [19520]: --> [2:OK]
Jun 12 11:51:34.39: [19520]: SEND send EOP (no more pages or documents)
Jun 12 11:51:34.39: [19520]: <-- [9:AT+FTH=3\r]
Jun 12 11:51:34.43: [19520]: --> [7:CONNECT]
Jun 12 11:51:34.43: [19520]: <-- HDLC<3:FF C8 F4>
Jun 12 11:51:34.43: [19520]: <-- data [3]
Jun 12 11:51:34.43: [19520]: <-- data [2]
Jun 12 11:51:35.75: [19520]: --> [2:OK]
Jun 12 11:51:35.75: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:51:38.85: [19520]: --> [0:]
Jun 12 11:51:38.85: [19520]: MODEM <Empty line>
Jun 12 11:51:38.85: [19520]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:51:38.85: [19520]: <-- data [1]
Jun 12 11:51:38.91: [19520]: --> [2:OK]
Jun 12 11:51:38.91: [19520]: SEND send EOP (no more pages or documents)
Jun 12 11:51:38.91: [19520]: <-- [9:AT+FTH=3\r]
Jun 12 11:51:38.95: [19520]: --> [7:CONNECT]
Jun 12 11:51:38.95: [19520]: <-- HDLC<3:FF C8 F4>
Jun 12 11:51:38.95: [19520]: <-- data [3]
Jun 12 11:51:38.95: [19520]: <-- data [2]
Jun 12 11:51:40.27: [19520]: --> [2:OK]
Jun 12 11:51:40.27: [19520]: <-- [9:AT+FRH=3\r]
Jun 12 11:51:43.37: [19520]: --> [0:]
Jun 12 11:51:43.37: [19520]: MODEM <Empty line>
Jun 12 11:51:43.37: [19520]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:51:43.37: [19520]: <-- data [1]
Jun 12 11:51:43.57: [19520]: MODEM TIMEOUT: reading line from modem
Jun 12 11:51:43.57: [19520]: MODEM <Timeout>
Jun 12 11:51:43.57: [19520]: No response to EOP repeated 3 tries
Jun 12 11:51:43.57: [19520]: <-- [9:AT+FTH=3\r]
Jun 12 11:51:47.91: [19520]: --> [2:OK]
Jun 12 11:51:47.91: [19520]: MODEM input buffering enabled
Jun 12 11:51:47.91: [19520]: <-- [5:ATH0\r]
Jun 12 11:51:48.66: [19520]: --> [2:OK]
Jun 12 11:51:48.66: [19520]: MODEM set DTR OFF
Jun 12 11:51:48.66: [19520]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jun 12 11:51:48.66: [19520]: SESSION END

Jun 12 11:52:54.41: [19545]: SESSION BEGIN 000000256 913612630200
Jun 12 11:52:54.41: [19545]: HylaFAX (tm) Version 4.3.0.2
Jun 12 11:52:54.41: [19545]: SEND FAX: JOB 90 DEST 03612630200 COMMID 000000256 DEVICE '/dev/ttyS0' FROM 'corpfin2 <isit@xxxxxxxxxxx>' USER isit
Jun 12 11:52:54.41: [19545]: STATE CHANGE: RUNNING -> SENDING
Jun 12 11:52:54.41: [19545]: <-- [12:AT+FCLASS=1\r]
Jun 12 11:52:54.43: [19545]: --> [2:OK]
Jun 12 11:52:54.43: [19545]: DIAL 03612630200
Jun 12 11:52:54.43: [19545]: <-- [16:ATDT03612630200\r]
Jun 12 11:53:16.98: [19545]: --> [7:CONNECT]
Jun 12 11:53:18.08: [19545]: --> HDLC<11:FF C0 04 61 02 02 FF 60 42 BE BB>
Jun 12 11:53:18.08: [19545]: --> [2:OK]
Jun 12 11:53:18.08: [19545]: REMOTE NSF "86 40 40 FF 06 42"
Jun 12 11:53:18.08: [19545]: NSF remote fax equipment: unknown 
Jun 12 11:53:18.08: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:53:18.10: [19545]: --> [7:CONNECT]
Jun 12 11:53:19.33: [19545]: --> HDLC<44:FF C0 04 61 02 02 73 0D 00 04 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 F4 77>
Jun 12 11:53:19.34: [19545]: --> [2:OK]
Jun 12 11:53:19.34: [19545]: REMOTE NSF "86 40 40 CE B0 00 20 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04"
Jun 12 11:53:19.34: [19545]: NSF remote fax equipment: unknown 
Jun 12 11:53:19.34: [19545]: NSF possible remote station ID: "                                "
Jun 12 11:53:19.34: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:53:19.36: [19545]: --> [7:CONNECT]
Jun 12 11:53:20.10: [19545]: --> HDLC<25:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 A4 F3>
Jun 12 11:53:20.11: [19545]: --> [2:OK]
Jun 12 11:53:20.11: [19545]: REMOTE CSI ""
Jun 12 11:53:20.11: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:53:20.13: [19545]: --> [7:CONNECT]
Jun 12 11:53:20.42: [19545]: --> HDLC<9:FF C8 01 00 F3 0D 00 7E 3D>
Jun 12 11:53:20.43: [19545]: --> [2:OK]
Jun 12 11:53:20.43: [19545]: REMOTE best rate 9600 bit/s
Jun 12 11:53:20.43: [19545]: REMOTE max A4 page width (215 mm)
Jun 12 11:53:20.43: [19545]: REMOTE max A4 page length (297 mm)
Jun 12 11:53:20.43: [19545]: REMOTE best vres 7.7 line/mm
Jun 12 11:53:20.43: [19545]: REMOTE format support: MH, MR
Jun 12 11:53:20.43: [19545]: REMOTE best 20 ms, 10 ms/scanline
Jun 12 11:53:20.43: [19545]: USE 9600 bit/s
Jun 12 11:53:20.43: [19545]: SEND file "docq/doc180.ps;40"
Jun 12 11:53:20.43: [19545]: USE A4 page width (215 mm)
Jun 12 11:53:20.43: [19545]: USE A4 page length (297 mm)
Jun 12 11:53:20.43: [19545]: USE 3.85 line/mm
Jun 12 11:53:20.43: [19545]: USE 2-D MR
Jun 12 11:53:20.43: [19545]: USE 20 ms/scanline
Jun 12 11:53:20.43: [19545]: SEND training at v.29 9600 bit/s
Jun 12 11:53:20.43: [19545]: <-- [9:AT+FRS=7\r]
Jun 12 11:53:20.55: [19545]: --> [2:OK]
Jun 12 11:53:20.55: [19545]: <-- [9:AT+FTH=3\r]
Jun 12 11:53:20.59: [19545]: --> [7:CONNECT]
Jun 12 11:53:20.59: [19545]: <-- HDLC<23:FF C0 C2 CC CC AC 0C 6C 6C AC 4C 0C 1C 0C 8C 9C D4 04 04 04 04 04 04>
Jun 12 11:53:20.59: [19545]: <-- data [23]
Jun 12 11:53:20.59: [19545]: <-- data [2]
Jun 12 11:53:22.38: [19545]: --> [7:CONNECT]
Jun 12 11:53:22.38: [19545]: <-- HDLC<6:FF C8 C1 00 60 00>
Jun 12 11:53:22.38: [19545]: <-- data [6]
Jun 12 11:53:22.38: [19545]: <-- data [2]
Jun 12 11:53:22.81: [19545]: --> [2:OK]
Jun 12 11:53:22.81: [19545]: <-- [9:AT+FTS=7\r]
Jun 12 11:53:22.90: [19545]: --> [2:OK]
Jun 12 11:53:22.90: [19545]: <-- [10:AT+FTM=96\r]
Jun 12 11:53:22.97: [19545]: --> [7:CONNECT]
Jun 12 11:53:22.97: [19545]: <-- data [1024]
Jun 12 11:53:22.97: [19545]: <-- data [776]
Jun 12 11:53:22.97: [19545]: <-- data [2]
Jun 12 11:53:24.92: [19545]: --> [2:OK]
Jun 12 11:53:24.92: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:53:25.84: [19545]: --> [7:CONNECT]
Jun 12 11:53:26.78: [19545]: --> HDLC<5:FF C8 21 57 BE>
Jun 12 11:53:26.79: [19545]: --> [2:OK]
Jun 12 11:53:26.79: [19545]: TRAINING succeeded
Jun 12 11:53:26.79: [19545]: <-- [9:AT+FRS=7\r]
Jun 12 11:53:26.91: [19545]: --> [2:OK]
Jun 12 11:53:26.91: [19545]: <-- [10:AT+FTM=96\r]
Jun 12 11:53:26.98: [19545]: --> [7:CONNECT]
Jun 12 11:53:26.98: [19545]: SEND begin page
Jun 12 11:53:26.98: [19545]: <-- data [1031]
Jun 12 11:53:26.98: [19545]: <-- data [1024]
Jun 12 11:53:26.98: [19545]: <-- data [1024]
Jun 12 11:53:26.98: [19545]: <-- data [1025]
Jun 12 11:53:26.98: [19545]: <-- data [1026]
Jun 12 11:53:28.32: [19545]: <-- data [1047]
Jun 12 11:53:29.21: [19545]: <-- data [1061]
Jun 12 11:53:30.11: [19545]: <-- data [1052]
Jun 12 11:53:31.00: [19545]: <-- data [1046]
Jun 12 11:53:31.93: [19545]: <-- data [1039]
Jun 12 11:53:31.93: [19545]: <-- data [1037]
Jun 12 11:53:32.88: [19545]: <-- data [1037]
Jun 12 11:53:33.81: [19545]: <-- data [1027]
Jun 12 11:53:34.74: [19545]: <-- data [1028]
Jun 12 11:53:35.65: [19545]: <-- data [1031]
Jun 12 11:53:36.56: [19545]: <-- data [1031]
Jun 12 11:53:37.47: [19545]: <-- data [1029]
Jun 12 11:53:38.37: [19545]: <-- data [1026]
Jun 12 11:53:39.27: [19545]: <-- data [1027]
Jun 12 11:53:40.17: [19545]: <-- data [1037]
Jun 12 11:53:41.08: [19545]: <-- data [1031]
Jun 12 11:53:41.97: [19545]: <-- data [1032]
Jun 12 11:53:42.86: [19545]: <-- data [1030]
Jun 12 11:53:43.77: [19545]: <-- data [1030]
Jun 12 11:53:44.67: [19545]: <-- data [1026]
Jun 12 11:53:44.67: [19545]: <-- data [1029]
Jun 12 11:53:45.57: [19545]: <-- data [850]
Jun 12 11:53:46.47: [19545]: SENT 27469 bytes of data
Jun 12 11:53:46.47: [19545]: <-- data [1033]
Jun 12 11:53:47.37: [19545]: <-- data [1025]
Jun 12 11:53:48.26: [19545]: <-- data [1036]
Jun 12 11:53:49.16: [19545]: <-- data [1032]
Jun 12 11:53:50.06: [19545]: <-- data [1033]
Jun 12 11:53:50.97: [19545]: <-- data [1037]
Jun 12 11:53:51.88: [19545]: <-- data [1032]
Jun 12 11:53:52.78: [19545]: <-- data [1024]
Jun 12 11:53:53.69: [19545]: <-- data [1024]
Jun 12 11:53:54.60: [19545]: <-- data [1045]
Jun 12 11:53:55.50: [19545]: <-- data [1036]
Jun 12 11:53:56.39: [19545]: <-- data [1037]
Jun 12 11:53:57.28: [19545]: <-- data [1027]
Jun 12 11:53:58.21: [19545]: <-- data [1024]
Jun 12 11:53:58.21: [19545]: <-- data [110]
Jun 12 11:53:59.12: [19545]: SENT 14446 bytes of data
Jun 12 11:53:59.12: [19545]: SEND 2D RTC
Jun 12 11:53:59.12: [19545]: <-- data [30]
Jun 12 11:53:59.12: [19545]: <-- data [2]
Jun 12 11:53:59.12: [19545]: SEND end page
Jun 12 11:54:02.38: [19545]: --> [2:OK]
Jun 12 11:54:02.38: [19545]: <-- [9:AT+FTS=9\r]
Jun 12 11:54:02.49: [19545]: --> [2:OK]
Jun 12 11:54:02.49: [19545]: SEND send EOP (no more pages or documents)
Jun 12 11:54:02.49: [19545]: <-- [9:AT+FTH=3\r]
Jun 12 11:54:02.53: [19545]: --> [7:CONNECT]
Jun 12 11:54:02.53: [19545]: <-- HDLC<3:FF C8 F4>
Jun 12 11:54:02.53: [19545]: <-- data [3]
Jun 12 11:54:02.53: [19545]: <-- data [2]
Jun 12 11:54:03.85: [19545]: --> [2:OK]
Jun 12 11:54:03.85: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:54:06.95: [19545]: --> [0:]
Jun 12 11:54:06.95: [19545]: MODEM <Empty line>
Jun 12 11:54:06.95: [19545]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:54:06.95: [19545]: <-- data [1]
Jun 12 11:54:07.01: [19545]: --> [2:OK]
Jun 12 11:54:07.01: [19545]: SEND send EOP (no more pages or documents)
Jun 12 11:54:07.01: [19545]: <-- [9:AT+FTH=3\r]
Jun 12 11:54:07.05: [19545]: --> [7:CONNECT]
Jun 12 11:54:07.05: [19545]: <-- HDLC<3:FF C8 F4>
Jun 12 11:54:07.05: [19545]: <-- data [3]
Jun 12 11:54:07.05: [19545]: <-- data [2]
Jun 12 11:54:08.37: [19545]: --> [2:OK]
Jun 12 11:54:08.37: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:54:11.47: [19545]: --> [0:]
Jun 12 11:54:11.47: [19545]: MODEM <Empty line>
Jun 12 11:54:11.47: [19545]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:54:11.47: [19545]: <-- data [1]
Jun 12 11:54:11.53: [19545]: --> [2:OK]
Jun 12 11:54:11.53: [19545]: SEND send EOP (no more pages or documents)
Jun 12 11:54:11.53: [19545]: <-- [9:AT+FTH=3\r]
Jun 12 11:54:11.57: [19545]: --> [7:CONNECT]
Jun 12 11:54:11.57: [19545]: <-- HDLC<3:FF C8 F4>
Jun 12 11:54:11.57: [19545]: <-- data [3]
Jun 12 11:54:11.57: [19545]: <-- data [2]
Jun 12 11:54:12.89: [19545]: --> [2:OK]
Jun 12 11:54:12.89: [19545]: <-- [9:AT+FRH=3\r]
Jun 12 11:54:15.99: [19545]: --> [0:]
Jun 12 11:54:15.99: [19545]: MODEM <Empty line>
Jun 12 11:54:15.99: [19545]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:54:15.99: [19545]: <-- data [1]
Jun 12 11:54:16.05: [19545]: --> [2:OK]
Jun 12 11:54:16.05: [19545]: No response to EOP repeated 3 tries
Jun 12 11:54:16.05: [19545]: <-- [9:AT+FTH=3\r]
Jun 12 11:54:16.09: [19545]: --> [7:CONNECT]
Jun 12 11:54:16.09: [19545]: <-- HDLC<3:FF C8 DF>
Jun 12 11:54:16.09: [19545]: <-- data [3]
Jun 12 11:54:16.09: [19545]: <-- data [2]
Jun 12 11:54:17.41: [19545]: --> [2:OK]
Jun 12 11:54:17.41: [19545]: MODEM input buffering enabled
Jun 12 11:54:17.41: [19545]: <-- [5:ATH0\r]
Jun 12 11:54:18.16: [19545]: --> [2:OK]
Jun 12 11:54:18.16: [19545]: MODEM set DTR OFF
Jun 12 11:54:18.16: [19545]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jun 12 11:54:18.16: [19545]: SESSION END

Jun 12 11:55:26.88: [19557]: SESSION BEGIN 000000257 913612630200
Jun 12 11:55:26.88: [19557]: HylaFAX (tm) Version 4.3.0.2
Jun 12 11:55:26.88: [19557]: SEND FAX: JOB 90 DEST 03612630200 COMMID 000000257 DEVICE '/dev/ttyS0' FROM 'corpfin2 <isit@xxxxxxxxxxx>' USER isit
Jun 12 11:55:26.88: [19557]: STATE CHANGE: RUNNING -> SENDING
Jun 12 11:55:26.88: [19557]: <-- [12:AT+FCLASS=1\r]
Jun 12 11:55:26.90: [19557]: --> [2:OK]
Jun 12 11:55:27.50: [19557]: DIAL 03612630200
Jun 12 11:55:27.50: [19557]: <-- [16:ATDT03612630200\r]
Jun 12 11:55:48.28: [19557]: --> [7:CONNECT]
Jun 12 11:55:49.39: [19557]: --> HDLC<11:FF C0 04 61 02 02 FF 60 42 BE BB>
Jun 12 11:55:49.39: [19557]: --> [2:OK]
Jun 12 11:55:49.39: [19557]: REMOTE NSF "86 40 40 FF 06 42"
Jun 12 11:55:49.39: [19557]: NSF remote fax equipment: unknown 
Jun 12 11:55:49.39: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:55:49.41: [19557]: --> [7:CONNECT]
Jun 12 11:55:50.64: [19557]: --> HDLC<44:FF C0 04 61 02 02 73 0D 00 04 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 20 F4 77>
Jun 12 11:55:50.64: [19557]: --> [2:OK]
Jun 12 11:55:50.64: [19557]: REMOTE NSF "86 40 40 CE B0 00 20 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04"
Jun 12 11:55:50.64: [19557]: NSF remote fax equipment: unknown 
Jun 12 11:55:50.64: [19557]: NSF possible remote station ID: "                                "
Jun 12 11:55:50.64: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:55:50.66: [19557]: --> [7:CONNECT]
Jun 12 11:55:51.41: [19557]: --> HDLC<25:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 A4 F3>
Jun 12 11:55:51.42: [19557]: --> [2:OK]
Jun 12 11:55:51.42: [19557]: REMOTE CSI ""
Jun 12 11:55:51.42: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:55:51.44: [19557]: --> [7:CONNECT]
Jun 12 11:55:51.73: [19557]: --> HDLC<9:FF C8 01 00 F3 0D 00 7E 3D>
Jun 12 11:55:51.74: [19557]: --> [2:OK]
Jun 12 11:55:51.74: [19557]: REMOTE best rate 9600 bit/s
Jun 12 11:55:51.74: [19557]: REMOTE max A4 page width (215 mm)
Jun 12 11:55:51.74: [19557]: REMOTE max A4 page length (297 mm)
Jun 12 11:55:51.74: [19557]: REMOTE best vres 7.7 line/mm
Jun 12 11:55:51.74: [19557]: REMOTE format support: MH, MR
Jun 12 11:55:51.74: [19557]: REMOTE best 20 ms, 10 ms/scanline
Jun 12 11:55:51.74: [19557]: USE 9600 bit/s
Jun 12 11:55:51.74: [19557]: SEND file "docq/doc180.ps;40"
Jun 12 11:55:51.74: [19557]: USE A4 page width (215 mm)
Jun 12 11:55:51.74: [19557]: USE A4 page length (297 mm)
Jun 12 11:55:51.74: [19557]: USE 3.85 line/mm
Jun 12 11:55:51.74: [19557]: USE 2-D MR
Jun 12 11:55:51.74: [19557]: USE 20 ms/scanline
Jun 12 11:55:51.74: [19557]: SEND training at v.29 9600 bit/s
Jun 12 11:55:51.74: [19557]: <-- [9:AT+FRS=7\r]
Jun 12 11:55:51.85: [19557]: --> [2:OK]
Jun 12 11:55:51.85: [19557]: <-- [9:AT+FTH=3\r]
Jun 12 11:55:51.89: [19557]: --> [7:CONNECT]
Jun 12 11:55:51.89: [19557]: <-- HDLC<23:FF C0 C2 CC CC AC 0C 6C 6C AC 4C 0C 1C 0C 8C 9C D4 04 04 04 04 04 04>
Jun 12 11:55:51.89: [19557]: <-- data [23]
Jun 12 11:55:51.89: [19557]: <-- data [2]
Jun 12 11:55:53.68: [19557]: --> [7:CONNECT]
Jun 12 11:55:53.68: [19557]: <-- HDLC<6:FF C8 C1 00 60 00>
Jun 12 11:55:53.68: [19557]: <-- data [6]
Jun 12 11:55:53.68: [19557]: <-- data [2]
Jun 12 11:55:54.11: [19557]: --> [2:OK]
Jun 12 11:55:54.11: [19557]: <-- [9:AT+FTS=7\r]
Jun 12 11:55:54.20: [19557]: --> [2:OK]
Jun 12 11:55:54.20: [19557]: <-- [10:AT+FTM=96\r]
Jun 12 11:55:54.27: [19557]: --> [7:CONNECT]
Jun 12 11:55:54.27: [19557]: <-- data [1024]
Jun 12 11:55:54.27: [19557]: <-- data [776]
Jun 12 11:55:54.27: [19557]: <-- data [2]
Jun 12 11:55:56.22: [19557]: --> [2:OK]
Jun 12 11:55:56.22: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:55:57.14: [19557]: --> [7:CONNECT]
Jun 12 11:55:58.08: [19557]: --> HDLC<5:FF C8 21 57 BE>
Jun 12 11:55:58.09: [19557]: --> [2:OK]
Jun 12 11:55:58.09: [19557]: TRAINING succeeded
Jun 12 11:55:58.09: [19557]: <-- [9:AT+FRS=7\r]
Jun 12 11:55:58.20: [19557]: --> [2:OK]
Jun 12 11:55:58.20: [19557]: <-- [10:AT+FTM=96\r]
Jun 12 11:55:58.27: [19557]: --> [7:CONNECT]
Jun 12 11:55:58.27: [19557]: SEND begin page
Jun 12 11:55:58.27: [19557]: <-- data [1030]
Jun 12 11:55:58.27: [19557]: <-- data [1024]
Jun 12 11:55:58.27: [19557]: <-- data [1024]
Jun 12 11:55:58.27: [19557]: <-- data [1025]
Jun 12 11:55:58.27: [19557]: <-- data [1026]
Jun 12 11:55:59.61: [19557]: <-- data [1047]
Jun 12 11:56:00.51: [19557]: <-- data [1061]
Jun 12 11:56:01.40: [19557]: <-- data [1053]
Jun 12 11:56:02.29: [19557]: <-- data [1045]
Jun 12 11:56:03.23: [19557]: <-- data [1039]
Jun 12 11:56:03.23: [19557]: <-- data [1037]
Jun 12 11:56:04.17: [19557]: <-- data [1037]
Jun 12 11:56:05.10: [19557]: <-- data [1027]
Jun 12 11:56:06.03: [19557]: <-- data [1028]
Jun 12 11:56:06.94: [19557]: <-- data [1031]
Jun 12 11:56:07.85: [19557]: <-- data [1031]
Jun 12 11:56:08.76: [19557]: <-- data [1029]
Jun 12 11:56:09.67: [19557]: <-- data [1026]
Jun 12 11:56:10.57: [19557]: <-- data [1027]
Jun 12 11:56:11.47: [19557]: <-- data [1037]
Jun 12 11:56:12.37: [19557]: <-- data [1032]
Jun 12 11:56:13.26: [19557]: <-- data [1031]
Jun 12 11:56:14.15: [19557]: <-- data [1030]
Jun 12 11:56:15.06: [19557]: <-- data [1030]
Jun 12 11:56:15.96: [19557]: <-- data [1026]
Jun 12 11:56:15.96: [19557]: <-- data [1029]
Jun 12 11:56:16.86: [19557]: <-- data [845]
Jun 12 11:56:17.76: [19557]: SENT 27464 bytes of data
Jun 12 11:56:17.76: [19557]: <-- data [1033]
Jun 12 11:56:18.66: [19557]: <-- data [1025]
Jun 12 11:56:19.56: [19557]: <-- data [1036]
Jun 12 11:56:20.46: [19557]: <-- data [1032]
Jun 12 11:56:21.36: [19557]: <-- data [1033]
Jun 12 11:56:22.26: [19557]: <-- data [1037]
Jun 12 11:56:23.17: [19557]: <-- data [1032]
Jun 12 11:56:24.07: [19557]: <-- data [1024]
Jun 12 11:56:24.98: [19557]: <-- data [1024]
Jun 12 11:56:25.89: [19557]: <-- data [1045]
Jun 12 11:56:26.79: [19557]: <-- data [1036]
Jun 12 11:56:27.68: [19557]: <-- data [1037]
Jun 12 11:56:28.58: [19557]: <-- data [1027]
Jun 12 11:56:29.50: [19557]: <-- data [1024]
Jun 12 11:56:29.50: [19557]: <-- data [110]
Jun 12 11:56:30.41: [19557]: SENT 14446 bytes of data
Jun 12 11:56:30.41: [19557]: SEND 2D RTC
Jun 12 11:56:30.41: [19557]: <-- data [30]
Jun 12 11:56:30.41: [19557]: <-- data [2]
Jun 12 11:56:30.41: [19557]: SEND end page
Jun 12 11:56:33.67: [19557]: --> [2:OK]
Jun 12 11:56:33.67: [19557]: <-- [9:AT+FTS=9\r]
Jun 12 11:56:33.78: [19557]: --> [2:OK]
Jun 12 11:56:33.78: [19557]: SEND send EOP (no more pages or documents)
Jun 12 11:56:33.78: [19557]: <-- [9:AT+FTH=3\r]
Jun 12 11:56:33.82: [19557]: --> [7:CONNECT]
Jun 12 11:56:33.82: [19557]: <-- HDLC<3:FF C8 F4>
Jun 12 11:56:33.82: [19557]: <-- data [3]
Jun 12 11:56:33.82: [19557]: <-- data [2]
Jun 12 11:56:35.14: [19557]: --> [2:OK]
Jun 12 11:56:35.14: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:56:38.24: [19557]: --> [0:]
Jun 12 11:56:38.24: [19557]: MODEM <Empty line>
Jun 12 11:56:38.24: [19557]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:56:38.24: [19557]: <-- data [1]
Jun 12 11:56:38.30: [19557]: --> [2:OK]
Jun 12 11:56:38.30: [19557]: SEND send EOP (no more pages or documents)
Jun 12 11:56:38.30: [19557]: <-- [9:AT+FTH=3\r]
Jun 12 11:56:38.34: [19557]: --> [7:CONNECT]
Jun 12 11:56:38.34: [19557]: <-- HDLC<3:FF C8 F4>
Jun 12 11:56:38.34: [19557]: <-- data [3]
Jun 12 11:56:38.34: [19557]: <-- data [2]
Jun 12 11:56:39.66: [19557]: --> [2:OK]
Jun 12 11:56:39.66: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:56:42.76: [19557]: --> [0:]
Jun 12 11:56:42.76: [19557]: MODEM <Empty line>
Jun 12 11:56:42.76: [19557]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:56:42.76: [19557]: <-- data [1]
Jun 12 11:56:42.82: [19557]: --> [2:OK]
Jun 12 11:56:42.82: [19557]: SEND send EOP (no more pages or documents)
Jun 12 11:56:42.82: [19557]: <-- [9:AT+FTH=3\r]
Jun 12 11:56:42.86: [19557]: --> [7:CONNECT]
Jun 12 11:56:42.86: [19557]: <-- HDLC<3:FF C8 F4>
Jun 12 11:56:42.86: [19557]: <-- data [3]
Jun 12 11:56:42.86: [19557]: <-- data [2]
Jun 12 11:56:44.18: [19557]: --> [2:OK]
Jun 12 11:56:44.18: [19557]: <-- [9:AT+FRH=3\r]
Jun 12 11:56:47.28: [19557]: --> [0:]
Jun 12 11:56:47.28: [19557]: MODEM <Empty line>
Jun 12 11:56:47.28: [19557]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 12 11:56:47.28: [19557]: <-- data [1]
Jun 12 11:56:47.34: [19557]: --> [2:OK]
Jun 12 11:56:47.34: [19557]: No response to EOP repeated 3 tries
Jun 12 11:56:47.34: [19557]: SEND: No response to EOP repeated 3 tries; Giving up after 3 attempts to send same page "docq/doc180.ps;40", dirnum 0
Jun 12 11:56:47.34: [19557]: <-- [9:AT+FTH=3\r]
Jun 12 11:56:47.38: [19557]: --> [7:CONNECT]
Jun 12 11:56:47.38: [19557]: <-- HDLC<3:FF C8 DF>
Jun 12 11:56:47.38: [19557]: <-- data [3]
Jun 12 11:56:47.38: [19557]: <-- data [2]
Jun 12 11:56:48.70: [19557]: --> [2:OK]
Jun 12 11:56:48.70: [19557]: MODEM input buffering enabled
Jun 12 11:56:48.70: [19557]: <-- [5:ATH0\r]
Jun 12 11:56:49.45: [19557]: --> [2:OK]
Jun 12 11:56:49.45: [19557]: MODEM set DTR OFF
Jun 12 11:56:49.45: [19557]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jun 12 11:56:49.45: [19557]: SESSION END