[hylafax-users] COMREC invalid response received

["Hans Klose" <hansklose@xxxxxx>]

Hi,

i use t38modem with hylafax. From some stations i have problems to
send to the hylafaxserver. In the log comes "COMREC invalid response
received". When ther are 2 pages only one will be received.
I attached a sample logfile. Is that behavior an issue from 
t38modem or can i modify hylafax to make it work?

Regards Hans.
-- 
GRATIS für alle GMX-Mitglieder: Die maxdome Movie-FLAT!
Jetzt freischalten unter http://portal.gmx.net/de/go/maxdome01

THCHYLAFAX01 [~]# cat /var/spool/hylafax/log/c000000057 
Apr 16 14:12:08.16: [ 3609]: SESSION BEGIN 000000057 
Apr 16 14:12:08.16: [ 3609]: HylaFAX (tm) Version 6.0.4
Apr 16 14:12:08.16: [ 3609]: CallID: "3039493222" "854002006"
Apr 16 14:12:08.16: [ 3609]: <-- [4:ATA\r]
Apr 16 14:12:12.20: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:12.20: [ 3609]: ANSWER: FAX CONNECTION  DEVICE '/dev/ttyx0'
Apr 16 14:12:12.20: [ 3609]: STATE CHANGE: ANSWERING -> RECEIVING
Apr 16 14:12:12.20: [ 3609]: RECV FAX: begin
Apr 16 14:12:12.20: [ 3609]: <-- 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 6C 74 0C 74 2C>
Apr 16 14:12:12.20: [ 3609]: <-- data [32]
Apr 16 14:12:12.20: [ 3609]: <-- data [2]
Apr 16 14:12:14.10: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:14.10: [ 3609]: <-- HDLC<23:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04>
Apr 16 14:12:14.10: [ 3609]: <-- data [23]
Apr 16 14:12:14.10: [ 3609]: <-- data [2]
Apr 16 14:12:14.82: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:14.82: [ 3609]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Apr 16 14:12:14.82: [ 3609]: <-- data [13]
Apr 16 14:12:14.82: [ 3609]: <-- data [2]
Apr 16 14:12:15.31: [ 3609]: --> [2:OK]
Apr 16 14:12:15.31: [ 3609]: <-- [9:AT+FRH=3\r]
Apr 16 14:12:16.33: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:17.39: [ 3609]: --> HDLC<5:FF C8 58 B8 00>
Apr 16 14:12:17.39: [ 3609]: --> [2:OK]
Apr 16 14:12:17.39: [ 3609]: RECV recv CRP (command repeat)
Apr 16 14:12:17.39: [ 3609]: <-- [9:AT+FTH=3\r]
Apr 16 14:12:17.39: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:17.39: [ 3609]: <-- 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 6C 74 0C 74 2C>
Apr 16 14:12:17.39: [ 3609]: <-- data [32]
Apr 16 14:12:17.39: [ 3609]: <-- data [2]
Apr 16 14:12:19.71: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:19.71: [ 3609]: <-- HDLC<23:FF C0 02 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04 04>
Apr 16 14:12:19.71: [ 3609]: <-- data [23]
Apr 16 14:12:19.71: [ 3609]: <-- data [2]
Apr 16 14:12:20.43: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:20.43: [ 3609]: <-- HDLC<13:FF C8 01 00 77 5F 23 01 FB C1 01 01 18>
Apr 16 14:12:20.43: [ 3609]: <-- data [13]
Apr 16 14:12:20.43: [ 3609]: <-- data [2]
Apr 16 14:12:20.91: [ 3609]: --> [2:OK]
Apr 16 14:12:20.91: [ 3609]: <-- [9:AT+FRH=3\r]
Apr 16 14:12:21.86: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:23.08: [ 3609]: --> HDLC<11:FF C8 C1 00 44 1F 21 01 00 65 AF>
Apr 16 14:12:23.08: [ 3609]: --> [2:OK]
Apr 16 14:12:23.08: [ 3609]: RECV recv DCS (command signal)
Apr 16 14:12:23.08: [ 3609]: REMOTE wants 14400 bit/s
Apr 16 14:12:23.08: [ 3609]: REMOTE wants A4 page width (215 mm)
Apr 16 14:12:23.08: [ 3609]: REMOTE wants unlimited page length
Apr 16 14:12:23.08: [ 3609]: REMOTE wants 3.85 line/mm
Apr 16 14:12:23.08: [ 3609]: REMOTE wants 1-D MH
Apr 16 14:12:23.08: [ 3609]: REMOTE wants T.30 Annex A, 256-byte ECM
Apr 16 14:12:23.08: [ 3609]: RECV training at v.17 14400 bit/s
Apr 16 14:12:23.08: [ 3609]: <-- [11:AT+FRM=145\r]
Apr 16 14:12:24.83: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:26.33: [ 3609]: RECV: TCF 2742 bytes, 1% non-zero, 2697 zero-run
Apr 16 14:12:26.33: [ 3609]: --> [10:NO CARRIER]
Apr 16 14:12:26.33: [ 3609]: <-- [9:AT+FRS=7\r]
Apr 16 14:12:26.40: [ 3609]: --> [2:OK]
Apr 16 14:12:26.40: [ 3609]: TRAINING succeeded
Apr 16 14:12:26.40: [ 3609]: <-- [9:AT+FTH=3\r]
Apr 16 14:12:26.41: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:26.41: [ 3609]: <-- HDLC<3:FF C8 21>
Apr 16 14:12:26.41: [ 3609]: <-- data [3]
Apr 16 14:12:26.41: [ 3609]: <-- data [2]
Apr 16 14:12:27.45: [ 3609]: --> [2:OK]
Apr 16 14:12:27.45: [ 3609]: <-- [11:AT+FRM=146\r]
Apr 16 14:12:29.61: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:29.61: [ 3609]: MODEM input buffering enabled
Apr 16 14:12:30.55: [ 3609]: RECV received frame number 0
Apr 16 14:12:30.71: [ 3609]: RECV received frame number 1
Apr 16 14:12:30.91: [ 3609]: RECV received frame number 2
Apr 16 14:12:31.13: [ 3609]: RECV received frame number 3
Apr 16 14:12:31.51: [ 3609]: RECV received frame number 4
Apr 16 14:12:31.67: [ 3609]: RECV received frame number 5
Apr 16 14:12:31.75: [ 3609]: RECV received frame number 6
Apr 16 14:12:31.95: [ 3609]: RECV received frame number 7
Apr 16 14:12:32.11: [ 3609]: RECV received frame number 8
Apr 16 14:12:32.27: [ 3609]: RECV received frame number 9
Apr 16 14:12:32.43: [ 3609]: RECV received frame number 10
Apr 16 14:12:32.52: [ 3609]: RECV received frame number 11
Apr 16 14:12:32.67: [ 3609]: RECV received frame number 12
Apr 16 14:12:32.83: [ 3609]: RECV received frame number 13
Apr 16 14:12:32.99: [ 3609]: RECV received frame number 14
Apr 16 14:12:33.15: [ 3609]: RECV received frame number 15
Apr 16 14:12:33.31: [ 3609]: RECV received frame number 16
Apr 16 14:12:33.40: [ 3609]: RECV received frame number 17
Apr 16 14:12:33.55: [ 3609]: RECV received frame number 18
Apr 16 14:12:33.71: [ 3609]: RECV received frame number 19
Apr 16 14:12:33.87: [ 3609]: RECV received frame number 20
Apr 16 14:12:34.03: [ 3609]: RECV received frame number 21
Apr 16 14:12:34.19: [ 3609]: RECV received frame number 22
Apr 16 14:12:34.35: [ 3609]: RECV received frame number 23
Apr 16 14:12:34.44: [ 3609]: RECV received frame number 24
Apr 16 14:12:34.60: [ 3609]: RECV received frame number 25
Apr 16 14:12:34.75: [ 3609]: RECV received frame number 26
Apr 16 14:12:34.91: [ 3609]: RECV received frame number 27
Apr 16 14:12:35.07: [ 3609]: RECV received frame number 28
Apr 16 14:12:35.23: [ 3609]: RECV received frame number 29
Apr 16 14:12:35.32: [ 3609]: RECV received frame number 30
Apr 16 14:12:35.48: [ 3609]: RECV received frame number 31
Apr 16 14:12:35.64: [ 3609]: RECV received frame number 32
Apr 16 14:12:35.80: [ 3609]: RECV received frame number 33
Apr 16 14:12:35.95: [ 3609]: RECV received frame number 34
Apr 16 14:12:36.11: [ 3609]: RECV received frame number 35
Apr 16 14:12:36.27: [ 3609]: RECV received frame number 36
Apr 16 14:12:36.36: [ 3609]: RECV received frame number 37
Apr 16 14:12:36.52: [ 3609]: RECV received frame number 38
Apr 16 14:12:36.67: [ 3609]: RECV received frame number 39
Apr 16 14:12:36.83: [ 3609]: RECV received frame number 40
Apr 16 14:12:36.99: [ 3609]: RECV received frame number 41
Apr 16 14:12:37.15: [ 3609]: RECV received frame number 42
Apr 16 14:12:37.24: [ 3609]: RECV received frame number 43
Apr 16 14:12:37.40: [ 3609]: RECV received frame number 44
Apr 16 14:12:37.56: [ 3609]: RECV received frame number 45
Apr 16 14:12:37.71: [ 3609]: RECV received frame number 46
Apr 16 14:12:37.87: [ 3609]: RECV received frame number 47
Apr 16 14:12:38.03: [ 3609]: RECV received frame number 48
Apr 16 14:12:38.12: [ 3609]: RECV received frame number 49
Apr 16 14:12:38.60: [ 3609]: RECV received frame number 50
Apr 16 14:12:39.00: [ 3609]: RECV received frame number 51
Apr 16 14:12:39.28: [ 3609]: RECV received frame number 52
Apr 16 14:12:39.48: [ 3609]: RECV received frame number 53
Apr 16 14:12:39.71: [ 3609]: RECV received frame number 54
Apr 16 14:12:39.91: [ 3609]: RECV received frame number 55
Apr 16 14:12:40.07: [ 3609]: RECV received frame number 56
Apr 16 14:12:40.16: [ 3609]: RECV received frame number 57
Apr 16 14:12:40.40: [ 3609]: RECV received frame number 58
Apr 16 14:12:40.56: [ 3609]: RECV received frame number 59
Apr 16 14:12:40.72: [ 3609]: RECV received frame number 60
Apr 16 14:12:40.94: [ 3609]: RECV received frame number 61
Apr 16 14:12:41.16: [ 3609]: RECV received frame number 62
Apr 16 14:12:41.24: [ 3609]: RECV received frame number 63
Apr 16 14:12:41.52: [ 3609]: RECV received frame number 64
Apr 16 14:12:41.72: [ 3609]: RECV received frame number 65
Apr 16 14:12:41.94: [ 3609]: RECV received frame number 66
Apr 16 14:12:42.19: [ 3609]: RECV received frame number 67
Apr 16 14:12:42.47: [ 3609]: RECV received frame number 68
Apr 16 14:12:42.72: [ 3609]: RECV received frame number 69
Apr 16 14:12:42.94: [ 3609]: RECV received frame number 70
Apr 16 14:12:43.19: [ 3609]: RECV received frame number 71
Apr 16 14:12:43.43: [ 3609]: RECV received frame number 72
Apr 16 14:12:43.66: [ 3609]: RECV received frame number 73
Apr 16 14:12:43.79: [ 3609]: RECV received frame number 74
Apr 16 14:12:44.17: [ 3609]: RECV received frame number 75
Apr 16 14:12:44.35: [ 3609]: RECV received frame number 76
Apr 16 14:12:44.51: [ 3609]: RECV received frame number 77
Apr 16 14:12:44.67: [ 3609]: RECV received frame number 78
Apr 16 14:12:44.75: [ 3609]: RECV received frame number 79
Apr 16 14:12:44.91: [ 3609]: RECV received frame number 80
Apr 16 14:12:45.07: [ 3609]: RECV received frame number 81
Apr 16 14:12:45.23: [ 3609]: RECV received frame number 82
Apr 16 14:12:45.43: [ 3609]: RECV received frame number 83
Apr 16 14:12:45.66: [ 3609]: RECV received frame number 84
Apr 16 14:12:45.83: [ 3609]: RECV received frame number 85
Apr 16 14:12:45.99: [ 3609]: RECV received frame number 86
Apr 16 14:12:46.15: [ 3609]: RECV received frame number 87
Apr 16 14:12:46.23: [ 3609]: RECV received frame number 88
Apr 16 14:12:46.39: [ 3609]: RECV received frame number 89
Apr 16 14:12:46.59: [ 3609]: RECV received frame number 90
Apr 16 14:12:46.79: [ 3609]: RECV received frame number 91
Apr 16 14:12:46.95: [ 3609]: RECV received frame number 92
Apr 16 14:12:47.11: [ 3609]: RECV received frame number 93
Apr 16 14:12:47.27: [ 3609]: RECV received frame number 94
Apr 16 14:12:47.35: [ 3609]: RECV received frame number 95
Apr 16 14:12:47.51: [ 3609]: RECV received frame number 96
Apr 16 14:12:47.67: [ 3609]: RECV received frame number 97
Apr 16 14:12:47.83: [ 3609]: RECV received frame number 98
Apr 16 14:12:47.99: [ 3609]: RECV received frame number 99
Apr 16 14:12:48.15: [ 3609]: RECV received frame number 100
Apr 16 14:12:48.31: [ 3609]: RECV received frame number 101
Apr 16 14:12:48.39: [ 3609]: RECV received frame number 102
Apr 16 14:12:48.59: [ 3609]: RECV received frame number 103
Apr 16 14:12:48.75: [ 3609]: RECV received frame number 104
Apr 16 14:12:48.91: [ 3609]: RECV received frame number 105
Apr 16 14:12:49.11: [ 3609]: RECV received frame number 106
Apr 16 14:12:49.27: [ 3609]: RECV received frame number 107
Apr 16 14:12:49.51: [ 3609]: RECV received frame number 108
Apr 16 14:12:49.75: [ 3609]: RECV received frame number 109
Apr 16 14:12:49.91: [ 3609]: RECV received frame number 110
Apr 16 14:12:49.99: [ 3609]: RECV received frame number 111
Apr 16 14:12:50.15: [ 3609]: RECV received frame number 112
Apr 16 14:12:50.31: [ 3609]: RECV received frame number 113
Apr 16 14:12:50.55: [ 3609]: RECV received frame number 114
Apr 16 14:12:50.78: [ 3609]: RECV received frame number 115
Apr 16 14:12:51.07: [ 3609]: RECV received frame number 116
Apr 16 14:12:51.27: [ 3609]: RECV received frame number 117
Apr 16 14:12:51.53: [ 3609]: RECV received frame number 118
Apr 16 14:12:51.81: [ 3609]: RECV received frame number 119
Apr 16 14:12:52.14: [ 3609]: RECV received frame number 120
Apr 16 14:12:52.31: [ 3609]: RECV received frame number 121
Apr 16 14:12:52.55: [ 3609]: RECV received frame number 122
Apr 16 14:12:52.75: [ 3609]: RECV received frame number 123
Apr 16 14:12:52.83: [ 3609]: RECV received frame number 124
Apr 16 14:12:52.99: [ 3609]: RECV received frame number 125
Apr 16 14:12:53.23: [ 3609]: RECV received frame number 126
Apr 16 14:12:53.39: [ 3609]: RECV received frame number 127
Apr 16 14:12:53.47: [ 3609]: RECV received frame number 128
Apr 16 14:12:53.83: [ 3609]: RECV received frame number 129
Apr 16 14:12:53.99: [ 3609]: RECV received frame number 130
Apr 16 14:12:54.15: [ 3609]: RECV received frame number 131
Apr 16 14:12:54.31: [ 3609]: RECV received frame number 132
Apr 16 14:12:54.39: [ 3609]: RECV received frame number 133
Apr 16 14:12:54.63: [ 3609]: RECV received frame number 134
Apr 16 14:12:54.79: [ 3609]: RECV received frame number 135
Apr 16 14:12:55.03: [ 3609]: RECV received frame number 136
Apr 16 14:12:55.11: [ 3609]: RECV received frame number 137
Apr 16 14:12:55.35: [ 3609]: RECV received frame number 138
Apr 16 14:12:55.61: [ 3609]: RECV received frame number 139
Apr 16 14:12:55.79: [ 3609]: RECV received frame number 140
Apr 16 14:12:55.95: [ 3609]: RECV received frame number 141
Apr 16 14:12:56.15: [ 3609]: RECV received frame number 142
Apr 16 14:12:56.39: [ 3609]: RECV received frame number 143
Apr 16 14:12:56.47: [ 3609]: RECV received frame number 144
Apr 16 14:12:56.67: [ 3609]: RECV received frame number 145
Apr 16 14:12:56.99: [ 3609]: RECV received frame number 146
Apr 16 14:12:57.24: [ 3609]: RECV received frame number 147
Apr 16 14:12:57.24: [ 3609]: RECV received RCP frame
Apr 16 14:12:57.24: [ 3609]: MODEM input buffering disabled
Apr 16 14:12:57.24: [ 3609]: --> [10:NO CARRIER]
Apr 16 14:12:57.24: [ 3609]: <-- [9:AT+FRH=3\r]
Apr 16 14:12:57.42: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:58.51: [ 3609]: --> HDLC<9:FF C8 FD F2 00 00 C9 3C 5E>
Apr 16 14:12:58.51: [ 3609]: --> [2:OK]
Apr 16 14:12:58.51: [ 3609]: RECV recv PPS (partial page signal)
Apr 16 14:12:58.51: [ 3609]: RECV recv MPS (more pages, same document)
Apr 16 14:12:58.51: [ 3609]: RECV received 148 frames of block 1 of page 1
Apr 16 14:12:59.51: [ 3609]: <-- [9:AT+FRS=7\r]
Apr 16 14:12:59.58: [ 3609]: --> [2:OK]
Apr 16 14:12:59.58: [ 3609]: <-- [9:AT+FTH=3\r]
Apr 16 14:12:59.58: [ 3609]: --> [7:CONNECT]
Apr 16 14:12:59.58: [ 3609]: <-- HDLC<3:FF C8 37>
Apr 16 14:12:59.58: [ 3609]: <-- data [3]
Apr 16 14:12:59.58: [ 3609]: <-- data [2]
Apr 16 14:12:59.89: [ 3609]: RECV/CQ: Bad 1D pixel count, row 1126, got 0, expected 1728
Apr 16 14:12:59.89: [ 3609]: RECV/CQ: Bad 1D pixel count, row 1127, got 0, expected 1728
Apr 16 14:12:59.89: [ 3609]: RECV/CQ: Bad 1D pixel count, row 1128, got 0, expected 1728
Apr 16 14:12:59.89: [ 3609]: RECV/CQ: Bad 1D pixel count, row 1129, got 0, expected 1728
Apr 16 14:12:59.89: [ 3609]: RECV/CQ: Adjusting for RTC found at row 1126
Apr 16 14:12:59.89: [ 3609]: RECV: 37767 bytes of data, 1126 total lines
Apr 16 14:13:00.62: [ 3609]: --> [2:OK]
Apr 16 14:13:00.62: [ 3609]: RECV send RNR (receive not ready)
Apr 16 14:13:00.62: [ 3609]: <-- [9:AT+FRH=3\r]
Apr 16 14:13:02.50: [ 3609]: --> [7:CONNECT]
Apr 16 14:13:03.46: [ 3609]: --> HDLC<5:FF C8 F6 EC 24>
Apr 16 14:13:03.46: [ 3609]: --> [2:OK]
Apr 16 14:13:03.46: [ 3609]: RECV recv RR (receive ready)
Apr 16 14:13:03.46: [ 3609]: <-- [9:AT+FRS=7\r]
Apr 16 14:13:09.27: [ 3609]: --> [2:OK]
Apr 16 14:13:09.27: [ 3609]: RECV send MCF (message confirmation)
Apr 16 14:13:09.27: [ 3609]: <-- [9:AT+FTH=3\r]
Apr 16 14:13:09.27: [ 3609]: --> [7:CONNECT]
Apr 16 14:13:09.27: [ 3609]: RECV FAX (000000057): from <UNSPECIFIED>, page 1 in 0:00:51, INF, 3.85 line/mm, 1-D MH, 14400 bit/s
Apr 16 14:13:09.27: [ 3609]: <-- HDLC<3:FF C8 31>
Apr 16 14:13:09.27: [ 3609]: <-- data [3]
Apr 16 14:13:09.27: [ 3609]: <-- data [2]
Apr 16 14:13:10.86: [ 3609]: --> [2:OK]
Apr 16 14:13:10.86: [ 3609]: <-- [11:AT+FRM=146\r]
Apr 16 14:13:15.90: [ 3609]: --> [8:+FCERROR]
Apr 16 14:13:15.90: [ 3609]: <-- [11:AT+FRM=146\r]
Apr 16 14:13:15.90: [ 3609]: --> [8:+FCERROR]
Apr 16 14:13:15.90: [ 3609]: <-- [9:AT+FRH=3\r]
Apr 16 14:13:15.90: [ 3609]: --> [7:CONNECT]
Apr 16 14:13:16.86: [ 3609]: --> HDLC<5:FF C8 F6 EC 24>
Apr 16 14:13:16.86: [ 3609]: --> [2:OK]
Apr 16 14:13:16.86: [ 3609]: RECV recv RR (receive ready)
Apr 16 14:13:16.86: [ 3609]: RECV FAX (000000057): recvq/fax000000029.tif from <UNSPECIFIED>, route to <unspecified>, 1 pages in 0:01:04
Apr 16 14:13:16.86: [ 3609]: RECV FAX: COMREC invalid response received
Apr 16 14:13:16.86: [ 3609]: <-- [9:AT+FRS=7\r]
Apr 16 14:13:22.68: [ 3609]: --> [2:OK]
Apr 16 14:13:22.68: [ 3609]: <-- [9:AT+FTH=3\r]
Apr 16 14:13:22.68: [ 3609]: --> [7:CONNECT]
Apr 16 14:13:22.68: [ 3609]: <-- HDLC<3:FF C8 5F>
Apr 16 14:13:22.68: [ 3609]: <-- data [3]
Apr 16 14:13:22.68: [ 3609]: <-- data [2]
Apr 16 14:13:24.26: [ 3609]: --> [2:OK]
Apr 16 14:13:24.26: [ 3609]: MODEM input buffering enabled
Apr 16 14:13:24.26: [ 3609]: RECV FAX (000000057): session with <UNSPECIFIED> terminated abnormally: COMREC invalid response received
Apr 16 14:13:24.26: [ 3609]: RECV FAX: bin/faxrcvd "recvq/fax000000029.tif" "ttyx0" "000000057" "COMREC invalid response received" "3039493222" "854002006"
Apr 16 14:13:24.26: [ 3609]: RECV FAX: end
Apr 16 14:13:24.26: [ 3609]: COMREC invalid response received
Apr 16 14:13:24.26: [ 3609]: SESSION END