ZTE MF622 connection problem

[janprunk]

Hello !

I am on a Debian system trying to make the HDSPA/UMTS Modem ZTE MF622 modem dial via PPP.
I am using usb-modeswitch package to recognise this modem.

But here is what I get:
#syslog
Aug 6 15:29:42 vaio pppd[4675]: pppd 2.4.4 started by root, uid 0
Aug 6 15:29:43 vaio chat[4677]: abort on (BUSY)
Aug 6 15:29:43 vaio chat[4677]: abort on (NO CARRIER)
Aug 6 15:29:43 vaio chat[4677]: abort on (VOICE)
Aug 6 15:29:43 vaio chat[4677]: abort on (NO DIALTONE)
Aug 6 15:29:43 vaio chat[4677]: abort on (NO DIAL TONE)
Aug 6 15:29:43 vaio chat[4677]: abort on (NO ANSWER)
Aug 6 15:29:43 vaio chat[4677]: abort on (DELAYED)
Aug 6 15:29:43 vaio chat[4677]: send (ATZ^M)
Aug 6 15:29:43 vaio chat[4677]: expect (OK)
Aug 6 15:29:43 vaio chat[4677]: ATZ^M^M
Aug 6 15:29:43 vaio chat[4677]: ERROR^M
Aug 6 15:30:28 vaio chat[4677]: alarm
Aug 6 15:30:28 vaio chat[4677]: send (AT^M)
Aug 6 15:30:28 vaio chat[4677]: expect (OK)
Aug 6 15:30:28 vaio chat[4677]: AT^M^M
Aug 6 15:30:28 vaio chat[4677]: OK
Aug 6 15:30:28 vaio chat[4677]: -- got it
Aug 6 15:30:28 vaio chat[4677]: send (ATDT*99#^M)
Aug 6 15:30:28 vaio chat[4677]: expect (CONNECT)
Aug 6 15:30:28 vaio chat[4677]: ^M
Aug 6 15:30:28 vaio chat[4677]: ATDT*99#^M^M
Aug 6 15:30:28 vaio chat[4677]: ERROR^M

vaio:/etc/chatscripts# cat gprs
# This chatfile was generated by pppconfig 2.3.16.
# Please do not delete any of the comments. Pppconfig needs them.
#
# ispauth chat
# abortstring
ABORT BUSY ABORT 'NO CARRIER' ABORT VOICE ABORT 'NO DIALTONE' ABORT 'NO DIAL TONE' ABORT 'NO ANSWER' ABORT DELAYED
# modeminit
'' ATZ
# ispnumber
OK-AT-OK "ATDT*99#"
## '' ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
# ispconnect
CONNECT ''
# prelogin

# ispname

#ogin:mobitel
# "mobitel"
# ogin:mobitel replace_with_name
# isppassword

#password:internet
# "\qinternet"
# ssword:internet \qreplace_with_password
# postlogin
'' \d\c
# end of pppconfig stuff

Thank you for assistance !

[janprunk]

Attached also dmesg log:
11.126723] option 3-1:1.0: GSM modem (1-port) converter detected
[ 11.126813] usb 3-1: GSM modem (1-port) converter now attached to ttyUSB0
[ 11.126831] option 3-1:1.1: GSM modem (1-port) converter detected
[ 11.126886] usb 3-1: GSM modem (1-port) converter now attached to ttyUSB1
[ 11.126901] option 3-1:1.2: GSM modem (1-port) converter detected
[ 11.126952] usb 3-1: GSM modem (1-port) converter now attached to ttyUSB2
[ 11.126972] usbcore: registered new interface driver option
[ 11.126976] option: USB Driver for GSM modems: v0.7.2
[ 11.340697] Yenta: ISA IRQ mask 0x0cb8, PCI irq 21
[ 11.340703] Socket status: 30000006
[ 11.340707] Yenta: Raising subordinate bus# of parent bus (#06) from #07 to #0a
[ 11.340717] pcmcia: parent PCI bridge I/O window: 0x2000 - 0x2fff
[ 11.340722] cs: IO port probe 0x2000-0x2fff: clean.
[ 11.341038] pcmcia: parent PCI bridge Memory window: 0xb0100000 - 0xb01fffff
[ 11.698570] cs: IO port probe 0x100-0x3af: clean.
[ 11.700856] cs: IO port probe 0x3e0-0x4ff: excluding 0x4d0-0x4d7
[ 11.701686] cs: IO port probe 0x820-0x8ff: clean.
[ 11.702369] cs: IO port probe 0xc00-0xcf7: clean.
[ 11.703210] cs: IO port probe 0xa00-0xaff: clean.
[ 11.957044] ACPI: PCI Interrupt 0000:00:1b.0[A] -> GSI 19 (level, low) -> IRQ 19
[ 11.957074] PCI: Setting latency timer of device 0000:00:1b.0 to 64

[janprunk]

There are 2 more things, that came to my mind, regarding the problem:

1. Where do I enter PIN code to the HSDPA modem, when it gets turned on by being plugged into an USB port ?

2. When using my Nokia mobitel phone (another case) I enter PIN when turning on the phone.
It also can establish an Internet connection (sadly just over GPRS), here is the log:
Aug 8 19:14:13 vaio pppd[11344]: pppd 2.4.4 started by root, uid 0
Aug 8 19:14:14 vaio bluetoothd[6673]: link_key_request (sba=00:02:C7:E5:FF:77, dba=00:18:C5D:24:AF)
Aug 8 19:14:15 vaio chat[11348]: abort on (BUSY)
Aug 8 19:14:15 vaio chat[11348]: abort on (NO CARRIER)
Aug 8 19:14:15 vaio chat[11348]: abort on (VOICE)
Aug 8 19:14:15 vaio chat[11348]: abort on (NO DIALTONE)
Aug 8 19:14:15 vaio chat[11348]: abort on (NO DIAL TONE)
Aug 8 19:14:15 vaio chat[11348]: abort on (NO ANSWER)
Aug 8 19:14:15 vaio chat[11348]: abort on (DELAYED)
Aug 8 19:14:15 vaio chat[11348]: send (ATZ^M)
Aug 8 19:14:15 vaio chat[11348]: expect (OK)
Aug 8 19:14:15 vaio chat[11348]: ATZ^M^M
Aug 8 19:14:15 vaio chat[11348]: OK
Aug 8 19:14:15 vaio chat[11348]: -- got it
Aug 8 19:14:15 vaio chat[11348]: send (ATDT*99*#^M)
Aug 8 19:14:16 vaio chat[11348]: expect (CONNECT)
Aug 8 19:14:16 vaio chat[11348]: ^M
Aug 8 19:14:17 vaio chat[11348]: ATDT*99*#^M^M
Aug 8 19:14:17 vaio chat[11348]: CONNECT
Aug 8 19:14:17 vaio chat[11348]: -- got it
Aug 8 19:14:17 vaio chat[11348]: send (\d)
Aug 8 19:14:18 vaio pppd[11344]: Serial connection established.
Aug 8 19:14:18 vaio pppd[11344]: using channel 4
Aug 8 19:14:18 vaio pppd[11344]: Using interface ppp0
Aug 8 19:14:18 vaio pppd[11344]: Connect: ppp0 <--> /dev/rfcomm0
Aug 8 19:14:19 vaio pppd[11344]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x3d9aa8b4> <pcomp> <accomp>]
Aug 8 19:14:19 vaio pppd[11344]: rcvd [LCP ConfRej id=0x1 <magic 0x3d9aa8b4> <pcomp> <accomp>]
Aug 8 19:14:19 vaio pppd[11344]: sent [LCP ConfReq id=0x2 <asyncmap 0x0>]
Aug 8 19:14:19 vaio pppd[11344]: rcvd [LCP ConfAck id=0x2 <asyncmap 0x0>]
Aug 8 19:14:20 vaio pppd[11344]: rcvd [LCP ConfReq id=0x0 <auth pap> <mru 1500> <asyncmap 0xa0000>]
Aug 8 19:14:20 vaio pppd[11344]: sent [LCP ConfAck id=0x0 <auth pap> <mru 1500> <asyncmap 0xa0000>]
Aug 8 19:14:20 vaio pppd[11344]: sent [LCP EchoReq id=0x0 magic=0x0]
Aug 8 19:14:20 vaio pppd[11344]: sent [PAP AuthReq id=0x1 user="mobitel" password=<hidden>]
Aug 8 19:14:20 vaio pppd[11344]: rcvd [LCP EchoRep id=0x0 magic=0x0]
Aug 8 19:14:20 vaio pppd[11344]: rcvd [PAP AuthAck id=0x1 ""]
Aug 8 19:14:20 vaio pppd[11344]: PAP authentication succeeded
Aug 8 19:14:20 vaio pppd[11344]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Aug 8 19:14:20 vaio pppd[11344]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Aug 8 19:14:20 vaio pppd[11344]: rcvd [IPCP ConfReq id=0x0 <addr 10.6.6.6>]
Aug 8 19:14:20 vaio pppd[11344]: sent [IPCP ConfAck id=0x0 <addr 10.6.6.6>]
Aug 8 19:14:20 vaio pppd[11344]: rcvd [LCP ProtRej id=0x0 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Aug 8 19:14:20 vaio pppd[11344]: Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
Aug 8 19:14:22 vaio pppd[11344]: rcvd [IPCP ConfRej id=0x1 <compress VJ 0f 01>]
Aug 8 19:14:22 vaio pppd[11344]: sent [IPCP ConfReq id=0x2 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns3 0.0.0.0>]
Aug 8 19:14:22 vaio pppd[11344]: rcvd [IPCP ConfNak id=0x2 <addr 10.203.153.190> <ms-dns1 213.229.249.161> <ms-dns3 193.189.160.13>]
Aug 8 19:14:22 vaio pppd[11344]: sent [IPCP ConfReq id=0x3 <addr 10.203.153.190> <ms-dns1 213.229.249.161> <ms-dns3 193.189.160.13>]
Aug 8 19:14:22 vaio pppd[11344]: rcvd [IPCP ConfAck id=0x3 <addr 10.203.153.190> <ms-dns1 213.229.249.161> <ms-dns3 193.189.160.13>]
Aug 8 19:14:22 vaio pppd[11344]: Cannot determine ethernet address for proxy ARP
Aug 8 19:14:22 vaio pppd[11344]: local IP address 10.203.153.190
Aug 8 19:14:22 vaio pppd[11344]: remote IP address 10.6.6.6
Aug 8 19:14:22 vaio pppd[11344]: primary DNS address 213.229.249.161
Aug 8 19:14:22 vaio pppd[11344]: secondary DNS address 193.189.160.13
Aug 8 19:14:22 vaio pppd[11344]: Script /etc/ppp/ip-up started (pid 11352)
Aug 8 19:14:22 vaio pppd[11344]: Script /etc/ppp/ip-up finished (pid 11352), status = 0x0
Aug 8 19:14:25 vaio ntpd[3031]: sendto(89.212.75.6) (fd=19): Invalid argument

[janprunk]

Hello !

The problem is now half-way solved:
I entered the PIN code by executing:
echo 'at+cpin="1234"' > /dev/ttyUSB0

But I still get this error
:
## /etc/chatscripts/provider

# This chatfile was generated by pppconfig 2.3.16.
# Please do not delete any of the comments. Pppconfig needs them.
#
# ispauth chat
# abortstring
ABORT BUSY ABORT 'NO CARRIER' ABORT VOICE ABORT 'NO DIALTONE' ABORT 'NO DIAL TONE' ABORT 'NO ANSWER' ABORT DELAYED
# modeminit
'' ATZ
# ispnumber
OK-AT-OK "ATDT*99#"
## '' ATQ0 V1 E1 S0=0 &C1 &D2 +FCLASS=0
# ispconnect
CONNECT \d\c

#ogin:mobitel
# "mobitel"
# ogin:mobitel replace_with_name
# isppassword

#password:internet
# "\qinternet"
# ssword:internet \qreplace_with_password
# postlogin
# end of pppconfig stuff

## error with "pon provider"

Aug 8 21:13:22 vaio chat[4821]: expect (OK)
Aug 8 21:13:22 vaio chat[4821]: ATZ^M^M
Aug 8 21:13:22 vaio chat[4821]: OK
Aug 8 21:13:22 vaio chat[4821]: -- got it
Aug 8 21:13:22 vaio chat[4821]: send (ATDT*99#^M)
Aug 8 21:13:22 vaio chat[4821]: expect (CONNECT)
Aug 8 21:13:22 vaio chat[4821]: ^M
Aug 8 21:13:22 vaio chat[4821]: ATDT*99#^M^M
Aug 8 21:13:22 vaio chat[4821]: CONNECT
Aug 8 21:13:22 vaio chat[4821]: -- got it
Aug 8 21:13:22 vaio chat[4821]: send (\d)
Aug 8 21:13:23 vaio pppd[4819]: Serial connection established.
Aug 8 21:13:23 vaio pppd[4819]: using channel 3
Aug 8 21:13:23 vaio pppd[4819]: Using interface ppp0
Aug 8 21:13:23 vaio pppd[4819]: Connect: ppp0 <--> /dev/ttyUSB0
Aug 8 21:13:24 vaio pppd[4819]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xcabc37ce> <pcomp> <accomp>]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [LCP ConfReq id=0x8 <asyncmap 0x0> <auth chap MD5> <magic 0xfee4e9> <pcomp> <accomp>]
Aug 8 21:13:24 vaio pppd[4819]: sent [LCP ConfNak id=0x8 <auth pap>]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xcabc37ce> <pcomp> <accomp>]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [LCP ConfReq id=0x9 <asyncmap 0x0> <auth pap> <magic 0xfee4e9> <pcomp> <accomp>]
Aug 8 21:13:24 vaio pppd[4819]: sent [LCP ConfAck id=0x9 <asyncmap 0x0> <auth pap> <magic 0xfee4e9> <pcomp> <accomp>]
Aug 8 21:13:24 vaio pppd[4819]: sent [LCP EchoReq id=0x0 magic=0xcabc37ce]
Aug 8 21:13:24 vaio pppd[4819]: sent [PAP AuthReq id=0x1 user="mobitel" password=<hidden>]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [LCP DiscReq id=0xa magic=0xfee4e9]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [LCP EchoRep id=0x0 magic=0xfee4e9 ca bc 37 ce]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [PAP AuthAck id=0x1 ""]
Aug 8 21:13:24 vaio pppd[4819]: PAP authentication succeeded
Aug 8 21:13:24 vaio pppd[4819]: sent [CCP ConfReq id=0x1 <deflate 15> <deflate(old#) 15> <bsd v1 15>]
Aug 8 21:13:24 vaio pppd[4819]: sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0>]
Aug 8 21:13:24 vaio pppd[4819]: rcvd [LCP ProtRej id=0xb 80 fd 01 01 00 0f 1a 04 78 00 18 04 78 00 15 03 2f]
Aug 8 21:13:24 vaio pppd[4819]: Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
Aug 8 21:13:24 vaio pppd[4819]: Hangup (SIGHUP)