Mozilla/5.0 (X11; U; Linux i686; en-US; rv:1.8.0.7)
Gecko/20060909 Firefox/1.5.0.7
Linux io 2.6.8-3-686-smp #1 SMP Thu Sep 7 04:39:15 UTC
2006 i686 GNU/Linux
Debian GNU/Linux 3.1 - mixed ( not stirred ;-)
I logged into webmin, and created a user. When I
clicked save... 404. Webmin had shutdown. I confirmed
this by attempting to stop webmin. I've looked through
the logs but have not come up with any error.
Logged In: YES
user_id=992058
Webmin stopped again with a deletion of a user.
Logged In: YES
user_id=129364
Does anything get logged to /var/webmin/miniserv.error when
you try to add a user? Webmin's web server should be
re-configured as part of this process, but not killed!
Logged In: YES
user_id=992058
I checked all the logs both times... no error reported.
/var/log/webmin/miniserv.err
[21/Oct/2006:07:28:21 -0700] miniserv.pl started
[21/Oct/2006:07:28:21 -0700] PAM authentication enabled
[21/Oct/2006:08:32:57 -0700] miniserv.pl started
[21/Oct/2006:08:32:57 -0700] PAM authentication enabled
[21/Oct/2006:08:33:13 -0700] miniserv.pl started
[21/Oct/2006:08:33:13 -0700] PAM authentication enabled
[21/Oct/2006:09:20:19 -0700] miniserv.pl started
[21/Oct/2006:09:20:19 -0700] PAM authentication enabled
/var/log/webmin/miniserv.log
192.168.13.114 - - [21/Oct/2006:08:31:27 -0700] "GET /
HTTP/1.1" 401 1293
192.168.13.114 - - [21/Oct/2006:08:31:27 -0700] "GET
/favicon.ico HTTP/1.1" 401 1293
192.168.13.114 - - [21/Oct/2006:08:31:32 -0700] "POST
/session_login.cgi HTTP/1.1" 401 1342
192.168.13.114 - root [21/Oct/2006:08:31:37 -0700] "POST
/session_login.cgi HTTP/1.1" 302 0
192.168.13.114 - root [21/Oct/2006:08:31:37 -0700] "GET /
HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:31:53 -0700] "GET
/acl/ HTTP/1.1" 200 11678
192.168.13.114 - root [21/Oct/2006:08:31:53 -0700] "GET
/images/left.gif HTTP/1.1" 200 118
192.168.13.114 - root [21/Oct/2006:08:31:55 -0700] "GET
/acl/edit_user.cgi HTTP/1.1" 200 16660
192.168.13.114 - root [21/Oct/2006:08:32:11 -0700] "POST
/acl/save_user.cgi HTTP/1.1" 302 0
192.168.13.114 - root [21/Oct/2006:08:33:15 -0700] "GET /
HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:33:20 -0700] "GET
/acl/ HTTP/1.1" 200 20861
192.168.13.114 - root [21/Oct/2006:08:38:14 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:38:19 -0700] "GET
/webminlog/ HTTP/1.1" 200 6439
192.168.13.114 - root [21/Oct/2006:08:38:27 -0700] "GET
/webminlog/search.cgi?uall=1&user=admin&nuser=admin&mall=1&module=adsl-client&tall=2&from_d=&from_m=0&from_y=&to_d=&to_m=0&to_y=&fall=1&file=
HTTP/1.1" 200 1395
192.168.13.114 - root [21/Oct/2006:08:38:31 -0700] "GET
/webminlog/view.cgi?id=1161444731.3147.0&return=%3C/td%3E%3Ctd%20%3E&returndesc=%3C/td%3E%3Ctd%20%3E
HTTP/1.1" 200 3266
192.168.13.114 - root [21/Oct/2006:08:38:51 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:41:00 -0700] "GET
/init/ HTTP/1.1" 200 20001
192.168.13.114 - root [21/Oct/2006:08:41:08 -0700] "GET
/?cat=system HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:41:58 -0700] "GET
/webmin/ HTTP/1.1" 200 3885
192.168.13.114 - root [21/Oct/2006:08:42:01 -0700] "GET
/webmin/edit_log.cgi HTTP/1.1" 200 6429
192.168.13.114 - root [21/Oct/2006:08:42:31 -0700] "GET
/webmin/index.cgi HTTP/1.1" 200 3885
192.168.13.114 - root [21/Oct/2006:08:42:47 -0700] "GET
/webmin/edit_advanced.cgi HTTP/1.1" 200 8057
192.168.13.114 - root [21/Oct/2006:08:42:51 -0700] "GET
/webmin/index.cgi HTTP/1.1" 200 3885
192.168.13.114 - root [21/Oct/2006:08:42:56 -0700] "GET
/webmin/edit_proxy.cgi HTTP/1.1" 200 9200
192.168.13.114 - root [21/Oct/2006:08:43:20 -0700] "GET
/webmin/index.cgi HTTP/1.1" 200 3885
192.168.13.114 - root [21/Oct/2006:08:43:22 -0700] "GET
/webmin/edit_proxy.cgi HTTP/1.1" 200 9200
192.168.13.114 - root [21/Oct/2006:08:43:32 -0700] "GET
/webmin/index.cgi HTTP/1.1" 200 3885
192.168.13.114 - root [21/Oct/2006:08:43:41 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:43:57 -0700] "GET
/acl/ HTTP/1.1" 200 20861
192.168.13.114 - root [21/Oct/2006:08:45:03 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:08:46:29 -0700] "GET
/acl/ HTTP/1.1" 200 20861
192.168.13.114 - root [21/Oct/2006:08:50:35 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7331
192.168.13.114 - root [21/Oct/2006:09:04:00 -0700] "GET
/acl/ HTTP/1.1" 200 20861
192.168.13.114 - root [21/Oct/2006:09:04:02 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7331
192.168.13.114 - - [21/Oct/2006:09:04:03 -0700] "GET
/session_login.cgi?logout=1 HTTP/1.1" 401 1359
192.168.13.114 - admin [21/Oct/2006:09:04:08 -0700] "POST
/session_login.cgi HTTP/1.1" 302 0
192.168.13.114 - admin [21/Oct/2006:09:04:08 -0700] "GET /
HTTP/1.1" 200 7447
192.168.13.114 - admin [21/Oct/2006:09:04:11 -0700] "GET
/acl/ HTTP/1.1" 200 20862
192.168.13.114 - admin [21/Oct/2006:09:04:18 -0700] "POST
/acl/delete_users.cgi HTTP/1.1" 200 1224
192.168.13.114 - admin [21/Oct/2006:09:04:20 -0700] "POST
/acl/delete_users.cgi HTTP/1.1" 302 0
192.168.13.114 - admin [21/Oct/2006:09:20:27 -0700] "GET /
HTTP/1.1" 200 7447
192.168.13.114 - admin [21/Oct/2006:09:20:32 -0700] "GET
/webmin/ HTTP/1.1" 200 3886
192.168.13.114 - admin [21/Oct/2006:09:20:34 -0700] "GET
/webmin/edit_upgrade.cgi HTTP/1.1" 200 6254
192.168.13.114 - admin [21/Oct/2006:09:20:39 -0700] "GET
/webmin/update.cgi?source=0&other=&missing=1&third=1&upuser=&uppass=
HTTP/1.1" 200 1054
192.168.13.114 - admin [21/Oct/2006:09:20:42 -0700] "GET
/webmin/edit_upgrade.cgi HTTP/1.1" 200 6254
192.168.13.114 - admin [21/Oct/2006:09:21:42 -0700] "GET
/?cat=webmin HTTP/1.1" 200 7447
192.168.13.114 - admin [21/Oct/2006:09:21:52 -0700] "GET
/net/ HTTP/1.1" 200 1791
192.168.13.114 - admin [21/Oct/2006:09:21:55 -0700] "GET
/net/list_dns.cgi HTTP/1.1" 200 3165
192.168.13.114 - admin [21/Oct/2006:09:22:21 -0700] "GET
/net/save_dns.cgi?hostname=io&order_0=files&order_1=dns&order_2=&order_3=&order_4=&order_5=&hosts=1&nameserver_0=68.2.16.30&nameserver_1=68.1.208.30&nameserver_2=&domain_def=1&domain=
HTTP/1.1" 200 1022
Logged In: YES
user_id=129364
Try this - run the command :
strace -p `cat /var/webmin/miniserv.pid`
in a shell window, and then try creating a Webmin user. Then
post the output of that command to this bug report .. it
will show me what is going wrong.
Logged In: YES
user_id=992058
As requested:
# strace -p `cat /var/run/webmin.pid`
Process 3263 attached - interrupt to quit
select(8, [6 7], NULL, NULL, {4, 521000}) = 0 (Timeout)
time(NULL) = 1161572609
waitpid(-1, 0xbfffda68, WNOHANG) = -1 ECHILD (No
child processes)
select(8, [6 7], NULL, NULL, {10, 0}) = 1 (in [6], left
{3, 107000})
time(NULL) = 1161572616
waitpid(-1, 0xbfffda68, WNOHANG) = -1 ECHILD (No
child processes)
accept(6, {sa_family=AF_INET, sin_port=htons(55143),
sin_addr=inet_addr("192.168.13.114")}, [16]) = 10
ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffc858) = -1
EINVAL (Invalid argument)
_llseek(10, 0, 0xbfffc8a0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffc858) = -1
EINVAL (Invalid argument)
_llseek(10, 0, 0xbfffc8a0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(10, F_SETFD, FD_CLOEXEC) = 0
pipe([11, 12]) = 0
ioctl(11, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(11, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(12, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(12, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(11, F_SETFD, FD_CLOEXEC) = 0
fcntl64(12, F_SETFD, FD_CLOEXEC) = 0
pipe([13, 14]) = 0
ioctl(13, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(13, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(14, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(14, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(13, F_SETFD, FD_CLOEXEC) = 0
fcntl64(14, F_SETFD, FD_CLOEXEC) = 0
clone(child_stack=0,
flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD,
child_tidptr=0x401b20c8) = 3272
close(12) = 0
close(13) = 0
close(10) = 0
select(16, [6 7 11], NULL, NULL, {10, 0}) = 1 (in [11], left
{9, 905000})
time(NULL) = 1161572616
waitpid(-1, 0xbfffda68, WNOHANG) = 0
read(11, "verify c4da62bf4381fc66aea52d0b0"..., 4096) = 40
write(14, "2 admin\n", 8) = 8
select(16, [6 7 11], NULL, NULL, {10, 0}) = 1 (in [11], left
{9, 641000})
time(NULL) = 1161572616
waitpid(-1, 0xbfffda68, WNOHANG) = 0
read(11, "", 4096) = 0
close(11) = 0
close(14) = 0
select(8, [6 7], NULL, NULL, {10, 0}) = ? ERESTARTNOHAND
(To be restarted)
--- SIGCHLD (Child exited) @ 0 (0) ---
select(8, [6 7], NULL, NULL, {9, 994000}) = 1 (in [6], left
{4, 612000})
time(NULL) = 1161572622
waitpid(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}],
WNOHANG) = 3272
waitpid(-1, 0xbfffda68, WNOHANG) = -1 ECHILD (No
child processes)
accept(6, {sa_family=AF_INET, sin_port=htons(55148),
sin_addr=inet_addr("192.168.13.114")}, [16]) = 10
ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffc858) = -1
EINVAL (Invalid argument)
_llseek(10, 0, 0xbfffc8a0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffc858) = -1
EINVAL (Invalid argument)
_llseek(10, 0, 0xbfffc8a0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(10, F_SETFD, FD_CLOEXEC) = 0
pipe([11, 12]) = 0
ioctl(11, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(11, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(12, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(12, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(11, F_SETFD, FD_CLOEXEC) = 0
fcntl64(12, F_SETFD, FD_CLOEXEC) = 0
pipe([13, 14]) = 0
ioctl(13, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(13, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(14, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(14, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(13, F_SETFD, FD_CLOEXEC) = 0
fcntl64(14, F_SETFD, FD_CLOEXEC) = 0
clone(child_stack=0,
flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD,
child_tidptr=0x401b20c8) = 3277
close(12) = 0
close(13) = 0
close(10) = 0
select(16, [6 7 11], NULL, NULL, {10, 0}) = 1 (in [11], left
{9, 958000})
time(NULL) = 1161572622
waitpid(-1, 0xbfffda68, WNOHANG) = 0
read(11, "verify c4da62bf4381fc66aea52d0b0"..., 4096) = 40
write(14, "2 admin\n", 8) = 8
select(16, [6 7 11], NULL, NULL, {10, 0}) = 1 (in [11], left
{9, 503000})
time(NULL) = 1161572622
waitpid(-1, 0xbfffda68, WNOHANG) = 0
read(11, "", 4096) = 0
close(11) = 0
close(14) = 0
select(8, [6 7], NULL, NULL, {10, 0}) = ? ERESTARTNOHAND
(To be restarted)
--- SIGCHLD (Child exited) @ 0 (0) ---
select(8, [6 7], NULL, NULL, {9, 992000}) = 0 (Timeout)
time(NULL) = 1161572632
waitpid(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}],
WNOHANG) = 3277
waitpid(-1, 0xbfffda68, WNOHANG) = -1 ECHILD (No
child processes)
select(8, [6 7], NULL, NULL, {10, 0}) = 0 (Timeout)
time(NULL) = 1161572642
waitpid(-1, 0xbfffda68, WNOHANG) = -1 ECHILD (No
child processes)
select(8, [6 7], NULL, NULL, {10, 0}) = 1 (in [6], left
{2, 679000})
time(NULL) = 1161572649
waitpid(-1, 0xbfffda68, WNOHANG) = -1 ECHILD (No
child processes)
accept(6, {sa_family=AF_INET, sin_port=htons(55173),
sin_addr=inet_addr("192.168.13.114")}, [16]) = 10
ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffc858) = -1
EINVAL (Invalid argument)
_llseek(10, 0, 0xbfffc8a0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(10, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffc858) = -1
EINVAL (Invalid argument)
_llseek(10, 0, 0xbfffc8a0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(10, F_SETFD, FD_CLOEXEC) = 0
pipe([11, 12]) = 0
ioctl(11, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(11, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(12, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(12, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(11, F_SETFD, FD_CLOEXEC) = 0
fcntl64(12, F_SETFD, FD_CLOEXEC) = 0
pipe([13, 14]) = 0
ioctl(13, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(13, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
ioctl(14, SNDCTL_TMR_TIMEBASE or TCGETS, 0xbfffd868) = -1
EINVAL (Invalid argument)
_llseek(14, 0, 0xbfffd8b0, SEEK_CUR) = -1 ESPIPE (Illegal
seek)
fcntl64(13, F_SETFD, FD_CLOEXEC) = 0
fcntl64(14, F_SETFD, FD_CLOEXEC) = 0
clone(child_stack=0,
flags=CLONE_CHILD_CLEARTID|CLONE_CHILD_SETTID|SIGCHLD,
child_tidptr=0x401b20c8) = 3282
close(12) = 0
close(13) = 0
close(10) = 0
select(16, [6 7 11], NULL, NULL, {10, 0}) = 1 (in [11], left
{9, 910000})
time(NULL) = 1161572650
waitpid(-1, 0xbfffda68, WNOHANG) = 0
read(11, "verify c4da62bf4381fc66aea52d0b0"..., 4096) = 40
write(14, "2 admin\n", 8) = 8
select(16, [6 7 11], NULL, NULL, {10, 0}) = ? ERESTARTNOHAND
(To be restarted)
--- SIGUSR1 (User defined signal 1) @ 0 (0) ---
Process 3263 detached
Logged In: YES
user_id=129364
Does Webmin fail in the same way if you go to the Webmin
Configuration module, click on IP Access Control, and click
'Save' ?
Logged In: YES
user_id=992058
ip access control saved fine for any host as well as a
specified host.
Logged In: YES
user_id=129364
Ok .. how about changing to a different theme? Does that
work OK?
Logged In: YES
user_id=992058
changing the theme also stops webmin.
# strace -p `cat /var/run/webmin.pid`
Process 5356 attached - interrupt to quit
select(24, [6 7 11 12 13 15 17 19], NULL, NULL, {6, 226000})
= 1 (in [13], left {0, 562000})
time(NULL) = 1161729610
waitpid(-1, 0xbffffc28, WNOHANG) = 0
read(13, "verify 28a30b774e8f1c4955bec03d8"..., 4096) = 40
write(18, "2 root\n", 7) = 7
select(24, [6 7 11 12 13 15 17 19], NULL, NULL, {10, 0}) = 1
(in [13], left {9, 626000})
time(NULL) = 1161729610
waitpid(-1, 0xbffffc28, WNOHANG) = 0
read(13, "", 4096) = 0
close(13) = 0
close(18) = 0
select(24, [6 7 11 12 15 17 19], NULL, NULL, {10, 0}) = ?
ERESTARTNOHAND (To be restarted)
--- SIGCHLD (Child exited) @ 0 (0) ---
select(24, [6 7 11 12 15 17 19], NULL, NULL, {9, 993000}) =
1 (in [11], left {8, 240000})
time(NULL) = 1161729612
waitpid(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}],
WNOHANG) = 5376
waitpid(-1, 0xbffffc28, WNOHANG) = 0
read(11, "verify 28a30b774e8f1c4955bec03d8"..., 4096) = 40
write(14, "2 root\n", 7) = 7
select(24, [6 7 11 12 15 17 19], NULL, NULL, {10, 0}) = 1
(in [11], left {9, 814000})
time(NULL) = 1161729612
waitpid(-1, 0xbffffc28, WNOHANG) = 0
read(11, "", 4096) = 0
close(11) = 0
close(14) = 0
select(24, [6 7 12 15 17 19], NULL, NULL, {10, 0}) = ?
ERESTARTNOHAND (To be restarted)
--- SIGCHLD (Child exited) @ 0 (0) ---
select(24, [6 7 12 15 17 19], NULL, NULL, {9, 994000}) = 1
(in [15], left {6, 380000})
time(NULL) = 1161729616
waitpid(-1, [{WIFEXITED(s) && WEXITSTATUS(s) == 0}],
WNOHANG) = 5374
waitpid(-1, 0xbffffc28, WNOHANG) = 0
read(15, "verify 28a30b774e8f1c4955bec03d8"..., 4096) = 40
write(20, "2 root\n", 7) = 7
--- SIGUSR1 (User defined signal 1) @ 0 (0) ---
Process 5356 detached
Logged In: YES
user_id=129364
For reasons unknown, it looks like the USR1 signal used to
re-configure Webmin's web server is instead killing it -
even though there is a signal handler in place.
I will add a work-around for this in the next release.