Re: [lwip-users] [ppp-new] Problems connection on Windows7

[Felipe Provenzano]

Thank you Sylvain,

Fortunately, yes, we have enough RAM/FLASH  for the extra log \o/

Follows:

[    97:23: tcp] ppp phase changed: unit 1: phase=10

[    97:23: tcp] Connection terminated.

[    97:23: tcp] ppp phase changed: unit 1: phase=0

[    97:23: tcp] ppp_link_terminated: unit 1

[    97:23: tcp] ppp_link_terminated: unit 1: link_status_cb=8063b4d err_code=0

[    97:23: tcp] Error Code 8

[    97:23: tcp] ppp_link_terminated: finished.

[    99:37: tcp] Disconnected

[    99:37: tcp] ppp_sighup: unit 1 sig_hup -> ppp_hup

[    99:37: tcp] ppp_hup: unit 1

[   103:37: tcp] --------------- Received 12

[   103:37: tcp] ppp_open() called, holdoff=0

[   103:37: tcp] ppp phase changed: unit 1: phase=1

[   103:37: tcp] ppp_over_serial_open: unit 1: connecting

[   103:37: tcp] ppp_start: unit 1

[   103:37: tcp] ppp_set_xaccm[1]: out_accm=0 0 0 0

[   103:37: tcp] ppp_send_config[1]: out_accm=FF FF FF FF

[   103:37: tcp] ppp_recv_config[1]: in_accm=FF FF FF FF

[   103:37: tcp] neg_upap: 1

[   103:37: tcp] neg_chap: 0

[   103:37: tcp] neg_chap_md5: 0

[   103:37: tcp] neg_chap_ms: 0

[   103:37: tcp] neg_chap_ms2: 0

[   103:37: tcp] sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0xda0f9d9d> <pcomp> <accomp>]

[   103:37: tcp] ppp_write[1]: len=46

[   103:37: tcp] ppp_start: finished

[   103:37: tcp] netif: setting default interface pp

[   103:37: tcp] --------------- Received 135

[   103:37: tcp] pppos_input[1]: got 135 bytes

[   103:23: tcp] tcpip_thread: CALLBACK 6807cbb8

[   103:23: tcp] rcvd [LCP ConfReq id=0x0 <asyncmap 0x0> <magic 0x374d5ead> <pcomp> <accomp> <callback CBCP> <mrru 1614> <endpoint 13 17 01 6c 36 8a 24 6c a2 48 57 81 3d 75 7e 18 ce c5 4e 00 00 00 00>]

[   103:23: tcp] sent [LCP ConfRej id=0x0 <callback CBCP> <mrru 1614>]

[   103:23: tcp] ppp_write[1]: len=30

[   103:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   103:23: tcp] rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0xda0f9d9d> <pcomp> <accomp>]

[   103:37: tcp] --------------- Received 76

[   103:37: tcp] pppos_input[1]: got 76 bytes

[   103:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   103:23: tcp] rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x374d5ead> <pcomp> <accomp> <endpoint 13 17 01 6c 36 8a 24 6c a2 48 57 81 3d 75 7e 18 ce c5 4e 00 00 00 00>]

[   103:23: tcp] sent [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x374d5ead> <pcomp> <accomp> <endpoint 13 17 01 6c 36 8a 24 6c a2 48 57 81 3d 75 7e 18 ce c5 4e 00 00 00 00>]

[   103:23: tcp] ppp_write[1]: len=76

[   103:23: tcp] ppp_send_config[1]: out_accm=0 0 0 0

[   103:23: tcp] ppp_recv_config[1]: in_accm=0 0 0 0

[   103:23: tcp] ppp phase changed: unit 1: phase=5

[   103:23: tcp] ppp phase changed: unit 1: phase=7

[   103:23: tcp] sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]

[   103:23: tcp] ppp_write[1]: len=35

[   103:37: tcp] --------------- Received 56

[   103:37: tcp] pppos_input[1]: got 56 bytes

[   103:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   103:23: tcp] rcvd [proto=0x80fd] 01 02 00 0a 12 06 00 00 00 01

[   103:23: tcp] Unsupported protocol 0x80fd received

[   103:23: tcp] sent [LCP ProtRej id=0x2 80 fd 01 02 00 0a 12 06 00 00 00 01]

[   103:23: tcp] ppp_write[1]: len=24

[   103:23: tcp] tcpip_thread: CALLBACK 6807cbb8

[   103:23: tcp] rcvd [LCP ProtRej id=0x3 80 21 01 01 00 1c 02 06 00 2d 0f 01 03 06 00 00 00 00 81 06 00 00 00 00 83 06 00 00 00 00]

[   103:23: tcp] Protocol-Reject for 0x8021 received

[   103:37: tcp] --------------- Received 34

[   103:37: tcp] pppos_input[1]: got 34 bytes

[   103:23: tcp] tcpip_thread: CALLBACK 6807cbb8

[   103:23: tcp] rcvd [LCP TermReq id=0x4 "7M^\37777777655\000<\37777777715t\000\000\000\000"]

[   103:23: tcp] LCP terminated by peer (7M^M--^@<address@hidden@address@hidden@)

[   103:23: tcp] ppp phase changed: unit 1: phase=4

[   103:23: tcp] ppp_link_down: unit 1

[   103:23: tcp] ppp_send_config[1]: out_accm=FF FF FF FF

[   103:23: tcp] ppp_recv_config[1]: in_accm=0 0 0 0

[   103:23: tcp] sent [LCP TermAck id=0x4]

[   103:23: tcp] ppp_write[1]: len=17

[   109:23: tcp] ppp phase changed: unit 1: phase=10

[   109:23: tcp] Connection terminated.

[   109:23: tcp] ppp phase changed: unit 1: phase=0

[   109:23: tcp] ppp_link_terminated: unit 1

[   109:23: tcp] ppp_link_terminated: unit 1: link_status_cb=8063b4d err_code=0

[   109:23: tcp] Error Code 8

[   109:23: tcp] ppp_link_terminated: finished.

[   111:37: tcp] Disconnected

[   111:37: tcp] ppp_sighup: unit 1 sig_hup -> ppp_hup

[   111:37: tcp] ppp_hup: unit 1

[   116:37: tcp] --------------- Received 12

[   116:37: tcp] ppp_open() called, holdoff=0

[   116:37: tcp] ppp phase changed: unit 1: phase=1

[   116:37: tcp] ppp_over_serial_open: unit 1: connecting

[   116:37: tcp] ppp_start: unit 1

[   116:37: tcp] ppp_set_xaccm[1]: out_accm=0 0 0 0

[   116:37: tcp] ppp_send_config[1]: out_accm=FF FF FF FF

[   116:37: tcp] ppp_recv_config[1]: in_accm=FF FF FF FF

[   116:37: tcp] neg_upap: 1

[   116:37: tcp] neg_chap: 0

[   116:37: tcp] neg_chap_md5: 0

[   116:37: tcp] neg_chap_ms: 0

[   116:37: tcp] neg_chap_ms2: 0

[   116:37: tcp] sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x525cc497> <pcomp> <accomp>]

[   116:37: tcp] ppp_write[1]: len=45

[   116:37: tcp] ppp_start: finished

[   116:37: tcp] netif: setting default interface pp

[   116:37: tcp] --------------- Received 135

[   116:37: tcp] pppos_input[1]: got 135 bytes

[   116:23: tcp] tcpip_thread: CALLBACK 6807cbb8

[   116:23: tcp] rcvd [LCP ConfReq id=0x0 <asyncmap 0x0> <magic 0x5ae21aa9> <pcomp> <accomp> <callback CBCP> <mrru 1614> <endpoint 13 17 01 6c 36 8a 24 6c a2 48 57 81 3d 75 7e 18 ce c5 4e 00 00 00 00>]

[   116:23: tcp] sent [LCP ConfRej id=0x0 <callback CBCP> <mrru 1614>]

[   116:23: tcp] ppp_write[1]: len=30

[   116:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   116:23: tcp] rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x525cc497> <pcomp> <accomp>]

[   116:37: tcp] --------------- Received 77

[   116:37: tcp] pppos_input[1]: got 77 bytes

[   116:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   116:23: tcp] rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x5ae21aa9> <pcomp> <accomp> <endpoint 13 17 01 6c 36 8a 24 6c a2 48 57 81 3d 75 7e 18 ce c5 4e 00 00 00 00>]

[   116:23: tcp] sent [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x5ae21aa9> <pcomp> <accomp> <endpoint 13 17 01 6c 36 8a 24 6c a2 48 57 81 3d 75 7e 18 ce c5 4e 00 00 00 00>]

[   116:23: tcp] ppp_write[1]: len=77

[   116:23: tcp] ppp_send_config[1]: out_accm=0 0 0 0

[   116:23: tcp] ppp_recv_config[1]: in_accm=0 0 0 0

[   116:23: tcp] ppp phase changed: unit 1: phase=5

[   116:23: tcp] ppp phase changed: unit 1: phase=7

[   116:23: tcp] sent [IPCP ConfReq id=0x1 <compress VJ 0f 01> <addr 0.0.0.0> <ms-dns1 0.0.0.0> <ms-dns2 0.0.0.0>]

[   116:23: tcp] ppp_write[1]: len=35

[   116:37: tcp] --------------- Received 56

[   116:37: tcp] pppos_input[1]: got 56 bytes

[   116:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   116:23: tcp] rcvd [proto=0x80fd] 01 02 00 0a 12 06 00 00 00 01

[   116:23: tcp] Unsupported protocol 0x80fd received

[   116:23: tcp] sent [LCP ProtRej id=0x2 80 fd 01 02 00 0a 12 06 00 00 00 01]

[   116:23: tcp] ppp_write[1]: len=24

[   116:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   116:23: tcp] rcvd [LCP ProtRej id=0x3 80 21 01 01 00 1c 02 06 00 2d 0f 01 03 06 00 00 00 00 81 06 00 00 00 00 83 06 00 00 00 00]

[   116:23: tcp] Protocol-Reject for 0x8021 received

[   116:37: tcp] --------------- Received 35

[   116:37: tcp] pppos_input[1]: got 35 bytes

[   116:23: tcp] tcpip_thread: CALLBACK 6807cbf8

[   116:23: tcp] rcvd [LCP TermReq id=0x4 "Z\37777777742\032\37777777651\000<\37777777715t\000\000\000\000"]

[   116:23: tcp] LCP terminated by peer (ZM-b^ZM-)^@<address@hidden@address@hidden@)

[   116:23: tcp] ppp phase changed: unit 1: phase=4

[   116:23: tcp] ppp_link_down: unit 1

[   116:23: tcp] ppp_send_config[1]: out_accm=FF FF FF FF

[   116:23: tcp] ppp_recv_config[1]: in_accm=0 0 0 0

[   116:23: tcp] sent [LCP TermAck id=0x4]

[   116:23: tcp] ppp_write[1]: len=17

[   122:23: tcp] ppp phase changed: unit 1: phase=10

[   122:23: tcp] Connection terminated.

[   122:23: tcp] ppp phase changed: unit 1: phase=0

[   122:23: tcp] ppp_link_terminated: unit 1

[   122:23: tcp] ppp_link_terminated: unit 1: link_status_cb=8063b4d err_code=0

[   122:23: tcp] Error Code 8

[   122:23: tcp] ppp_link_terminated: finished.

If you need more logs i believe i still having some space to include it.

thank you very much

Felipe

On Tue, Jan 14, 2014 at 12:44 PM, Sylvain Rochet <address@hidden> wrote:

Hello Felipe,

On Sun, Jan 12, 2014 at 10:26:31PM -0200, Felipe Provenzano wrote:
> Hello guys,
>
> My name is Felipe i am working in a device using the Lwip, and we are
> trying to connect it in a pc using the PPPoS.
> The first test in the Windows XP worked very well. But nothing worked when
> we tested in the Windows 7 and higher.
> I know that Microsoft changed some things after Vista, and thats the reason
> i started to use the ppp-new branch, i was thinking that with the CHAP-MS

> support the things could  just works. No. :(

>
> I am trying to debug the communication, and as far as i arrived there is a
> problem in the authentication, but i do not know if is possible to solve,
> or not.
>
> Do you could help me figure out whats wrong??

Something is messy around protocol accept/reject.

I hope your target have enough RAM/FLASH for heavy debug, so could you
enable PRINTPKT_SUPPORT ?  :-)

Add `#define PRINTPKT_SUPPORT LWIP_DBG_ON` in your lwipopts.h, this will
show packet details.

Sylvain

_______________________________________________
lwip-users mailing list
address@hidden
https://lists.nongnu.org/mailman/listinfo/lwip-users

--
"We all make choices, but in the end, our choices make us"