Próbuję zestawić stabilne połączenie używając nowo kupionego routera 3G Edimax 3G-6200nL i modemu ZTE MF100.
Po podłączeniu modemu do routera udaje się połączyć, internet śmiga, jednak po 1-3 minutach połączenie pada bez żadnej oczywistej przyczyny. Do tej pory nie udało mi się uzyskać stabilnego połączenia.
Dane, których używam, są zgodne z tymi podawanymi przez operatora (Beeline UZ):
APN: internet.beeline.uz
Login: beeline
Password: beeline
(Co ciekawe, router łączy również na krótko przy wpisaniu APN "internet" i bez uwierzytelniania).
Aktualizacja oprogramowania routera (z 1.02 do 1.03) nie pomaga. Downgrade oprogramowania modemu z V1.0.0.B4 do V1.0.0.B1 sprawia tyle, że - jak wynika z logów - po rozłączeniu modem wydaje się próbować ustanowić połączenie na nowo, bezskutecznie (przy B4 po prostu "kończy działalność").
Log z wersji B4:
Kod: Zaznacz cały
Jan 1 00:00:00 (none) syslog.info syslogd started: BusyBox v1.11.1
Jan 1 00:00:47 (none) local2.notice pppd[1491]: pppd 2.4.4 started by root, uid 0
Jan 1 00:00:48 (none) local2.info chat[1500]: abort on (BUSY)
Jan 1 00:00:48 (none) local2.info chat[1500]: abort on (NO CARRIER)
Jan 1 00:00:48 (none) local2.info chat[1500]: abort on (ERROR)
Jan 1 00:00:48 (none) local2.info chat[1500]: report (CONNECT)
Jan 1 00:00:48 (none) local2.info chat[1500]: timeout set to 10 seconds
Jan 1 00:00:48 (none) local2.info chat[1500]: send (ATZ^M)
Jan 1 00:00:48 (none) local2.info chat[1500]: expect (OK)
Jan 1 00:00:48 (none) local2.info chat[1500]: ^M
Jan 1 00:00:48 (none) local2.info chat[1500]: OK
Jan 1 00:00:48 (none) local2.info chat[1500]: -- got it
Jan 1 00:00:48 (none) local2.info chat[1500]: send (ATE0V1&F&D2&C1S0=0S7=60^M)
Jan 1 00:00:49 (none) local2.info chat[1500]: expect (OK)
Jan 1 00:00:49 (none) local2.info chat[1500]: ^M
Jan 1 00:00:49 (none) local2.info chat[1500]: ^M
Jan 1 00:00:49 (none) local2.info chat[1500]: OK
Jan 1 00:00:49 (none) local2.info chat[1500]: -- got it
Jan 1 00:00:49 (none) local2.info chat[1500]: send (AT+CGDCONT=1,"IP","internet.beeline.uz","",0,0^M)
Jan 1 00:00:50 (none) local2.info chat[1500]: timeout set to 30 seconds
Jan 1 00:00:50 (none) local2.info chat[1500]: expect (OK)
Jan 1 00:00:50 (none) local2.info chat[1500]: ^M
Jan 1 00:00:50 (none) local2.info chat[1500]: ^M
Jan 1 00:00:50 (none) local2.info chat[1500]: OK
Jan 1 00:00:50 (none) local2.info chat[1500]: -- got it
Jan 1 00:00:50 (none) local2.info chat[1500]: send (ATD*99#^M)
Jan 1 00:00:50 (none) local2.info chat[1500]: expect (CONNECT)
Jan 1 00:00:50 (none) local2.info chat[1500]: ^M
Jan 1 00:00:50 (none) local2.info chat[1500]: ^M
Jan 1 00:00:50 (none) local2.info chat[1500]: CONNECT
Jan 1 00:00:50 (none) local2.info chat[1500]: -- got it
Jan 1 00:00:50 (none) local2.info chat[1500]: send ( ^M)
Jan 1 00:00:50 (none) local2.info pppd[1491]: Serial connection established.
Jan 1 00:00:50 (none) local2.debug pppd[1491]: using channel 1
Jan 1 00:00:50 (none) local2.info pppd[1491]: Using interface ppp4
Jan 1 00:00:50 (none) local2.notice pppd[1491]: Connect: ppp4 <--> /dev/ttyUSB3
Jan 1 00:00:53 (none) local2.debug pppd[1491]: sent [LCP ConfReq id=0x1 <mru 1412> <asyncmap 0x0> <magic 0x37526f8c> <pcomp> <accomp>]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [LCP ConfReq id=0xb <asyncmap 0x0> <auth chap MD5> <magic 0x17871be> <pcomp> <accomp>]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: lcp_reqci: returning CONFACK.
Jan 1 00:00:53 (none) local2.debug pppd[1491]: sent [LCP ConfAck id=0xb <asyncmap 0x0> <auth chap MD5> <magic 0x17871be> <pcomp> <accomp>]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [LCP ConfAck id=0x1 <mru 1412> <asyncmap 0x0> <magic 0x37526f8c> <pcomp> <accomp>]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: sent [LCP EchoReq id=0x0 magic=0x37526f8c]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [LCP DiscReq id=0xc magic=0x17871be]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [CHAP Challenge id=0x1 <6006cc079e8cb6e3dc4dcae5601cbe44>, name = "UMTS_CHAP_SRVR"]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: sent [CHAP Response id=0x1 <b7ba5bdc9b41727c09f38a02c78c94a7>, name = "beeline"]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [LCP EchoRep id=0x0 magic=0x17871be 37 52 6f 8c]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [CHAP Success id=0x1 ""]
Jan 1 00:00:53 (none) local2.info pppd[1491]: CHAP authentication succeeded
Jan 1 00:00:53 (none) local2.notice pppd[1491]: CHAP authentication succeeded
Jan 1 00:00:53 (none) local2.debug pppd[1491]: sent [CCP ConfReq id=0x1 <bsd v1 15>]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: rcvd [LCP ProtRej id=0xd 80 fd 01 01 00 07 15 03 2f]
Jan 1 00:00:53 (none) local2.debug pppd[1491]: Protocol-Reject for 'Compression Control Protocol' (0x80fd) received
Jan 1 00:00:54 (none) local2.debug pppd[1491]: rcvd [IPCP ConfNak id=0x1 <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
Jan 1 00:00:54 (none) local2.debug pppd[1491]: sent [IPCP ConfReq id=0x2 <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: rcvd [IPCP ConfNak id=0x2 <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: sent [IPCP ConfReq id=0x3 <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14> <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: rcvd [IPCP ConfReq id=0x4]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: ipcp: returning Configure-NAK
Jan 1 00:00:55 (none) local2.debug pppd[1491]: sent [IPCP ConfNak id=0x4 <addr 0.0.0.0>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: rcvd [IPCP ConfRej id=0x3 <ms-wins 10.11.12.13> <ms-wins 10.11.12.14>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: sent [IPCP ConfReq id=0x4 <addr 0.0.0.0> <ms-dns1 10.11.12.13> <ms-dns2 10.11.12.14>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: rcvd [IPCP ConfReq id=0x5]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: ipcp: returning Configure-ACK
Jan 1 00:00:55 (none) local2.debug pppd[1491]: sent [IPCP ConfAck id=0x5]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: rcvd [IPCP ConfNak id=0x4 <addr 10.11.11.9> <ms-dns1 83.221.161.1> <ms-dns2 83.221.160.1>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: sent [IPCP ConfReq id=0x5 <addr 10.11.11.9> <ms-dns1 83.221.161.1> <ms-dns2 83.221.160.1>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: rcvd [IPCP ConfAck id=0x5 <addr 10.11.11.9> <ms-dns1 83.221.161.1> <ms-dns2 83.221.160.1>]
Jan 1 00:00:55 (none) local2.debug pppd[1491]: ipcp: up
Jan 1 00:00:55 (none) local2.warn pppd[1491]: Could not determine remote IP address: defaulting to 10.64.64.68
Jan 1 00:00:55 (none) local2.notice pppd[1491]: local IP address 10.11.11.9
Jan 1 00:00:55 (none) local2.notice pppd[1491]: remote IP address 10.64.64.68
Jan 1 00:00:55 (none) local2.notice pppd[1491]: primary DNS address 83.221.161.1
Jan 1 00:00:55 (none) local2.notice pppd[1491]: secondary DNS address 83.221.160.1
Jan 1 00:00:55 (none) local2.debug pppd[1491]: Script /etc/ppp/ip-up started (pid 1513)
Sep 4 22:06:11 (none) local2.info pppd[1491]: System time change detected.
Sep 4 22:06:11 (none) local2.debug pppd[1491]: Script /etc/ppp/ip-up finished (pid 1513), status = 0x0
Sep 4 22:07:02 (none) local2.debug pppd[1491]: sent [LCP EchoReq id=0x1 magic=0x37526f8c]
Sep 4 22:07:02 (none) local2.debug pppd[1491]: rcvd [LCP EchoRep id=0x1 magic=0x17871be 37 52 6f 8c]
Sep 4 22:08:02 (none) local2.debug pppd[1491]: sent [LCP EchoReq id=0x2 magic=0x37526f8c]
Sep 4 22:08:02 (none) local2.debug pppd[1491]: rcvd [LCP EchoRep id=0x2 magic=0x17871be 37 52 6f 8c]
Sep 4 22:08:38 (none) local2.debug pppd[1491]: rcvd [LCP TermReq id=0xe]
Sep 4 22:08:38 (none) local2.info pppd[1491]: LCP terminated by peer
Sep 4 22:08:38 (none) local2.debug pppd[1491]: ipcp: down
Sep 4 22:08:38 (none) local2.info pppd[1491]: Connect time 2.6 minutes.
Sep 4 22:08:38 (none) local2.info pppd[1491]: Sent 109114 bytes, received 301232 bytes.
Sep 4 22:08:38 (none) local2.debug pppd[1491]: Script /etc/ppp/ip-down started (pid 2289)
Sep 4 22:08:38 (none) local2.debug pppd[1491]: CCP: Down event in state 1!
Sep 4 22:08:38 (none) local2.debug pppd[1491]: sent [LCP TermAck id=0xe]
Sep 4 22:08:38 (none) local2.debug pppd[1491]: Script /etc/ppp/ip-down finished (pid 2289), status = 0x0
Sep 4 22:08:41 (none) local2.notice pppd[1491]: Connection terminated.
Sep 4 22:08:41 (none) local2.info chat[2317]: send (\K^M)
Sep 4 22:08:41 (none) local2.warn pppd[1491]: disconnect script failed
Sep 4 22:08:43 (none) local2.notice pppd[1491]: Connection terminated.
Sep 4 22:08:43 (none) local2.info pppd[1491]: Terminating on signal 15
Sep 4 22:08:43 (none) local2.notice pppd[1491]: Modem hangup
Sep 4 22:08:43 (none) local2.debug pppd[1491]: LCP: Down event in state 1!
Sep 4 22:08:43 (none) local2.info pppd[1491]: Exit.
Przy firmware B1, przy kolejnych próbach CCP i/lub LCP zwracają stan "0".
Co ciekawe, modem (najwyraźniej bez simlocka) zachowuje się identycznie z kartami SIM innych operatorów oraz... przy podłączeniu bezpośrednio do komputera i skonfigurowaniu połączenia "ręcznie" w Windows (= nie poprzez dołączone oprogramowanie operatora). Czyżby więc dopiero oprogramowanie operatora sprawiało, że modem nie zrywa?
Nie do końca wszystko rozumiem, tak więc będę ogromnie wdzięczny za wszelką pomoc!
k.