Debian Jessie: pure-ftpd-mysql stops after some hours or days

Discussion in 'Server Operation' started by orasis, Jul 27, 2016.

  1. orasis

    orasis Member

    Hi, I run ISPConfig3 on a debian jessie, upgraded from a wheezy installation on various servers and I face this issue only on the production ones although the setup is identical with my 2 development machines -- even the hardware on one of them. What is happening is that pure-ftpd-mysql crashes/stops after a couple of days and makes ISPconfig3 show the red warning that one of the services is offline. Connections using FTP or FTPS do not work of course and I face this some months now, I was hoping it would be a bug of that software but it is still not working well.

    Here is what I get when it is stopped if I check the service:
    Code:
    ~# systemctl -n 500 status pure-ftpd-mysql.service
    ● pure-ftpd-mysql.service - (null)
       Loaded: loaded (/etc/init.d/pure-ftpd-mysql)
       Active: active (exited) since Mon 2016-07-25 21:53:36 EEST; 1 day 17h ago
    
    Jul 26 02:42:02 xxxxxx pure-ftpd[14212]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:43:01 xxxxxx pure-ftpd[14525]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:44:01 xxxxxx pure-ftpd[14597]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:45:01 xxxxxx pure-ftpd[15173]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:45:01 xxxxxx pure-ftpd[15198]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:46:02 xxxxxx pure-ftpd[16314]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:47:02 xxxxxx pure-ftpd[16335]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:48:02 xxxxxx pure-ftpd[16931]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:49:01 xxxxxx pure-ftpd[16954]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:50:01 xxxxxx pure-ftpd[17407]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:50:01 xxxxxx pure-ftpd[17488]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:51:01 xxxxxx pure-ftpd[18158]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:52:02 xxxxxx pure-ftpd[18775]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:53:01 xxxxxx pure-ftpd[18802]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:54:02 xxxxxx pure-ftpd[19386]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:55:01 xxxxxx pure-ftpd[19473]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:55:01 xxxxxx pure-ftpd[19499]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:56:02 xxxxxx pure-ftpd[20610]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:57:01 xxxxxx pure-ftpd[20630]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:58:02 xxxxxx pure-ftpd[21218]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 02:59:01 xxxxxx pure-ftpd[21244]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:00:02 xxxxxx pure-ftpd[21718]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:00:35 xxxxxx pure-ftpd[22440]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:01:01 xxxxxx pure-ftpd[22461]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:02:02 xxxxxx pure-ftpd[23040]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:03:01 xxxxxx pure-ftpd[23066]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:04:02 xxxxxx pure-ftpd[23645]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:05:01 xxxxxx pure-ftpd[23699]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:05:01 xxxxxx pure-ftpd[23724]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:06:02 xxxxxx pure-ftpd[24842]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:07:02 xxxxxx pure-ftpd[24864]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:08:01 xxxxxx pure-ftpd[24924]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:08:01 xxxxxx pure-ftpd[24924]: (?@127.0.0.1) [INFO] Logout.
    Jul 26 03:09:01 xxxxxx pure-ftpd[25492]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:10:02 xxxxxx pure-ftpd[26062]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:10:02 xxxxxx pure-ftpd[26142]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:11:01 xxxxxx pure-ftpd[26737]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:12:02 xxxxxx pure-ftpd[27315]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:13:01 xxxxxx pure-ftpd[27343]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:14:02 xxxxxx pure-ftpd[27397]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:15:02 xxxxxx pure-ftpd[27977]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:15:02 xxxxxx pure-ftpd[28001]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:16:02 xxxxxx pure-ftpd[29116]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:17:01 xxxxxx pure-ftpd[29147]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:18:02 xxxxxx pure-ftpd[29732]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:19:01 xxxxxx pure-ftpd[29754]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:20:01 xxxxxx pure-ftpd[30257]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:20:01 xxxxxx pure-ftpd[30334]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:21:01 xxxxxx pure-ftpd[30985]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:22:02 xxxxxx pure-ftpd[31564]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:23:02 xxxxxx pure-ftpd[31587]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:24:02 xxxxxx pure-ftpd[32170]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:25:01 xxxxxx pure-ftpd[32224]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:25:01 xxxxxx pure-ftpd[32224]: (?@127.0.0.1) [INFO] Logout.
    Jul 26 03:25:01 xxxxxx pure-ftpd[32249]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:26:02 xxxxxx pure-ftpd[921]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:27:01 xxxxxx pure-ftpd[960]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:28:02 xxxxxx pure-ftpd[1554]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:29:01 xxxxxx pure-ftpd[1574]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:30:01 xxxxxx pure-ftpd[2071]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:30:01 xxxxxx pure-ftpd[2164]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:31:01 xxxxxx pure-ftpd[2797]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:32:01 xxxxxx pure-ftpd[3062]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:33:01 xxxxxx pure-ftpd[3400]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:34:02 xxxxxx pure-ftpd[3979]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:35:01 xxxxxx pure-ftpd[4038]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:35:01 xxxxxx pure-ftpd[4064]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:36:02 xxxxxx pure-ftpd[5198]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:37:01 xxxxxx pure-ftpd[5226]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:38:02 xxxxxx pure-ftpd[5803]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:39:01 xxxxxx pure-ftpd[5848]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:40:02 xxxxxx pure-ftpd[6358]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:40:02 xxxxxx pure-ftpd[6441]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:40:02 xxxxxx pure-ftpd[6441]: (?@127.0.0.1) [INFO] Logout.
    Jul 26 03:41:01 xxxxxx pure-ftpd[7089]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:42:02 xxxxxx pure-ftpd[7670]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:43:01 xxxxxx pure-ftpd[7693]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Jul 26 03:44:03 xxxxxx pure-ftpd[8272]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    ............
    .. and here is what I get if I restart it:
    Code:
    ~# systemctl -n 100 status pure-ftpd-mysql.service
    ● pure-ftpd-mysql.service - (null)
       Loaded: loaded (/etc/init.d/pure-ftpd-mysql)
       Active: active (running) since Wed 2016-07-27 15:08:18 EEST; 43s ago
      Process: 19961 ExecStop=/etc/init.d/pure-ftpd-mysql stop (code=exited, status=0/SUCCESS)
      Process: 19971 ExecStart=/etc/init.d/pure-ftpd-mysql start (code=exited, status=0/SUCCESS)
       CGroup: /system.slice/pure-ftpd-mysql.service
               └─19980 pure-ftpd (SERVER)
    
    Jul 27 15:08:18 xxxxxx pure-ftpd-mysql[19971]: Starting ftp server: Running: /usr/sbin/pure-ftpd-mysql-virtualchroot -l mysql:/etc/pure-ftpd/db/mysql.conf -l pam -p 40400:40500 -E -Y 1 -u 1000 -J ECDHE-RSA-AES128-GCM-S...28-GCM-SHA256:DH
    Jul 27 15:08:18 xxxxxx systemd[1]: Started (null).
    Jul 27 15:09:01 xxxxxx pure-ftpd[20015]: (?@127.0.0.1) [INFO] New connection from 127.0.0.1
    Hint: Some lines were ellipsized, use -l to show in full.
    Any help to fix this issue would be greatly appreciated, thanks a lot,
    P.S
    Sometimes it takes me a while to get back to the forums but ... :D
     
  2. till

    till Super Moderator Staff Member ISPConfig Developer

    I dont had that issue yet so I can't provide a fix, but at least I can provide a workaround. Install monit on the server and let it restart pure-ftpd automatically when it fails.
     
  3. orasis

    orasis Member

    Till ! thanks yeah that is a good temporary solution although I hate monit, I used to have it then wiped it out.
    By the way thinking it could be external attacks is not the case cause only 1 of those servers has FTP/FTPS ports open to the firewall, but all have this symptom of crashing the same way. And I did the upgrade from wheezy exactly the same way I did on the development machines and very carefully. Any ideas on what to check ?

    George
     

Share This Page