Help Upgrading from 3.0.19 to 3.0.20
Aurélio de Souza Ribeiro Neto
netolistas at mpc.com.br
Tue Feb 4 15:24:17 CET 2020
Hello All,
I'm trying to upgrade from 3.0.19 to 3.0.20 and I'm having this
problem:
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Processing
generate_sql_clients
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql) in
generate_sql_clients: query is SELECT id, nasname, shortname, type,
secret, server FROM nas
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Reserved connection
(0)
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Executing select
query: SELECT id, nasname, shortname, type, secret, server FROM nas
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Adding client
127.0.0.1 (Local Host) to global clients list
Tue Feb 4 10:40:53 2020 : Debug: Adding client 127.0.0.1/32
(127.0.0.1) to prefix tree 32
Tue Feb 4 10:40:53 2020 : Error: Failed to add duplicate client Local
Host
Tue Feb 4 10:40:53 2020 : Warning: Failed to add client, possible
duplicate?
Bad talloc magic value - unknown value
talloc abort: Bad talloc magic value - unknown value
Aborted (core dumped)
Full log attached.
In 3.0.19 I don't have this issue using the same settings and
database.
Any hint?
Thanks
-------------- next part --------------
Tue Feb 4 10:40:53 2020 : Debug: Server was built with:
Tue Feb 4 10:40:53 2020 : Debug: accounting : yes
Tue Feb 4 10:40:53 2020 : Debug: authentication : yes
Tue Feb 4 10:40:53 2020 : Debug: ascend-binary-attributes : yes
Tue Feb 4 10:40:53 2020 : Debug: coa : yes
Tue Feb 4 10:40:53 2020 : Debug: control-socket : yes
Tue Feb 4 10:40:53 2020 : Debug: detail : yes
Tue Feb 4 10:40:53 2020 : Debug: dhcp : yes
Tue Feb 4 10:40:53 2020 : Debug: dynamic-clients : yes
Tue Feb 4 10:40:53 2020 : Debug: osfc2 : no
Tue Feb 4 10:40:53 2020 : Debug: proxy : yes
Tue Feb 4 10:40:53 2020 : Debug: regex-pcre : no
Tue Feb 4 10:40:53 2020 : Debug: regex-posix : yes
Tue Feb 4 10:40:53 2020 : Debug: regex-posix-extended : yes
Tue Feb 4 10:40:53 2020 : Debug: session-management : yes
Tue Feb 4 10:40:53 2020 : Debug: stats : yes
Tue Feb 4 10:40:53 2020 : Debug: systemd : yes
Tue Feb 4 10:40:53 2020 : Debug: tcp : yes
Tue Feb 4 10:40:53 2020 : Debug: threads : yes
Tue Feb 4 10:40:53 2020 : Debug: tls : yes
Tue Feb 4 10:40:53 2020 : Debug: unlang : yes
Tue Feb 4 10:40:53 2020 : Debug: vmps : yes
Tue Feb 4 10:40:53 2020 : Debug: developer : no
Tue Feb 4 10:40:53 2020 : Debug: Server core libs:
Tue Feb 4 10:40:53 2020 : Debug: freeradius-server : 3.0.20
Tue Feb 4 10:40:53 2020 : Debug: talloc : 2.0.*
Tue Feb 4 10:40:53 2020 : Debug: ssl : 1.0.2g release
Tue Feb 4 10:40:53 2020 : Debug: Endianness:
Tue Feb 4 10:40:53 2020 : Debug: little
Tue Feb 4 10:40:53 2020 : Debug: Compilation flags:
Tue Feb 4 10:40:53 2020 : Debug: cppflags : -Wdate-time -D_FORTIFY_SOURCE=2
Tue Feb 4 10:40:53 2020 : Debug: cflags : -I. -Isrc -include src/freeradius-devel/autoconf.h -include src/freeradius-devel/build.h -include src/freeradius-devel/features.h -include src/freeradius-devel/radpaths.h -fno-strict-aliasing -g -O2 -fPIE -fstack-protector-strong -Wformat -Werror=format-security -Wdate-time -D_FORTIFY_SOURCE=2 -O2 -Wall -std=c99 -D_GNU_SOURCE -D_REENTRANT -D_POSIX_PTHREAD_SEMANTICS -DOPENSSL_NO_KRB5 -DNDEBUG -DIS_MODULE=1
Tue Feb 4 10:40:53 2020 : Debug: ldflags : -Wl,-Bsymbolic-functions -fPIE -pie -Wl,-z,relro -Wl,-z,now
Tue Feb 4 10:40:53 2020 : Debug: libs : -lcrypto -lssl -ltalloc -latomic -lcap -lnsl -lresolv -ldl -lpthread -lreadline
Tue Feb 4 10:40:53 2020 : Debug:
Tue Feb 4 10:40:53 2020 : Info: FreeRADIUS Version 3.0.20
Tue Feb 4 10:40:53 2020 : Info: Copyright (C) 1999-2019 The FreeRADIUS server project and contributors
Tue Feb 4 10:40:53 2020 : Info: There is NO warranty; not even for MERCHANTABILITY or FITNESS FOR A
Tue Feb 4 10:40:53 2020 : Info: PARTICULAR PURPOSE
Tue Feb 4 10:40:53 2020 : Info: You may redistribute copies of FreeRADIUS under the terms of the
Tue Feb 4 10:40:53 2020 : Info: GNU General Public License
Tue Feb 4 10:40:53 2020 : Info: For more information about these matters, see the file named COPYRIGHT
Tue Feb 4 10:40:53 2020 : Info: Starting - reading configuration files ...
Tue Feb 4 10:40:53 2020 : Debug: including dictionary file /usr/share/freeradius/dictionary
Tue Feb 4 10:40:53 2020 : Debug: including dictionary file /usr/share/freeradius/dictionary.dhcp
Tue Feb 4 10:40:53 2020 : Debug: including dictionary file /usr/share/freeradius/dictionary.vqp
Tue Feb 4 10:40:53 2020 : Debug: including dictionary file /etc/freeradius/dictionary
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/radiusd.conf
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/proxy.conf
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/clients.conf
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/sql
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-config/sql/main/mysql/queries.conf
Tue Feb 4 10:40:53 2020 : Debug: including files in directory /etc/freeradius/mods-enabled/
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/echo
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/utf8
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/replicate
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/ntlm_auth
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/pap
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/realm
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/files
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/attr_filter
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/date
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/mschap
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/passwd
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/exec
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/sqlippool
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-config/sql/ippool/mysql/queries.conf
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/chap
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/preprocess
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/expr
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/expiration
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/unpack
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/dynamic_clients
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/linelog
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/soh
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/mods-enabled/logintime
Tue Feb 4 10:40:53 2020 : Debug: including files in directory /etc/freeradius/policy.d/
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/rfc7542
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/moonshot-targeted-ids
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/debug
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/operator-name
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/dhcp
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/accounting
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/control
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/filter
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/canonicalization
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/eap
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/abfab-tr
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/policy.d/cui
Tue Feb 4 10:40:53 2020 : Debug: OPTIMIZING (${policy.cui_require_operator_name} == yes) --> FALSE
Tue Feb 4 10:40:53 2020 : Debug: OPTIMIZING (no == yes) --> FALSE
Tue Feb 4 10:40:53 2020 : Debug: OPTIMIZING (${policy.cui_require_operator_name} == yes) --> FALSE
Tue Feb 4 10:40:53 2020 : Debug: OPTIMIZING (no == yes) --> FALSE
Tue Feb 4 10:40:53 2020 : Debug: including files in directory /etc/freeradius/sites-enabled/
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/sites-enabled/inner-tunnel
Tue Feb 4 10:40:53 2020 : Debug: including configuration file /etc/freeradius/sites-enabled/default
Tue Feb 4 10:40:53 2020 : Debug: main {
Tue Feb 4 10:40:53 2020 : Debug: security {
Tue Feb 4 10:40:53 2020 : Debug: user = "freerad"
Tue Feb 4 10:40:53 2020 : Debug: group = "freerad"
Tue Feb 4 10:40:53 2020 : Debug: allow_core_dumps = no
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[473]: The item 'max_attributes' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[491]: The item 'reject_delay' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[511]: The item 'status_server' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: name = "freeradius"
Tue Feb 4 10:40:53 2020 : Debug: prefix = "/usr"
Tue Feb 4 10:40:53 2020 : Debug: localstatedir = "/var"
Tue Feb 4 10:40:53 2020 : Debug: logdir = "/var/log/freeradius"
Tue Feb 4 10:40:53 2020 : Debug: run_dir = "/var/run/freeradius"
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[85]: The item 'sysconfdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[90]: The item 'radacctdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[97]: The item 'confdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[99]: The item 'certdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[100]: The item 'cadir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[104]: The item 'db_dir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[138]: The item 'libdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[149]: The item 'pidfile' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[170]: The item 'correct_escapes' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[224]: The item 'max_request_time' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[243]: The item 'cleanup_delay' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[262]: The item 'max_requests' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[280]: The item 'hostname_lookups' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[383]: The item 'checkrad' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[532]: The item 'proxy_requests' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: main {
Tue Feb 4 10:40:53 2020 : Debug: name = "freeradius"
Tue Feb 4 10:40:53 2020 : Debug: prefix = "/usr"
Tue Feb 4 10:40:53 2020 : Debug: localstatedir = "/var"
Tue Feb 4 10:40:53 2020 : Debug: sbindir = "/usr/sbin"
Tue Feb 4 10:40:53 2020 : Debug: logdir = "/var/log/freeradius"
Tue Feb 4 10:40:53 2020 : Debug: run_dir = "/var/run/freeradius"
Tue Feb 4 10:40:53 2020 : Debug: libdir = "/usr/lib/freeradius"
Tue Feb 4 10:40:53 2020 : Debug: radacctdir = "/var/log/freeradius/radacct"
Tue Feb 4 10:40:53 2020 : Debug: hostname_lookups = no
Tue Feb 4 10:40:53 2020 : Debug: max_request_time = 15
Tue Feb 4 10:40:53 2020 : Debug: cleanup_delay = 10
Tue Feb 4 10:40:53 2020 : Debug: max_requests = 7680
Tue Feb 4 10:40:53 2020 : Debug: pidfile = "/var/run/freeradius/freeradius.pid"
Tue Feb 4 10:40:53 2020 : Debug: checkrad = "/usr/sbin/checkrad"
Tue Feb 4 10:40:53 2020 : Debug: debug_level = 0
Tue Feb 4 10:40:53 2020 : Debug: proxy_requests = no
Tue Feb 4 10:40:53 2020 : Debug: log {
Tue Feb 4 10:40:53 2020 : Debug: stripped_names = no
Tue Feb 4 10:40:53 2020 : Debug: auth = yes
Tue Feb 4 10:40:53 2020 : Debug: auth_badpass = yes
Tue Feb 4 10:40:53 2020 : Debug: auth_goodpass = no
Tue Feb 4 10:40:53 2020 : Debug: colourise = yes
Tue Feb 4 10:40:53 2020 : Debug: msg_denied = "You are already logged in - access denied"
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[298]: The item 'destination' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[315]: The item 'file' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[323]: The item 'syslog_facility' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: resources {
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: security {
Tue Feb 4 10:40:53 2020 : Debug: max_attributes = 200
Tue Feb 4 10:40:53 2020 : Debug: reject_delay = 1.000000
Tue Feb 4 10:40:53 2020 : Debug: status_server = yes
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[85]: The item 'sysconfdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[97]: The item 'confdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[99]: The item 'certdir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[100]: The item 'cadir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[104]: The item 'db_dir' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/radiusd.conf[170]: The item 'correct_escapes' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: radiusd: #### Loading Realms and Home Servers ####
Tue Feb 4 10:40:53 2020 : Debug: proxy server {
Tue Feb 4 10:40:53 2020 : Debug: retry_delay = 5
Tue Feb 4 10:40:53 2020 : Debug: retry_count = 3
Tue Feb 4 10:40:53 2020 : Debug: default_fallback = no
Tue Feb 4 10:40:53 2020 : Debug: dead_time = 120
Tue Feb 4 10:40:53 2020 : Debug: wake_all_if_all_dead = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: home_server localhost {
Tue Feb 4 10:40:53 2020 : Debug: ipaddr = 127.0.0.1
Tue Feb 4 10:40:53 2020 : Debug: port = 1812
Tue Feb 4 10:40:53 2020 : Debug: type = "auth"
Tue Feb 4 10:40:53 2020 : Debug: secret = "testing123"
Tue Feb 4 10:40:53 2020 : Debug: response_window = 20.000000
Tue Feb 4 10:40:53 2020 : Debug: response_timeouts = 1
Tue Feb 4 10:40:53 2020 : Debug: max_outstanding = 65536
Tue Feb 4 10:40:53 2020 : Debug: zombie_period = 40
Tue Feb 4 10:40:53 2020 : Debug: status_check = "status-server"
Tue Feb 4 10:40:53 2020 : Debug: ping_interval = 30
Tue Feb 4 10:40:53 2020 : Debug: check_interval = 30
Tue Feb 4 10:40:53 2020 : Debug: check_timeout = 4
Tue Feb 4 10:40:53 2020 : Debug: num_answers_to_alive = 3
Tue Feb 4 10:40:53 2020 : Debug: revive_interval = 120
Tue Feb 4 10:40:53 2020 : Debug: limit {
Tue Feb 4 10:40:53 2020 : Debug: max_connections = 16
Tue Feb 4 10:40:53 2020 : Debug: max_requests = 0
Tue Feb 4 10:40:53 2020 : Debug: lifetime = 0
Tue Feb 4 10:40:53 2020 : Debug: idle_timeout = 0
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: coa {
Tue Feb 4 10:40:53 2020 : Debug: irt = 2
Tue Feb 4 10:40:53 2020 : Debug: mrt = 16
Tue Feb 4 10:40:53 2020 : Debug: mrc = 5
Tue Feb 4 10:40:53 2020 : Debug: mrd = 30
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Warning: Ignoring "response_window = 20.000000", forcing to "response_window = 15.000000"
Tue Feb 4 10:40:53 2020 : Debug: home_server_pool my_auth_failover {
Tue Feb 4 10:40:53 2020 : Debug: type = fail-over
Tue Feb 4 10:40:53 2020 : Debug: home_server = localhost
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: realm example.com {
Tue Feb 4 10:40:53 2020 : Debug: auth_pool = my_auth_failover
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: realm LOCAL {
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: radiusd: #### Loading Clients ####
Tue Feb 4 10:40:53 2020 : Debug: client localhost {
Tue Feb 4 10:40:53 2020 : Debug: ipaddr = 127.0.0.1
Tue Feb 4 10:40:53 2020 : Debug: require_message_authenticator = no
Tue Feb 4 10:40:53 2020 : Debug: secret = "secret"
Tue Feb 4 10:40:53 2020 : Debug: nas_type = "other"
Tue Feb 4 10:40:53 2020 : Debug: proto = "*"
Tue Feb 4 10:40:53 2020 : Debug: limit {
Tue Feb 4 10:40:53 2020 : Debug: max_connections = 16
Tue Feb 4 10:40:53 2020 : Debug: lifetime = 0
Tue Feb 4 10:40:53 2020 : Debug: idle_timeout = 30
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Adding client 127.0.0.1/32 (127.0.0.1) to prefix tree 32
Tue Feb 4 10:40:53 2020 : Debug: client localhost_ipv6 {
Tue Feb 4 10:40:53 2020 : Debug: ipv6addr = ::1
Tue Feb 4 10:40:53 2020 : Debug: require_message_authenticator = no
Tue Feb 4 10:40:53 2020 : Debug: secret = "testing123"
Tue Feb 4 10:40:53 2020 : Debug: limit {
Tue Feb 4 10:40:53 2020 : Debug: max_connections = 16
Tue Feb 4 10:40:53 2020 : Debug: lifetime = 0
Tue Feb 4 10:40:53 2020 : Debug: idle_timeout = 30
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Adding client ::1/128 (::1) to prefix tree 128
Tue Feb 4 10:40:53 2020 : Info: Debugger not attached
Tue Feb 4 10:40:53 2020 : Info: systemd watchdog is disabled
Tue Feb 4 10:40:53 2020 : Debug: # Creating Auth-Type = mschap
Tue Feb 4 10:40:53 2020 : Debug: # Creating Auth-Type = PAP
Tue Feb 4 10:40:53 2020 : Debug: # Creating Auth-Type = CHAP
Tue Feb 4 10:40:53 2020 : Debug: # Creating Auth-Type = MS-CHAP
Tue Feb 4 10:40:53 2020 : Debug: radiusd: #### Instantiating modules ####
Tue Feb 4 10:40:53 2020 : Debug: modules {
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_sql, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_sql
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "sql" from file /etc/freeradius/mods-enabled/sql
Tue Feb 4 10:40:53 2020 : Debug: sql {
Tue Feb 4 10:40:53 2020 : Debug: driver = "rlm_sql_mysql"
Tue Feb 4 10:40:53 2020 : Debug: server = "mysql.mpc.com.br"
Tue Feb 4 10:40:53 2020 : Debug: port = 3306
Tue Feb 4 10:40:53 2020 : Debug: login = "FREERADIUS"
Tue Feb 4 10:40:53 2020 : Debug: password = "CfnpEuBJhvaPpjAd"
Tue Feb 4 10:40:53 2020 : Debug: radius_db = "mpc_freeradius"
Tue Feb 4 10:40:53 2020 : Debug: read_groups = yes
Tue Feb 4 10:40:53 2020 : Debug: read_profiles = yes
Tue Feb 4 10:40:53 2020 : Debug: read_clients = yes
Tue Feb 4 10:40:53 2020 : Debug: delete_stale_sessions = yes
Tue Feb 4 10:40:53 2020 : Debug: sql_user_name = "%{User-Name}"
Tue Feb 4 10:40:53 2020 : Debug: default_user_profile = ""
Tue Feb 4 10:40:53 2020 : Debug: client_query = "SELECT id, nasname, shortname, type, secret, server FROM nas"
Tue Feb 4 10:40:53 2020 : Debug: authorize_check_query = "SELECT DISTINCT (R.id), R.username, R.attribute, R.value, R.op FROM mpc_freeradius.radcheck R, mpc_freeradius.nas N, mpc_lw.maclist M WHERE R.username = BINARY '%{SQL-User-Name}' AND M.usuario_login = BINARY '%{SQL-User-Name}' AND N.nasname = '%{Nas-IP-Address}' AND N.gw_id = (SELECT gateway_id FROM mpc_lw.maclist WHERE usuario_login = BINARY '%{SQL-User-Name}' AND plano_id NOT IN (6,8,9,793) AND gateway_id = ( SELECT gw_id FROM mpc_freeradius.nas WHERE nasname = '%{Nas-IP-Address}' ) ORDER BY ID) UNION ALL SELECT DISTINCT (R.id), R.username, R.attribute, R.value, R.op FROM mpc_freeradius.radcheck R, mpc_freeradius.nas N, mpc_lw.maclist M WHERE R.username = BINARY '%{SQL-User-Name}' AND M.usuario_login = BINARY '%{SQL-User-Name}' AND M.grupocliente = 'ALL-POPS'"
Tue Feb 4 10:40:53 2020 : Debug: authorize_reply_query = "SELECT DISTINCT (R.id), R.username, R.attribute, R.value, R.op FROM mpc_freeradius.radcheck R, mpc_freeradius.nas N, mpc_lw.maclist M WHERE R.username = BINARY '%{SQL-User-Name}' AND M.usuario_login = BINARY '%{SQL-User-Name}' AND N.nasname = '%{Nas-IP-Address}' AND N.gw_id = (SELECT gateway_id FROM mpc_lw.maclist WHERE usuario_login = BINARY '%{SQL-User-Name}' AND plano_id NOT IN (6,8,9,793) AND gateway_id = ( SELECT gw_id FROM mpc_freeradius.nas WHERE nasname = '%{Nas-IP-Address}' ) ORDER BY ID) UNION ALL SELECT DISTINCT (R.id), R.username, R.attribute, R.value, R.op FROM mpc_freeradius.radcheck R, mpc_freeradius.nas N, mpc_lw.maclist M WHERE R.username = BINARY '%{SQL-User-Name}' AND M.usuario_login = BINARY '%{SQL-User-Name}' AND M.grupocliente = 'ALL-POPS'"
Tue Feb 4 10:40:53 2020 : Debug: authorize_group_check_query = "SELECT id, groupname, attribute, Value, op FROM radgroupcheck WHERE groupname = '%{SQL-Group}' ORDER BY id"
Tue Feb 4 10:40:53 2020 : Debug: authorize_group_reply_query = "SELECT id, groupname, attribute, value, op FROM radgroupreply WHERE groupname = '%{SQL-Group}' ORDER BY id"
Tue Feb 4 10:40:53 2020 : Debug: group_membership_query = "SELECT groupname FROM radusergroup WHERE username = '%{SQL-User-Name}' ORDER BY priority"
Tue Feb 4 10:40:53 2020 : Debug: simul_count_query = "SELECT COUNT(*) FROM radacct WHERE username = '%{SQL-User-Name}' AND acctstoptime IS NULL AND framedipaddress NOT REGEXP '^10\.'"
Tue Feb 4 10:40:53 2020 : Debug: simul_verify_query = "SELECT radacctid, acctsessionid, username, nasipaddress, nasportid, framedipaddress, callingstationid, framedprotocol FROM radacct WHERE username = '%{SQL-User-Name}' AND acctstoptime IS NULL AND framedipaddress NOT REGEXP '^10\.'"
Tue Feb 4 10:40:53 2020 : Debug: safe_characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /"
Tue Feb 4 10:40:53 2020 : Debug: auto_escape = no
Tue Feb 4 10:40:53 2020 : Debug: accounting {
Tue Feb 4 10:40:53 2020 : Debug: reference = "%{tolower:type.%{%{Acct-Status-Type}:-%{Request-Processing-Stage}}.query}"
Tue Feb 4 10:40:53 2020 : Debug: type {
Tue Feb 4 10:40:53 2020 : Debug: accounting-on {
Tue Feb 4 10:40:53 2020 : Debug: query = "UPDATE radacct SET acctstoptime = FROM_UNIXTIME(%{integer:Event-Timestamp}), acctsessiontime = '%{integer:Event-Timestamp}' - UNIX_TIMESTAMP(acctstarttime), acctterminatecause = '%{%{Acct-Terminate-Cause}:-NAS-Reboot}' WHERE acctstoptime IS NULL AND nasipaddress = '%{NAS-IP-Address}' AND acctstarttime <= FROM_UNIXTIME(%{integer:Event-Timestamp})"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: accounting-off {
Tue Feb 4 10:40:53 2020 : Debug: query = "UPDATE radacct SET acctstoptime = FROM_UNIXTIME(%{integer:Event-Timestamp}), acctsessiontime = '%{integer:Event-Timestamp}' - UNIX_TIMESTAMP(acctstarttime), acctterminatecause = '%{%{Acct-Terminate-Cause}:-NAS-Reboot}' WHERE acctstoptime IS NULL AND nasipaddress = '%{NAS-IP-Address}' AND acctstarttime <= FROM_UNIXTIME(%{integer:Event-Timestamp})"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: start {
Tue Feb 4 10:40:53 2020 : Debug: query = "INSERT INTO radacct (acctsessionid, acctuniqueid, username, realm, nasipaddress, nasportid, nasporttype, acctstarttime, acctupdatetime, acctstoptime, acctsessiontime, acctauthentic, connectinfo_start, connectinfo_stop, acctinputoctets, acctoutputoctets, calledstationid, callingstationid, acctterminatecause, servicetype, framedprotocol, framedipaddress, framedipv6address,framedipv6prefix, framedinterfaceid, delegatedipv6prefix) VALUES ('%{Acct-Session-Id}', '%{Acct-Unique-Session-Id}', '%{SQL-User-Name}', '%{Realm}', '%{NAS-IP-Address}', '%{%{NAS-Port}:-%{NAS-Port-ID}}', '%{NAS-Port-Type}', FROM_UNIXTIME(%{integer:Event-Timestamp}), FROM_UNIXTIME(%{integer:Event-Timestamp}), NULL, '0', '%{Acct-Authentic}', '%{Connect-Info}', '', '0', '0', '%{Called-Station-Id}', '%{Calling-Station-Id}', '', '%{Service-Type}', '%{Framed-Protocol}', '%{Framed-IP-Address}', '%{Framed-IPv6-Address}', '%{Framed-IPv6-Prefix}', '%{Framed-Interface-Id}', '%{Delegated-IPv6-Prefix}')"
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/mods-config/sql/main/mysql/queries.conf[432]: The item '-query' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: interim-update {
Tue Feb 4 10:40:53 2020 : Debug: query = "UPDATE radacct SET acctupdatetime = (@acctupdatetime_old:=acctupdatetime), acctupdatetime = FROM_UNIXTIME(%{integer:Event-Timestamp}), acctinterval = %{integer:Event-Timestamp} - UNIX_TIMESTAMP(@acctupdatetime_old), framedipaddress = '%{Framed-IP-Address}', framedipv6address = '%{Framed-IPv6-Address}', framedipv6prefix = '%{Framed-IPv6-Prefix}', framedinterfaceid = '%{Framed-Interface-Id}', delegatedipv6prefix = '%{Delegated-IPv6-Prefix}', acctsessiontime = %{%{Acct-Session-Time}:-NULL}, acctinputoctets = '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', acctoutputoctets = '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}' WHERE AcctUniqueId = '%{Acct-Unique-Session-Id}'"
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/mods-config/sql/main/mysql/queries.conf[541]: The item '-query' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: stop {
Tue Feb 4 10:40:53 2020 : Debug: query = "UPDATE radacct SET acctstoptime = FROM_UNIXTIME(%{integer:Event-Timestamp}), acctsessiontime = %{%{Acct-Session-Time}:-NULL}, acctinputoctets = '%{%{Acct-Input-Gigawords}:-0}' << 32 | '%{%{Acct-Input-Octets}:-0}', acctoutputoctets = '%{%{Acct-Output-Gigawords}:-0}' << 32 | '%{%{Acct-Output-Octets}:-0}', acctterminatecause = '%{Acct-Terminate-Cause}', connectinfo_stop = '%{Connect-Info}' WHERE AcctUniqueId = '%{Acct-Unique-Session-Id}'"
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/mods-config/sql/main/mysql/queries.conf[633]: The item '-query' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: post-auth {
Tue Feb 4 10:40:53 2020 : Debug: reference = ".query"
Tue Feb 4 10:40:53 2020 : Debug: query = "INSERT INTO radpostauth (username, pass, reply, authdate) VALUES ( '%{SQL-User-Name}', '%{%{User-Password}:-%{Chap-Password}}', '%{reply:Packet-Type}', '%S')"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/mods-enabled/sql[148]: The item 'authreply_table' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Driver rlm_sql_mysql (module rlm_sql_mysql) loaded and linked
Tue Feb 4 10:40:53 2020 : Debug: Creating attribute SQL-Group
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_always, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_always
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "reject" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always reject {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "reject"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "fail" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always fail {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "fail"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "ok" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always ok {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "ok"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "handled" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always handled {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "handled"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "invalid" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always invalid {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "invalid"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "userlock" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always userlock {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "userlock"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "notfound" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always notfound {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "notfound"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "noop" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always noop {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "noop"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "updated" from file /etc/freeradius/mods-enabled/always
Tue Feb 4 10:40:53 2020 : Debug: always updated {
Tue Feb 4 10:40:53 2020 : Debug: rcode = "updated"
Tue Feb 4 10:40:53 2020 : Debug: simulcount = 0
Tue Feb 4 10:40:53 2020 : Debug: mpp = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_exec, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_exec
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "echo" from file /etc/freeradius/mods-enabled/echo
Tue Feb 4 10:40:53 2020 : Debug: exec echo {
Tue Feb 4 10:40:53 2020 : Debug: wait = yes
Tue Feb 4 10:40:53 2020 : Debug: program = "/bin/echo %{User-Name}"
Tue Feb 4 10:40:53 2020 : Debug: input_pairs = "request"
Tue Feb 4 10:40:53 2020 : Debug: output_pairs = "reply"
Tue Feb 4 10:40:53 2020 : Debug: shell_escape = yes
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_utf8, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_utf8
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "utf8" from file /etc/freeradius/mods-enabled/utf8
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_replicate, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_replicate
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "replicate" from file /etc/freeradius/mods-enabled/replicate
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "ntlm_auth" from file /etc/freeradius/mods-enabled/ntlm_auth
Tue Feb 4 10:40:53 2020 : Debug: exec ntlm_auth {
Tue Feb 4 10:40:53 2020 : Debug: wait = yes
Tue Feb 4 10:40:53 2020 : Debug: program = "/path/to/ntlm_auth --request-nt-key --domain=MYDOMAIN --username=%{mschap:User-Name} --password=%{User-Password}"
Tue Feb 4 10:40:53 2020 : Debug: shell_escape = yes
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_pap, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_pap
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "pap" from file /etc/freeradius/mods-enabled/pap
Tue Feb 4 10:40:53 2020 : Debug: pap {
Tue Feb 4 10:40:53 2020 : Debug: normalise = yes
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_realm, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_realm
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "IPASS" from file /etc/freeradius/mods-enabled/realm
Tue Feb 4 10:40:53 2020 : Debug: realm IPASS {
Tue Feb 4 10:40:53 2020 : Debug: format = "prefix"
Tue Feb 4 10:40:53 2020 : Debug: delimiter = "/"
Tue Feb 4 10:40:53 2020 : Debug: ignore_default = no
Tue Feb 4 10:40:53 2020 : Debug: ignore_null = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "suffix" from file /etc/freeradius/mods-enabled/realm
Tue Feb 4 10:40:53 2020 : Debug: realm suffix {
Tue Feb 4 10:40:53 2020 : Debug: format = "suffix"
Tue Feb 4 10:40:53 2020 : Debug: delimiter = "@"
Tue Feb 4 10:40:53 2020 : Debug: ignore_default = no
Tue Feb 4 10:40:53 2020 : Debug: ignore_null = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "bangpath" from file /etc/freeradius/mods-enabled/realm
Tue Feb 4 10:40:53 2020 : Debug: realm bangpath {
Tue Feb 4 10:40:53 2020 : Debug: format = "prefix"
Tue Feb 4 10:40:53 2020 : Debug: delimiter = "!"
Tue Feb 4 10:40:53 2020 : Debug: ignore_default = no
Tue Feb 4 10:40:53 2020 : Debug: ignore_null = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "realmpercent" from file /etc/freeradius/mods-enabled/realm
Tue Feb 4 10:40:53 2020 : Debug: realm realmpercent {
Tue Feb 4 10:40:53 2020 : Debug: format = "suffix"
Tue Feb 4 10:40:53 2020 : Debug: delimiter = "%"
Tue Feb 4 10:40:53 2020 : Debug: ignore_default = no
Tue Feb 4 10:40:53 2020 : Debug: ignore_null = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "ntdomain" from file /etc/freeradius/mods-enabled/realm
Tue Feb 4 10:40:53 2020 : Debug: realm ntdomain {
Tue Feb 4 10:40:53 2020 : Debug: format = "prefix"
Tue Feb 4 10:40:53 2020 : Debug: delimiter = "\\"
Tue Feb 4 10:40:53 2020 : Debug: ignore_default = no
Tue Feb 4 10:40:53 2020 : Debug: ignore_null = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_files, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_files
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "files" from file /etc/freeradius/mods-enabled/files
Tue Feb 4 10:40:53 2020 : Debug: files {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/freeradius/mods-config/files/authorize"
Tue Feb 4 10:40:53 2020 : Debug: acctusersfile = "/etc/freeradius/mods-config/files/accounting"
Tue Feb 4 10:40:53 2020 : Debug: preproxy_usersfile = "/etc/freeradius/mods-config/files/pre-proxy"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_attr_filter, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_attr_filter
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "attr_filter.post-proxy" from file /etc/freeradius/mods-enabled/attr_filter
Tue Feb 4 10:40:53 2020 : Debug: attr_filter attr_filter.post-proxy {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/freeradius/mods-config/attr_filter/post-proxy"
Tue Feb 4 10:40:53 2020 : Debug: key = "%{Realm}"
Tue Feb 4 10:40:53 2020 : Debug: relaxed = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "attr_filter.pre-proxy" from file /etc/freeradius/mods-enabled/attr_filter
Tue Feb 4 10:40:53 2020 : Debug: attr_filter attr_filter.pre-proxy {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/freeradius/mods-config/attr_filter/pre-proxy"
Tue Feb 4 10:40:53 2020 : Debug: key = "%{Realm}"
Tue Feb 4 10:40:53 2020 : Debug: relaxed = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "attr_filter.access_reject" from file /etc/freeradius/mods-enabled/attr_filter
Tue Feb 4 10:40:53 2020 : Debug: attr_filter attr_filter.access_reject {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/freeradius/mods-config/attr_filter/access_reject"
Tue Feb 4 10:40:53 2020 : Debug: key = "%{User-Name}"
Tue Feb 4 10:40:53 2020 : Debug: relaxed = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "attr_filter.access_challenge" from file /etc/freeradius/mods-enabled/attr_filter
Tue Feb 4 10:40:53 2020 : Debug: attr_filter attr_filter.access_challenge {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/freeradius/mods-config/attr_filter/access_challenge"
Tue Feb 4 10:40:53 2020 : Debug: key = "%{User-Name}"
Tue Feb 4 10:40:53 2020 : Debug: relaxed = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "attr_filter.accounting_response" from file /etc/freeradius/mods-enabled/attr_filter
Tue Feb 4 10:40:53 2020 : Debug: attr_filter attr_filter.accounting_response {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/freeradius/mods-config/attr_filter/accounting_response"
Tue Feb 4 10:40:53 2020 : Debug: key = "%{User-Name}"
Tue Feb 4 10:40:53 2020 : Debug: relaxed = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_date, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_date
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "date" from file /etc/freeradius/mods-enabled/date
Tue Feb 4 10:40:53 2020 : Debug: date {
Tue Feb 4 10:40:53 2020 : Debug: format = "%b %e %Y %H:%M:%S %Z"
Tue Feb 4 10:40:53 2020 : Debug: utc = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "wispr2date" from file /etc/freeradius/mods-enabled/date
Tue Feb 4 10:40:53 2020 : Debug: date wispr2date {
Tue Feb 4 10:40:53 2020 : Debug: format = "%Y-%m-%dT%H:%M:%S"
Tue Feb 4 10:40:53 2020 : Debug: utc = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_mschap, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_mschap
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "mschap" from file /etc/freeradius/mods-enabled/mschap
Tue Feb 4 10:40:53 2020 : Debug: mschap {
Tue Feb 4 10:40:53 2020 : Debug: use_mppe = yes
Tue Feb 4 10:40:53 2020 : Debug: require_encryption = no
Tue Feb 4 10:40:53 2020 : Debug: require_strong = no
Tue Feb 4 10:40:53 2020 : Debug: with_ntdomain_hack = yes
Tue Feb 4 10:40:53 2020 : Debug: passchange {
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: allow_retry = yes
Tue Feb 4 10:40:53 2020 : Debug: winbind_retry_with_normalised_username = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_passwd, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_passwd
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "etc_passwd" from file /etc/freeradius/mods-enabled/passwd
Tue Feb 4 10:40:53 2020 : Debug: passwd etc_passwd {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/etc/passwd"
Tue Feb 4 10:40:53 2020 : Debug: format = "*User-Name:Crypt-Password:"
Tue Feb 4 10:40:53 2020 : Debug: delimiter = ":"
Tue Feb 4 10:40:53 2020 : Debug: ignore_nislike = no
Tue Feb 4 10:40:53 2020 : Debug: ignore_empty = yes
Tue Feb 4 10:40:53 2020 : Debug: allow_multiple_keys = no
Tue Feb 4 10:40:53 2020 : Debug: hash_size = 100
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "exec" from file /etc/freeradius/mods-enabled/exec
Tue Feb 4 10:40:53 2020 : Debug: exec {
Tue Feb 4 10:40:53 2020 : Debug: wait = no
Tue Feb 4 10:40:53 2020 : Debug: input_pairs = "request"
Tue Feb 4 10:40:53 2020 : Debug: shell_escape = yes
Tue Feb 4 10:40:53 2020 : Debug: timeout = 10
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_sqlippool, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_sqlippool
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "sqlippool" from file /etc/freeradius/mods-enabled/sqlippool
Tue Feb 4 10:40:53 2020 : Debug: sqlippool {
Tue Feb 4 10:40:53 2020 : Debug: sql_module_instance = "sql"
Tue Feb 4 10:40:53 2020 : Debug: lease_duration = 3600
Tue Feb 4 10:40:53 2020 : Debug: pool_name = "Pool-Name"
Tue Feb 4 10:40:53 2020 : Debug: default_pool = "main_pool"
Tue Feb 4 10:40:53 2020 : Debug: attribute_name = "Framed-IP-Address"
Tue Feb 4 10:40:53 2020 : Debug: allocate_begin = "START TRANSACTION"
Tue Feb 4 10:40:53 2020 : Debug: allocate_clear = "UPDATE radippool SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '', expiry_time = NULL WHERE expiry_time <= NOW() - INTERVAL 1 SECOND AND nasipaddress = '%{%{Nas-IP-Address}:-%{Nas-IPv6-Address}}'"
Tue Feb 4 10:40:53 2020 : Debug: allocate_clear_timeout = 1
Tue Feb 4 10:40:53 2020 : Debug: allocate_find = "SELECT framedipaddress FROM radippool WHERE pool_name = '%{control:Pool-Name}' AND (expiry_time < NOW() OR expiry_time IS NULL) ORDER BY (username <> '%{User-Name}'), (callingstationid <> '%{Calling-Station-Id}'), expiry_time LIMIT 1 FOR UPDATE"
Tue Feb 4 10:40:53 2020 : Debug: allocate_update = "UPDATE radippool SET nasipaddress = '%{NAS-IP-Address}', pool_key = '%{Calling-Station-Id}', callingstationid = '%{Calling-Station-Id}', username = '%{User-Name}', expiry_time = NOW() + INTERVAL 3600 SECOND WHERE framedipaddress = '%I' AND expiry_time IS NULL"
Tue Feb 4 10:40:53 2020 : Debug: allocate_commit = "COMMIT"
Tue Feb 4 10:40:53 2020 : Debug: pool_check = "SELECT id FROM radippool WHERE pool_name='%{control:Pool-Name}' LIMIT 1"
Tue Feb 4 10:40:53 2020 : Debug: start_begin = "START TRANSACTION"
Tue Feb 4 10:40:53 2020 : Debug: start_update = "UPDATE radippool SET expiry_time = NOW() + INTERVAL 3600 SECOND WHERE nasipaddress = '%{NAS-IP-Address}' AND pool_key = '%{Calling-Station-Id}' AND username = '%{User-Name}' AND callingstationid = '%{Calling-Station-Id}' AND framedipaddress = '%{Framed-IP-Address}'"
Tue Feb 4 10:40:53 2020 : Debug: start_commit = "COMMIT"
Tue Feb 4 10:40:53 2020 : Debug: alive_begin = "START TRANSACTION"
Tue Feb 4 10:40:53 2020 : Debug: alive_update = "UPDATE radippool SET expiry_time = NOW() + INTERVAL 3600 SECOND WHERE nasipaddress = '%{%{Nas-IP-Address}:-%{Nas-IPv6-Address}}' AND pool_key = '%{Calling-Station-Id}' AND username = '%{User-Name}' AND callingstationid = '%{Calling-Station-Id}' AND framedipaddress = '%{Framed-IP-Address}'"
Tue Feb 4 10:40:53 2020 : Debug: alive_commit = "COMMIT"
Tue Feb 4 10:40:53 2020 : Debug: stop_begin = "START TRANSACTION"
Tue Feb 4 10:40:53 2020 : Debug: stop_clear = "UPDATE radippool SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '', expiry_time = NULL WHERE nasipaddress = '%{%{Nas-IP-Address}:-%{Nas-IPv6-Address}}' AND pool_key = '%{Calling-Station-Id}' AND username = '%{User-Name}' AND callingstationid = '%{Calling-Station-Id}' AND framedipaddress = '%{Framed-IP-Address}'"
Tue Feb 4 10:40:53 2020 : Debug: stop_commit = "COMMIT"
Tue Feb 4 10:40:53 2020 : Debug: on_begin = "START TRANSACTION"
Tue Feb 4 10:40:53 2020 : Debug: on_clear = "UPDATE radippool SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '', expiry_time = NULL WHERE nasipaddress = '%{%{Nas-IP-Address}:-%{Nas-IPv6-Address}}'"
Tue Feb 4 10:40:53 2020 : Debug: on_commit = "COMMIT"
Tue Feb 4 10:40:53 2020 : Debug: off_begin = "START TRANSACTION"
Tue Feb 4 10:40:53 2020 : Debug: off_clear = "UPDATE radippool SET nasipaddress = '', pool_key = 0, callingstationid = '', username = '', expiry_time = NULL WHERE nasipaddress = '%{%{Nas-IP-Address}:-%{Nas-IPv6-Address}}'"
Tue Feb 4 10:40:53 2020 : Debug: off_commit = "COMMIT"
Tue Feb 4 10:40:53 2020 : Debug: messages {
Tue Feb 4 10:40:53 2020 : Debug: exists = "Existing IP: %{reply:Framed-IP-Address} (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
Tue Feb 4 10:40:53 2020 : Debug: 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})"
Tue Feb 4 10:40:53 2020 : Debug: clear = "Released IP Framed-IP-Address (did %{Called-Station-Id} cli %{Calling-Station-Id} user %{User-Name})"
Tue Feb 4 10:40:53 2020 : Debug: failed = "IP Allocation FAILED from %{control:Pool-Name} (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
Tue Feb 4 10:40:53 2020 : Debug: nopool = "No Pool-Name defined (did %{Called-Station-Id} cli %{Calling-Station-Id} port %{NAS-Port} user %{User-Name})"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_chap, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_chap
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "chap" from file /etc/freeradius/mods-enabled/chap
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_preprocess, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_preprocess
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "preprocess" from file /etc/freeradius/mods-enabled/preprocess
Tue Feb 4 10:40:53 2020 : Debug: preprocess {
Tue Feb 4 10:40:53 2020 : Debug: huntgroups = "/etc/freeradius/mods-config/preprocess/huntgroups"
Tue Feb 4 10:40:53 2020 : Debug: hints = "/etc/freeradius/mods-config/preprocess/hints"
Tue Feb 4 10:40:53 2020 : Debug: with_ascend_hack = no
Tue Feb 4 10:40:53 2020 : Debug: ascend_channels_per_line = 23
Tue Feb 4 10:40:53 2020 : Debug: with_ntdomain_hack = no
Tue Feb 4 10:40:53 2020 : Debug: with_specialix_jetstream_hack = no
Tue Feb 4 10:40:53 2020 : Debug: with_cisco_vsa_hack = no
Tue Feb 4 10:40:53 2020 : Debug: with_alvarion_vsa_hack = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_expr, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_expr
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "expr" from file /etc/freeradius/mods-enabled/expr
Tue Feb 4 10:40:53 2020 : Debug: expr {
Tue Feb 4 10:40:53 2020 : Debug: safe_characters = "@abcdefghijklmnopqrstuvwxyzABCDEFGHIJKLMNOPQRSTUVWXYZ0123456789.-_: /äéöüàâæçèéêëîïôœùûüaÿÄÉÖÜßÀÂÆÇÈÉÊËÎÏÔŒÙÛÜŸ"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_expiration, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_expiration
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "expiration" from file /etc/freeradius/mods-enabled/expiration
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_unpack, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_unpack
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "unpack" from file /etc/freeradius/mods-enabled/unpack
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_dynamic_clients, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_dynamic_clients
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "dynamic_clients" from file /etc/freeradius/mods-enabled/dynamic_clients
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_linelog, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_linelog
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "linelog" from file /etc/freeradius/mods-enabled/linelog
Tue Feb 4 10:40:53 2020 : Debug: linelog {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/var/log/freeradius/radius.log"
Tue Feb 4 10:40:53 2020 : Debug: escape_filenames = no
Tue Feb 4 10:40:53 2020 : Debug: syslog_severity = "info"
Tue Feb 4 10:40:53 2020 : Debug: permissions = 384
Tue Feb 4 10:40:53 2020 : Debug: format = "This is a log message for %{User-Name}"
Tue Feb 4 10:40:53 2020 : Debug: reference = "messages.%{%{reply:Packet-Type}:-default}"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "log_accounting" from file /etc/freeradius/mods-enabled/linelog
Tue Feb 4 10:40:53 2020 : Debug: linelog log_accounting {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/var/log/freeradius/radius.log"
Tue Feb 4 10:40:53 2020 : Debug: escape_filenames = no
Tue Feb 4 10:40:53 2020 : Debug: syslog_severity = "info"
Tue Feb 4 10:40:53 2020 : Debug: permissions = 384
Tue Feb 4 10:40:53 2020 : Debug: format = ""
Tue Feb 4 10:40:53 2020 : Debug: reference = "Accounting-Request.%{%{Acct-Status-Type}:-unknown}"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "log_post_auth" from file /etc/freeradius/mods-enabled/linelog
Tue Feb 4 10:40:53 2020 : Debug: linelog log_post_auth {
Tue Feb 4 10:40:53 2020 : Debug: filename = "/var/log/freeradius/radius.log"
Tue Feb 4 10:40:53 2020 : Debug: escape_filenames = no
Tue Feb 4 10:40:53 2020 : Debug: syslog_severity = "info"
Tue Feb 4 10:40:53 2020 : Debug: permissions = 384
Tue Feb 4 10:40:53 2020 : Debug: reference = "%{reply:Packet-Type}"
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/mods-enabled/linelog[176]: The item 'Access-Accept' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Warning: /etc/freeradius/mods-enabled/linelog[177]: The item 'Access-Reject' is defined, but is unused by the configuration
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_soh, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_soh
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "soh" from file /etc/freeradius/mods-enabled/soh
Tue Feb 4 10:40:53 2020 : Debug: soh {
Tue Feb 4 10:40:53 2020 : Debug: dhcp = yes
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: Loaded rlm_logintime, checking if it's valid
Tue Feb 4 10:40:53 2020 : Debug: # Loaded module rlm_logintime
Tue Feb 4 10:40:53 2020 : Debug: # Loading module "logintime" from file /etc/freeradius/mods-enabled/logintime
Tue Feb 4 10:40:53 2020 : Debug: logintime {
Tue Feb 4 10:40:53 2020 : Debug: minimum_timeout = 60
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: instantiate {
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: # Instantiating module "sql" from file /etc/freeradius/mods-enabled/sql
Tue Feb 4 10:40:53 2020 : Info: rlm_sql_mysql: libmysql version: 5.7.29
Tue Feb 4 10:40:53 2020 : Debug: mysql {
Tue Feb 4 10:40:53 2020 : Debug: tls {
Tue Feb 4 10:40:53 2020 : Debug: tls_required = no
Tue Feb 4 10:40:53 2020 : Debug: check_cert = no
Tue Feb 4 10:40:53 2020 : Debug: check_cert_cn = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Debug: warnings = "auto"
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Attempting to connect to database "mpc_freeradius"
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Initialising connection pool
Tue Feb 4 10:40:53 2020 : Debug: pool {
Tue Feb 4 10:40:53 2020 : Debug: start = 5
Tue Feb 4 10:40:53 2020 : Debug: min = 3
Tue Feb 4 10:40:53 2020 : Debug: max = 32
Tue Feb 4 10:40:53 2020 : Debug: spare = 10
Tue Feb 4 10:40:53 2020 : Debug: uses = 0
Tue Feb 4 10:40:53 2020 : Debug: lifetime = 60
Tue Feb 4 10:40:53 2020 : Debug: cleanup_interval = 30
Tue Feb 4 10:40:53 2020 : Debug: idle_timeout = 60
Tue Feb 4 10:40:53 2020 : Debug: retry_delay = 30
Tue Feb 4 10:40:53 2020 : Debug: spread = no
Tue Feb 4 10:40:53 2020 : Debug: }
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Opening additional connection (0), 1 of 32 pending slots used
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Starting connect to MySQL server
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Connected to database 'mpc_freeradius' on mysql.mpc.com.br via TCP/IP, server version 5.7.27-0ubuntu0.16.04.1-log, protocol version 10
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Opening additional connection (1), 1 of 31 pending slots used
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Starting connect to MySQL server
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Connected to database 'mpc_freeradius' on mysql.mpc.com.br via TCP/IP, server version 5.7.27-0ubuntu0.16.04.1-log, protocol version 10
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Opening additional connection (2), 1 of 30 pending slots used
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Starting connect to MySQL server
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Connected to database 'mpc_freeradius' on mysql.mpc.com.br via TCP/IP, server version 5.7.27-0ubuntu0.16.04.1-log, protocol version 10
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Opening additional connection (3), 1 of 29 pending slots used
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Starting connect to MySQL server
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Connected to database 'mpc_freeradius' on mysql.mpc.com.br via TCP/IP, server version 5.7.27-0ubuntu0.16.04.1-log, protocol version 10
Tue Feb 4 10:40:53 2020 : Info: rlm_sql (sql): Opening additional connection (4), 1 of 28 pending slots used
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Starting connect to MySQL server
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql_mysql: Connected to database 'mpc_freeradius' on mysql.mpc.com.br via TCP/IP, server version 5.7.27-0ubuntu0.16.04.1-log, protocol version 10
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Processing generate_sql_clients
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql) in generate_sql_clients: query is SELECT id, nasname, shortname, type, secret, server FROM nas
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Reserved connection (0)
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Executing select query: SELECT id, nasname, shortname, type, secret, server FROM nas
Tue Feb 4 10:40:53 2020 : Debug: rlm_sql (sql): Adding client 127.0.0.1 (Local Host) to global clients list
Tue Feb 4 10:40:53 2020 : Debug: Adding client 127.0.0.1/32 (127.0.0.1) to prefix tree 32
Tue Feb 4 10:40:53 2020 : Error: Failed to add duplicate client Local Host
Tue Feb 4 10:40:53 2020 : Warning: Failed to add client, possible duplicate?
Bad talloc magic value - unknown value
talloc abort: Bad talloc magic value - unknown value
Aborted (core dumped)
More information about the Freeradius-Users
mailing list