sixfab / Sixfab_PPP_Installer

Repository of Sixfab PPP Installer Tool
MIT License
33 stars 35 forks source link

Error establishing internet connection #16

Closed uros-skopus closed 3 years ago

uros-skopus commented 4 years ago

This is my log file:

Mar 06 12:59:54 raspberrypi pppd[1288]: pppd options in effect: Mar 06 12:59:54 raspberrypi sh[434]: pppd options in effect: Mar 06 12:59:54 raspberrypi sh[434]: debug # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: updetach # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: dump # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: noauth # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: remotename 3gppp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: /dev/ttyUSB3 # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: 115200 # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: lock # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: connect chat -s -v -f /etc/chatscripts/chat-connect -T vipmobile # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: disconnect chat -s -v -f /etc/chatscripts/chat-disconnect # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: nocrtscts # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: modem # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: asyncmap 0 # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi sh[434]: lcp-echo-failure 4 # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi sh[434]: lcp-echo-interval 30 # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi sh[434]: hide-password # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: novj # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: novjccomp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: ipcp-accept-local # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: ipcp-accept-remote # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: ipparam 3gppp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: noipdefault # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: ipcp-max-failure 30 # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: defaultroute # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: usepeerdns # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: noccp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi sh[434]: noipx # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi pppd[1288]: debug # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: updetach # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: dump # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: noauth # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: remotename 3gppp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: /dev/ttyUSB3 # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: 115200 # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: lock # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: connect chat -s -v -f /etc/chatscripts/chat-connect -T vipmobile # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: disconnect chat -s -v -f /etc/chatscripts/chat-disconnect # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: nocrtscts # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: modem # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: asyncmap 0 # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi pppd[1288]: lcp-echo-failure 4 # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi pppd[1288]: lcp-echo-interval 30 # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi pppd[1288]: hide-password # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: novj # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: novjccomp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: ipcp-accept-local # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: ipcp-accept-remote # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: ipparam 3gppp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: noipdefault # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: ipcp-max-failure 30 # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: defaultroute # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: usepeerdns # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: noccp # (from /etc/ppp/peers/provider) Mar 06 12:59:54 raspberrypi pppd[1288]: noipx # (from /etc/ppp/options) Mar 06 12:59:54 raspberrypi pppd[1288]: pppd 2.4.7 started by root, uid 0 Mar 06 12:59:55 raspberrypi chat[1290]: abort on (BUSY) Mar 06 12:59:55 raspberrypi sh[434]: abort on (BUSY) Mar 06 12:59:55 raspberrypi sh[434]: abort on (NO CARRIER) Mar 06 12:59:55 raspberrypi sh[434]: abort on (NO DIALTONE) Mar 06 12:59:55 raspberrypi sh[434]: abort on (ERROR) Mar 06 12:59:55 raspberrypi sh[434]: abort on (NO ANSWER) Mar 06 12:59:55 raspberrypi sh[434]: timeout set to 30 seconds Mar 06 12:59:55 raspberrypi sh[434]: send (AT^M) Mar 06 12:59:55 raspberrypi chat[1290]: abort on (NO CARRIER) Mar 06 12:59:55 raspberrypi chat[1290]: abort on (NO DIALTONE) Mar 06 12:59:55 raspberrypi chat[1290]: abort on (ERROR) Mar 06 12:59:55 raspberrypi chat[1290]: abort on (NO ANSWER) Mar 06 12:59:55 raspberrypi chat[1290]: timeout set to 30 seconds Mar 06 12:59:55 raspberrypi chat[1290]: send (AT^M) Mar 06 12:59:55 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:55 raspberrypi sh[434]: expect (OK) Mar 06 12:59:55 raspberrypi sh[434]: ^M Mar 06 12:59:55 raspberrypi sh[434]: OK Mar 06 12:59:55 raspberrypi sh[434]: -- got it Mar 06 12:59:55 raspberrypi sh[434]: send (ATE0^M) Mar 06 12:59:55 raspberrypi chat[1290]: ^M Mar 06 12:59:55 raspberrypi chat[1290]: OK Mar 06 12:59:55 raspberrypi chat[1290]: -- got it Mar 06 12:59:55 raspberrypi chat[1290]: send (ATE0^M) Mar 06 12:59:55 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:55 raspberrypi sh[434]: expect (OK) Mar 06 12:59:55 raspberrypi sh[434]: ^M Mar 06 12:59:55 raspberrypi sh[434]: OK Mar 06 12:59:55 raspberrypi sh[434]: -- got it Mar 06 12:59:55 raspberrypi sh[434]: send (AT+QCFG="band",F,400A0E189F,A0E189F,1^M) Mar 06 12:59:55 raspberrypi chat[1290]: ^M Mar 06 12:59:55 raspberrypi chat[1290]: ^M Mar 06 12:59:55 raspberrypi chat[1290]: OK Mar 06 12:59:55 raspberrypi chat[1290]: -- got it Mar 06 12:59:55 raspberrypi chat[1290]: send (AT+QCFG="band",F,400A0E189F,A0E189F,1^M) Mar 06 12:59:56 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:56 raspberrypi sh[434]: expect (OK) Mar 06 12:59:56 raspberrypi sh[434]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: OK Mar 06 12:59:56 raspberrypi sh[434]: ^M Mar 06 12:59:56 raspberrypi sh[434]: OK Mar 06 12:59:56 raspberrypi sh[434]: -- got it Mar 06 12:59:56 raspberrypi sh[434]: send (AT+QCFG="nwscanseq",03,1^M) Mar 06 12:59:56 raspberrypi chat[1290]: -- got it Mar 06 12:59:56 raspberrypi chat[1290]: send (AT+QCFG="nwscanseq",03,1^M) Mar 06 12:59:56 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:56 raspberrypi sh[434]: expect (OK) Mar 06 12:59:56 raspberrypi sh[434]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: OK Mar 06 12:59:56 raspberrypi sh[434]: ^M Mar 06 12:59:56 raspberrypi sh[434]: OK Mar 06 12:59:56 raspberrypi sh[434]: -- got it Mar 06 12:59:56 raspberrypi sh[434]: send (AT+QCFG="nwscanmode",3,1^M) Mar 06 12:59:56 raspberrypi chat[1290]: -- got it Mar 06 12:59:56 raspberrypi chat[1290]: send (AT+QCFG="nwscanmode",3,1^M) Mar 06 12:59:56 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:56 raspberrypi sh[434]: expect (OK) Mar 06 12:59:56 raspberrypi sh[434]: ^M Mar 06 12:59:56 raspberrypi sh[434]: OK Mar 06 12:59:56 raspberrypi sh[434]: -- got it Mar 06 12:59:56 raspberrypi sh[434]: send (AT+QCFG="iotopmode",1,1^M) Mar 06 12:59:56 raspberrypi chat[1290]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: ^M Mar 06 12:59:56 raspberrypi chat[1290]: OK Mar 06 12:59:56 raspberrypi chat[1290]: -- got it Mar 06 12:59:56 raspberrypi chat[1290]: send (AT+QCFG="iotopmode",1,1^M) Mar 06 12:59:57 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:57 raspberrypi sh[434]: expect (OK) Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: OK Mar 06 12:59:57 raspberrypi sh[434]: -- got it Mar 06 12:59:57 raspberrypi sh[434]: send (ATI;+CSUB;+CSQ;+COPS?;+CGREG?;&D2^M) Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: OK Mar 06 12:59:57 raspberrypi chat[1290]: -- got it Mar 06 12:59:57 raspberrypi chat[1290]: send (ATI;+CSUB;+CSQ;+COPS?;+CGREG?;&D2^M) Mar 06 12:59:57 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:57 raspberrypi sh[434]: expect (OK) Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: Quectel^M Mar 06 12:59:57 raspberrypi sh[434]: BG96^M Mar 06 12:59:57 raspberrypi sh[434]: Revision: BG96MAR02A08M1G^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: SubEdition: V05^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: +CSQ: 99,99^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: +COPS: 0^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: +CGREG: 0,4^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: OK Mar 06 12:59:57 raspberrypi sh[434]: -- got it Mar 06 12:59:57 raspberrypi sh[434]: send (AT+CGDCONT=1,"IP","vipmobile",,0,0^M) Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: Quectel^M Mar 06 12:59:57 raspberrypi chat[1290]: BG96^M Mar 06 12:59:57 raspberrypi chat[1290]: Revision: BG96MAR02A08M1G^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: SubEdition: V05^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: +CSQ: 99,99^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: +COPS: 0^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: +CGREG: 0,4^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: OK Mar 06 12:59:57 raspberrypi chat[1290]: -- got it Mar 06 12:59:57 raspberrypi chat[1290]: send (AT+CGDCONT=1,"IP","vipmobile",,0,0^M) Mar 06 12:59:57 raspberrypi chat[1290]: expect (OK) Mar 06 12:59:57 raspberrypi sh[434]: expect (OK) Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: OK Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: OK Mar 06 12:59:57 raspberrypi sh[434]: -- got it Mar 06 12:59:57 raspberrypi sh[434]: send (ATD99#^M) Mar 06 12:59:57 raspberrypi chat[1290]: -- got it Mar 06 12:59:57 raspberrypi chat[1290]: send (ATD99#^M) Mar 06 12:59:57 raspberrypi chat[1290]: expect (CONNECT) Mar 06 12:59:57 raspberrypi sh[434]: expect (CONNECT) Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi sh[434]: ^M Mar 06 12:59:57 raspberrypi sh[434]: CONNECT Mar 06 12:59:57 raspberrypi sh[434]: -- got it Mar 06 12:59:57 raspberrypi chat[1290]: ^M Mar 06 12:59:57 raspberrypi NetworkManager[372]: [1583495997.9195] manager: (ppp0): new Generic device (/org/freedesktop/NetworkManager/Devices/11) Mar 06 12:59:57 raspberrypi sh[434]: Script chat -s -v -f /etc/chatscripts/chat-connect -T vipmobile finished (pid 1289), status = 0x0 Mar 06 12:59:57 raspberrypi sh[434]: Serial connection established. Mar 06 12:59:57 raspberrypi sh[434]: using channel 7 Mar 06 12:59:57 raspberrypi sh[434]: Using interface ppp0 Mar 06 12:59:57 raspberrypi sh[434]: Connect: ppp0 <--> /dev/ttyUSB3 Mar 06 12:59:57 raspberrypi chat[1290]: CONNECT Mar 06 12:59:57 raspberrypi chat[1290]: -- got it Mar 06 12:59:57 raspberrypi pppd[1288]: Script chat -s -v -f /etc/chatscripts/chat-connect -T vipmobile finished (pid 1289), status = 0x0 Mar 06 12:59:57 raspberrypi pppd[1288]: Serial connection established. Mar 06 12:59:57 raspberrypi pppd[1288]: using channel 7 Mar 06 12:59:57 raspberrypi pppd[1288]: Using interface ppp0 Mar 06 12:59:57 raspberrypi pppd[1288]: Connect: ppp0 <--> /dev/ttyUSB3 Mar 06 12:59:57 raspberrypi NetworkManager[372]: [1583495997.9500] devices added (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Mar 06 12:59:57 raspberrypi NetworkManager[372]: [1583495997.9501] device added (path: /sys/devices/virtual/net/ppp0, iface: ppp0): no ifupdown configuration found. Mar 06 12:59:58 raspberrypi pppd[1288]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x4fe804e6> ] Mar 06 12:59:58 raspberrypi sh[434]: sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x4fe804e6> ] Mar 06 12:59:58 raspberrypi sh[434]: rcvd [LCP ConfReq id=0x12 <asyncmap 0x0> <magic 0xd087f471> ] Mar 06 12:59:58 raspberrypi sh[434]: No auth is possible Mar 06 12:59:58 raspberrypi sh[434]: sent [LCP ConfRej id=0x12 ] Mar 06 12:59:58 raspberrypi sh[434]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x4fe804e6> ] Mar 06 12:59:58 raspberrypi sh[434]: rcvd [LCP ConfReq id=0x13 <asyncmap 0x0> <magic 0xd087f471> ] Mar 06 12:59:58 raspberrypi sh[434]: sent [LCP ConfAck id=0x13 <asyncmap 0x0> <magic 0xd087f471> ] Mar 06 12:59:58 raspberrypi sh[434]: sent [LCP EchoReq id=0x0 magic=0x4fe804e6] Mar 06 12:59:58 raspberrypi sh[434]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>] Mar 06 12:59:58 raspberrypi pppd[1288]: rcvd [LCP ConfReq id=0x12 <asyncmap 0x0> <magic 0xd087f471> ] Mar 06 12:59:58 raspberrypi sh[434]: rcvd [LCP DiscReq id=0x14 magic=0xd087f471] Mar 06 12:59:58 raspberrypi sh[434]: rcvd [LCP EchoRep id=0x0 magic=0xd087f471 4f e8 04 e6] Mar 06 12:59:58 raspberrypi pppd[1288]: No auth is possible Mar 06 12:59:58 raspberrypi sh[434]: Modem hangup Mar 06 12:59:58 raspberrypi sh[434]: Connection terminated. Mar 06 12:59:58 raspberrypi pppd[1288]: sent [LCP ConfRej id=0x12 ] Mar 06 12:59:58 raspberrypi pppd[1288]: rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x4fe804e6> ] Mar 06 12:59:58 raspberrypi pppd[1288]: rcvd [LCP ConfReq id=0x13 <asyncmap 0x0> <magic 0xd087f471> ] Mar 06 12:59:58 raspberrypi pppd[1288]: sent [LCP ConfAck id=0x13 <asyncmap 0x0> <magic 0xd087f471> ] Mar 06 12:59:58 raspberrypi pppd[1288]: sent [LCP EchoReq id=0x0 magic=0x4fe804e6] Mar 06 12:59:58 raspberrypi pppd[1288]: sent [IPCP ConfReq id=0x1 <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>] Mar 06 12:59:58 raspberrypi pppd[1288]: rcvd [LCP DiscReq id=0x14 magic=0xd087f471] Mar 06 12:59:58 raspberrypi NetworkManager[372]: [1583495998.9361] devices removed (path: /sys/devices/virtual/net/ppp0, iface: ppp0) Mar 06 12:59:58 raspberrypi pppd[1288]: rcvd [LCP EchoRep id=0x0 magic=0xd087f471 4f e8 04 e6] Mar 06 12:59:58 raspberrypi pppd[1288]: Modem hangup Mar 06 12:59:58 raspberrypi pppd[1288]: Connection terminated. Mar 06 12:59:59 raspberrypi pppd[1288]: Exit. Mar 06 12:59:59 raspberrypi sudo[1284]: pam_unix(sudo:session): session closed for user root

As you can see, initially I got: Mar 06 12:59:57 raspberrypi sh[434]: CONNECT

But then later: Mar 06 12:59:58 raspberrypi pppd[1288]: Modem hangup Mar 06 12:59:58 raspberrypi pppd[1288]: Connection terminated.

After that NETLIGHT led is blinking as it searches for a network: Flicker slowly (200ms ON/1800ms OFF) | Network searching