New FTP Users can't login

[pyropoptrt]

I'm having an issue where new users can't login into sites recently created. This is the error I'm getting, "Could not connect as user (username)". I'm currently using ISPConfig 2.2.30. Any input on what is causing this? I've tried deleting the site and client so that I could recreate it fresh but it doesn't delete from the recycle bin even after clicking Empty Recycle Bin.

[falko]

Which distribution are you using? Are there any errors in the logs? Did you try both active and passive transfers in your FTP client?

[pyropoptrt]

Hey Falko, I'm using ISPConfig 2.2.3o and I've tried connected via active and passive and neither has worked. Honestly, I don't remember how to access the ISPConfig logs to find the error.

[pyropoptrt]

here is the latest entry from proftpd.log

Jun 05 13:26:30 outpost proftpd[28088] outpost (67.98.241.15[67.98.241.15]): FTP session opened.
Jun 05 13:26:30 outpost proftpd[28088] outpost (67.98.241.15[67.98.241.15]): mod_delay/0.5: delaying for 156 usecs
Jun 05 13:26:30 outpost proftpd[28088] outpost (67.98.241.15[67.98.241.15]): no such user 'ergon.mobi_ergon'
Jun 05 13:26:30 outpost proftpd[28088] outpost (67.98.241.15[67.98.241.15]): USER ergon.mobi_ergon: no such user found from 67.98.241.15 [67.98.241.15] to $
Jun 05 13:26:30 outpost proftpd[28088] outpost (67.98.241.15[67.98.241.15]): mod_delay/0.5: delaying for 1334014 usecs
Jun 05 13:26:32 outpost proftpd[28088] outpost (67.98.241.15[67.98.241.15]): FTP session closed.

[pyropoptrt]

and this is info from the isp_isp_user table show that the user does exist

> select doc_id, user_username, user_admin, user_shell from isp_isp_user order by doc_id desc limit 1;

+--------+------------------+------------+------------+
| doc_id | user_username | user_admin | user_shell |
+--------+------------------+------------+------------+
| 86 | ergon.mobi_ergon | 1 | 1 |
+--------+------------------+------------+------------+

[till]

FTP does not authenticate against the mysql database, it authenticates against /etc/password. The problem is that usernames may not contain a dot, change your username or username_prefix so that there is no dot in it.

[pyropoptrt]

well the username is generated from ISPConfig for that particular site. I have a passwd file and a passwd-. I checked both files and neither contain that new user I've created. So, do I need to start manually users to the passwd file or is this some kind of bug that is in ISPConfig 2.2.30?

[till]

ISPConfig does not create usernames with a dot by default and this is no bug. You must have changed the username prefix to a wrong value. Please change it back to the original value.

[pyropoptrt]

So based on what you're saying this username wouldn't work on this example site because it has a dot in the name as well?

http://www.pyropoptrt.com/images/isp_userpanel.png

[falko]

well the username is generated from ISPConfig for that particular site. I have a passwd file and a passwd-. I checked both files and neither contain that new user I've created.
What's the output of ls -la /root/ispconfig? Are there any warnings in /home/admispconfig/ispconfig/ispconfig.log?

[pyropoptrt]

What's the output of ls -la /root/ispconfig?

drwxr-xr-x 10 root root 4096 2008-02-11 02:14 .
drwxr-xr-x 4 root root 4096 2008-02-11 02:14 ..
-rwxr-xr-x 1 root root 34607 2009-04-01 23:37 cronolog
-rwxr-xr-x 1 root root 9673 2009-04-01 23:37 cronosplit
drwxr-xr-x 12 root root 4096 2009-04-01 23:28 httpd
drwxr-xr-x 16 root root 4096 2009-04-01 23:37 isp
drwxr-xr-x 7 root root 4096 2009-04-01 23:29 libmcrypt
-rw-r--r-- 1 root root 8 2009-04-01 23:37 .old_path_httpd_root
drwxr-xr-x 6 root root 4096 2009-04-01 23:28 openssl
drwxr-xr-x 6 root root 4096 2009-04-01 23:33 php
drwxr-xr-x 4 root root 4096 2008-02-11 02:14 scripts
drwxr-xr-x 4 root root 4096 2009-04-01 23:37 standard_cgis
drwxr-xr-x 2 root root 4096 2009-04-01 23:37 sv
-rwx------ 1 root root 9389 2009-04-01 23:37 uninstall


Are there any warnings in /home/admispconfig/ispconfig/ispconfig.log?

There are 35,174 lines in the file. Here's some lines pertaining to that username:

05.06.2009 - 10:21:48 => DEBUG - Could not connect as user ergon.mobi_ergon <a href='https://servername.com:81/i$
05.06.2009 - 10:21:51 => DEBUG - Could not connect as user ergon.mobi_ergon <a href='https://servername.com:81/i$
05.06.2009 - 10:21:53 => DEBUG - Could not connect as user ergon.mobi_ergon <a href='https://servername.com:81/i$

I removed the server name obviously.

[falko]

Do you see any errors when you run
/root/ispconfig/php/php /root/ispconfig/scripts/writeconf.php
manually on the shell?

[pyropoptrt]

here's the output when running that command

start
INSERT: 47
INSERT: 46
INSERT: 49
UPDATE: 20
UPDATE: 45
DELETE: 50
DELETE: 51
INSERT USER: 87
INSERT USER: 80
INSERT USER: 81
INSERT USER: 84
INSERT USER: 86
INSERT USER: 88
mkdir: cannot create directory `etc': File exists
mkdir: cannot create directory `etc/pam.d/': File exists
mkdir: cannot create directory `bin': File exists
mkdir: cannot create directory `lib': File exists
mkdir: cannot create directory `usr/bin': File exists
mkdir: cannot create directory `dev': File exists
mknod: `dev/null': File exists
mknod: `dev/zero': File exists
mkdir: cannot create directory `/var/www/web20/.//var': File exists
mkdir: cannot create directory `/var/www/web20/.//var/run': File exists
mkdir: cannot create directory `/var/www/web20/.//var/run/mysqld': File exists
UPDATE USER: 21
UPDATE USER: 62
UPDATE USER: 78
mkdir: cannot create directory `etc': File exists
mkdir: cannot create directory `etc/pam.d/': File exists
mkdir: cannot create directory `bin': File exists
mkdir: cannot create directory `lib': File exists
mkdir: cannot create directory `usr/bin': File exists
mkdir: cannot create directory `dev': File exists
mknod: `dev/null': File exists
mknod: `dev/zero': File exists
mkdir: cannot create directory `/var/www/web45/.//var': File exists
mkdir: cannot create directory `/var/www/web45/.//var/run': File exists
mkdir: cannot create directory `/var/www/web45/.//var/run/mysqld': File exists
ln: creating symbolic link `/var/www/web45/.//var/run/mysqld/mysqld.sock' to `/var/run/mysqld/mysqld.sock': File exists
UPDATE USER: 79
DELETE USER: 89
ende

[pyropoptrt]

after running that last command you gave me the user seems to be working. Was that last command just updating conf files? Any ideas of what could have caused this issue with it not adding the user to the /etc/passwd file?

[falko]

It seems as if the command wasn't run for a while - it should've run automatically. Can you post the output of ps aux?

[pyropoptrt]

here you go Falko:

USER PID %CPU %MEM VSZ RSS TTY STAT START TIME COMMAND
root 1 0.0 0.0 2948 1852 ? Ss 2008 0:09 /sbin/init
root 2 0.0 0.0 0 0 ? S< 2008 0:00 [kthreadd]
root 3 0.0 0.0 0 0 ? S< 2008 0:02 [migration/0]
root 4 0.0 0.0 0 0 ? SN 2008 0:00 [ksoftirqd/0]
root 5 0.0 0.0 0 0 ? S< 2008 0:00 [watchdog/0]
root 6 0.0 0.0 0 0 ? S< 2008 0:06 [migration/1]
root 7 0.0 0.0 0 0 ? SN 2008 0:00 [ksoftirqd/1]
root 8 0.0 0.0 0 0 ? S< 2008 0:00 [watchdog/1]
root 9 0.0 0.0 0 0 ? S< 2008 0:03 [migration/2]
root 10 0.0 0.0 0 0 ? SN 2008 0:00 [ksoftirqd/2]
root 11 0.0 0.0 0 0 ? S< 2008 0:00 [watchdog/2]
root 12 0.0 0.0 0 0 ? S< 2008 0:06 [migration/3]
root 13 0.0 0.0 0 0 ? SN 2008 0:00 [ksoftirqd/3]
root 14 0.0 0.0 0 0 ? S< 2008 0:00 [watchdog/3]
root 15 0.0 0.0 0 0 ? S< 2008 0:00 [events/0]
root 16 0.0 0.0 0 0 ? S< 2008 0:00 [events/1]
root 17 0.0 0.0 0 0 ? S< 2008 0:00 [events/2]
root 18 0.0 0.0 0 0 ? S< 2008 0:00 [events/3]
root 19 0.0 0.0 0 0 ? S< 2008 0:00 [khelper]
root 41 0.0 0.0 0 0 ? S< 2008 0:00 [kblockd/0]
root 42 0.0 0.0 0 0 ? S< 2008 0:00 [kblockd/1]
root 43 0.0 0.0 0 0 ? S< 2008 0:00 [kblockd/2]
root 44 0.0 0.0 0 0 ? S< 2008 0:00 [kblockd/3]
root 45 0.0 0.0 0 0 ? S< 2008 0:00 [kacpid]
root 46 0.0 0.0 0 0 ? S< 2008 0:00 [kacpi_notify]
root 161 0.0 0.0 0 0 ? S< 2008 0:00 [kseriod]
root 198 0.0 0.0 0 0 ? S 2008 0:04 [pdflush]
root 199 0.0 0.0 0 0 ? S 2008 0:01 [pdflush]
root 200 0.0 0.0 0 0 ? S< 2008 0:15 [kswapd0]
root 251 0.0 0.0 0 0 ? S< 2008 0:00 [aio/0]
root 252 0.0 0.0 0 0 ? S< 2008 0:00 [aio/1]
root 253 0.0 0.0 0 0 ? S< 2008 0:00 [aio/2]
root 254 0.0 0.0 0 0 ? S< 2008 0:00 [aio/3]
root 2065 0.0 0.0 0 0 ? S< 2008 0:00 [ksuspend_usbd]
root 2067 0.0 0.0 0 0 ? S< 2008 0:00 [khubd]
root 2154 0.0 0.0 0 0 ? S< 2008 0:00 [ata/0]
root 2155 0.0 0.0 0 0 ? S< 2008 0:00 [ata/1]
root 2157 0.0 0.0 0 0 ? S< 2008 0:00 [ata/2]
root 2158 0.0 0.0 0 0 ? S< 2008 0:00 [ata/3]
root 2159 0.0 0.0 0 0 ? S< 2008 0:00 [ata_aux]
root 2208 0.0 0.0 0 0 ? S< 2008 0:00 [scsi_eh_0]
root 2215 0.0 0.0 0 0 ? S< 2008 0:00 [scsi_eh_1]
root 2216 0.0 0.0 0 0 ? S< 2008 0:00 [scsi_eh_2]
root 2420 0.0 0.0 0 0 ? S< 2008 3:04 [kjournald]
root 2615 0.0 0.0 2448 668 ? S<s 2008 0:00 /sbin/udevd --daemon
root 3617 0.0 0.0 0 0 ? S< 2008 0:00 [kpsmoused]
root 4189 0.0 0.0 1692 516 tty4 Ss+ 2008 0:00 /sbin/getty 38400 tty4
root 4190 0.0 0.0 1696 516 tty5 Ss+ 2008 0:00 /sbin/getty 38400 tty5
root 4192 0.0 0.0 1692 516 tty2 Ss+ 2008 0:00 /sbin/getty 38400 tty2
root 4193 0.0 0.0 1696 520 tty3 Ss+ 2008 0:00 /sbin/getty 38400 tty3
root 4194 0.0 0.0 1696 520 tty1 Ss+ 2008 0:00 /sbin/getty 38400 tty1
root 4196 0.0 0.0 1692 516 tty6 Ss+ 2008 0:00 /sbin/getty 38400 tty6
syslog 4239 0.0 0.0 1912 736 ? Ss 2008 0:49 /sbin/syslogd -a /var/lib/named/dev/log -u syslog
root 4258 0.0 0.0 1836 536 ? S 2008 0:00 /bin/dd bs 1 if /proc/kmsg of /var/run/klogd/kmsg
klog 4260 0.0 0.0 2600 1396 ? Ss 2008 0:00 /sbin/klogd -P /var/run/klogd/kmsg
root 4475 0.0 0.0 1864 432 ? S 2008 0:00 /usr/sbin/courierlogger -pid=/var/run/courier/authdaemon/pid -start /usr/lib/courier/courier-authlib/authdaemond
root 4476 0.0 0.0 2032 628 ? S 2008 0:00 /usr/lib/courier/courier-authlib/authdaemond
root 4495 0.0 0.0 1868 352 ? S 2008 0:00 /usr/sbin/courierlogger -pid=/var/run/courier/imapd.pid -start -name=imapd /usr/sbin/couriertcpd -address=0 -maxprocs=40 -maxperip=20 -nodnsl
root 4496 0.0 0.0 1972 588 ? S 2008 0:00 /usr/sbin/couriertcpd -address=0 -maxprocs=40 -maxperip=20 -nodnslookup -noidentlookup 143 /usr/lib/courier/courier/imaplogin /usr/bin/imapd
root 4499 0.0 0.0 2032 256 ? S 2008 0:00 /usr/lib/courier/courier-authlib/authdaemond
root 4500 0.0 0.0 2032 256 ? S 2008 0:00 /usr/lib/courier/courier-authlib/authdaemond
root 4501 0.0 0.0 2032 256 ? S 2008 0:00 /usr/lib/courier/courier-authlib/authdaemond
root 4502 0.0 0.0 2032 256 ? S 2008 0:00 /usr/lib/courier/courier-authlib/authdaemond
root 4503 0.0 0.0 2032 256 ? S 2008 0:00 /usr/lib/courier/courier-authlib/authdaemond
root 4520 0.0 0.0 1868 352 ? S 2008 0:00 /usr/sbin/courierlogger -pid=/var/run/courier/imapd-ssl.pid -start -name=imapd-ssl /usr/sbin/couriertcpd -address=0 -maxprocs=40 -maxperip=20
root 4521 0.0 0.0 1972 592 ? S 2008 0:00 /usr/sbin/couriertcpd -address=0 -maxprocs=40 -maxperip=20 -nodnslookup -noidentlookup 993 /usr/bin/couriertls -server -tcpd /usr/lib/courier
root 4534 0.0 0.0 1972 552 ? S 2008 0:00 /usr/sbin/couriertcpd -pid=/var/run/courier/pop3d.pid -stderrlogger=/usr/sbin/courierlogger -maxprocs=40 -maxperip=4 -nodnslookup -noidentloo
root 4536 0.0 0.0 1868 528 ? S 2008 0:00 /usr/sbin/courierlogger courierpop3login
root 4555 0.0 0.0 1864 348 ? S 2008 0:00 /usr/sbin/courierlogger -pid=/var/run/courier/pop3d-ssl.pid -start -name=pop3d-ssl /usr/sbin/couriertcpd -address=0 -maxprocs=40 -maxperip=4
root 4556 0.0 0.0 1968 588 ? S 2008 0:00 /usr/sbin/couriertcpd -address=0 -maxprocs=40 -maxperip=4 -nodnslookup -noidentlookup 995 /usr/bin/couriertls -server -tcpd /usr/lib/courier/
root 4641 0.0 0.0 7452 744 ? Ss 2008 0:00 /usr/sbin/saslauthd -a pam -c -m /var/spool/postfix/var/run/saslauthd -n 5
root 4642 0.0 0.0 7452 472 ? S 2008 0:00 /usr/sbin/saslauthd -a pam -c -m /var/spool/postfix/var/run/saslauthd -n 5
root 4643 0.0 0.0 7452 356 ? S 2008 0:00 /usr/sbin/saslauthd -a pam -c -m /var/spool/postfix/var/run/saslauthd -n 5
root 4644 0.0 0.0 7452 356 ? S 2008 0:00 /usr/sbin/saslauthd -a pam -c -m /var/spool/postfix/var/run/saslauthd -n 5
root 4645 0.0 0.0 7452 356 ? S 2008 0:00 /usr/sbin/saslauthd -a pam -c -m /var/spool/postfix/var/run/saslauthd -n 5
ntp 4721 0.0 0.0 4108 1216 ? Ss 2008 0:00 /usr/sbin/ntpd -p /var/run/ntpd.pid -u 106:111 -g
daemon 4754 0.0 0.0 1964 432 ? Ss 2008 0:00 /usr/sbin/atd
root 5934 0.0 0.0 1736 472 ? S Jun08 0:00 /root/ispconfig/cronolog --symlink=/var/log/httpd/ispconfig_access_log /var/log/httpd/ispconfig_access_log_%Y_%m_%d
root 5935 0.0 0.0 1736 472 ? S Jun08 0:00 /root/ispconfig/cronolog --symlink=/var/log/httpd/ispconfig_access_log /var/log/httpd/ispconfig_access_log_%Y_%m_%d
bind 6118 0.0 0.3 36020 8240 ? Ssl Jun08 0:00 /usr/sbin/named -u bind -t /var/lib/named
root 6953 0.0 0.0 3864 1384 ? S Apr01 0:00 /bin/sh /usr/bin/mysqld_safe
mysql 6990 0.0 2.0 133332 41960 ? Sl Apr01 2:13 /usr/sbin/mysqld --basedir=/usr --datadir=/var/lib/mysql --user=mysql --pid-file=/var/run/mysqld/mysqld.pid --skip-external-locking --port=33
root 6991 0.0 0.0 2892 688 ? S Apr01 0:00 logger -p daemon.err -t mysqld_safe -i -t mysqld
1001 8766 0.0 0.0 0 0 ? Z Jun08 0:00 [freshclam] <defunct>
1001 12892 0.0 0.0 0 0 ? Z Jun08 0:00 [freshclam] <defunct>
root 14573 0.0 0.0 5284 996 ? Ss Jan26 0:33 /usr/sbin/sshd
1001 18691 0.0 0.0 0 0 ? Z Jun08 0:00 [freshclam] <defunct>
root 19187 0.0 0.0 5324 1680 ? Ss Jun08 0:00 /usr/lib/postfix/master
postfix 19200 0.0 0.0 5368 1728 ? S Jun08 0:00 qmgr -l -t fifo -u
1001 25343 0.0 0.0 0 0 ? Z 09:19 0:00 [freshclam] <defunct>
root 25523 0.0 0.1 8036 2504 ? Ss 09:31 0:00 sshd: dtirfsolutions.com_admin [priv]
10076 25527 0.0 0.0 8036 1696 ? S 09:31 0:00 sshd: dtirfsolutions.com_admin@notty
10076 25528 0.0 0.0 4524 1240 ? Ss 09:31 0:00 /usr/lib/openssh/sftp-server
root 25529 0.0 0.1 8036 2504 ? Ss 09:31 0:00 sshd: dtiruggedpower.com_admin [priv]
10054 25531 0.0 0.0 8184 1720 ? S 09:31 0:00 sshd: dtiruggedpower.com_admin@notty
10054 25532 0.0 0.0 4532 1284 ? Ss 09:31 0:00 /usr/lib/openssh/sftp-server
root 25533 0.0 0.1 8036 2504 ? Ss 09:31 0:00 sshd: dtims.com_admin [priv]
10045 25535 0.0 0.0 8340 1852 ? S 09:31 0:00 sshd: dtims.com_admin@notty
10045 25536 0.0 0.0 4628 1340 ? Ss 09:31 0:00 /usr/lib/openssh/sftp-server
postfix 25597 0.0 0.1 5652 2380 ? S 09:35 0:00 tlsmgr -l -t unix -u -c
postfix 25899 0.0 0.0 5332 1608 ? S 09:54 0:00 pickup -l -t fifo -u -c
1001 25964 0.0 0.4 16364 10208 ? S Apr13 0:23 /root/ispconfig/httpd/bin/ispconfig_httpd -DSSL
root 26135 0.0 0.0 3552 1032 ? Ss Apr01 0:04 /usr/sbin/cron
www-data 26317 0.0 0.5 41716 12328 ? S 10:23 0:00 /usr/sbin/apache2 -k start
www-data 26318 0.0 0.5 41708 12264 ? S 10:23 0:00 /usr/sbin/apache2 -k start
root 26391 0.0 0.4 15536 9052 ? Ss Apr01 0:00 /root/ispconfig/httpd/bin/ispconfig_httpd -DSSL
root 26392 0.0 0.0 3868 1332 ? S Apr01 2:48 /bin/bash /root/ispconfig/sv/ispconfig_wconf
1001 26403 0.0 0.5 18000 11964 ? S Apr01 0:23 /root/ispconfig/httpd/bin/ispconfig_httpd -DSSL
www-data 26430 0.0 0.5 41708 12248 ? S 10:30 0:00 /usr/sbin/apache2 -k start
www-data 26626 0.0 0.5 41576 12140 ? S 10:45 0:00 /usr/sbin/apache2 -k start
www-data 26640 0.0 0.5 41552 11264 ? S 10:46 0:00 /usr/sbin/apache2 -k start
www-data 26642 0.0 0.4 41420 9492 ? S 10:46 0:00 /usr/sbin/apache2 -k start
www-data 26647 0.0 0.5 41576 12164 ? S 10:46 0:00 /usr/sbin/apache2 -k start
www-data 26672 0.0 0.4 41420 9464 ? S 10:48 0:00 /usr/sbin/apache2 -k start
www-data 26677 0.0 0.5 41576 11964 ? S 10:48 0:00 /usr/sbin/apache2 -k start
proftpd 26729 0.0 0.0 9372 1520 ? Ss Apr01 0:00 proftpd: (accepting connections)
www-data 26732 0.0 0.4 41420 9464 ? S 10:52 0:00 /usr/sbin/apache2 -k start
1001 26735 0.0 0.0 3016 1252 ? Ss Apr01 0:07 /home/admispconfig/ispconfig/tools/clamav/bin/freshclam -d -c 10 --datadir=/home/admispconfig/ispconfig/tools/clamav/share/clamav
root 26794 0.0 0.1 8036 2404 ? Ss 10:57 0:00 sshd: ergon [priv]
ergon 26796 0.0 0.0 8036 1532 ? S 10:57 0:00 sshd: ergon@pts/0
ergon 26797 0.3 0.1 5624 2992 pts/0 Ss 10:57 0:00 -bash
root 26823 0.0 0.0 2892 616 ? S 10:58 0:00 sleep 10
ergon 26824 0.0 0.0 2624 1000 pts/0 R+ 10:58 0:00 ps aux
root 32352 0.0 0.7 41420 16316 ? Rs Apr08 0:07 /usr/sbin/apache2 -k start

[till]

Please run:

/etc/init.d/ispconfig_server restart

[pyropoptrt]

Will do later on tonight when the server load will be as minimal as possible.

[pyropoptrt]

forgot to do this last night. I'll do this and the update to 2.3.2 this evening.

[till]

The latest release is 2.2.32 and not 2.3.2. 2.3.2 is a test version which is about 2 years old and outdated and not available for download anymore for some time.

[pyropoptrt]

oops, I meant 2.2.32.

[pyropoptrt]

Please run:

/etc/init.d/ispconfig_server restart

I've restarted ispconfig. Didn't get a chance to update to the latest release but it'll be done over the weekend.