I have a pppoe server running for a few months, however now I am getting the following error in the log when a new client connect:
dhcpv6: failed to join to All_DHCP_Relay_Agents_and_Servers
I'm using accel-ppp version 1.8.0.
This is the full log of connection:
Code: Select all
[2015-06-11 11:32:36.549] ppp3: : connect: ppp3 <--> pppoe(00:50:56:a3:7e:66)
[2015-06-11 11:32:36.549] ppp3: : lcp_layer_init
[2015-06-11 11:32:36.549] ppp3: : auth_layer_init
[2015-06-11 11:32:36.549] ppp3: : ccp_layer_init
[2015-06-11 11:32:36.549] ppp3: : ipcp_layer_init
[2015-06-11 11:32:36.549] ppp3: : ipv6cp_layer_init
[2015-06-11 11:32:36.549] ppp3: : ppp established
[2015-06-11 11:32:36.549] ppp3: 89b05d3374721792: lcp_layer_start
[2015-06-11 11:32:36.550] ppp3: 89b05d3374721792: send [LCP ConfReq id=1 <auth MSCHAP-v2> <mru 1492> <magic 2ae8944a>]
[2015-06-11 11:32:36.588] ppp3: 89b05d3374721792: recv [LCP ConfReq id=0 <mru 1480> <magic 2bdd2a59> <pcomp> <accomp> < d 3 6 >]
[2015-06-11 11:32:36.589] ppp3: 89b05d3374721792: send [LCP ConfRej id=0 <pcomp> <accomp> < d 3 6 >]
[2015-06-11 11:32:36.589] ppp3: 89b05d3374721792: recv [LCP ConfReq id=1 <mru 1480> <magic 2bdd2a59>]
[2015-06-11 11:32:36.589] ppp3: 89b05d3374721792: send [LCP ConfAck id=1 ]
[2015-06-11 11:32:39.550] ppp3: 89b05d3374721792: fsm timeout
[2015-06-11 11:32:39.550] ppp3: 89b05d3374721792: send [LCP ConfReq id=1 <auth MSCHAP-v2> <mru 1492> <magic 2ae8944a>]
[2015-06-11 11:32:39.551] ppp3: 89b05d3374721792: recv [LCP ConfAck id=1 <auth MSCHAP-v2> <mru 1492> <magic 2ae8944a>]
[2015-06-11 11:32:39.551] ppp3: 89b05d3374721792: lcp_layer_started
[2015-06-11 11:32:39.551] ppp3: 89b05d3374721792: auth_layer_start
[2015-06-11 11:32:39.551] ppp3: 89b05d3374721792: send [MSCHAP-v2 Challenge id=1 <61c8ec52b642d83d3df717450c8f8>]
[2015-06-11 11:32:39.551] ppp3: 89b05d3374721792: recv [LCP Ident id=2 <MSRASV5.20>]
[2015-06-11 11:32:39.551] ppp3: 89b05d3374721792: recv [LCP Ident id=3 <MSRAS-0-BACKUP>]
[2015-06-11 11:32:39.552] ppp3: 89b05d3374721792: recv [LCP Ident id=4 <▒�▒"/9I▒P▒_K8!>]
[2015-06-11 11:32:39.553] ppp3: 89b05d3374721792: recv [MSCHAP-v2 Response id=1 <70c1be0bf7439eadc7b6ed2e5917>, <88b92043207c55da93d26878af4eb852db357cc9926fa6f>, F=0, name="liberado"]
[2015-06-11 11:32:39.553] ppp3: 89b05d3374721792: send [RADIUS(1) Access-Request id=1 <User-Name "liberado"> <NAS-Identifier "accel-ppp"> <NAS-IP-Address 177.84.70.213> <NAS-Port 3> <NAS-Port-Type Virtual> <Service-Type Framed-User> <Framed-Protocol PPP> <Calling-Station-Id "00:50:56:a3:7e:66"> <Called-Station-Id "eth3:00:50:56:a3:23:9c"><Microsoft MS-CHAP-Challenge ><Microsoft MS-CHAP2-Response >]
[2015-06-11 11:32:39.553] ppp3: 89b05d3374721792: recv [RADIUS(1) Access-Accept id=1 <Service-Type Framed-User> <Framed-Protocol PPP> <Framed-Pool "mypool"> <Framed-IPv6-Prefix 2000:xxx:b101::/64> <Delegated-IPv6-Prefix 2000:xxx:e101::/48> <Filter-Id "10240"><Microsoft MS-CHAP2-Success ><Microsoft MS-MPPE-Recv-Key ><Microsoft MS-MPPE-Send-Key ><Microsoft MS-MPPE-Encryption-Policy 1><Microsoft MS-MPPE-Encryption-Type 6>]
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: send [MSCHAP-v2 Success id=1 "S=2B6FEDAE60C4621F6365BFEA544FBC24DB166762 M=Authentication succeeded"]
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: auth_layer_started
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: ccp_layer_start
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: ipcp_layer_start
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: send [IPCP ConfReq id=1 <addr 192.168.100.1>]
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: ipv6cp_layer_start
[2015-06-11 11:32:39.554] ppp3: 89b05d3374721792: liberado: authentication succeeded
[2015-06-11 11:32:39.557] ppp3: 89b05d3374721792: recv [IPV6CP ConfReq id=5 <addr 0:0:0:1>]
[2015-06-11 11:32:39.557] ppp3: 89b05d3374721792: send [IPV6CP ConfReq id=1 <addr 6fe0:a8a6:e941:d223>]
[2015-06-11 11:32:39.557] ppp3: 89b05d3374721792: send [IPV6CP ConfAck id=5]
[2015-06-11 11:32:39.557] ppp3: 89b05d3374721792: recv [CCP ConfReq id=6 <mppe -H -M -S -L -D -C>]
[2015-06-11 11:32:39.557] ppp3: 89b05d3374721792: send [CCP ConfReq id=1 <mppe -H -M -S -L -D -C>]
[2015-06-11 11:32:39.557] ppp3: 89b05d3374721792: send [CCP ConfAck id=6]
[2015-06-11 11:32:39.558] ppp3: 89b05d3374721792: recv [IPCP ConfReq id=7 <addr 0.0.0.0> <dns1 0.0.0.0> <wins1 0.0.0.0> <dns2 0.0.0.0> <wins2 0.0.0.0>]
[2015-06-11 11:32:39.558] ppp3: 89b05d3374721792: send [IPCP ConfNak id=7 <addr xxx.xxx.129.4> <dns1 177.84.70.1> <dns2 177.84.70.4>]
[2015-06-11 11:32:39.558] ppp3: 89b05d3374721792: recv [IPCP ConfAck id=1 <addr 192.168.100.1>]
[2015-06-11 11:32:39.558] ppp3: 89b05d3374721792: recv [IPV6CP ConfAck id=1 <addr 6fe0:a8a6:e941:d223>]
[2015-06-11 11:32:39.558] ppp3: 89b05d3374721792: ipv6cp_layer_started
[2015-06-11 11:32:39.657] ppp3: 89b05d3374721792: recv [CCP ConfAck id=1 <mppe -H -M -S -L -D -C>]
[2015-06-11 11:32:39.657] ppp3: 89b05d3374721792: ccp_layer_started
[2015-06-11 11:32:39.657] ppp3: 89b05d3374721792: recv [IPCP ConfReq id=8 <addr xxx.xxx.129.4> <dns1 177.84.70.1> <wins1 0.0.0.0> <dns2 177.84.70.4> <wins2 0.0.0.0>]
[2015-06-11 11:32:39.657] ppp3: 89b05d3374721792: send [IPCP ConfAck id=8]
[2015-06-11 11:32:39.657] ppp3: 89b05d3374721792: ipcp_layer_started
[2015-06-11 11:32:39.657] ppp3: 89b05d3374721792: send [RADIUS(1) Accounting-Request id=1 <User-Name "liberado"> <NAS-Identifier "accel-ppp"> <NAS-IP-Address 177.84.70.213> <NAS-Port 3> <NAS-Port-Type Virtual> <Service-Type Framed-User> <Framed-Protocol PPP> <Calling-Station-Id "00:50:56:a3:7e:66"> <Called-Station-Id "eth3:00:50:56:a3:23:9c"> <Acct-Status-Type Start> <Acct-Authentic RADIUS> <Acct-Session-Id "89b05d3374721792"> <Acct-Session-Time 0> <Acct-Input-Octets 0> <Acct-Output-Octets 0> <Acct-Input-Packets 0> <Acct-Output-Packets 0> <Acct-Input-Gigawords 0> <Acct-Output-Gigawords 0> <Framed-IP-Address xxx.xxx.129.4> <Framed-Interface-Id 0:0:0:1> <Framed-IPv6-Prefix 2000:xxx:b101::/64>]
[2015-06-11 11:32:39.658] ppp3: 89b05d3374721792: recv [RADIUS(1) Accounting-Response id=1]
[2015-06-11 11:32:39.658] ppp3: 89b05d3374721792: shaper: installed shaper 10240/10240 (Kbit)
[2015-06-11 11:32:39.659] ppp3: 89b05d3374721792: pppoe: ppp started
[2015-06-11 11:32:39.660] ppp3: 89b05d3374721792: dhcpv6: failed to join to All_DHCP_Relay_Agents_and_Servers
[2015-06-11 11:32:39.660] ppp3: 89b05d3374721792: pppd_compat: ip-up started (pid 3485)
[2015-06-11 11:32:39.665] ppp3: 89b05d3374721792: pppd_compat: ip-up finished (0)
[2015-06-11 11:32:39.877] ppp3: 89b05d3374721792: recv [DHCPv6 Information-Request XID=35f026 <Elapsed-Time 16777216> <Client-ID 1:00011c4596d2005056a37e66> <Vendor-Class 6002462675370573824> <Option-Request DNSSL,DNS,Vendor-Specific,32>]
[2015-06-11 11:32:39.877] ppp3: 89b05d3374721792: send [DHCPv6 Reply XID=35f026 <Server-ID 3:001b0000000000000001> <Client-ID 1:00011c4596d2005056a37e66> <DNSSL> <DNS 2000:xxx:c:0:177:84:70:1,2000:xxx:c:0:177:84:70:4> <Preference 255>]