lwip-users
[Top][All Lists]
Advanced
[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

[lwip-users] R: Re: Unable to connect to HTTP server using PPP

From: Renato Barresi
Subject: [lwip-users] R: Re: Unable to connect to HTTP server using PPP
Date: Fri, 7 Feb 2020 10:00:00 -0300
Hi Sylvain,

I changed VJ_SUPPORT to 0 and still got the same behavior. 

I'm sending the PPP debug trace.

Thank you for your help!

Regards, 

Renato


------------------Updated lwipopts.h-------------------

#define NETIF_DEBUG             LWIP_DBG_ON
#define HTTPD_DEBUG LWIP_DBG_ON
#define TCP_DEBUG               LWIP_DBG_ON

#define PPP_DEBUG                       LWIP_DBG_ON
#define PRINTPKT_SUPPORT                1
#define PPP_PROTOCOLNAME 1

 /*PPP*/
#define PPP_USE_PBUF_RAM                0

#define PPP_NUM_TIMEOUTS_PER_PCB        (1 + PPP_IPV4_SUPPORT + PPP_IPV6_SUPPORT + CCP_SUPPORT)

#define VJ_SUPPORT                      0
#define CCP_SUPPORT                     0
#define EAP_SUPPORT                     0

#define PPP_MRU                         1500
#define PPP_DEFMRU                      1500
#define PPP_MAXMRU                      1500
#define PPP_MINMRU                      128

/*ICMP*/
#define IP_DEFAULT_TTL                  255

#define MEMP_NUM_PBUF                   120
#define MEMP_NUM_TCP_PCB                40

/*TCP*/
#define LWIP_TCP_SACK_OUT               1
#define TCP_TTL                    255
#define TCP_MAXRTX                      12
#define TCP_SYNMAXRTX                   6
#define TCP_MSS                         1460
#define TCP_WND                         (4 * TCP_MSS)
#define TCP_SND_BUF                     (4 * TCP_MSS)

//#define TCP_SND_QUEUELEN                ((4 * (TCP_SND_BUF) + (TCP_MSS - 1))/(TCP_MSS))
//#define MEMP_NUM_TCP_SEG                16

 /*HTTP*/
//#define LWIP_HTTPD_SUPPORT_REQUESTLIST      1
//#define LWIP_HTTPD_SUPPORT_11_KEEPALIVE     1
#define HTTPD_MAX_RETRIES                   15
#define HTTPD_POLL_INTERVAL                 6
#define HTTPD_TCP_PRIO                      TCP_PRIO_MIN
//#define LWIP_HTTPD_REQ_QUEUELEN             15
//#define LWIP_HTTPD_MAX_REQ_LENGTH           LWIP_MIN(1023, (LWIP_HTTPD_REQ_QUEUELEN * PBUF_POOL_BUFSIZE))
//#define HTTPD_MAX_WRITE_LEN(pcb)     ((u16_t)(3 * altcp_mss(pcb)))



-------------PPP/TCP/HTTP debug trace---------------

Sending AT+CGATT=0
SIM5320A answer: OK

Sending ATD*99***1#
SIM5320A answer: CONNECT 460800

netif: netmask of interface netif: setting default interface pp
ppp_connect[0]: holdoff=3
ppp phase changed[0]: phase=2
httpd_init
tcp_bind: bind to port 80
ppp phase changed[0]: phase=3
pppos_connect: unit 0: connecting
ppp_start[0]
ppp phase changed[0]: phase=6
pppos_send_config[0]: out_accm=FF FF FF FF
ppp_send_config[0]
pppos_recv_config[0]: in_accm=FF FF FF FF
ppp_recv_config[0]
ppp: auth protocols: CHAP=1 CHAP_MD5=1
sent [LCP ConfReq id=0x1 <asyncmap 0x0> <magic 0x244e43a3> <pcomp> <accomp>]
pppos_write[0]: len=24
ppp_start[0]: finished
pppos_input[0]: got 97 bytes
pppos_iput[0]: Dropping bad fcs 0x85ae proto=0x21
pppos_input_drop: pbuf len=29, addr 0x20007b08
rcvd [LCP ConfAck id=0x1 <asyncmap 0x0> <magic 0x244e43a3> <pcomp> <accomp>]
pppos_input[0]: got 55 bytes
rcvd [LCP ConfReq id=0x1 <asyncmap 0x0> <auth chap MD5> <magic 0xf1e10a> <pcomp> <accomp>]
sent [LCP ConfAck id=0x1 <asyncmap 0x0> <auth chap MD5> <magic 0xf1e10a> <pcomp> <accomp>]
pppos_write[0]: len=29
netif_set_mtu[0]: mtu=1500
pppos_send_config[0]: out_accm=0 0 0 0
ppp_send_config[0]
pppos_recv_config[0]: in_accm=0 0 0 0
ppp_recv_config[0]
ppp phase changed[0]: phase=7
pppos_input[0]: got 64 bytes
rcvd [LCP DiscReq id=0x2 magic=0xf1e10a]
rcvd [CHAP Challenge id=0x1 <9032248cd0d3739cee4c5778fada7bab>, name = "UMTS_CHAP_SRVR"]
No CHAP secret found for authenticating us to UMTS_CHAP_SRVR
sent [CHAP Response id=0x1 <994c5703a744c6368b7ad260944a3c3c>, name = ""]
pppos_write[0]: len=25
pppos_input[0]: got 10 bytes
rcvd [CHAP Success id=0x1 ""]
CHAP authentication succeeded
CHAP authentication succeeded ppp phase changed[0]: phase=9
sent [IPCP ConfReq id=0x1 <addr 0.0.0.0>]
pppos_write[0]: len=14
pppos_input[0]: got 34 bytes
rcvd [IPCP ConfNak id=0x1 < 81 06 0a 0b 0c 0d> < 83 06 0a 0b 0c 0e> < 82 06 0a 0b 0c 0d> < 84 06 0a 0b 0c 0e>]
sent [IPCP ConfReq id=0x2 <addr 0.0.0.0>]
pppos_write[0]: len=14
pppos_input[0]: got 34 bytes
rcvd [IPCP ConfNak id=0x2 < 81 06 0a 0b 0c 0d> < 83 06 0a 0b 0c 0e> < 82 06 0a 0b 0c 0d> < 84 06 0a 0b 0c 0e>]
sent [IPCP ConfReq id=0x3 <addr 0.0.0.0>]
pppos_write[0]: len=14
pppos_input[0]: got 26 bytes
rcvd [IPCP ConfReq id=0x0]
sent [IPCP ConfNak id=0x0 <addr 0.0.0.0>]
pppos_write[0]: len=14
rcvd [IPCP ConfNak id=0x3 <addr 10.2.86.229>]
sent [IPCP ConfReq id=0x4 <addr 10.2.86.229>]
pppos_write[0]: len=14
pppos_input[0]: got 21 bytes
pppos_input[0]: Dropping bad fcs 0xb7ce proto=0x4
pppos_input_drop: pbuf len=4, addr 0x20007b08
rcvd [IPCP ConfAck id=0x4 <addr 10.2.86.229>]
pppos_input[0]: got 10 bytes
rcvd [IPCP ConfReq =0x2]
sent [IPCP ConfAck id=0x2]
pppos_write[0]: len=8
Could not determine remote IP address: defaulting to 10.64.64.64
netif: GW address of interface pp set to 10.64.64.64
netif_set_ipaddr: netif address being changed
sifup[0]: err_code=0
status_cb: Connected
   our_ipaddr  = 10.2.86.229
   gatewayaddr = 10.64.64.64
   netmask     = 255.255.255.255
local  IP address 10.2.86.229
remote IP address 10.64.64.64
ppp phase changed[0]: phase=10
pppos_input[0]: got 174 bytes
ppp_input[0]: ip in pbuf len=52
TCP connection request 61218 -> 80.
pppos_netif_output[0]: proto=0x21, len = 48
ppp_input[0]: ip in pbuf len=52
TCP connection request 61219 -> 80.
pppos_netif_output[0]: proto=0x21, len = 48
ppp_input[0]: ip in pbuf len=52
TCP connection request 61220 -> 80.
pppos_netif_output[0]: proto=0x21, len = 48
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling plication
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
pppos_input[0]: got 46 bytes
ppp_input[0]: ip in pbuf len=40
TCP connection established 61218 -> 80.
http_accept 0x2000a8a8 / 0
pppos_input[0]: got 46 bytes
ppp_input[0]: ip in pbuf len=40
TCP connection established 61219 -> 80.
http_accept 0x2000a7ec / 0
pppos_input[0]: got 46 bytes
ppp_input[0]: ip in pbuf len=40
TCP connection established 61220 -> 80.
http_accept 0x2000a730 / 0
pppos_input[0]: got 92 bytes
ppp_input[0]: ip in pbuf len=40
ppp_input[0]: ip in pbuf len=40
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
pppos_input[0]: got 549 bytes
ppp_input[0]: ip in pbuf len=497
http_recv: pcb=0x2000a8a8 pbuf=0x20007b08 err=Ok.
tcp_recved: received 457 bytes, wnd 5840 (0).
Received 457 bytes
First pbuf
CRLF received, parsing request
Received GET request"
Received "GET" request for URI: "/"
Lookingfor /index.shtml...
Looking for /index.ssi...
Looking for /index.shtm...
Looking for /index.html...
Opened.
http_recv: data 0x8021978 len 695
http_send: pcb=0x2000a8a8 hs=0x20001abc left=695
Trying go send 695 bytes
Sent 695 bytes
End of file.
Closing connection 0x2000a8a8
tcp_close: closing in State: ESTABLISHED
pppos_netif_output[0]: proto=0x21, len = 735
ppp_input[0]: ip in pbuf len=40
pppos_input[0]: got 92 bytes
ppp_input[0]: ip in pbuf len=40
ppp_input[0]: ip in pbuf len=40
pppos_input[0]: got 46 bytes
ppp_input[0]: ip in pbuf len=40
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing activepcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
http_poll: pcb=0x2000a730 hs=0x20001c24 pcb_state=ESTABLISHED
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
http_poll: pcb=0x2000a7ec hs=0x20001b70 pcb_state=ESTABLISHED
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 735
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: procssing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
http_poll: pcb=0x2000a730 hs=0x20001c24 pcb_state=ESTABLISHED
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
http_poll: pcb=0x2000a7ec hs=0x20001b70 pcb_state=ESTABLISHED
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_ l owtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
http_poll: pcb=0x2000a730 hs=0x20001c24 pcb_state=ESTABLISHED
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
http_poll: pcb=0x2000a7ec hs=0x20001b70 pcb_state=ESTABLISHED
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 735
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing acive pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
pppos_input[0]: got 92 bytes
ppp_input[0]: ip in pbuf len=40
http_recv: pcb=0x2000a7ec pbuf=0 err=Ok.
Closing connection 0x2000a7ec
tcp_close: closing in State: CLOSE_WAIT
pppos_netif_output[0]: proto=0x21, len = 40
ppp_input[0]: ip in pbuf len=40
http_recv: pcb=0x2000a730 pbuf=0 err=Ok.
Closing connection 0x2000a730
tcp_close: closing in State: CLOSE_WAIT
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
cp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: pro e ssing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
pppos_input[0]: got 92 bytes
ppp_input[0]: ip in pbuf len=40
pppos_netif_output[0]: proto=0x21, len = 40
ppp_input[0]: ip in pbuf len=40
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtm : processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tc_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling plication
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
pppos_netif_output[0]: proto=0x21, len = 735
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
pppos_input[0]: got 46 bytes
ppp_input[0]: ip in pbuf len=40
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtm : processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
pppos_input[0]: got 46 bytes
ppp_input[0]: ip in pbuf len=40
pppos_netif_output[0]: proto=0x21, len = 40
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcpslowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slotmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processingactive pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application
tcp_slowtmr: processing active pcb
tcp_slowtmr: polling application

On Tue, Feb 4, 2020 at 8:19 AM  <address@hidden>  wrote:
Hi Renato,

On Mon, Feb 03, 2020 at 03:26:54PM -0300, Renato Barresi wrote:
>
> #define VJ_SUPPORT                      1

Could you try disabling VJ support ? It is known to be broken.

Once this is done, if you still have any issue, please sent the PPP
debug trace. PPP_DEBUG + PRINTPKT_SUPPORT (+ PPP_PROTOCOLNAME) enabled.

Sylvain
reply via email to
[Prev in Thread] Current Thread [Next in Thread]