cancel
Showing results for 
Search instead for 
Did you mean: 
cancel
662
Views
5
Helpful
1
Replies

ASR9901 PPPoE session setup failed to start I-Edge session

tiger_lee
Level 1
Level 1

Hi All,

Recently, We are trying to setup a BNG PPPoE with Dslite, but we found that We can not setup PPPoE session, even under IPv4, the PPPoE session will be failed to start I-Edge session. 

Could anyone to check any configuration issue with our AAA configuration.

The below is the test environment setup.

 

 

The below is the PPPoE IPv4 configuration and debug log.

radius-server host 10.10.10.1 auth-port 1812 acct-port 1813
key 7 010703174F020808701E1D
aaa group server radius test
server 10.10.10.1 auth-port 1812 acct-port 1813
source-interface GigabitEthernet0/0/0/1
!
pool vrf default ipv4 VD4222B_PPP_V4_POOL
address-range 10.20.20.1 10.20.20.254
dynamic-template
type ppp ipv4-ppp
ppp authentication pap chap
ppp ipcp peer-address pool VD4222B_PPP_V4_POOL
ipv4 unnumbered Loopback20
!
type ipsubscriber ipv4
!
!
interface Loopback20
ipv4 address 10.20.20.254 255.255.255.255
!
interface GigabitEthernet0/0/0/4
ipv4 point-to-point
ipv4 unnumbered Loopback20
service-policy type control subscriber ppp-ipv4-pm
pppoe enable

aaa accounting subscriber list group test
aaa authorization subscriber list group test
aaa authentication subscriber list group test
!
class-map type control subscriber match-any ppp-ipv4-cm
match protocol ppp
end-class-map
!
!
policy-map type control subscriber ppp-ipv4-pm
event session-start match-all
class type control subscriber ppp-ipv4-cm do-until-failure
10 authenticate aaa list list
20 activate dynamic-template ipv4-ppp
!
!
end-policy-map
!
end


debug pppoe protocol ////debug on access interface without vlan
RP/0/RSP0/CPU0:ASR9901#LC/0/0/CPU0:Jan 26 16:08:46.970 UTC: pppoe_ma[125]: [PADI-Recv]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:08:46.970 UTC: pppoe_ma[125]: [PADI-Recv]: Service-name:
LC/0/0/CPU0:Jan 26 16:08:46.970 UTC: pppoe_ma[125]: [PADI-Recv]: Host-uniq: 1a0000000000000030000000
LC/0/0/CPU0:Jan 26 16:08:46.971 UTC: pppoe_ma[125]: [PADO-Sent]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:08:46.971 UTC: pppoe_ma[125]: [PADR-Recv]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:08:46.971 UTC: pppoe_ma[125]: [PADR-Recv]: Service-name:
LC/0/0/CPU0:Jan 26 16:08:46.971 UTC: pppoe_ma[125]: [PADR-Recv]: Host-uniq: 1a0000000000000031000000
LC/0/0/CPU0:Jan 26 16:08:47.085 UTC: pppoe_ma[125]: [PADS-Sent]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:08:47.085 UTC: pppoe_ma[125]: [PADS-Sent]: REJECTED - failed to start I-Edge session


debug ppp all ////debug on access interface without vlan
RP/0/RSP0/CPU0:ASR9901#show ppp LC/0/0/CPU0:Jan 26 16:18:48.109 UTC: pppoe_ma[125]: [PADI-Recv]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:18:48.109 UTC: pppoe_ma[125]: [PADI-Recv]: Service-name:
LC/0/0/CPU0:Jan 26 16:18:48.109 UTC: pppoe_ma[125]: [PADI-Recv]: Host-uniq: 1d0000000000000036000000
LC/0/0/CPU0:Jan 26 16:18:48.109 UTC: pppoe_ma[125]: [PADO-Sent]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:18:48.110 UTC: pppoe_ma[125]: [PADR-Recv]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:18:48.110 UTC: pppoe_ma[125]: [PADR-Recv]: Service-name:
LC/0/0/CPU0:Jan 26 16:18:48.110 UTC: pppoe_ma[125]: [PADR-Recv]: Host-uniq: 1d0000000000000037000000
LC/0/0/CPU0:Jan 26 16:18:48.222 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Initial]: Up Event
LC/0/0/CPU0:Jan 26 16:18:48.222 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Initial]: Change to state Closed
LC/0/0/CPU0:Jan 26 16:18:48.222 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Closed]: Down Event
LC/0/0/CPU0:Jan 26 16:18:48.222 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Closed]: Change to state Initial
LC/0/0/CPU0:Jan 26 16:18:48.222 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Initial]: Up Event
LC/0/0/CPU0:Jan 26 16:18:48.222 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Initial]: Change to state Closed
LC/0/0/CPU0:Jan 26 16:18:48.223 UTC: pppoe_ma[125]: [PADS-Sent]: GigabitEthernet0/0/0/4 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:18:48.223 UTC: pppoe_ma[125]: [PADS-Sent]: REJECTED - failed to start I-Edge session
LC/0/0/CPU0:Jan 26 16:18:48.324 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Closed]: Down Event
LC/0/0/CPU0:Jan 26 16:18:48.324 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Closed]: Change to state Initial
LC/0/0/CPU0:Jan 26 16:18:48.324 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/4.pppoe7: [Initial]: Close Event


debug pppoe protocol//debug on access interface with vlan
RP/0/RSP0/CPU0:ASR9901#LC/0/0/CPU0:Jan 26 16:20:50.703 UTC: pppoe_ma[125]: [PADI-Recv]: GigabitEthernet0/0/0/0.100 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:20:50.703 UTC: pppoe_ma[125]: [PADI-Recv]: vlan-id-outer 100
LC/0/0/CPU0:Jan 26 16:20:50.703 UTC: pppoe_ma[125]: [PADI-Recv]: Service-name:
LC/0/0/CPU0:Jan 26 16:20:50.703 UTC: pppoe_ma[125]: [PADI-Recv]: Host-uniq: 1e0000000000000038000000
LC/0/0/CPU0:Jan 26 16:20:50.704 UTC: pppoe_ma[125]: [PADO-Sent]: GigabitEthernet0/0/0/0.100 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:20:50.704 UTC: pppoe_ma[125]: [PADO-Sent]: vlan-id-outer 100
LC/0/0/CPU0:Jan 26 16:20:50.704 UTC: pppoe_ma[125]: [PADR-Recv]: GigabitEthernet0/0/0/0.100 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:20:50.704 UTC: pppoe_ma[125]: [PADR-Recv]: vlan-id-outer 100
LC/0/0/CPU0:Jan 26 16:20:50.704 UTC: pppoe_ma[125]: [PADR-Recv]: Service-name:
LC/0/0/CPU0:Jan 26 16:20:50.704 UTC: pppoe_ma[125]: [PADR-Recv]: Host-uniq: 1e0000000000000039000000
LC/0/0/CPU0:Jan 26 16:20:50.819 UTC: pppoe_ma[125]: [PADS-Sent]: GigabitEthernet0/0/0/0.100 peer-mac f8e4.3b54.1a0a
LC/0/0/CPU0:Jan 26 16:20:50.819 UTC: pppoe_ma[125]: [PADS-Sent]: vlan-id-outer 100
LC/0/0/CPU0:Jan 26 16:20:50.819 UTC: pppoe_ma[125]: [PADS-Sent]: REJECTED - failed to start I-Edge session
LC/0/0/CPU0:Jan 26 16:20:50.820 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Initial]: Up Event
LC/0/0/CPU0:Jan 26 16:20:50.820 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Initial]: Change to state Closed
LC/0/0/CPU0:Jan 26 16:20:50.820 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Closed]: Down Event
LC/0/0/CPU0:Jan 26 16:20:50.820 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Closed]: Change to state Initial
LC/0/0/CPU0:Jan 26 16:20:50.820 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Initial]: Up Event
LC/0/0/CPU0:Jan 26 16:20:50.820 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Initial]: Change to state Closed
LC/0/0/CPU0:Jan 26 16:20:50.920 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Closed]: Down Event
LC/0/0/CPU0:Jan 26 16:20:50.920 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Closed]: Change to state Initial
LC/0/0/CPU0:Jan 26 16:20:50.920 UTC: PPP-MA[266]: LCP: GigabitEthernet0/0/0/0.100.pppoe9718: [Initial]: Close Event

 

1 Accepted Solution

Accepted Solutions

tiger_lee
Level 1
Level 1

Found root cause, the Policy map is not correct, resoved.

View solution in original post

1 Reply 1

tiger_lee
Level 1
Level 1

Found root cause, the Policy map is not correct, resoved.