rlm_python works in -X, fatal signal when started using systemctl (pRet is NULL)
Jonathan Davis
jonathan at prioritycolo.com
Fri Nov 19 23:13:31 CET 2021
I'm running into a couple of different problems which muddies the issue.
Below is the current output of freeradius -Xx but I'm unable to get the
example working under 3.0.25-2
When I symlink python3 to mods-enabled, I get the following error:
Fri Nov 19 21:56:41 2021 : Error:
/etc/freeradius/mods-enabled/python3[9]: Failed to link to module
'rlm_python3': /usr/lib/freeradius/rlm_python3.so: cannot open shared
object file: No such file or directory
Which is true, in that dir there is only rlm_python.so
apt list | grep freeradius gives:
argonaut-freeradius/focal 1.3-2 all
freeradius-common/focal,now 3.0.25-2 all [installed,automatic]
freeradius-config/focal,now 3.0.25-2 amd64 [installed,automatic]
freeradius-dbg/focal 3.0.25-2 amd64
freeradius-dhcp/focal 3.0.25-2 amd64
freeradius-iodbc/focal 3.0.25-2 amd64
freeradius-krb5/focal 3.0.25-2 amd64
freeradius-ldap/focal 3.0.25-2 amd64
freeradius-memcached/focal 3.0.25-2 amd64
freeradius-mysql/focal 3.0.25-2 amd64
freeradius-perl-util/focal 3.0.25-2 amd64
freeradius-postgresql/focal 3.0.25-2 amd64
freeradius-python3/focal 3.0.20+dfsg-3build1 amd64
freeradius-redis/focal 3.0.25-2 amd64
freeradius-rest/focal 3.0.25-2 amd64
freeradius-utils/focal,now 3.0.25-2 amd64 [installed,automatic]
freeradius-yubikey/focal 3.0.25-2 amd64
freeradius/focal,now 3.0.25-2 amd64 [installed]
fusiondirectory-plugin-freeradius-schema/focal 1.3-2 all
fusiondirectory-plugin-freeradius/focal 1.3-2 all
libfreeradius-dev/focal 3.0.25-2 amd64
libfreeradius3/focal,now 3.0.25-2 amd64 [installed,automatic]
Originally under the package of 3.0.20 installed under Ubuntu was where
the title of this thread came from, with the suggestion to upgrade to
the networkfradius version 3.0.25-2. (which I originally boched a little).
The original freeradius -Xx I can dig up, here is current which is
producing the 'rlm_python3' error:
root at radius-2:/etc/freeradius/mods-enabled# freeradius -Xx
Fri Nov 19 21:56:41 2021 : Debug: Server was built with:
Fri Nov 19 21:56:41 2021 : Debug: accounting : yes
Fri Nov 19 21:56:41 2021 : Debug: authentication : yes
Fri Nov 19 21:56:41 2021 : Debug: ascend-binary-attributes : yes
Fri Nov 19 21:56:41 2021 : Debug: coa : yes
Fri Nov 19 21:56:41 2021 : Debug: recv-coa-from-home-server : no
Fri Nov 19 21:56:41 2021 : Debug: control-socket : yes
Fri Nov 19 21:56:41 2021 : Debug: detail : yes
Fri Nov 19 21:56:41 2021 : Debug: dhcp : yes
Fri Nov 19 21:56:41 2021 : Debug: dynamic-clients : yes
Fri Nov 19 21:56:41 2021 : Debug: osfc2 : no
Fri Nov 19 21:56:41 2021 : Debug: proxy : yes
Fri Nov 19 21:56:41 2021 : Debug: regex-pcre : no
Fri Nov 19 21:56:41 2021 : Debug: regex-posix : yes
Fri Nov 19 21:56:41 2021 : Debug: regex-posix-extended : yes
Fri Nov 19 21:56:41 2021 : Debug: session-management : yes
Fri Nov 19 21:56:41 2021 : Debug: stats : yes
Fri Nov 19 21:56:41 2021 : Debug: systemd : yes
Fri Nov 19 21:56:41 2021 : Debug: tcp : yes
Fri Nov 19 21:56:41 2021 : Debug: threads : yes
Fri Nov 19 21:56:41 2021 : Debug: tls : yes
Fri Nov 19 21:56:41 2021 : Debug: unlang : yes
Fri Nov 19 21:56:41 2021 : Debug: vmps : yes
Fri Nov 19 21:56:41 2021 : Debug: developer : no
Fri Nov 19 21:56:41 2021 : Debug: Server core libs:
Fri Nov 19 21:56:41 2021 : Debug: freeradius-server : 3.0.25
Fri Nov 19 21:56:41 2021 : Debug: talloc : 2.3.*
Fri Nov 19 21:56:41 2021 : Debug: ssl : 1.1.1f
release
Fri Nov 19 21:56:41 2021 : Debug: Endianness:
Fri Nov 19 21:56:41 2021 : Debug: little
Fri Nov 19 21:56:41 2021 : Debug: Compilation flags:
Fri Nov 19 21:56:41 2021 : Debug: cppflags : -Wdate-time
-D_FORTIFY_SOURCE=2
Fri Nov 19 21:56:41 2021 : 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
-fdebug-prefix-map=/srv/jenkins/workspace/freeradius-release-3.0/build-packages/platforms/ubuntu20/freeradius-server=.
-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
Fri Nov 19 21:56:41 2021 : Debug: ldflags : -Wl,-Bsymbolic-functions
-Wl,-z,relro -Wl,-z,now
Fri Nov 19 21:56:41 2021 : Debug: libs : -lcrypto -lssl -ltalloc
-latomic -lcap -lnsl -lresolv -ldl -lpthread -lreadline
Fri Nov 19 21:56:41 2021 : Debug:
Fri Nov 19 21:56:41 2021 : Info: FreeRADIUS Version 3.0.25
Fri Nov 19 21:56:41 2021 : Info: Copyright (C) 1999-2021 The FreeRADIUS
server project and contributors
Fri Nov 19 21:56:41 2021 : Info: There is NO warranty; not even for
MERCHANTABILITY or FITNESS FOR A
Fri Nov 19 21:56:41 2021 : Info: PARTICULAR PURPOSE
Fri Nov 19 21:56:41 2021 : Info: You may redistribute copies of
FreeRADIUS under the terms of the
Fri Nov 19 21:56:41 2021 : Info: GNU General Public License
Fri Nov 19 21:56:41 2021 : Info: For more information about these
matters, see the file named COPYRIGHT
Fri Nov 19 21:56:41 2021 : Info: Starting - reading configuration files ...
Fri Nov 19 21:56:41 2021 : Debug: including dictionary file
/usr/share/freeradius/dictionary
Fri Nov 19 21:56:41 2021 : Debug: including dictionary file
/usr/share/freeradius/dictionary.dhcp
Fri Nov 19 21:56:41 2021 : Debug: including dictionary file
/usr/share/freeradius/dictionary.vqp
Fri Nov 19 21:56:41 2021 : Debug: including dictionary file
/etc/freeradius/dictionary
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/radiusd.conf
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/clients.conf
Fri Nov 19 21:56:41 2021 : Debug: including files in directory
/etc/freeradius/clients/
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/clients/raritans.conf
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/clients/sc.conf
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/clients/linux-servers.conf
Fri Nov 19 21:56:41 2021 : Debug: including files in directory
/etc/freeradius/mods-enabled/
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/sradutmp
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/pap
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/preprocess
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/logintime
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/passwd
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/unpack
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/detail.log
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/date
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/soh
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/totp
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/utf8
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/detail
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/python3
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/radutmp
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/realm
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/linelog
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/sql
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-config/sql/main/sqlite/queries.conf
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-config/sql/main/sqlite/queries.conf
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-config/sql/main/sqlite/queries.conf
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/dynamic_clients
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/replicate
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/digest
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/pam
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/unix
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/files
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/mods-enabled/expr
Fri Nov 19 21:56:41 2021 : Debug: including files in directory
/etc/freeradius/policy.d/
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/rfc7542
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/eap
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/operator-name
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/abfab-tr
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/dhcp
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/filter
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/accounting
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/debug
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/cui
Fri Nov 19 21:56:41 2021 : Debug: OPTIMIZING
(${policy.cui_require_operator_name} == yes) --> FALSE
Fri Nov 19 21:56:41 2021 : Debug: OPTIMIZING (no == yes) --> FALSE
Fri Nov 19 21:56:41 2021 : Debug: OPTIMIZING
(${policy.cui_require_operator_name} == yes) --> FALSE
Fri Nov 19 21:56:41 2021 : Debug: OPTIMIZING (no == yes) --> FALSE
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/canonicalization
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/moonshot-targeted-ids
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/policy.d/control
Fri Nov 19 21:56:41 2021 : Debug: including files in directory
/etc/freeradius/sites-enabled/
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/sites-enabled/default
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/sites-enabled/linux-servers
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/sites-enabled/sc
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/sites-enabled/raritans
Fri Nov 19 21:56:41 2021 : Debug: including configuration file
/etc/freeradius/sites-enabled/inner-tunnel
Fri Nov 19 21:56:41 2021 : Debug: main {
Fri Nov 19 21:56:41 2021 : Debug: security {
Fri Nov 19 21:56:41 2021 : Debug: user = "root"
Fri Nov 19 21:56:41 2021 : Debug: group = "root"
Fri Nov 19 21:56:41 2021 : Debug: allow_core_dumps = no
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[559]:
The item 'max_attributes' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[576]:
The item 'reject_delay' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[596]:
The item 'status_server' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: name = "freeradius"
Fri Nov 19 21:56:41 2021 : Debug: prefix = "/usr"
Fri Nov 19 21:56:41 2021 : Debug: localstatedir = "/var"
Fri Nov 19 21:56:41 2021 : Debug: logdir = "/var/log/freeradius"
Fri Nov 19 21:56:41 2021 : Debug: run_dir = "/var/run/freeradius"
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[85]:
The item 'sysconfdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[97]:
The item 'confdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[99]:
The item 'certdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[100]:
The item 'cadir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[104]:
The item 'db_dir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[138]:
The item 'libdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[149]:
The item 'pidfile' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[170]:
The item 'correct_escapes' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[224]:
The item 'max_request_time' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[243]:
The item 'cleanup_delay' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[262]:
The item 'max_requests' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[280]:
The item 'hostname_lookups' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[413]:
The item 'checkrad' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[617]:
The item 'proxy_requests' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: main {
Fri Nov 19 21:56:41 2021 : Debug: name = "freeradius"
Fri Nov 19 21:56:41 2021 : Debug: prefix = "/usr"
Fri Nov 19 21:56:41 2021 : Debug: localstatedir = "/var"
Fri Nov 19 21:56:41 2021 : Debug: sbindir = "/usr/sbin"
Fri Nov 19 21:56:41 2021 : Debug: logdir = "/var/log/freeradius"
Fri Nov 19 21:56:41 2021 : Debug: run_dir = "/var/run/freeradius"
Fri Nov 19 21:56:41 2021 : Debug: libdir = "/usr/lib/freeradius"
Fri Nov 19 21:56:41 2021 : Debug: radacctdir =
"/var/log/freeradius/radacct"
Fri Nov 19 21:56:41 2021 : Debug: hostname_lookups = no
Fri Nov 19 21:56:41 2021 : Debug: max_request_time = 5
Fri Nov 19 21:56:41 2021 : Debug: cleanup_delay = 5
Fri Nov 19 21:56:41 2021 : Debug: max_requests = 16384
Fri Nov 19 21:56:41 2021 : Debug: postauth_client_lost = no
Fri Nov 19 21:56:41 2021 : Debug: pidfile =
"/var/run/freeradius/freeradius.pid"
Fri Nov 19 21:56:41 2021 : Debug: checkrad = "/usr/sbin/checkrad"
Fri Nov 19 21:56:41 2021 : Debug: debug_level = 0
Fri Nov 19 21:56:41 2021 : Debug: proxy_requests = no
Fri Nov 19 21:56:41 2021 : Debug: log {
Fri Nov 19 21:56:41 2021 : Debug: stripped_names = no
Fri Nov 19 21:56:41 2021 : Debug: auth = no
Fri Nov 19 21:56:41 2021 : Debug: auth_accept = no
Fri Nov 19 21:56:41 2021 : Debug: auth_badpass = no
Fri Nov 19 21:56:41 2021 : Debug: auth_goodpass = no
Fri Nov 19 21:56:41 2021 : Debug: colourise = yes
Fri Nov 19 21:56:41 2021 : Debug: msg_denied = "You are already
logged in - access denied"
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[309]:
The item 'destination' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[326]:
The item 'file' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[334]:
The item 'syslog_facility' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: resources {
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: security {
Fri Nov 19 21:56:41 2021 : Debug: max_attributes = 200
Fri Nov 19 21:56:41 2021 : Debug: reject_delay = 0.200000
Fri Nov 19 21:56:41 2021 : Debug: status_server = yes
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[85]:
The item 'sysconfdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[97]:
The item 'confdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[99]:
The item 'certdir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[100]:
The item 'cadir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[104]:
The item 'db_dir' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Warning: /etc/freeradius/radiusd.conf[170]:
The item 'correct_escapes' is defined, but is unused by the configuration
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Warning: Ignoring "reject_delay = 0.200000",
forcing to "reject_delay = 1.000000"
Fri Nov 19 21:56:41 2021 : Debug: radiusd: #### Loading Realms and Home
Servers ####
Fri Nov 19 21:56:41 2021 : Debug: radiusd: #### Loading Clients ####
Fri Nov 19 21:56:41 2021 : Debug: client localhost {
Fri Nov 19 21:56:41 2021 : Debug: ipaddr = 127.0.0.1
Fri Nov 19 21:56:41 2021 : Debug: require_message_authenticator = no
Fri Nov 19 21:56:41 2021 : Debug: secret = "testing123"
Fri Nov 19 21:56:41 2021 : Debug: nas_type = "other"
Fri Nov 19 21:56:41 2021 : Debug: proto = "*"
Fri Nov 19 21:56:41 2021 : Debug: limit {
Fri Nov 19 21:56:41 2021 : Debug: max_connections = 16
Fri Nov 19 21:56:41 2021 : Debug: lifetime = 0
Fri Nov 19 21:56:41 2021 : Debug: idle_timeout = 30
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Adding client 127.0.0.1/32 (127.0.0.1)
to prefix tree 32
Fri Nov 19 21:56:41 2021 : Debug: client localhost_ipv6 {
Fri Nov 19 21:56:41 2021 : Debug: ipv6addr = ::1
Fri Nov 19 21:56:41 2021 : Debug: require_message_authenticator = no
Fri Nov 19 21:56:41 2021 : Debug: secret = "testing123"
Fri Nov 19 21:56:41 2021 : Debug: limit {
Fri Nov 19 21:56:41 2021 : Debug: max_connections = 16
Fri Nov 19 21:56:41 2021 : Debug: lifetime = 0
Fri Nov 19 21:56:41 2021 : Debug: idle_timeout = 30
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Info: Debugger not attached
Fri Nov 19 21:56:41 2021 : Info: systemd watchdog is disabled
Fri Nov 19 21:56:41 2021 : Debug: # Creating Auth-Type = PAP
Fri Nov 19 21:56:41 2021 : Debug: # Creating Autz-Type = New-TLS-Connection
Fri Nov 19 21:56:41 2021 : Debug: # Creating Auth-Type = pam
Fri Nov 19 21:56:41 2021 : Debug: radiusd: #### Instantiating modules ####
Fri Nov 19 21:56:41 2021 : Debug: modules {
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_radutmp, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_radutmp
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "sradutmp" from
file /etc/freeradius/mods-enabled/sradutmp
Fri Nov 19 21:56:41 2021 : Debug: radutmp sradutmp {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/var/log/freeradius/sradutmp"
Fri Nov 19 21:56:41 2021 : Debug: username = "%{User-Name}"
Fri Nov 19 21:56:41 2021 : Debug: case_sensitive = yes
Fri Nov 19 21:56:41 2021 : Debug: check_with_nas = yes
Fri Nov 19 21:56:41 2021 : Debug: permissions = 420
Fri Nov 19 21:56:41 2021 : Debug: caller_id = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_pap, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_pap
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "pap" from file
/etc/freeradius/mods-enabled/pap
Fri Nov 19 21:56:41 2021 : Debug: pap {
Fri Nov 19 21:56:41 2021 : Debug: normalise = yes
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_preprocess, checking if
it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_preprocess
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "preprocess" from
file /etc/freeradius/mods-enabled/preprocess
Fri Nov 19 21:56:41 2021 : Debug: preprocess {
Fri Nov 19 21:56:41 2021 : Debug: huntgroups =
"/etc/freeradius/mods-config/preprocess/huntgroups"
Fri Nov 19 21:56:41 2021 : Debug: hints =
"/etc/freeradius/mods-config/preprocess/hints"
Fri Nov 19 21:56:41 2021 : Debug: with_ascend_hack = no
Fri Nov 19 21:56:41 2021 : Debug: ascend_channels_per_line = 23
Fri Nov 19 21:56:41 2021 : Debug: with_ntdomain_hack = no
Fri Nov 19 21:56:41 2021 : Debug: with_specialix_jetstream_hack = no
Fri Nov 19 21:56:41 2021 : Debug: with_cisco_vsa_hack = no
Fri Nov 19 21:56:41 2021 : Debug: with_alvarion_vsa_hack = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_logintime, checking if it's
valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_logintime
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "logintime" from
file /etc/freeradius/mods-enabled/logintime
Fri Nov 19 21:56:41 2021 : Debug: logintime {
Fri Nov 19 21:56:41 2021 : Debug: minimum_timeout = 60
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_attr_filter, checking if
it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_attr_filter
Fri Nov 19 21:56:41 2021 : Debug: # Loading module
"attr_filter.post-proxy" from file /etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: attr_filter attr_filter.post-proxy {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/etc/freeradius/mods-config/attr_filter/post-proxy"
Fri Nov 19 21:56:41 2021 : Debug: key = "%{Realm}"
Fri Nov 19 21:56:41 2021 : Debug: relaxed = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module
"attr_filter.pre-proxy" from file /etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: attr_filter attr_filter.pre-proxy {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/etc/freeradius/mods-config/attr_filter/pre-proxy"
Fri Nov 19 21:56:41 2021 : Debug: key = "%{Realm}"
Fri Nov 19 21:56:41 2021 : Debug: relaxed = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module
"attr_filter.access_reject" from file
/etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: attr_filter attr_filter.access_reject {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/etc/freeradius/mods-config/attr_filter/access_reject"
Fri Nov 19 21:56:41 2021 : Debug: key = "%{User-Name}"
Fri Nov 19 21:56:41 2021 : Debug: relaxed = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module
"attr_filter.access_challenge" from file
/etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: attr_filter
attr_filter.access_challenge {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/etc/freeradius/mods-config/attr_filter/access_challenge"
Fri Nov 19 21:56:41 2021 : Debug: key = "%{User-Name}"
Fri Nov 19 21:56:41 2021 : Debug: relaxed = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module
"attr_filter.accounting_response" from file
/etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: attr_filter
attr_filter.accounting_response {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/etc/freeradius/mods-config/attr_filter/accounting_response"
Fri Nov 19 21:56:41 2021 : Debug: key = "%{User-Name}"
Fri Nov 19 21:56:41 2021 : Debug: relaxed = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "attr_filter.coa"
from file /etc/freeradius/mods-enabled/attr_filter
Fri Nov 19 21:56:41 2021 : Debug: attr_filter attr_filter.coa {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/etc/freeradius/mods-config/attr_filter/coa"
Fri Nov 19 21:56:41 2021 : Debug: key = "%{User-Name}"
Fri Nov 19 21:56:41 2021 : Debug: relaxed = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_passwd, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_passwd
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "etc_passwd" from
file /etc/freeradius/mods-enabled/passwd
Fri Nov 19 21:56:41 2021 : Debug: passwd etc_passwd {
Fri Nov 19 21:56:41 2021 : Debug: filename = "/etc/passwd"
Fri Nov 19 21:56:41 2021 : Debug: format =
"*User-Name:Crypt-Password:"
Fri Nov 19 21:56:41 2021 : Debug: delimiter = ":"
Fri Nov 19 21:56:41 2021 : Debug: ignore_nislike = no
Fri Nov 19 21:56:41 2021 : Debug: ignore_empty = yes
Fri Nov 19 21:56:41 2021 : Debug: allow_multiple_keys = no
Fri Nov 19 21:56:41 2021 : Debug: hash_size = 100
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_always, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_always
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "reject" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always reject {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "reject"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "fail" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always fail {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "fail"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "ok" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always ok {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "ok"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "handled" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always handled {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "handled"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "invalid" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always invalid {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "invalid"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "userlock" from
file /etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always userlock {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "userlock"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "notfound" from
file /etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always notfound {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "notfound"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "noop" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always noop {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "noop"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "updated" from file
/etc/freeradius/mods-enabled/always
Fri Nov 19 21:56:41 2021 : Debug: always updated {
Fri Nov 19 21:56:41 2021 : Debug: rcode = "updated"
Fri Nov 19 21:56:41 2021 : Debug: simulcount = 0
Fri Nov 19 21:56:41 2021 : Debug: mpp = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_unpack, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_unpack
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "unpack" from file
/etc/freeradius/mods-enabled/unpack
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_detail, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_detail
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "auth_log" from
file /etc/freeradius/mods-enabled/detail.log
Fri Nov 19 21:56:41 2021 : Debug: detail auth_log {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/auth-detail-%Y%m%d"
Fri Nov 19 21:56:41 2021 : Debug: header = "%t"
Fri Nov 19 21:56:41 2021 : Debug: permissions = 384
Fri Nov 19 21:56:41 2021 : Debug: locking = no
Fri Nov 19 21:56:41 2021 : Debug: escape_filenames = no
Fri Nov 19 21:56:41 2021 : Debug: log_packet_header = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "reply_log" from
file /etc/freeradius/mods-enabled/detail.log
Fri Nov 19 21:56:41 2021 : Debug: detail reply_log {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/reply-detail-%Y%m%d"
Fri Nov 19 21:56:41 2021 : Debug: header = "%t"
Fri Nov 19 21:56:41 2021 : Debug: permissions = 384
Fri Nov 19 21:56:41 2021 : Debug: locking = no
Fri Nov 19 21:56:41 2021 : Debug: escape_filenames = no
Fri Nov 19 21:56:41 2021 : Debug: log_packet_header = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "pre_proxy_log"
from file /etc/freeradius/mods-enabled/detail.log
Fri Nov 19 21:56:41 2021 : Debug: detail pre_proxy_log {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/pre-proxy-detail-%Y%m%d"
Fri Nov 19 21:56:41 2021 : Debug: header = "%t"
Fri Nov 19 21:56:41 2021 : Debug: permissions = 384
Fri Nov 19 21:56:41 2021 : Debug: locking = no
Fri Nov 19 21:56:41 2021 : Debug: escape_filenames = no
Fri Nov 19 21:56:41 2021 : Debug: log_packet_header = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "post_proxy_log"
from file /etc/freeradius/mods-enabled/detail.log
Fri Nov 19 21:56:41 2021 : Debug: detail post_proxy_log {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/post-proxy-detail-%Y%m%d"
Fri Nov 19 21:56:41 2021 : Debug: header = "%t"
Fri Nov 19 21:56:41 2021 : Debug: permissions = 384
Fri Nov 19 21:56:41 2021 : Debug: locking = no
Fri Nov 19 21:56:41 2021 : Debug: escape_filenames = no
Fri Nov 19 21:56:41 2021 : Debug: log_packet_header = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_date, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_date
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "date" from file
/etc/freeradius/mods-enabled/date
Fri Nov 19 21:56:41 2021 : Debug: date {
Fri Nov 19 21:56:41 2021 : Debug: format = "%b %e %Y %H:%M:%S %Z"
Fri Nov 19 21:56:41 2021 : Debug: utc = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "wispr2date" from
file /etc/freeradius/mods-enabled/date
Fri Nov 19 21:56:41 2021 : Debug: date wispr2date {
Fri Nov 19 21:56:41 2021 : Debug: format = "%Y-%m-%dT%H:%M:%S"
Fri Nov 19 21:56:41 2021 : Debug: utc = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_soh, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_soh
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "soh" from file
/etc/freeradius/mods-enabled/soh
Fri Nov 19 21:56:41 2021 : Debug: soh {
Fri Nov 19 21:56:41 2021 : Debug: dhcp = yes
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_totp, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_totp
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "totp" from file
/etc/freeradius/mods-enabled/totp
Fri Nov 19 21:56:41 2021 : Debug: Loaded rlm_utf8, checking if it's valid
Fri Nov 19 21:56:41 2021 : Debug: # Loaded module rlm_utf8
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "utf8" from file
/etc/freeradius/mods-enabled/utf8
Fri Nov 19 21:56:41 2021 : Debug: # Loading module "detail" from file
/etc/freeradius/mods-enabled/detail
Fri Nov 19 21:56:41 2021 : Debug: detail {
Fri Nov 19 21:56:41 2021 : Debug: filename =
"/var/log/freeradius/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d"
Fri Nov 19 21:56:41 2021 : Debug: header = "%t"
Fri Nov 19 21:56:41 2021 : Debug: permissions = 384
Fri Nov 19 21:56:41 2021 : Debug: locking = no
Fri Nov 19 21:56:41 2021 : Debug: escape_filenames = no
Fri Nov 19 21:56:41 2021 : Debug: log_packet_header = no
Fri Nov 19 21:56:41 2021 : Debug: }
Fri Nov 19 21:56:41 2021 : Error:
/etc/freeradius/mods-enabled/python3[9]: Failed to link to module
'rlm_python3': /usr/lib/freeradius/rlm_python3.so: cannot open shared
object file: No such file or directory
On 2021-11-19 2:55 p.m., Jorge Pereira wrote:
> Could you share the “radiusd -Xx” output with us?
More information about the Freeradius-Users
mailing list