Hi Nicolas,
<snip>
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: Aux:>
>ATD*99***1#\r
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: Aux:<
>\r\nCONNECT\r\n
> Jan 2 16:25:14 109656587698 daemon.debug ofonod[600]:
>drivers/atmodem/gprs-context.c:at_cgdata_cb() ok 1
> Jan 2 16:25:14 109656587698 daemon.debug ofonod[600]:
>drivers/atmodem/gprs-context.c:setup_ppp()
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_generate_event: current state 0:INITIAL
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 0
>(Up), action: 2, new_state: 2 (CLOSED)
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_generate_event: current state 2:CLOSED
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 2
>(Open), action: 1026, new_state: 6 (REQSENT)
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_initialize_restart_count: current state 2:CLOSED
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_send_configure_request: current state 2:CLOSED
>
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP:
>gatchat/gatppp.c:ppp_enter_phase() 1
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_process_configure_ack: current state 6:REQSENT
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_generate_event: current state 6:REQSENT
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 8
>(RCA), action: 27, new_state: 7 (ACKRCVD)
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_initialize_restart_count: current state 6:REQSENT
>
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_process_configure_request: current state 7:ACKRCVD
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_generate_event: current state 7:ACKRCVD
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 7
>(RCR-), action: 4007, new_state: 7 (ACKRCVD)
>
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_send_configure_nak: current state 7:ACKRCVD
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_process_configure_request: current state 7:ACKRCVD
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_generate_event: current state 7:ACKRCVD
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 6
>(RCR+), action: 2109, new_state: 9 (OPENED)
>
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_send_configure_ack: current state 7:ACKRCVD
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP:
>gatchat/gatppp.c:ppp_enter_phase() 2
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP:
>gatchat/gatppp.c:ppp_enter_phase() 3
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 0:INITIAL
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 2
>(Open), action: 401, new_state: 1 (STARTING)
>
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 1:STARTING
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: event: 0
>(Up), action: 1026, new_state: 6 (REQSENT)
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_initialize_restart_count: current state 1:STARTING
> Jan 2 16:25:14 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_send_configure_request: current state 1:STARTING
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_timeout: current state 6:REQSENT
>
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 6:REQSENT
>
>
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: event: 4
>(TO+), action: 1006, new_state: 6 (REQSENT)
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_send_configure_request: current state 6:REQSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_process_configure_request: current state 6:REQSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 6:REQSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: event: 6
>(RCR+), action: 2008, new_state: 8 (ACKSENT)
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_send_configure_ack: current state 6:REQSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_process_configure_reject: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: event: 9
>(RCN), action: 1028, new_state: 8 (ACKSENT)
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_initialize_restart_count: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_send_configure_request: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_process_configure_nak: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: event: 9
>(RCN), action: 1028, new_state: 8 (ACKSENT)
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_initialize_restart_count: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_send_configure_request: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_process_configure_ack: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_generate_event: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: event: 8
>(RCA), action: 129, new_state: 9 (OPENED)
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: ipcp:
>pppcp_initialize_restart_count: current state 8:ACKSENT
> Jan 2 16:25:18 109656587698 daemon.info ofonod[600]: PPP: lcp:
>pppcp_generate_event: current state 9:OPENED
So we were able to negotiate IPCP parameters but network setup failed.
Are you running as root and is your tun module loaded?
Regards,
-Denis
Hi Denis,
Thank you for the advice. I forgot to configure the TUN device.
Now, the PPP link is established entirely.
Regards,
Nicolas