[RADIATOR] Idle timeout issue
Jennings Tuala
jtuala at blueskysamoa.com
Fri Apr 13 08:26:55 CDT 2012
Hi there,
I’m having some issues with idle timeouts in radiator. Users are suddenly
being disconnected after say 25 minutes of inactivity. This never used to
happen before so I attached a trace 4 debug for you to have a look at.
Would greatly appreciate your assistance please.
Thanks,
Jay
Tue Apr 10 15:48:32 2012: DEBUG: Packet dump:
*** Received from 110.5.112.85 port 32817 ....
Code: Access-Request
Identifier: 29
Authentic: <137><202><239><165><163>W<22><229>Xfg<168>&<144><174><216>
Attributes:
User-Name = "6100510"
User-Password = @[<4>=<161><221><154>u<141><0><143><5><1><165>_<250>
NAS-IP-Address = 110.5.112.85
Service-Type = Login-User
Framed-IP-Address = 10.17.4.212
Called-Station-Id = "00:90:0B:05:6B:14"
Calling-Station-Id = "38:59:f9:80:c8:5d"
NAS-Identifier = "110.5.112.85"
Acct-Session-Id = "00:90:0B:05:6B:14:133411720333317"
NAS-Port-Type = Wireless-IEEE-802-11
Tue Apr 10 15:48:32 2012: DEBUG: Handling request with Handler '',
Identifier ''
Tue Apr 10 15:48:32 2012: DEBUG: Deleting session for 6100510,
110.5.112.85,
Tue Apr 10 15:48:32 2012: DEBUG: do query is: 'delete from RADONLINE where
NASIDENTIFIER='110.5.112.85' and NASPORT=0':
Tue Apr 10 15:48:32 2012: DEBUG: Handling with Radius::AuthSQL:
Tue Apr 10 15:48:32 2012: DEBUG: Handling with Radius::AuthSQL:
Tue Apr 10 15:48:32 2012: DEBUG: Query is: 'select PASSWORD, SESSIONTIMEOUT
from SUBSCRIBERS where USERNAME='6100510' and SESSIONTIMEOUT > 0':
Tue Apr 10 15:48:32 2012: DEBUG: Radius::AuthSQL looks for match with
6100510 [6100510]
Tue Apr 10 15:48:32 2012: DEBUG: Radius::AuthSQL ACCEPT: : 6100510 [6100510]
Tue Apr 10 15:48:32 2012: DEBUG: AuthBy SQL result: ACCEPT,
Tue Apr 10 15:48:32 2012: DEBUG: Access accepted for 6100510
Tue Apr 10 15:48:32 2012: DEBUG: Packet dump:
*** Sending to 110.5.112.85 port 32817 ....
Code: Access-Accept
Identifier: 29
Authentic: <253>;<226>m<181>{}V<28><250><198><209><179><151><176><224>
Attributes:
Session-Timeout = 86400
Tue Apr 10 15:48:32 2012: DEBUG: Packet dump:
*** Received from 110.5.112.85 port 32817 ....
Code: Accounting-Request
Identifier: 30
Authentic: {<211>=c;_<160><152>Z<132><22><10>RE<253><3>
Attributes:
User-Name = "6100510"
Acct-Status-Type = Start
Acct-Session-Id = "00:90:0B:05:6B:14:133411720333317"
Acct-Authentic = Local
NAS-Identifier = "110.5.112.85"
NAS-IP-Address = 110.5.112.85
Calling-Station-Id = "38:59:f9:80:c8:5d"
Called-Station-Id = "00:90:0B:05:6B:14"
Framed-IP-Address = 10.17.4.212
NAS-Port-Type = Wireless-IEEE-802-11
Tue Apr 10 15:48:32 2012: DEBUG: Handling request with Handler '',
Identifier ''
Tue Apr 10 15:48:32 2012: DEBUG: Adding session for 6100510, 110.5.112.85,
Tue Apr 10 15:48:32 2012: DEBUG: do query is: 'delete from RADONLINE where
NASIDENTIFIER='110.5.112.85' and NASPORT=00':
Tue Apr 10 15:48:32 2012: DEBUG: do query is: 'insert into SUBSCRIBERS
(USERNAME, NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP,
FRAMEDIPADDRESS,
NASPORTTYPE, SERVICETYPE, DNIS)':
Tue Apr 10 15:48:32 2012: ERR: do failed for 'insert into SUBSCRIBERS
(USERNAME, NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP,
FRAMEDIPADDRESS,
NASPORTTYPE, SERVICETYPE, DNIS)': You have an error in your SQL syntax;
check the manual that corresponds to your MySQL server version for the right
syntax to use near '' at line 1
Tue Apr 10 15:48:32 2012: ERR: do failed for 'insert into SUBSCRIBERS
(USERNAME, NASIDENTIFIER, NASPORT, ACCTSESSIONID, TIME_STAMP,
FRAMEDIPADDRESS,
NASPORTTYPE, SERVICETYPE, DNIS)': You have an error in your SQL syntax;
check the manual that corresponds to your MySQL server version for the right
syntax to use near '' at line 1
Tue Apr 10 15:48:32 2012: DEBUG: Handling with Radius::AuthSQL:
Tue Apr 10 15:48:32 2012: DEBUG: Handling accounting with Radius::AuthSQL
Tue Apr 10 15:48:32 2012: DEBUG: AuthBy SQL result: ACCEPT,
Tue Apr 10 15:48:32 2012: DEBUG: Accounting accepted
Tue Apr 10 15:48:32 2012: DEBUG: Packet dump:
*** Sending to 110.5.112.85 port 32817 ....
Code: Accounting-Response
Identifier: 30
Authentic: <159><4>g<161><5>4,Pq<29><169>L<159><251><160><242>
Attributes:
Tue Apr 10 16:14:18 2012: DEBUG: Packet dump:
*** Received from 110.5.112.85 port 32817 ....
Code: Accounting-Request
Identifier: 29
Authentic: <153>3B}f<158><172>Pb<30><192><139><246><23>h<148>
Attributes:
User-Name = "6100510"
Acct-Status-Type = Stop
Acct-Session-Id = "00:90:0B:05:6B:14:133411720333317"
Acct-Authentic = RADIUS
Acct-Session-Time = 1547
NAS-Identifier = "110.5.112.85"
NAS-IP-Address = 110.5.112.85
Acct-Input-Octets = 1069902
Acct-Output-Octets = 93367
Acct-Input-Packets = 1017
Acct-Output-Packets = 1087
Calling-Station-Id = "38:59:f9:80:c8:5d"
Called-Station-Id = "00:90:0B:05:6B:14"
Framed-IP-Address = 10.17.4.212
NAS-Port-Type = Wireless-IEEE-802-11
Class = " "
Acct-Terminate-Cause = User-Request
Tue Apr 10 16:14:18 2012: DEBUG: Handling request with Handler '',
Identifier ''
Tue Apr 10 16:14:18 2012: DEBUG: Deleting session for 6100510,
110.5.112.85,
Tue Apr 10 16:14:18 2012: DEBUG: do query is: 'delete from RADONLINE where
NASIDENTIFIER='110.5.112.85' and NASPORT=0':
Tue Apr 10 16:14:18 2012: DEBUG: Handling with Radius::AuthSQL:
Tue Apr 10 16:14:18 2012: DEBUG: Handling accounting with Radius::AuthSQL
Tue Apr 10 16:14:18 2012: DEBUG: do query is: 'update SUBSCRIBERS set
SESSIONTIMEOUT="until Time" where USERNAME='6100510'':
Tue Apr 10 16:14:18 2012: DEBUG: AuthBy SQL result: ACCEPT,
Tue Apr 10 16:14:18 2012: DEBUG: Accounting accepted
Tue Apr 10 16:14:18 2012: DEBUG: Packet dump:
*** Sending to 110.5.112.85 port 32817 ....
Code: Accounting-Response
Identifier: 29
Authentic: <203>W~n<225><215>'<26><206><28><183>}<161><181><240><6>
Attributes:
-------------- next part --------------
An HTML attachment was scrubbed...
URL: http://www.open.com.au/pipermail/radiator/attachments/20120414/75685ebc/attachment-0001.html
More information about the radiator
mailing list