• Zarejestrowany: 2012-08-29
  • Posty: 24

Temat: 1043ND i E398 rozłącza się z Play LTE

Dzień dobry.
Posiadam TP-Link TL-WR1043N/ND v1 z softem OpenWrt Barrier Breaker 14.07 / LuCI 0.12 Branch (0.12+git-15.037.36195-f1e2a26). Do niego mam przyłączony aktywny hub USB, a do huba Huawei E398, drukarkę i dysk z własnym zasilaniem. Problem jest z modemem, bo jak przez długi czas działał poprawnie, tak raz na jakiś czas rozłącza się z siecią LTE i nie może połączyć. Manualne łączenie nie pomaga, trzeba router zrestartować żeby ruszyło. Dzisiaj wogóle odmówił posłuszeństwa.

Modem podłączony do komputera łączy się bez problemu.
Poniżej załączam log systemowy. Ktoś coś w nim widzi ciekawego?


Wed Nov 11 03:17:26 2015 daemon.info pppd[5210]: Serial connection established.
Wed Nov 11 03:17:26 2015 daemon.info pppd[5210]: Using interface 3g-wan
Wed Nov 11 03:17:26 2015 daemon.notice pppd[5210]: Connect: 3g-wan <--> /dev/ttyUSB0
Wed Nov 11 03:17:27 2015 daemon.err transmission-daemon[2101]: DHT dht.transmissionbt.com:6881: Name or service not known (tr-dht.c:126)
Wed Nov 11 03:17:33 2015 daemon.info pppd[5210]: No response to 5 echo-requests
Wed Nov 11 03:17:33 2015 daemon.notice pppd[5210]: Serial link appears to be disconnected.
Wed Nov 11 03:17:39 2015 daemon.notice pppd[5210]: Connection terminated.
Wed Nov 11 03:17:39 2015 kern.err kernel: [ 1671.220000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:17:40 2015 daemon.notice pppd[5210]: Modem hangup
Wed Nov 11 03:17:40 2015 daemon.info pppd[5210]: Exit.
Wed Nov 11 03:17:40 2015 daemon.notice netifd: Interface 'wan' is now down
Wed Nov 11 03:17:40 2015 daemon.notice netifd: Interface 'wan' is setting up now
Wed Nov 11 03:17:42 2015 kern.err kernel: [ 1673.930000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:17:42 2015 daemon.notice netifd: wan (5345): Trying to set mode
Wed Nov 11 03:17:58 2015 daemon.notice netifd: wan (5345): Timeout setting WWAN mode!
Wed Nov 11 03:17:58 2015 kern.err kernel: [ 1690.040000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:17:58 2015 daemon.notice pppd[5372]: pppd 2.4.7 started by root, uid 0
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: abort on (BUSY)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: abort on (NO CARRIER)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: abort on (ERROR)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: report (CONNECT)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: timeout set to 10 seconds
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: send (AT&F^M)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: expect (OK)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: AT&F^M^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: OK
Wed Nov 11 03:17:59 2015 local2.info chat[5374]:  -- got it
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: send (ATE1^M)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: expect (OK)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: ^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: ATE1^M^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: OK
Wed Nov 11 03:17:59 2015 local2.info chat[5374]:  -- got it
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: send (AT+CGDCONT=1,"IP","internet"^M)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: timeout set to 30 seconds
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: expect (OK)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: ^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: AT+CGDCONT=1,"IP","internet"^M^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: OK
Wed Nov 11 03:17:59 2015 local2.info chat[5374]:  -- got it
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: send (ATD*99***1#^M)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: expect (CONNECT)
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: ^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: ATD*99***1#^M^M
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: CONNECT
Wed Nov 11 03:17:59 2015 local2.info chat[5374]:  -- got it
Wed Nov 11 03:17:59 2015 local2.info chat[5374]: send ( ^M)
Wed Nov 11 03:17:59 2015 daemon.info pppd[5372]: Serial connection established.
Wed Nov 11 03:17:59 2015 daemon.info pppd[5372]: Using interface 3g-wan
Wed Nov 11 03:17:59 2015 daemon.notice pppd[5372]: Connect: 3g-wan <--> /dev/ttyUSB0
Wed Nov 11 03:18:06 2015 daemon.info pppd[5372]: No response to 5 echo-requests
Wed Nov 11 03:18:06 2015 daemon.notice pppd[5372]: Serial link appears to be disconnected.
Wed Nov 11 03:18:07 2015 daemon.info pppd[5372]: Terminating on signal 15
Wed Nov 11 03:18:12 2015 daemon.notice netifd: Interface 'wan' is now down
Wed Nov 11 03:18:12 2015 daemon.notice netifd: Interface 'wan' is setting up now
Wed Nov 11 03:18:12 2015 kern.err kernel: [ 1704.210000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:18:12 2015 kern.err kernel: [ 1704.320000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:18:13 2015 daemon.notice netifd: wan (5433): comgt 03:18:13 -> -- Error Report --
Wed Nov 11 03:18:13 2015 daemon.notice netifd: wan (5433): comgt 03:18:13 -> ---->              ^
Wed Nov 11 03:18:13 2015 daemon.notice netifd: wan (5433): comgt 03:18:13 -> Error @114, line 9, Could not write to COM device. (1)
Wed Nov 11 03:18:13 2015 daemon.notice netifd: wan (5433):
Wed Nov 11 03:18:13 2015 daemon.notice pppd[5456]: pppd 2.4.7 started by root, uid 0
Wed Nov 11 03:18:13 2015 daemon.notice pppd[5456]: Removed stale lock on ttyUSB0 (pid 5372)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: abort on (BUSY)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: abort on (NO CARRIER)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: abort on (ERROR)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: report (CONNECT)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: timeout set to 10 seconds
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: send (AT&F^M)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: expect (OK)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: AT&F^M^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: OK
Wed Nov 11 03:18:14 2015 local2.info chat[5484]:  -- got it
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: send (ATE1^M)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: expect (OK)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: ^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: ATE1^M^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: OK
Wed Nov 11 03:18:14 2015 local2.info chat[5484]:  -- got it
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: send (AT+CGDCONT=1,"IP","internet"^M)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: timeout set to 30 seconds
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: expect (OK)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: ^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: AT+CGDCONT=1,"IP","internet"^M^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: OK
Wed Nov 11 03:18:14 2015 local2.info chat[5484]:  -- got it
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: send (ATD*99***1#^M)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: expect (CONNECT)
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: ^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: ATD*99***1#^M^M
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: CONNECT
Wed Nov 11 03:18:14 2015 local2.info chat[5484]:  -- got it
Wed Nov 11 03:18:14 2015 local2.info chat[5484]: send ( ^M)
Wed Nov 11 03:18:14 2015 daemon.info pppd[5456]: Serial connection established.
Wed Nov 11 03:18:14 2015 daemon.info pppd[5456]: Using interface 3g-wan
Wed Nov 11 03:18:14 2015 daemon.notice pppd[5456]: Connect: 3g-wan <--> /dev/ttyUSB0
Wed Nov 11 03:18:21 2015 daemon.info pppd[5456]: No response to 5 echo-requests
Wed Nov 11 03:18:21 2015 daemon.notice pppd[5456]: Serial link appears to be disconnected.
Wed Nov 11 03:18:27 2015 daemon.notice pppd[5456]: Connection terminated.
Wed Nov 11 03:18:27 2015 kern.err kernel: [ 1719.550000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:18:28 2015 daemon.notice pppd[5456]: Modem hangup
Wed Nov 11 03:18:28 2015 daemon.info pppd[5456]: Exit.
Wed Nov 11 03:18:28 2015 daemon.notice netifd: Interface 'wan' is now down
Wed Nov 11 03:18:28 2015 daemon.notice netifd: Interface 'wan' is setting up now
Wed Nov 11 03:18:30 2015 kern.err kernel: [ 1722.270000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:18:31 2015 daemon.notice netifd: wan (5594): Trying to set mode
Wed Nov 11 03:18:45 2015 daemon.notice netifd: Interface 'wan' is now down
Wed Nov 11 03:18:45 2015 daemon.notice netifd: Interface 'wan' is setting up now
Wed Nov 11 03:18:47 2015 kern.err kernel: [ 1738.820000] option1 ttyUSB0: option_instat_callback: error -2
Wed Nov 11 03:18:47 2015 daemon.notice pppd[5654]: pppd 2.4.7 started by root, uid 0
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: abort on (BUSY)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: abort on (NO CARRIER)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: abort on (ERROR)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: report (CONNECT)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: timeout set to 10 seconds
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: send (AT&F^M)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: expect (OK)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: AT&F^M^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: OK
Wed Nov 11 03:18:48 2015 local2.info chat[5657]:  -- got it
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: send (ATE1^M)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: expect (OK)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: ^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: ATE1^M^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: OK
Wed Nov 11 03:18:48 2015 local2.info chat[5657]:  -- got it
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: send (AT+CGDCONT=1,"IP","internet"^M)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: timeout set to 30 seconds
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: expect (OK)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: ^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: AT+CGDCONT=1,"IP","internet"^M^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: OK
Wed Nov 11 03:18:48 2015 local2.info chat[5657]:  -- got it
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: send (ATD*99***1#^M)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: expect (CONNECT)
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: ^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: ATD*99***1#^M^M
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: CONNECT
Wed Nov 11 03:18:48 2015 local2.info chat[5657]:  -- got it
Wed Nov 11 03:18:48 2015 local2.info chat[5657]: send ( ^M)
Wed Nov 11 03:18:48 2015 daemon.info pppd[5654]: Serial connection established.
Wed Nov 11 03:18:48 2015 daemon.info pppd[5654]: Using interface 3g-wan
Wed Nov 11 03:18:48 2015 daemon.notice pppd[5654]: Connect: 3g-wan <--> /dev/ttyUSB0

2 Odpowiedź przez Cezary

  • Skąd: Warszawa
  • Zarejestrowany: 2006-02-25
  • Posty: 115,917

Odp: 1043ND i E398 rozłącza się z Play LTE

Wed Nov 11 03:18:06 2015 daemon.info pppd[5372]: No response to 5 echo-requests


Druga strona w ogóle nie odpowiada. Przepnij go do komputera i sprawdź czy nadal działa i np. nie skończyła sie karta.

Masz niepotrzebny router, uszkodzony czy nie - chętnie przygarnę go.

Cezary's Strona

3 Odpowiedź przez kitencjusz

  • Zarejestrowany: 2012-08-29
  • Posty: 24

Odp: 1043ND i E398 rozłącza się z Play LTE

Dzięki za radę. Poprawiłem kartę SIM i ruszyło.
Ale martwi mnie też to samo-rozłączanie. Czasem muszę zrestartować router aby załapał.
Plus to co znalazłem w logu kernela:

[   33.920000] cfg80211:   (2402000 KHz - 2482000 KHz @ 40000 KHz), (N/A, 2000 mBm), (N/A)
[   33.920000] cfg80211:   (5170000 KHz - 5250000 KHz @ 80000 KHz), (N/A, 2000 mBm), (N/A)
[   33.930000] cfg80211:   (5250000 KHz - 5330000 KHz @ 80000 KHz), (N/A, 2000 mBm), (0 s)
[   33.940000] cfg80211:   (5490000 KHz - 5710000 KHz @ 80000 KHz), (N/A, 2700 mBm), (0 s)
[   33.950000] cfg80211:   (57240000 KHz - 65880000 KHz @ 2160000 KHz), (N/A, 4000 mBm), (N/A)
[   34.370000] br-lan: port 1(eth0.1) entered forwarding state
[   34.520000] option1 ttyUSB0: option_instat_callback: error -2
[   37.080000] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
[   37.100000] device wlan0 entered promiscuous mode
[   37.100000] br-lan: port 2(wlan0) entered forwarding state
[   37.110000] br-lan: port 2(wlan0) entered forwarding state
[   37.400000] br-lan: port 2(wlan0) entered disabled state
[   47.480000] br-lan: port 2(wlan0) entered forwarding state
[   47.490000] br-lan: port 2(wlan0) entered forwarding state
[   47.490000] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[   49.490000] br-lan: port 2(wlan0) entered forwarding state
[   51.620000] option1 ttyUSB0: option_instat_callback: error -2
[   68.260000] option1 ttyUSB0: option_instat_callback: error -2
[   70.970000] option1 ttyUSB0: option_instat_callback: error -2
[   87.080000] option1 ttyUSB0: option_instat_callback: error -2
[  101.770000] option1 ttyUSB0: option_instat_callback: error -2
[  104.500000] option1 ttyUSB0: option_instat_callback: error -2
[  120.600000] option1 ttyUSB0: option_instat_callback: error -2
[  135.300000] option1 ttyUSB0: option_instat_callback: error -2
[  138.010000] option1 ttyUSB0: option_instat_callback: error -2
[  154.120000] option1 ttyUSB0: option_instat_callback: error -2

4 Odpowiedź przez Cezary

  • Skąd: Warszawa
  • Zarejestrowany: 2006-02-25
  • Posty: 115,917

Odp: 1043ND i E398 rozłącza się z Play LTE

Port szeregowy nie odpowiada lub już go nie ma.

Masz niepotrzebny router, uszkodzony czy nie - chętnie przygarnę go.

Cezary's Strona

5 Odpowiedź przez Sigma

  • Sigma
  • Użytkownik
  • Nieaktywny
  • Zarejestrowany: 2014-01-25
  • Posty: 239

Odp: 1043ND i E398 rozłącza się z Play LTE

A dlaczego łączysz tego e398 bez qmi? To całkiem wydajny sterownik smile

OpenWrt: WAX206/NWA50AX/EA6350v3 || W szufladzie: WNDR4300/TL-WDR4300/SR3200

6 Odpowiedź przez kitencjusz

  • Zarejestrowany: 2012-08-29
  • Posty: 24

Odp: 1043ND i E398 rozłącza się z Play LTE

Przez QMI jeszcze nie próbowałem, na razie przez LUCI ustawiłem opcje tak żeby to działało. A jak już zadziałało to sprawia kłopoty. Dziś jak wrócę to pokombinuje żeby działało na nowym sterowniku.

7 Odpowiedź przez Sigma

  • Sigma
  • Użytkownik
  • Nieaktywny
  • Zarejestrowany: 2014-01-25
  • Posty: 239

Odp: 1043ND i E398 rozłącza się z Play LTE

Najnowsze Luci od Cezarego (z 28 listopada) ma możliwość wyklikania QMI z poziomu GUI smile

OpenWrt: WAX206/NWA50AX/EA6350v3 || W szufladzie: WNDR4300/TL-WDR4300/SR3200

8 Odpowiedź przez stanlej

  • Zarejestrowany: 2015-05-20
  • Posty: 8

Odp: 1043ND i E398 rozłącza się z Play LTE

Mam identyczny problem. Używam modemu Huawei E3251 z kartą Play, wpiętego bezpośrednio pod TL-WR1043ND v2.1 na oprogramowaniu Gargoyle. Co jakiś czas internet zanika. Muszę restartować router z poziomu oprogramowania lub odłączyć jego zasilanie. Problem występuje od jakiegoś miesiąca z tego co pamiętam. Wcześniej wszystko działało bez zarzutu.

9 Odpowiedź przez Cezary

  • Skąd: Warszawa
  • Zarejestrowany: 2006-02-25
  • Posty: 115,917

Odp: 1043ND i E398 rozłącza się z Play LTE

Pisz się do play. Jak działało i nic nie zmieniałeś to sam widzisz po której stronie jest problem.

Masz niepotrzebny router, uszkodzony czy nie - chętnie przygarnę go.

Cezary's Strona

10 Odpowiedź przez kitencjusz

  • Zarejestrowany: 2012-08-29
  • Posty: 24

Odp: 1043ND i E398 rozłącza się z Play LTE

@ stanlej
Możesz mi napisać jakie prędkości osiągasz na swoim modemie w PLAYu? U mnie niby łączy się przez LTE, ale jak robię pomiary przez Speedtest to w zależności od pory dnia mam 1.3-3.5Mb (godziny wieczorne) do 13-14Mb (6 rano). Jak dla mnie to strasznie mało. Pod router mam podłączony TV i YouTube często się zacina przez niskie transfery, trzeba czekać aż film się zbuforuje i ruszy ale co chwile jest to samo.

11 Odpowiedź przez stanlej

  • Zarejestrowany: 2015-05-20
  • Posty: 8

Odp: 1043ND i E398 rozłącza się z Play LTE

http://www.speedtest.net/result/4883406224.png
Tak to wygląda w tej chwili. Modem HSPA + DC .

12 Odpowiedź przez kitencjusz

  • Zarejestrowany: 2012-08-29
  • Posty: 24

Odp: 1043ND i E398 rozłącza się z Play LTE

A mógłbyś zmierzyć prędkość w porze wieczornej, tj pomiędzy 18 a 21 wtedy gdy ruch jest większy?

13 Odpowiedź przez stanlej

  • Zarejestrowany: 2015-05-20
  • Posty: 8

Odp: 1043ND i E398 rozłącza się z Play LTE

Jasne. Z dotychczasowego doświadczenia w tych godzinach prędkość waha się w granicach 7-9 Mb/s.

14 Odpowiedź przez kitencjusz (edytowany przez kitencjusz 2015-12-03 21:23:50)

  • Zarejestrowany: 2012-08-29
  • Posty: 24

Odp: 1043ND i E398 rozłącza się z Play LTE

U mnie w tym momencie wygląda to tak:
http://www.speedtest.net/result/4885050496.png

15 Odpowiedź przez stanlej

  • Zarejestrowany: 2015-05-20
  • Posty: 8

Odp: 1043ND i E398 rozłącza się z Play LTE

http://www.speedtest.net/result/4885113610.png

Aktualny stan.