AIX

AIX

Connect with fellow AIX users and experts to gain knowledge, share insights, and solve problems.

 View Only
Back to discussions
Expand all | Collapse all

Compile proftpd with sftp ftps and mysql auth with IBM Xlc

  • 1.  Compile proftpd with sftp ftps and mysql auth with IBM Xlc

    Posted Mon February 10, 2014 05:44 AM

    Originally posted by: bugmenot69


    I'm trying to get proftpd working with ftps sftp and mysql authentication. 

    So far ftps sftp ftp can work correctly but when I add mysql auth, I have a strange bug.

    If I set a DB that answer to ping but does not host a db authentication fails after timeout and it's impossible to use other auth method so even pam auth will be disable. I have a different version of protfpd compile with GCC that does work correctly, but I don't know how it has been compile.

     

    Here's all the info I can came up with:

     

    Configure line : 

    
Version: 1.3.4b (maint)
  Platform: AIX6 (AIX6_1_0_0) [AIX 1 00C7EE904C00]
  Built: Fri Feb 7 2014 10:47:16 CUT
  Built With:
    configure  '--with-modules=mod_tls:mod_sql:mod_sql_mysql:mod_sql_passwd:mod_sftp:mod_sftp_sql' '--without-getopt' '--enable-openssl' '--with-includes=/opt/freeware/include/mysql/' '--with-libraries=/opt/freeware/lib/mysql' '--prefix=/usr/local/proftpd' 'CC=cc' 'CFLAGS=-DSYSV -D_AIX -D_AIX32 -D_AIX41 -D_AIX43 -D_AIX51 -D_AIX52 -D_AIX53 -D_AIX61 -D_ALL_SOURCE -DFUNCPROTO=15 -O -I/opt/freeware/include' 'LDFLAGS=-L/opt/freeware/lib -Wl,-blibpath:/opt/freeware/lib:/opt/freeware/lib/mysql:/usr/lib:/lib' 'CPPFLAGS=-U__STR__'

  CFLAGS: -DSYSV -D_AIX -D_AIX32 -D_AIX41 -D_AIX43 -D_AIX51 -D_AIX52 -D_AIX53 -D_AIX61 -D_ALL_SOURCE -DFUNCPROTO=15 -O -I/opt/freeware/include
  LDFLAGS: -L$(top_srcdir)/lib -L/opt/freeware/lib -Wl,-blibpath:/opt/freeware/lib:/opt/freeware/lib/mysql:/usr/lib:/lib -L/opt/freeware/lib/mysql -L/opt/freeware/lib -L/opt/freeware/lib/mysql -L/opt/freeware/lib -L/opt/freeware/lib/
  LIBS:  -lssl -lcrypto -lssl -lcrypto -lm -lmysqlclient  -lssl  -lpam  -lcrypto -lsupp  -ldl -lz

     

    rpm install:

    AIX-rpm-6.1.6.15-5
    apr-1.4.6-1
    apr-util-1.5.1-1
    apr-util-ldap-1.5.1-1
    bash-3.0-1
    bzip2-1.0.6-1
    cdrecord-1.9-7
    coreutils-5.0-2
    db4-4.7.25-2
    expat-2.1.0-1
    gcc-4.6.1-1
    gcc-cpp-4.6.1-1
    gettext-0.10.40-8
    gmp-5.1.3-1
    gmp-devel-5.1.3-1
    grep-2.5.1-1
    httpd-2.4.3-1
    ibm.scsi.disk.10k300-RPQR-1
    ibm.scsi.disk.146lp-C50K-1
    ibm.scsi.disk.146z10-s28g-1
    ibm.scsi.disk.73lpx15-c51d-1
    info-4.13a-2
    libgcc-4.6.1-1
    libiconv-1.14-2
    libmpc-1.0.1-2
    libmpc-devel-1.0.1-2
    libstdc++-4.6.1-1
    libstdc++-devel-4.6.1-1
    mkisofs-1.13-4
    mpfr-3.1.2-1
    mpfr-devel-3.1.2-1
    mysql-5.1.73-1
    mysql-devel-5.1.73-1
    mysql-libs-5.1.73-1
    openldap-2.4.23-0.3
    openssl-1.0.1e-2
    openssl-devel-1.0.1e-2
    pci.1069B166.08-0508008a-1
    pci.1069B166.0A-050A008a-1
    pci.1069B166.10-0510006d-1
    pci.1069B166.10-0710000b-1
    pci.df1000fa-1-191A5
    pci.df1000fa-1-90X13
    pci.df1080f9-1-91x4
    pcre-8.32-1
    readline-6.2-4
    screen-3.9.10-2
    ses.0018-0018-01
    zlib-1.2.7-2
    zlib-devel-1.2.7-2

    here's the trace log and the sql log

    TRACE Log

    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'ServerName' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'ServerType' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'UseIPv6' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '<Limit>' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'DenyAll' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '</Limit>' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'Port' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SystemLog' to module mod_log
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:9>: signals already blocked (block count = 1)
    Feb 07 15:44:11 [15139036] <signal:9>: signals already unblocked (block count = 2)
    Feb 07 15:44:11 [15139036] <signal:9>: signals already blocked (block count = 1)
    Feb 07 15:44:11 [15139036] <signal:9>: signals already unblocked (block count = 2)
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'LogFormat' to module mod_log
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'LogFormat' to module mod_log
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSProtocol' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'UseReverseDNS' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '<Global>' to module mod_core
    Feb 07 15:44:11 [15139036] <fsio:8>: using system read() for path '/usr/local/proftpd/etc/proftpd.conf' (967 bytes)
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'DefaultRoot' to module mod_auth
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'Umask' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'AllowOverwrite' to module mod_xfer
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'ExtendedLog' to module mod_log
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'ExtendedLog' to module mod_log
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'AuthOrder' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLAuthTypes' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLPasswordEngine' to module mod_sql_passwd
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLPasswordEncoding' to module mod_sql_passwd
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLPasswordRounds' to module mod_sql_passwd
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLNamedQuery' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLPasswordUserSalt' to module mod_sql_passwd
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLAuthenticate' to module mod_sql
    Feb 07 15:44:11 [15139036] <fsio:8>: using system read() for path '/usr/local/proftpd/etc/proftpd.conf' (1005 bytes)
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLConnectInfo' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLUserInfo' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLOptions' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLMinUserUID' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLMinUserGID' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLDefaultGID' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLDefaultUID' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLLogFile' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSEngine' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSRSACertificateFile' to module mod_tls
    Feb 07 15:44:11 [15139036] <fsio:8>: using system lstat() for path '/usr/local/proftpd/etc/proftpd.cert.pem'
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSRSACertificateKeyFile' to module mod_tls
    Feb 07 15:44:11 [15139036] <fsio:8>: using system lstat() for path '/usr/local/proftpd/etc/proftpd.key.pem'
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSLog' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSVerifyClient' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSRenegotiate' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSRequired' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '</Global>' to module mod_core
    Feb 07 15:44:11 [15139036] <fsio:8>: using system read() for path '/usr/local/proftpd/etc/proftpd.conf' (985 bytes)
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '<VirtualHost>' to module mod_core
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:7>: '0.0.0.0' resolved to IPv4 address 0.0.0.0
    Feb 07 15:44:11 [15139036] <dns:5>: stashed IP address '0.0.0.0' for name '0.0.0.0' in the netaddr IP cache
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'Port' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSEngine' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLUserWhereClause' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '</VirtualHost>' to module mod_core
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name 'unicorsSrv' to IP address
    Feb 07 15:44:11 [15139036] <dns:2>: no IP address found in netaddr IP cache for name 'unicorsSrv'
    Feb 07 15:44:11 [15139036] <dns:7>: attempting to resolve 'unicorsSrv' to IPv4 address via DNS
    Feb 07 15:44:11 [15139036] <dns:7>: resolved 'unicorsSrv' to IPv4 address 172.23.21.71
    Feb 07 15:44:11 [15139036] <dns:5>: stashed IP address '172.23.21.71' for name 'unicorsSrv' in the netaddr IP cache
    Feb 07 15:44:11 [15139036] <dns:5>: stashed IP address '172.23.21.71' for name '172.23.21.71' in the netaddr IP cache
    Feb 07 15:44:11 [15139036] <dns:4>: addr 0.0.0.0 does not match addr 172.23.21.71
    Feb 07 15:44:11 [15139036] <fsio:8>: using system read() for path '/usr/local/proftpd/etc/proftpd.conf' (979 bytes)
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '<VirtualHost>' to module mod_core
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:7>: '0.0.0.0' resolved to IPv4 address 0.0.0.0
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'Port' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSEngine' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'TLSOptions' to module mod_tls
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLUserWhereClause' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '</VirtualHost>' to module mod_core
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name 'unicorsSrv' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '172.23.21.71' from netaddr IP cache for name 'unicorsSrv'
    Feb 07 15:44:11 [15139036] <dns:4>: addr 0.0.0.0 does not match addr 172.23.21.71
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <fsio:8>: using system read() for path '/usr/local/proftpd/etc/proftpd.conf' (1007 bytes)
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '<IfModule>' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '<VirtualHost>' to module mod_core
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:7>: '0.0.0.0' resolved to IPv4 address 0.0.0.0
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'Port' to module mod_core
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SQLUserWhereClause' to module mod_sql
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SFTPEngine' to module mod_sftp
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SFTPLog' to module mod_sftp
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SFTPHostKey' to module mod_sftp
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SFTPHostKey' to module mod_sftp
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SFTPAuthorizedUserKeys' to module mod_sftp
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'SFTPCompression' to module mod_sftp
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive 'MaxLoginAttempts' to module mod_auth
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '</VirtualHost>' to module mod_core
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name 'unicorsSrv' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '172.23.21.71' from netaddr IP cache for name 'unicorsSrv'
    Feb 07 15:44:11 [15139036] <dns:4>: addr 0.0.0.0 does not match addr 172.23.21.71
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <config:7>: dispatching directive '</IfModule>' to module mod_core
    Feb 07 15:44:11 [15139036] <fsio:8>: using system read() for path '/usr/local/proftpd/etc/proftpd.conf' (1024 bytes)
    Feb 07 15:44:11 [15139036] <fsio:8>: using system close() for path '/usr/local/proftpd/etc/proftpd.conf'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name 'unicorsSrv' to IP address
    Feb 07 15:44:11 [15139036] <dns:7>: attempting to resolve 'unicorsSrv' to IPv4 address via DNS
    Feb 07 15:44:11 [15139036] <dns:7>: resolved 'unicorsSrv' to IPv4 address 172.23.21.71
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '172.23.21.71' from netaddr IP cache for name '172.23.21.71'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:10>: resolving name '0.0.0.0' to IP address
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <dns:4>: using IP address '0.0.0.0' from netaddr IP cache for name '0.0.0.0'
    Feb 07 15:44:11 [15139036] <event:8>: dispatching event 'core.postparse' to mod_delay (at 20047058)
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <fsio:8>: using system open() for path '/usr/local/proftpd/var/proftpd.delay'
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <fsio:8>: using system fstat() for path '/usr/local/proftpd/var/proftpd.delay'
    Feb 07 15:44:11 [15139036] <delay:8>: mapping DelayTable '/usr/local/proftpd/var/proftpd.delay' (25760 bytes, fd 3) into memory
    Feb 07 15:44:11 [15139036] <delay:8>: unmapping DelayTable '/usr/local/proftpd/var/proftpd.delay' from memory
    Feb 07 15:44:11 [15139036] <fsio:8>: using system close() for path '/usr/local/proftpd/var/proftpd.delay'
    Feb 07 15:44:11 [15139036] <event:8>: dispatching event 'core.postparse' to mod_tls (at 20047214)
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked


    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <event:8>: dispatching event 'core.postparse' to mod_sftp (at 20047bec)
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked


    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <scoreboard:7>: reading scoreboard header
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <scoreboard:4>: closing scoreboard fd 3
    Feb 07 15:44:11 [15139036] <event:8>: dispatching event 'core.startup' to mod_core (at 200462c0)
    Feb 07 15:44:11 [15139036] <event:3>: module 'core' (20004610) registering handler for event 'core.restart' (at 200462d8)
    Feb 07 15:44:11 [15139036] <binding:4>: bound address 0.0.0.0, port 0 to socket fd 0
    Feb 07 15:44:11 [15139036] <binding:8>: created binding for 172.23.21.71#0, server 20079710
    Feb 07 15:44:11 [15139036] <binding:8>: created binding for 0.0.0.0#210, server 200c3600
    Feb 07 15:44:11 [15139036] <binding:8>: created binding for 0.0.0.0#214, server 200cd3d0
    Feb 07 15:44:11 [15139036] <binding:8>: created binding for 0.0.0.0#211, server 200ce540
    Feb 07 15:44:11 [15139036] <fsio:8>: using system lstat() for path '/etc/shutmsg'
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked

    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <event:3>: module 'sql' (20024058) registering handler for event 'core.chroot' (at 20047520)
    Feb 07 15:44:11 [15139036] <event:3>: module 'sql' (20024058) registering handler for event 'core.exit' (at 2004752c)
    Feb 07 15:44:11 [15139036] <event:3>: module 'tls' (2001d038) registering handler for event 'core.exit' (at 200471d8)
    Feb 07 15:44:11 [15139036] <event:3>: module 'tls' (2001d038) registering handler for event 'core.timeout-idle' (at 200471e4)
    Feb 07 15:44:11 [15139036] <event:3>: module 'tls' (2001d038) registering handler for event 'core.timeout-login' (at 200471e4)
    Feb 07 15:44:11 [15139036] <event:3>: module 'tls' (2001d038) registering handler for event 'core.timeout-no-transfer' (at 200471e4)
    Feb 07 15:44:11 [15139036] <event:3>: module 'tls' (2001d038) registering handler for event 'core.timeout-session' (at 200471e4)
    Feb 07 15:44:11 [15139036] <event:3>: module 'tls' (2001d038) registering handler for event 'core.timeout-stalled' (at 200471e4)
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked

    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <auth:5>: added 'mod_auth_pam.c' to auth-only module list
    Feb 07 15:44:11 [15139036] <delay:6>: opening DelayTable '/usr/local/proftpd/var/proftpd.delay'
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <fsio:8>: using system open() for path '/usr/local/proftpd/var/proftpd.delay'
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked

    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <event:3>: module 'log' (20019648) registering handler for event 'core.exit' (at 20046fbc)
    Feb 07 15:44:11 [15139036] <event:3>: module 'log' (20019648) registering handler for event 'core.timeout-stalled' (at 20046fc8)
    Feb 07 15:44:11 [15139036] <timer:7>: added timer ID 1 ('TimeoutLogin', for module 'auth'), triggering in 300 seconds
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <scoreboard:7>: reading scoreboard header
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <event:3>: module 'auth' (20014c80) registering handler for event 'core.exit' (at 20046cec)
    Feb 07 15:44:11 [15139036] <scoreboard:3>: adding new scoreboard entry
    Feb 07 15:44:11 [15139036] <lock:9>: attempt #1 to write-lock scoreboard mutex fd 10
    Feb 07 15:44:11 [15139036] <lock:9>: write-lock of scoreboard mutex fd 10 successful
    Feb 07 15:44:11 [15139036] <signal:5>: signals blocked
    Feb 07 15:44:11 [15139036] <signal:5>: signals unblocked
    Feb 07 15:44:11 [15139036] <lock:9>: attempt #1 to unlock scoreboard mutex fd 10
    Feb 07 15:44:11 [15139036] <lock:9>: unlock of scoreboard mutex fd 10 successful
    Feb 07 15:44:11 [15139036] <scoreboard:3>: updating scoreboard entry
    Feb 07 15:44:11 [15139036] <lock:9>: attempting to write-lock scoreboard fd 9 entry, offset 16
    Feb 07 15:44:11 [15139036] <lock:9>: write-lock of scoreboard fd 9 entry, offset 16 succeeded
    Feb 07 15:44:11 [15139036] <lock:9>: attempting to unlock scoreboard fd 9 entry, offset 16
    Feb 07 15:44:11 [15139036] <lock:9>: unlock of scoreboard fd 9 entry, offset 16 succeeded
    Feb 07 15:44:11 [15139036] <scoreboard:3>: finished updating scoreboard entry
    Feb 07 15:44:11 [15139036] <lock:9>: attempt #1 to read-lock scoreboard mutex fd 10
    Feb 07 15:44:11 [15139036] <lock:9>: read-lock of scoreboard mutex fd 10 successful
    Feb 07 15:44:11 [15139036] <scoreboard:5>: reading scoreboard entry
    Feb 07 15:44:11 [15139036] <lock:9>: attempt #1 to unlock scoreboard mutex fd 10
    Feb 07 15:44:11 [15139036] <lock:9>: unlock of scoreboard mutex fd 10 successful
    Feb 07 15:44:11 [15139036] <lock:9>: attempt #1 to read-lock scoreboard mutex fd 10
    Feb 07 15:44:11 [15139036] <lock:9>: read-lock of scoreboard mutex fd 10 successful
    Feb 07 15:44:11 [15139036] <scoreboard:5>: reading scoreboard entry
    Feb 07 15:44:11 [15139036] <lock:9>: attempt #1 to unlock scoreboard mutex fd 10
    Feb 07 15:44:11 [15139036] <lock:9>: unlock of scoreboard mutex fd 10 successful
    Feb 07 15:44:11 [15139036] <event:3>: module 'auth_unix' (20013c40) registering handler for event 'core.exit' (at 20046aac)
    Feb 07 15:44:11 [15139036] <event:3>: module 'xfer' (20010f50) registering handler for event 'core.exit' (at 200468cc)
    Feb 07 15:44:11 [15139036] <event:3>: module 'xfer' (20010f50) registering handler for event 'core.timeout-stalled' (at 200468d8)
    Feb 07 15:44:11 [15139036] <event:3>: module 'xfer' (20010f50) registering handler for event 'core.signal.USR2' (at 200468e4)
    Feb 07 15:44:11 [15139036] <timer:7>: added timer ID 2 ('TimeoutIdle', for module '[none]'), triggering in 600 seconds
    Feb 07 15:44:11 [15139036] <inet:7>: setting SO_OOBINLINE for listening socket -1
    Feb 07 15:44:11 [15139036] <inet:7>: setting SO_OOBINLINE for reading socket 0
    Feb 07 15:44:11 [15139036] <inet:7>: setting SO_OOBINLINE for writing socket 1
    Feb 07 15:44:11 [15139036] <response:1>: 220 ProFTPD 1.3.4b Server (ftp daemon) [127.0.0.1]
    Feb 07 15:44:11 [15139036] <timer:7>: reset timer ID 2 ('TimeoutIdle', for module '[none]')
    Feb 07 15:44:11 [15139036] <response:9>: clearing response lists before dispatching command 'USER'
    Feb 07 15:44:11 [15139036] <command:7>: dispatching PRE_CMD command 'USER Robertripou' to mod_tls.c
    Feb 07 15:44:11 [15139036] <command:7>: dispatching PRE_CMD command 'USER Robertripou' to mod_core.c
    Feb 07 15:44:11 [15139036] <command:7>: dispatching PRE_CMD command 'USER Robertripou' to mod_core.c
    Feb 07 15:44:11 [15139036] <command:7>: dispatching PRE_CMD command 'USER Robertripou' to mod_delay.c
    Feb 07 15:44:11 [15139036] <command:7>: dispatching PRE_CMD command 'USER Robertripou' to mod_auth.c
    Feb 07 15:44:11 [15139036] <auth:6>: dispatching auth request "endpwent" to module mod_sql
    Feb 07 15:44:11 [15139036] <auth:6>: dispatching auth request "endpwent" to module mod_auth_unix
    Feb 07 15:44:11 [15139036] <auth:6>: dispatching auth request "endgrent" to module mod_sql
    Feb 07 15:44:11 [15139036] <auth:6>: dispatching auth request "endgrent" to module mod_auth_unix
    Feb 07 15:44:11 [15139036] <command:7>: dispatching CMD command 'USER Robertripou' to mod_auth.c
    Feb 07 15:44:11 [15139036] <auth:6>: dispatching auth request "requires_pass" to module mod_tls
    Feb 07 15:44:11 [15139036] <response:7>: response added to pending list: 331 Password required for Robertripou
    Feb 07 15:44:11 [15139036] <command:7>: dispatching POST_CMD command 'USER Robertripou' to mod_sql.c
    Feb 07 15:44:11 [15139036] <command:7>: dispatching POST_CMD command 'USER Robertripou' to mod_delay.c
    Feb 07 15:44:11 [15139036] <delay:8>: mapping DelayTable '/usr/local/proftpd/var/proftpd.delay' (25760 bytes, fd 6) into memory
    Feb 07 15:44:11 [15139036] <delay:8>: write-locking DelayTable '/usr/local/proftpd/var/proftpd.delay', row 3
    Feb 07 15:44:11 [15139036] <delay:9>: interval between connect and USER command: 213 usecs
    Feb 07 15:44:11 [15139036] <delay:6>: selecting median interval from 15 values
    Feb 07 15:44:11 [15139036] <delay:7>: selected median interval of 207 usecs
    Feb 07 15:44:11 [15139036] <delay:8>: adding 213 usecs to USER row
    Feb 07 15:44:11 [15139036] <delay:8>: unlocking DelayTable '/usr/local/proftpd/var/proftpd.delay', row 3
    Feb 07 15:44:11 [15139036] <delay:8>: unmapping DelayTable '/usr/local/proftpd/var/proftpd.delay' from memory
    Feb 07 15:44:11 [15139036] <command:7>: dispatching LOG_CMD command 'USER Robertripou' to mod_sql.c
    Feb 07 15:44:11 [15139036] <command:7>: dispatching LOG_CMD command 'USER Robertripou' to mod_log.c
    Feb 07 15:44:11 [15139036] <response:9>: flushing response list for 'USER'
    Feb 07 15:44:11 [15139036] <response:1>: 331 Password required for Robertripou
    Feb 07 15:44:12 [15139036] <timer:7>: reset timer ID 2 ('TimeoutIdle', for module '[none]')
    Feb 07 15:44:12 [15139036] <response:9>: clearing response lists before dispatching command 'PASS'
    Feb 07 15:44:12 [15139036] <command:7>: dispatching PRE_CMD command 'PASS (hidden)' to mod_tls.c
    Feb 07 15:44:12 [15139036] <command:7>: dispatching PRE_CMD command 'PASS (hidden)' to mod_core.c
    Feb 07 15:44:12 [15139036] <command:7>: dispatching PRE_CMD command 'PASS (hidden)' to mod_core.c
    Feb 07 15:44:12 [15139036] <command:7>: dispatching PRE_CMD command 'PASS (hidden)' to mod_sql_passwd.c
    Feb 07 15:44:12 [15139036] <signal:5>: signals blocked
    Feb 07 15:45:27 [15139036] <signal:5>: signals unblocked
    Feb 07 15:45:27 [15139036] <scoreboard:3>: deleting scoreboard entry
    Feb 07 15:45:27 [15139036] <lock:9>: attempting to write-lock scoreboard fd 9 entry, offset 16
    Feb 07 15:45:27 [15139036] <lock:9>: write-lock of scoreboard fd 9 entry, offset 16 succeeded
    Feb 07 15:45:27 [15139036] <lock:9>: attempt #1 to write-lock scoreboard mutex fd 10
    Feb 07 15:45:27 [15139036] <lock:9>: write-lock of scoreboard mutex fd 10 successful
    Feb 07 15:45:27 [15139036] <lock:9>: attempt #1 to unlock scoreboard mutex fd 10
    Feb 07 15:45:27 [15139036] <lock:9>: unlock of scoreboard mutex fd 10 successful
    Feb 07 15:45:27 [15139036] <lock:9>: attempting to unlock scoreboard fd 9 entry, offset 16
    Feb 07 15:45:27 [15139036] <lock:9>: unlock of scoreboard fd 9 entry, offset 16 succeeded
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to core (at 200462a8)
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to mod_sql (at 2004752c)
    Feb 07 15:45:27 [15139036] <signal:5>: signals blocked
    Feb 07 15:45:27 [15139036] <signal:5>: signals unblocked
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to mod_tls (at 200471d8)
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to mod_log (at 20046fbc)
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to mod_auth (at 20046cec)
    Feb 07 15:45:27 [15139036] <scoreboard:4>: closing scoreboard fd 9
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to mod_auth_unix (at 20046aac)
    Feb 07 15:45:27 [15139036] <auth:6>: dispatching auth request "endpwent" to module mod_sql
    Feb 07 15:45:27 [15139036] <auth:6>: dispatching auth request "endpwent" to module mod_auth_unix
    Feb 07 15:45:27 [15139036] <auth:6>: dispatching auth request "endgrent" to module mod_sql
    Feb 07 15:45:27 [15139036] <auth:6>: dispatching auth request "endgrent" to module mod_auth_unix
    Feb 07 15:45:27 [15139036] <event:8>: dispatching event 'core.exit' to mod_xfer (at 200468cc)


    SQL Log

        Feb 07 15:44:11 mod_sql/4.3[15139036]: defaulting to 'mysql' backend
        Feb 07 15:44:11 mod_sql/4.3[15139036]: backend module 'mod_sql_mysql/4.0.8'
        Feb 07 15:44:11 mod_sql/4.3[15139036]: backend api    'mod_sql_api_v1'
        Feb 07 15:44:11 mod_sql/4.3[15139036]: >>> sql_sess_init
        Feb 07 15:44:11 mod_sql/4.3[15139036]: entering         mysql cmd_defineconnection
        Feb 07 15:44:11 mod_sql/4.3[15139036]:   name: 'default'
        Feb 07 15:44:11 mod_sql/4.3[15139036]:   user: 'mysql_poney_user'
        Feb 07 15:44:11 mod_sql/4.3[15139036]:   host: 'pingableHostWithoutDB.net'
        Feb 07 15:44:11 mod_sql/4.3[15139036]:     db: 'mysql_poney_user'
        Feb 07 15:44:11 mod_sql/4.3[15139036]:   port: '15140'
        Feb 07 15:44:11 mod_sql/4.3[15139036]:    ttl: '2'
        Feb 07 15:44:11 mod_sql/4.3[15139036]: exiting  mysql cmd_defineconnection
        Feb 07 15:44:11 mod_sql/4.3[15139036]: connection 'default' successfully established
        Feb 07 15:44:11 mod_sql/4.3[15139036]: mod_sql engine     : on
        Feb 07 15:44:11 mod_sql/4.3[15139036]: negative_cache     : off
        Feb 07 15:44:11 mod_sql/4.3[15139036]: authenticate       : users
        Feb 07 15:44:11 mod_sql/4.3[15139036]: usertable          : proftpd_users
        Feb 07 15:44:11 mod_sql/4.3[15139036]: userid field       : userid
        Feb 07 15:44:11 mod_sql/4.3[15139036]: password field     : passwd
        Feb 07 15:44:11 mod_sql/4.3[15139036]: UID field          : uid
        Feb 07 15:44:11 mod_sql/4.3[15139036]: GID field          : gid
        Feb 07 15:44:11 mod_sql/4.3[15139036]: homedir field      : homedir
        Feb 07 15:44:11 mod_sql/4.3[15139036]: shell field        : shell
        Feb 07 15:44:11 mod_sql/4.3[15139036]: SQLMinUserUID      : 200
        Feb 07 15:44:11 mod_sql/4.3[15139036]: SQLMinUserGID      : 1
        Feb 07 15:44:11 mod_sql/4.3[15139036]: <<< sql_sess_init
        Feb 07 15:44:12 mod_sql/4.3[15139036]: >>> sql_escapestr
        Feb 07 15:44:12 mod_sql/4.3[15139036]: entering         mysql cmd_escapestring
        Feb 07 15:44:12 mod_sql/4.3[15139036]: entering         mysql cmd_open
        Feb 07 15:45:27 mod_sql/4.3[15139036]: exiting  mysql cmd_open
        Feb 07 15:45:27 mod_sql/4.3[15139036]: exiting  mysql cmd_escapestring
        Feb 07 15:45:27 mod_sql/4.3[15139036]: unrecoverable backend error
        Feb 07 15:45:27 mod_sql/4.3[15139036]: error: '2003'
        Feb 07 15:45:27 mod_sql/4.3[15139036]: message: 'Can't connect to MySQL server on 'pingableHostWithoutDB.net' (78)'
        Feb 07 15:45:27 mod_sql/4.3[15139036]: entering         mysql cmd_exit
        Feb 07 15:45:27 mod_sql/4.3[15139036]: exiting  mysql cmd_exit
     

    see the one minute jump in sql log there's a problem with the compilation somewhere and it's related to mysql because if I disable mysql auth in configuration then everything does work fluently.