[Proftpd-user] migrating from proftp on RH7 to proftp on RH8

Tim McIntire <[email protected]> Wed, 19 Jan 2022 20:01:18 +0000
Newsgroups gmane.network.proftpd.user
Message-ID <BMXPR01MB474176225FB6096961B1289FF6599@BMXPR01MB4741.INDPRD01.PROD.OUTLOOK.COM>
Running into a problem when migrating to a new RH8 host.   I have  working configuration running proftp 1.3.5e-9 running on RH7. The database is on a remote mariadb server running RH7.  The RH proftp version is proftpd-1.3.6e-4.

From the original proftp instance, I can authenticate remote users successfully. The same user/password fails from the RH8 instances.   The DB connection is successful, but the remote ftp login is not:

Here is what I see in the sql log on the proftp server

2022-01-19 14:53:59,862 mod_sql/4.3[86691]: defaulting to 'mysql' backend
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: backend module 'mod_sql_mysql/4.0.9'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: backend api    'mod_sql_api_v1'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: >>> sql_sess_init
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: entering   mysql cmd_defineconnection
2022-01-19 14:53:59,862 mod_sql/4.3[86691]:   name: 'default'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]:   user: 'vsftpd'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]:   host: 'HOST IP'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]:     db: 'proftpd_admin'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]:   port: '3306'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]:    ttl: '0'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: exiting      mysql cmd_defineconnection
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: connection 'default' successfully established
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: mod_sql engine     : on
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: negative_cache     : off
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: authenticate       : users
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: usertable          : usertable
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: userid field       : userid
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: password field     : passwd
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: UID field          : uid
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: GID field          : gid
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: homedir field      : homedir
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: homedir(default)   : '/var/ftp'
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: shell field        : shell
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: SQLMinUserUID      : 500
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: SQLMinUserGID      : 500
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: SQLDefaultUID      : 65533
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: SQLDefaultGID      : 500
2022-01-19 14:53:59,862 mod_sql/4.3[86691]: <<< sql_sess_init
2022-01-19 14:54:10,646 mod_sql/4.3[86691]: >>> sql_pre_pass
2022-01-19 14:54:10,646 mod_sql/4.3[86691]: <<< sql_pre_pass
2022-01-19 14:54:10,646 mod_sql/4.3[86691]: >>> cmd_getpwnam
2022-01-19 14:54:10,646 mod_sql/4.3[86691]: entering   mysql cmd_escapestring
2022-01-19 14:54:10,646 mod_sql/4.3[86691]: entering   mysql cmd_open
2022-01-19 14:54:10,648 mod_sql/4.3[86691]: MySQL client version: 10.3.6
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: MySQL server version: 5.5.65-MariaDB
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: MySQL SSL connection: false
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: MySQL connection character set now 'utf8mb4' (from 'UTF-8')
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: connection 'default' opened
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: connection 'default' count is now 2
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: exiting      mysql cmd_open
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: entering   mysql cmd_close
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: connection 'default' count is now 1
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: exiting      mysql cmd_close
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: exiting      mysql cmd_escapestring
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: cache miss for user '[email protected]'
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: entering   mysql cmd_select
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: entering   mysql cmd_open
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: connection 'default' count is now 2
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: exiting      mysql cmd_open
2022-01-19 14:54:10,649 mod_sql/4.3[86691]: query "SELECT userid, passwd, uid, gid, homedir, shell FROM usertable WHERE (userid='[email protected]') AND (((disabled=0 and (NOW()<=expiration or expiration=-1 or expiration=0)))) LIMIT 1"
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: entering   mysql cmd_close
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: connection 'default' count is now 1
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: exiting      mysql cmd_close
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: exiting      mysql cmd_select
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: cache miss for user '[email protected]'
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: user '[email protected]' cached
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: + pwd.pw_name  : [email protected]
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: + pwd.pw_uid   : 10100
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: + pwd.pw_gid   : 10001
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: + pwd.pw_dir   : /opt/proftpd/userdir
2022-01-19 14:54:10,650 mod_sql/4.3[86691]: + pwd.pw_shell : /bin/bash

2022-01-19 14:54:10,650 mod_sql/4.3[86691]: <<< cmd_getpwnam
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: >>> cmd_auth
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: entering   mysql cmd_escapestring
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: entering   mysql cmd_open
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: connection 'default' count is now 2
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: exiting      mysql cmd_open
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: entering   mysql cmd_close
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: connection 'default' count is now 1
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: exiting      mysql cmd_close
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: exiting      mysql cmd_escapestring
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: cache hit for user '[email protected]'
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: >>> cmd_check
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: checking password using SQLAuthType 'Backend'
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: entering   mysql cmd_checkauth
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: password mismatch
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: exiting      mysql cmd_checkauth
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: 'Backend' SQLAuthType handler reports failure
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: <<< cmd_check
2022-01-19 14:54:10,653 mod_sql/4.3[86691]: <<< cmd_auth

Any suggestions?

Thanks... Tim

_______________________________________________
ProFTPD Users List   <[email protected]>
Unsubscribe problems?
http://www.proftpd.org/list-unsub.html