09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [HandleRadius] >=>=>=>=>=>=>=> Auth Packet received from 10.20.1.87, size: 329 >=>=>=>=>=>=>=> 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Authenticator: 4a54e6e19ba23521a74228cef2db9662 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'User-Name', value: "28:28:5d:e0:d1:1e" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'Password', value: "fbc68575edfd743e7b76446daaf03b03" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseAttr] User-Password = "Redback" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'Service-Type', value: "5" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'NAS-Identifier', value: "se100-1" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'NAS-Port', value: "2533388248" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'NAS-Real-Port', vendor 2352, value: "33751040" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'NAS-Port-Type', value: "5" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'NAS-Port-Id', value: "1818697833" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Unknown VSA 38, vendor 2352, value: "0000000b" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'Mac-Addr', vendor 2352, value: "28-28-5d-e0-d1-1e" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Attribute 'Called-Station-Id', value: "10.20.5.131" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'DHCP-Field', vendor 2352, value: "010a140583" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'Platform-Type', vendor 2352, value: "4" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'OS-Version', vendor 2352, value: "12.1.1.9p1" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'Redback-Agent-Remote-Id', vendor 2352, value: "00030f3d2e34" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Unknown VSA 2, vendor 3561, value: "00030f3d2e34" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'Redback-Agent-Circuit-Id', vendor 2352, value: "0006018d01000005" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] Unknown VSA 1, vendor 3561, value: "0006018d01000005" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'DHCP-Option', vendor 2352, value: "3d3d070128285de0d11e" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'DHCP-Option', vendor 2352, value: "0c0c0d4b65656e657469635f4c697465" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [ParseBody] VSA 'DHCP-Vendor-Class-ID', vendor 2352, value: "ndhcpc" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [TryAuthISG] Trying to authenticate ISG with method 'opt82' 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [TryAuthISGByOpt82] Opt82 params: "00030f3d2e34", 5 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [CheckBlackList] ANI '28-28-5d-e0-d1-1e' (User '012173') is clean 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AuthenticateFromDB] User '012173' (vg_id = 21911) 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AuthenticateFromDB] User: '012173', bill by traffic, unlimited session timeout (0) 09.06.2016 16:05:36 INFO 0x7fabf11ac700 [RunAuthRequest] Access-Accept, <012173> [21911] 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [RunAuthRequest] =============== Output attributes dump: =============== 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [RunAuthRequest] Attribute 'Session-Timeout', value: "0" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [RunAuthRequest] Attribute 'Service-Type', value: "5" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [RunAuthRequest] Attribute 'Class', value: "00021911" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [RunAuthRequest] Attribute 'Acct-Interim-Interval', value: "600" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Dynamic-QoS-Param', vendor 2352, value: "police-class-rate LCLASS rate-absolute 102400" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Dynamic-QoS-Param', vendor 2352, value: "meter-class-rate LCLASS rate-absolute 102400" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Dynamic-QoS-Param', vendor 2352, value: "police-class-burst LCLASS 13107200" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Dynamic-QoS-Param', vendor 2352, value: "meter-class-burst LCLASS 13107200" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Dynamic-QoS-Param', vendor 2352, value: "police-class-excess-burst LCLASS 19660800" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Dynamic-QoS-Param', vendor 2352, value: "meter-class-excess-burst LCLASS 19660800" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'IP-Interface-Name', vendor 2352, value: "CLIENTS" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'DHCP-Max-Leases', vendor 2352, value: "1" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Context-Name', vendor 2352, value: "l3-dclips" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Qos-Policing-Profile-Name', vendor 2352, value: "qos-default-in" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'Qos-Metering-Profile-Name', vendor 2352, value: "qos-default-out" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [AddAttrs] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf11ac700 [HandleRadius] <=<=<=<=<=<=<=< Authentication answer sent successfully, time: 0.012 <=<=<=<=<=<=<=< 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [HandleRadius] >=>=>=>=>=>=>=> Acct Packet received from 10.20.1.87, size: 791 >=>=>=>=>=>=>=> 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Authenticator: 25847bd77721a2a4a3ce9d71a0768512 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'User-Name', value: "28:28:5d:e0:d1:1e" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Acct-Status-Type', value: "1" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Acct-Session-Id', value: "FF16033C78006FD8-57596A19" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Service-Type', value: "5" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Acct-Update-Reason', vendor 2352, value: "1" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'NAS-Identifier', value: "se100-1" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'NAS-Port', value: "2533388248" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'NAS-Real-Port', vendor 2352, value: "33751040" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'NAS-Port-Type', value: "5" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'NAS-Port-Id', value: "1818697833" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Unknown VSA 38, vendor 2352, value: "0000000b" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Mac-Addr', vendor 2352, value: "28-28-5d-e0-d1-1e" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Called-Station-Id', value: "10.20.5.131" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'DHCP-Field', vendor 2352, value: "010a140583" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Platform-Type', vendor 2352, value: "4" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'OS-Version', vendor 2352, value: "12.1.1.9p1" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Redback-Agent-Remote-Id', vendor 2352, value: "00030f3d2e34" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Unknown VSA 2, vendor 3561, value: "00030f3d2e34" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Redback-Agent-Circuit-Id', vendor 2352, value: "0006018d01000005" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Unknown VSA 1, vendor 3561, value: "0006018d01000005" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Acct-Authentic', value: "1" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'IP-Interface-Name', vendor 2352, value: "CLIENTS" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'DHCP-Max-Leases', vendor 2352, value: "1" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Context-Name', vendor 2352, value: "l3-dclips" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'DHCP-Vendor-Class-ID', vendor 2352, value: "ndhcpc" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'DHCP-Option', vendor 2352, value: "3d3d070128285de0d11e" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'DHCP-Option', vendor 2352, value: "0c0c0d4b65656e657469635f4c697465" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Session-Timeout', value: "0" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Class', value: "00021911" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Acct-Interim-Interval', value: "600" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Qos-Policing-Profile-Name', vendor 2352, value: "qos-default-in" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Qos-Metering-Profile-Name', vendor 2352, value: "qos-default-out" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'NAT-Policy-Name', vendor 2352, value: "NAT-L3-Policy" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Dynamic-QoS-Param', vendor 2352, value: "police-class-rate LCLASS rate-absolute 102400" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Dynamic-QoS-Param', vendor 2352, value: "meter-class-rate LCLASS rate-absolute 102400" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Dynamic-QoS-Param', vendor 2352, value: "police-class-burst LCLASS 13107200" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Dynamic-QoS-Param', vendor 2352, value: "meter-class-burst LCLASS 13107200" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Dynamic-QoS-Param', vendor 2352, value: "police-class-excess-burst LCLASS 19660800" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] VSA 'Dynamic-QoS-Param', vendor 2352, value: "meter-class-excess-burst LCLASS 19660800" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Idle-Timeout', value: "86400" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [ParseBody] Attribute 'Event-Timestamp', value: "1465477658" 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [RunAcctRequest] Acct-Status-Type = START 09.06.2016 16:05:36 INFO 0x7fabf09ab700 [RunAcctRequestInst] Acct START, Session-Id FF16033C78006FD8-57596A19 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [RunAcctRequestInst] No record with SessionID = 'FF16033C78006FD8-57596A19' found in cache, adding new entry 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [RunAcctRequestInst] Looking for auth session: NAS_IP_ADDRESS: 10.20.1.87; SESSION_ID: FF16033C78006FD8-57596A19; 09.06.2016 16:05:36 INFO 0x7fabf09ab700 [RunAcctRequestInst] Starting Handler:ScriptStart for 012173. 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [lb2] Run script: /usr/local/billing/scripts/handler-clips-v2.sh 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [lb2] --action start --session FF16033C78006FD8-57596A19 --login 012173 --nas 10.20.1.87 --ip 0.0.0.0 --shape 102400 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [RunAcctRequestInst] End DRadius::RunAcctRequestInst 09.06.2016 16:05:36 VERBOSE 0x7fabf09ab700 [HandleRadius] <=<=<=<=<=<=<=< Accounting answer sent successfully, time: 0.128 <=<=<=<=<=<=<=<