Acermodem 56 Surf can't receive fax
Frank Thieme (fthieme@gmx.net)
Sun, 17 Jan 1999 00:11:37 +0100
Howdy!
I just bought this Modem after my older one gave up.
Ok I tried to get faxes, but it doesn't work. I haven't tried to send
yet.
Here's the log:
01/15 16:45:55 yS1 mgetty: experimental test release 1.1.19-Nov24
01/15 16:45:55 yS1 check for lockfiles
01/15 16:45:55 yS1 checklock: stat failed, no file
01/15 16:45:55 yS1 locking the line
01/15 16:45:55 yS1 makelock(ttyS1) called
01/15 16:45:55 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
01/15 16:45:55 yS1 lock made
01/15 16:45:56 yS1 tio_get_rs232_lines: status: RTS CTS DSR DTR
01/15 16:45:56 yS1 lowering DTR to reset Modem
01/15 16:45:56 yS1 tss: set speed to 115200 (10002)
01/15 16:45:56 yS1 tio_set_flow_control( HARD )
01/15 16:45:56 yS1 waiting for line to clear (VTIME), read:
01/15 16:45:56 yS1 send: \dATQ0V1H0[0d]
01/15 16:45:57 yS1 waiting for ``OK''
01/15 16:45:57 yS1 got: ATQ0V1H0[0d]
01/15 16:45:57 yS1 CND: ATQ0V1H0[0d][0a]OK ** found **
01/15 16:45:57 yS1 send: ATS0=0Q0&D3&C1[0d]
01/15 16:45:57 yS1 waiting for ``OK''
01/15 16:45:57 yS1 got: [0d]
01/15 16:45:57 yS1 CND: OK[0a]ATS0=0Q0&D3&C1[0d]
01/15 16:45:57 yS1 CND: ATS0=0Q0&D3&C1[0d][0a]OK ** found **
I also tried ATZ instead of the standard init-chat
01/15 16:45:57 yS1 mdm_send: 'ATI'
01/15 16:45:57 yS1 got:[0d][0a]ATI[0d]
01/15 16:45:57 yS1 got:[0d][0a]5601[0d]
01/15 16:45:57 yS1 mdm_gis: string 1: '5601'
01/15 16:45:57 yS1 got:[0a][0d][0a]OK[0d]
01/15 16:45:57 yS1 mdm_identify: string '5601'
01/15 16:45:57 yS1 USR Courier/Sportster 56k detected
01/15 16:45:58 yS1 mdm_send: 'ATI3'
01/15 16:45:58 yS1 got:[0a]ATI3[0d]
01/15 16:45:58 yS1 got:[0d][0a]Texas Instruments RK 56000 Fax Rev.
4.7.30[0d]
01/15 16:45:58 yS1 mdm_gis: string 1: 'Texas Instruments RK 56000 Fax
Rev. 4.7.30'
01/15 16:45:58 yS1 got:[0a][0d][0a]OK[0d]
01/15 16:45:58 yS1 additional info: 'Texas Instruments RK 56000 Fax
Rev. 4.7.30'
01/15 16:45:58 yS1 mdm_send: 'AT+FCLASS=2.0'
01/15 16:45:58 yS1 got:[0a]AT+FCLASS=2.0[0d]
01/15 16:45:58 yS1 mdm_command: string 'AT+FCLASS=2.0'
01/15 16:45:58 yS1 got:[0d][0a]OK[0d]
01/15 16:45:58 yS1 mdm_command: string 'OK' -> OK
01/15 16:45:58 yS1 mdm_send: 'AT+FAA=1;+FCR=1'
01/15 16:45:58 yS1 got:[0a]AT+FAA=1;+FCR=1[0d]
01/15 16:45:58 yS1 mdm_command: string 'AT+FAA=1;+FCR=1'
01/15 16:45:58 yS1 got:[0d][0a]OK[0d]
01/15 16:45:58 yS1 mdm_command: string 'OK' -> OK
01/15 16:45:58 yS1 mdm_send: 'AT+FBO=1'
01/15 16:45:58 yS1 got:[0a]AT+FBO=1[0d]
01/15 16:45:58 yS1 mdm_command: string 'AT+FBO=1'
01/15 16:45:58 yS1 got:[0d][0a]OK[0d]
01/15 16:45:58 yS1 mdm_command: string 'OK' -> OK
01/15 16:45:58 yS1 mdm_send: 'AT+FNR=1,1,1,0'
01/15 16:45:58 yS1 got:[0a]AT+FNR=1,1,1,0[0d]
01/15 16:45:58 yS1 mdm_command: string 'AT+FNR=1,1,1,0'
01/15 16:45:58 yS1 got:[0d][0a]OK[0d]
01/15 16:45:58 yS1 mdm_command: string 'OK' -> OK
01/15 16:45:59 yS1 mdm_send: 'AT+FLI="+49-341-4217636"'
01/15 16:45:59 yS1 got:[0a]AT+FLI="+49-341-4217636"[0d]
01/15 16:45:59 yS1 mdm_command: string 'AT+FLI="+49-341-4217636"'
01/15 16:45:59 yS1 got:[0d][0a]OK[0d]
01/15 16:45:59 yS1 mdm_command: string 'OK' -> OK
01/15 16:45:59 yS1 mdm_send: 'AT+FCC=1,5,0,2,0,0,0,0'
01/15 16:45:59 yS1 got:[0a]AT+FCC=1,5,0,2,0,0,0,0[0d]
01/15 16:45:59 yS1 mdm_command: string 'AT+FCC=1,5,0,2,0,0,0,0'
01/15 16:45:59 yS1 got:[0d][0a]OK[0d]
01/15 16:45:59 yS1 mdm_command: string 'OK' -> OK
the Sportster workaround 1,5,0,2,0,0,0,5 doesn't work...
01/15 16:45:59 yS1 waiting for line to clear (VTIME), read:
01/15 16:45:59 yS1 removing lock file
01/15 16:45:59 yS1 waiting...
01/15 16:49:15 yS1 select returned 1
01/15 16:49:15 yS1 checking lockfiles, locking the line
01/15 16:49:15 yS1 makelock(ttyS1) called
01/15 16:49:15 yS1 do_makelock: lock='/var/lock/LCK..ttyS1'
01/15 16:49:15 yS1 lock made
01/15 16:49:15 yS1 wfr: waiting for ``RING''
01/15 16:49:15 yS1 got: [0a][0d][0a]RING[0d]
01/15 16:49:15 yS1 CND: RING
01/15 16:49:15 yS1 wfr: rc=0, drn=0
01/15 16:49:15 yS1 send: ATA[0d]
01/15 16:49:15 yS1 waiting for ``CONNECT''
01/15 16:49:15 yS1 got: ATA[0d]
01/15 16:49:15 yS1 CND: OKATA[0d][0a]+FCO[0d]
01/15 16:49:23 yS1 CND: +FCO
01/15 16:49:23 yS1 found action string: ``+FCO_''
01/15 16:49:23 yS1 start fax receiver...
01/15 16:49:23 yS1 fax receiver: entry
01/15 16:49:23 yS1 fax_wait_for(OK)
01/15 16:49:23 yS1 got:[0a][0a][0d][0a]+FTI:"+49441800668007
"[0d]
01/15 16:49:25 yS1 fax_wait_for: string '+FTI:"+49441800668007 "'
01/15 16:49:25 yS1 fax_id: '+FTI:"+49441800668007 "'
01/15 16:49:25 yS1 got:[0a][0d][0a]+FCS:1,5,0,2,0,0,0,0[0d]
01/15 16:49:25 yS1 fax_wait_for: string '+FCS:1,5,0,2,0,0,0,0'
01/15 16:49:25 yS1 transmission par.: '+FCS:1,5,0,2,0,0,0,0'
01/15 16:49:25 yS1 got:[0a][0d][0a]OK[0d]
01/15 16:49:25 yS1 fax_wait_for: string 'OK'** found **
01/15 16:49:25 yS1 looking for utmp entry... (my PID: 2262)
01/15 16:49:25 yS1 utmp + wtmp entry made
01/15 16:49:25 yS1 tio_set_flow_control( HARD XON_IN )
01/15 16:49:25 yS1 mdm_send: 'AT+FLO=2'
01/15 16:49:25 yS1 got:[0a]AT+FLO=2[0d]
01/15 16:49:25 yS1 mdm_command: string 'AT+FLO=2'
01/15 16:49:25 yS1 got:[0d][0a]OK[0d]
01/15 16:49:25 yS1 mdm_command: string 'OK' -> OK
01/15 16:49:25 yS1 fax_send: 'AT+FDR'
01/15 16:49:25 yS1 fax_wait_for(CONNECT)
01/15 16:49:25 yS1 got:[0a]AT+FDR[0d]
01/15 16:49:25 yS1 fax_wait_for: string 'AT+FDR'
01/15 16:49:25 yS1 got:[0d][0a]CONNECT[0d]
01/15 16:49:31 yS1 fax_wait_for: string 'CONNECT'** found **
01/15 16:49:31 yS1 sending DC2
01/15 16:49:31 yS1 fax_get_page_data: wait for EOL, got:
[0a][19]D5V='v[11]L[0f][ab][d6][9b]sGZ[a8][b6][df][8d][d1][a3]}[c0][19]dH[1e]lx[84]c[0d][f8]$[87][18]m[c7][b3]m[8d][8c][01][e6][98][84]
[de]r9[b5][99][f6][98]y[e7][1c]i[e9][99]v[15][9b][12]T[c6]a[d4]fED[19][85][c4][bf][ad]Bf[a6]5[ec][09][d7][02][85][87][de]z[06][df][92][b6][19]nW\[96][d8][9c]f;[f5]i[8d][d7]a[81][8f]}[cc][89]}[97][9c]e[f7][9b]lg[da][12]v[9c][9e]7'[a6][a7]`[b8][17][db][03][f7]Y[0e]W[03][9d][ef][19][ba]M[1c]ti[98]d[16][d8][05][c7][1e][9a][9c][9a]sC[9b]u[97][1a]q[86][07]e[f1][e7]a[e6][9e]hg'nY[f7][99][d6]
tb-[17][13][9b][8a][d1][da]x8[98]a[f6][d9]sw[9d][d4][f7]Xe[a7][99][89][86][da][a1][c9]/i[d6][de]i[cb]Yz[ee][19]l&\[1a]6[1c]}[87][02]j[10]
01/15 16:49:31 yS1 fax_get_page_data: receiving
/var/spool/fax/incoming/ff69f637bS1-+49441800668007.01...
01/15 16:49:32 yS1 fax_get_page_data: page end, bytes received: 1598
01/15 16:49:32 yS1 fax_wait_for(OK)
01/15 16:49:32 yS1 got:[0d][0a]+FPS:1,3,0,0,0[0d]
01/15 16:49:32 yS1 fax_wait_for: string '+FPS:1,3,0,0,0'
01/15 16:49:32 yS1 page status: +FPS:1,3,0,0,0
01/15 16:49:32 yS1 3 lines received, 0 lines bad, 0 bytes lost
01/15 16:49:32 yS1 got:[0a][0d][0a]+FHS:A1[0d]
01/15 16:49:41 yS1 fax_wait_for: string '+FHS:A1'
01/15 16:49:41 yS1 connection hangup: '+FHS:A1'
01/15 16:49:41 yS1 (Unexpected hangup / read() error / write() error
(int.))
01/15 16:49:41 yS1 got:[0a][0d][0a]OK[0d]
01/15 16:49:41 yS1 fax_wait_for: string 'OK'** found **
01/15 16:49:41 yS1 fax receiver: hangup & end
01/15 16:49:41 yS1 fax_notify_mail: sending mail to: faxadmin
01/15 16:49:42 ##### fax dev=ttyS1, pid=2262, caller='none', name='',
id='+49441800668007 ', +FHNG=-05, pages=1, time=00:00:26