prepaid config :Accounting-Request 'No Reply' error
Jaafar Bin Sarim
jrsm at staff.singnet.com.sg
Tue Jun 24 01:21:20 CDT 2008
Hello Hugh
Pls find attached the logs.
radpwtstn.txt and radiuslogn.txt
^ ^
n =1 indicates test with both "AccountingStopsOnly" and "PostAuthHook"
removed
n =2 indicates test with "PostAuthHook" removed
n =3 indicates test with "AccountingStopsOnly" removed
I'm using Radiator 3.4
>uname -a
Linux paris 2.2.16-4.lfssmp #1 SMP Wed Jul 12 14:00:26 EDT 2000 i686
Best Regards
Jaafar Sarim
SingNet
On Sun, 26 Jan 2003, Hugh Irvine wrote:
> Hello Jafar -
>
> Thanks for sending the files.
>
> Could you please try an experiment for me, by removing the
> "AccountingStopsOnly" and the "PostAuthHook" and trying your tests
> again. I would like to see which one is causing the problem. And could
> you also please send me the Radiator version and the hardware/software
> platform you are running on?
>
> regards
>
> Hugh
-------------- next part --------------
Code: Access-Request
Identifier: 86
Authentic: 1234567890123456
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
User-Password = "Z<128>L"<191><0><178><189><136><200><244><203>r<253><244><238>"
sending Access-Request...
OK
Code: Access-Accept
Identifier: 86
Authentic: "<25>!<18><11><17><215><23>sS<240><30><15>#9>
Attributes:
Session-Timeout = 3200
State = "A"
Code: Accounting-Request
Identifier: 87
Authentic: <0><0><0><0><0><0><0><0><0><0><0><0><0><0><0><0>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Start
sending Accounting-Request Start...
OK
Code: Accounting-Response
Identifier: 87
Authentic: <227><187><242><19><196>,BJ<160><163><136>+<248><251><228><152>
Attributes:
Code: Accounting-Request
Identifier: 88
Authentic: <0><0><0><0><0><0><0><0><0><0><0><0><0><0><0><0>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Time = 1000
Acct-Input-Octets = 20000
Acct-Output-Octets = 30000
sending Accounting-Request Stop...
OK
Code: Accounting-Response
Identifier: 88
Authentic: 7<171><187>M0<127>.!<216><151><162><228><142>o<229><198>
Attributes:
-------------- next part --------------
[root at paris prepaid]$ tail -f logfile.20030127
Mon Jan 27 08:24:26 2003: DEBUG: Creating authentication port 0.0.0.0:2312
Mon Jan 27 08:24:26 2003: DEBUG: Creating accounting port 0.0.0.0:2313
Mon Jan 27 08:24:26 2003: INFO: Server started: Radiator 3.4 on paris
Mon Jan 27 08:25:11 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Access-Request
Identifier: 86
Authentic: 1234567890123456
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
User-Password = "Z<128>L"<191><0><178><189><136><200><244><203>r<253><244><238>"
Mon Jan 27 08:25:11 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:25:11 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:25:11 2003: DEBUG: Deleting session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:25:11 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:25:11 2003: DEBUG: Handling with Radius::AuthSQL: checkprepaidSQL
Mon Jan 27 08:25:12 2003: DEBUG: Query is: select TIMEBALANCE, STATUS from PREPAID where NAME=2003011501
Mon Jan 27 08:25:12 2003: DEBUG: Radius::AuthSQL looks for match with 2003011501
Mon Jan 27 08:25:12 2003: DEBUG: Radius::AuthSQL ACCEPT:
Mon Jan 27 08:25:12 2003: DEBUG: Access accepted for 2003011501
Mon Jan 27 08:25:12 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Access-Accept
Identifier: 86
Authentic: 1234567890123456
Attributes:
Session-Timeout = 3200
State = "A"
Mon Jan 27 08:25:12 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Accounting-Request
Identifier: 87
Authentic: <129>P<151>[<176>P<236><229>s<158><16><176><192>Pr<214>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Start
Mon Jan 27 08:25:12 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:25:12 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:25:12 2003: DEBUG: Adding session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:25:12 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:25:12 2003: DEBUG: Handling accounting with Radius::AuthSQL
Mon Jan 27 08:25:12 2003: DEBUG: do query is: update PREPAID set TIMEBALANCE=TIMEBALANCE-0 where name='2003011501'
Mon Jan 27 08:25:12 2003: DEBUG: Accounting accepted
Mon Jan 27 08:25:12 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Accounting-Response
Identifier: 87
Authentic: <129>P<151>[<176>P<236><229>s<158><16><176><192>Pr<214>
Attributes:
Mon Jan 27 08:25:12 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Accounting-Request
Identifier: 88
Authentic: cMhY<180>'Q<140>3<179><135><23><239><23>`<214>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Time = 1000
Acct-Input-Octets = 20000
Acct-Output-Octets = 30000
Mon Jan 27 08:25:12 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:25:12 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:25:12 2003: DEBUG: Deleting session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:25:12 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:25:12 2003: DEBUG: Handling accounting with Radius::AuthSQL
Mon Jan 27 08:25:12 2003: DEBUG: do query is: update PREPAID set TIMEBALANCE=TIMEBALANCE-01000 where name='2003011501'
Mon Jan 27 08:25:12 2003: DEBUG: Accounting accepted
Mon Jan 27 08:25:12 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Accounting-Response
Identifier: 88
Authentic: cMhY<180>'Q<140>3<179><135><23><239><23>`<214>
Attributes:
-------------- next part --------------
Code: Access-Request
Identifier: 159
Authentic: 1234567890123456
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
User-Password = "Z<128>L"<191><0><178><189><136><200><244><203>r<253><244><238>"
sending Access-Request...
OK
Code: Access-Accept
Identifier: 159
Authentic: <238><141><26><17><227><148><148>Tm<225>)<22><143><176><163>L
Attributes:
Session-Timeout = 2200
State = "A"
Code: Accounting-Request
Identifier: 160
Authentic: <0><0><0><0><0><0><0><0><0><0><0><0><0><0><0><0>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Start
sending Accounting-Request Start...
OK
Code: Accounting-Response
Identifier: 160
Authentic: |<246><180><224>W<148>+G<186>P6V%<159>"<160>
Attributes:
Code: Accounting-Request
Identifier: 161
Authentic: <0><0><0><0><0><0><0><0><0><0><0><0><0><0><0><0>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Time = 1000
Acct-Input-Octets = 20000
Acct-Output-Octets = 30000
sending Accounting-Request Stop...
OK
Code: Accounting-Response
Identifier: 161
Authentic: <13><232><193><177>ER<221>5<134>%?.z<203><14>H
Attributes:
-------------- next part --------------
Mon Jan 27 08:30:39 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Access-Request
Identifier: 159
Authentic: 1234567890123456
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
User-Password = "Z<128>L"<191><0><178><189><136><200><244><203>r<253><244><238>"
Mon Jan 27 08:30:39 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:30:39 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:30:39 2003: DEBUG: Deleting session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:30:39 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:30:39 2003: DEBUG: Handling with Radius::AuthSQL: checkprepaidSQL
Mon Jan 27 08:30:40 2003: DEBUG: Query is: select TIMEBALANCE, STATUS from PREPAID where NAME=2003011501
Mon Jan 27 08:30:40 2003: DEBUG: Radius::AuthSQL looks for match with 2003011501
Mon Jan 27 08:30:40 2003: DEBUG: Radius::AuthSQL ACCEPT:
Mon Jan 27 08:30:40 2003: DEBUG: Access accepted for 2003011501
Mon Jan 27 08:30:40 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Access-Accept
Identifier: 159
Authentic: 1234567890123456
Attributes:
Session-Timeout = 2200
State = "A"
Mon Jan 27 08:30:40 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Accounting-Request
Identifier: 160
Authentic: 6<127><190><16><246><179><236><133>#<168>U<137>8<1>a<233>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Start
Mon Jan 27 08:30:40 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:30:40 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:30:40 2003: DEBUG: Adding session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:30:40 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:30:40 2003: DEBUG: Handling accounting with Radius::AuthSQL
Mon Jan 27 08:30:40 2003: DEBUG: Accounting accepted
Mon Jan 27 08:30:40 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Accounting-Response
Identifier: 160
Authentic: 6<127><190><16><246><179><236><133>#<168>U<137>8<1>a<233>
Attributes:
Mon Jan 27 08:30:40 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Accounting-Request
Identifier: 161
Authentic: ~<166>$+7<228><218><243>;-<139><188>F<30><254>>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Time = 1000
Acct-Input-Octets = 20000
Acct-Output-Octets = 30000
Mon Jan 27 08:30:40 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:30:40 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:30:40 2003: DEBUG: Deleting session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:30:40 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:30:40 2003: DEBUG: Handling accounting with Radius::AuthSQL
Mon Jan 27 08:30:40 2003: DEBUG: do query is: update PREPAID set TIMEBALANCE=TIMEBALANCE-01000 where name='2003011501'
Mon Jan 27 08:30:40 2003: DEBUG: Accounting accepted
Mon Jan 27 08:30:40 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Accounting-Response
Identifier: 161
Authentic: ~<166>$+7<228><218><243>;-<139><188>F<30><254>>
Attributes:
-------------- next part --------------
Code: Access-Request
Identifier: 95
Authentic: 1234567890123456
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
User-Password = "Z<128>L"<191><0><178><189><136><200><244><203>r<253><244><238>"
sending Access-Request...
OK
Code: Access-Accept
Identifier: 95
Authentic: <252><145>Oj<248><164><138><133><161><178><24>n<197><140><27><171>
Attributes:
Session-Timeout = 1200
State = "A"
Code: Accounting-Request
Identifier: 96
Authentic: <0><0><0><0><0><0><0><0><0><0><0><0><0><0><0><0>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Start
sending Accounting-Request Start...
No reply
Code: Accounting-Request
Identifier: 97
Authentic: <0><0><0><0><0><0><0><0><0><0><0><0><0><0><0><0>
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Time = 1000
Acct-Input-Octets = 20000
Acct-Output-Octets = 30000
sending Accounting-Request Stop...
No reply
-------------- next part --------------
Mon Jan 27 08:33:50 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Access-Request
Identifier: 95
Authentic: 1234567890123456
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
User-Password = "Z<128>L"<191><0><178><189><136><200><244><203>r<253><244><238>"
Mon Jan 27 08:33:50 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:33:50 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:33:50 2003: DEBUG: Deleting session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:33:50 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:33:50 2003: DEBUG: Handling with Radius::AuthSQL: checkprepaidSQL
Mon Jan 27 08:33:50 2003: DEBUG: Query is: select TIMEBALANCE, STATUS from PREPAID where NAME=2003011501
Mon Jan 27 08:33:50 2003: DEBUG: Radius::AuthSQL looks for match with 2003011501
Mon Jan 27 08:33:50 2003: DEBUG: Radius::AuthSQL ACCEPT:
Mon Jan 27 08:33:50 2003: DEBUG: Access accepted for 2003011501
Mon Jan 27 08:33:50 2003: DEBUG: Packet dump:
*** Sending to 127.0.0.1 port 1230 ....
Code: Access-Accept
Identifier: 95
Authentic: 1234567890123456
Attributes:
Session-Timeout = 1200
State = "A"
Mon Jan 27 08:33:50 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Accounting-Request
Identifier: 96
Authentic: *G<18><18>E<212><183><170>0 s-u<163><2>7
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Start
Mon Jan 27 08:33:50 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:33:50 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:33:50 2003: DEBUG: Adding session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:33:50 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:33:50 2003: DEBUG: Handling accounting with Radius::AuthSQL
Mon Jan 27 08:33:50 2003: DEBUG: do query is: update PREPAID set TIMEBALANCE=TIMEBALANCE-0 where name='2003011501'
Mon Jan 27 08:33:55 2003: DEBUG: Packet dump:
*** Received from 127.0.0.1 port 1230 ....
Code: Accounting-Request
Identifier: 97
Authentic: q<232><198><161><252>t>Ihhs<163><162>2O&
Attributes:
User-Name = "2003011501 at prepaid"
Service-Type = Framed-User
NAS-IP-Address = 203.63.154.1
NAS-Port = 1234
NAS-Port-Type = Async
Acct-Session-Id = "00001234"
Acct-Status-Type = Stop
Acct-Delay-Time = 0
Acct-Session-Time = 1000
Acct-Input-Octets = 20000
Acct-Output-Octets = 30000
Mon Jan 27 08:33:55 2003: DEBUG: Handling request with Handler 'Realm=prepaid'
Mon Jan 27 08:33:55 2003: DEBUG: Rewrote user name to 2003011501
Mon Jan 27 08:33:55 2003: DEBUG: Deleting session for 2003011501 at prepaid, 203.63.154.1, 1234
Mon Jan 27 08:33:55 2003: DEBUG: Handling with Radius::AuthSQL
Mon Jan 27 08:33:55 2003: DEBUG: Handling accounting with Radius::AuthSQL
Mon Jan 27 08:33:55 2003: DEBUG: do query is: update PREPAID set TIMEBALANCE=TIMEBALANCE-01000 where name='2003011501'
More information about the radiator
mailing list