nas102:/var/log/accel-ppp# tail -f local-debug.log|grep "00000000000A769C\|ipoe1142\|08:00:27:32:2c:bb"
[2017-10-20 15:20:14.282] ipoe1142: 00000000000A769C: radius(1): req_enter 1
[2017-10-20 15:20:14.283] ipoe1142: 00000000000A769C: radius(1): req_exit 0
[2017-10-20 15:21:14.282] ipoe1142: 00000000000A769C: radius(1): req_enter 1
[2017-10-20 15:21:14.283] ipoe1142: 00000000000A769C: radius(1): req_exit 0
[2017-10-20 15:22:14.282] ipoe1142: 00000000000A769C: radius(1): req_enter 1
[2017-10-20 15:22:14.283] ipoe1142: 00000000000A769C: radius(1): req_exit 0
[2017-10-20 15:23:14.282] ipoe1142: 00000000000A769C: radius(1): req_enter 1
[2017-10-20 15:23:14.283] ipoe1142: 00000000000A769C: radius(1): req_exit 0
[2017-10-20 15:24:14.282] ipoe1142: 00000000000A769C: radius(1): req_enter 1
[2017-10-20 15:24:14.283] ipoe1142: 00000000000A769C: radius(1): req_exit 0
[2017-10-20 15:24:15.843] ipoe1142: 00000000000A769C: ipoe: session timed out
[2017-10-20 15:24:15.843] ipoe1142: 00000000000A769C: terminate
[2017-10-20 15:24:15.846] ipoe1142: 00000000000A769C: radius(1): req_enter 1
[2017-10-20 15:24:15.846] ipoe1142: 00000000000A769C: send [RADIUS(1) Accounting-Request id=1a <User-Name "bond0.113-08:00:27:32:2c:bb"> < NAS-Identifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "08:00:27:32:2c:bb"> <Calle d-Station-Id "bond0.113"> <Acct-Status-Type Stop> <Acct-Authentic RADIUS> <Acct-Session-Id "00000000000A769C"> <Acct-Session-Time 1502> <A cct-Input-Octets 117678> <Acct-Output-Octets 299752> <Acct-Input-Packets 1090> <Acct-Output-Packets 542> <Acct-Input-Gigawords 0> <Acct-Ou tput-Gigawords 0> <Framed-IP-Address 10.1.142.56> <Acct-Terminate-Cause Lost-Carrier>]
[2017-10-20 15:24:15.846] ipoe1142: 00000000000A769C: radius(1): req_exit 0
[2017-10-20 15:24:15.846] ipoe1142: 00000000000A769C: ipoe: session finished
[2017-10-20 15:25:04.277] ipoe1142: 00000000000A8A30: create interface ipoe1142 parent bond0.114
[2017-10-20 15:25:04.277] ipoe1142: 00000000000A8A30: radius(1): req_enter 1
[2017-10-20 15:25:04.277] ipoe1142: 00000000000A8A30: send [RADIUS(1) Access-Request id=1 <User-Name "bond0.114-18:d6:c7:3a:fd:d5"> <NAS-I dentifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "18:d6:c7:3a:fd:d5"> <Called-Sta tion-Id "bond0.114"> <User-Password>]
[2017-10-20 15:25:04.278] ipoe1142: 00000000000A8A30: radius(1): req_exit 0
[2017-10-20 15:25:04.278] ipoe1142: 00000000000A8A30: recv [RADIUS(1) Access-Accept id=1 <Acct-Interim-Interval 60> <Framed-Pool "ip_83">]
[2017-10-20 15:25:04.278] ipoe1142: 00000000000A8A30: bond0.114-18:d6:c7:3a:fd:d5: authentication succeeded
[2017-10-20 15:25:04.278] ipoe1142: 00000000000A8A30: send [DHCPv4 Offer xid=1459db7d yiaddr=10.1.136.6 chaddr=18:d6:c7:3a:fd:d5 <Message- Type Offer> <Server-ID 10.1.128.1> <Lease-Time 300> <T1 120> <Router 10.1.128.1> <Subnet 255.255.224.0> <DNS 91.196.80.11,91.196.80.11>]
[2017-10-20 15:25:04.304] ipoe1142: 00000000000A8A30: recv [DHCPv4 Request xid=1459db7d chaddr=18:d6:c7:3a:fd:d5 <Message-Type Request> <M ax-Message-Size 1024> <Client-ID 0118d6c73afdd5> <Host-Name TL-WR840N> <Vendor-Class 4d53465420352e30> <Request-IP 10.1.136.6> <Server-ID 10.1.128.1> <Request-List Subnet,Router,DNS,Domain-Name,Route,Vendor-Specific,44,46,47,Classless-Route,249> <Relay-Agent {Agent-Circuit-ID _000400720019} {Agent-Remote-ID _0006ec228025b5e0}>]
[2017-10-20 15:25:04.304] ipoe1142: 00000000000A8A30: ipoe: activate session
[2017-10-20 15:25:04.304] ipoe1142: 00000000000A8A30: radius(1): req_enter 1
[2017-10-20 15:25:04.304] ipoe1142: 00000000000A8A30: send [RADIUS(1) Accounting-Request id=1 <User-Name "bond0.114-18:d6:c7:3a:fd:d5"> <N AS-Identifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "18:d6:c7:3a:fd:d5"> <Called -Station-Id "bond0.114"> <Acct-Status-Type Start> <Acct-Authentic RADIUS> <Acct-Session-Id "00000000000A8A30"> <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 10.1.136.6>]
[2017-10-20 15:25:04.304] ipoe1142: 00000000000A8A30: send [DHCPv4 Ack xid=1459db7d yiaddr=10.1.136.6 chaddr=18:d6:c7:3a:fd:d5 <Message-Ty pe Ack> <Server-ID 10.1.128.1> <Lease-Time 300> <T1 120> <Router 10.1.128.1> <Subnet 255.255.224.0> <DNS 91.196.80.11,91.196.80.11>]
[2017-10-20 15:25:04.305] ipoe1142: 00000000000A8A30: radius(1): req_exit 0
[2017-10-20 15:25:04.305] ipoe1142: 00000000000A8A30: recv [RADIUS(1) Accounting-Response id=1]
[2017-10-20 15:25:04.305] ipoe1142: 00000000000A8A30: ipoe: session started
[2017-10-20 15:25:05.912] ipoe1142: 00000000000A8A30: recv [DHCPv4 Request xid=5d977aa9 ciaddr=10.1.134.147 chaddr=00:0f:ea:e5:0f:11 <Mess age-Type Request> <Client-ID 01000feae50f11> <Max-Message-Size 1492> <Request-List Subnet,Router,DNS,Host-Name,Domain-Name,Broadcast,Route ,NTP,249> <Vendor-Class 756468637020312e31372e34> <Relay-Agent {Agent-Circuit-ID _000400720019} {Agent-Remote-ID _0006ec228025b5e0}>]
[2017-10-20 15:25:05.912] ipoe1142: 00000000000A8A30: mac change detected
[2017-10-20 15:25:05.912] ipoe1142: 00000000000A8A30: terminate
[2017-10-20 15:25:05.915] ipoe1142: 00000000000A8A30: radius(1): req_enter 1
[2017-10-20 15:25:05.916] ipoe1142: 00000000000A8A30: send [RADIUS(1) Accounting-Request id=1 <User-Name "bond0.114-18:d6:c7:3a:fd:d5"> <N AS-Identifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "18:d6:c7:3a:fd:d5"> <Called -Station-Id "bond0.114"> <Acct-Status-Type Stop> <Acct-Authentic RADIUS> <Acct-Session-Id "00000000000A8A30"> <Acct-Session-Time 2> <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 10.1.136.6> <Acct-Terminate-Cause User-Request>]
[2017-10-20 15:25:05.916] ipoe1142: 00000000000A8A30: radius(1): req_exit 0
[2017-10-20 15:25:05.916] ipoe1142: 00000000000A8A30: ipoe: session finished
[2017-10-20 15:25:45.210] ipoe1142: 00000000000A8ACE: create interface ipoe1142 parent bond0.114
[2017-10-20 15:25:45.210] ipoe1142: 00000000000A8ACE: radius(1): req_enter 1
[2017-10-20 15:25:45.210] ipoe1142: 00000000000A8ACE: send [RADIUS(1) Access-Request id=1 <User-Name "bond0.114-f8:d1:11:cf:1a:ff"> <NAS-I dentifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "f8:d1:11:cf:1a:ff"> <Called-Sta tion-Id "bond0.114"> <User-Password>]
[2017-10-20 15:25:45.212] ipoe1142: 00000000000A8ACE: radius(1): req_exit 0
[2017-10-20 15:25:45.212] ipoe1142: 00000000000A8ACE: recv [RADIUS(1) Access-Accept id=1 <Acct-Interim-Interval 60> <Framed-Pool "ip_83">]
[2017-10-20 15:25:45.213] ipoe1142: 00000000000A8ACE: bond0.114-f8:d1:11:cf:1a:ff: authentication succeeded
[2017-10-20 15:25:45.213] ipoe1142: 00000000000A8ACE: send [DHCPv4 Offer xid=8a96023b yiaddr=10.1.135.11 chaddr=f8:d1:11:cf:1a:ff <Message -Type Offer> <Server-ID 10.1.128.1> <Lease-Time 300> <T1 120> <Router 10.1.128.1> <Subnet 255.255.224.0> <DNS 91.196.80.11,91.196.80.11>]
[2017-10-20 15:25:45.226] ipoe1142: 00000000000A8ACE: recv [DHCPv4 Request xid=8a96023b chaddr=f8:d1:11:cf:1a:ff <Message-Type Request> <M ax-Message-Size 1024> <Client-ID 01f8d111cf1aff> <Host-Name TL-WR740N> <Vendor-Class 4d53465420352e30> <Request-IP 10.1.135.11> <Server-ID 10.1.128.1> <Request-List Subnet,Router,DNS,Domain-Name,Route,Vendor-Specific,44,46,47,Classless-Route,249> <Relay-Agent {Agent-Circuit-I D _000400720019} {Agent-Remote-ID _0006ec228025b5e0}>]
[2017-10-20 15:25:45.226] ipoe1142: 00000000000A8ACE: ipoe: activate session
[2017-10-20 15:25:45.245] ipoe1142: 00000000000A8ACE: radius(1): req_enter 1
[2017-10-20 15:25:45.245] ipoe1142: 00000000000A8ACE: send [RADIUS(1) Accounting-Request id=1 <User-Name "bond0.114-f8:d1:11:cf:1a:ff"> <N AS-Identifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "f8:d1:11:cf:1a:ff"> <Called -Station-Id "bond0.114"> <Acct-Status-Type Start> <Acct-Authentic RADIUS> <Acct-Session-Id "00000000000A8ACE"> <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 10.1.135.11>]
[2017-10-20 15:25:45.246] ipoe1142: 00000000000A8ACE: send [DHCPv4 Ack xid=8a96023b yiaddr=10.1.135.11 chaddr=f8:d1:11:cf:1a:ff <Message-T ype Ack> <Server-ID 10.1.128.1> <Lease-Time 300> <T1 120> <Router 10.1.128.1> <Subnet 255.255.224.0> <DNS 91.196.80.11,91.196.80.11>]
[2017-10-20 15:25:45.246] ipoe1142: 00000000000A8ACE: radius(1): req_exit 0
[2017-10-20 15:25:45.246] ipoe1142: 00000000000A8ACE: recv [RADIUS(1) Accounting-Response id=1]
[2017-10-20 15:25:45.248] ipoe1142: 00000000000A8ACE: ipoe: session started
[2017-10-20 15:25:46.925] ipoe1142: 00000000000A8ACE: recv [DHCPv4 Request xid=5ecd8840 ciaddr=10.1.135.239 chaddr=98
d0:58:c0:fd <Mess age-Type Request> <Max-Message-Size 1024> <Client-ID 0198ded058c0fd> <Host-Name TL-WR840N> <Vendor-Class 4d53465420352e30> <Request-List S ubnet,Router,DNS,Domain-Name,Route,Vendor-Specific,44,46,47,Classless-Route,249> <Relay-Agent {Agent-Circuit-ID _000400720019} {Agent-Remo te-ID _0006ec228025b5e0}>]
[2017-10-20 15:25:46.925] ipoe1142: 00000000000A8ACE: mac change detected
[2017-10-20 15:25:46.925] ipoe1142: 00000000000A8ACE: terminate
[2017-10-20 15:25:46.927] ipoe1142: 00000000000A8ACE: radius(1): req_enter 1
[2017-10-20 15:25:46.927] ipoe1142: 00000000000A8ACE: send [RADIUS(1) Accounting-Request id=1 <User-Name "bond0.114-f8:d1:11:cf:1a:ff"> <N AS-Identifier "nas102"> <NAS-Port 1179> <NAS-Port-Id "ipoe1142"> <NAS-Port-Type Ethernet> <Calling-Station-Id "f8:d1:11:cf:1a:ff"> <Called -Station-Id "bond0.114"> <Acct-Status-Type Stop> <Acct-Authentic RADIUS> <Acct-Session-Id "00000000000A8ACE"> <Acct-Session-Time 2> <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 10.1.135.11> <Acct-Terminate-Cause User-Request>]
[2017-10-20 15:25:46.927] ipoe1142: 00000000000A8ACE: radius(1): req_exit 0
[2017-10-20 15:25:46.928] ipoe1142: 00000000000A8ACE: ipoe: session finished