Description

This article gives a possible reason for the RADIUS interim-update message to not include acct Octets/Packet fields on MX2008 (BNG), and suggests a way to resolve the issue.

Symptoms

Customers may find that the RADIUS interim-update message does not include the acct Octets/Packet fields for the AE interface. The physical interface, on the other hand, has no such problem. 

user@mx# run show subscribers client-type dhcp extensive
Type: DHCP
User Name: pass@mx
IP Address: 10.0.0.7
IP Netmask: 255.255.0.0
Primary DNS Address: 8.8.8.8
Secondary DNS Address: 8.8.4.4
Logical System: default
Routing Instance: default
Interface: demux0.3221225483
Interface type: Dynamic
Underlying Interface: demux0.3221225482
Dynamic Profile Name: demux-pro
Dynamic Profile Version: 1
MAC Address: 00:10:94:00:00:01
State: Active
Radius Accounting ID: 12
Session ID: 12
PFE Flow ID: 27
VLAN Id: 100
Login Time: 2019-09-10 09:07:53 IST
DHCP Options: len 53
35 01 01 39 02 02 40 3d 07 01 00 10 94 00 00 01 33 04 00 00
00 3c 0c 15 63 6c 69 65 6e 74 5f 50 6f 72 74 20 2f 2f 34 2f
39 2d 30 2d 30 37 06 01 03 06 0f 21 2c
IP Address Pool: dhcpv4-p1
Accounting interval: 600

user@mx# run show subscribers id 12 accounting-statistics
Total subscribers: 0, Active Subscribers: 0

Sep 10 09:07:53.308324 authd_radius_send_acctg_msg: Starting RADIUS accounting session-id:12
Sep 10 09:07:53.308328 authd_radius_send_acctg_msg: session-id:12 profile=none username=pass@mx acctg_id=(12), ls=default, lr=default
Sep 10 09:07:53.308339 radius-acct-interim: User-Name added: pass@mx
Sep 10 09:07:53.308345 radius-acct-interim: Acct-Status-Type added: 3
Sep 10 09:07:53.308353 radius-acct-interim: Acct-Session-Id added: 12
Sep 10 09:07:53.308363 radius-acct-interim: Event-Timestamp added: 2019-09-10 09:07:53
<<<<<<Acct-Input-Octets/Acct-Output-Octets fields are missing>>>>>>
Sep 10 09:07:53.308369 radius-acct-interim: Acct-Session-Time added: 0
<<<<<<Acct-Input-Packets/Acct-Output-Packets fields are missing>>>>>>
Sep 10 09:07:53.308378 radius-acct-interim: Acct-Delay-Time added: 0
Sep 10 09:07:53.308390 radius-acct-interim: Service-Type added: 2
Sep 10 09:07:53.308403 storeFilterNameList failed for subscriber session-id:12 result = -7
Sep 10 09:07:53.308409 clearFilterNameList for subscriber session-id:12
Sep 10 09:07:53.308418 radius-acct-interim: Cos-Shaping-Rate (Juniper-ERX-VSA) added: Port speed: 10000000k
Sep 10 09:07:53.308439 radius-acct-interim: Acct-Authentic added: 2

From the AAA/PFED traceoption, we can find that the subscriber stale stats request from SDB has failed.  

AAA traceoption:
===================
Sep 10 09:07:53.308247 ../../../../../../../src/junos/usr.sbin/authd/aaa-service/authd_aaa_stats_driver.cc:4347 Failed to retrieve stats for the session-id:12 error = 10
Sep 10 09:07:53.308275 Subscriber accounting: session-id: 12 reqType: time-volume from AST
Sep 10 09:07:53.308282 Session start time not found or invalid for session-id:12
Sep 10 09:07:53.308294 AccFsm::current state=Acc-Start-Sent(1) event=4 session-id:12
Sep 10 09:07:53.308299 ACC-FSM:sendAccInterim_a4 for session-id:12

PFED traceoption:
===================
Sep 10 09:07:53.280273 (12037) DEBUG: pfed_get_location_id_by_ifl_index[471] libpeer get location failed: ret=-1, errno=2 for ifl:ae0
Sep 10 09:07:53.280298 (12037) DEBUG: pfed_handle_substats_failure[2158] Immediate : subscriber stale stats request from SDB failed for sid: 12, ifl_Index : 27

Solution

This is because ether-options is not supported by the subscriber management functionality on the MX2008 platform as indicated in PR1457926 . This problem is, however, not seen on MX240/MX480/MX960 because the ether-options knob is NOT available on these platforms.

To resolve this issue, modify the interface configuration from ether-options to gigether-options . 

user@mx# delete interfaces xe-0/0/0 ether-options
user@mx# set interfaces xe-0/0/0 gigether-options 802.3ad ae0  

user@mx# show | compare
[edit interfaces xe-0/0/0]
-     ether-options {
-         802.3ad ae0;
-     }
+     gigether-options {
+         802.3ad ae0;
+     }
user@mx# commit
commit complete

user@mx# run show subscribers client-type dhcp extensive
Type: DHCP
User Name: pass@mx
IP Address: 10.0.0.8
IP Netmask: 255.255.0.0
Primary DNS Address: 8.8.8.8
Secondary DNS Address: 8.8.4.4
Logical System: default
Routing Instance: default
Interface: demux0.3221225485
Interface type: Dynamic
Underlying Interface: demux0.3221225484
Dynamic Profile Name: demux-pro
Dynamic Profile Version: 1
MAC Address: 00:10:94:00:00:01
State: Active
Radius Accounting ID: 14
Session ID: 14
PFE Flow ID: 31
VLAN Id: 100
Login Time: 2019-09-10 09:16:30 IST
DHCP Options: len 53
35 01 01 39 02 02 40 3d 07 01 00 10 94 00 00 01 33 04 00 00
00 3c 0c 15 63 6c 69 65 6e 74 5f 50 6f 72 74 20 2f 2f 34 2f
39 2d 30 2d 30 37 06 01 03 06 0f 21 2c
IP Address Pool: dhcpv4-p1
Accounting interval: 600

user@mx# run show subscribers id 14 accounting-statistics
Session ID: 14
Interface: demux0.3221225485
Accounting Statistics
   Input bytes: 0
   Input packets: 0
   Output bytes: 0
   Output packets: 0
IPv6
   Input bytes: 0
   Input packets: 0
   Output bytes: 0
   Output packets: 0

Sep 10 09:16:30.654434 authd_radius_send_acctg_msg: Starting RADIUS accounting session-id:14
Sep 10 09:16:30.654439 authd_radius_send_acctg_msg: session-id:14 profile=none username=pass@mx acctg_id=(14), ls=default, lr=default
Sep 10 09:16:30.654450 radius-acct-interim: User-Name added: pass@mx
Sep 10 09:16:30.654456 radius-acct-interim: Acct-Status-Type added: 3
Sep 10 09:16:30.654463 radius-acct-interim: Acct-Session-Id added: 14
Sep 10 09:16:30.654473 radius-acct-interim: Event-Timestamp added: 2019-09-10 09:16:30
Sep 10 09:16:30.654480 radius-acct-interim: Acct-Input-Octets added: 0  <<<<<<<<Acct Octets/Packet fields included in interim message</span>    
Sep 10 09:16:30.654486 radius-acct-interim: Acct-Output-Octets added: 0      
Sep 10 09:16:30.654491 radius-acct-interim: Acct-Session-Time added: 0
Sep 10 09:16:30.654497 radius-acct-interim: Acct-Input-Packets added: 0
Sep 10 09:16:30.654502 radius-acct-interim: Acct-Output-Packets added: 0
Sep 10 09:16:30.654511 radius-acct-interim: Acct-Delay-Time added: 0
Sep 10 09:16:30.654520 radius-acct-interim: Service-Type added: 2

Related Information