rad_recv: Accounting-Request packet from host 10.45.0.9:7002, id=24, length=232
User-Name = "rvgibson"
NAS-IP-Address = 10.45.0.9
NAS-Port = 2210
NAS-Port-Type = Async
Service-Type = Framed-User
Acct-Status-Type = Stop
Acct-Delay-Time = 17
Acct-Session-Id = "390747682"
Acct-Authentic = RADIUS
Idle-Timeout = 0
Acct-Session-Time = 2277
Acct-Input-Octets = 30599
Acct-Output-Octets = 127694
Acct-Input-Packets = 529
Acct-Output-Packets = 802
X-Ascend-Disconnect-Cause = 45
X-Ascend-Connect-Progress = 60
X-Ascend-Xmit-Rate = 46667
X-Ascend-Data-Rate = 21600
X-Ascend-PreSession-Time = 26
X-Ascend-Pre-Input-Octets = 285
X-Ascend-Pre-Output-Octets = 247
X-Ascend-Pre-Input-Packets = 11
X-Ascend-Pre-Output-Packets = 11
X-Ascend-First-Dest = 65.255.255.255
X-Ascend-Modem-PortNo = 52
X-Ascend-Modem-SlotNo = 9
X-Ascend-Modem-ShelfNo = 1
Calling-Station-Id = "5036512800"
Called-Station-Id = "2634593"
Framed-Protocol = PPP
Framed-IP-Address = 65.182.231.239
Processing the preacct section of radiusd.conf
modcall: entering group preacct for request 28
modcall[preacct]: module "preprocess" returns noop for request 28
rlm_acct_unique: Hashing 'NAS-Port = 2210,Client-IP-Address = 10.45.0.9,NAS-IP-Address = 10.45.0.9,Acct-Session-Id = "390747682",User-Name
= "rvgibson"'
rlm_acct_unique: Acct-Unique-Session-ID = "29487a05fb1b964f".
modcall[preacct]: module "acct_unique" returns ok for request 28
rlm_realm: No '@' in User-Name = "rvgibson", looking up realm NULL
rlm_realm: No such realm "NULL"
modcall[preacct]: module "suffix" returns noop for request 28
modcall[preacct]: module "files" returns noop for request 28
modcall: group preacct returns ok for request 28
Processing the accounting section of radiusd.conf
modcall: entering group accounting for request 28
radius_xlat: '/var/log/radacct/10.45.0.9/detail-20050307'
rlm_detail: /var/log/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/radacct/10.45.0.9/detail-20050307
modcall[accounting]: module "detail" returns ok for request 28
modcall[accounting]: module "unix" returns fail for request 28
modcall: group accounting returns fail for request 28
Finished request 28
Scott Baker wrote:
Aha! Now you're talking:
Acct-Delay-Time = 62575 Acct-Session-Id = "301140517" -- Acct-Delay-Time = 69824 Acct-Session-Id = "301140517" -- Acct-Delay-Time = 69874 Acct-Session-Id = "301140517" -- Acct-Delay-Time = 69924 Acct-Session-Id = "301140517" -- Acct-Delay-Time = 69824 Acct-Session-Id = "301140517" -- Acct-Delay-Time = 69874 Acct-Session-Id = "301140517" -- Acct-Delay-Time = 69924 Acct-Session-Id = "301140517"
I'll run it in debug mode, thanks for the heads up.
Alan DeKok wrote:
Scott Baker <[EMAIL PROTECTED]> wrote:
So I'm guessing it's never hearing back "I got your Accounting packet" even though the server is logging it. Do the accounting packets require an acknowledge?
Yes. If the NAS doesn't like the ACK (wrong source IP, etc), it will ignore it, and send another Accounting-Request, with an updated Acct-Delay-Time.
Alan DeKok.
- List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
-- Scott Baker Canby Telephone - Network Administrator - RHCE Ph: 503.266.8253
- List info/subscribe/unsubscribe? See http://www.freeradius.org/list/users.html
