Re: [hylafax-users] Hylafax cannot receive faxes

[Ján Koštial <jan.kostial@xxxxxxxxxx>]

I am sending new logs with "SessionTracing: 0xFFF".

Jan Kostial



-----Original Message-----
From: Lee Howard [mailto:faxguy@xxxxxxxxxxxxxxxx] 
Sent: Friday, June 22, 2007 12:39 AM
To: Ján Koštial
Cc: hylafax-users@xxxxxxxxxxx
Subject: Re: [hylafax-users] Hylafax cannot receive faxes

Ján Koštial wrote:

>Hi,
>I have installed Hylafax on new Fedora7 (modem ZyXEL omni56K Plus).
>I receive fax from another Hylafax on Fedora Core 5 (modem Motorola?) with
>error. Can anyone help me? Thanks.
>

Thank you for providing both the sender and receiver logs.  
Unfortunately in this case the logging is not detailed enough to say 
what is going on.

Please set "SessionTracing: 0xFFF" in the modem configuration files on 
both the sender and receiver and then try again and send those logs.

Thanks,

Lee.

Jun 22 08:25:01.54: [10397]: SESSION BEGIN 000004289 421445623384
Jun 22 08:25:01.54: [10397]: HylaFAX (tm) Version 4.3.0
Jun 22 08:25:01.54: [10397]: SEND FAX: JOB 761 DEST 5623384 COMMID 000004289 DEVICE '/dev/ttyS0' FROM 'datarix <datarix@xxxxxxxxxxxxxxxxxxxx>' USER datarix
Jun 22 08:25:01.54: [10397]: STATE CHANGE: RUNNING -> SENDING
Jun 22 08:25:01.54: [10397]: <-- [12:AT+FCLASS=1\r]
Jun 22 08:25:01.56: [10397]: --> [2:OK]
Jun 22 08:25:01.56: [10397]: DIAL 5623384
Jun 22 08:25:01.56: [10397]: <-- [14:ATX3DT5623384\r]
Jun 22 08:25:13.68: [10397]: --> [7:CONNECT]
Jun 22 08:25:15.42: [10397]: --> HDLC<34:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 CC 74 CC DA 7F>
Jun 22 08:25:15.43: [10397]: --> [2:OK]
Jun 22 08:25:15.43: [10397]: REMOTE NSF "AD 00 55 48 79 6C 61 46 41 58 20 28 74 6D 29 20 56 65 72 73 69 6F 6E 20 34 2E 33 2E 33"
Jun 22 08:25:15.43: [10397]: NSF remote fax equipment: HylaFAX 
Jun 22 08:25:15.43: [10397]: NSF remote station ID: "HylaFAX (tm) Version 4.3.3"
Jun 22 08:25:15.43: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:15.45: [10397]: --> [7:CONNECT]
Jun 22 08:25:16.43: [10397]: --> HDLC<25:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04 92 8C>
Jun 22 08:25:16.44: [10397]: --> [2:OK]
Jun 22 08:25:16.44: [10397]: REMOTE CSI "DATARIX"
Jun 22 08:25:16.44: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:16.46: [10397]: --> [7:CONNECT]
Jun 22 08:25:17.18: [10397]: --> HDLC<15:FF C8 01 00 77 5F 23 01 FB C1 01 01 18 0C 8E>
Jun 22 08:25:17.19: [10397]: --> [2:OK]
Jun 22 08:25:17.19: [10397]: REMOTE best rate 14400 bit/s
Jun 22 08:25:17.19: [10397]: REMOTE max A3 page width (303 mm)
Jun 22 08:25:17.19: [10397]: REMOTE max unlimited page length
Jun 22 08:25:17.19: [10397]: REMOTE best vres R16 x 15.4 line/mm
Jun 22 08:25:17.19: [10397]: REMOTE format support: MH, MR, MMR
Jun 22 08:25:17.19: [10397]: REMOTE supports T.30 Annex A, 256-byte ECM
Jun 22 08:25:17.19: [10397]: REMOTE best 0 ms/scanline
Jun 22 08:25:17.19: [10397]: USE 14400 bit/s
Jun 22 08:25:17.19: [10397]: USE error correction mode
Jun 22 08:25:17.19: [10397]: SEND file "docq/doc1034.pdf;c1"
Jun 22 08:25:17.19: [10397]: USE A4 page width (215 mm)
Jun 22 08:25:17.19: [10397]: USE unlimited page length
Jun 22 08:25:17.19: [10397]: USE 7.7 line/mm
Jun 22 08:25:17.19: [10397]: USE 2-D MMR
Jun 22 08:25:17.19: [10397]: USE 0 ms/scanline
Jun 22 08:25:17.19: [10397]: SEND training at v.17 14400 bit/s
Jun 22 08:25:17.19: [10397]: <-- [9:AT+FRS=7\r]
Jun 22 08:25:17.32: [10397]: --> [2:OK]
Jun 22 08:25:17.32: [10397]: <-- [9:AT+FTH=3\r]
Jun 22 08:25:17.37: [10397]: --> [7:CONNECT]
Jun 22 08:25:17.37: [10397]: <-- HDLC<23:FF C0 C2 4E A6 6E 4E A6 CA 1E 86 62 B4 74 2A 74 4A 74 D2 04 04 04 04>
Jun 22 08:25:17.37: [10397]: <-- data [23]
Jun 22 08:25:17.37: [10397]: <-- data [2]
Jun 22 08:25:19.16: [10397]: --> [7:CONNECT]
Jun 22 08:25:19.16: [10397]: <-- HDLC<7:FF C8 C1 00 46 1F 22>
Jun 22 08:25:19.16: [10397]: <-- data [7]
Jun 22 08:25:19.16: [10397]: <-- data [2]
Jun 22 08:25:19.62: [10397]: --> [2:OK]
Jun 22 08:25:19.62: [10397]: <-- [9:AT+FTS=7\r]
Jun 22 08:25:19.71: [10397]: --> [2:OK]
Jun 22 08:25:19.71: [10397]: <-- [11:AT+FTM=145\r]
Jun 22 08:25:19.75: [10397]: --> [7:CONNECT]
Jun 22 08:25:19.75: [10397]: <-- data [1024]
Jun 22 08:25:19.75: [10397]: <-- data [1024]
Jun 22 08:25:19.75: [10397]: <-- data [652]
Jun 22 08:25:19.75: [10397]: <-- data [2]
Jun 22 08:25:22.87: [10397]: --> [2:OK]
Jun 22 08:25:22.87: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:23.30: [10397]: --> [7:CONNECT]
Jun 22 08:25:24.11: [10397]: --> HDLC<25:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04 92 8C>
Jun 22 08:25:24.12: [10397]: --> [2:OK]
Jun 22 08:25:24.12: [10397]: REMOTE CSI "DATARIX"
Jun 22 08:25:24.12: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:24.14: [10397]: --> [7:CONNECT]
Jun 22 08:25:24.86: [10397]: --> HDLC<15:FF C8 01 00 77 5F 23 01 FB C1 01 01 18 0C 8E>
Jun 22 08:25:24.86: [10397]: --> [2:OK]
Jun 22 08:25:24.86: [10397]: SEND training at v.17 14400 bit/s
Jun 22 08:25:24.86: [10397]: <-- [9:AT+FRS=7\r]
Jun 22 08:25:24.98: [10397]: --> [2:OK]
Jun 22 08:25:24.98: [10397]: <-- [9:AT+FTH=3\r]
Jun 22 08:25:25.03: [10397]: --> [7:CONNECT]
Jun 22 08:25:25.03: [10397]: <-- HDLC<23:FF C0 C2 4E A6 6E 4E A6 CA 1E 86 62 B4 74 2A 74 4A 74 D2 04 04 04 04>
Jun 22 08:25:25.03: [10397]: <-- data [23]
Jun 22 08:25:25.03: [10397]: <-- data [2]
Jun 22 08:25:26.82: [10397]: --> [7:CONNECT]
Jun 22 08:25:26.82: [10397]: <-- HDLC<7:FF C8 C1 00 46 1F 22>
Jun 22 08:25:26.82: [10397]: <-- data [7]
Jun 22 08:25:26.82: [10397]: <-- data [2]
Jun 22 08:25:27.28: [10397]: --> [2:OK]
Jun 22 08:25:27.28: [10397]: <-- [9:AT+FTS=7\r]
Jun 22 08:25:27.37: [10397]: --> [2:OK]
Jun 22 08:25:27.37: [10397]: <-- [11:AT+FTM=145\r]
Jun 22 08:25:27.41: [10397]: --> [7:CONNECT]
Jun 22 08:25:27.41: [10397]: <-- data [1024]
Jun 22 08:25:27.41: [10397]: <-- data [1024]
Jun 22 08:25:27.41: [10397]: <-- data [652]
Jun 22 08:25:27.41: [10397]: <-- data [2]
Jun 22 08:25:30.53: [10397]: --> [2:OK]
Jun 22 08:25:30.53: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:30.95: [10397]: --> [7:CONNECT]
Jun 22 08:25:31.79: [10397]: --> HDLC<25:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04 92 8C>
Jun 22 08:25:31.79: [10397]: --> [2:OK]
Jun 22 08:25:31.79: [10397]: REMOTE CSI "DATARIX"
Jun 22 08:25:31.79: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:31.81: [10397]: --> [7:CONNECT]
Jun 22 08:25:32.51: [10397]: --> HDLC<15:FF C8 01 00 77 5F 23 01 FB C1 01 01 18 0C 8E>
Jun 22 08:25:32.51: [10397]: --> [2:OK]
Jun 22 08:25:32.51: [10397]: SEND training at v.17 14400 bit/s
Jun 22 08:25:32.51: [10397]: <-- [9:AT+FRS=7\r]
Jun 22 08:25:32.63: [10397]: --> [2:OK]
Jun 22 08:25:32.63: [10397]: <-- [9:AT+FTH=3\r]
Jun 22 08:25:32.69: [10397]: --> [7:CONNECT]
Jun 22 08:25:32.69: [10397]: <-- HDLC<23:FF C0 C2 4E A6 6E 4E A6 CA 1E 86 62 B4 74 2A 74 4A 74 D2 04 04 04 04>
Jun 22 08:25:32.69: [10397]: <-- data [23]
Jun 22 08:25:32.69: [10397]: <-- data [2]
Jun 22 08:25:34.47: [10397]: --> [7:CONNECT]
Jun 22 08:25:34.47: [10397]: <-- HDLC<7:FF C8 C1 00 46 1F 22>
Jun 22 08:25:34.47: [10397]: <-- data [7]
Jun 22 08:25:34.47: [10397]: <-- data [2]
Jun 22 08:25:34.93: [10397]: --> [2:OK]
Jun 22 08:25:34.93: [10397]: <-- [9:AT+FTS=7\r]
Jun 22 08:25:35.02: [10397]: --> [2:OK]
Jun 22 08:25:35.02: [10397]: <-- [11:AT+FTM=145\r]
Jun 22 08:25:35.06: [10397]: --> [7:CONNECT]
Jun 22 08:25:35.06: [10397]: <-- data [1024]
Jun 22 08:25:35.06: [10397]: <-- data [1024]
Jun 22 08:25:35.06: [10397]: <-- data [652]
Jun 22 08:25:35.06: [10397]: <-- data [2]
Jun 22 08:25:38.17: [10397]: --> [2:OK]
Jun 22 08:25:38.17: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:38.63: [10397]: --> [7:CONNECT]
Jun 22 08:25:39.44: [10397]: --> HDLC<25:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04 92 8C>
Jun 22 08:25:39.44: [10397]: --> [2:OK]
Jun 22 08:25:39.44: [10397]: REMOTE CSI "DATARIX"
Jun 22 08:25:39.44: [10397]: <-- [9:AT+FRH=3\r]
Jun 22 08:25:39.46: [10397]: --> [7:CONNECT]
Jun 22 08:25:40.18: [10397]: --> HDLC<15:FF C8 01 00 77 5F 23 01 FB C1 01 01 18 0C 8E>
Jun 22 08:25:40.19: [10397]: --> [2:OK]
Jun 22 08:25:40.19: [10397]: DIS/DTC received 3 times; DCS not recognized
Jun 22 08:25:40.19: [10397]: <-- [9:AT+FTH=3\r]
Jun 22 08:25:40.25: [10397]: --> [7:CONNECT]
Jun 22 08:25:40.25: [10397]: <-- HDLC<3:FF C8 DF>
Jun 22 08:25:40.25: [10397]: <-- data [3]
Jun 22 08:25:40.25: [10397]: <-- data [2]
Jun 22 08:25:41.56: [10397]: --> [2:OK]
Jun 22 08:25:41.56: [10397]: MODEM input buffering enabled
Jun 22 08:25:41.56: [10397]: <-- [5:ATH0\r]
Jun 22 08:25:42.28: [10397]: --> [2:OK]
Jun 22 08:25:42.28: [10397]: MODEM set DTR OFF
Jun 22 08:25:42.28: [10397]: STATE CHANGE: SENDING -> MODEMWAIT (timeout 5)
Jun 22 08:25:42.28: [10397]: SESSION END

Jun 22 07:59:03.61: [12170]: SESSION BEGIN 000000008 421445623384
Jun 22 07:59:03.61: [12170]: HylaFAX (tm) Version 4.3.3
Jun 22 07:59:03.61: [12170]: MODEM set XON/XOFF/FLUSH: input ignored, output disabled
Jun 22 07:59:03.61: [12170]: <-- [4:ATA\r]
Jun 22 07:59:10.28: [12170]: --> [7:CONNECT]
Jun 22 07:59:10.28: [12170]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyS0'
Jun 22 07:59:10.28: [12170]: STATE CHANGE: ANSWERING -> RECEIVING
Jun 22 07:59:10.28: [12170]: RECV FAX: begin
Jun 22 07:59:10.28: [12170]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 CC 74 CC>
Jun 22 07:59:10.28: [12170]: <-- data [32]
Jun 22 07:59:10.28: [12170]: <-- data [2]
Jun 22 07:59:11.54: [12170]: --> [7:CONNECT]
Jun 22 07:59:11.54: [12170]: <-- HDLC<23:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04>
Jun 22 07:59:11.54: [12170]: <-- data [23]
Jun 22 07:59:11.54: [12170]: <-- data [2]
Jun 22 07:59:12.56: [12170]: --> [7:CONNECT]
Jun 22 07:59:12.56: [12170]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Jun 22 07:59:12.56: [12170]: <-- data [13]
Jun 22 07:59:12.56: [12170]: <-- data [2]
Jun 22 07:59:13.05: [12170]: --> [2:OK]
Jun 22 07:59:13.05: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:13.58: [12170]: --> [7:CONNECT]
Jun 22 07:59:15.03: [12170]: --> HDLC<23:FF C0 C2 4E A6 6E 4E A6 CA 1E 86 62 B4 74 2A 74 4A 74 D2 04 04 04 04>
Jun 22 07:59:15.03: [12170]: --> [2:OK]
Jun 22 07:59:15.03: [12170]: REMOTE TSI "K.R.T.-FaxServer"
Jun 22 07:59:15.03: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:15.07: [12170]: --> [7:CONNECT]
Jun 22 07:59:15.43: [12170]: --> HDLC<7:FF C8 C1 00 46 1F 22>
Jun 22 07:59:15.43: [12170]: --> [2:OK]
Jun 22 07:59:15.43: [12170]: DELAY 1500 ms
Jun 22 07:59:16.93: [12170]: <-- [9:AT+FTH=3\r]
Jun 22 07:59:17.97: [12170]: --> [7:CONNECT]
Jun 22 07:59:17.97: [12170]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 CC 74 CC>
Jun 22 07:59:17.97: [12170]: <-- data [32]
Jun 22 07:59:17.97: [12170]: <-- data [2]
Jun 22 07:59:19.22: [12170]: --> [7:CONNECT]
Jun 22 07:59:19.22: [12170]: <-- HDLC<23:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04>
Jun 22 07:59:19.22: [12170]: <-- data [23]
Jun 22 07:59:19.22: [12170]: <-- data [2]
Jun 22 07:59:20.24: [12170]: --> [7:CONNECT]
Jun 22 07:59:20.24: [12170]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Jun 22 07:59:20.24: [12170]: <-- data [13]
Jun 22 07:59:20.24: [12170]: <-- data [2]
Jun 22 07:59:20.73: [12170]: --> [2:OK]
Jun 22 07:59:20.73: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:21.18: [12170]: --> [7:CONNECT]
Jun 22 07:59:22.68: [12170]: --> HDLC<23:FF C0 C2 4E A6 6E 4E A6 CA 1E 86 62 B4 74 2A 74 4A 74 D2 04 04 04 04>
Jun 22 07:59:22.68: [12170]: --> [2:OK]
Jun 22 07:59:22.68: [12170]: REMOTE TSI "K.R.T.-FaxServer"
Jun 22 07:59:22.68: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:22.72: [12170]: --> [7:CONNECT]
Jun 22 07:59:23.08: [12170]: --> HDLC<7:FF C8 C1 00 46 1F 22>
Jun 22 07:59:23.08: [12170]: --> [2:OK]
Jun 22 07:59:23.08: [12170]: DELAY 1500 ms
Jun 22 07:59:24.58: [12170]: <-- [9:AT+FTH=3\r]
Jun 22 07:59:25.62: [12170]: --> [7:CONNECT]
Jun 22 07:59:25.62: [12170]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 CC 74 CC>
Jun 22 07:59:25.62: [12170]: <-- data [32]
Jun 22 07:59:25.62: [12170]: <-- data [2]
Jun 22 07:59:26.88: [12170]: --> [7:CONNECT]
Jun 22 07:59:26.88: [12170]: <-- HDLC<23:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04>
Jun 22 07:59:26.88: [12170]: <-- data [23]
Jun 22 07:59:26.88: [12170]: <-- data [2]
Jun 22 07:59:27.90: [12170]: --> [7:CONNECT]
Jun 22 07:59:27.90: [12170]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Jun 22 07:59:27.90: [12170]: <-- data [13]
Jun 22 07:59:27.90: [12170]: <-- data [2]
Jun 22 07:59:28.39: [12170]: --> [2:OK]
Jun 22 07:59:28.39: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:28.84: [12170]: --> [7:CONNECT]
Jun 22 07:59:30.34: [12170]: --> HDLC<23:FF C0 C2 4E A6 6E 4E A6 CA 1E 86 62 B4 74 2A 74 4A 74 D2 04 04 04 04>
Jun 22 07:59:30.34: [12170]: --> [2:OK]
Jun 22 07:59:30.34: [12170]: REMOTE TSI "K.R.T.-FaxServer"
Jun 22 07:59:30.34: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:30.38: [12170]: --> [7:CONNECT]
Jun 22 07:59:30.74: [12170]: --> HDLC<7:FF C8 C1 00 46 1F 22>
Jun 22 07:59:30.74: [12170]: --> [2:OK]
Jun 22 07:59:30.74: [12170]: DELAY 1500 ms
Jun 22 07:59:32.24: [12170]: <-- [9:AT+FTH=3\r]
Jun 22 07:59:33.28: [12170]: --> [7:CONNECT]
Jun 22 07:59:33.28: [12170]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 CC 74 CC>
Jun 22 07:59:33.28: [12170]: <-- data [32]
Jun 22 07:59:33.28: [12170]: <-- data [2]
Jun 22 07:59:34.54: [12170]: --> [7:CONNECT]
Jun 22 07:59:34.54: [12170]: <-- HDLC<23:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04>
Jun 22 07:59:34.54: [12170]: <-- data [23]
Jun 22 07:59:34.54: [12170]: <-- data [2]
Jun 22 07:59:35.56: [12170]: --> [7:CONNECT]
Jun 22 07:59:35.56: [12170]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Jun 22 07:59:35.56: [12170]: <-- data [13]
Jun 22 07:59:35.56: [12170]: <-- data [2]
Jun 22 07:59:36.05: [12170]: --> [2:OK]
Jun 22 07:59:36.05: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:36.40: [12170]: --> [7:CONNECT]
Jun 22 07:59:37.35: [12170]: --> HDLC<3:FF C8 DF>
Jun 22 07:59:37.36: [12170]: --> [2:OK]
Jun 22 07:59:37.36: [12170]: HDLC frame too short (3 bytes)
Jun 22 07:59:37.36: [12170]: <-- [9:AT+FRS=7\r]
Jun 22 07:59:37.53: [12170]: --> [2:OK]
Jun 22 07:59:37.53: [12170]: <-- [9:AT+FTH=3\r]
Jun 22 07:59:38.57: [12170]: --> [7:CONNECT]
Jun 22 07:59:38.57: [12170]: <-- HDLC<3:FF C8 58>
Jun 22 07:59:38.57: [12170]: <-- data [3]
Jun 22 07:59:38.57: [12170]: <-- data [2]
Jun 22 07:59:38.80: [12170]: --> [2:OK]
Jun 22 07:59:38.80: [12170]: RECV send CRP (command repeat)
Jun 22 07:59:38.80: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:45.80: [12170]: --> [0:]
Jun 22 07:59:45.80: [12170]: MODEM <Empty line>
Jun 22 07:59:45.80: [12170]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 22 07:59:45.80: [12170]: <-- data [1]
Jun 22 07:59:45.81: [12170]: --> [2:OK]
Jun 22 07:59:45.81: [12170]: DELAY 1500 ms
Jun 22 07:59:47.31: [12170]: <-- [9:AT+FTH=3\r]
Jun 22 07:59:48.35: [12170]: --> [7:CONNECT]
Jun 22 07:59:48.35: [12170]: <-- HDLC<32:FF C0 04 B5 00 AA 12 9E 36 86 62 82 1A 04 14 2E B6 94 04 6A A6 4E CE 96 F6 76 04 2C 74 CC 74 CC>
Jun 22 07:59:48.35: [12170]: <-- data [32]
Jun 22 07:59:48.35: [12170]: <-- data [2]
Jun 22 07:59:49.61: [12170]: --> [7:CONNECT]
Jun 22 07:59:49.61: [12170]: <-- HDLC<23:FF C0 02 1A 92 4A 82 2A 82 22 04 04 04 04 04 04 04 04 04 04 04 04 04>
Jun 22 07:59:49.61: [12170]: <-- data [23]
Jun 22 07:59:49.61: [12170]: <-- data [2]
Jun 22 07:59:50.63: [12170]: --> [7:CONNECT]
Jun 22 07:59:50.63: [12170]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Jun 22 07:59:50.63: [12170]: <-- data [13]
Jun 22 07:59:50.63: [12170]: <-- data [2]
Jun 22 07:59:51.12: [12170]: --> [2:OK]
Jun 22 07:59:51.12: [12170]: <-- [9:AT+FRH=3\r]
Jun 22 07:59:58.12: [12170]: --> [0:]
Jun 22 07:59:58.12: [12170]: MODEM <Empty line>
Jun 22 07:59:58.12: [12170]: MODEM TIMEOUT: waiting for v.21 carrier
Jun 22 07:59:58.12: [12170]: <-- data [1]
Jun 22 07:59:58.13: [12170]: --> [2:OK]
Jun 22 07:59:58.13: [12170]: RECV FAX: RSPREC invalid response received
Jun 22 07:59:58.13: [12170]: RECV FAX: end
Jun 22 07:59:58.13: [12170]: SESSION END