TIMEOUTs and ERRORs after EOP.

[vwelch@icebox.bmsc.com (Victor Welchman)]

I'm getting timeouts in the middle of a transmission and errors after the
final EOP.  I'm using a hayes-accura 28.8 modem with an SGI Indy.  I changed
the following things in my config file:

added commands ATS36=0 and ATS7=180 to avoid timeouts.
Used CLOCAL as root.
Reduced the restrictions to allow erroneous pages to pass through.

Even with the restrictions reduced I still get errors.  Anyone know how this
particular log file could result?

Jun 30 10:50:51.77: [ 2274]: SESSION BEGIN 00000014 17707344601
Jun 30 10:50:51.77: [ 2274]: SEND FAX: JOB 11 DEST 17707344601 COMMID 00000014
Jun 30 10:50:51.77: [ 2274]: MODEM set DTR OFF
Jun 30 10:50:51.77: [ 2274]: MODEM set baud rate: 0 baud (flow control unchanged)
Jun 30 10:50:51.78: [ 2274]: DELAY 2600 ms
Jun 30 10:50:54.37: [ 2274]: MODEM set DTR ON
Jun 30 10:50:54.38: [ 2274]: MODEM set baud rate: 2400 baud, input flow XON/XOFF, output flow XON/XOFF
Jun 30 10:50:54.38: [ 2274]: MODEM flush i/o
Jun 30 10:50:54.38: [ 2274]: <-- [20:ATS36=0E0V1Q0S0=0H0\r]
Jun 30 10:50:54.65: [ 2274]: --> [2:OK]
Jun 30 10:50:54.65: [ 2274]: <-- [22:ATS8=2S7=180&K4&D2&C1\r]
Jun 30 10:50:59.65: [ 2274]: MODEM TIMEOUT: reading line from modem
Jun 30 10:50:59.65: [ 2274]: MODEM <Timeout>
Jun 30 10:50:59.66: [ 2274]: <-- [7:ATL3M1\r]
Jun 30 10:50:59.84: [ 2274]: --> [2:OK]
Jun 30 10:50:59.84: [ 2274]: STATE CHANGE: RUNNING -> SENDING
Jun 30 10:50:59.84: [ 2274]: MODEM input buffering enabled
Jun 30 10:50:59.85: [ 2274]: Apply DialString rules to "17707344601"
Jun 30 10:50:59.85: [ 2274]: --> return result "17707344601"
Jun 30 10:50:59.85: [ 2274]: <-- [12:AT+FCLASS=1\r]
Jun 30 10:51:00.13: [ 2274]: --> [2:OK]
Jun 30 10:51:00.13: [ 2274]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled
Jun 30 10:51:00.14: [ 2274]: DIAL 17707344601
Jun 30 10:51:00.14: [ 2274]: <-- [16:ATDT17707344601\r]
Jun 30 10:51:18.29: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:18.29: [ 2274]: MODEM input buffering disabled
Jun 30 10:51:19.90: [ 2274]: --> HDLC<21:FF C0 04 00 00 A4 00 00 00 48 0A B0 42 00 02 00 54 8E 00 A2 78>
Jun 30 10:51:19.90: [ 2274]: --> [2:OK]
Jun 30 10:51:19.90: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:51:20.00: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:20.68: [ 2274]: --> HDLC<28:FF C0 04 00 00 A4 80 2A 0A AA CA 04 12 C2 A2 2A 04 32 82 C2 92 2A C2 82 4A 0A 02 E2>
Jun 30 10:51:20.68: [ 2274]: --> [2:OK]
Jun 30 10:51:20.68: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:51:20.78: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:21.38: [ 2274]: --> HDLC<25:FF C0 02 04 04 04 04 04 04 04 04 8C 0C 6C 2C 04 2C CC EC 04 0C EC EC 03 BF>
Jun 30 10:51:21.38: [ 2274]: --> [2:OK]
Jun 30 10:51:21.38: [ 2274]: REMOTE CSI "770 734 4601"
Jun 30 10:51:21.38: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:51:21.48: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:21.66: [ 2274]: --> HDLC<9:FF C8 01 00 73 17 20 8D BD>
Jun 30 10:51:21.66: [ 2274]: --> [2:OK]
Jun 30 10:51:21.66: [ 2274]: REMOTE best rate 9600 bit/s
Jun 30 10:51:21.66: [ 2274]: REMOTE max page width 1728 pixels in 215 mm
Jun 30 10:51:21.66: [ 2274]: REMOTE max unlimited page length 
Jun 30 10:51:21.66: [ 2274]: REMOTE best vres 7.7 line/mm
Jun 30 10:51:21.66: [ 2274]: REMOTE best format 2-D MR
Jun 30 10:51:21.66: [ 2274]: REMOTE supports T.30 Annex A, ECM
Jun 30 10:51:21.66: [ 2274]: REMOTE best 10 ms, 5 ms/scanline
Jun 30 10:51:21.66: [ 2274]: USE 9600 bit/s
Jun 30 10:51:21.66: [ 2274]: USE 10 ms, 5 ms/scanline
Jun 30 10:51:21.66: [ 2274]: SEND file "docq/doc11.ps;30"
Jun 30 10:51:21.66: [ 2274]: USE page width 1728 pixels in 215 mm
Jun 30 10:51:21.66: [ 2274]: USE unlimited page length 
Jun 30 10:51:21.66: [ 2274]: USE 3.85 line/mm
Jun 30 10:51:21.66: [ 2274]: USE 1-D MR
Jun 30 10:51:21.66: [ 2274]: SEND training at v.29 9600 bit/s
Jun 30 10:51:21.66: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:51:22.71: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:22.71: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:51:22.71: [ 2274]: <-- data [23]
Jun 30 10:51:22.72: [ 2274]: <-- data [2]
Jun 30 10:51:23.60: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:23.60: [ 2274]: <-- HDLC<6:FF C8 C1 00 60 14>
Jun 30 10:51:23.60: [ 2274]: <-- data [6]
Jun 30 10:51:23.60: [ 2274]: <-- data [2]
Jun 30 10:51:24.01: [ 2274]: --> [2:OK]
Jun 30 10:51:24.01: [ 2274]: DELAY 75 ms
Jun 30 10:51:24.08: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:51:24.09: [ 2274]: <-- [10:AT+FTM=96\r]
Jun 30 10:51:24.45: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:24.45: [ 2274]: <-- data [1024]
Jun 30 10:51:24.45: [ 2274]: <-- data [776]
Jun 30 10:51:24.45: [ 2274]: <-- data [2]
Jun 30 10:51:32.03: [ 2274]: --> [2:OK]
Jun 30 10:51:32.03: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:51:32.03: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:51:35.12: [ 2274]: --> [0:]
Jun 30 10:51:35.12: [ 2274]: MODEM <Empty line>
Jun 30 10:51:35.12: [ 2274]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 30 10:51:35.12: [ 2274]: <-- data [1]
Jun 30 10:51:35.17: [ 2274]: --> [2:OK]
Jun 30 10:51:35.17: [ 2274]: DELAY 1500 ms
Jun 30 10:51:36.66: [ 2274]: SEND training at v.29 9600 bit/s
Jun 30 10:51:36.66: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:51:37.72: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:37.72: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:51:37.72: [ 2274]: <-- data [23]
Jun 30 10:51:37.72: [ 2274]: <-- data [2]
Jun 30 10:51:38.61: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:38.61: [ 2274]: <-- HDLC<6:FF C8 C1 00 60 14>
Jun 30 10:51:38.61: [ 2274]: <-- data [6]
Jun 30 10:51:38.61: [ 2274]: <-- data [2]
Jun 30 10:51:39.02: [ 2274]: --> [2:OK]
Jun 30 10:51:39.02: [ 2274]: DELAY 75 ms
Jun 30 10:51:39.09: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:51:39.09: [ 2274]: <-- [10:AT+FTM=96\r]
Jun 30 10:51:39.45: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:39.46: [ 2274]: <-- data [1024]
Jun 30 10:51:39.46: [ 2274]: <-- data [776]
Jun 30 10:51:39.46: [ 2274]: <-- data [2]
Jun 30 10:51:47.04: [ 2274]: --> [2:OK]
Jun 30 10:51:47.04: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:51:47.04: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:51:50.13: [ 2274]: --> [0:]
Jun 30 10:51:50.13: [ 2274]: MODEM <Empty line>
Jun 30 10:51:50.13: [ 2274]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 30 10:51:50.13: [ 2274]: <-- data [1]
Jun 30 10:51:50.18: [ 2274]: --> [2:OK]
Jun 30 10:51:50.18: [ 2274]: DELAY 1500 ms
Jun 30 10:51:51.67: [ 2274]: SEND training at v.29 7200 bit/s
Jun 30 10:51:51.67: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:51:52.72: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:52.72: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:51:52.72: [ 2274]: <-- data [23]
Jun 30 10:51:52.72: [ 2274]: <-- data [2]
Jun 30 10:51:53.60: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:53.60: [ 2274]: <-- HDLC<6:FF C8 C1 00 70 14>
Jun 30 10:51:53.60: [ 2274]: <-- data [6]
Jun 30 10:51:53.60: [ 2274]: <-- data [2]
Jun 30 10:51:54.01: [ 2274]: --> [2:OK]
Jun 30 10:51:54.01: [ 2274]: DELAY 75 ms
Jun 30 10:51:54.09: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:51:54.09: [ 2274]: <-- [10:AT+FTM=72\r]
Jun 30 10:51:54.45: [ 2274]: --> [7:CONNECT]
Jun 30 10:51:54.45: [ 2274]: <-- data [1024]
Jun 30 10:51:54.45: [ 2274]: <-- data [326]
Jun 30 10:51:54.45: [ 2274]: <-- data [2]
Jun 30 10:52:00.16: [ 2274]: --> [2:OK]
Jun 30 10:52:00.16: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:52:00.16: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:52:03.25: [ 2274]: --> [0:]
Jun 30 10:52:03.25: [ 2274]: MODEM <Empty line>
Jun 30 10:52:03.25: [ 2274]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 30 10:52:03.25: [ 2274]: <-- data [1]
Jun 30 10:52:03.30: [ 2274]: --> [2:OK]
Jun 30 10:52:03.30: [ 2274]: DELAY 1500 ms
Jun 30 10:52:04.79: [ 2274]: SEND training at v.29 7200 bit/s
Jun 30 10:52:04.79: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:52:05.82: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:05.82: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:52:05.82: [ 2274]: <-- data [23]
Jun 30 10:52:05.82: [ 2274]: <-- data [2]
Jun 30 10:52:06.71: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:06.71: [ 2274]: <-- HDLC<6:FF C8 C1 00 70 14>
Jun 30 10:52:06.71: [ 2274]: <-- data [6]
Jun 30 10:52:06.71: [ 2274]: <-- data [2]
Jun 30 10:52:07.12: [ 2274]: --> [2:OK]
Jun 30 10:52:07.12: [ 2274]: DELAY 75 ms
Jun 30 10:52:07.20: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:52:07.20: [ 2274]: <-- [10:AT+FTM=72\r]
Jun 30 10:52:07.56: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:07.56: [ 2274]: <-- data [1024]
Jun 30 10:52:07.56: [ 2274]: <-- data [326]
Jun 30 10:52:07.56: [ 2274]: <-- data [2]
Jun 30 10:52:13.27: [ 2274]: --> [2:OK]
Jun 30 10:52:13.27: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:52:13.27: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:52:16.36: [ 2274]: --> [0:]
Jun 30 10:52:16.36: [ 2274]: MODEM <Empty line>
Jun 30 10:52:16.36: [ 2274]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 30 10:52:16.36: [ 2274]: <-- data [1]
Jun 30 10:52:16.41: [ 2274]: --> [2:OK]
Jun 30 10:52:16.41: [ 2274]: DELAY 1500 ms
Jun 30 10:52:17.90: [ 2274]: SEND training at v.27ter 4800 bit/s
Jun 30 10:52:17.90: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:52:18.92: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:18.92: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:52:18.92: [ 2274]: <-- data [23]
Jun 30 10:52:18.92: [ 2274]: <-- data [2]
Jun 30 10:52:19.82: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:19.82: [ 2274]: <-- HDLC<6:FF C8 C1 00 50 14>
Jun 30 10:52:19.82: [ 2274]: <-- data [6]
Jun 30 10:52:19.82: [ 2274]: <-- data [2]
Jun 30 10:52:20.23: [ 2274]: --> [2:OK]
Jun 30 10:52:20.24: [ 2274]: DELAY 75 ms
Jun 30 10:52:20.31: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:52:20.31: [ 2274]: <-- [10:AT+FTM=48\r]
Jun 30 10:52:21.35: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:21.35: [ 2274]: <-- data [900]
Jun 30 10:52:21.35: [ 2274]: <-- data [2]
Jun 30 10:52:25.18: [ 2274]: --> [2:OK]
Jun 30 10:52:25.18: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:52:25.18: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:52:28.28: [ 2274]: --> [0:]
Jun 30 10:52:28.28: [ 2274]: MODEM <Empty line>
Jun 30 10:52:28.28: [ 2274]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 30 10:52:28.28: [ 2274]: <-- data [1]
Jun 30 10:52:28.33: [ 2274]: --> [2:OK]
Jun 30 10:52:28.33: [ 2274]: DELAY 1500 ms
Jun 30 10:52:29.82: [ 2274]: SEND training at v.27ter 4800 bit/s
Jun 30 10:52:29.82: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:52:30.92: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:30.92: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:52:30.92: [ 2274]: <-- data [23]
Jun 30 10:52:30.92: [ 2274]: <-- data [2]
Jun 30 10:52:31.81: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:31.81: [ 2274]: <-- HDLC<6:FF C8 C1 00 50 14>
Jun 30 10:52:31.81: [ 2274]: <-- data [6]
Jun 30 10:52:31.81: [ 2274]: <-- data [2]
Jun 30 10:52:32.23: [ 2274]: --> [2:OK]
Jun 30 10:52:32.23: [ 2274]: DELAY 75 ms
Jun 30 10:52:32.30: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:52:32.30: [ 2274]: <-- [10:AT+FTM=48\r]
Jun 30 10:52:33.34: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:33.34: [ 2274]: <-- data [900]
Jun 30 10:52:33.34: [ 2274]: <-- data [2]
Jun 30 10:52:37.18: [ 2274]: --> [2:OK]
Jun 30 10:52:37.18: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:52:37.18: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:52:40.27: [ 2274]: --> [0:]
Jun 30 10:52:40.27: [ 2274]: MODEM <Empty line>
Jun 30 10:52:40.27: [ 2274]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 30 10:52:40.27: [ 2274]: <-- data [1]
Jun 30 10:52:40.27: [ 2274]: MODEM TIMEOUT: writing to modem
Jun 30 10:52:40.32: [ 2274]: --> [2:OK]
Jun 30 10:52:40.32: [ 2274]: DELAY 1500 ms
Jun 30 10:52:41.82: [ 2274]: SEND training at v.27ter fallback mode 2400 bit/s
Jun 30 10:52:41.82: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:52:42.92: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:42.92: [ 2274]: <-- HDLC<23:FF C0 C2 0E AE 2E A6 CA E6 76 96 16 2E F6 72 04 04 04 04 04 04 04 04>
Jun 30 10:52:42.93: [ 2274]: <-- data [23]
Jun 30 10:52:42.93: [ 2274]: <-- data [2]
Jun 30 10:52:43.81: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:43.81: [ 2274]: <-- HDLC<6:FF C8 C1 00 40 14>
Jun 30 10:52:43.81: [ 2274]: <-- data [6]
Jun 30 10:52:43.81: [ 2274]: <-- data [2]
Jun 30 10:52:44.22: [ 2274]: --> [2:OK]
Jun 30 10:52:44.22: [ 2274]: DELAY 75 ms
Jun 30 10:52:44.30: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:52:44.30: [ 2274]: <-- [10:AT+FTM=24\r]
Jun 30 10:52:45.57: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:45.57: [ 2274]: <-- data [450]
Jun 30 10:52:45.57: [ 2274]: <-- data [2]
Jun 30 10:52:47.53: [ 2274]: --> [2:OK]
Jun 30 10:52:47.53: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:52:47.53: [ 2274]: <-- [9:AT+FRH=3\r]
Jun 30 10:52:47.84: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:49.11: [ 2274]: --> HDLC<5:FF C8 21 57 BE>
Jun 30 10:52:49.11: [ 2274]: --> [2:OK]
Jun 30 10:52:49.11: [ 2274]: TRAINING succeeded
Jun 30 10:52:49.11: [ 2274]: <-- [10:AT+FTM=24\r]
Jun 30 10:52:50.38: [ 2274]: --> [7:CONNECT]
Jun 30 10:52:50.38: [ 2274]: SEND begin page
Jun 30 10:52:50.38: [ 2274]: MODEM set XON/XOFF/FLUSH: input interpreted, output disabled
Jun 30 10:52:50.39: [ 2274]: <-- data [1026]
Jun 30 10:52:50.39: [ 2274]: <-- data [1029]
Jun 30 10:52:50.39: [ 2274]: <-- data [1026]
Jun 30 10:52:50.39: [ 2274]: <-- data [153]
Jun 30 10:52:50.39: [ 2274]: SENT 3224 bytes of data
Jun 30 10:52:50.39: [ 2274]: <-- data [1028]
Jun 30 10:52:50.39: [ 2274]: <-- data [1026]
Jun 30 10:52:58.28: [ 2274]: <-- data [1027]
Jun 30 10:52:58.28: [ 2274]: <-- data [132]
Jun 30 10:53:06.59: [ 2274]: SENT 3204 bytes of data
Jun 30 10:53:06.59: [ 2274]: <-- data [1032]
Jun 30 10:53:06.59: [ 2274]: <-- data [1028]
Jun 30 10:53:14.49: [ 2274]: <-- data [1029]
Jun 30 10:53:14.49: [ 2274]: <-- data [120]
Jun 30 10:53:14.49: [ 2274]: SENT 3192 bytes of data
Jun 30 10:53:14.49: [ 2274]: <-- data [1030]
Jun 30 10:53:22.35: [ 2274]: <-- data [1029]
Jun 30 10:53:22.35: [ 2274]: <-- data [379]
Jun 30 10:53:22.36: [ 2274]: SENT 2426 bytes of data
Jun 30 10:53:22.36: [ 2274]: SEND 1D RTC
Jun 30 10:53:22.36: [ 2274]: <-- data [29]
Jun 30 10:53:30.42: [ 2274]: <-- data [2]
Jun 30 10:53:30.42: [ 2274]: SEND end page
Jun 30 10:53:30.42: [ 2274]: --> [2:OK]
Jun 30 10:53:30.42: [ 2274]: MODEM set XON/XOFF/DRAIN: input ignored, output disabled
Jun 30 10:53:40.78: [ 2274]: DELAY 95 ms
Jun 30 10:53:40.87: [ 2274]: SEND send EOP (no more pages or documents)
Jun 30 10:53:40.87: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:53:40.88: [ 2274]: --> [3:000]
Jun 30 10:53:40.88: [ 2274]: SEND send EOP (no more pages or documents)
Jun 30 10:53:40.88: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:53:40.88: [ 2274]: --> [5:ERROR]
Jun 30 10:53:40.88: [ 2274]: SEND send EOP (no more pages or documents)
Jun 30 10:53:40.88: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:53:40.88: [ 2274]: --> [5:ERROR]
Jun 30 10:53:40.88: [ 2274]: <-- [9:AT+FTH=3\r]
Jun 30 10:53:40.88: [ 2274]: --> [5:ERROR]
Jun 30 10:53:40.88: [ 2274]: MODEM input buffering enabled
Jun 30 10:53:40.88: [ 2274]: <-- [5:ATH0\r]
Jun 30 10:53:40.88: [ 2274]: --> [5:ERROR]
Jun 30 10:53:40.88: [ 2274]: MODEM Command error
Jun 30 10:53:40.88: [ 2274]: MODEM set DTR OFF
Jun 30 10:53:40.88: [ 2274]: MODEM set baud rate: 0 baud (flow control unchanged)
Jun 30 10:53:40.88: [ 2274]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jun 30 10:53:40.88: [ 2274]: SESSION END