darunia:/etc/freeradius# /usr/sbin/freeradius -XX 
Wed Jul 11 15:21:00 2007 : Info: Starting - reading configuration files ...
Wed Jul 11 15:21:00 2007 : Debug: reread_config:  reading radiusd.conf
Wed Jul 11 15:21:00 2007 : Debug: Config:   including file: /etc/freeradius/proxy.conf
Wed Jul 11 15:21:00 2007 : Debug: Config:   including file: /etc/freeradius/clients.conf
Wed Jul 11 15:21:00 2007 : Debug: Config:   including file: /etc/freeradius/snmp.conf
Wed Jul 11 15:21:00 2007 : Debug: Config:   including file: /etc/freeradius/eap.conf
Wed Jul 11 15:21:00 2007 : Debug: Config:   including file: /etc/freeradius/sql.conf
Wed Jul 11 15:21:00 2007 : Debug:  main: prefix = "/usr"
Wed Jul 11 15:21:00 2007 : Debug:  main: localstatedir = "/var"
Wed Jul 11 15:21:00 2007 : Debug:  main: logdir = "/var/log/freeradius"
Wed Jul 11 15:21:00 2007 : Debug:  main: libdir = "/usr/lib/freeradius"
Wed Jul 11 15:21:00 2007 : Debug:  main: radacctdir = "/var/log/freeradius/radacct"
Wed Jul 11 15:21:00 2007 : Debug:  main: hostname_lookups = no
Wed Jul 11 15:21:00 2007 : Debug:  main: snmp = no
Wed Jul 11 15:21:00 2007 : Debug:  main: max_request_time = 30
Wed Jul 11 15:21:00 2007 : Debug:  main: cleanup_delay = 5
Wed Jul 11 15:21:00 2007 : Debug:  main: max_requests = 1024
Wed Jul 11 15:21:00 2007 : Debug:  main: delete_blocked_requests = 0
Wed Jul 11 15:21:00 2007 : Debug:  main: port = 0
Wed Jul 11 15:21:00 2007 : Debug:  main: allow_core_dumps = no
Wed Jul 11 15:21:00 2007 : Debug:  main: log_stripped_names = no
Wed Jul 11 15:21:00 2007 : Debug:  main: log_file = "/var/log/freeradius/radius.log"
Wed Jul 11 15:21:00 2007 : Debug:  main: log_auth = no
Wed Jul 11 15:21:00 2007 : Debug:  main: log_auth_badpass = no
Wed Jul 11 15:21:00 2007 : Debug:  main: log_auth_goodpass = no
Wed Jul 11 15:21:00 2007 : Debug:  main: pidfile = "/var/run/freeradius/freeradius.pid"
Wed Jul 11 15:21:00 2007 : Debug:  main: user = "freerad"
Wed Jul 11 15:21:00 2007 : Debug:  main: group = "freerad"
Wed Jul 11 15:21:00 2007 : Debug:  main: usercollide = no
Wed Jul 11 15:21:00 2007 : Debug:  main: lower_user = "no"
Wed Jul 11 15:21:00 2007 : Debug:  main: lower_pass = "no"
Wed Jul 11 15:21:00 2007 : Debug:  main: nospace_user = "no"
Wed Jul 11 15:21:00 2007 : Debug:  main: nospace_pass = "no"
Wed Jul 11 15:21:00 2007 : Debug:  main: checkrad = "/usr/sbin/checkrad"
Wed Jul 11 15:21:00 2007 : Debug:  main: proxy_requests = yes
Wed Jul 11 15:21:00 2007 : Debug:  proxy: retry_delay = 5
Wed Jul 11 15:21:00 2007 : Debug:  proxy: retry_count = 3
Wed Jul 11 15:21:00 2007 : Debug:  proxy: synchronous = no
Wed Jul 11 15:21:00 2007 : Debug:  proxy: default_fallback = yes
Wed Jul 11 15:21:00 2007 : Debug:  proxy: dead_time = 120
Wed Jul 11 15:21:00 2007 : Debug:  proxy: post_proxy_authorize = no
Wed Jul 11 15:21:00 2007 : Debug:  proxy: wake_all_if_all_dead = no
Wed Jul 11 15:21:00 2007 : Debug:  security: max_attributes = 200
Wed Jul 11 15:21:00 2007 : Debug:  security: reject_delay = 1
Wed Jul 11 15:21:00 2007 : Debug:  security: status_server = no
Wed Jul 11 15:21:00 2007 : Debug:  main: debug_level = 0
Wed Jul 11 15:21:00 2007 : Debug: read_config_files:  reading dictionary
Wed Jul 11 15:21:00 2007 : Debug: read_config_files:  reading naslist
Wed Jul 11 15:21:00 2007 : Info: Using deprecated naslist file.  Support for this will go away soon.
Wed Jul 11 15:21:00 2007 : Debug: read_config_files:  reading clients
Wed Jul 11 15:21:00 2007 : Debug: read_config_files:  reading realms
Wed Jul 11 15:21:00 2007 : Debug: radiusd:  entering modules setup
Wed Jul 11 15:21:00 2007 : Debug: Module: Library search path is /usr/lib/freeradius
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded exec 
Wed Jul 11 15:21:00 2007 : Debug:  exec: wait = yes
Wed Jul 11 15:21:00 2007 : Debug:  exec: program = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  exec: input_pairs = "request"
Wed Jul 11 15:21:00 2007 : Debug:  exec: output_pairs = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  exec: packet_type = "(null)"
Wed Jul 11 15:21:00 2007 : Info: rlm_exec: Wait=yes but no output defined. Did you mean output=none?
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated exec (exec) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded expr 
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated expr (expr) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded LDAP 
Wed Jul 11 15:21:00 2007 : Debug:  ldap: server = "ldap.domain.ca"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: port = 389
Wed Jul 11 15:21:00 2007 : Debug:  ldap: net_timeout = 1
Wed Jul 11 15:21:00 2007 : Debug:  ldap: timeout = 4
Wed Jul 11 15:21:00 2007 : Debug:  ldap: timelimit = 3
Wed Jul 11 15:21:00 2007 : Debug:  ldap: identity = ""
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_mode = no
Wed Jul 11 15:21:00 2007 : Debug:  ldap: start_tls = yes
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_cacertfile = "/etc/ssl/certs/ca/Root_CA.crt"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_cacertdir = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_certfile = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_keyfile = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_randfile = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: tls_require_cert = "allow"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: password = ""
Wed Jul 11 15:21:00 2007 : Debug:  ldap: basedn = "ou=staff,dc=domain,dc=ca"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: filter = "(uid=%u)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: base_filter = "(objectclass=radiusprofile)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: default_profile = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: profile_attribute = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: password_header = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: password_attribute = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: access_attr = "uid"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: groupname_attribute = "cn"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: groupmembership_filter = "(|(&(objectClass=GroupOfNames)(member=%{Ldap-UserDn}))(&(objectClass=GroupOfUniqueNames)(uniquemember=%{Ldap-UserDn})))"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: groupmembership_attribute = "(null)"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: dictionary_mapping = "/etc/freeradius/ldap.attrmap"
Wed Jul 11 15:21:00 2007 : Debug:  ldap: ldap_debug = 1
Wed Jul 11 15:21:00 2007 : Debug:  ldap: ldap_connections_number = 5
Wed Jul 11 15:21:00 2007 : Debug:  ldap: compare_check_items = no
Wed Jul 11 15:21:00 2007 : Debug:  ldap: access_attr_used_for_allow = yes
Wed Jul 11 15:21:00 2007 : Debug:  ldap: do_xlat = yes
Wed Jul 11 15:21:00 2007 : Debug:  ldap: edir_account_policy_check = no
Wed Jul 11 15:21:00 2007 : Debug:  ldap: set_auth_type = yes
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: Registering ldap_groupcmp for Ldap-Group
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: Registering ldap_xlat with xlat_name ldap
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: reading ldap<->radius mappings from file /etc/freeradius/ldap.attrmap
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusCheckItem mapped to RADIUS $GENERIC$
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusReplyItem mapped to RADIUS $GENERIC$
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusAuthType mapped to RADIUS Auth-Type
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusSimultaneousUse mapped to RADIUS Simultaneous-Use
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusCalledStationId mapped to RADIUS Called-Station-Id
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusCallingStationId mapped to RADIUS Calling-Station-Id
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP lmPassword mapped to RADIUS LM-Password
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP ntPassword mapped to RADIUS NT-Password
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP acctFlags mapped to RADIUS SMB-Account-CTRL-TEXT
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusExpiration mapped to RADIUS Expiration
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusNASIpAddress mapped to RADIUS NAS-IP-Address
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusServiceType mapped to RADIUS Service-Type
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedProtocol mapped to RADIUS Framed-Protocol
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedIPAddress mapped to RADIUS Framed-IP-Address
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedIPNetmask mapped to RADIUS Framed-IP-Netmask
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedRoute mapped to RADIUS Framed-Route
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedRouting mapped to RADIUS Framed-Routing
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFilterId mapped to RADIUS Filter-Id
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedMTU mapped to RADIUS Framed-MTU
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedCompression mapped to RADIUS Framed-Compression
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginIPHost mapped to RADIUS Login-IP-Host
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginService mapped to RADIUS Login-Service
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginTCPPort mapped to RADIUS Login-TCP-Port
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusCallbackNumber mapped to RADIUS Callback-Number
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusCallbackId mapped to RADIUS Callback-Id
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedIPXNetwork mapped to RADIUS Framed-IPX-Network
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusClass mapped to RADIUS Class
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusSessionTimeout mapped to RADIUS Session-Timeout
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusIdleTimeout mapped to RADIUS Idle-Timeout
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusTerminationAction mapped to RADIUS Termination-Action
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginLATService mapped to RADIUS Login-LAT-Service
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginLATNode mapped to RADIUS Login-LAT-Node
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginLATGroup mapped to RADIUS Login-LAT-Group
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedAppleTalkLink mapped to RADIUS Framed-AppleTalk-Link
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedAppleTalkNetwork mapped to RADIUS Framed-AppleTalk-Network
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusFramedAppleTalkZone mapped to RADIUS Framed-AppleTalk-Zone
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusPortLimit mapped to RADIUS Port-Limit
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusLoginLATPort mapped to RADIUS Login-LAT-Port
Wed Jul 11 15:21:00 2007 : Debug: rlm_ldap: LDAP radiusReplyMessage mapped to RADIUS Reply-Message
Wed Jul 11 15:21:00 2007 : Debug: conns: 0x80187ee8
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated ldap (ldap) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded preprocess 
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: huntgroups = "/etc/freeradius/huntgroups"
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: hints = "/etc/freeradius/hints"
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: with_ascend_hack = no
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: ascend_channels_per_line = 23
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: with_ntdomain_hack = no
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: with_specialix_jetstream_hack = no
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: with_cisco_vsa_hack = no
Wed Jul 11 15:21:00 2007 : Debug:  preprocess: with_alvarion_vsa_hack = no
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated preprocess (preprocess) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded Acct-Unique-Session-Id 
Wed Jul 11 15:21:00 2007 : Debug:  acct_unique: key = "User-Name, Acct-Session-Id, NAS-IP-Address, Client-IP-Address, NAS-Port"
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated acct_unique (acct_unique) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded files 
Wed Jul 11 15:21:00 2007 : Debug:  files: usersfile = "/etc/freeradius/users"
Wed Jul 11 15:21:00 2007 : Debug:  files: acctusersfile = "/etc/freeradius/acct_users"
Wed Jul 11 15:21:00 2007 : Debug:  files: preproxy_usersfile = "/etc/freeradius/preproxy_users"
Wed Jul 11 15:21:00 2007 : Debug:  files: compat = "no"
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated files (files) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded detail 
Wed Jul 11 15:21:00 2007 : Debug:  detail: detailfile = "/var/log/freeradius/radacct/%{Client-IP-Address}/detail-%Y%m%d"
Wed Jul 11 15:21:00 2007 : Debug:  detail: detailperm = 384
Wed Jul 11 15:21:00 2007 : Debug:  detail: dirperm = 493
Wed Jul 11 15:21:00 2007 : Debug:  detail: locking = no
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated detail (detail) 
Wed Jul 11 15:21:00 2007 : Debug: Module: Loaded radutmp 
Wed Jul 11 15:21:00 2007 : Debug:  radutmp: filename = "/var/log/freeradius/radutmp"
Wed Jul 11 15:21:00 2007 : Debug:  radutmp: username = "%{User-Name}"
Wed Jul 11 15:21:00 2007 : Debug:  radutmp: case_sensitive = yes
Wed Jul 11 15:21:00 2007 : Debug:  radutmp: check_with_nas = yes
Wed Jul 11 15:21:00 2007 : Debug:  radutmp: perm = 384
Wed Jul 11 15:21:00 2007 : Debug:  radutmp: callerid = yes
Wed Jul 11 15:21:00 2007 : Debug: Module: Instantiated radutmp (radutmp) 
Wed Jul 11 15:21:00 2007 : Debug: Listening on authentication *:1812
Wed Jul 11 15:21:00 2007 : Debug: Listening on accounting *:1813
Wed Jul 11 15:21:00 2007 : Info: Ready to process requests.