MYSQL check_error: 1064 received

Deep Purple jinjusi at yahoo.co.kr
Tue May 6 07:01:47 CEST 2008


Hello
My Linux BOX  
Fedora Core 5 
freeradius-server-2.0.3.tar.gz
freeradius-client-1.1.5.tar.bz2
pptpd-1.3.3-1.fc5.i386.rpm
-------------------------------------------------------
1.MYSQL check_error: 1064 received
2.IP Allocation FAILED from dialup_pool1
3.sqlippool_log_nopool = "No Pool-Name defined
My radippool
-------------------------------------------------------
#
# Table structure for table 'radippool'
#
CREATE TABLE radippool (
  id                    int(11) unsigned NOT NULL auto_increment,
  pool_name             varchar(30) NOT NULL,
  framedipaddress       varchar(15) NOT NULL default '',
  nasipaddress          varchar(15) NOT NULL default '',
  calledstationid       VARCHAR(30) NOT NULL,
  callingstationid      VARCHAR(30) NOT NULL,
  expiry_time           DATETIME NULL default NULL,
  username              varchar(64) NOT NULL default '',
  pool_key              varchar(30) NOT NULL,
  PRIMARY KEY (id)
);

MY radiusd -X 
-------------------------------------------------------
FreeRADIUS Version 2.0.3, for host i686-redhat-linux-gnu, built on Apr 15 2008 at 18:25:23
Copyright (C) 1999-2008 The FreeRADIUS server project and contributors. 
There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A 
PARTICULAR PURPOSE. 
You may redistribute copies of FreeRADIUS under the terms of the 
GNU General Public License. 
Starting - reading configuration files ...
including configuration file /etc/raddb/radiusd.conf
including configuration file /etc/raddb/proxy.conf
including configuration file /etc/raddb/clients.conf
including configuration file /etc/raddb/snmp.conf
including configuration file /etc/raddb/eap.conf
including configuration file /etc/raddb/sql.conf
including configuration file /etc/raddb/sql/mysql/dialup.conf
including configuration file /etc/raddb/sql/mysql/counter.conf
including configuration file /etc/raddb/sqlippool.conf
including configuration file /etc/raddb/sql/mysql/ippool.conf
including configuration file /etc/raddb/policy.conf
including files in directory /etc/raddb/sites-enabled/
including configuration file /etc/raddb/sites-enabled/default
including dictionary file /etc/raddb/dictionary
main {
 prefix = "/usr"
 localstatedir = "/var"
 logdir = "/var/log/radius"
 libdir = "/usr/lib"
 radacctdir = "/var/log/radius/radacct"
 hostname_lookups = no
 max_request_time = 30
 cleanup_delay = 5
 max_requests = 1024
 allow_core_dumps = no
 pidfile = "/var/run/radiusd/radiusd.pid"
 user = "radiusd"
 group = "radiusd"
 checkrad = "/usr/sbin/checkrad"
 debug_level = 0
 proxy_requests = yes
 security {
 max_attributes = 200
 reject_delay = 1
 status_server = yes
 }
}
 client localhost {
 ipaddr = 127.0.0.1
 require_message_authenticator = no
 secret = "test1234"
 nastype = "other"
 }
radiusd: #### Loading Realms and Home Servers ####
 proxy server {
 retry_delay = 5
 retry_count = 3
 default_fallback = no
 dead_time = 120
 wake_all_if_all_dead = no
 }
 home_server localhost {
 ipaddr = 127.0.0.1
 port = 1812
 type = "auth"
 secret = "testing123"
 response_window = 20
 max_outstanding = 65536
 zombie_period = 40
 status_check = "status-server"
 ping_check = "none"
 ping_interval = 30
 check_interval = 30
 num_answers_to_alive = 3
 num_pings_to_alive = 3
 revive_interval = 120
 status_check_timeout = 4
 }
 home_server_pool my_auth_failover {
 type = fail-over
 home_server = localhost
 }
 realm example.com {
 auth_pool = my_auth_failover
 }
 realm LOCAL {
 }
radiusd: #### Instantiating modules ####
 instantiate {
 Module: Linked to module rlm_exec
 Module: Instantiating exec
  exec {
 wait = yes
 input_pairs = "request"
 shell_escape = yes
  }
 Module: Linked to module rlm_expr
 Module: Instantiating expr
 Module: Linked to module rlm_expiration
 Module: Instantiating expiration
  expiration {
 reply-message = "Password Has Expired  "
  }
 Module: Linked to module rlm_logintime
 Module: Instantiating logintime
  logintime {
 reply-message = "You are calling outside your allowed timespan  "
 minimum-timeout = 60
  }
 Module: Linked to module rlm_sqlcounter
 Module: Instantiating noresetcounter
  sqlcounter noresetcounter {
 counter-name = "Max-All-Session-Time"
 check-name = "Max-All-Session"
 key = "User-Name"
 sqlmod-inst = "sql"
 query = "SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='%{%k}'"
 reset = "never"
 safe-characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
  }
rlm_sqlcounter: Reply attribute set to Session-Timeout.
rlm_sqlcounter: Counter attribute Max-All-Session-Time is number 11273
rlm_sqlcounter: Check attribute Max-All-Session is number 3000
rlm_sqlcounter: Current Time: 1208605561 [2008-04-19 20:46:01], Next reset 0 [2008-04-19 20:00:00]
rlm_sqlcounter: Current Time: 1208605561 [2008-04-19 20:46:01], Prev reset 0 [2008-04-19 20:00:00]
 }
radiusd: #### Loading Virtual Servers ####
server {
 modules {
 Module: Checking authenticate {...} for more modules to load
 Module: Linked to module rlm_pap
 Module: Instantiating pap
  pap {
 encryption_scheme = "auto"
 auto_header = yes
  }
 Module: Linked to module rlm_chap
 Module: Instantiating chap
 Module: Linked to module rlm_mschap
 Module: Instantiating mschap
  mschap {
 use_mppe = no
 require_encryption = no
 require_strong = no
 with_ntdomain_hack = no
  }
 Module: Linked to module rlm_unix
 Module: Instantiating unix
  unix {
 radwtmp = "/var/log/radius/radwtmp"
  }
 Module: Linked to module rlm_eap
 Module: Instantiating eap
  eap {
 default_eap_type = "md5"
 timer_expire = 60
 ignore_unknown_eap_types = no
 cisco_accounting_username_bug = no
  }
 Module: Linked to sub-module rlm_eap_md5
 Module: Instantiating eap-md5
 Module: Linked to sub-module rlm_eap_leap
 Module: Instantiating eap-leap
 Module: Linked to sub-module rlm_eap_gtc
 Module: Instantiating eap-gtc
   gtc {
 challenge = "Password: "
 auth_type = "PAP"
   }
 Module: Linked to sub-module rlm_eap_tls
 Module: Instantiating eap-tls
   tls {
 rsa_key_exchange = no
 dh_key_exchange = yes
 rsa_key_length = 512
 dh_key_length = 512
 verify_depth = 0
 pem_file_type = yes
 private_key_file = "/etc/raddb/certs/server.pem"
 certificate_file = "/etc/raddb/certs/server.pem"
 CA_file = "/etc/raddb/certs/ca.pem"
 private_key_password = "whatever"
 dh_file = "/etc/raddb/certs/dh"
 random_file = "/etc/raddb/certs/random"
 fragment_size = 1024
 include_length = yes
 check_crl = no
 cipher_list = "DEFAULT"
 make_cert_command = "/etc/raddb/certs/bootstrap"
   }
 Module: Linked to sub-module rlm_eap_ttls
 Module: Instantiating eap-ttls
   ttls {
 default_eap_type = "md5"
 copy_request_to_tunnel = no
 use_tunneled_reply = no
 virtual_server = "inner-tunnel"
   }
 Module: Linked to sub-module rlm_eap_peap
 Module: Instantiating eap-peap
   peap {
 default_eap_type = "mschapv2"
 copy_request_to_tunnel = no
 use_tunneled_reply = no
 proxy_tunneled_request_as_eap = yes
 virtual_server = "inner-tunnel"
   }
 Module: Linked to sub-module rlm_eap_mschapv2
 Module: Instantiating eap-mschapv2
   mschapv2 {
 with_ntdomain_hack = no
   }
 Module: Checking authorize {...} for more modules to load
 Module: Linked to module rlm_preprocess
 Module: Instantiating preprocess
  preprocess {
 huntgroups = "/etc/raddb/huntgroups"
 hints = "/etc/raddb/hints"
 with_ascend_hack = no
 ascend_channels_per_line = 23
 with_ntdomain_hack = no
 with_specialix_jetstream_hack = no
 with_cisco_vsa_hack = no
 with_alvarion_vsa_hack = no
  }
 Module: Linked to module rlm_realm
 Module: Instantiating suffix
  realm suffix {
 format = "suffix"
 delimiter = "@"
 ignore_default = no
 ignore_null = no
  }
 Module: Linked to module rlm_files
 Module: Instantiating files
  files {
 usersfile = "/etc/raddb/users"
 acctusersfile = "/etc/raddb/acct_users"
 preproxy_usersfile = "/etc/raddb/preproxy_users"
 compat = "no"
  }
 Module: Linked to module rlm_sql
 Module: Instantiating sql
  sql {
 driver = "rlm_sql_mysql"
 server = "localhost"
 port = ""
 login = "radiusid"
 password = "test1234"
 radius_db = "radius"
 read_groups = yes
 sqltrace = no
 sqltracefile = "/var/log/radius/sqltrace.sql"
 readclients = no
 deletestalesessions = yes
 num_sql_socks = 5
 sql_user_name = "%{User-Name}"
 default_user_profile = ""
 nas_query = "SELECT id, nasname, shortname, type, secret FROM nas"
 authorize_check_query = "SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id"
 authorize_reply_query = "SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id"
 authorize_group_check_query = "SELECT id, groupname, attribute,           Value, op           FROM radgroupcheck           WHERE groupname = '%{Sql-Group}'           ORDER BY id"
 authorize_group_reply_query = "SELECT id, groupname, attribute,           value, op           FROM radgroupreply           WHERE groupname = '%{Sql-Group}'           ORDER BY id"
 accounting_onoff_query = "          UPDATE radacct           SET              acctstoptime       =  '%S',              acctsessiontime    =  unix_timestamp('%S') -                                    unix_timestamp(acctstarttime),              acctterminatecause =  '%{Acct-Terminate-Cause}',              acctstopdelay      =  %{%{Acct-Delay-Time}:-0}           WHERE acctsessiontime =  0           AND acctstoptime      =  NULL           AND nasipaddress      =  '%{NAS-IP-Address}'           AND acctstarttime     <= '%S'"
 accounting_update_query = "           UPDATE radacct           SET              framedipaddress = '%{Framed-IP-Address}',              acctsessiontime     = '%{Acct-Session-Time}',              acctinputoctets     = '%{%{Acct-Input-Gigawords}:-0}'  << 32 |                                    '%{%{Acct-Input-Octets}:-0}',              acctoutputoctets    = '%{%{Acct-Output-Gigawords}:-0}' << 32 |                                    '%{%{Acct-Output-Octets}:-0}'           WHERE acctsessionid = '%{Acct-Session-Id}'           AND username        = '%{SQL-User-Name}'           AND nasipaddress    = '%{NAS-IP-Address}'"
 accounting_update_query_alt = "           INSERT INTO radacct             (acctsessionid,    acctuniqueid,      username,              realm,            nasipaddress,      nasportid,              nasporttype,      acctstarttime,     acctsessiontime,              acctauthentic,    connectinfo_start, acctinputoctets,              acctoutputoctets, calledstationid,   callingstationid,              servicetype,      framedprotocol,    framedipaddress,              acctstartdelay,   xascendsessionsvrkey)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}',             
 DATE_SUB('%S',                       INTERVAL (%{%{Acct-Session-Time}:-0} +                                 %{%{Acct-Delay-Time}:-0}) SECOND),                       '%{Acct-Session-Time}',              '%{Acct-Authentic}', '',              '%{%{Acct-Input-Gigawords}:-0}' << 32 |              '%{%{Acct-Input-Octets}:-0}',              '%{%{Acct-Output-Gigawords}:-0}' << 32 |              '%{%{Acct-Output-Octets}:-0}',              '%{Called-Station-Id}', '%{Calling-Station-Id}',              '%{Service-Type}', '%{Framed-Protocol}',              '%{Framed-IP-Address}',              '0', '%{X-Ascend-Session-Svr-Key}')"
 accounting_start_query = "           INSERT INTO radacct             (acctsessionid,    acctuniqueid,     username,              realm,            nasipaddress,     nasportid,              nasporttype,      acctstarttime,    acctstoptime,              acctsessiontime,  acctauthentic,    connectinfo_start,              connectinfo_stop, acctinputoctets,  acctoutputoctets,              calledstationid,  callingstationid, acctterminatecause,              servicetype,      framedprotocol,   framedipaddress,              acctstartdelay,   acctstopdelay,    xascendsessionsvrkey)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}',
 '%{NAS-Port}',              '%{NAS-Port-Type}', '%S', NULL,              '0', '%{Acct-Authentic}', '%{Connect-Info}',              '', '0', '0',              '%{Called-Station-Id}', '%{Calling-Station-Id}', '',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '%{%{Acct-Delay-Time}:-0}', '0', '%{X-Ascend-Session-Svr-Key}')"
 accounting_start_query_alt = "           UPDATE radacct SET              acctstarttime     = '%S',              acctstartdelay    = '%{%{Acct-Delay-Time}:-0}',              connectinfo_start = '%{Connect-Info}'           WHERE acctsessionid  = '%{Acct-Session-Id}'           AND username         = '%{SQL-User-Name}'           AND nasipaddress     = '%{NAS-IP-Address}'"
 accounting_stop_query = "           UPDATE radacct SET              acctstoptime       = '%S',              acctsessiontime    = '%{Acct-Session-Time}',              acctinputoctets    = '%{%{Acct-Input-Gigawords}:-0}' << 32 |                                   '%{%{Acct-Input-Octets}:-0}',              acctoutputoctets   = '%{%{Acct-Output-Gigawords}:-0}' << 32 |                                   '%{%{Acct-Output-Octets}:-0}',              acctterminatecause = '%{Acct-Terminate-Cause}',              acctstopdelay      = '%{%{Acct-Delay-Time}:-0}',              connectinfo_stop   = '%{Connect-Info}'           WHERE acctsessionid   = '%{Acct-Session-Id}'           AND username          = '%{SQL-User-Name}'           AND
 nasipaddress      = '%{NAS-IP-Address}'"
 accounting_stop_query_alt = "           INSERT INTO radacct             (acctsessionid, acctuniqueid, username,              realm, nasipaddress, nasportid,              nasporttype, acctstarttime, acctstoptime,              acctsessiontime, acctauthentic, connectinfo_start,              connectinfo_stop, acctinputoctets, acctoutputoctets,              calledstationid, callingstationid, acctterminatecause,              servicetype, framedprotocol, framedipaddress,              acctstartdelay, acctstopdelay)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}', '%{NAS-Port}',              '%{NAS-Port-Type}',             
 DATE_SUB('%S',                  INTERVAL (%{%{Acct-Session-Time}:-0} +                  %{%{Acct-Delay-Time}:-0}) SECOND),              '%S', '%{Acct-Session-Time}', '%{Acct-Authentic}', '',              '%{Connect-Info}',              '%{%{Acct-Input-Gigawords}:-0}' << 32 |              '%{%{Acct-Input-Octets}:-0}',              '%{%{Acct-Output-Gigawords}:-0}' << 32 |              '%{%{Acct-Output-Octets}:-0}',              '%{Called-Station-Id}', '%{Calling-Station-Id}',              '%{Acct-Terminate-Cause}',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '0', '%{%{Acct-Delay-Time}:-0}')"
 group_membership_query = "SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority"
 connect_failure_retry_delay = 60
 simul_count_query = ""
 simul_verify_query = "SELECT radacctid, acctsessionid, username,                                nasipaddress, nasportid, framedipaddress,                                callingstationid, framedprotocol                                FROM radacct                                WHERE username = '%{SQL-User-Name}'                                AND acctstoptime = NULL"
 postauth_query = "INSERT INTO radpostauth                           (username, pass, reply, authdate)                           VALUES (                           '%{User-Name}',                           '%{%{User-Password}:-%{Chap-Password}}',                           '%{reply:Packet-Type}', '%S')"
 safe-characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
  }
rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked
rlm_sql (sql): Attempting to connect to radiusid at localhost:/radius
rlm_sql (sql): starting 0
rlm_sql (sql): Attempting to connect rlm_sql_mysql #0
rlm_sql_mysql: Starting connect to MySQL server for #0
rlm_sql (sql): Connected new DB handle, #0
rlm_sql (sql): starting 1
rlm_sql (sql): Attempting to connect rlm_sql_mysql #1
rlm_sql_mysql: Starting connect to MySQL server for #1
rlm_sql (sql): Connected new DB handle, #1
rlm_sql (sql): starting 2
rlm_sql (sql): Attempting to connect rlm_sql_mysql #2
rlm_sql_mysql: Starting connect to MySQL server for #2
rlm_sql (sql): Connected new DB handle, #2
rlm_sql (sql): starting 3
rlm_sql (sql): Attempting to connect rlm_sql_mysql #3
rlm_sql_mysql: Starting connect to MySQL server for #3
rlm_sql (sql): Connected new DB handle, #3
rlm_sql (sql): starting 4
rlm_sql (sql): Attempting to connect rlm_sql_mysql #4
rlm_sql_mysql: Starting connect to MySQL server for #4
rlm_sql (sql): Connected new DB handle, #4
 Module: Checking preacct {...} for more modules to load
 Module: Linked to module rlm_acct_unique
 Module: Instantiating acct_unique
  acct_unique {
 key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port"
  }
 Module: Checking accounting {...} for more modules to load
 Module: Linked to module rlm_detail
 Module: Instantiating detail
  detail {
 detailfile = "/var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d"
 header = "%t"
 detailperm = 384
 dirperm = 493
 locking = no
 log_packet_header = no
  }
 Module: Linked to module rlm_radutmp
 Module: Instantiating radutmp
  radutmp {
 filename = "/var/log/radius/radutmp"
 username = "%{User-Name}"
 case_sensitive = yes
 check_with_nas = yes
 perm = 384
 callerid = yes
  }
 Module: Linked to module rlm_sqlippool
 Module: Instantiating sqlippool
  sqlippool {
 sql-instance-name = "sql"
 lease-duration = 3600
 pool-name = ""
 allocate-begin = "START TRANSACTION"
 allocate-clear = "UPDATE radippool   SET nasipaddress = '', pool_key = 0,   callingstationid = '', username = '',   expiry_time IS NULL   WHERE expiry_time <= NOW() - INTERVAL 1 SECOND"
 allocate-find = "SELECT framedipaddress FROM radippool   WHERE pool_name = '%{control:Pool-Name}'   AND expiry_time IS NULL   ORDER BY RAND()   LIMIT 1   FOR UPDATE"
 allocate-update = "UPDATE radippool  SET nasipaddress = '%{NAS-IP-Address}', pool_key = '%{NAS-Port}',  callingstationid = '%{Calling-Station-Id}', username = '%{User-Name}',  expiry_time = NOW() + INTERVAL 3600 SECOND  WHERE framedipaddress = '%I'"
 allocate-commit = "COMMIT"
 allocate-rollback = "ROLLBACK"
 pool-check = "SELECT id FROM radippool  WHERE pool_name='%{control:Pool-Name}' LIMIT 1"
 start-begin = "START TRANSACTION"
 start-update = "UPDATE radippool  SET expiry_time = NOW() + INTERVAL 3600 SECOND  WHERE nasipaddress = '%{NAS-IP-Address}' AND  pool_key = '%{NAS-Port}'"
 start-commit = "COMMIT"
 start-rollback = "ROLLBACK"
 alive-begin = "START TRANSACTION"
 alive-update = "UPDATE radippool  SET expiry_time = NOW() + INTERVAL 3600 SECOND  WHERE nasipaddress = '%{Nas-IP-Address}' AND pool_key = '%{NAS-Port}'  AND username = '%{User-Name}'  AND callingstationid = '%{Calling-Station-Id}'  AND framedipaddress = '%{Framed-IP-Address}'"
 alive-commit = "COMMIT"
 alive-rollback = "ROLLBACK"
 stop-begin = "START TRANSACTION"
 stop-clear = "UPDATE radippool  SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '',  expiry_time IS NULL  WHERE nasipaddress = '%{Nas-IP-Address}' AND pool_key = '%{NAS-Port}'  AND username = '%{User-Name}'  AND callingstationid = '%{Calling-Station-Id}'  AND framedipaddress = '%{Framed-IP-Address}'"
 stop-commit = "COMMIT"
 stop-rollback = "ROLLBACK"
 on-begin = "START TRANSACTION"
 on-clear = "UPDATE radippool  SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '',  expiry_time IS NULL  WHERE nasipaddress = '%{Nas-IP-Address}'"
 on-commit = "COMMIT"
 on-rollback = "ROLLBACK"
 off-begin = "START TRANSACTION"
 off-clear = "UPDATE radippool  SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '',  expiry_time IS NULL  WHERE nasipaddress = '%{Nas-IP-Address}'"
 off-commit = "COMMIT"
 off-rollback = "ROLLBACK"
 sqlippool_log_exists = "Existing IP: %{reply:Framed-IP-Address}   (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
 sqlippool_log_success = "Allocated IP: %{reply:Framed-IP-Address} from %{control:Pool-Name}   (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
 sqlippool_log_clear = "Released IP %{Framed-IP-Address} (did %{Called-Station-Id} cli %{Calling-Station-Id} user %{User-Name})"
 sqlippool_log_failed = "IP Allocation FAILED from %{control:Pool-Name}   (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
 sqlippool_log_nopool = "No Pool-Name defined   (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
 defaultpool = "main_pool"
  }
rlm_sql (sql): Reserving sql socket id: 4
 Module: Linked to module rlm_attr_filter
 Module: Instantiating attr_filter.accounting_response
  attr_filter attr_filter.accounting_response {
 attrsfile = "/etc/raddb/attrs.accounting_response"
 key = "%{User-Name}"
  }
 Module: Checking session {...} for more modules to load
 Module: Checking post-proxy {...} for more modules to load
 Module: Checking post-auth {...} for more modules to load
 Module: Instantiating attr_filter.access_reject
  attr_filter attr_filter.access_reject {
 attrsfile = "/etc/raddb/attrs.access_reject"
 key = "%{User-Name}"
  }
 }
}
radiusd: #### Opening IP addresses and Ports ####
listen {
 type = "auth"
 ipaddr = *
 port = 0
}
listen {
 type = "acct"
 ipaddr = *
 port = 0
}
main {
 snmp = no
 smux_password = ""
 snmp_write_access = no
}
Listening on authentication address * port 1812
Listening on accounting address * port 1813
Listening on proxy address * port 1814
Ready to process requests.
rad_recv: Access-Request packet from host 127.0.0.1 port 32771, id=124, length=150
 Service-Type = Framed-User
 Framed-Protocol = PPP
 User-Name = "test"
 MS-CHAP-Challenge = 0xc5ac1174350544cd13a3a19a5b8fe003
 MS-CHAP2-Response = 0x0500caf32d299dbd505edfb10d4ea4d87ee30000000000000000503a118fd04e0a3c56a71ee4de8f3f17005fbb831d142dc4
 Calling-Station-Id = "121.176.82.138"
 NAS-IP-Address = 127.0.0.1
 NAS-Port = 0
+- entering group authorize
++[preprocess] returns ok
++[chap] returns noop
  rlm_mschap: Found MS-CHAP attributes.  Setting 'Auth-Type  = mschap'
++[mschap] returns ok
    rlm_realm: No '@' in User-Name = "test", looking up realm NULL
    rlm_realm: No such realm "NULL"
++[suffix] returns noop
  rlm_eap: No EAP-Message, not doing EAP
++[eap] returns noop
++[unix] returns notfound
    users: Matched entry DEFAULT at line 172
++[files] returns ok
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
rlm_sql (sql): Reserving sql socket id: 3
 expand: SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radcheck           WHERE username = 'test'           ORDER BY id
rlm_sql (sql): User found in radcheck table
 expand: SELECT id, username, attribute, value, op           FROM radreply           WHERE username = '%{SQL-User-Name}'           ORDER BY id -> SELECT id, username, attribute, value, op           FROM radreply           WHERE username = 'test'           ORDER BY id
 expand: SELECT groupname           FROM radusergroup           WHERE username = '%{SQL-User-Name}'           ORDER BY priority -> SELECT groupname           FROM radusergroup           WHERE username = 'test'           ORDER BY priority
 expand: SELECT id, groupname, attribute,           Value, op           FROM radgroupcheck           WHERE groupname = '%{Sql-Group}'           ORDER BY id -> SELECT id, groupname, attribute,           Value, op           FROM radgroupcheck           WHERE groupname = 'dialup_pool1'           ORDER BY id
rlm_sql (sql): User found in group dialup_pool1
 expand: SELECT id, groupname, attribute,           value, op           FROM radgroupreply           WHERE groupname = '%{Sql-Group}'           ORDER BY id -> SELECT id, groupname, attribute,           value, op           FROM radgroupreply           WHERE groupname = 'dialup_pool1'           ORDER BY id
rlm_sql (sql): Released sql socket id: 3
++[sql] returns ok
rlm_expiration: Checking Expiration time: '19 May 2008'
++[expiration] returns ok
++[logintime] returns noop
rlm_sqlcounter: Entering module authorize code
sqlcounter_expand:  'SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='%{User-Name}''
 expand: SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='%{User-Name}' -> SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='test'
sqlcounter_expand:  '%{sql:SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='test'}'
rlm_sql (sql): - sql_xlat
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='test' -> SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='test'
rlm_sql (sql): Reserving sql socket id: 2
rlm_sql (sql): - sql_xlat finished
rlm_sql (sql): Released sql socket id: 2
 expand: %{sql:SELECT SUM(AcctSessionTime) FROM radacct WHERE UserName='test'} -> 3751
rlm_sqlcounter: (Check item - counter) is greater than zero
rlm_sqlcounter: Authorized user test, check_item=360000, counter=3751
rlm_sqlcounter: Sent Reply-Item for user test, Type=Session-Timeout, value=356249
++[noresetcounter] returns ok
rlm_pap: Found existing Auth-Type, not changing it.
++[pap] returns noop
  rad_check_password:  Found Auth-Type mschap
auth: type "MSCHAP"
+- entering group MS-CHAP
  rlm_mschap: Told to do MS-CHAPv2 for test with NT-Password
++[mschap] returns ok
+- entering group session
 expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
 expand: %{User-Name} -> test
++[radutmp] returns ok
Login OK: [test/<via Auth-Type = mschap>] (from client localhost port 0 cli 121.176.82.138)
+- entering group post-auth
rlm_sql (sql): Reserving sql socket id: 1
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: START TRANSACTION -> START TRANSACTION
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: UPDATE radippool   SET nasipaddress = '', pool_key = 0,   callingstationid = '', username = '',   expiry_time IS NULL   WHERE expiry_time <= NOW() - INTERVAL 1 SECOND -> UPDATE radippool   SET nasipaddress = '', pool_key = 0,   callingstationid = '', username = '',   expiry_time IS NULL   WHERE expiry_time <= NOW() - INTERVAL 1 SECOND
rlm_sql_mysql: MYSQL check_error: 1064 received
sqlippool_command: database query error in: 'UPDATE radippool   SET nasipaddress = '', pool_key = 0,   callingstationid = '', username = '',   expiry_time IS NULL   WHERE expiry_time <= NOW() - INTERVAL 1 SECOND'
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: SELECT framedipaddress FROM radippool   WHERE pool_name = '%{control:Pool-Name}'   AND expiry_time IS NULL   ORDER BY RAND()   LIMIT 1   FOR UPDATE -> SELECT framedipaddress FROM radippool   WHERE pool_name = 'dialup_pool1'   AND expiry_time IS NULL   ORDER BY RAND()   LIMIT 1   FOR UPDATE
sqlippool_query1: SQL query did not return any results
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: COMMIT -> COMMIT
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: SELECT id FROM radippool  WHERE pool_name='%{control:Pool-Name}' LIMIT 1 -> SELECT id FROM radippool  WHERE pool_name='dialup_pool1' LIMIT 1
rlm_sql (sql): Released sql socket id: 1
rlm_sqlippool: IP address could not be allocated.
 expand: IP Allocation FAILED from %{control:Pool-Name}   (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name}) -> IP Allocation FAILED from dialup_pool1   (did  cli 121.176.82.138 port 0 user test)
IP Allocation FAILED from dialup_pool1   (did  cli 121.176.82.138 port 0 user test)
++[sqlippool] returns notfound
rlm_sql (sql): Processing sql_postauth
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: %{User-Password} -> 
 expand: %{Chap-Password} -> 
 expand: INSERT INTO radpostauth                           (username, pass, reply, authdate)                           VALUES (                           '%{User-Name}',                           '%{%{User-Password}:-%{Chap-Password}}',                           '%{reply:Packet-Type}', '%S') -> INSERT INTO radpostauth                           (username, pass, reply, authdate)                           VALUES (                           'test',                           '',                           'Access-Accept', '2008-04-19 20:46:08')
rlm_sql (sql) in sql_postauth: query is INSERT INTO radpostauth                           (username, pass, reply, authdate)                           VALUES (                           'test',                           '',                           'Access-Accept', '2008-04-19 20:46:08')
rlm_sql (sql): Reserving sql socket id: 0
rlm_sql (sql): Released sql socket id: 0
++[sql] returns ok
Sending Access-Accept of id 124 to 127.0.0.1 port 32771
 Framed-Protocol = PPP
 Framed-Compression = Van-Jacobson-TCP-IP
 Session-Timeout = 356249
 MS-CHAP2-Success = 0x05533d34363644443445384430314142383438313442463536393542334338314542463146394244353536
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 127.0.0.1 port 32771, id=125, length=114
 Acct-Session-Id = "4809DB830D9500"
 User-Name = "test"
 Acct-Status-Type = Start
 Service-Type = Framed-User
 Framed-Protocol = PPP
 Calling-Station-Id = "121.176.82.138"
 Acct-Authentic = RADIUS
 NAS-Port-Type = Async
 Framed-IP-Address = 111.111.111.173
 NAS-IP-Address = 127.0.0.1
 NAS-Port = 0
 Acct-Delay-Time = 0
+- entering group preacct
++[preprocess] returns ok
rlm_acct_unique: Hashing 'NAS-Port = 0,Client-IP-Address = 127.0.0.1,NAS-IP-Address = 127.0.0.1,Acct-Session-Id = "4809DB830D9500",User-Name = "test"'
rlm_acct_unique: Acct-Unique-Session-ID = "9d5d17a8d0b2e79c".
++[acct_unique] returns ok
    rlm_realm: No '@' in User-Name = "test", looking up realm NULL
    rlm_realm: No such realm "NULL"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting
 expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/radius/radacct/127.0.0.1/detail-20080419
rlm_detail: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/radius/radacct/127.0.0.1/detail-20080419
 expand: %t -> Sat Apr 19 20:46:11 2008
++[detail] returns ok
++[unix] returns ok
 expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
 expand: %{User-Name} -> test
++[radutmp] returns ok
rlm_sql (sql): Reserving sql socket id: 3
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: START TRANSACTION -> START TRANSACTION
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: UPDATE radippool  SET expiry_time = NOW() + INTERVAL 3600 SECOND  WHERE nasipaddress = '%{NAS-IP-Address}' AND  pool_key = '%{NAS-Port}' -> UPDATE radippool  SET expiry_time = NOW() + INTERVAL 3600 SECOND  WHERE nasipaddress = '127.0.0.1' AND  pool_key = '0'
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: COMMIT -> COMMIT
rlm_sql (sql): Released sql socket id: 3
++[sqlippool] returns ok
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: %{Acct-Delay-Time} -> 0
 expand:            INSERT INTO radacct             (acctsessionid,    acctuniqueid,     username,              realm,            nasipaddress,     nasportid,              nasporttype,      acctstarttime,    acctstoptime,              acctsessiontime,  acctauthentic,    connectinfo_start,              connectinfo_stop, acctinputoctets,  acctoutputoctets,              calledstationid,  callingstationid, acctterminatecause,              servicetype,      framedprotocol,   framedipaddress,              acctstartdelay,   acctstopdelay,    xascendsessionsvrkey)           VALUES             ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}',              '%{SQL-User-Name}',              '%{Realm}', '%{NAS-IP-Address}',
 '%{NAS-Port}',              '%{NAS-Port-Type}', '%S', NULL,              '0', '%{Acct-Authentic}', '%{Connect-Info}',              '', '0', '0',              '%{Called-Station-Id}', '%{Calling-Station-Id}', '',              '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}',              '%{%{Acct-Delay-Time}:-0}', '0', '%{X-Ascend-Session-Svr-Key}') ->            INSERT INTO radacct             (acctsessionid,    acctuniqueid,     username,              realm,            nasipaddress,     nasportid,              nasporttype,      acctstarttime,    acctstoptime,              acctsessiontime,  acctauthentic,    connectinfo_start,              connectinfo_stop, acctinputoctets,  acctoutputoctets,              calledstationid,  callingstationid,
 acctterminatecause,              servicetype,      framedprotocol,   framedipaddress,              acctstartdelay,   acctstopdelay,    xascendsessionsvrkey)           VALUES             ('4809DB830D9500', '9d5d17a8d0b2e79c',              'test',              '', '127.0.0.1', '0',              'Async', '2008-04-19 20:46:11', NULL,              '0', 'RADIUS', '',              '', '0', '0',              '', '121.176.82.138', '',              'Framed-User', 'PPP', '111.111.111.173',              '0', '0', '')
rlm_sql (sql): Reserving sql socket id: 2
rlm_sql (sql): Released sql socket id: 2
++[sql] returns ok
 expand: %{User-Name} -> test
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 125 to 127.0.0.1 port 32771
Finished request 1.
Cleaning up request 1 ID 125 with timestamp +10
Going to the next request
Waking up in 1.9 seconds.
Cleaning up request 0 ID 124 with timestamp +7
Ready to process requests.
rad_recv: Accounting-Request packet from host 127.0.0.1 port 32771, id=126, length=150
 Acct-Session-Id = "4809DB830D9500"
 User-Name = "test"
 Acct-Status-Type = Stop
 Service-Type = Framed-User
 Framed-Protocol = PPP
 Acct-Authentic = RADIUS
 Acct-Session-Time = 4
 Acct-Output-Octets = 12
 Acct-Input-Octets = 1671
 Acct-Output-Packets = 1
 Acct-Input-Packets = 19
 Calling-Station-Id = "121.176.82.138"
 NAS-Port-Type = Async
 Acct-Terminate-Cause = User-Request
 Framed-IP-Address = 111.111.111.173
 NAS-IP-Address = 127.0.0.1
 NAS-Port = 0
 Acct-Delay-Time = 0
+- entering group preacct
++[preprocess] returns ok
rlm_acct_unique: Hashing 'NAS-Port = 0,Client-IP-Address = 127.0.0.1,NAS-IP-Address = 127.0.0.1,Acct-Session-Id = "4809DB830D9500",User-Name = "test"'
rlm_acct_unique: Acct-Unique-Session-ID = "9d5d17a8d0b2e79c".
++[acct_unique] returns ok
    rlm_realm: No '@' in User-Name = "test", looking up realm NULL
    rlm_realm: No such realm "NULL"
++[suffix] returns noop
++[files] returns noop
+- entering group accounting
 expand: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d -> /var/log/radius/radacct/127.0.0.1/detail-20080419
rlm_detail: /var/log/radius/radacct/%{Client-IP-Address}/detail-%Y%m%d expands to /var/log/radius/radacct/127.0.0.1/detail-20080419
 expand: %t -> Sat Apr 19 20:46:15 2008
++[detail] returns ok
++[unix] returns ok
 expand: /var/log/radius/radutmp -> /var/log/radius/radutmp
 expand: %{User-Name} -> test
++[radutmp] returns ok
rlm_sql (sql): Reserving sql socket id: 1
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: START TRANSACTION -> START TRANSACTION
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: UPDATE radippool  SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '',  expiry_time IS NULL  WHERE nasipaddress = '%{Nas-IP-Address}' AND pool_key = '%{NAS-Port}'  AND username = '%{User-Name}'  AND callingstationid = '%{Calling-Station-Id}'  AND framedipaddress = '%{Framed-IP-Address}' -> UPDATE radippool  SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '',  expiry_time IS NULL  WHERE nasipaddress = '127.0.0.1' AND pool_key = '0'  AND username = 'test'  AND callingstationid = '121.176.82.138'  AND framedipaddress = '111.111.111.173'
rlm_sql_mysql: MYSQL check_error: 1064 received
sqlippool_command: database query error in: 'UPDATE radippool  SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '',  expiry_time IS NULL  WHERE nasipaddress = '127.0.0.1' AND pool_key = '0'  AND username = 'test'  AND callingstationid = '121.176.82.138'  AND framedipaddress = '111.111.111.173''
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: COMMIT -> COMMIT
rlm_sql (sql): Released sql socket id: 1
 expand: Released IP %{Framed-IP-Address} (did %{Called-Station-Id} cli %{Calling-Station-Id} user %{User-Name}) -> Released IP 111.111.111.173 (did  cli 121.176.82.138 user test)
Released IP 111.111.111.173 (did  cli 121.176.82.138 user test)
++[sqlippool] returns ok
 expand: %{User-Name} -> test
rlm_sql (sql): sql_set_user escaped user --> 'test'
 expand: %{Acct-Input-Gigawords} -> 
 expand: %{Acct-Input-Octets} -> 1671
 expand: %{Acct-Output-Gigawords} -> 
 expand: %{Acct-Output-Octets} -> 12
 expand: %{Acct-Delay-Time} -> 0
 expand:            UPDATE radacct SET              acctstoptime       = '%S',              acctsessiontime    = '%{Acct-Session-Time}',              acctinputoctets    = '%{%{Acct-Input-Gigawords}:-0}' << 32 |                                   '%{%{Acct-Input-Octets}:-0}',              acctoutputoctets   = '%{%{Acct-Output-Gigawords}:-0}' << 32 |                                   '%{%{Acct-Output-Octets}:-0}',              acctterminatecause = '%{Acct-Terminate-Cause}',              acctstopdelay      = '%{%{Acct-Delay-Time}:-0}',              connectinfo_stop   = '%{Connect-Info}'           WHERE acctsessionid   = '%{Acct-Session-Id}'           AND username          = '%{SQL-User-Name}'           AND nasipaddress     
 = '%{NAS-IP-Address}' ->            UPDATE radacct SET              acctstoptime       = '2008-04-19 20:46:15',              acctsessiontime    = '4',              acctinputoctets    = '0' << 32 |                                   '1671',              acctoutputoctets   = '0' << 32 |                                   '12',              acctterminatecause = 'User-Request',              acctstopdelay      = '0',              connectinfo_stop   = ''           WHERE acctsessionid   = '4809DB830D9500'           AND username          = 'test'           AND nasipaddress      = '127.0.0.1'
rlm_sql (sql): Reserving sql socket id: 0
rlm_sql (sql): Released sql socket id: 0
++[sql] returns ok
 expand: %{User-Name} -> test
 attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] returns updated
Sending Accounting-Response of id 126 to 127.0.0.1 port 32771
Finished request 2.
Cleaning up request 2 ID 126 with timestamp +14
Going to the next request
Ready to process requests.


      ________________________________________________________ 
180도 달라진 야후! 메일 - 여러 개의 메시지를 동시에 확인? 새로운 야후! 메일의 탭으로 가능해집니다.
http://kr.content.mail.yahoo.com/cgland




More information about the Freeradius-Users mailing list