(RADIATOR) Having some DBissues when using radmin/radiator and OTP
Haakan Olofsson
olofson at dax.net
Sun Mar 18 07:02:32 CST 2007
At 00:11 18.03.2007, Hugh Irvine wrote:
>I will need to see a copy of your configuration file, so could you
>please send me a copy (no secrets)?
>
>And what does the database log show when the error happens?
Hello Hugh
Well all logs from radiator and mysql are in the text that follows ,
including the running radiator config.
You'll find mysql logs in the bottom of this mail
Config file
afasdf# cat /etc/radiator/radmin.cfg
Foreground
LogStdout
AuthPort 1645
AcctPort 1646
LogFile %L/logfile2
LogDir /var/log/radius
DbDir /etc/radiator
DictionaryFile %D/dictionary.cisco
PreClientHook file:"%D/alterNASPort"
SnmpgetProg /usr/local/bin/snmpget
SnmpwalkProg /usr/local/bin/snmpwalk
Trace 4
# You will probably want to change this to suit your site.
# You should list all the clients you have, and their secrets
# If you are using the Radmin Clients table, you wil probably
# want to disable this.
<Client DEFAULT>
Secret SETECASTRONOMY
DupInterval 0
NasType Cisco
</Client>
# Handle everyone with RADMIN, then OTP
<Realm DEFAULT>
# Ensure we first check the username validity with Radmin
# and then check the password with OTP afterwards
AuthByPolicy ContinueWhileAccept
# Check username validity etc with RAdmin:
<AuthBy RADMIN>
# Change DBSource, DBUsername, DBAuth for
your database
# See the reference manual. You will also have to
# change the one in <SessionDatabse SQL> below
# so its the same
DBSource dbi:mysql:radmin:localhost
DBUsername radius
DBAuth SETECASTRONOMY
# Never look up the DEFAULT user
NoDefault
# AuthBy OTP below will check the password
NoCheckPassword
# Here we set up a custom select query that
gets the FULLNAME
# column, where we are storing the users SMS number
AuthSelect select PASS_WORD, STATICADDRESS,
TIMELEFT, MAXLOGINS, SERVICENAME, BADLOGINS, VALIDFROM, VALIDTO,
TELEPHONENUMBER, FULLNAME from RADUSERS where USERNAME=%0
# Here we add the users SMS number from the
FULLNAME column
# to the incoming request
# so AuthBy OTP will get it below
AuthColumnDef 0, SMS-Number, request
# You can add to or change these if you want, but you
# will probably want to change the database
schema first
AccountingTable RADUSAGE
AcctColumnDef USERNAME,User-Name
AcctColumnDef PASS_WORD,Password
AcctColumnDef TELEPHONENUMBER,TelephoneNumber
AcctColumnDef TIME_STAMP,Timestamp,integer
AcctColumnDef ACCTSTATUSTYPE,Acct-Status-Type,integer
AcctColumnDef ACCTDELAYTIME,Acct-Delay-Time,integer
AcctColumnDef
ACCTINPUTOCTETS,Acct-Input-Octets,integer
AcctColumnDef
ACCTOUTPUTOCTETS,Acct-Output-Octets,integer
AcctColumnDef ACCTSESSIONID,Acct-Session-Id
AcctColumnDef
ACCTSESSIONTIME,Acct-Session-Time,integer
AcctColumnDef
ACCTTERMINATECAUSE,Acct-Terminate-Cause,integer
AcctColumnDef FRAMEDIPADDRESS,Framed-IP-Address
AcctColumnDef NASIDENTIFIER,NAS-IP-Address
AcctColumnDef NASIDENTIFIER,NAS-Identifier
AcctColumnDef NASPORT,NAS-Port,integer
AcctColumnDef DNIS,Called-Station-Id
AcctColumnDef CALLINGSTATIONID,Calling-Station-Id
# This updates the time and octets left
# for this user
AcctSQLStatement update RADUSERS set
TIMELEFT=TIMELEFT-0%{Acct-Session-Time},
OCTETSINLEFT=OCTETSINLEFT-0%{Acct-Input-Octets},
OCTETSOUTLEFT=OCTETSOUTLEFT-0%{Acct-Output-Octets} where USERNAME='%n'
</AuthBy>
# If the username is valid etc then we get to here
and issue or check
# the One-Time-Pasword
<AuthBy OTP>
# This hook generates a new random password
and sends it
# to the users SMS number (which we got from
the FULLNAME column
# in the Radmin database above),
# You can configure 'test' to 1 to prevent sending
ChallengeHook sub {\
use Radius::SMS::Tele2SMS;\
my ($self, $user, $p, $context) = @_;\
$context->{otp_password} =
$self->generate_password();\
my $errormsg = $self->sms_tele2(\
debug => '-',\
username => 'tele2',\
password => 'CGcer32',\
mclass => '1',\
to => $p->get_attr('SMS-Number'),\
text => "Password: $context->{otp_password}",\
test => 1);\
return (defined $errormsg) ? undef :
'Wait for your password via SMS';\
}
# ChallengeHook sub {my ($self, $user, $p,
$context) = @_;\
# $context->{otp_password} =
$self->generate_password();\
#system('/bin/echo', "in sample
ChallengeHook for", $user, "password is", $context->{otp_password});\
#return "Your OTP password has been printed
by Radiator on STDOUT";}
</AuthBy>
# This clause logs all authentication successes and
failures to the RADAUTHLOG table
# Suitable for use with RAdmin version 1.6 or later
<AuthLog SQL>
# This database spec usually should be
exactly the same
# as in <AuthBy RADMIN> above
DBSource dbi:mysql:radmin:localhost
DBUsername radius
DBAuth SETECASTRONOMY
LogSuccess
SuccessQuery insert into RADAUTHLOG
(TIME_STAMP, USERNAME, TYPE) values (%t, '%n', 1)
LogFailure
FailureQuery insert into RADAUTHLOG
(TIME_STAMP, USERNAME, TYPE, REASON) values (%t, '%n', 0, %1)
</AuthLog>
</Realm>
<SessionDatabase SQL>
# This database spec usually should be exactly the same
# as in <AuthBy RADMIN> above
DBSource dbi:mysql:radmin:localhost
DBUsername radius
DBAuth SETECASTRONOMY
</SessionDatabase>
------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------
Logs from radiator
afasdf# radiusd -config_file /etc/radiator/radmin.cfg
Sat Mar 17 19:10:36 2007: DEBUG: Finished reading configuration file
'/etc/radiator/radmin.cfg'
This Radiator license will expire on 2007-05-30
This Radiator license will stop operating after 1000 requests
To purchase an unlimited full source version of Radiator, see
http://www.open.com.au/ordering.html
To extend your license period, contact admin at open.com.au
Sat Mar 17 19:10:36 2007: DEBUG: Reading dictionary file
'/etc/radiator/dictionary.cisco'
Sat Mar 17 19:10:36 2007: DEBUG: Creating authentication port 0.0.0.0:1645
Sat Mar 17 19:10:36 2007: DEBUG: Creating accounting port 0.0.0.0:1646
Sat Mar 17 19:10:36 2007: NOTICE: Server started: Radiator 3.16 on
some.radius.server (LOCKED)
Sat Mar 17 19:10:45 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:10:45 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1695 ....
Code: Accounting-Request
Identifier: 14
Authentic: XC<10><162><3<5><217><129><209><14><234>{L<159><174>
Attributes:
User-Name = "olofson"
NAS-Port = 1955
Service-Type = Framed
Framed-Protocol = PPP
Framed-IP-Address = 10.0.202.65
Class = "juniks"
Calling-Station-Id = "192.168.254.88"
Acct-Status-Type = Stop
Acct-Input-Octets = 2728
Acct-Output-Octets = 0
Acct-Session-Id = "FB00041C"
Acct-Session-Time = 249
Acct-Input-Packets = 26
Acct-Output-Packets = 0
Acct-Terminate-Cause = User-Request
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:10:45 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:10:45 2007: DEBUG: Deleting session for olofson,
10.0.202.2, 1955
Sat Mar 17 19:10:45 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01955':
Sat Mar 17 19:10:45 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:10:45 2007: DEBUG: Handling accounting with Radius::AuthRADMIN
Sat Mar 17 19:10:45 2007: DEBUG: do query is: 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPOR
Sat Mar 17 19:10:45 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPO
Sat Mar 17 19:10:45 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPO
Sat Mar 17 19:10:45 2007: DEBUG: AuthBy RADMIN result: IGNORE, Database failure
Sat Mar 17 19:10:46 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:10:46 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1695 ....
Code: Accounting-Request
Identifier: 14
Authentic: XC<10><162><3<5><217><129><209><14><234>{L<159><174>
Attributes:
User-Name = "olofson"
NAS-Port = 1955
Service-Type = Framed
Framed-Protocol = PPP
Framed-IP-Address = 10.0.202.65
Class = "juniks"
Calling-Station-Id = "192.168.254.88"
Acct-Status-Type = Stop
Acct-Input-Octets = 2728
Acct-Output-Octets = 0
Acct-Session-Id = "FB00041C"
Acct-Session-Time = 249
Acct-Input-Packets = 26
Acct-Output-Packets = 0
Acct-Terminate-Cause = User-Request
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:10:46 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:10:46 2007: DEBUG: Deleting session for olofson,
10.0.202.2, 1955
Sat Mar 17 19:10:46 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01955':
Sat Mar 17 19:10:46 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:10:46 2007: DEBUG: Handling accounting with Radius::AuthRADMIN
Sat Mar 17 19:10:46 2007: DEBUG: do query is: 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPOR
Sat Mar 17 19:10:46 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPO
Sat Mar 17 19:10:46 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPO
Sat Mar 17 19:10:46 2007: DEBUG: AuthBy RADMIN result: IGNORE, Database failure
Sat Mar 17 19:10:47 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:10:47 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1695 ....
Code: Accounting-Request
Identifier: 14
Authentic: XC<10><162><3<5><217><129><209><14><234>{L<159><174>
Attributes:
User-Name = "olofson"
NAS-Port = 1955
Service-Type = Framed
Framed-Protocol = PPP
Framed-IP-Address = 10.0.202.65
Class = "juniks"
Calling-Station-Id = "192.168.254.88"
Acct-Status-Type = Stop
Acct-Input-Octets = 2728
Acct-Output-Octets = 0
Acct-Session-Id = "FB00041C"
Acct-Session-Time = 249
Acct-Input-Packets = 26
Acct-Output-Packets = 0
Acct-Terminate-Cause = User-Request
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:10:47 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:10:47 2007: DEBUG: Deleting session for olofson,
10.0.202.2, 1955
Sat Mar 17 19:10:47 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01955':
Sat Mar 17 19:10:47 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:10:47 2007: DEBUG: Handling accounting with Radius::AuthRADMIN
Sat Mar 17 19:10:47 2007: DEBUG: do query is: 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPOR
Sat Mar 17 19:10:47 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPO
Sat Mar 17 19:10:47 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTINPUTOCTETS,ACCTOUTPUTOCTETS,ACCTSESSIONID,ACCTSESSIONTIME,ACCTSTATUSTYPE,ACCTTERMINATECAUSE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPO
Sat Mar 17 19:10:47 2007: DEBUG: AuthBy RADMIN result: IGNORE, Database failure
Sat Mar 17 19:10:50 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:10:50 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1666 ....
Code: Access-Request
Identifier: 76
Authentic: <196><204>9<245><230>6U<10>[<217>K<214><148><187>}<196>
Attributes:
User-Name = "olofson"
User-Password =
"<140><0>8Mf<137><163><200><207>z<209><198>E<17>y<147>"
NAS-Port = 1956
Service-Type = Framed
Framed-Protocol = PPP
Called-Station-Id = "192.168.1.2"
Calling-Station-Id = "192.168.254.88"
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:10:50 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:10:50 2007: DEBUG: Deleting session for olofson,
10.0.202.2, 1956
Sat Mar 17 19:10:50 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01956':
Sat Mar 17 19:10:50 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:10:50 2007: DEBUG: Handling with Radius::AuthRADMIN:
Sat Mar 17 19:10:50 2007: ERR: Attribute number 79 is not defined in
your dictionary
Sat Mar 17 19:10:50 2007: DEBUG: Query is: 'select PASS_WORD,
STATICADDRESS, TIMELEFT, MAXLOGINS, SERVICENAME, BADLOGINS,
VALIDFROM, VALIDTO, TELEPHONENUMBER, FULLNAME from RADUSERS where
USERNAME='olofson'':
Sat Mar 17 19:10:50 2007: DEBUG: Query is: 'select ATTR_ID,
VENDOR_ID, IVALUE, SVALUE, ITEM_TYPE from RADCONFIG where
NAME='olofson' order by ITEM_TYPE':
Sat Mar 17 19:10:50 2007: DEBUG: Radius::AuthRADMIN looks for match
with olofson [olofson]
Sat Mar 17 19:10:50 2007: DEBUG: Query is: 'select NASIDENTIFIER,
NASPORT, ACCTSESSIONID, FRAMEDIPADDRESS from RADONLINE where
USERNAME='olofson'':
Sat Mar 17 19:10:50 2007: DEBUG: ValidFrom date converted to: 1173707880
Sat Mar 17 19:10:50 2007: DEBUG: Expiration date converted to: 1205280000
Sat Mar 17 19:10:50 2007: DEBUG: do query is: 'update RADUSERS set
BADLOGINS=0 where USERNAME='olofson'':
Sat Mar 17 19:10:50 2007: DEBUG: AuthBy RADMIN result: ACCEPT,
Sat Mar 17 19:10:50 2007: DEBUG: Handling with Radius::AuthOTP:
Sat Mar 17 19:10:50 2007: DEBUG: Radius::AuthOTP looks for match with
olofson [olofson]
Sat Mar 17 19:10:50 2007: DEBUG: TELE2 SMSsender requesting
http://10.0.200.96:13013/cgi-bin/sendsms?username=yourusername&password=yourpassword&mclass=1&to=4741319106&text=Password:
kiducej85&test=1
Sat Mar 17 19:10:51 2007: ERR: Tele2 SMSsender generated a bad
request: 500 Can't connect to 10.0.200.96:13013 (connect: Invalid argument)
Sat Mar 17 19:10:51 2007: DEBUG: Radius::AuthOTP REJECT: OTP
challenge failed. Is OTP set up properly?: olofson [olofson]
Sat Mar 17 19:10:51 2007: DEBUG: AuthBy OTP result: REJECT, OTP
challenge failed. Is OTP set up properly?
Sat Mar 17 19:10:51 2007: INFO: Access rejected for olofson: OTP
challenge failed. Is OTP set up properly?
Sat Mar 17 19:10:51 2007: DEBUG: do query is: 'insert into RADAUTHLOG
(TIME_STAMP, USERNAME, TYPE, REASON) values (1174158651, 'olofson',
0, 'OTP challenge failed. Is OTP set up properly?')':
Sat Mar 17 19:10:51 2007: DEBUG: Packet dump:
*** Sending to 10.0.202.2 port 1666 ....
Code: Access-Reject
Identifier: 76
Authentic: <196><204>9<245><230>6U<10>[<217>K<214><148><187>}<196>
Attributes:
Reply-Message = "Request Denied"
Sat Mar 17 19:11:03 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:11:03 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1666 ....
Code: Access-Request
Identifier: 77
Authentic: <186><144><228><249><201><27>E{<129>N<205><31><177><28><179><18>
Attributes:
User-Name = "olofson"
User-Password = "<7>D<180>y<173>s<154>`x3s<146><206><4><255>&"
NAS-Port = 1956
Service-Type = Framed
Framed-Protocol = PPP
Called-Station-Id = "192.168.1.2"
Calling-Station-Id = "192.168.254.88"
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:11:03 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:11:03 2007: DEBUG: Deleting session for olofson,
10.0.202.2, 1956
Sat Mar 17 19:11:03 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01956':
Sat Mar 17 19:11:03 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:11:03 2007: DEBUG: Handling with Radius::AuthRADMIN:
Sat Mar 17 19:11:03 2007: ERR: Attribute number 79 is not defined in
your dictionary
Sat Mar 17 19:11:03 2007: DEBUG: Query is: 'select PASS_WORD,
STATICADDRESS, TIMELEFT, MAXLOGINS, SERVICENAME, BADLOGINS,
VALIDFROM, VALIDTO, TELEPHONENUMBER, FULLNAME from RADUSERS where
USERNAME='olofson'':
Sat Mar 17 19:11:03 2007: DEBUG: Query is: 'select ATTR_ID,
VENDOR_ID, IVALUE, SVALUE, ITEM_TYPE from RADCONFIG where
NAME='olofson' order by ITEM_TYPE':
Sat Mar 17 19:11:03 2007: DEBUG: Radius::AuthRADMIN looks for match
with olofson [olofson]
Sat Mar 17 19:11:03 2007: DEBUG: Query is: 'select NASIDENTIFIER,
NASPORT, ACCTSESSIONID, FRAMEDIPADDRESS from RADONLINE where
USERNAME='olofson'':
Sat Mar 17 19:11:03 2007: DEBUG: ValidFrom date converted to: 1173707880
Sat Mar 17 19:11:03 2007: DEBUG: Expiration date converted to: 1205280000
Sat Mar 17 19:11:03 2007: DEBUG: do query is: 'update RADUSERS set
BADLOGINS=0 where USERNAME='olofson'':
Sat Mar 17 19:11:03 2007: DEBUG: AuthBy RADMIN result: ACCEPT,
Sat Mar 17 19:11:03 2007: DEBUG: Handling with Radius::AuthOTP:
Sat Mar 17 19:11:03 2007: DEBUG: Radius::AuthOTP looks for match with
olofson [olofson]
Sat Mar 17 19:11:03 2007: DEBUG: Radius::AuthOTP ACCEPT: blaj:
olofson [olofson]
Sat Mar 17 19:11:03 2007: DEBUG: AuthBy OTP result: ACCEPT, blaj
Sat Mar 17 19:11:03 2007: DEBUG: Access accepted for olofson
Sat Mar 17 19:11:03 2007: DEBUG: do query is: 'insert into RADAUTHLOG
(TIME_STAMP, USERNAME, TYPE) values (1174158663, 'olofson', 1)':
Sat Mar 17 19:11:03 2007: DEBUG: Packet dump:
*** Sending to 10.0.202.2 port 1666 ....
Code: Access-Accept
Identifier: 77
Authentic: <186><144><228><249><201><27>E{<129>N<205><31><177><28><179><18>
Attributes:
Sat Mar 17 19:11:04 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:11:04 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1696 ....
Code: Accounting-Request
Identifier: 15
Authentic: <179>>W{<222><165><189><234><184><248><241>`<193><237><21><169>
Attributes:
User-Name = "olofson"
NAS-Port = 1956
Service-Type = Framed
Framed-Protocol = PPP
Framed-IP-Address = 10.0.202.65
Class = "juniks"
Calling-Station-Id = "192.168.254.88"
Acct-Status-Type = Start
Acct-Session-Id = "FB00041D"
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:11:04 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:11:04 2007: DEBUG: Adding session for olofson, 10.0.202.2, 1956
Sat Mar 17 19:11:04 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01956':
Sat Mar 17 19:11:04 2007: DEBUG: do query is: 'insert into RADONLINE
(USERNAME, NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP,
FRAMEDIPADDRESS, NASPORTTYPE, SERVICETYPE) values ('olofson',
'10.0.202.2', 1956, 'FB00041D', 1174158664, '10.0.202.65', 'Virtual',
'Framed')':
Sat Mar 17 19:11:04 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:11:04 2007: DEBUG: Handling accounting with Radius::AuthRADMIN
Sat Mar 17 19:11:04 2007: DEBUG: do query is: 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0.
Sat Mar 17 19:11:04 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0
Sat Mar 17 19:11:04 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0
Sat Mar 17 19:11:04 2007: DEBUG: AuthBy RADMIN result: IGNORE, Database failure
Sat Mar 17 19:11:05 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:11:05 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1696 ....
Code: Accounting-Request
Identifier: 15
Authentic: <179>>W{<222><165><189><234><184><248><241>`<193><237><21><169>
Attributes:
User-Name = "olofson"
NAS-Port = 1956
Service-Type = Framed
Framed-Protocol = PPP
Framed-IP-Address = 10.0.202.65
Class = "juniks"
Calling-Station-Id = "192.168.254.88"
Acct-Status-Type = Start
Acct-Session-Id = "FB00041D"
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:11:05 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:11:05 2007: DEBUG: Adding session for olofson, 10.0.202.2, 1956
Sat Mar 17 19:11:05 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01956':
Sat Mar 17 19:11:05 2007: DEBUG: do query is: 'insert into RADONLINE
(USERNAME, NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP,
FRAMEDIPADDRESS, NASPORTTYPE, SERVICETYPE) values ('olofson',
'10.0.202.2', 1956, 'FB00041D', 1174158665, '10.0.202.65', 'Virtual',
'Framed')':
Sat Mar 17 19:11:05 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:11:05 2007: DEBUG: Handling accounting with Radius::AuthRADMIN
Sat Mar 17 19:11:05 2007: DEBUG: do query is: 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0.
Sat Mar 17 19:11:05 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0
Sat Mar 17 19:11:05 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0
Sat Mar 17 19:11:05 2007: DEBUG: AuthBy RADMIN result: IGNORE, Database failure
Sat Mar 17 19:11:06 2007: ERR: Attribute number 66 is not defined in
your dictionary
Sat Mar 17 19:11:06 2007: DEBUG: Packet dump:
*** Received from 10.0.202.2 port 1696 ....
Code: Accounting-Request
Identifier: 15
Authentic: <179>>W{<222><165><189><234><184><248><241>`<193><237><21><169>
Attributes:
User-Name = "olofson"
NAS-Port = 1956
Service-Type = Framed
Framed-Protocol = PPP
Framed-IP-Address = 10.0.202.65
Class = "juniks"
Calling-Station-Id = "192.168.254.88"
Acct-Status-Type = Start
Acct-Session-Id = "FB00041D"
Acct-Authentic = RADIUS
Acct-Delay-Time = 0
NAS-IP-Address = 10.0.202.2
NAS-Port-Type = Virtual
Sat Mar 17 19:11:06 2007: DEBUG: Handling request with Handler 'Realm=DEFAULT'
Sat Mar 17 19:11:06 2007: DEBUG: Adding session for olofson, 10.0.202.2, 1956
Sat Mar 17 19:11:06 2007: DEBUG: do query is: 'delete from RADONLINE
where NASIDENTIFIER='10.0.202.2' and NASPORT=01956':
Sat Mar 17 19:11:06 2007: DEBUG: do query is: 'insert into RADONLINE
(USERNAME, NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP,
FRAMEDIPADDRESS, NASPORTTYPE, SERVICETYPE) values ('olofson',
'10.0.202.2', 1956, 'FB00041D', 1174158666, '10.0.202.65', 'Virtual',
'Framed')':
Sat Mar 17 19:11:06 2007: DEBUG: Handling with Radius::AuthRADMIN
Sat Mar 17 19:11:06 2007: DEBUG: Handling accounting with Radius::AuthRADMIN
Sat Mar 17 19:11:06 2007: DEBUG: do query is: 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0.
Sat Mar 17 19:11:06 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0
Sat Mar 17 19:11:06 2007: ERR: do failed for 'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,'FB00041D',1,'192.168.254.88','10.0
Sat Mar 17 19:11:06 2007: DEBUG: AuthBy RADMIN result: IGNORE, Database failure
^C
------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------
Logs from mysqlqueries
070317 19:11:05 957 Connect radius at localhost on radmin
957 Query delete from RADONLINE where
NASIDENTIFIER='10.0.202.2' and NASPORT=01956
957 Query insert into RADONLINE (USERNAME,
NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP, FRAMEDIPADDRESS,
NASPORTTYPE, SERVICETYPE) values ('olofson', '10.0.202.2', 1956,
'FB00041D', 1174158665, '10.0.202.65', 'Virtual', 'Framed')
957 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158665, 4, 'Handling with
Radius::AuthRADMIN')
957 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158665, 4, 'Handling
accounting with Radius::AuthRADMIN')
957 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158665, 4, 'do query is:
\'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,\'FB00041D\',1,\'192.168.254.88\',\'10.0.')
957 Query insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values
(0,'FB00041D',1,'192.168.254.88','10.0.202.65','10.0.202.2',1956,1174158665,'olofson')
957 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158665, 0, 'do failed for
\'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,\'FB00041D\',1,\'192.168.254.88\',\'10.0')
957 Quit
958 Connect radius at localhost on radmin
958 Query insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values
(0,'FB00041D',1,'192.168.254.88','10.0.202.65','10.0.202.2',1956,1174158665,'olofson')
958 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158665, 0, 'do failed for
\'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,\'FB00041D\',1,\'192.168.254.88\',\'10.0')
958 Quit
070317 19:11:06 959 Connect radius at localhost on radmin
959 Query delete from RADONLINE where
NASIDENTIFIER='10.0.202.2' and NASPORT=01956
959 Query insert into RADONLINE (USERNAME,
NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP, FRAMEDIPADDRESS,
NASPORTTYPE, SERVICETYPE) values ('olofson', '10.0.202.2', 1956,
'FB00041D', 1174158666, '10.0.202.65', 'Virtual', 'Framed')
959 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158666, 4, 'Handling with
Radius::AuthRADMIN')
959 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158666, 4, 'Handling
accounting with Radius::AuthRADMIN')
959 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158666, 4, 'do query is:
\'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,\'FB00041D\',1,\'192.168.254.88\',\'10.0.')
959 Query insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values
(0,'FB00041D',1,'192.168.254.88','10.0.202.65','10.0.202.2',1956,1174158666,'olofson')
959 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158666, 0, 'do failed for
\'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,\'FB00041D\',1,\'192.168.254.88\',\'10.0')
959 Quit
960 Connect radius at localhost on radmin
960 Query insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values
(0,'FB00041D',1,'192.168.254.88','10.0.202.65','10.0.202.2',1956,1174158666,'olofson')
960 Query insert into RADMESSAGES
(TIME_STAMP, TYPE, MESSAGE) values (1174158666, 0, 'do failed for
\'insert into RADUSAGE
(ACCTDELAYTIME,ACCTSESSIONID,ACCTSTATUSTYPE,CALLINGSTATIONID,FRAMEDIPADDRESS,NASIDENTIFIER,NASPORT,TIME_STAMP,USERNAME)
values (0,\'FB00041D\',1,\'192.168.254.88\',\'10.0')
960 Quit
------------------------------------------------------------------------------------------------------------------------------------------------------------------------------------
--
Archive at http://www.open.com.au/archives/radiator/
Announcements on radiator-announce at open.com.au
To unsubscribe, email 'majordomo at open.com.au' with
'unsubscribe radiator' in the body of the message.
More information about the radiator
mailing list