All of lore.kernel.org
 help / color / mirror / Atom feed
* automount errors under high load
@ 2006-11-03 21:22 Fletcher Mattox
  2006-11-04  0:15 ` Jeff Moyer
  2006-11-04  2:04 ` Ian Kent
  0 siblings, 2 replies; 7+ messages in thread
From: Fletcher Mattox @ 2006-11-03 21:22 UTC (permalink / raw)
  To: autofs

Hi,

Under high load (100 mount/sec) automount will fail with either of these
error messages from mount.

    mount: filer3:/vol/vol2/v2q017: can't read superblock
    mount: RPC: Authentication error; why = Client credential too weak

I find these error messages suspicious, and do not believe either of
them represent the true problem.  I have appended the debug output in
case that is useful.  I notice that it seems to try the mount seven
times each, before giving up with one of the above errors (usually
it is the superblock error).

I have also noticed corruption of /etc/mtab.  Sometimes static mounts
just disappear from it during busy times.  I assume this is some type
of race condition where file locking fails.  I do not know if this is
the same problem or a different problem, but I thought I would mention it.

I do not know what causes such a high load of mount requests.  But I see
them in the accounting files.  Nothing obvious is going on when the errors
occur.  They happen for several seconds at a time, 6-8 times per day.

The NFS client is ubuntu 6.06 (dapper), kernel 2.6.17.4, automount 4.1.4.
The NFS server is a Network Appliances filer.

Thanks,
Fletcher

Nov  2 08:41:09 smtp automount[3862]: handle_child: got pid 15301, sig 0 (0), stat 0 
Nov  2 08:41:09 smtp automount[3862]: sig_child: found pending iop pid 15301: signalled 0 (sig 0), exit status 0
Nov  2 08:41:09 smtp automount[3862]: send_ready: token=4324 
Nov  2 08:41:11 smtp automount[3862]: handle_packet: type = 0 
Nov  2 08:41:11 smtp automount[3862]: handle_packet_missing: token 4325, name v2q007 
Nov  2 08:41:11 smtp automount[3862]: attempting to mount entry /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: lookup(yp): looking up v2q007
Nov  2 08:41:11 smtp automount[15326]: ret = 1
Nov  2 08:41:11 smtp automount[15326]: lookup(yp): v2q007 -> -intr,grpid,quota,retry=2^Ifiler3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): expanded entry: -intr,grpid,quota,retry=2^Ifiler3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): dequote("intr,grpid,quota,retry=2") -> intr,grpid,quota,retry=2
Nov  2 08:41:11 smtp automount[15326]: parse(sun): gathered options: tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2
Nov  2 08:41:11 smtp automount[15326]: parse(sun): dequote("filer3:/vol/vol2/v2q007") -> filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): core of entry: options=tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2, loc=filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): mounting root /v/filer3, mountpoint v2q007, what filer3:/vol/vol2/v2q007, fstype nfs, options tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2 
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): root=/v/filer3 name=v2q007 what=filer3:/vol/vol2/v2q007, fstype=nfs, options=tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): nfs options="tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2", nosymlink=0, symlink=0, ro=0
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): is_local_mount: filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): from filer3:/vol/vol2/v2q007 elected filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): calling mkdir_path /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): calling mount -t nfs -s  -o tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2 filer3:/vol/vol2/v2q007 /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: >> mount: filer3:/vol/vol2/v2q007: can't read superblock
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): nfs: mount failure filer3:/vol/vol2/v2q007 on /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: failed to mount /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: umount_multi: path=/v/filer3/v2q007 incl=1 
Nov  2 08:41:11 smtp automount[15326]: umount_multi: no mounts found under /v/filer3/v2q007

^ permalink raw reply	[flat|nested] 7+ messages in thread
* automount errors under high load
@ 2006-11-03 21:22 Fletcher Mattox
  0 siblings, 0 replies; 7+ messages in thread
From: Fletcher Mattox @ 2006-11-03 21:22 UTC (permalink / raw)
  To: autofs

Hi,

Under high load (100 mount/sec) automount will fail with either of these
error messages from mount.

    mount: filer3:/vol/vol2/v2q017: can't read superblock
    mount: RPC: Authentication error; why = Client credential too weak

I find these error messages suspicious, and do not believe either of
them represent the true problem.  I have appended the debug output in
case that is useful.  I notice that it seems to try the mount seven
times each, before giving up with one of the above errors (usually
it is the superblock error).

I have also noticed corruption of /etc/mtab.  Sometimes static mounts
just disappear from it during busy times.  I assume this is some type
of race condition where file locking fails.  I do not know if this is
the same problem or a different problem, but I thought I would mention it.

I do not know what causes such a high load of mount requests.  But I see
them in the accounting files.  Nothing obvious is going on when the errors
occur.  They happen for several seconds at a time, 6-8 times per day.

The NFS client is ubuntu 6.06 (dapper), kernel 2.6.17.4, automount 4.1.4.
The NFS server is a Network Appliances filer.

Thanks,
Fletcher

Nov  2 08:41:09 smtp automount[3862]: handle_child: got pid 15301, sig 0 (0), stat 0 
Nov  2 08:41:09 smtp automount[3862]: sig_child: found pending iop pid 15301: signalled 0 (sig 0), exit status 0
Nov  2 08:41:09 smtp automount[3862]: send_ready: token=4324 
Nov  2 08:41:11 smtp automount[3862]: handle_packet: type = 0 
Nov  2 08:41:11 smtp automount[3862]: handle_packet_missing: token 4325, name v2q007 
Nov  2 08:41:11 smtp automount[3862]: attempting to mount entry /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: lookup(yp): looking up v2q007
Nov  2 08:41:11 smtp automount[15326]: ret = 1
Nov  2 08:41:11 smtp automount[15326]: lookup(yp): v2q007 -> -intr,grpid,quota,retry=2^Ifiler3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): expanded entry: -intr,grpid,quota,retry=2^Ifiler3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): dequote("intr,grpid,quota,retry=2") -> intr,grpid,quota,retry=2
Nov  2 08:41:11 smtp automount[15326]: parse(sun): gathered options: tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2
Nov  2 08:41:11 smtp automount[15326]: parse(sun): dequote("filer3:/vol/vol2/v2q007") -> filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): core of entry: options=tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2, loc=filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: parse(sun): mounting root /v/filer3, mountpoint v2q007, what filer3:/vol/vol2/v2q007, fstype nfs, options tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2 
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): root=/v/filer3 name=v2q007 what=filer3:/vol/vol2/v2q007, fstype=nfs, options=tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): nfs options="tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2", nosymlink=0, symlink=0, ro=0
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): is_local_mount: filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): from filer3:/vol/vol2/v2q007 elected filer3:/vol/vol2/v2q007
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): calling mkdir_path /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): calling mount -t nfs -s  -o tcp,rsize=8192,wsize=8192,intr,grpid,quota,retry=2 filer3:/vol/vol2/v2q007 /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: >> mount: filer3:/vol/vol2/v2q007: can't read superblock
Nov  2 08:41:11 smtp automount[15326]: mount(nfs): nfs: mount failure filer3:/vol/vol2/v2q007 on /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: failed to mount /v/filer3/v2q007
Nov  2 08:41:11 smtp automount[15326]: umount_multi: path=/v/filer3/v2q007 incl=1 
Nov  2 08:41:11 smtp automount[15326]: umount_multi: no mounts found under /v/filer3/v2q007

^ permalink raw reply	[flat|nested] 7+ messages in thread

end of thread, other threads:[~2006-11-04  2:14 UTC | newest]

Thread overview: 7+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2006-11-03 21:22 automount errors under high load Fletcher Mattox
2006-11-04  0:15 ` Jeff Moyer
2006-11-04  0:55   ` Fletcher Mattox
2006-11-04  2:14     ` Ian Kent
2006-11-04  0:55   ` Fletcher Mattox
2006-11-04  2:04 ` Ian Kent
  -- strict thread matches above, loose matches on Subject: below --
2006-11-03 21:22 Fletcher Mattox

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.