#################################################################### # TL-MR3420 System Log # Time = 2012-01-01 0:06:02 363s # H-Ver = MR3420 v2 00000000 : S-Ver = 3.13.27 Build 120905 Rel.73281n # 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:00:07 OTHER INFO System started 1st day 00:00:13 DHCP NOTICE DHCP server started 1st day 00:00:13 SECURITY INFO PPTP Passthrough enabled 1st day 00:00:13 SECURITY INFO L2TP Passthrough enabled 1st day 00:00:13 SECURITY INFO IPSEC Passthrough enabled 1st day 00:00:13 SECURITY INFO FTP ALG enabled 1st day 00:00:13 SECURITY INFO TFTP ALG enabled 1st day 00:00:13 SECURITY INFO H323 ALG enabled 1st day 00:00:13 SECURITY INFO RTSP ALG enabled 1st day 00:00:22 3G/4G NOTICE handle_card start 1st day 00:00:22 3G/4G INFO LTE Modem = 0, modemStatus = 1, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:00:28 DHCP INFO DHCPS:Recv REQUEST from 00:0F:B0:05:1B:48 1st day 00:00:28 DHCP INFO DHCPS:Send NAK 1st day 00:00:29 DHCP INFO DHCPS:Recv DISCOVER from 00:0F:B0:05:1B:48 1st day 00:00:30 DHCP INFO DHCPS:Send OFFER with ip 192.168.0.100 1st day 00:00:30 DHCP INFO DHCPS:Recv REQUEST from 00:0F:B0:05:1B:48 1st day 00:00:30 DHCP INFO DHCPS:Send ACK to 192.168.0.100 1st day 00:00:31 3G/4G INFO Before Mode switch VendorID = 0x12d1, ProductID = 0x1f01 1st day 00:00:32 DHCP INFO DHCPS:Recv INFORM from 00:0F:B0:05:1B:48 1st day 00:00:43 3G/4G NOTICE echo "/tmp/3G/12d1_1f01_0:55534243000000000000000000000011060000000100000000000000000000" > /tmp/3G/switch_cmd_file 1st day 00:00:43 3G/4G INFO After mode switch vendorID = 0x12d1, productID = 0x1442 1st day 00:00:43 3G/4G NOTICE 803: Before judgeModemTypeByTargetID, index = -1, targetPid = 0x1442 1st day 00:00:47 PPP INFO chat:terminate: status == 6 1st day 00:00:47 PPP INFO chat:terminate: status == 0 1st day 00:00:52 PPP INFO chat:terminate: status == 3 1st day 00:00:58 PPP INFO chat:terminate: status == 3 1st day 00:00:58 3G/4G INFO Main interface_index[0] = 0 1st day 00:00:59 3G/4G NOTICE After mode switch vendorID is 0x12d1 productID is 0x1442 1st day 00:01:00 3G/4G INFO getModemPinStatus 1347 getModemParamByScript return valid type = 1 1st day 00:01:00 3G/4G INFO card_add 962 minfo.modeswitchcmd = /tmp/3G/12d1_1f01_0 minfo.simLock = 16, minfo.modemChipTyp = 1 1st day 00:01:00 3G/4G NOTICE 967: Before judgeModemTypeByTargetID, index = -1, targetPid = 0x1442 1st day 00:01:00 3G/4G NOTICE After judgeModemTypeByTargetID, modem type = 0 1st day 00:01:00 3G/4G INFO LTE Modem = 0, modemStatus = 2, targetVendorID = 0x12d1, targerProductID = 0x1442 1st day 00:01:00 3G/4G INFO USB modem is ready 1st day 00:01:00 3G/4G NOTICE modem index is 4 1st day 00:01:00 3G/4G NOTICE setModemISP 1331 Get ISP by AT command. 1st day 00:01:02 3G/4G NOTICE parseResponseBuf 245 Respone data is: at+cimi^M^M 260171100546402^M ^M OK^M , len = 33 1st day 00:01:02 3G/4G NOTICE modemATCommandGetISP 881 ret = 0, bufISP = at+cimi^M^M 260171100546402^M ^M OK^M 1st day 00:01:02 3G/4G NOTICE modemATCommandGetISP 904 counter = 15 1st day 00:01:02 3G/4G NOTICE buffer is 260171100546402 1st day 00:01:02 3G/4G NOTICE mcc is 260 1st day 00:01:02 3G/4G NOTICE mnc is 171 1st day 00:01:02 3G/4G NOTICE setModemISP 1335 mcc is 260, mnc is 171 1st day 00:01:02 PPP WARNING 3G/4G disconnected 1st day 00:01:21 3G/4G NOTICE parseResponseBuf 245 Respone data is: at+CSQ^M^M +CSQ: 27,99^M ^M OK^M , len = 28 1st day 00:01:21 PPP NOTICE Standard authentication. 1st day 00:01:21 3G/4G INFO Run 3G dial cmd: pppd 3g 1 /dev/ttyUSB0 115200 connect "chat -s -v -f /etc/ppp/c 1st day 00:01:22 PPP INFO chat:get_string : OK 1st day 00:01:23 PPP INFO chat:get_string : OK 1st day 00:01:23 PPP INFO chat:get_string : OK 1st day 00:01:23 PPP INFO chat:get_string : CONNECT 1st day 00:01:23 PPP INFO chat:terminate: status == 0 1st day 00:01:24 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:27 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:30 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:33 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:36 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:39 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:42 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:45 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:48 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:51 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0xb7993f27] 1st day 00:01:54 PPP INFO chat:terminate: status == 0 1st day 00:02:13 3G/4G NOTICE Now disconnect times is 1 1st day 00:02:13 3G/4G NOTICE 3G Modem connecting error, please check the dial number and APN. 1st day 00:02:13 3G/4G INFO sw3GMobileCmdReq 378 mobileFormatCmd error 1st day 00:02:15 3G/4G NOTICE modem index is 4 1st day 00:02:15 3G/4G NOTICE setModemISP 1331 Get ISP by AT command. 1st day 00:02:22 3G/4G NOTICE modemATCommandGetISP 881 ret = 1, bufISP = 1st day 00:02:22 3G/4G NOTICE modemATCommandGetISP 918 counter = 0 1st day 00:02:22 3G/4G NOTICE setModemISP 1348 Get ISP by AT command failed. 1st day 00:02:43 PPP NOTICE Standard authentication. 1st day 00:02:43 3G/4G INFO Run 3G dial cmd: pppd 3g 1 /dev/ttyUSB0 115200 connect "chat -s -v -f /etc/ppp/c 1st day 00:03:00 PPP INFO chat:terminate: status == 3 1st day 00:03:20 3G/4G NOTICE Now disconnect times is 2 1st day 00:03:20 3G/4G NOTICE 3G Modem can't connect to network, now reset itself to try connecting again. 1st day 00:03:20 3G/4G NOTICE Reset the 3G modem, please wait. 1st day 00:03:20 3G/4G NOTICE handle_card start 1st day 00:03:20 3G/4G INFO LTE Modem = 0, modemStatus = 1, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:03:20 3G/4G NOTICE main 82 process is running, return. 1st day 00:03:22 3G/4G INFO sw3GMobileCmdReq 378 mobileFormatCmd error 1st day 00:03:22 3G/4G INFO LTE Modem = 0, modemStatus = 0, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:03:24 3G/4G INFO 3G Modem is plugged out. 1st day 00:03:27 3G/4G NOTICE handle_card start 1st day 00:03:27 3G/4G INFO LTE Modem = 0, modemStatus = 1, targetVendorID = 0x0000, targerProductID = 0x0000 1st day 00:03:30 DHCP INFO DHCPS:Recv INFORM from 00:0F:B0:05:1B:48 1st day 00:03:36 3G/4G INFO Before Mode switch VendorID = 0x12d1, ProductID = 0x1f01 1st day 00:03:49 3G/4G NOTICE echo "/tmp/3G/12d1_1f01_0:55534243000000000000000000000011060000000100000000000000000000" > /tmp/3G/switch_cmd_file 1st day 00:03:49 3G/4G INFO After mode switch vendorID = 0x12d1, productID = 0x1442 1st day 00:03:49 3G/4G NOTICE 803: Before judgeModemTypeByTargetID, index = -1, targetPid = 0x1442 1st day 00:03:52 PPP INFO chat:terminate: status == 6 1st day 00:03:52 PPP INFO chat:terminate: status == 0 1st day 00:03:57 PPP INFO chat:terminate: status == 3 1st day 00:04:03 PPP INFO chat:terminate: status == 3 1st day 00:04:03 3G/4G INFO Main interface_index[0] = 0 1st day 00:04:04 3G/4G NOTICE After mode switch vendorID is 0x12d1 productID is 0x1442 1st day 00:04:05 3G/4G INFO getModemPinStatus 1347 getModemParamByScript return valid type = 1 1st day 00:04:05 3G/4G INFO card_add 962 minfo.modeswitchcmd = /tmp/3G/12d1_1f01_0 minfo.simLock = 16, minfo.modemChipTyp = 1 1st day 00:04:05 3G/4G NOTICE 967: Before judgeModemTypeByTargetID, index = -1, targetPid = 0x1442 1st day 00:04:05 3G/4G NOTICE After judgeModemTypeByTargetID, modem type = 0 1st day 00:04:05 3G/4G INFO LTE Modem = 0, modemStatus = 2, targetVendorID = 0x12d1, targerProductID = 0x1442 1st day 00:04:05 3G/4G INFO USB modem is ready 1st day 00:04:05 3G/4G NOTICE modem index is 4 1st day 00:04:05 3G/4G NOTICE setModemISP 1331 Get ISP by AT command. 1st day 00:04:06 3G/4G NOTICE parseResponseBuf 245 Respone data is: at+cimi^M^M 260171100546402^M ^M OK^M , len = 33 1st day 00:04:06 3G/4G NOTICE modemATCommandGetISP 881 ret = 0, bufISP = at+cimi^M^M 260171100546402^M ^M OK^M 1st day 00:04:06 3G/4G NOTICE modemATCommandGetISP 904 counter = 15 1st day 00:04:06 3G/4G NOTICE buffer is 260171100546402 1st day 00:04:06 3G/4G NOTICE mcc is 260 1st day 00:04:06 3G/4G NOTICE mnc is 171 1st day 00:04:06 3G/4G NOTICE setModemISP 1335 mcc is 260, mnc is 171 1st day 00:04:25 3G/4G NOTICE parseResponseBuf 245 Respone data is: at+CSQ^M^M +CSQ: 27,99^M ^M OK^M , len = 28 1st day 00:04:25 PPP NOTICE Standard authentication. 1st day 00:04:25 3G/4G INFO Run 3G dial cmd: pppd 3g 1 /dev/ttyUSB0 115200 connect "chat -s -v -f /etc/ppp/c 1st day 00:04:27 PPP INFO chat:get_string : OK 1st day 00:04:27 PPP INFO chat:get_string : OK 1st day 00:04:27 PPP INFO chat:get_string : OK 1st day 00:04:27 PPP INFO chat:get_string : CONNECT 1st day 00:04:27 PPP INFO chat:terminate: status == 0 1st day 00:04:28 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:31 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:34 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:37 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:40 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:43 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:46 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:49 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:52 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:55 PPP INFO sent [LCP Req mru=1480 asyncmap=0x0 magic=0x81b30d01] 1st day 00:04:58 PPP INFO chat:terminate: status == 0 1st day 00:05:01 DHCP INFO DHCPS:Recv INFORM from 00:0F:B0:05:1B:48 1st day 00:05:17 3G/4G NOTICE Now disconnect times is 1 1st day 00:05:17 3G/4G NOTICE 3G Modem connecting error, please check the dial number and APN. 1st day 00:05:17 3G/4G INFO sw3GMobileCmdReq 378 mobileFormatCmd error 1st day 00:05:19 3G/4G NOTICE modem index is 4 1st day 00:05:19 3G/4G NOTICE setModemISP 1331 Get ISP by AT command. 1st day 00:05:26 3G/4G NOTICE modemATCommandGetISP 881 ret = 1, bufISP = 1st day 00:05:26 3G/4G NOTICE modemATCommandGetISP 918 counter = 0 1st day 00:05:26 3G/4G NOTICE setModemISP 1348 Get ISP by AT command failed. 1st day 00:05:47 PPP NOTICE Standard authentication. 1st day 00:05:47 3G/4G INFO Run 3G dial cmd: pppd 3g 1 /dev/ttyUSB0 115200 connect "chat -s -v -f /etc/ppp/c