I have a customer with a permanent link and a small network of machines. The
radius users file allocates a netmask of 255.255.255.248 as follows. The
problem is that when dannya calls in neither the specified ip address or
netmask is allocated. A logfile trace is attached. Any suggestions on how to
fix this problem would be appreciated.
Regards. Paul
dannya Auth-Type = System, Client-Id = pm1
Service-Type = Framed-User,
Framed-Protocol = PPP,
Framed-IP-Address = 203.63.235.96,
Framed-Netmask = 255.255.255.248,
Framed-MTU = 1500,
Idle-Timeout = 999999
Fri Aug 6 18:11:03 1999: DEBUG: Packet dump:
*** Received from 203.63.235.9 port 1028 ....
Code: Access-Request
Identifier: 202
Authentic: (<8><14><160><137>`<17><214>7<149>{:<0><217><249>i
Attributes:
User-Name = "dannya"
User-Password = "<130><129><247>H<16>~<198><198><160><1><10>Cr<3>A""
NAS-IP-Address = 203.63.235.9
NAS-Port = 7
NAS-Port-Type = Async
Service-Type = Framed-User
Framed-Protocol = PPP
Fri Aug 6 18:11:03 1999: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Fri Aug 6 18:11:03 1999: DEBUG: Deleting session for dannya, 203.63.235.9, 7
Fri Aug 6 18:11:03 1999: DEBUG: do query is: delete from RADONLINE where
NASIDENTIFIER='203.63.235.9' and NASPORT=7
Fri Aug 6 18:11:03 1999: DEBUG: Handling with Radius::AuthRADMIN
Fri Aug 6 18:11:03 1999: DEBUG: do query is: insert into RADMESSAGES (TIME_STAMP,
TYPE, MESSAGE)
values (933927063, 4, 'Handling with Radius::AuthRADMIN')
Fri Aug 6 18:11:03 1999: DEBUG: Handling with Radius::AuthRADMIN
Fri Aug 6 18:11:03 1999: DEBUG: do query is: insert into RADMESSAGES (TIME_STAMP,
TYPE, MESSAGE)
values (933927063, 4, 'Handling with Radius::AuthRADMIN')
Fri Aug 6 18:11:03 1999: DEBUG: Query is: select PASS_WORD, STATICADDRESS, TIMELEFT,
MAXLOGINS from RADUSERS where USERNAME='dannya' and BADLOGINS < 5 and VALIDFROM <
933927063 and VALIDTO > 933927063
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthRADMIN looks for match with dannya
Fri Aug 6 18:11:03 1999: DEBUG: do query is: insert into RADMESSAGES (TIME_STAMP,
TYPE, MESSAGE)
values (933927063, 4, 'Radius::AuthRADMIN looks for match with dannya')
Fri Aug 6 18:11:03 1999: DEBUG: Query is: select PASS_WORD, STATICADDRESS, TIMELEFT,
MAXLOGINS from RADUSERS where USERNAME='DEFAULT' and BADLOGINS < 5 and VALIDFROM <
933927063 and VALIDTO > 933927063
Fri Aug 6 18:11:03 1999: DEBUG: Handling with Radius::AuthFILE
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthFILE looks for match with dannya
Fri Aug 6 18:11:03 1999: DEBUG: Handling with Radius::AuthUNIX
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthUNIX looks for match with dannya
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthUNIX REJECT: Check item Client-Id
expression 'pm1' does not match '' in request
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthFILE REJECT: Check item Client-Id
expression 'pm1' does not match '' in request
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthFILE looks for match with DEFAULT
Fri Aug 6 18:11:03 1999: DEBUG: Handling with Radius::AuthUNIX
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthUNIX looks for match with dannya
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthUNIX REJECT: Prefix does not match
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthFILE REJECT: Prefix does not match
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthFILE looks for match with DEFAULT1
Fri Aug 6 18:11:03 1999: DEBUG: Handling with Radius::AuthUNIX
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthUNIX looks for match with dannya
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthUNIX ACCEPT:
Fri Aug 6 18:11:03 1999: DEBUG: Radius::AuthFILE ACCEPT:
Fri Aug 6 18:11:03 1999: DEBUG: Access accepted for dannya
Fri Aug 6 18:11:03 1999: DEBUG: Packet dump:
*** Sending to 203.63.235.9 port 1028 ....
Code: Access-Accept
Identifier: 202
Authentic: (<8><14><160><137>`<17><214>7<149>{:<0><217><249>i
Attributes:
Framed-IP-Address = 255.255.255.254
Service-Type = Framed-User
Framed-Protocol = PPP
Framed-MTU = 1500
Idle-Timeout = 2400
Fri Aug 6 18:11:04 1999: DEBUG: Packet dump:
*** Received from 203.63.235.9 port 1028 ....
Code: Accounting-Request
Identifier: 203
Authentic: #<194>p"<200>S<164><164>O<216><255><241>.<13><176><128>
Attributes:
Acct-Session-Id = "060000DC"
User-Name = "dannya"
NAS-IP-Address = 203.63.235.9
NAS-Port = 7
NAS-Port-Type = Async
Acct-Status-Type = Start
Acct-Authentic = RADIUS
Service-Type = Framed-User
Framed-Protocol = PPP
Framed-IP-Address = 203.63.235.43
Acct-Delay-Time = 0
Fri Aug 6 18:11:04 1999: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Fri Aug 6 18:11:04 1999: DEBUG: Adding session for dannya, 203.63.235.9, 7
Fri Aug 6 18:11:04 1999: DEBUG: do query is: delete from RADONLINE where
NASIDENTIFIER='203.63.235.9' and NASPORT=7
Fri Aug 6 18:11:04 1999: DEBUG: do query is: insert into RADONLINE (USERNAME,
NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP, FRAMEDIPADDRESS, NASPORTTYPE,
SERVICETYPE) values ('dannya', '203.63.235.9', 7, '060000DC', 933927064,
'203.63.235.43', 'Async', 'Framed-User')
Fri Aug 6 18:11:04 1999: DEBUG: Handling with Radius::AuthRADMIN
Fri Aug 6 18:11:04 1999: DEBUG: do query is: insert into RADMESSAGES (TIME_STAMP,
TYPE, MESSAGE)
values (933927064, 4, 'Handling with Radius::AuthRADMIN')
Fri Aug 6 18:11:04 1999: DEBUG: Handling accounting with Radius::AuthRADMIN
Fri Aug 6 18:11:04 1999: DEBUG: do query is: insert into RADMESSAGES (TIME_STAMP,
TYPE, MESSAGE)
values (933927064, 4, 'Handling accounting with Radius::AuthRADMIN')
Fri Aug 6 18:11:04 1999: DEBUG: do query is: update RADUSERS set TIMELEFT=TIMELEFT-0,
OCTETSINLEFT=OCTETSINLEFT-0, OCTETSOUTLEFT=OCTETSOUTLEFT-0 where USERNAME='dannya'
Fri Aug 6 18:11:04 1999: DEBUG: do query is: insert into RADUSAGE
(USERNAME, TIME_STAMP, ACCTSTATUSTYPE, ACCTDELAYTIME, ACCTSESSIONID,
FRAMEDIPADDRESS, NASIDENTIFIER, NASPORT)
values
('dannya', 933927064, 1, 0, '060000DC', '203.63.235.43',
'203.63.235.9', 7)
