Community discussions

MikroTik App
 
Milo
just joined
Topic Author
Posts: 2
Joined: Wed Jul 09, 2014 7:51 am

PPP (IPCP) issue

Wed Jul 09, 2014 8:37 am

Hello,

I'm trying to get working RB912G 2HnD with Sierra Wireless NC8755 (so officially supported by RouterOS), but peer seems not to be happy with router's requests.

This part is looping:
00:00:37 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x5
00:00:37 async,ppp,debug,packet <addr 0.0.0.0>
00:00:37 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:37 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:38 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x5
00:00:38 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:38 async,ppp,debug,packet <ms-dns 10.11.12.14>
On RouterOS v5.26 status of the interface was "authorized" but "not running", now, on v6.15 it is "link established" and also (obvsiously) "not running".

More logs below:
00:00:31 async,ppp,info ppp-out1: initializing...
00:00:31 async,ppp,info ppp-out1: reseting link...
00:00:32 async,ppp,info ppp-out1: initializing modem...
00:00:33 async,ppp,info ppp-out1: dialing out...
00:00:33 async,ppp,debug ppp-out1: LCP lowerup
00:00:33 async,ppp,debug ppp-out1: LCP open
00:00:33 async,ppp,debug,packet ppp-out1: sent LCP ConfReq id=0x1
00:00:33 async,ppp,debug,packet <magic 0x350fbdfc>
00:00:33 async,ppp,debug,packet <pcomp>
00:00:33 async,ppp,debug,packet <accomp>
00:00:33 async,ppp,debug,packet ppp-out1: rcvd LCP ConfReq id=0x3
00:00:33 async,ppp,debug,packet <asyncmap 0x0>
00:00:33 async,ppp,debug,packet <magic 0x834e4a1>
00:00:33 async,ppp,debug,packet <pcomp>
00:00:33 async,ppp,debug,packet <accomp>
00:00:33 async,ppp,debug,packet <auth chap>
00:00:33 async,ppp,debug,packet ppp-out1: sent LCP ConfAck id=0x3
00:00:33 async,ppp,debug,packet <asyncmap 0x0>
00:00:33 async,ppp,debug,packet <magic 0x834e4a1>
00:00:33 async,ppp,debug,packet <pcomp>
00:00:33 async,ppp,debug,packet <accomp>
00:00:33 async,ppp,debug,packet <auth chap>
00:00:33 async,ppp,debug,packet ppp-out1: rcvd LCP ConfAck id=0x1
00:00:33 async,ppp,debug,packet <magic 0x350fbdfc>
00:00:33 async,ppp,debug,packet <pcomp>
00:00:33 async,ppp,debug,packet <accomp>
00:00:33 async,ppp,debug ppp-out1: LCP opened
00:00:33 async,ppp,debug,packet ppp-out1: rcvd LCP DiscReq id=0x4
00:00:33 async,ppp,debug,packet <magic 0x834e4a1>
00:00:33 async,ppp,debug,packet ppp-out1: rcvd CHAP Challenge id=0x1
00:00:33 async,ppp,debug,packet <challenge len=16>
00:00:33 async,ppp,debug,packet <name UMTS_CHAP_SRVR>
00:00:33 async,ppp,debug,packet ppp-out1: sent CHAP Response id=0x1
00:00:33 async,ppp,debug,packet <response len=16>
00:00:33 async,ppp,debug,packet ppp-out1: rcvd CHAP Success id=0x1
00:00:33 async,ppp,info ppp-out1: authenticated
00:00:33 async,ppp,debug ppp-out1: IPCP lowerup
00:00:33 async,ppp,debug ppp-out1: IPCP open
00:00:33 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x1
00:00:33 async,ppp,debug,packet <addr 0.0.0.0>
00:00:33 async,ppp,debug,packet <ms-dns 0.0.0.0>
00:00:33 async,ppp,debug,packet <ms-dns 0.0.0.0>
00:00:33 async,ppp,debug ppp-out1: IPV6CP open
00:00:33 async,ppp,debug ppp-out1: MPLSCP lowerup
00:00:33 async,ppp,debug ppp-out1: MPLSCP open
00:00:33 async,ppp,debug,packet ppp-out1: sent MPLSCP ConfReq id=0x1
00:00:33 async,ppp,debug ppp-out1: BCP open
00:00:33 async,ppp,debug ppp-out1: CCP lowerup
00:00:33 async,ppp,debug ppp-out1: CCP open
00:00:33 async,ppp,debug,packet ppp-out1: rcvd LCP ProtRej id=0x5
00:00:33 async,ppp,debug,packet 82 81 01 01 00 04
00:00:34 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x1
00:00:34 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:34 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:34 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x2
00:00:34 async,ppp,debug,packet <addr 0.0.0.0>
00:00:34 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:34 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:35 async,ppp,debug ppp-out1: IPCP timer
00:00:35 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x3
00:00:35 async,ppp,debug,packet <addr 0.0.0.0>
00:00:35 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:35 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:36 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x3
00:00:36 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:36 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:36 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x4
00:00:36 async,ppp,debug,packet <addr 0.0.0.0>
00:00:36 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:36 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:37 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x4
00:00:37 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:37 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:37 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x5
00:00:37 async,ppp,debug,packet <addr 0.0.0.0>
00:00:37 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:37 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:38 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x5
00:00:38 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:38 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:39 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x6
00:00:39 async,ppp,debug,packet <addr 0.0.0.0>
00:00:39 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:39 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:40 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x6
00:00:40 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:40 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:40 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x7
00:00:40 async,ppp,debug,packet <addr 0.0.0.0>
00:00:40 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:40 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:41 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x7
00:00:41 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:41 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:41 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x8
00:00:41 async,ppp,debug,packet <addr 0.0.0.0>
00:00:41 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:41 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:42 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x8
00:00:42 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:42 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:42 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0x9
00:00:42 async,ppp,debug,packet <addr 0.0.0.0>
00:00:42 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:42 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:43 async,ppp,debug,packet ppp-out1: rcvd IPCP ConfNak id=0x9
00:00:43 async,ppp,debug,packet <ms-dns 10.11.12.13>
00:00:43 async,ppp,debug,packet <ms-dns 10.11.12.14>
00:00:43 async,ppp,debug,packet ppp-out1: sent IPCP ConfReq id=0xa
I would appreciate any help with this problem

EDIT: Looks like someone had similar issue on GNU/Linux with Sierra 3/4G card https://mail.gnome.org/archives/network ... 00074.html (unfortunately no solution/fix so far mentioned)

I also tried two different SIM cards from different telecoms (both are OK - checked on other devices).

EDIT2: just tested this with other modem - DELL 5520. With same effect. I was trying to change some other parameters like compression (on/off) or compression type but without success. I also can share supout.rif in case of need.

I was reading that some telecoms are not saying explicitly what they don't like about client's approach and they are just sending rubbish during IPCP negotiations (I don't know if this is true though).

Thanks,
Milo
 
User avatar
jacekes
Member Candidate
Member Candidate
Posts: 167
Joined: Tue Aug 30, 2011 9:34 am
Location: Poznan, Poland
Contact:

Re: PPP (IPCP) issue

Sat Jul 19, 2014 10:05 pm

Hi,

I guess it's you who has called me on friday.
Tell me, what modem init string have you used?
Addresses served in IPCP can look weird, even though they might work properly, especially on Orange in Poland. Anyway, this is not the case - you get 0.0.0.0 as the IP for your host.

I guess I'd really need to review the config live on the device if I'm supposed to help.
I've managed to launch Dell 5520 modems on a RB 411 UAHR and Orange PL SIM without any problems, so it's surely possible.

Kind regards,
Jacek Skórzewski
 
Milo
just joined
Topic Author
Posts: 2
Joined: Wed Jul 09, 2014 7:51 am

Re: PPP (IPCP) issue

Sat Jul 19, 2014 10:25 pm

Hi,

I guess it's you who has called me on friday.
Tell me, what modem init string have you used?
Addresses served in IPCP can look weird, even though they might work properly, especially on Orange in Poland. Anyway, this is not the case - you get 0.0.0.0 as the IP for your host.
I've sent you an email but looks like you didn't get it. Just send in one more time (but you found the post anyway).

Hm, I went through RFC for IPCP. I would say that my PPP client is "provoking" remote peer by suggesting local address which won't be accepted for sure (client is giving 0.0.0.0 address here). Remote peer is obliged to correct this by sending address which is fine for him (ConfNak). But this is not happening at all (peer is only replying with MS DNS hosts). Am I correct?
I guess I'd really need to review the config live on the device if I'm supposed to help.
I've managed to launch Dell 5520 modems on a RB 411 UAHR and Orange PL SIM without any problems, so it's surely possible.
OK, this somehow promising then! init string is empty (so set to default).

Which part of configuration should I dump beside init string for the modem for your possible review?

P.S. remote access isn't possible yet, working on it.

All the best,
Milo
 
User avatar
jacekes
Member Candidate
Member Candidate
Posts: 167
Joined: Tue Aug 30, 2011 9:34 am
Location: Poznan, Poland
Contact:

Re: PPP (IPCP) issue

Thu Jul 24, 2014 12:05 pm

For all the future readers (if any) - in this case the problem wasn't related to PPPoE or IPCP. The cellular signal level was too low and the PPP-client interface wasn't really fully up.

Who is online

Users browsing this forum: helleon and 49 guests