![]() |
I am having a problem sending faxes to a zerox 390 workstation. I am sending a 1 page fax but the actual fax never gets there instead my customer got about 50 copies of the cover page. The software seems to keep training down the modem but still fails. I am running 4.0pl2 on SCO openserver 5. I have attached a copy of the log. If anyone has any ideas as to whats wrong please help out. Thanks Oct 30 09:26:12.72: [29413]: SESSION BEGIN 00157208 1920916514334380 Oct 30 09:26:12.72: [29413]: SEND FAX: JOB 28281 DEST 9-1-651-433-4380 COMMID 00157208 Oct 30 09:26:12.72: [29413]: DELAY 2600 ms Oct 30 09:26:17.68: [29413]: <-- [15:ATE0V1Q0S0=0H0\r] Oct 30 09:26:19.02: [29413]: --> [2:OK] Oct 30 09:26:19.02: [29413]: <-- [21:ATS8=2S7=60&K3&D3&C1\r] Oct 30 09:26:19.28: [29413]: --> [2:OK] Oct 30 09:26:19.28: [29413]: <-- [12:AT+FCLASS=1\r] Oct 30 09:26:19.50: [29413]: --> [2:OK] Oct 30 09:26:19.50: [29413]: <-- [9:AT+FAA=0\r] Oct 30 09:26:19.58: [29413]: --> [2:OK] Oct 30 09:26:19.58: [29413]: <-- [5:ATM0\r] Oct 30 09:26:19.66: [29413]: --> [2:OK] Oct 30 09:26:19.66: [29413]: <-- [12:AT+FCLASS=1\r] Oct 30 09:26:19.84: [29413]: --> [2:OK] Oct 30 09:26:19.84: [29413]: DIAL 916514334380 Oct 30 09:26:19.84: [29413]: <-- [17:ATDT916514334380\r] Oct 30 09:26:36.76: [29413]: --> [7:CONNECT] Oct 30 09:26:38.51: [29413]: --> [2:OK] Oct 30 09:26:38.51: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:26:38.61: [29413]: --> [7:CONNECT] Oct 30 09:26:39.25: [29413]: --> [2:OK] Oct 30 09:26:39.25: [29413]: REMOTE CSI "6514334380" Oct 30 09:26:39.25: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:26:39.35: [29413]: --> [7:CONNECT] Oct 30 09:26:39.59: [29413]: --> [2:OK] Oct 30 09:26:39.59: [29413]: REMOTE best rate 14400 bit/s Oct 30 09:26:39.59: [29413]: REMOTE max page width 1728 pixels in 215 mm Oct 30 09:26:39.59: [29413]: REMOTE max unlimited page length Oct 30 09:26:39.59: [29413]: REMOTE best vres 7.7 line/mm Oct 30 09:26:39.59: [29413]: REMOTE best format 2-D MMR Oct 30 09:26:39.59: [29413]: REMOTE supports T.30 Annex A, ECM Oct 30 09:26:39.59: [29413]: REMOTE best 10 ms/scanline Oct 30 09:26:39.59: [29413]: USE 14400 bit/s Oct 30 09:26:39.59: [29413]: USE 10 ms/scanline Oct 30 09:26:39.59: [29413]: SEND file "docq/doc28281.cover;30" Oct 30 09:26:39.59: [29413]: USE page width 1728 pixels in 215 mm Oct 30 09:26:39.59: [29413]: USE unlimited page length Oct 30 09:26:39.59: [29413]: USE 3.85 line/mm Oct 30 09:26:39.59: [29413]: USE 1-D MR Oct 30 09:26:39.62: [29413]: SEND training at v.17 14400 bit/s Oct 30 09:26:39.62: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:26:39.73: [29413]: --> [7:CONNECT] Oct 30 09:26:39.73: [29413]: <-- data [23] Oct 30 09:26:39.73: [29413]: <-- data [2] Oct 30 09:26:41.67: [29413]: --> [7:CONNECT] Oct 30 09:26:41.67: [29413]: <-- data [6] Oct 30 09:26:41.67: [29413]: <-- data [2] Oct 30 09:26:42.17: [29413]: --> [2:OK] Oct 30 09:26:42.17: [29413]: DELAY 75 ms Oct 30 09:26:42.26: [29413]: <-- [11:AT+FTM=145\r] Oct 30 09:26:42.45: [29413]: --> [7:CONNECT] Oct 30 09:26:42.45: [29413]: <-- data [1024] Oct 30 09:26:42.45: [29413]: <-- data [1024] Oct 30 09:26:42.51: [29413]: <-- data [652] Oct 30 09:26:42.51: [29413]: <-- data [2] Oct 30 09:26:45.39: [29413]: --> [6:] Oct 30 09:26:45.39: [29413]: --> [2:OK] Oct 30 09:26:45.39: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:26:45.63: [29413]: --> [7:CONNECT] Oct 30 09:26:46.89: [29413]: --> [2:OK] Oct 30 09:26:46.89: [29413]: TRAINING succeeded Oct 30 09:26:46.89: [29413]: <-- [11:AT+FTM=146\r] Oct 30 09:26:47.01: [29413]: --> [7:CONNECT] Oct 30 09:26:47.01: [29413]: SEND begin page Oct 30 09:26:47.01: [29413]: <-- data [1030] Oct 30 09:26:47.01: [29413]: <-- data [1033] Oct 30 09:26:47.07: [29413]: <-- data [1047] Oct 30 09:26:47.08: [29413]: <-- data [1043] Oct 30 09:26:47.13: [29413]: <-- data [1024] Oct 30 09:26:47.13: [29413]: <-- data [1024] Oct 30 09:26:48.48: [29413]: <-- data [1039] Oct 30 09:26:48.48: [29413]: <-- data [1025] Oct 30 09:26:49.36: [29413]: <-- data [1036] Oct 30 09:26:49.36: [29413]: <-- data [1042] Oct 30 09:26:50.14: [29413]: <-- data [1036] Oct 30 09:26:51.02: [29413]: <-- data [1031] Oct 30 09:26:51.02: [29413]: <-- data [1047] Oct 30 09:26:51.86: [29413]: <-- data [1029] Oct 30 09:26:52.97: [29413]: <-- data [1031] Oct 30 09:26:52.97: [29413]: <-- data [1029] Oct 30 09:26:53.51: [29413]: <-- data [1024] Oct 30 09:26:54.61: [29413]: <-- data [1024] Oct 30 09:26:54.61: [29413]: <-- data [962] Oct 30 09:26:55.19: [29413]: SENT 19394 bytes of data Oct 30 09:26:55.19: [29413]: <-- data [1024] Oct 30 09:26:56.03: [29413]: <-- data [1024] Oct 30 09:26:56.03: [29413]: <-- data [1024] Oct 30 09:26:56.87: [29413]: <-- data [1024] Oct 30 09:26:57.99: [29413]: <-- data [1024] Oct 30 09:26:57.99: [29413]: <-- data [748] Oct 30 09:26:58.73: [29413]: SENT 5868 bytes of data Oct 30 09:26:58.73: [29413]: SEND 1D RTC Oct 30 09:26:58.73: [29413]: <-- data [29] Oct 30 09:26:58.73: [29413]: <-- data [2] Oct 30 09:26:58.73: [29413]: SEND end page Oct 30 09:27:02.33: [29413]: --> [66:] Oct 30 09:27:02.33: [29413]: --> [2:OK] Oct 30 09:27:02.33: [29413]: DELAY 75 ms Oct 30 09:27:02.42: [29413]: SEND send MPS (more pages, same document) Oct 30 09:27:02.42: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:27:02.53: [29413]: --> [7:CONNECT] Oct 30 09:27:02.53: [29413]: <-- data [3] Oct 30 09:27:02.53: [29413]: <-- data [2] Oct 30 09:27:04.57: [29413]: --> [2:OK] Oct 30 09:27:04.57: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:27:04.79: [29413]: --> [7:CONNECT] Oct 30 09:27:06.07: [29413]: --> [2:OK] Oct 30 09:27:06.07: [29413]: SEND recv RTN (retrain negative) Oct 30 09:27:06.07: [29413]: SEND training at v.17 14400 bit/s Oct 30 09:27:06.07: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:27:06.17: [29413]: --> [7:CONNECT] Oct 30 09:27:06.17: [29413]: <-- data [23] Oct 30 09:27:06.17: [29413]: <-- data [2] Oct 30 09:27:08.13: [29413]: --> [7:CONNECT] Oct 30 09:27:08.13: [29413]: <-- data [6] Oct 30 09:27:08.13: [29413]: <-- data [2] Oct 30 09:27:08.61: [29413]: --> [2:OK] Oct 30 09:27:08.62: [29413]: DELAY 75 ms Oct 30 09:27:08.71: [29413]: <-- [11:AT+FTM=145\r] Oct 30 09:27:08.91: [29413]: --> [7:CONNECT] Oct 30 09:27:08.91: [29413]: <-- data [1024] Oct 30 09:27:08.91: [29413]: <-- data [1024] Oct 30 09:27:08.97: [29413]: <-- data [652] Oct 30 09:27:08.97: [29413]: <-- data [2] Oct 30 09:27:11.83: [29413]: --> [6:] Oct 30 09:27:11.83: [29413]: --> [2:OK] Oct 30 09:27:11.83: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:27:12.07: [29413]: --> [7:CONNECT] Oct 30 09:27:13.33: [29413]: --> [2:OK] Oct 30 09:27:13.33: [29413]: TRAINING succeeded Oct 30 09:27:13.33: [29413]: <-- [11:AT+FTM=146\r] Oct 30 09:27:13.45: [29413]: --> [7:CONNECT] Oct 30 09:27:13.45: [29413]: SEND begin page Oct 30 09:27:13.45: [29413]: <-- data [1030] Oct 30 09:27:13.45: [29413]: <-- data [1033] Oct 30 09:27:13.51: [29413]: <-- data [1047] Oct 30 09:27:13.51: [29413]: <-- data [1043] Oct 30 09:27:13.57: [29413]: <-- data [1024] Oct 30 09:27:13.57: [29413]: <-- data [1024] Oct 30 09:27:14.93: [29413]: <-- data [1039] Oct 30 09:27:14.93: [29413]: <-- data [1025] Oct 30 09:27:16.01: [29413]: <-- data [1036] Oct 30 09:27:16.01: [29413]: <-- data [1042] Oct 30 09:27:16.57: [29413]: <-- data [1036] Oct 30 09:27:17.45: [29413]: <-- data [1031] Oct 30 09:27:17.45: [29413]: <-- data [1047] Oct 30 09:27:18.31: [29413]: <-- data [1029] Oct 30 09:27:19.41: [29413]: <-- data [1031] Oct 30 09:27:19.41: [29413]: <-- data [1029] Oct 30 09:27:19.97: [29413]: <-- data [1024] Oct 30 09:27:21.05: [29413]: <-- data [1024] Oct 30 09:27:21.05: [29413]: <-- data [962] Oct 30 09:27:21.61: [29413]: SENT 19394 bytes of data Oct 30 09:27:21.61: [29413]: <-- data [1024] Oct 30 09:27:22.71: [29413]: <-- data [1024] Oct 30 09:27:22.71: [29413]: <-- data [1024] Oct 30 09:27:23.27: [29413]: <-- data [1024] Oct 30 09:27:24.35: [29413]: <-- data [1024] Oct 30 09:27:24.35: [29413]: <-- data [748] Oct 30 09:27:25.23: [29413]: SENT 5868 bytes of data Oct 30 09:27:25.23: [29413]: SEND 1D RTC Oct 30 09:27:25.23: [29413]: <-- data [29] Oct 30 09:27:25.23: [29413]: <-- data [2] Oct 30 09:27:25.23: [29413]: SEND end page Oct 30 09:27:28.77: [29413]: --> [66:] Oct 30 09:27:28.77: [29413]: --> [2:OK] Oct 30 09:27:28.77: [29413]: DELAY 75 ms Oct 30 09:27:28.86: [29413]: SEND send MPS (more pages, same document) Oct 30 09:27:28.86: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:27:28.97: [29413]: --> [7:CONNECT] Oct 30 09:27:28.97: [29413]: <-- data [3] Oct 30 09:27:28.97: [29413]: <-- data [2] Oct 30 09:27:31.03: [29413]: --> [2:OK] Oct 30 09:27:31.03: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:27:31.27: [29413]: --> [7:CONNECT] Oct 30 09:27:32.52: [29413]: --> [2:OK] Oct 30 09:27:32.52: [29413]: SEND recv RTN (retrain negative) Oct 30 09:27:32.52: [29413]: SEND training at v.17 12000 bit/s Oct 30 09:27:32.52: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:27:32.59: [29413]: --> [7:CONNECT] Oct 30 09:27:32.59: [29413]: <-- data [23] Oct 30 09:27:32.59: [29413]: <-- data [2] Oct 30 09:27:34.55: [29413]: --> [7:CONNECT] Oct 30 09:27:34.55: [29413]: <-- data [6] Oct 30 09:27:34.55: [29413]: <-- data [2] Oct 30 09:27:35.03: [29413]: --> [2:OK] Oct 30 09:27:35.03: [29413]: DELAY 75 ms Oct 30 09:27:35.12: [29413]: <-- [11:AT+FTM=121\r] Oct 30 09:27:35.33: [29413]: --> [7:CONNECT] Oct 30 09:27:35.33: [29413]: <-- data [1024] Oct 30 09:27:35.33: [29413]: <-- data [1024] Oct 30 09:27:35.39: [29413]: <-- data [202] Oct 30 09:27:35.39: [29413]: <-- data [2] Oct 30 09:27:38.27: [29413]: --> [4:] Oct 30 09:27:38.27: [29413]: --> [2:OK] Oct 30 09:27:38.27: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:27:38.51: [29413]: --> [7:CONNECT] Oct 30 09:27:39.77: [29413]: --> [2:OK] Oct 30 09:27:39.77: [29413]: TRAINING succeeded Oct 30 09:27:39.77: [29413]: <-- [11:AT+FTM=122\r] Oct 30 09:27:39.89: [29413]: --> [7:CONNECT] Oct 30 09:27:39.89: [29413]: SEND begin page Oct 30 09:27:39.89: [29413]: <-- data [1030] Oct 30 09:27:39.89: [29413]: <-- data [1037] Oct 30 09:27:39.95: [29413]: <-- data [1043] Oct 30 09:27:39.95: [29413]: <-- data [1043] Oct 30 09:27:40.01: [29413]: <-- data [1024] Oct 30 09:27:40.01: [29413]: <-- data [1034] Oct 30 09:27:41.29: [29413]: <-- data [1029] Oct 30 09:27:41.29: [29413]: <-- data [1030] Oct 30 09:27:42.17: [29413]: <-- data [1049] Oct 30 09:27:43.37: [29413]: <-- data [1036] Oct 30 09:27:43.37: [29413]: <-- data [1031] Oct 30 09:27:44.27: [29413]: <-- data [1046] Oct 30 09:27:45.27: [29413]: <-- data [1030] Oct 30 09:27:45.27: [29413]: <-- data [1031] Oct 30 09:27:46.14: [29413]: <-- data [1029] Oct 30 09:27:47.34: [29413]: <-- data [807] Oct 30 09:27:47.34: [29413]: SENT 16167 bytes of data Oct 30 09:27:47.34: [29413]: <-- data [1024] Oct 30 09:27:48.02: [29413]: <-- data [1024] Oct 30 09:27:49.22: [29413]: <-- data [1024] Oct 30 09:27:49.22: [29413]: <-- data [1024] Oct 30 09:27:50.10: [29413]: <-- data [1024] Oct 30 09:27:51.29: [29413]: <-- data [1024] Oct 30 09:27:51.29: [29413]: <-- data [291] Oct 30 09:27:52.27: [29413]: SENT 6435 bytes of data Oct 30 09:27:52.27: [29413]: SEND 1D RTC Oct 30 09:27:52.27: [29413]: <-- data [29] Oct 30 09:27:52.27: [29413]: <-- data [2] Oct 30 09:27:52.27: [29413]: SEND end page Oct 30 09:27:56.27: [29413]: --> [66:] Oct 30 09:27:56.27: [29413]: --> [2:OK] Oct 30 09:27:56.27: [29413]: DELAY 75 ms Oct 30 09:27:56.36: [29413]: SEND send MPS (more pages, same document) Oct 30 09:27:56.36: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:27:56.47: [29413]: --> [7:CONNECT] Oct 30 09:27:56.47: [29413]: <-- data [3] Oct 30 09:27:56.47: [29413]: <-- data [2] Oct 30 09:27:58.50: [29413]: --> [2:OK] Oct 30 09:27:58.50: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:27:58.74: [29413]: --> [7:CONNECT] Oct 30 09:28:00.00: [29413]: --> [2:OK] Oct 30 09:28:00.00: [29413]: SEND recv RTN (retrain negative) Oct 30 09:28:00.00: [29413]: SEND training at v.17 12000 bit/s Oct 30 09:28:00.00: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:28:00.10: [29413]: --> [7:CONNECT] Oct 30 09:28:00.10: [29413]: <-- data [23] Oct 30 09:28:00.10: [29413]: <-- data [2] Oct 30 09:28:02.02: [29413]: --> [7:CONNECT] Oct 30 09:28:02.02: [29413]: <-- data [6] Oct 30 09:28:02.02: [29413]: <-- data [2] Oct 30 09:28:02.52: [29413]: --> [2:OK] Oct 30 09:28:02.53: [29413]: DELAY 75 ms Oct 30 09:28:02.62: [29413]: <-- [11:AT+FTM=121\r] Oct 30 09:28:02.82: [29413]: --> [7:CONNECT] Oct 30 09:28:02.82: [29413]: <-- data [1024] Oct 30 09:28:02.82: [29413]: <-- data [1024] Oct 30 09:28:02.88: [29413]: <-- data [202] Oct 30 09:28:02.88: [29413]: <-- data [2] Oct 30 09:28:05.76: [29413]: --> [4:] Oct 30 09:28:05.76: [29413]: --> [2:OK] Oct 30 09:28:05.76: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:28:06.00: [29413]: --> [7:CONNECT] Oct 30 09:28:07.26: [29413]: --> [2:OK] Oct 30 09:28:07.26: [29413]: TRAINING succeeded Oct 30 09:28:07.26: [29413]: <-- [11:AT+FTM=122\r] Oct 30 09:28:07.38: [29413]: --> [7:CONNECT] Oct 30 09:28:07.38: [29413]: SEND begin page Oct 30 09:28:07.38: [29413]: <-- data [1030] Oct 30 09:28:07.38: [29413]: <-- data [1037] Oct 30 09:28:07.44: [29413]: <-- data [1043] Oct 30 09:28:07.44: [29413]: <-- data [1043] Oct 30 09:28:07.50: [29413]: <-- data [1024] Oct 30 09:28:07.50: [29413]: <-- data [1034] Oct 30 09:28:08.78: [29413]: <-- data [1029] Oct 30 09:28:08.78: [29413]: <-- data [1030] Oct 30 09:28:09.63: [29413]: <-- data [1049] Oct 30 09:28:10.85: [29413]: <-- data [1036] Oct 30 09:28:10.85: [29413]: <-- data [1031] Oct 30 09:28:11.73: [29413]: <-- data [1046] Oct 30 09:28:12.73: [29413]: <-- data [1030] Oct 30 09:28:12.73: [29413]: <-- data [1031] Oct 30 09:28:13.64: [29413]: <-- data [1029] Oct 30 09:28:14.84: [29413]: <-- data [807] Oct 30 09:28:14.84: [29413]: SENT 16167 bytes of data Oct 30 09:28:14.84: [29413]: <-- data [1024] Oct 30 09:28:15.42: [29413]: <-- data [1024] Oct 30 09:28:16.60: [29413]: <-- data [1024] Oct 30 09:28:16.60: [29413]: <-- data [1024] Oct 30 09:28:17.60: [29413]: <-- data [1024] Oct 30 09:28:18.90: [29413]: <-- data [1024] Oct 30 09:28:18.90: [29413]: <-- data [291] Oct 30 09:28:18.90: [29413]: SENT 6435 bytes of data Oct 30 09:28:18.90: [29413]: SEND 1D RTC Oct 30 09:28:18.90: [29413]: <-- data [29] Oct 30 09:28:18.90: [29413]: <-- data [2] Oct 30 09:28:18.90: [29413]: SEND end page Oct 30 09:28:23.73: [29413]: --> [66:] Oct 30 09:28:23.73: [29413]: --> [2:OK] Oct 30 09:28:23.73: [29413]: DELAY 75 ms Oct 30 09:28:23.82: [29413]: SEND send MPS (more pages, same document) Oct 30 09:28:23.82: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:28:23.89: [29413]: --> [7:CONNECT] Oct 30 09:28:23.89: [29413]: <-- data [3] Oct 30 09:28:23.89: [29413]: <-- data [2] Oct 30 09:28:25.97: [29413]: --> [2:OK] Oct 30 09:28:25.97: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:28:26.21: [29413]: --> [7:CONNECT] Oct 30 09:28:27.49: [29413]: --> [2:OK] Oct 30 09:28:27.49: [29413]: SEND recv RTN (retrain negative) Oct 30 09:28:27.49: [29413]: SEND training at v.17 9600 bit/s Oct 30 09:28:27.49: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:28:27.57: [29413]: --> [7:CONNECT] Oct 30 09:28:27.57: [29413]: <-- data [23] Oct 30 09:28:27.57: [29413]: <-- data [2] Oct 30 09:28:29.53: [29413]: --> [7:CONNECT] Oct 30 09:28:29.54: [29413]: <-- data [6] Oct 30 09:28:29.54: [29413]: <-- data [2] Oct 30 09:28:30.01: [29413]: --> [2:OK] Oct 30 09:28:30.01: [29413]: DELAY 75 ms Oct 30 09:28:30.10: [29413]: <-- [10:AT+FTM=97\r] Oct 30 09:28:30.31: [29413]: --> [7:CONNECT] Oct 30 09:28:30.31: [29413]: <-- data [1024] Oct 30 09:28:30.31: [29413]: <-- data [776] Oct 30 09:28:30.31: [29413]: <-- data [2] Oct 30 09:28:33.27: [29413]: --> [4:] Oct 30 09:28:33.27: [29413]: --> [2:OK] Oct 30 09:28:33.27: [29413]: <-- [9:AT+FRH=3\r] Oct 30 09:28:33.34: [29413]: ABORT: job abort requested Oct 30 09:28:33.34: [29413]: --> [0:] Oct 30 09:28:33.34: [29413]: MODEM <Empty line> Oct 30 09:28:33.35: [29413]: DELAY 1500 ms Oct 30 09:28:34.86: [29413]: SEND training at v.17 9600 bit/s Oct 30 09:28:34.86: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:28:34.86: [29413]: --> [7:CONNECT] Oct 30 09:28:34.86: [29413]: TRAINING failed Oct 30 09:28:34.86: [29413]: <-- [9:AT+FTH=3\r] Oct 30 09:28:34.86: [29413]: --> [7:���}] Oct 30 09:28:34.86: [29413]: SEND FAILED: Job aborted by user Oct 30 09:28:34.86: [29413]: <-- [5:ATH0\r] Oct 30 09:28:34.86: [29413]: --> [2:OK] Oct 30 09:28:35.11: [29413]: SESSION END