#################################################################### # TL-MR3420 System Log # Time = 2014-06-28 1:27:02 1343s # H-Ver = MR3420 v2 00000000 : S-Ver = 3.14.9 Build 140319 Rel.38485n # L = 192.168.0.1 : M = 255.255.255.0 # 3G/4G : 3G/4G = 0.0.0.0 : M = 0.0.0.0 : G = 0.0.0.0 #################################################################### 1st day 00:01:42 PPP INFO rcvd [IPCP Req] 1st day 00:01:42 PPP INFO sent [IPCP Ack] 1st day 00:01:42 PPP INFO rcvd [IPCP Nak addr=100.68.10.254 dns1=213.249.17.11 dns3=213.249.39.29] 1st day 00:01:42 PPP INFO sent [IPCP Req addr=100.68.10.254 dns1=213.249.17.11 dns3=213.249.39.29] 1st day 00:01:42 PPP INFO rcvd [IPCP Ack addr=100.68.10.254 dns1=213.249.17.11 dns3=213.249.39.29] 1st day 00:01:42 PPP INFO ipcp_up :ipv4 = 0, ipv6 = 0, ipcp_wantoptions[0].default_route = 1^M 1st day 00:01:42 PPP INFO delete old gateway^M 1st day 00:01:42 PPP INFO send_phase 2091 pppd_phase = 0x8, ipv6 = 0, ipv4 = 0^M 1st day 00:01:42 PPP INFO In pppd the httpd-id is 788, set link phase is 0x8 1st day 00:01:42 3G/4G NOTICE 3G/4G connected 1st day 00:01:45 3G/4G DEBUG minfo->ISP is 0x1940000 1st day 00:01:45 3G/4G INFO Modem information is updated 1st day 00:02:09 PPP INFO send_phase 2091 pppd_phase = 0xd, ipv6 = 0, ipv4 = 0^M 1st day 00:02:09 PPP INFO In pppd the httpd-id is 788, set link phase is 0xd 1st day 00:02:09 PPP INFO send_phase 2091 pppd_phase = 0x10, ipv6 = 0, ipv4 = 0^M 1st day 00:02:09 PPP INFO In pppd the httpd-id is 788, set link phase is 0x10 1st day 00:02:39 PPP INFO send_phase 2091 pppd_phase = 0x10, ipv6 = 0, ipv4 = 0^M 1st day 00:02:39 PPP INFO In pppd the httpd-id is 788, set link phase is 0x10 1st day 00:03:09 PPP INFO send_phase 2091 pppd_phase = 0x10, ipv6 = 0, ipv4 = 0^M 1st day 00:03:09 PPP INFO In pppd the httpd-id is 788, set link phase is 0x10 1st day 00:03:39 PPP INFO send_phase 2091 pppd_phase = 0x10, ipv6 = 0, ipv4 = 0^M 1st day 00:03:39 PPP INFO In pppd the httpd-id is 788, set link phase is 0x10 1st day 00:04:09 PPP INFO send_phase 2091 pppd_phase = 0xd, ipv6 = 0, ipv4 = 0^M 1st day 00:04:09 PPP INFO In pppd the httpd-id is 788, set link phase is 0xd 1st day 00:04:09 PPP INFO send_phase 2091 pppd_phase = 0x10, ipv6 = 0, ipv4 = 0^M 1st day 00:04:09 PPP INFO In pppd the httpd-id is 788, set link phase is 0x10 1st day 00:04:25 DHCP INFO DHCPS:Recv INFORM from 00:19:D2:AD:F2:6B 1st day 00:04:39 PPP INFO send_phase 2091 pppd_phase = 0x10, ipv6 = 0, ipv4 = 0^M 1st day 00:04:39 PPP INFO In pppd the httpd-id is 788, set link phase is 0x10 1st day 00:06:09 PPP INFO send_phase 2091 pppd_phase = 0xd, ipv6 = 0, ipv4 = 0^M 1st day 00:06:09 PPP INFO In pppd the httpd-id is 788, set link phase is 0xd 1st day 00:06:13 3G/4G WARNING Ping DNS failed, timeout interval 60 seconds 1st day 00:06:27 3G/4G WARNING Detect DNS and NTP failed 1st day 00:07:13 3G/4G WARNING Ping DNS failed, timeout interval 60 seconds 1st day 00:07:27 3G/4G WARNING Detect DNS and NTP failed 1st day 00:07:40 PPP ERROR Send_phase(PHASE_PEER_NOT_RESPONDING) 1st day 00:07:40 PPP INFO send_phase 2091 pppd_phase = 0xf, ipv6 = 0, ipv4 = 0^M 1st day 00:07:40 PPP INFO In pppd the httpd-id is 788, set link phase is 0xf 1st day 00:07:40 PPP ERROR Call function lcp_close to close lcp 1st day 00:07:40 PPP ERROR Peer not responding 1st day 00:07:40 PPP INFO send_phase 2091 pppd_phase = 0x9, ipv6 = 0, ipv4 = 0^M 1st day 00:07:40 PPP INFO In pppd the httpd-id is 788, set link phase is 0x9 1st day 00:07:40 PPP INFO send_phase 2091 pppd_phase = 0x7, ipv6 = 0, ipv4 = 0^M 1st day 00:07:40 PPP INFO In pppd the httpd-id is 788, set link phase is 0x7 1st day 00:07:40 PPP ERROR LCP down 1st day 00:07:40 PPP WARNING LCP down 1st day 00:07:40 PPP INFO send_phase 2091 pppd_phase = 0x4, ipv6 = 0, ipv4 = 0^M 1st day 00:07:40 PPP INFO In pppd the httpd-id is 788, set link phase is 0x4 1st day 00:07:40 PPP INFO sent [LCP TermReq] 1st day 00:07:40 PPP INFO got_sigterm, Terminating on signal 15 1st day 00:07:40 PPP ERROR User request 1st day 00:07:40 PPP INFO send_phase 2091 pppd_phase = 0x9, ipv6 = 0, ipv4 = 0^M 1st day 00:07:40 PPP INFO In pppd the httpd-id is 788, set link phase is 0x9 1st day 00:07:45 OTHER NOTICE Clear the USB PORT 1st day 00:07:45 3G/4G INFO handle_card start 1st day 00:07:45 3G/4G INFO LTE Modem = 0, modemStatus = 1, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:07:47 3G/4G INFO LTE Modem = 0, modemStatus = 0, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:07:49 3G/4G INFO Modem is plugged out. 1st day 00:07:52 3G/4G INFO handle_card start 1st day 00:07:52 3G/4G INFO LTE Modem = 0, modemStatus = 1, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:08:01 3G/4G INFO Before Mode switch VendorID = 0x2357, ProductID = 0x0200 1st day 00:08:01 3G/4G DEBUG => 1st day 00:08:01 3G/4G DEBUG =>T: Bus=01 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#= 1 Spd=480 MxCh= 1 1st day 00:08:01 3G/4G DEBUG =>B: Alloc= 0/800 us ( 0%), #Int= 0, #Iso= 0 1st day 00:08:01 3G/4G DEBUG =>D: Ver= 2.00 Cls=09(hub ) Sub=00 Prot=01 MxPS=64 #Cfgs= 1 1st day 00:08:01 3G/4G DEBUG =>P: Vendor=1d6b ProdID=0002 Rev= 2.06 1st day 00:08:01 3G/4G DEBUG =>S: Manufacturer=Linux 2.6.31--LSDK-9.2.0_U5.508 ehci_hcd 1st day 00:08:01 3G/4G DEBUG =>S: Product=ATH EHCI 1st day 00:08:01 3G/4G DEBUG =>S: SerialNumber=platform 1st day 00:08:01 3G/4G DEBUG =>C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr= 0mA 1st day 00:08:01 3G/4G DEBUG =>I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub ) Sub=00 Prot=00 Driver=hub 1st day 00:08:01 3G/4G DEBUG =>E: Ad=81(I) Atr=03(Int.) MxPS= 4 Ivl=256ms 1st day 00:08:01 3G/4G DEBUG => 1st day 00:08:01 3G/4G DEBUG =>T: Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#= 6 Spd=480 MxCh= 0 1st day 00:08:01 3G/4G DEBUG =>D: Ver= 2.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=64 #Cfgs= 1 1st day 00:08:01 3G/4G DEBUG =>P: Vendor=2357 ProdID=0200 Rev= 0.00 1st day 00:08:01 3G/4G DEBUG =>S: Manufacturer=TP-LINK, Incorporated 1st day 00:08:01 3G/4G DEBUG =>S: Product=TP-LINK HSUPA Modem 1st day 00:08:01 3G/4G DEBUG =>S: SerialNumber=863077010765000 1st day 00:08:01 3G/4G DEBUG =>C:* #Ifs= 1 Cfg#= 1 Atr=c0 MxPwr=500mA 1st day 00:08:01 3G/4G DEBUG =>I:* If#= 0 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50 Driver=(none) 1st day 00:08:01 3G/4G DEBUG =>E: Ad=01(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:01 3G/4G DEBUG =>E: Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:01 3G/4G DEBUG vendor id is 05c6 1st day 00:08:05 3G/4G DEBUG try cmd = usb_modeswitch -v 0x2357 -p 0x0200 -I -W -c /tmp/3G/2357_0200_0 &^M 1st day 00:08:13 3G/4G DEBUG echo "/tmp/3G/2357_0200_0:5553424312345678000000000000061b000000020000000000000000000000" > /tmp/3G/switch_cmd_file 1st day 00:08:13 3G/4G DEBUG Before judgeModemTypeByTargetID, index = -1, targetPid = 0x0201 1st day 00:08:13 3G/4G DEBUG => 1st day 00:08:13 3G/4G DEBUG =>T: Bus=01 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#= 1 Spd=480 MxCh= 1 1st day 00:08:13 3G/4G DEBUG =>B: Alloc= 0/800 us ( 0%), #Int= 0, #Iso= 0 1st day 00:08:13 3G/4G DEBUG =>D: Ver= 2.00 Cls=09(hub ) Sub=00 Prot=01 MxPS=64 #Cfgs= 1 1st day 00:08:13 3G/4G DEBUG =>P: Vendor=1d6b ProdID=0002 Rev= 2.06 1st day 00:08:13 3G/4G DEBUG =>S: Manufacturer=Linux 2.6.31--LSDK-9.2.0_U5.508 ehci_hcd 1st day 00:08:13 3G/4G DEBUG =>S: Product=ATH EHCI 1st day 00:08:13 3G/4G DEBUG =>S: SerialNumber=platform 1st day 00:08:13 3G/4G DEBUG =>C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr= 0mA 1st day 00:08:13 3G/4G DEBUG =>I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub ) Sub=00 Prot=00 Driver=hub 1st day 00:08:13 3G/4G DEBUG =>E: Ad=81(I) Atr=03(Int.) MxPS= 4 Ivl=256ms 1st day 00:08:13 3G/4G DEBUG => 1st day 00:08:13 3G/4G DEBUG =>T: Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#= 7 Spd=480 MxCh= 0 1st day 00:08:13 3G/4G DEBUG =>D: Ver= 2.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=64 #Cfgs= 1 1st day 00:08:13 3G/4G DEBUG =>P: Vendor=2357 ProdID=0201 Rev= 0.00 1st day 00:08:13 3G/4G DEBUG =>S: Manufacturer=TP-LINK, Incorporated 1st day 00:08:13 3G/4G DEBUG =>S: Product=TP-LINK HSUPA Modem 1st day 00:08:13 3G/4G DEBUG =>S: SerialNumber=863077010765000 1st day 00:08:13 3G/4G DEBUG =>C:* #Ifs= 5 Cfg#= 1 Atr=e0 MxPwr=500mA 1st day 00:08:13 3G/4G DEBUG =>I:* If#= 0 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=(none) 1st day 00:08:13 3G/4G DEBUG =>E: Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=01(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:13 3G/4G DEBUG =>I:* If#= 1 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=(none) 1st day 00:08:13 3G/4G DEBUG =>E: Ad=82(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=02(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:13 3G/4G DEBUG =>I:* If#= 2 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50 Driver=(none) 1st day 00:08:13 3G/4G DEBUG =>E: Ad=03(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=83(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:13 3G/4G DEBUG =>I:* If#= 3 Alt= 0 #EPs= 3 Cls=ff(vend.) Sub=ff Prot=ff Driver=(none) 1st day 00:08:13 3G/4G DEBUG =>E: Ad=84(I) Atr=03(Int.) MxPS= 64 Ivl=2ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=85(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=04(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:13 3G/4G DEBUG =>I:* If#= 4 Alt= 0 #EPs= 3 Cls=ff(vend.) Sub=ff Prot=ff Driver=(none) 1st day 00:08:13 3G/4G DEBUG =>E: Ad=86(I) Atr=03(Int.) MxPS= 64 Ivl=2ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=87(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:13 3G/4G DEBUG =>E: Ad=05(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:13 3G/4G DEBUG 3GEther is 0 1st day 00:08:16 3G/4G DEBUG => 1st day 00:08:16 3G/4G DEBUG =>T: Bus=01 Lev=00 Prnt=00 Port=00 Cnt=00 Dev#= 1 Spd=480 MxCh= 1 1st day 00:08:16 3G/4G DEBUG =>B: Alloc= 0/800 us ( 0%), #Int= 0, #Iso= 0 1st day 00:08:16 3G/4G DEBUG =>D: Ver= 2.00 Cls=09(hub ) Sub=00 Prot=01 MxPS=64 #Cfgs= 1 1st day 00:08:16 3G/4G DEBUG =>P: Vendor=1d6b ProdID=0002 Rev= 2.06 1st day 00:08:16 3G/4G DEBUG =>S: Manufacturer=Linux 2.6.31--LSDK-9.2.0_U5.508 ehci_hcd 1st day 00:08:16 3G/4G DEBUG =>S: Product=ATH EHCI 1st day 00:08:16 3G/4G DEBUG =>S: SerialNumber=platform 1st day 00:08:16 3G/4G DEBUG =>C:* #Ifs= 1 Cfg#= 1 Atr=e0 MxPwr= 0mA 1st day 00:08:16 3G/4G DEBUG =>I:* If#= 0 Alt= 0 #EPs= 1 Cls=09(hub ) Sub=00 Prot=00 Driver=hub 1st day 00:08:16 3G/4G DEBUG =>E: Ad=81(I) Atr=03(Int.) MxPS= 4 Ivl=256ms 1st day 00:08:16 3G/4G DEBUG => 1st day 00:08:16 3G/4G DEBUG =>T: Bus=01 Lev=01 Prnt=01 Port=00 Cnt=01 Dev#= 7 Spd=480 MxCh= 0 1st day 00:08:16 3G/4G DEBUG =>D: Ver= 2.00 Cls=00(>ifc ) Sub=00 Prot=00 MxPS=64 #Cfgs= 1 1st day 00:08:16 3G/4G DEBUG =>P: Vendor=2357 ProdID=0201 Rev= 0.00 1st day 00:08:16 3G/4G DEBUG =>S: Manufacturer=TP-LINK, Incorporated 1st day 00:08:16 3G/4G DEBUG =>S: Product=TP-LINK HSUPA Modem 1st day 00:08:16 3G/4G DEBUG =>S: SerialNumber=863077010765000 1st day 00:08:16 3G/4G DEBUG =>C:* #Ifs= 5 Cfg#= 1 Atr=e0 MxPwr=500mA 1st day 00:08:16 3G/4G DEBUG =>I:* If#= 0 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=usbserial_generic 1st day 00:08:16 3G/4G DEBUG =>E: Ad=81(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=01(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:16 3G/4G DEBUG =>I:* If#= 1 Alt= 0 #EPs= 2 Cls=ff(vend.) Sub=ff Prot=ff Driver=usbserial_generic 1st day 00:08:16 3G/4G DEBUG =>E: Ad=82(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=02(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:16 3G/4G DEBUG =>I:* If#= 2 Alt= 0 #EPs= 2 Cls=08(stor.) Sub=06 Prot=50 Driver=usbserial_generic 1st day 00:08:16 3G/4G DEBUG =>E: Ad=03(O) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=83(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:16 3G/4G DEBUG =>I:* If#= 3 Alt= 0 #EPs= 3 Cls=ff(vend.) Sub=ff Prot=ff Driver=usbserial_generic 1st day 00:08:16 3G/4G DEBUG =>E: Ad=84(I) Atr=03(Int.) MxPS= 64 Ivl=2ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=85(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=04(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:16 3G/4G DEBUG =>I:* If#= 4 Alt= 0 #EPs= 3 Cls=ff(vend.) Sub=ff Prot=ff Driver=usbserial_generic 1st day 00:08:16 3G/4G DEBUG =>E: Ad=86(I) Atr=03(Int.) MxPS= 64 Ivl=2ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=87(I) Atr=02(Bulk) MxPS= 512 Ivl=0ms 1st day 00:08:16 3G/4G DEBUG =>E: Ad=05(O) Atr=02(Bulk) MxPS= 512 Ivl=4ms 1st day 00:08:16 3G/4G DEBUG serialNum 5 indexInt 3 1st day 00:08:17 PPP INFO chat:terminate: status == 0 1st day 00:08:23 PPP INFO chat:terminate: status == 3 1st day 00:08:23 3G/4G INFO Ignore interface 1 of device whose vendor ID:0x2357, product ID:0x201 1st day 00:08:28 PPP INFO chat:terminate: status == 3 1st day 00:08:28 3G/4G INFO Main interface_index[0] = 3 1st day 00:08:29 3G/4G DEBUG Modem vendorID = 0x2357, productID = 0x0200, switch cmd = /tmp/3G/2357_0200_0 1st day 00:08:29 3G/4G INFO After mode switch vendorID is 0x2357 productID is 0x0201 1st day 00:08:29 3G/4G DEBUG card_add 877 minfo.modeswitchcmd = /tmp/3G/2357_0200_0 minfo.simLock = 0, minfo.modemChipTyp = 0 1st day 00:08:29 3G/4G INFO Before judgeModemTypeByTargetID, index = -1, targetPid = 0x0201 1st day 00:08:29 3G/4G DEBUG 3GEther is 0 1st day 00:08:29 3G/4G INFO After judgeModemTypeByTargetID, modem type = 0 1st day 00:08:29 3G/4G INFO LTE Modem = 0, modemStatus = 2, targetVendorID = 0x2357, targerProductID = 0x0201 1st day 00:08:29 3G/4G DEBUG lteModemATCommandGetPinStatus 284 modem name is /dev/ttyUSB3 1st day 00:08:30 3G/4G DEBUG parseResponseBuf 246 Respone data is: at+cpin?^M^M +CPIN: READY^M ^M OK^M , len = 31 1st day 00:08:30 3G/4G DEBUG lteModemATCommandGetPinStatus 302 ret = 0, bufPinMsg = at+cpin?^M^M +CPIN: READY^M ^M OK^M 1st day 00:08:30 3G/4G INFO USB modem is ready 1st day 00:19:28 DHCP INFO DHCPS:Recv REQUEST from 00:19:D2:AD:F2:6B 1st day 00:19:28 DHCP INFO DHCPS:Send ACK to 192.168.0.100 1st day 00:19:31 DHCP INFO DHCPS:Recv INFORM from 00:19:D2:AD:F2:6B