rad_recv: Access-Request packet from host 192.168.0.7:32865, id=112, length=182
        NAS-Port-Type = Ethernet
        Calling-Station-Id = "00:16:D4:AE:23:AE"
        Called-Station-Id = "Empresa Gateway 1"
        NAS-Port-Id = "ether2"
        User-Name = "castro"
        NAS-Port = 2159018021
        Acct-Session-Id = "80b00025"
        Framed-IP-Address = 10.6.0.2
        Mikrotik-Attr-10 = 0x0a060002
        User-Password = "123456"
        Service-Type = Login-User
        WISPr-Logoff-URL = "http://10.6.0.1/logout"
        NAS-Identifier = "serv7"
        NAS-IP-Address = 192.168.0.7
  Processing the authorize section of radiusd.conf
modcall: entering group authorize for request 0
  modcall[authorize]: module "preprocess" returns ok for request 0
  modcall[authorize]: module "chap" returns noop for request 0
  modcall[authorize]: module "mschap" returns noop for request 0
    rlm_realm: No '@' in User-Name = "castro", looking up realm NULL
    rlm_realm: No such realm "NULL"
  modcall[authorize]: module "suffix" returns noop for request 0
  rlm_eap: No EAP-Message, not doing EAP
  modcall[authorize]: module "eap" returns noop for request 0
radius_xlat:  'castro'
rlm_sql (sql): sql_set_user escaped user --> 'castro'
radius_xlat:  'SELECT ID, USERNAME, ATRIBUTO, CONTEUDO, OP FROM RADIUS_CHECK('castro') '
rlm_sql (sql): Reserving sql socket id: 6
query:  SELECT ID, USERNAME, ATRIBUTO, CONTEUDO, OP FROM RADIUS_CHECK('castro')
radius_xlat:  ''
radius_xlat:  'SELECT ID, USERNAME, ATRIBUTO, CONTEUDO, OP FROM RADIUS_REPLY('castro') '
query:  SELECT ID, USERNAME, ATRIBUTO, CONTEUDO, OP FROM RADIUS_REPLY('castro')
radius_xlat:  ''
rlm_sql (sql): Released sql socket id: 6
  modcall[authorize]: module "sql" returns ok for request 0
modcall: leaving group authorize (returns ok) for request 0
auth: type Local
auth: user supplied User-Password matches local User-Password
  Processing the post-auth section of radiusd.conf
modcall: entering group post-auth for request 0
rlm_sql (sql): Processing sql_postauth
radius_xlat:  'castro'
rlm_sql (sql): sql_set_user escaped user --> 'castro'
radius_xlat:  'INSERT INTO ASS_POST_AUTH (USERNAME,PASS,REPLY,DATA_HORA) VALUES ('castro', '123456', 'Access-Accept', '2008-04-01 21:30:40')'
radius_xlat:  '/var/log/freeradius/sqltrace.sql'
rlm_sql (sql) in sql_postauth: query is INSERT INTO ASS_POST_AUTH (USERNAME,PASS,REPLY,DATA_HORA) VALUES ('castro', '123456', 'Access-Accept', '2008-04-01 21:30:40')
rlm_sql (sql): Reserving sql socket id: 5
query:  INSERT INTO ASS_POST_AUTH (USERNAME,PASS,REPLY,DATA_HORA) VALUES ('castro', '123456', 'Access-Accept', '2008-04-01 21:30:40')
rlm_sql (sql): Released sql socket id: 5
  modcall[post-auth]: module "sql" returns ok for request 0
modcall: leaving group post-auth (returns ok) for request 0
Sending Access-Accept of id 112 to 192.168.0.7 port 32865
        Mikrotik-Rate-Limit := "256k/256k"
        WISPr-Redirection-URL := "http://www.empresa.com.br/"
Finished request 0
Going to the next request
--- Walking the entire request list ---
Waking up in 6 seconds...
rad_recv: Accounting-Request packet from host 192.168.0.7:32865, id=113, length=146
        Acct-Status-Type = Start
        NAS-Port-Type = Ethernet
        Calling-Station-Id = "00:16:D4:AE:23:AE"
        Called-Station-Id = "Empresa Gateway 1"
        NAS-Port-Id = "ether2"
        User-Name = "castro"
        NAS-Port = 2159018021
        Acct-Session-Id = "80b00025"
        Framed-IP-Address = 10.6.0.2
        Mikrotik-Attr-10 = 0x0a060002
        Event-Timestamp = "Jan  4 2000 10:30:24 BRT"
        NAS-Identifier = "serv7"
        NAS-IP-Address = 192.168.0.7
        Acct-Delay-Time = 0
  Processing the preacct section of radiusd.conf
modcall: entering group preacct for request 1
  modcall[preacct]: module "preprocess" returns noop for request 1
rlm_acct_unique: Hashing 'NAS-Port = 2159018021,Client-IP-Address = 192.168.0.7,NAS-IP-Address = 192.168.0.7,Acct-Session-Id = "80b00025",User-Name = "castro"'
rlm_acct_unique: Acct-Unique-Session-ID = "f58da41769feab44".
  modcall[preacct]: module "acct_unique" returns ok for request 1
    rlm_realm: No '@' in User-Name = "castro", looking up realm NULL
    rlm_realm: No such realm "NULL"
  modcall[preacct]: module "suffix" returns noop for request 1
modcall: leaving group preacct (returns ok) for request 1
  Processing the accounting section of radiusd.conf
modcall: entering group accounting for request 1
radius_xlat:  '/var/log/freeradius/radacct/192.168.0.7/detail-20080401'
rlm_detail: /var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/freeradius/radacct/192.168.0.7/detail-20080401
  modcall[accounting]: module "detail" returns ok for request 1
  modcall[accounting]: module "unix" returns ok for request 1
radius_xlat:  '/var/log/freeradius/radutmp'
radius_xlat:  'castro'
  modcall[accounting]: module "radutmp" returns ok for request 1
radius_xlat:  'castro'
rlm_sql (sql): sql_set_user escaped user --> 'castro'
radius_xlat:  'INSERT INTO ASS_ACCT (SESSION_ID, USERNAME, SERVICO, SERVIDOR, SERV_IP, IP, MAC, INICIO) VALUES ('80b00025', 'castro', 'X', 'serv7', '192.168.0.7', '10.6.0.2', '00:16:D4:AE:23:AE', '2008-04-01 21:30:40')'
radius_xlat:  '/var/log/freeradius/sqltrace.sql'
rlm_sql (sql): Reserving sql socket id: 4
query:  INSERT INTO ASS_ACCT (SESSION_ID, USERNAME, SERVICO, SERVIDOR, SERV_IP, IP, MAC, INICIO) VALUES ('80b00025', 'castro', 'X', 'serv7', '192.168.0.7', '10.6.0.2', '00:16:D4:AE:23:AE', '2008-04-01 21:30:40')
rlm_sql (sql): Released sql socket id: 4
  modcall[accounting]: module "sql" returns ok for request 1
modcall: leaving group accounting (returns ok) for request 1
Sending Accounting-Response of id 113 to 192.168.0.7 port 32865
Finished request 1
Going to the next request
Waking up in 6 seconds...
--- Walking the entire request list ---
Cleaning up request 0 ID 112 with timestamp 47f2d3b0
Cleaning up request 1 ID 113 with timestamp 47f2d3b0
Nothing to do.  Sleeping until we see a request.