Когда прописанн статический Ip address у пользователя то при положительном депозите подключение происходит, но при негативном депозите у пользователю выбивает ошибку подключения. При детальном рассмотрении оказалось, что когда у пользователя убрать ip и указать пул в тарифном плане, то всё нормально отрабатывается, но если поле "IP:" заполнено, то Framed-IP-Address не передаётся при негативном депозите, хотя radius даёт accept
Попытка подключения при ситуации с заполненным полем "IP:" у клиента в конце, до этого попытки подключения с пулами, прописанными в тарифном плане.
Код: Выделить всё
rad_recv: Access-Request packet from host 10.0.0.2 port 56162, id=162, length=171
User-Name = "test1"
Service-Type = Framed-User
Framed-Protocol = PPP
CHAP-Password = 0xbbca3363ed6b9c2495e6d4c9b452c8cf4d
CHAP-Challenge = 0x0400af10d6acae57a60f8fa5c8ad42eda5efca9017e9820886635d4b52f864
Chargeable-User-Identity = ""
Acct-Session-Id = "259"
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742070:112"
NAS-Port-Type = Ethernet
NAS-IP-Address = 10.0.0.2
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/abills_default
+group authorize {
++[preprocess] = ok
++[mschap] = noop
[files] users: Matched entry DEFAULT at line 38
++[files] = ok
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair Acct-Session-Id = 259
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair CHAP-Challenge = 0x0400af10d6acae57a60f8fa5c8ad42eda5efca9017e9820886635d4b52f864
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742070:112
rlm_perl: Added pair Chargeable-User-Identity =
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair CHAP-Password = 0xbbca3363ed6b9c2495e6d4c9b452c8cf4d
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair Framed-IP-Address = 172.16.1.37
rlm_perl: Added pair ERX-Service-Activate:1 = svc-guest-pppoe(svc-filter-in-nomoney)
rlm_perl: Added pair Reply-Message = NEG_DEPOSIT '-4291.67'
rlm_perl: Added pair Framed-IP-Netmask = 0.0.0.0
rlm_perl: Added pair Auth-Type = Accept
++[perl] = ok
+} # group authorize = ok
Found Auth-Type = Accept
Auth-Type = Accept, accepting the user
WARNING: Empty post-auth section. Using default return values.
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/abills_default
Sending Access-Accept of id 162 to 10.0.0.2 port 56162
Framed-IP-Address = 172.16.1.37
ERX-Service-Activate:1 = "svc-guest-pppoe(svc-filter-in-nomoney)"
Reply-Message = "NEG_DEPOSIT '-4291.67'"
Framed-IP-Netmask = 0.0.0.0
Finished request 5.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 10.0.0.2 port 56162, id=163, length=174
User-Name = "test1"
Acct-Status-Type = Start
Acct-Session-Id = "259"
Service-Type = Framed-User
Framed-Protocol = PPP
ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
Event-Timestamp = "Oct 28 2015 12:47:33 MSK"
Framed-IP-Address = 172.16.1.37
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742070:112"
NAS-Port-Type = Ethernet
NAS-IP-Address = 10.0.0.2
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/abills_default
+group preacct {
++[preprocess] = ok
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/abills_default
+group accounting {
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Acct-Delay-Time = 0
rlm_perl: Added pair Acct-Authentic = RADIUS
rlm_perl: Added pair Acct-Session-Id = 259
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair Framed-IP-Address = 172.16.1.37
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair Acct-Status-Type = Start
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742070:112
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
rlm_perl: Added pair Event-Timestamp = Oct 28 2015 12:47:33 MSK
++[perl] = ok
+} # group accounting = ok
Sending Accounting-Response of id 163 to 10.0.0.2 port 56162
Finished request 6.
Cleaning up request 6 ID 163 with timestamp +162
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Accounting-Request packet from host 10.0.0.2 port 56162, id=164, length=312
User-Name = "test1"
Acct-Status-Type = Interim-Update
Acct-Session-Id = "259"
Acct-Input-Octets = 0
Acct-Output-Octets = 0
Acct-Session-Time = 1
Acct-Input-Packets = 0
Acct-Output-Packets = 0
Service-Type = Framed-User
Framed-Protocol = PPP
ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
Event-Timestamp = "Oct 28 2015 12:47:33 MSK"
Framed-IP-Address = 172.16.1.37
ERX-Input-Gigapkts = 0
Acct-Input-Gigawords = 0
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742070:112"
NAS-Port-Type = Ethernet
ERX-Output-Gigapkts = 0
Acct-Output-Gigawords = 0
ERX-IPv6-Acct-Input-Octets = 0
ERX-IPv6-Acct-Output-Octets = 0
ERX-IPv6-Acct-Input-Packets = 0
ERX-IPv6-Acct-Output-Packets = 0
ERX-IPv6-Acct-Input-Gigawords = 0
ERX-IPv6-Acct-Output-Gigawords = 0
NAS-IP-Address = 10.0.0.2
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/abills_default
+group preacct {
++[preprocess] = ok
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/abills_default
+group accounting {
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Acct-Input-Packets = 0
rlm_perl: Added pair ERX-IPv6-Acct-Output-Packets = 0
rlm_perl: Added pair Acct-Delay-Time = 0
rlm_perl: Added pair Acct-Authentic = RADIUS
rlm_perl: Added pair Acct-Session-Id = 259
rlm_perl: Added pair ERX-IPv6-Acct-Output-Octets = 0
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair Acct-Input-Octets = 0
rlm_perl: Added pair ERX-IPv6-Acct-Input-Packets = 0
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair ERX-IPv6-Acct-Output-Gigawords = 0
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair Framed-IP-Address = 172.16.1.37
rlm_perl: Added pair Acct-Output-Octets = 0
rlm_perl: Added pair Acct-Output-Gigawords = 0
rlm_perl: Added pair Acct-Input-Gigawords = 0
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair ERX-IPv6-Acct-Input-Gigawords = 0
rlm_perl: Added pair Acct-Status-Type = Interim-Update
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742070:112
rlm_perl: Added pair ERX-IPv6-Acct-Input-Octets = 0
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair ERX-Input-Gigapkts = 0
rlm_perl: Added pair Acct-Output-Packets = 0
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair Acct-Session-Time = 1
rlm_perl: Added pair ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
rlm_perl: Added pair ERX-Output-Gigapkts = 0
rlm_perl: Added pair Event-Timestamp = Oct 28 2015 12:47:33 MSK
++[perl] = ok
+} # group accounting = ok
Sending Accounting-Response of id 164 to 10.0.0.2 port 56162
Finished request 7.
Cleaning up request 7 ID 164 with timestamp +162
Going to the next request
Waking up in 4.2 seconds.
Cleaning up request 5 ID 162 with timestamp +162
Ready to process requests.
rad_recv: Accounting-Request packet from host 10.0.0.2 port 56162, id=165, length=318
User-Name = "test1"
Acct-Status-Type = Stop
Acct-Session-Id = "259"
Acct-Input-Octets = 5129
Acct-Output-Octets = 0
Acct-Session-Time = 35
Acct-Input-Packets = 90
Acct-Output-Packets = 0
Acct-Terminate-Cause = User-Request
Service-Type = Framed-User
Framed-Protocol = PPP
ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
Event-Timestamp = "Oct 28 2015 12:48:07 MSK"
Framed-IP-Address = 172.16.1.37
ERX-Input-Gigapkts = 0
Acct-Input-Gigawords = 0
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742070:112"
NAS-Port-Type = Ethernet
ERX-Output-Gigapkts = 0
Acct-Output-Gigawords = 0
ERX-IPv6-Acct-Input-Octets = 0
ERX-IPv6-Acct-Output-Octets = 0
ERX-IPv6-Acct-Input-Packets = 0
ERX-IPv6-Acct-Output-Packets = 0
ERX-IPv6-Acct-Input-Gigawords = 0
ERX-IPv6-Acct-Output-Gigawords = 0
NAS-IP-Address = 10.0.0.2
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/abills_default
+group preacct {
++[preprocess] = ok
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/abills_default
+group accounting {
rlm_perl: Added pair ERX-IPv6-Acct-Output-Packets = 0
rlm_perl: Added pair Acct-Authentic = RADIUS
rlm_perl: Added pair Acct-Session-Id = 259
rlm_perl: Added pair ERX-IPv6-Acct-Output-Octets = 0
rlm_perl: Added pair ERX-IPv6-Acct-Input-Packets = 0
rlm_perl: Added pair Framed-IP-Address = 172.16.1.37
rlm_perl: Added pair Acct-Output-Octets = 0
rlm_perl: Added pair Acct-Output-Gigawords = 0
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair ERX-IPv6-Acct-Input-Gigawords = 0
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair Acct-Session-Time = 35
rlm_perl: Added pair ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
rlm_perl: Added pair ERX-Output-Gigapkts = 0
rlm_perl: Added pair Event-Timestamp = Oct 28 2015 12:48:07 MSK
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Acct-Input-Packets = 90
rlm_perl: Added pair Acct-Delay-Time = 0
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair Acct-Input-Octets = 5129
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair ERX-IPv6-Acct-Output-Gigawords = 0
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair Acct-Input-Gigawords = 0
rlm_perl: Added pair Acct-Terminate-Cause = User-Request
rlm_perl: Added pair Acct-Status-Type = Stop
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742070:112
rlm_perl: Added pair Acct-Output-Packets = 0
rlm_perl: Added pair ERX-Input-Gigapkts = 0
rlm_perl: Added pair ERX-IPv6-Acct-Input-Octets = 0
++[perl] = ok
+} # group accounting = ok
Sending Accounting-Response of id 165 to 10.0.0.2 port 56162
Finished request 8.
Cleaning up request 8 ID 165 with timestamp +196
Going to the next request
Ready to process requests.
rad_recv: Access-Request packet from host 10.0.0.2 port 56162, id=166, length=167
User-Name = "test1"
Service-Type = Framed-User
Framed-Protocol = PPP
CHAP-Password = 0xb4c062dc16b633b89af71ae14cee71bd0d
CHAP-Challenge = 0x51d8662f6adfbf4aa5bb4c954a52a288fef253a86070bf367012a3
Chargeable-User-Identity = ""
Acct-Session-Id = "262"
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742072:112"
NAS-Port-Type = Ethernet
NAS-IP-Address = 10.0.0.2
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/abills_default
+group authorize {
++[preprocess] = ok
++[mschap] = noop
[files] users: Matched entry DEFAULT at line 38
++[files] = ok
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair Acct-Session-Id = 262
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair CHAP-Challenge = 0x51d8662f6adfbf4aa5bb4c954a52a288fef253a86070bf367012a3
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742072:112
rlm_perl: Added pair Chargeable-User-Identity =
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair CHAP-Password = 0xb4c062dc16b633b89af71ae14cee71bd0d
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair Framed-IP-Address = 192.168.3.4
rlm_perl: Added pair ERX-Service-Activate:1 = svc-guest-pppoe(svc-filter-in-nomoney)
rlm_perl: Added pair Reply-Message = NEG_DEPOSIT '-4291.67'
rlm_perl: Added pair Framed-IP-Netmask = 0.0.0.0
rlm_perl: Added pair Auth-Type = Accept
++[perl] = ok
+} # group authorize = ok
Found Auth-Type = Accept
Auth-Type = Accept, accepting the user
WARNING: Empty post-auth section. Using default return values.
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/abills_default
Sending Access-Accept of id 166 to 10.0.0.2 port 56162
Framed-IP-Address = 109.200.129.69
ERX-Service-Activate:1 = "svc-guest-pppoe(svc-filter-in-nomoney)"
Reply-Message = "NEG_DEPOSIT '-4291.67'"
Framed-IP-Netmask = 0.0.0.0
Finished request 9.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 10.0.0.2 port 56162, id=167, length=174
User-Name = "test1"
Acct-Status-Type = Start
Acct-Session-Id = "262"
Service-Type = Framed-User
Framed-Protocol = PPP
ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
Event-Timestamp = "Oct 28 2015 12:48:25 MSK"
Framed-IP-Address = 192.168.3.4
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742072:112"
NAS-Port-Type = Ethernet
NAS-IP-Address = 10.0.0.2
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/abills_default
+group preacct {
++[preprocess] = ok
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/abills_default
+group accounting {
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Acct-Delay-Time = 0
rlm_perl: Added pair Acct-Authentic = RADIUS
rlm_perl: Added pair Acct-Session-Id = 262
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair Framed-IP-Address = 192.168.3.4
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair Acct-Status-Type = Start
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742072:112
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
rlm_perl: Added pair Event-Timestamp = Oct 28 2015 12:48:25 MSK
++[perl] = ok
+} # group accounting = ok
Sending Accounting-Response of id 167 to 10.0.0.2 port 56162
Finished request 10.
Cleaning up request 10 ID 167 with timestamp +214
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Accounting-Request packet from host 10.0.0.2 port 56162, id=168, length=312
User-Name = "test1"
Acct-Status-Type = Interim-Update
Acct-Session-Id = "262"
Acct-Input-Octets = 0
Acct-Output-Octets = 0
Acct-Session-Time = 1
Acct-Input-Packets = 0
Acct-Output-Packets = 0
Service-Type = Framed-User
Framed-Protocol = PPP
ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
Event-Timestamp = "Oct 28 2015 12:48:26 MSK"
Framed-IP-Address = 192.168.3.4
ERX-Input-Gigapkts = 0
Acct-Input-Gigawords = 0
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742072:112"
NAS-Port-Type = Ethernet
ERX-Output-Gigapkts = 0
Acct-Output-Gigawords = 0
ERX-IPv6-Acct-Input-Octets = 0
ERX-IPv6-Acct-Output-Octets = 0
ERX-IPv6-Acct-Input-Packets = 0
ERX-IPv6-Acct-Output-Packets = 0
ERX-IPv6-Acct-Input-Gigawords = 0
ERX-IPv6-Acct-Output-Gigawords = 0
NAS-IP-Address = 10.0.0.2
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/abills_default
+group preacct {
++[preprocess] = ok
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/abills_default
+group accounting {
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Acct-Input-Packets = 0
rlm_perl: Added pair ERX-IPv6-Acct-Output-Packets = 0
rlm_perl: Added pair Acct-Delay-Time = 0
rlm_perl: Added pair Acct-Authentic = RADIUS
rlm_perl: Added pair Acct-Session-Id = 262
rlm_perl: Added pair ERX-IPv6-Acct-Output-Octets = 0
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair Acct-Input-Octets = 0
rlm_perl: Added pair ERX-IPv6-Acct-Input-Packets = 0
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair ERX-IPv6-Acct-Output-Gigawords = 0
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair Framed-IP-Address = 192.168.3.4
rlm_perl: Added pair Acct-Output-Octets = 0
rlm_perl: Added pair Acct-Output-Gigawords = 0
rlm_perl: Added pair Acct-Input-Gigawords = 0
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair ERX-IPv6-Acct-Input-Gigawords = 0
rlm_perl: Added pair Acct-Status-Type = Interim-Update
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742072:112
rlm_perl: Added pair ERX-IPv6-Acct-Input-Octets = 0
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair ERX-Input-Gigapkts = 0
rlm_perl: Added pair Acct-Output-Packets = 0
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair Acct-Session-Time = 1
rlm_perl: Added pair ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
rlm_perl: Added pair ERX-Output-Gigapkts = 0
rlm_perl: Added pair Event-Timestamp = Oct 28 2015 12:48:26 MSK
++[perl] = ok
+} # group accounting = ok
Sending Accounting-Response of id 168 to 10.0.0.2 port 56162
Finished request 11.
Cleaning up request 11 ID 168 with timestamp +215
Going to the next request
Waking up in 4.2 seconds.
Cleaning up request 9 ID 166 with timestamp +214
Ready to process requests.
rad_recv: Accounting-Request packet from host 10.0.0.2 port 56162, id=169, length=318
User-Name = "test1"
Acct-Status-Type = Stop
Acct-Session-Id = "262"
Acct-Input-Octets = 12464
Acct-Output-Octets = 0
Acct-Session-Time = 74
Acct-Input-Packets = 215
Acct-Output-Packets = 0
Acct-Terminate-Cause = User-Request
Service-Type = Framed-User
Framed-Protocol = PPP
ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
Event-Timestamp = "Oct 28 2015 12:49:39 MSK"
Framed-IP-Address = 192.168.3.4
ERX-Input-Gigapkts = 0
Acct-Input-Gigawords = 0
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742072:112"
NAS-Port-Type = Ethernet
ERX-Output-Gigapkts = 0
Acct-Output-Gigawords = 0
ERX-IPv6-Acct-Input-Octets = 0
ERX-IPv6-Acct-Output-Octets = 0
ERX-IPv6-Acct-Input-Packets = 0
ERX-IPv6-Acct-Output-Packets = 0
ERX-IPv6-Acct-Input-Gigawords = 0
ERX-IPv6-Acct-Output-Gigawords = 0
NAS-IP-Address = 10.0.0.2
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/abills_default
+group preacct {
++[preprocess] = ok
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/abills_default
+group accounting {
rlm_perl: Added pair ERX-IPv6-Acct-Output-Packets = 0
rlm_perl: Added pair Acct-Authentic = RADIUS
rlm_perl: Added pair Acct-Session-Id = 262
rlm_perl: Added pair ERX-IPv6-Acct-Output-Octets = 0
rlm_perl: Added pair ERX-IPv6-Acct-Input-Packets = 0
rlm_perl: Added pair Framed-IP-Address = 192.168.3.4
rlm_perl: Added pair Acct-Output-Octets = 0
rlm_perl: Added pair Acct-Output-Gigawords = 0
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair ERX-IPv6-Acct-Input-Gigawords = 0
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair Acct-Session-Time = 74
rlm_perl: Added pair ERX-Attr-177 = 0x506f72742053706565643a20313030303030306b
rlm_perl: Added pair ERX-Output-Gigapkts = 0
rlm_perl: Added pair Event-Timestamp = Oct 28 2015 12:49:39 MSK
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Acct-Input-Packets = 215
rlm_perl: Added pair Acct-Delay-Time = 0
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair Acct-Input-Octets = 12464
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair ERX-IPv6-Acct-Output-Gigawords = 0
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair Acct-Input-Gigawords = 0
rlm_perl: Added pair Acct-Terminate-Cause = User-Request
rlm_perl: Added pair Acct-Status-Type = Stop
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742072:112
rlm_perl: Added pair Acct-Output-Packets = 0
rlm_perl: Added pair ERX-Input-Gigapkts = 0
rlm_perl: Added pair ERX-IPv6-Acct-Input-Octets = 0
++[perl] = ok
+} # group accounting = ok
Sending Accounting-Response of id 169 to 10.0.0.2 port 56162
Finished request 12.
Cleaning up request 12 ID 169 with timestamp +288
Going to the next request
Ready to process requests.
rad_recv: Access-Request packet from host 10.0.0.2 port 56162, id=170, length=156
User-Name = "test1"
Service-Type = Framed-User
Framed-Protocol = PPP
CHAP-Password = 0xd1755006f59ee1d0463ec1c683b7d28b49
CHAP-Challenge = 0x0aab613e0063c603c6ceb191999032c8
Chargeable-User-Identity = ""
Acct-Session-Id = "265"
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742074:112"
NAS-Port-Type = Ethernet
NAS-IP-Address = 10.0.0.2
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/abills_default
+group authorize {
++[preprocess] = ok
++[mschap] = noop
[files] users: Matched entry DEFAULT at line 38
++[files] = ok
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair Acct-Session-Id = 265
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair CHAP-Challenge = 0x0aab613e0063c603c6ceb191999032c8
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742074:112
rlm_perl: Added pair Chargeable-User-Identity =
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair CHAP-Password = 0xd1755006f59ee1d0463ec1c683b7d28b49
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair ERX-Service-Activate:1 = svc-guest-pppoe(svc-filter-in-nomoney)
rlm_perl: Added pair Reply-Message = NEG_DEPOSIT '-4291.67'
rlm_perl: Added pair Auth-Type = Accept
++[perl] = ok
+} # group authorize = ok
Found Auth-Type = Accept
Auth-Type = Accept, accepting the user
WARNING: Empty post-auth section. Using default return values.
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/abills_default
Sending Access-Accept of id 170 to 10.0.0.2 port 56162
ERX-Service-Activate:1 = "svc-guest-pppoe(svc-filter-in-nomoney)"
Reply-Message = "NEG_DEPOSIT '-4291.67'"
Finished request 13.
Going to the next request
Waking up in 4.9 seconds.
Cleaning up request 13 ID 170 with timestamp +358
Ready to process requests.
rad_recv: Access-Request packet from host 10.0.0.2 port 56162, id=171, length=168
User-Name = "test1"
Service-Type = Framed-User
Framed-Protocol = PPP
CHAP-Password = 0x7d24940df96a364cdbc205cb580c2c125b
CHAP-Challenge = 0xa3ff2f7a80318b236e66d2d635ff96d21d9a1bbc1134e00b863bbe7d
Chargeable-User-Identity = ""
Acct-Session-Id = "267"
ERX-Dhcp-Mac-Addr = "3c97.0e3a.af0a"
NAS-Identifier = "mx_80"
NAS-Port = 281018480
NAS-Port-Id = "ge-1/1/3.1073742076:112"
NAS-Port-Type = Ethernet
NAS-IP-Address = 10.0.0.2
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/abills_default
+group authorize {
++[preprocess] = ok
++[mschap] = noop
[files] users: Matched entry DEFAULT at line 38
++[files] = ok
rlm_perl: Added pair NAS-Port = 281018480
rlm_perl: Added pair Service-Type = Framed-User
rlm_perl: Added pair Acct-Session-Id = 267
rlm_perl: Added pair NAS-IP-Address = 10.0.0.2
rlm_perl: Added pair CHAP-Challenge = 0xa3ff2f7a80318b236e66d2d635ff96d21d9a1bbc1134e00b863bbe7d
rlm_perl: Added pair NAS-Port-Type = Ethernet
rlm_perl: Added pair NAS-Port-Id = ge-1/1/3.1073742076:112
rlm_perl: Added pair Chargeable-User-Identity =
rlm_perl: Added pair NAS-Identifier = mx_80
rlm_perl: Added pair CHAP-Password = 0x7d24940df96a364cdbc205cb580c2c125b
rlm_perl: Added pair User-Name = test1
rlm_perl: Added pair ERX-Dhcp-Mac-Addr = 3c97.0e3a.af0a
rlm_perl: Added pair Framed-Protocol = PPP
rlm_perl: Added pair ERX-Service-Activate:1 = svc-guest-pppoe(svc-filter-in-nomoney)
rlm_perl: Added pair Reply-Message = NEG_DEPOSIT '-4291.67'
rlm_perl: Added pair Auth-Type = Accept
++[perl] = ok
+} # group authorize = ok
Found Auth-Type = Accept
Auth-Type = Accept, accepting the user
WARNING: Empty post-auth section. Using default return values.
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/abills_default
Sending Access-Accept of id 171 to 10.0.0.2 port 56162
ERX-Service-Activate:1 = "svc-guest-pppoe(svc-filter-in-nomoney)"
Reply-Message = "NEG_DEPOSIT '-4291.67'"
Finished request 14.
Going to the next request
Waking up in 4.9 seconds.
Cleaning up request 14 ID 171 with timestamp +375
Ready to process requests.