Temat: Huawei HG553 + Huawei E398 -> Aero2 (pakiet) ciągłe rozłączanie
Witam,
Sprzęt taki jak w/w. Open WRT :
BusyBox v1.23.2 (2016-07-09 11:24:20 CEST) built-in shell (ash)
_ _____ _____
| | / ____|_ _|
| | _ _| | | |
| | | | | | | | |
| |___| |_| | |____ _| |_
|______\__,_|\_____|_____|
----------------------------------------------------------------
| |
| OpenWrt Chaos Calmer 15.05.1 (r49474) |
| Build time: 2016-11-11 17:42 CET |
| |
| Cezary Jackiewicz (obsy), [url]http://eko.one.pl[/url] |
| |
----------------------------------------------------------------
| Machine: Huawei EchoLife HG553Natomiast modem, wydaje mi się, że to Huawei E398 u-18, napisy na obudowie :
HUAWEI Mobile Broadband
LTE USB Rotator
HUAWEI E398Od samego początku kiedy mam ten zestaw i od kiedy kupuję w Aero2 pakiety (30gb / 30zł) mam wrażenie, że wcześniej nie działo się to tak często - po jakimś czasie się to nasiliło. Ale to może być tylko moje wrażenie. W pewnym momencie po prostu Interfejs odpowiedzialny za modem 3g przestaje działać, traci połączenie i nie jest w stanie się podnieść. W kółko próbuje wysłać komendy do połączenia i nic się nie dzieje (czasem po 30 minutach się obudzi i mu się uda, ale nie zawsze). Podczas połączenia wygląda to tak (wyciagnięcie modemu z USB) :
un Dec 18 20:03:56 2016 kern.info kernel: [ 921.348000] usb 1-1: USB disconnect, device number 2
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.352000] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.360000] option 1-1:1.0: device disconnected
Sun Dec 18 20:03:56 2016 kern.err kernel: [ 921.368000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 20:03:56 2016 kern.err kernel: [ 921.376000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 20:03:56 2016 kern.err kernel: [ 921.384000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 20:03:56 2016 kern.err kernel: [ 921.392000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.416000] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.424000] option 1-1:1.1: device disconnected
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.428000] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.440000] option 1-1:1.2: device disconnected
Sun Dec 18 20:03:56 2016 kern.info kernel: [ 921.444000] qmi_wwan 1-1:1.3 wwan0: unregister 'qmi_wwan' usb-ehci-platform-1, WWAN/QMI device
Sun Dec 18 20:03:56 2016 daemon.notice pppd[2268]: Modem hangup
Sun Dec 18 20:03:56 2016 daemon.info pppd[2268]: Connect time 13.4 minutes.
Sun Dec 18 20:03:56 2016 daemon.info pppd[2268]: Sent 2277115 bytes, received 50440981 bytes.
Sun Dec 18 20:03:56 2016 daemon.notice pppd[2268]: Connection terminated.
Sun Dec 18 20:03:56 2016 daemon.notice netifd: Network device '3g-wan' link is down
Sun Dec 18 20:03:56 2016 daemon.notice netifd: Network alias '3g-wan' link is down
Sun Dec 18 20:03:56 2016 daemon.notice netifd: Interface 'wan_6' has link connectivity loss
Sun Dec 18 20:03:56 2016 daemon.info pppd[2268]: Exit.
Sun Dec 18 20:03:56 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:03:56 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:03:56 2016 daemon.warn dnsmasq[1851]: no servers found in /tmp/resolv.conf.auto, will retry
Sun Dec 18 20:03:57 2016 daemon.notice netifd: Interface 'wan_6' is now down
Sun Dec 18 20:03:57 2016 daemon.notice netifd: Interface 'wan_6' is disabled
Sun Dec 18 20:03:58 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:04:06 2016 kern.info kernel: [ 931.980000] usb 1-1: new high-speed USB device number 3 using ehci-platform
Sun Dec 18 20:04:06 2016 kern.info kernel: [ 932.132000] usb-storage 1-1:1.0: USB Mass Storage device detected
Sun Dec 18 20:04:06 2016 kern.info kernel: [ 932.160000] scsi host2: usb-storage 1-1:1.0
Sun Dec 18 20:04:07 2016 kern.notice kernel: [ 933.164000] scsi 2:0:0:0: CD-ROM HUAWEI Mass Storage 2.31 PQ: 0 ANSI: 0
Sun Dec 18 20:04:08 2016 kern.info kernel: [ 933.492000] usb 1-1: USB disconnect, device number 3
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 941.812000] usb 1-1: new high-speed USB device number 4 using ehci-platform
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 941.960000] option 1-1:1.0: GSM modem (1-port) converter detected
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 941.968000] usb 1-1: GSM modem (1-port) converter now attached to ttyUSB0
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 941.976000] option 1-1:1.1: GSM modem (1-port) converter detected
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 941.984000] usb 1-1: GSM modem (1-port) converter now attached to ttyUSB1
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 941.992000] option 1-1:1.2: GSM modem (1-port) converter detected
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.000000] usb 1-1: GSM modem (1-port) converter now attached to ttyUSB2
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.048000] qmi_wwan 1-1:1.3: cdc-wdm0: USB WDM device
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.056000] qmi_wwan 1-1:1.3 wwan0: register 'qmi_wwan' at usb-ehci-platform-1, WWAN/QMI device, 00:a0:c6:00:00:00
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.068000] usb-storage 1-1:1.5: USB Mass Storage device detected
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.084000] scsi host3: usb-storage 1-1:1.5
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.088000] usb-storage 1-1:1.6: USB Mass Storage device detected
Sun Dec 18 20:04:16 2016 kern.info kernel: [ 942.108000] scsi host4: usb-storage 1-1:1.6
Sun Dec 18 20:04:17 2016 kern.notice kernel: [ 943.088000] scsi 3:0:0:0: CD-ROM HUAWEI Mass Storage 2.31 PQ: 0 ANSI: 0
Sun Dec 18 20:04:17 2016 kern.notice kernel: [ 943.128000] scsi 4:0:0:0: Direct-Access HUAWEI SD Storage 2.31 PQ: 0 ANSI: 2
Sun Dec 18 20:04:17 2016 kern.notice kernel: [ 943.148000] sd 4:0:0:0: [sda] Attached SCSI removable disk
Sun Dec 18 20:04:19 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:04:23 2016 daemon.notice pppd[3457]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: abort on (BUSY)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: abort on (NO CARRIER)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: abort on (ERROR)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: report (CONNECT)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: timeout set to 10 seconds
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: send (AT&F^M)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: expect (OK)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: AT&F^M^M
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: OK
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: -- got it
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: send (ATE1^M)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: expect (OK)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: ^M
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: ATE1^M^M
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: OK
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: -- got it
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: send (AT+CGDCONT=1,"IP","darmowy"^M)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: timeout set to 30 seconds
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: expect (OK)
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: ^M
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: AT+CGDCONT=1,"IP","darmowy"^M^M
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: +CME ERROR
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: -- failed
Sun Dec 18 20:04:24 2016 local2.info chat[3480]: Failed (ERROR)
Sun Dec 18 20:04:24 2016 daemon.err pppd[3457]: Connect script failed
Sun Dec 18 20:04:25 2016 daemon.info pppd[3457]: Exit.
Sun Dec 18 20:04:25 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:04:25 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:04:28 2016 daemon.notice netifd: wan (3529): Trying to set mode
Sun Dec 18 20:04:29 2016 daemon.notice pppd[3553]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: abort on (BUSY)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: abort on (NO CARRIER)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: abort on (ERROR)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: report (CONNECT)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: timeout set to 10 seconds
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: send (AT&F^M)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: expect (OK)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ^SIMST:1^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: AT&F^M^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: OK
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: -- got it
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: send (ATE1^M)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: expect (OK)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ATE1^M^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: OK
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: -- got it
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: send (AT+CGDCONT=1,"IP","darmowy"^M)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: timeout set to 30 seconds
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: expect (OK)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: AT+CGDCONT=1,"IP","darmowy"^M^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: OK
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: -- got it
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: send (ATD*99***1#^M)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: expect (CONNECT)
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: ATD*99***1#^M^M
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: CONNECT
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: -- got it
Sun Dec 18 20:04:30 2016 local2.info chat[3555]: send ( ^M)
Sun Dec 18 20:04:30 2016 daemon.info pppd[3553]: Serial connection established.
Sun Dec 18 20:04:30 2016 kern.info kernel: [ 956.064000] 3g-wan: renamed from ppp0
Sun Dec 18 20:04:30 2016 daemon.info pppd[3553]: Using interface 3g-wan
Sun Dec 18 20:04:30 2016 daemon.notice pppd[3553]: Connect: 3g-wan <--> /dev/ttyUSB1
Sun Dec 18 20:04:39 2016 daemon.warn pppd[3553]: Could not determine remote IP address: defaulting to 10.64.64.64
Sun Dec 18 20:04:39 2016 daemon.notice pppd[3553]: local IP address 100.83.160.29
Sun Dec 18 20:04:39 2016 daemon.notice pppd[3553]: remote IP address 10.64.64.64
Sun Dec 18 20:04:39 2016 daemon.notice pppd[3553]: primary DNS address 212.2.96.51
Sun Dec 18 20:04:39 2016 daemon.notice pppd[3553]: secondary DNS address 212.2.96.52
Sun Dec 18 20:04:39 2016 daemon.notice netifd: Network device '3g-wan' link is up
Sun Dec 18 20:04:39 2016 daemon.notice netifd: Interface 'wan' is now up
Sun Dec 18 20:04:39 2016 daemon.info dnsmasq[1851]: reading /tmp/resolv.conf.auto
Sun Dec 18 20:04:39 2016 daemon.info dnsmasq[1851]: using local addresses only for domain lan
Sun Dec 18 20:04:39 2016 daemon.info dnsmasq[1851]: using nameserver 212.2.96.51#53
Sun Dec 18 20:04:39 2016 daemon.info dnsmasq[1851]: using nameserver 212.2.96.52#53
Sun Dec 18 20:04:39 2016 daemon.notice netifd: Network alias '3g-wan' link is up
Sun Dec 18 20:04:39 2016 daemon.notice netifd: Interface 'wan_6' is enabled
Sun Dec 18 20:04:39 2016 daemon.notice netifd: Interface 'wan_6' has link connectivity
Sun Dec 18 20:04:39 2016 daemon.notice netifd: Interface 'wan_6' is setting up now
Sun Dec 18 20:04:40 2016 user.notice firewall: Reloading firewall due to ifup of wan (3g-wan)
Sun Dec 18 20:04:44 2016 user.notice ddns-scripts[3697]: myddns_ipv4: PID '3697' started at 2016-12-18 20:04
Sun Dec 18 20:04:45 2016 user.warn ddns-scripts[3697]: myddns_ipv4: Service section disabled! - TERMINATE
Sun Dec 18 20:04:45 2016 user.warn ddns-scripts[3697]: myddns_ipv4: PID '3697' exit WITH ERROR '1' at 2016-12-18 20:04
Sun Dec 18 20:05:01 2016 daemon.warn pppd[3553]: IPV6CP: timeout sending Config-Requests
Sun Dec 18 20:09:35 2016 daemon.info hostapd: wlan0: STA f0:d5:bf:44:bb:4b WPA: group key handshake completed (RSN)W pewnym momencie natomiast coś złego się dzieje - i tutaj nie ma reguły czy pakiety z Internetu są odbierane czy nie, logread wygląda bezustannie tak :
un Dec 18 20:56:54 2016 daemon.info pppd[4409]: No response to 5 echo-requests
Sun Dec 18 20:56:54 2016 daemon.notice pppd[4409]: Serial link appears to be disconnected.
Sun Dec 18 20:56:54 2016 daemon.info pppd[4409]: Connect time 36.2 minutes.
Sun Dec 18 20:56:54 2016 daemon.info pppd[4409]: Sent 4942289 bytes, received 122727320 bytes.
Sun Dec 18 20:56:54 2016 daemon.notice netifd: Network device '3g-wan' link is down
Sun Dec 18 20:56:54 2016 daemon.notice netifd: Network alias '3g-wan' link is down
Sun Dec 18 20:56:54 2016 daemon.notice netifd: Interface 'wan_6' has link connectivity loss
Sun Dec 18 20:56:54 2016 daemon.info pppd[4409]: Terminating on signal 15
Sun Dec 18 20:56:59 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:56:59 2016 daemon.notice netifd: Interface 'wan_6' is disabled
Sun Dec 18 20:56:59 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:56:59 2016 daemon.warn dnsmasq[1851]: no servers found in /tmp/resolv.conf.auto, will retry
Sun Dec 18 20:57:01 2016 daemon.notice pppd[5977]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:57:01 2016 daemon.notice pppd[5977]: Removed stale lock on ttyUSB1 (pid 4409)
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: abort on (BUSY)
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: abort on (NO CARRIER)
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: abort on (ERROR)
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: report (CONNECT)
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: timeout set to 10 seconds
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: send (AT&F^M)
Sun Dec 18 20:57:02 2016 local2.info chat[5982]: expect (OK)
Sun Dec 18 20:57:12 2016 local2.info chat[5982]: alarm
Sun Dec 18 20:57:12 2016 local2.info chat[5982]: Failed
Sun Dec 18 20:57:12 2016 daemon.err pppd[5977]: Connect script failed
Sun Dec 18 20:57:13 2016 daemon.info pppd[5977]: Exit.
Sun Dec 18 20:57:13 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:57:13 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:57:15 2016 daemon.notice pppd[6008]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:57:16 2016 local2.info chat[6010]: abort on (BUSY)
Sun Dec 18 20:57:16 2016 local2.info chat[6010]: abort on (NO CARRIER)
Sun Dec 18 20:57:16 2016 local2.info chat[6010]: abort on (ERROR)
Sun Dec 18 20:57:16 2016 local2.info chat[6010]: report (CONNECT)
Sun Dec 18 20:57:16 2016 local2.info chat[6010]: timeout set to 10 seconds
Sun Dec 18 20:57:16 2016 local2.info chat[6010]: send (AT&F^M)
Sun Dec 18 20:57:17 2016 local2.info chat[6010]: expect (OK)
Sun Dec 18 20:57:20 2016 local2.info chat[6010]: ^M
Sun Dec 18 20:57:20 2016 local2.info chat[6010]: ^RSSI:22^M
Sun Dec 18 20:57:21 2016 local2.info chat[6010]: ^M
Sun Dec 18 20:57:21 2016 local2.info chat[6010]: ^MODE:5,6^M
Sun Dec 18 20:57:22 2016 local2.info chat[6010]: ^M
Sun Dec 18 20:57:22 2016 local2.info chat[6010]: ^BOOT:41596239,0,0,0,99^M
Sun Dec 18 20:57:27 2016 local2.info chat[6010]: alarm
Sun Dec 18 20:57:27 2016 local2.info chat[6010]: Failed
Sun Dec 18 20:57:27 2016 daemon.err pppd[6008]: Connect script failed
Sun Dec 18 20:57:28 2016 daemon.info pppd[6008]: Exit.
Sun Dec 18 20:57:28 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:57:28 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:57:30 2016 daemon.notice pppd[6039]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: abort on (BUSY)
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: abort on (NO CARRIER)
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: abort on (ERROR)
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: report (CONNECT)
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: timeout set to 10 seconds
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: send (AT&F^M)
Sun Dec 18 20:57:31 2016 local2.info chat[6041]: expect (OK)
Sun Dec 18 20:57:41 2016 local2.info chat[6041]: alarm
Sun Dec 18 20:57:41 2016 local2.info chat[6041]: Failed
Sun Dec 18 20:57:41 2016 daemon.err pppd[6039]: Connect script failed
Sun Dec 18 20:57:42 2016 daemon.info pppd[6039]: Exit.
Sun Dec 18 20:57:42 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:57:42 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:57:44 2016 daemon.notice pppd[6070]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: abort on (BUSY)
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: abort on (NO CARRIER)
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: abort on (ERROR)
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: report (CONNECT)
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: timeout set to 10 seconds
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: send (AT&F^M)
Sun Dec 18 20:57:45 2016 local2.info chat[6072]: expect (OK)
Sun Dec 18 20:57:52 2016 local2.info chat[6072]: ^M
Sun Dec 18 20:57:52 2016 local2.info chat[6072]: ^BOOT:41596239,0,0,0,99^M
Sun Dec 18 20:57:55 2016 local2.info chat[6072]: alarm
Sun Dec 18 20:57:55 2016 local2.info chat[6072]: Failed
Sun Dec 18 20:57:55 2016 daemon.err pppd[6070]: Connect script failed
Sun Dec 18 20:57:56 2016 daemon.info pppd[6070]: Exit.
Sun Dec 18 20:57:56 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:57:56 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:57:58 2016 daemon.notice pppd[6101]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: abort on (BUSY)
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: abort on (NO CARRIER)
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: abort on (ERROR)
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: report (CONNECT)
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: timeout set to 10 seconds
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: send (AT&F^M)
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: expect (OK)
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: ^M
Sun Dec 18 20:57:59 2016 local2.info chat[6103]: ^RSSI:22^M
Sun Dec 18 20:58:05 2016 local2.info chat[6103]: ^M
Sun Dec 18 20:58:05 2016 local2.info chat[6103]: ^RSSI:22^M
Sun Dec 18 20:58:09 2016 local2.info chat[6103]: alarm
Sun Dec 18 20:58:09 2016 local2.info chat[6103]: Failed
Sun Dec 18 20:58:09 2016 daemon.err pppd[6101]: Connect script failed
Sun Dec 18 20:58:10 2016 daemon.info pppd[6101]: Exit.
Sun Dec 18 20:58:11 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:58:11 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:58:13 2016 daemon.notice pppd[6132]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: abort on (BUSY)
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: abort on (NO CARRIER)
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: abort on (ERROR)
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: report (CONNECT)
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: timeout set to 10 seconds
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: send (AT&F^M)
Sun Dec 18 20:58:14 2016 local2.info chat[6134]: expect (OK)
Sun Dec 18 20:58:17 2016 local2.info chat[6134]: ^M
Sun Dec 18 20:58:17 2016 local2.info chat[6134]: ^RSSI:22^M
Sun Dec 18 20:58:20 2016 local2.info chat[6134]: ^M
Sun Dec 18 20:58:20 2016 local2.info chat[6134]: ^RSSI:22^M
Sun Dec 18 20:58:22 2016 local2.info chat[6134]: ^M
Sun Dec 18 20:58:22 2016 local2.info chat[6134]: ^BOOT:41596239,0,0,0,99^M
Sun Dec 18 20:58:24 2016 local2.info chat[6134]: alarm
Sun Dec 18 20:58:24 2016 local2.info chat[6134]: Failed
Sun Dec 18 20:58:24 2016 daemon.err pppd[6132]: Connect script failed
Sun Dec 18 20:58:25 2016 daemon.info pppd[6132]: Exit.
Sun Dec 18 20:58:25 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:58:25 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:58:27 2016 daemon.notice pppd[6161]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: abort on (BUSY)
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: abort on (NO CARRIER)
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: abort on (ERROR)
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: report (CONNECT)
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: timeout set to 10 seconds
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: send (AT&F^M)
Sun Dec 18 20:58:28 2016 local2.info chat[6165]: expect (OK)
Sun Dec 18 20:58:38 2016 local2.info chat[6165]: alarm
Sun Dec 18 20:58:38 2016 local2.info chat[6165]: Failed
Sun Dec 18 20:58:38 2016 daemon.err pppd[6161]: Connect script failed
Sun Dec 18 20:58:39 2016 daemon.info pppd[6161]: Exit.
Sun Dec 18 20:58:39 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 20:58:39 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 20:58:41 2016 daemon.notice pppd[6191]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: abort on (BUSY)
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: abort on (NO CARRIER)
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: abort on (ERROR)
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: report (CONNECT)
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: timeout set to 10 seconds
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: send (AT&F^M)
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: expect (OK)
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: ^M
Sun Dec 18 20:58:42 2016 local2.info chat[6196]: ^RSSI:21^M
Sun Dec 18 20:58:47 2016 local2.info chat[6196]: ^M
Sun Dec 18 20:58:47 2016 local2.info chat[6196]: ^RSSI:21^M
Sun Dec 18 20:58:50 2016 local2.info chat[6196]: ^M
Sun Dec 18 20:58:50 2016 local2.info chat[6196]: ^RSSI:21^M
Sun Dec 18 20:58:52 2016 local2.info chat[6196]: ^M
Sun Dec 18 20:58:52 2016 local2.info chat[6196]: ^BOOT:41596239,0,0,0,99^M
Sun Dec 18 20:58:52 2016 local2.info chat[6196]: alarm
Sun Dec 18 20:58:52 2016 local2.info chat[6196]: Failed
Sun Dec 18 20:58:52 2016 daemon.err pppd[6191]: Connect script failed
Sun Dec 18 20:58:53 2016 daemon.info pppd[6191]: Exit.
Sun Dec 18 20:58:54 2016 daemon.notice netifd: Interface 'wan' is now downI tak w koło Macieju, jedynym ratunkiem który daje radę - restart Routera - modem podniesie się bez problemu, lub wyciągnięcie /włożenie modemu (poniżej log) - też bez problemu sie podniesie :
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.068000] usb 1-1: USB disconnect, device number 4
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.076000] option1 ttyUSB0: GSM modem (1-port) converter now disconnected from ttyUSB0
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.084000] option 1-1:1.0: device disconnected
Sun Dec 18 21:07:05 2016 kern.err kernel: [ 4711.092000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 21:07:05 2016 kern.err kernel: [ 4711.100000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 21:07:05 2016 kern.err kernel: [ 4711.108000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 21:07:05 2016 kern.err kernel: [ 4711.116000] option1 ttyUSB1: usb_wwan_indat_callback: resubmit read urb failed. (-19)
Sun Dec 18 21:07:05 2016 local2.info chat[7268]: warning: read() on stdin returned 0
Sun Dec 18 21:07:05 2016 local2.info chat[7268]: Failed
Sun Dec 18 21:07:05 2016 local2.err chat[7268]: Can't restore terminal parameters: Input/output error
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.136000] option1 ttyUSB1: GSM modem (1-port) converter now disconnected from ttyUSB1
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.144000] option 1-1:1.1: device disconnected
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.148000] option1 ttyUSB2: GSM modem (1-port) converter now disconnected from ttyUSB2
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.160000] option 1-1:1.2: device disconnected
Sun Dec 18 21:07:05 2016 kern.info kernel: [ 4711.164000] qmi_wwan 1-1:1.3 wwan0: unregister 'qmi_wwan' usb-ehci-platform-1, WWAN/QMI device
Sun Dec 18 21:07:05 2016 daemon.err pppd[7264]: Connect script failed
Sun Dec 18 21:07:06 2016 daemon.info pppd[7264]: Exit.
Sun Dec 18 21:07:07 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 21:07:15 2016 kern.info kernel: [ 4720.828000] usb 1-1: new high-speed USB device number 5 using ehci-platform
Sun Dec 18 21:07:15 2016 kern.info kernel: [ 4720.976000] usb-storage 1-1:1.0: USB Mass Storage device detected
Sun Dec 18 21:07:15 2016 kern.info kernel: [ 4720.988000] scsi host5: usb-storage 1-1:1.0
Sun Dec 18 21:07:16 2016 kern.info kernel: [ 4721.892000] usb 1-1: USB disconnect, device number 5
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.540000] usb 1-1: new high-speed USB device number 6 using ehci-platform
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.688000] option 1-1:1.0: GSM modem (1-port) converter detected
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.696000] usb 1-1: GSM modem (1-port) converter now attached to ttyUSB0
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.704000] option 1-1:1.1: GSM modem (1-port) converter detected
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.712000] usb 1-1: GSM modem (1-port) converter now attached to ttyUSB1
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.720000] option 1-1:1.2: GSM modem (1-port) converter detected
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.728000] usb 1-1: GSM modem (1-port) converter now attached to ttyUSB2
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.744000] qmi_wwan 1-1:1.3: cdc-wdm0: USB WDM device
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.752000] qmi_wwan 1-1:1.3 wwan0: register 'qmi_wwan' at usb-ehci-platform-1, WWAN/QMI device, 00:a0:c6:00:00:00
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.764000] usb-storage 1-1:1.5: USB Mass Storage device detected
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.796000] scsi host6: usb-storage 1-1:1.5
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.800000] usb-storage 1-1:1.6: USB Mass Storage device detected
Sun Dec 18 21:07:25 2016 kern.info kernel: [ 4730.816000] scsi host7: usb-storage 1-1:1.6
Sun Dec 18 21:07:26 2016 kern.notice kernel: [ 4731.800000] scsi 6:0:0:0: CD-ROM HUAWEI Mass Storage 2.31 PQ: 0 ANSI: 0
Sun Dec 18 21:07:26 2016 kern.notice kernel: [ 4731.836000] scsi 7:0:0:0: Direct-Access HUAWEI SD Storage 2.31 PQ: 0 ANSI: 2
Sun Dec 18 21:07:26 2016 kern.notice kernel: [ 4731.856000] sd 7:0:0:0: [sda] Attached SCSI removable disk
Sun Dec 18 21:07:28 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 21:07:31 2016 daemon.notice pppd[7737]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: abort on (BUSY)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: abort on (NO CARRIER)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: abort on (ERROR)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: report (CONNECT)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: timeout set to 10 seconds
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: send (AT&F^M)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: expect (OK)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^SRVST:1^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^MODE:5,4^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^SRVST:1^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: AT&F^M^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: OK
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: -- got it
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: send (ATE1^M)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: expect (OK)
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: ATE1^M^M
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: OK
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: -- got it
Sun Dec 18 21:07:32 2016 local2.info chat[7765]: send (AT+CGDCONT=1,"IP","darmowy"^M)
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: timeout set to 30 seconds
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: expect (OK)
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: ^M
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: AT+CGDCONT=1,"IP","darmowy"^M^M
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: +CME ERROR
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: -- failed
Sun Dec 18 21:07:33 2016 local2.info chat[7765]: Failed (ERROR)
Sun Dec 18 21:07:33 2016 daemon.err pppd[7737]: Connect script failed
Sun Dec 18 21:07:34 2016 daemon.info pppd[7737]: Exit.
Sun Dec 18 21:07:34 2016 daemon.notice netifd: Interface 'wan' is now down
Sun Dec 18 21:07:34 2016 daemon.notice netifd: Interface 'wan' is setting up now
Sun Dec 18 21:07:37 2016 daemon.notice netifd: wan (7808): Trying to set mode
Sun Dec 18 21:07:37 2016 daemon.notice pppd[7832]: pppd 2.4.7 started by root, uid 0
Sun Dec 18 21:07:38 2016 local2.info chat[7834]: abort on (BUSY)
Sun Dec 18 21:07:38 2016 local2.info chat[7834]: abort on (NO CARRIER)
Sun Dec 18 21:07:38 2016 local2.info chat[7834]: abort on (ERROR)
Sun Dec 18 21:07:38 2016 local2.info chat[7834]: report (CONNECT)
Sun Dec 18 21:07:38 2016 local2.info chat[7834]: timeout set to 10 seconds
Sun Dec 18 21:07:38 2016 local2.info chat[7834]: send (AT&F^M)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: expect (OK)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ^SIMST:1^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: AT&F^M^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: OK
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: -- got it
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: send (ATE1^M)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: expect (OK)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ATE1^M^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: OK
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: -- got it
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: send (AT+CGDCONT=1,"IP","darmowy"^M)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: timeout set to 30 seconds
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: expect (OK)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: AT+CGDCONT=1,"IP","darmowy"^M^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: OK
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: -- got it
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: send (ATD*99***1#^M)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: expect (CONNECT)
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: ATD*99***1#^M^M
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: CONNECT
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: -- got it
Sun Dec 18 21:07:39 2016 local2.info chat[7834]: send ( ^M)
Sun Dec 18 21:07:39 2016 daemon.info pppd[7832]: Serial connection established.
Sun Dec 18 21:07:39 2016 kern.info kernel: [ 4744.840000] 3g-wan: renamed from ppp0
Sun Dec 18 21:07:39 2016 daemon.info pppd[7832]: Using interface 3g-wan
Sun Dec 18 21:07:39 2016 daemon.notice pppd[7832]: Connect: 3g-wan <--> /dev/ttyUSB1
Sun Dec 18 21:07:48 2016 daemon.warn pppd[7832]: Could not determine remote IP address: defaulting to 10.64.64.64
Sun Dec 18 21:07:48 2016 daemon.notice pppd[7832]: local IP address 100.82.220.102
Sun Dec 18 21:07:48 2016 daemon.notice pppd[7832]: remote IP address 10.64.64.64
Sun Dec 18 21:07:48 2016 daemon.notice pppd[7832]: primary DNS address 212.2.96.51
Sun Dec 18 21:07:48 2016 daemon.notice pppd[7832]: secondary DNS address 212.2.96.52
Sun Dec 18 21:07:48 2016 daemon.notice netifd: Network device '3g-wan' link is up
Sun Dec 18 21:07:48 2016 daemon.notice netifd: Interface 'wan_6' is enabled
Sun Dec 18 21:07:48 2016 daemon.notice netifd: Network alias '3g-wan' link is up
Sun Dec 18 21:07:48 2016 daemon.notice netifd: Interface 'wan_6' has link connectivity
Sun Dec 18 21:07:48 2016 daemon.notice netifd: Interface 'wan_6' is setting up now
Sun Dec 18 21:07:48 2016 daemon.notice netifd: Interface 'wan' is now up
Sun Dec 18 21:07:48 2016 daemon.info dnsmasq[1851]: reading /tmp/resolv.conf.auto
Sun Dec 18 21:07:48 2016 daemon.info dnsmasq[1851]: using local addresses only for domain lan
Sun Dec 18 21:07:48 2016 daemon.info dnsmasq[1851]: using nameserver 212.2.96.51#53
Sun Dec 18 21:07:48 2016 daemon.info dnsmasq[1851]: using nameserver 212.2.96.52#53
Sun Dec 18 21:07:49 2016 user.notice firewall: Reloading firewall due to ifup of wan (3g-wan)
Sun Dec 18 21:07:53 2016 user.notice ddns-scripts[7974]: myddns_ipv4: PID '7974' started at 2016-12-18 21:07
Sun Dec 18 21:07:54 2016 user.warn ddns-scripts[7974]: myddns_ipv4: Service section disabled! - TERMINATE
Sun Dec 18 21:07:54 2016 user.warn ddns-scripts[7974]: myddns_ipv4: PID '7974' exit WITH ERROR '1' at 2016-12-18 21:07Nie ma reguły - może działać 3 minuty , a może 2 godziny - jak coś pobieram.
Jakieś propozycje Panowie złoci ?