automount dies almost immediately after upgrade to autofs 5.0.1

automount dies almost immediately after upgrade to autofs 5.0.1

[Dan Krejsa]

Hi,

Yesterday I updated autofs, the kernel, selinux-policy, and 
a few other things on my Fedora Core 6 laptop.  Today I brought
my laptop in to work, and autofs failed for /net mounts.

Here's the relevant section of yum.log:

Mar 04 13:12:39 Installed: kernel-xen.i686 2.6.19-1.2911.6.4.fc6
Mar 04 13:12:51 Installed: kernel.i686 2.6.19-1.2911.6.4.fc6
Mar 04 13:12:51 Installed: ieee80211-kmdl-2.6.19-1.2911.6.4.fc6.i686 1.2.16-17.fc6.at
Mar 04 13:12:52 Installed: ieee80211-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1.2.16-17.fc6.at
Mar 04 13:12:58 Updated: vim-common.i386 2:7.0.201-1.fc6
Mar 04 13:13:01 Updated: selinux-policy.noarch 2.4.6-41.fc6
Mar 04 13:13:03 Updated: kernel-headers.i386 2.6.19-1.2911.6.4.fc6
Mar 04 13:13:04 Updated: readahead.i386 1:1.3-7.fc6
Mar 04 13:13:04 Installed: ipw3945-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1.2.0-18.2.fc6.at
Mar 04 13:13:06 Updated: autofs.i386 1:5.0.1-0.rc3.23
Mar 04 13:13:07 Updated: vim-enhanced.i386 2:7.0.201-1.fc6
Mar 04 13:13:14 Updated: selinux-policy-targeted.noarch 2.4.6-41.fc6
Mar 04 13:13:15 Installed: nvidia-graphics9629-kmdl-2.6.19-1.2911.6.4.fc6.i686 1:1.0_9629-81.fc6.at
Mar 04 13:13:15 Updated: vim-minimal.i386 2:7.0.201-1.fc6
Mar 04 13:13:16 Installed: nvidia-graphics9629-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1:1.0_9629-81.fc6.at
Mar 04 13:13:17 Installed: ipw3945-kmdl-2.6.19-1.2911.6.4.fc6.i686 1.2.0-18.2.fc6.at

I tried restarting autofs using '/etc/init.d/autofs start'
and it would claim success "[OK]", but in a few seconds (probably
less than a minute) the automount process would
disappear and '/etc/init.d/autofs status' would report
autofs stopped. DNS & general network connectivity were working.

Last Friday (before the update) I had been using automounts under
/net with no problem, in the same environment. I'm not an autofs experts
and haven't messed with the default auto.* configuration files.

Any hints?

- Dan

Re: automount dies almost immediately after upgrade to autofs 5.0.1

[Ian Kent]

On Mon, 2007-03-05 at 21:36 -0800, Dan Krejsa wrote:
> Hi,
> 
> Yesterday I updated autofs, the kernel, selinux-policy, and 
> a few other things on my Fedora Core 6 laptop.  Today I brought
> my laptop in to work, and autofs failed for /net mounts.
> 
> Here's the relevant section of yum.log:
> 
> Mar 04 13:12:39 Installed: kernel-xen.i686 2.6.19-1.2911.6.4.fc6
> Mar 04 13:12:51 Installed: kernel.i686 2.6.19-1.2911.6.4.fc6
> Mar 04 13:12:51 Installed: ieee80211-kmdl-2.6.19-1.2911.6.4.fc6.i686 1.2.16-17.fc6.at
> Mar 04 13:12:52 Installed: ieee80211-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1.2.16-17.fc6.at
> Mar 04 13:12:58 Updated: vim-common.i386 2:7.0.201-1.fc6
> Mar 04 13:13:01 Updated: selinux-policy.noarch 2.4.6-41.fc6
> Mar 04 13:13:03 Updated: kernel-headers.i386 2.6.19-1.2911.6.4.fc6
> Mar 04 13:13:04 Updated: readahead.i386 1:1.3-7.fc6
> Mar 04 13:13:04 Installed: ipw3945-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1.2.0-18.2.fc6.at
> Mar 04 13:13:06 Updated: autofs.i386 1:5.0.1-0.rc3.23
> Mar 04 13:13:07 Updated: vim-enhanced.i386 2:7.0.201-1.fc6
> Mar 04 13:13:14 Updated: selinux-policy-targeted.noarch 2.4.6-41.fc6
> Mar 04 13:13:15 Installed: nvidia-graphics9629-kmdl-2.6.19-1.2911.6.4.fc6.i686 1:1.0_9629-81.fc6.at
> Mar 04 13:13:15 Updated: vim-minimal.i386 2:7.0.201-1.fc6
> Mar 04 13:13:16 Installed: nvidia-graphics9629-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1:1.0_9629-81.fc6.at
> Mar 04 13:13:17 Installed: ipw3945-kmdl-2.6.19-1.2911.6.4.fc6.i686 1.2.0-18.2.fc6.at
> 
> I tried restarting autofs using '/etc/init.d/autofs start'
> and it would claim success "[OK]", but in a few seconds (probably
> less than a minute) the automount process would
> disappear and '/etc/init.d/autofs status' would report
> autofs stopped. DNS & general network connectivity were working.

Is there anything at all in the logs?
You can get a debug log by following the instructions at
http://people.redhat.com/jmoyer

Ian

Re: automount dies almost immediately after upgrade to autofs 5.0.1

[Krejsa, Dan]

[-- Attachment #1: Type: text/plain, Size: 16148 bytes --]

Hi Ian & Folks,

I've included the debug log and other information asked for
below, and attached as separate files in an archive.

To collect the /var/log/debug output, I restarted autofs
as root, and in another shell as an ordinary user, did

  cd /net
  cd blue

The 'cd blue' call hanged, and the automount died (
according to /etc/init.d/autofs status) after
fetching the export list for blue. (I provide the output
of 'showmount -e blue' below.)  After a bit I was able
to interrupt the 'cd blue' call, getting back a 'No such
file or directory' message.  I then restarted autofs
again (/etc/init.d/autofs restart), and again tried
'cd blue' with the same results.

In the /var/log/debug output I see

Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(yp): read of master map auto.master failed: Can't bind to server
which serves this domain
Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(file): failed to read included master map auto.master

I'm not too surprised about the yp lookup failure, but I'm
not sure what to make of the lookup(file) failure, or even
whether this is to be worried about for /net mounts.

Thanks for any suggestions,

- Dan

[root@clifford etc]# uname -a
Linux clifford 2.6.19-1.2911.6.4.fc6 #1 SMP Sat Feb 24 14:39:04 EST 2007
i686 i686 i386 GNU/Linux
[root@clifford etc]# rpm -q autofs
autofs-5.0.1-0.rc3.23
[root@clifford etc]# lf -l auto.*
-rw-r--r-- 1 root root  560 Feb 19 20:39 auto.master
-rw-r--r-- 1 root root  581 Feb 19 20:39 auto.misc
-rwxr-xr-x 1 root root 1292 Feb 19 20:39 auto.net*
-rwxr-xr-x 1 root root  715 Feb 19 20:39 auto.smb*
[root@clifford etc]# cat auto.master
#
# $Id: auto.master,v 1.4 2005/01/04 14:36:54 raven Exp $
#
# Sample auto.master file
# This is an automounter map and it has the following format
# key [ -mount-options-separated-by-comma ] location
# For details of the format look at autofs(5).
#
/misc   /etc/auto.misc
/net    -hosts
#
# Include central master map if it can be found using
# nsswitch sources.
#
# Note that if there are entries for /net or /misc (as
# above) in the included master map any keys that are the
# same will not be seen as the first read key seen takes
# precedence.
#
+auto.master
[root@clifford etc]# cat auto.net
#!/bin/bash

# $Id: auto.net,v 1.8 2005/04/05 13:02:09 raven Exp $

# This file must be executable to work! chmod 755!

# Look at what a host is exporting to determine what we can mount.
# This is very simple, but it appears to work surprisingly well

key="$1"

# add "nosymlink" here if you want to suppress symlinking local
filesystems
# add "nonstrict" to make it OK for some filesystems to not mount
opts="-fstype=nfs,hard,intr,nodev,nosuid"

# Showmount comes in a number of names and varieties.  "showmount" is
# typically an older version which accepts the '--no-headers' flag
# but ignores it.  "kshowmount" is the newer version installed with
knfsd,
# which both accepts and acts on the '--no-headers' flag.
#SHOWMOUNT="kshowmount --no-headers -e $key"
#SHOWMOUNT="showmount -e $key | tail -n +2"

for P in /bin /sbin /usr/bin /usr/sbin
do
        for M in showmount kshowmount
        do
                if [ -x $P/$M ]
                then
                        SMNT=$P/$M
                        break
                fi
        done
done

[ -x $SMNT ] || exit 1

# Newer distributions get this right
SHOWMOUNT="$SMNT --no-headers -e $key"

$SHOWMOUNT | LC_ALL=C sort -k 1 | \
        awk -v key="$key" -v opts="$opts" -- '
        BEGIN   { ORS=""; first=1 }
                { if (first) { print opts; first=0 }; print " \\\n\t"
$1, key ":" $1 }
        END     { if (!first) print "\n"; else exit 1 }
        ' | sed 's/#/\\#/g'
[root@clifford etc]# cat auto.misc
#
# $Id: auto.misc,v 1.2 2003/09/29 08:22:35 raven Exp $
#
# This is an automounter map and it has the following format
# key [ -mount-options-separated-by-comma ] location
# Details may be found in the autofs(5) manpage

cd              -fstype=iso9660,ro,nosuid,nodev :/dev/cdrom

# the following entries are samples to pique your imagination
#linux          -ro,soft,intr           ftp.example.org:/pub/linux
#boot           -fstype=ext2            :/dev/hda1
#floppy         -fstype=auto            :/dev/fd0
#floppy         -fstype=ext2            :/dev/fd0
#e2floppy       -fstype=ext2            :/dev/fd0
#jaz            -fstype=ext2            :/dev/sdc1
#removable      -fstype=ext2            :/dev/hdd
[root@clifford etc]# cat auto.smb
#!/bin/bash

# $Id: auto.smb,v 1.3 2005/04/05 13:02:09 raven Exp $

# This file must be executable to work! chmod 755!

key="$1"
opts="-fstype=cifs"

for P in /bin /sbin /usr/bin /usr/sbin
do
        if [ -x $P/smbclient ]
        then
                SMBCLIENT=$P/smbclient
                break
        fi
done

[ -x $SMBCLIENT ] || exit 1

$SMBCLIENT -gNL $key 2>/dev/null| awk -v key="$key" -v opts="$opts"
-F'|' -- '
        BEGIN   { ORS=""; first=1 }
        /Disk/  {
                  if (first)
                        print opts; first=0
                  dir = $2
                  loc = $2
                  # Enclose mount dir and location in quotes
                  # Double quote "$" in location as it is special
                  gsub(/\$$/, "\\$", loc);
                  print " \\\n\t \"/" dir "\"", "\"://" key "/" loc "\""
                }
        END     { if (!first) print "\n"; else exit 1 }
        '
[root@clifford etc]#
[root@clifford etc]# showmount -e blue
Export list for blue:
/vol/vol0/fsfcvs                  (everyone)
/vol/vol0/sww                     (everyone)
/vol/vol5/prj-prlc-work-products  (everyone)
/vol/vol7/prj-2007-fall-release   (everyone)
/vol/vol0/tina                    (everyone)
/vol/vol0/software                (everyone)
/vol/vol0/rti_tools               (everyone)
/vol/vol7/prj-2007-hut-dev        (everyone)
/vol/vol1/dave-test               ala-doradb2
/vol/vol0/sales_video             (everyone)
/vol/vol0/jumpstart               (everyone)
/vol/vol5/ilt                     (everyone)
/vol/vol3/prj-2006-fall-release   (everyone)
/vol/vol2/prj-2006-spring-release (everyone)
/vol/vol0/jumpstart/redhat/BSD    (everyone)
/vol/vol0/vmware-test             (everyone)
/vol/vol5/tux                     (everyone)
/vol/vol0/ultravox                (everyone)
/vol/vol0/ecms                    web-ecms,cadacan,morpheus,wisdom
/vol/vol0/docs                    (everyone)
/vol/vol0                         morpheus
/vol/vol1                         morpheus
/vol/vol2                         morpheus
/vol/vol3                         morpheus
/vol/vol4                         morpheus,ala-toradb2,ala-doradb2
/vol/vol5                         morpheus
/vol/vol6                         (everyone)
/vol/vol7                         (everyone)
/vol/vol8                         (everyone)
/vol/vol7/prj-2007-hut-release    (everyone)
/vol/vol0/web                     (everyone)
/vol/vol1/it_laptop_backup        (everyone)
/vol/vol6/prj-2007-spring-release (everyone)
/vol/vol7/prj-2007-fall-dev       (everyone)
/vol/vol0/ithome                  (everyone)
[root@clifford etc]#
[root@clifford etc]# cd /var/log
[root@clifford log]# cat debug
Mar  6 09:19:31 localhost automount[3453]: Starting automounter version
5.0.1-0.rc3.23, master map auto.master
Mar  6 09:19:31 localhost automount[3453]: using kernel protocol version
5.00
Mar  6 09:19:31 localhost automount[3453]: lookup_nss_read_master:
reading master files auto.master
Mar  6 09:19:31 localhost automount[3453]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:19:31 localhost automount[3453]: mount_init: mount(bind):
bind_works = 1
Mar  6 09:19:31 localhost automount[3453]: lookup_read_master:
lookup(file): read entry /misc
Mar  6 09:19:31 localhost automount[3453]: lookup_read_master:
lookup(file): read entry /net
Mar  6 09:19:31 localhost automount[3453]: lookup_read_master:
lookup(file): read entry +auto.master
Mar  6 09:19:31 localhost automount[3453]: lookup_nss_read_master:
reading master files auto.master
Mar  6 09:19:31 localhost automount[3453]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:19:31 localhost automount[3453]: lookup_nss_read_master:
reading master nis auto.master
Mar  6 09:19:31 localhost automount[3453]: lookup_init: lookup(yp):
ctxt->mapname=auto.master
Mar  6 09:19:31 localhost automount[3453]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:19:31 localhost automount[3453]: lookup_read_master:
lookup(yp): read of master map auto.master failed: Can't bind to server
which serves this domain
Mar  6 09:19:31 localhost automount[3453]: lookup_read_master:
lookup(file): failed to read included master map auto.master
Mar  6 09:19:31 localhost automount[3453]: master_do_mount: mounting
/misc
Mar  6 09:19:31 localhost automount[3453]: lookup_nss_read_map: reading
map file /etc/auto.misc
Mar  6 09:19:31 localhost automount[3453]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:19:31 localhost automount[3453]: mount_init: mount(bind):
bind_works = 1
Mar  6 09:19:31 localhost automount[3453]: mounted indirect mount on
/misc with timeout 300, freq 75 seconds
Mar  6 09:19:31 localhost automount[3453]: master_do_mount: mounting
/net
Mar  6 09:19:31 localhost automount[3453]: lookup_nss_read_map: reading
map hosts (null)
Mar  6 09:19:31 localhost automount[3453]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:19:31 localhost automount[3453]: mounted indirect mount on
/net with timeout 300, freq 75 seconds
Mar  6 09:21:44 localhost automount[3453]: st_expire: state 1 path /misc
Mar  6 09:21:44 localhost automount[3453]: expire_proc: exp_proc =
3084581776 path /misc
Mar  6 09:21:44 localhost automount[3453]: expire_cleanup: got thid
3084581776 path /misc stat 0
Mar  6 09:21:44 localhost automount[3453]: expire_cleanup: sigchld: exp
3084581776 finished, switching from 2 to 1
Mar  6 09:21:44 localhost automount[3453]: st_ready: st_ready(): state =
2 path /misc
Mar  6 09:21:47 localhost automount[3453]: st_expire: state 1 path /net
Mar  6 09:21:47 localhost automount[3453]: expire_proc: exp_proc =
3084581776 path /net
Mar  6 09:21:47 localhost automount[3453]: mount still busy /net
Mar  6 09:21:47 localhost automount[3453]: expire_cleanup: got thid
3084581776 path /net stat 0
Mar  6 09:21:47 localhost automount[3453]: expire_cleanup: sigchld: exp
3084581776 finished, switching from 2 to 1
Mar  6 09:21:47 localhost automount[3453]: st_ready: st_ready(): state =
2 path /net
Mar  6 09:21:54 localhost automount[3453]: handle_packet: type = 3
Mar  6 09:21:54 localhost automount[3453]:
handle_packet_missing_indirect: token 1, name blue, request pid 3500
Mar  6 09:21:54 localhost automount[3453]: attempting to mount entry
/net/blue
Mar  6 09:21:54 localhost automount[3453]: lookup_mount: lookup(hosts):
fetchng export list for blue
Mar  6 09:23:52 localhost automount[3579]: Starting automounter version
5.0.1-0.rc3.23, master map auto.master
Mar  6 09:23:52 localhost automount[3579]: using kernel protocol version
5.00
Mar  6 09:23:52 localhost automount[3579]: lookup_nss_read_master:
reading master files auto.master
Mar  6 09:23:52 localhost automount[3579]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:23:52 localhost automount[3579]: mount_init: mount(bind):
bind_works = 1
Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(file): read entry /misc
Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(file): read entry /net
Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(file): read entry +auto.master
Mar  6 09:23:52 localhost automount[3579]: lookup_nss_read_master:
reading master files auto.master
Mar  6 09:23:52 localhost automount[3579]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:23:52 localhost automount[3579]: lookup_nss_read_master:
reading master nis auto.master
Mar  6 09:23:52 localhost automount[3579]: lookup_init: lookup(yp):
ctxt->mapname=auto.master
Mar  6 09:23:52 localhost automount[3579]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(yp): read of master map auto.master failed: Can't bind to server
which serves this domain
Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
lookup(file): failed to read included master map auto.master
Mar  6 09:23:52 localhost automount[3579]: master_do_mount: mounting
/misc
Mar  6 09:23:52 localhost automount[3579]: lookup_nss_read_map: reading
map file /etc/auto.misc
Mar  6 09:23:52 localhost automount[3579]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:23:52 localhost automount[3579]: mount_init: mount(bind):
bind_works = 1
Mar  6 09:23:53 localhost automount[3579]: mounted indirect mount on
/misc with timeout 300, freq 75 seconds
Mar  6 09:23:53 localhost automount[3579]: master_do_mount: mounting
/net
Mar  6 09:23:53 localhost automount[3579]: lookup_nss_read_map: reading
map hosts (null)
Mar  6 09:23:53 localhost automount[3579]: parse_init: parse(sun): init
gathered global options: (null)
Mar  6 09:23:53 localhost automount[3579]: mounted indirect mount on
/net with timeout 300, freq 75 seconds
Mar  6 09:24:01 localhost automount[3579]: handle_packet: type = 3
Mar  6 09:24:01 localhost automount[3579]:
handle_packet_missing_indirect: token 3, name blue, request pid 3500
Mar  6 09:24:01 localhost automount[3579]: attempting to mount entry
/net/blue
Mar  6 09:24:01 localhost automount[3579]: lookup_mount: lookup(hosts):
fetchng export list for blue
[root@clifford log]# 




On Tue, 2007-03-06 at 17:22 +0900, Ian Kent wrote:
> On Mon, 2007-03-05 at 21:36 -0800, Dan Krejsa wrote:
> > Hi,
> > 
> > Yesterday I updated autofs, the kernel, selinux-policy, and 
> > a few other things on my Fedora Core 6 laptop.  Today I brought
> > my laptop in to work, and autofs failed for /net mounts.
> > 
> > Here's the relevant section of yum.log:
> > 
> > Mar 04 13:12:39 Installed: kernel-xen.i686 2.6.19-1.2911.6.4.fc6
> > Mar 04 13:12:51 Installed: kernel.i686 2.6.19-1.2911.6.4.fc6
> > Mar 04 13:12:51 Installed: ieee80211-kmdl-2.6.19-1.2911.6.4.fc6.i686
1.2.16-17.fc6.at
> > Mar 04 13:12:52 Installed:
ieee80211-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1.2.16-17.fc6.at
> > Mar 04 13:12:58 Updated: vim-common.i386 2:7.0.201-1.fc6
> > Mar 04 13:13:01 Updated: selinux-policy.noarch 2.4.6-41.fc6
> > Mar 04 13:13:03 Updated: kernel-headers.i386 2.6.19-1.2911.6.4.fc6
> > Mar 04 13:13:04 Updated: readahead.i386 1:1.3-7.fc6
> > Mar 04 13:13:04 Installed:
ipw3945-kmdl-2.6.19-1.2911.6.4.fc6xen.i686 1.2.0-18.2.fc6.at
> > Mar 04 13:13:06 Updated: autofs.i386 1:5.0.1-0.rc3.23
> > Mar 04 13:13:07 Updated: vim-enhanced.i386 2:7.0.201-1.fc6
> > Mar 04 13:13:14 Updated: selinux-policy-targeted.noarch 2.4.6-41.fc6
> > Mar 04 13:13:15 Installed:
nvidia-graphics9629-kmdl-2.6.19-1.2911.6.4.fc6.i686 1:1.0_9629-81.fc6.at
> > Mar 04 13:13:15 Updated: vim-minimal.i386 2:7.0.201-1.fc6
> > Mar 04 13:13:16 Installed:
nvidia-graphics9629-kmdl-2.6.19-1.2911.6.4.fc6xen.i686
1:1.0_9629-81.fc6.at
> > Mar 04 13:13:17 Installed: ipw3945-kmdl-2.6.19-1.2911.6.4.fc6.i686
1.2.0-18.2.fc6.at
> > 
> > I tried restarting autofs using '/etc/init.d/autofs start'
> > and it would claim success "[OK]", but in a few seconds (probably
> > less than a minute) the automount process would
> > disappear and '/etc/init.d/autofs status' would report
> > autofs stopped. DNS & general network connectivity were working.
> 
> Is there anything at all in the logs?
> You can get a debug log by following the instructions at
> http://people.redhat.com/jmoyer
> 
> Ian
> 
> 

[-- Attachment #2: autofs.tgz --]
[-- Type: application/x-compressed, Size: 3675 bytes --]

[-- Attachment #3: Type: text/plain, Size: 140 bytes --]

_______________________________________________
autofs mailing list
autofs@linux.kernel.org
http://linux.kernel.org/mailman/listinfo/autofs

Re: automount dies almost immediately after upgrade to autofs 5.0.1

[Ian Kent]

On Tue, 2007-03-06 at 10:29 -0800, Krejsa, Dan wrote:
> Hi Ian & Folks,
> 
> I've included the debug log and other information asked for
> below, and attached as separate files in an archive.
> 
> To collect the /var/log/debug output, I restarted autofs
> as root, and in another shell as an ordinary user, did

Thanks.

> 
>   cd /net
>   cd blue
> 
> The 'cd blue' call hanged, and the automount died (
> according to /etc/init.d/autofs status) after
> fetching the export list for blue. (I provide the output
> of 'showmount -e blue' below.)  After a bit I was able
> to interrupt the 'cd blue' call, getting back a 'No such
> file or directory' message.  I then restarted autofs
> again (/etc/init.d/autofs restart), and again tried
> 'cd blue' with the same results.
> 
> In the /var/log/debug output I see
> 
> Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
> lookup(yp): read of master map auto.master failed: Can't bind to server
> which serves this domain
> Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
> lookup(file): failed to read included master map auto.master

Map includes are only allowed in file maps, this is the return from the
attempted include of "+auto.master".

> 
> I'm not too surprised about the yp lookup failure, but I'm
> not sure what to make of the lookup(file) failure, or even
> whether this is to be worried about for /net mounts.
> 
> Thanks for any suggestions,
> 
> - Dan
> 
> [root@clifford etc]# uname -a
> Linux clifford 2.6.19-1.2911.6.4.fc6 #1 SMP Sat Feb 24 14:39:04 EST 2007
> i686 i686 i386 GNU/Linux
> [root@clifford etc]# rpm -q autofs
> autofs-5.0.1-0.rc3.23
> [root@clifford etc]# lf -l auto.*
> -rw-r--r-- 1 root root  560 Feb 19 20:39 auto.master
> -rw-r--r-- 1 root root  581 Feb 19 20:39 auto.misc
> -rwxr-xr-x 1 root root 1292 Feb 19 20:39 auto.net*
> -rwxr-xr-x 1 root root  715 Feb 19 20:39 auto.smb*
> [root@clifford etc]# cat auto.master
> #
> # $Id: auto.master,v 1.4 2005/01/04 14:36:54 raven Exp $
> #
> # Sample auto.master file
> # This is an automounter map and it has the following format
> # key [ -mount-options-separated-by-comma ] location
> # For details of the format look at autofs(5).
> #
> /misc   /etc/auto.misc
> /net    -hosts
> #
> # Include central master map if it can be found using
> # nsswitch sources.
> #
> # Note that if there are entries for /net or /misc (as
> # above) in the included master map any keys that are the
> # same will not be seen as the first read key seen takes
> # precedence.
> #
> +auto.master
> [root@clifford etc]# cat auto.net

The auto.net script isn't used for the "-hosts" map.

snip ...

> [root@clifford etc]# showmount -e blue
> Export list for blue:
> /vol/vol0/fsfcvs                  (everyone)
> /vol/vol0/sww                     (everyone)
> /vol/vol5/prj-prlc-work-products  (everyone)
> /vol/vol7/prj-2007-fall-release   (everyone)
> /vol/vol0/tina                    (everyone)
> /vol/vol0/software                (everyone)
> /vol/vol0/rti_tools               (everyone)
> /vol/vol7/prj-2007-hut-dev        (everyone)
> /vol/vol1/dave-test               ala-doradb2
> /vol/vol0/sales_video             (everyone)
> /vol/vol0/jumpstart               (everyone)
> /vol/vol5/ilt                     (everyone)
> /vol/vol3/prj-2006-fall-release   (everyone)
> /vol/vol2/prj-2006-spring-release (everyone)
> /vol/vol0/jumpstart/redhat/BSD    (everyone)
> /vol/vol0/vmware-test             (everyone)
> /vol/vol5/tux                     (everyone)
> /vol/vol0/ultravox                (everyone)
> /vol/vol0/ecms                    web-ecms,cadacan,morpheus,wisdom
> /vol/vol0/docs                    (everyone)
> /vol/vol0                         morpheus
> /vol/vol1                         morpheus
> /vol/vol2                         morpheus
> /vol/vol3                         morpheus
> /vol/vol4                         morpheus,ala-toradb2,ala-doradb2
> /vol/vol5                         morpheus
> /vol/vol6                         (everyone)
> /vol/vol7                         (everyone)
> /vol/vol8                         (everyone)
> /vol/vol7/prj-2007-hut-release    (everyone)
> /vol/vol0/web                     (everyone)
> /vol/vol1/it_laptop_backup        (everyone)
> /vol/vol6/prj-2007-spring-release (everyone)
> /vol/vol7/prj-2007-fall-dev       (everyone)
> /vol/vol0/ithome                  (everyone)

Looks fine.

> [root@clifford etc]#
> [root@clifford etc]# cd /var/log
> [root@clifford log]# cat debug
> Mar  6 09:19:31 localhost automount[3453]: Starting automounter version
> 5.0.1-0.rc3.23, master map auto.master

There is a correction to the exports lookup code in 0.rc3.25 which you
should find in the testing directory on the mirrors. I've just requested
it be moved from testing to final so it should be available as an update
soon.

snip ...

> Mar  6 09:23:53 localhost automount[3579]: mounted indirect mount on
> /net with timeout 300, freq 75 seconds
> Mar  6 09:24:01 localhost automount[3579]: handle_packet: type = 3
> Mar  6 09:24:01 localhost automount[3579]:
> handle_packet_missing_indirect: token 3, name blue, request pid 3500
> Mar  6 09:24:01 localhost automount[3579]: attempting to mount entry
> /net/blue
> Mar  6 09:24:01 localhost automount[3579]: lookup_mount: lookup(hosts):
> fetchng export list for blue

Strange you don't get a SEGV and a core.
Do you see any core file in the root directory?

Ian

Re: automount dies almost immediately after upgrade to autofs 5.0.1

[Dan Krejsa]

Hi Ian,

Yes, in fact, there are multiple core.* files in / which
I didn't notice.  I can send you one of them if you like.
I checked with gdb and they are from automount.

[dlkrejsa@clifford /]$ gdb -c core.3805 /usr/sbin/automount
GNU gdb Red Hat Linux (6.5-15.fc6rh)
Copyright (C) 2006 Free Software Foundation, Inc.
GDB is free software, covered by the GNU General Public License, and you are
welcome to change it and/or distribute copies of it under certain conditions.
Type "show copying" to see the conditions.
There is absolutely no warranty for GDB.  Type "show warranty" for details.
This GDB was configured as "i386-redhat-linux-gnu"...
(no debugging symbols found)
Using host libthread_db library "/lib/libthread_db.so.1".


warning: Can't read pathname for load map: Input/output error.
(no debugging symbols found)
Loaded symbols for /usr/sbin/automount
Reading symbols from /lib/libpthread.so.0...(no debugging symbols found)...done.
Loaded symbols for /lib/libpthread.so.0
Reading symbols from /lib/libdl.so.2...(no debugging symbols found)...done.
Loaded symbols for /lib/libdl.so.2
Reading symbols from /lib/libgcc_s.so.1...
(no debugging symbols found)...done.
Loaded symbols for /lib/libgcc_s.so.1
Reading symbols from /lib/libc.so.6...(no debugging symbols found)...done.
Loaded symbols for /lib/libc.so.6
Reading symbols from /lib/ld-linux.so.2...
(no debugging symbols found)...done.
Loaded symbols for /lib/ld-linux.so.2
Reading symbols from /usr/lib/autofs/lookup_file.so...(no debugging symbols found)...done.
Loaded symbols for /usr/lib/autofs/lookup_file.so
Reading symbols from /lib/libnsl.so.1...
(no debugging symbols found)...done.
Loaded symbols for /lib/libnsl.so.1
Reading symbols from /usr/lib/autofs/parse_sun.so...(no debugging symbols found)...done.
Loaded symbols for /usr/lib/autofs/parse_sun.so
Reading symbols from /usr/lib/autofs/mount_nfs.so...
(no debugging symbols found)...done.
Loaded symbols for /usr/lib/autofs/mount_nfs.so
Reading symbols from /usr/lib/autofs/mount_bind.so...(no debugging symbols found)...done.
Loaded symbols for /usr/lib/autofs/mount_bind.so
Reading symbols from /usr/lib/autofs/lookup_hosts.so...
(no debugging symbols found)...done.
Loaded symbols for /usr/lib/autofs/lookup_hosts.so
Reading symbols from /lib/libnss_files.so.2...(no debugging symbols found)...done.
Loaded symbols for /lib/libnss_files.so.2
Reading symbols from /lib/libnss_dns.so.2...
(no debugging symbols found)...done.
Loaded symbols for /lib/libnss_dns.so.2
Reading symbols from /lib/libresolv.so.2...(no debugging symbols found)...done.
Loaded symbols for /lib/libresolv.so.2
Failed to read a valid object file image from memory.

Core was generated by `automount'.
Program terminated with signal 6, Aborted.
#0  0x00739402 in ?? ()
(gdb) tt
Argument required (filename to set it to.).
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x008afd40 in raise () from /lib/libc.so.6
#2  0x008b1591 in abort () from /lib/libc.so.6
#3  0x008e533b in __libc_message () from /lib/libc.so.6
#4  0x00968361 in __chk_fail () from /lib/libc.so.6
#5  0x00967817 in __strcat_chk () from /lib/libc.so.6
#6  0x0064aaad in rpc_time () from /usr/lib/autofs/lookup_hosts.so
#7  0x0064adce in rpc_time () from /usr/lib/autofs/lookup_hosts.so
#8  0x0064aff7 in rpc_exports_prune () from /usr/lib/autofs/lookup_hosts.so
#9  0x00646343 in lookup_mount () from /usr/lib/autofs/lookup_hosts.so
#10 0x80012409 in do_lookup_mount () from /usr/sbin/automount
#11 0x800133c6 in lookup_nss_mount () from /usr/sbin/automount
#12 0x8000b3d2 in expire_proc_indirect () from /usr/sbin/automount
#13 0x00d8d3db in start_thread () from /lib/libpthread.so.0
#14 0x0095426e in clone () from /lib/libc.so.6
(gdb) threads
Undefined command: "threads".  Try "help".
(gdb) help
List of classes of commands:

aliases -- Aliases of other commands
breakpoints -- Making program stop at certain points
data -- Examining data
files -- Specifying and examining files
internals -- Maintenance commands
obscure -- Obscure features
running -- Running the program
stack -- Examining the stack
status -- Status inquiries
support -- Support facilities
tracepoints -- Tracing of program execution without stopping the program
user-defined -- User-defined commands

Type "help" followed by a class name for a list of commands in that class.
Type "help" followed by command name for full documentation.
Command name abbreviations are allowed if unambiguous.
(gdb) help status
Status inquiries.

List of commands:

info -- Generic command for showing things about the program being debugged
macro -- Prefix for commands dealing with C preprocessor macros
show -- Generic command for showing things about the debugger

Type "help" followed by command name for full documentation.
Command name abbreviations are allowed if unambiguous.
(gdb) i th
  6 process 3805  0x00739402 in ?? ()
  5 process 3806  0x00739402 in ?? ()
  4 process 3807  0x00739402 in ?? ()
  3 process 3810  0x00739402 in ?? ()
  2 process 3813  0x00739402 in ?? ()
* 1 process 3841  0x00739402 in ?? ()
(gdb) th 6
Ambiguous command "th 6": thbreak, thread.
(gdb) thread 6
[Switching to thread 6 (process 3805)]#0  0x00739402 in ?? ()
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x00d94ebe in do_sigwait () from /lib/libpthread.so.0
#2  0x00d94f5f in sigwait () from /lib/libpthread.so.0
#3  0x80005838 in _start () from /usr/sbin/automount
(gdb) thread 5
[Switching to thread 5 (process 3806)]#0  0x00739402 in ?? ()
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x00d9142c in pthread_cond_timedwait@@GLIBC_2.3.2 ()
   from /lib/libpthread.so.0
#2  0x8001c8f6 in alarm_delete () from /usr/sbin/automount
#3  0x00d8d3db in start_thread () from /lib/libpthread.so.0
#4  0x0095426e in clone () from /lib/libc.so.6
(gdb) thread 4
[Switching to thread 4 (process 3807)]#0  0x00739402 in ?? ()
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x00d9142c in pthread_cond_timedwait@@GLIBC_2.3.2 ()
   from /lib/libpthread.so.0
#2  0x8001626b in expire_cleanup () from /usr/sbin/automount
#3  0x00d8d3db in start_thread () from /lib/libpthread.so.0
#4  0x0095426e in clone () from /lib/libc.so.6
(gdb) thread 3
[Switching to thread 3 (process 3810)]#0  0x00739402 in ?? ()
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x0094a6d3 in poll () from /lib/libc.so.6
#2  0x80008384 in handle_mounts () from /usr/sbin/automount
#3  0x00d8d3db in start_thread () from /lib/libpthread.so.0
#4  0x0095426e in clone () from /lib/libc.so.6
(gdb) thread 2
[Switching to thread 2 (process 3813)]#0  0x00739402 in ?? ()
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x0094a6d3 in poll () from /lib/libc.so.6
#2  0x80008384 in handle_mounts () from /usr/sbin/automount
#3  0x00d8d3db in start_thread () from /lib/libpthread.so.0
#4  0x0095426e in clone () from /lib/libc.so.6
(gdb) thread 1
[Switching to thread 1 (process 3841)]#0  0x00739402 in ?? ()
(gdb) bt
#0  0x00739402 in ?? ()
#1  0x008afd40 in raise () from /lib/libc.so.6
#2  0x008b1591 in abort () from /lib/libc.so.6
#3  0x008e533b in __libc_message () from /lib/libc.so.6
#4  0x00968361 in __chk_fail () from /lib/libc.so.6
#5  0x00967817 in __strcat_chk () from /lib/libc.so.6
#6  0x0064aaad in rpc_time () from /usr/lib/autofs/lookup_hosts.so
#7  0x0064adce in rpc_time () from /usr/lib/autofs/lookup_hosts.so
#8  0x0064aff7 in rpc_exports_prune () from /usr/lib/autofs/lookup_hosts.so
#9  0x00646343 in lookup_mount () from /usr/lib/autofs/lookup_hosts.so
#10 0x80012409 in do_lookup_mount () from /usr/sbin/automount
#11 0x800133c6 in lookup_nss_mount () from /usr/sbin/automount
#12 0x8000b3d2 in expire_proc_indirect () from /usr/sbin/automount
#13 0x00d8d3db in start_thread () from /lib/libpthread.so.0
#14 0x0095426e in clone () from /lib/libc.so.6
(gdb) 

I'll try out the rc3.25 version sometime...

Thanks,


- Dan

On Wed, 2007-03-07 at 10:09 +0900, Ian Kent wrote:
> On Tue, 2007-03-06 at 10:29 -0800, Krejsa, Dan wrote:
> > Hi Ian & Folks,
> > 
> > I've included the debug log and other information asked for
> > below, and attached as separate files in an archive.
> > 
> > To collect the /var/log/debug output, I restarted autofs
> > as root, and in another shell as an ordinary user, did
> 
> Thanks.
> 
> > 
> >   cd /net
> >   cd blue
> > 
> > The 'cd blue' call hanged, and the automount died (
> > according to /etc/init.d/autofs status) after
> > fetching the export list for blue. (I provide the output
> > of 'showmount -e blue' below.)  After a bit I was able
> > to interrupt the 'cd blue' call, getting back a 'No such
> > file or directory' message.  I then restarted autofs
> > again (/etc/init.d/autofs restart), and again tried
> > 'cd blue' with the same results.
> > 
> > In the /var/log/debug output I see
> > 
> > Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
> > lookup(yp): read of master map auto.master failed: Can't bind to server
> > which serves this domain
> > Mar  6 09:23:52 localhost automount[3579]: lookup_read_master:
> > lookup(file): failed to read included master map auto.master
> 
> Map includes are only allowed in file maps, this is the return from the
> attempted include of "+auto.master".
> 
> > 
> > I'm not too surprised about the yp lookup failure, but I'm
> > not sure what to make of the lookup(file) failure, or even
> > whether this is to be worried about for /net mounts.
> > 
> > Thanks for any suggestions,
> > 
> > - Dan
> > 
> > [root@clifford etc]# uname -a
> > Linux clifford 2.6.19-1.2911.6.4.fc6 #1 SMP Sat Feb 24 14:39:04 EST 2007
> > i686 i686 i386 GNU/Linux
> > [root@clifford etc]# rpm -q autofs
> > autofs-5.0.1-0.rc3.23
> > [root@clifford etc]# lf -l auto.*
> > -rw-r--r-- 1 root root  560 Feb 19 20:39 auto.master
> > -rw-r--r-- 1 root root  581 Feb 19 20:39 auto.misc
> > -rwxr-xr-x 1 root root 1292 Feb 19 20:39 auto.net*
> > -rwxr-xr-x 1 root root  715 Feb 19 20:39 auto.smb*
> > [root@clifford etc]# cat auto.master
> > #
> > # $Id: auto.master,v 1.4 2005/01/04 14:36:54 raven Exp $
> > #
> > # Sample auto.master file
> > # This is an automounter map and it has the following format
> > # key [ -mount-options-separated-by-comma ] location
> > # For details of the format look at autofs(5).
> > #
> > /misc   /etc/auto.misc
> > /net    -hosts
> > #
> > # Include central master map if it can be found using
> > # nsswitch sources.
> > #
> > # Note that if there are entries for /net or /misc (as
> > # above) in the included master map any keys that are the
> > # same will not be seen as the first read key seen takes
> > # precedence.
> > #
> > +auto.master
> > [root@clifford etc]# cat auto.net
> 
> The auto.net script isn't used for the "-hosts" map.
> 
> snip ...
> 
> > [root@clifford etc]# showmount -e blue
> > Export list for blue:
> > /vol/vol0/fsfcvs                  (everyone)
> > /vol/vol0/sww                     (everyone)
> > /vol/vol5/prj-prlc-work-products  (everyone)
> > /vol/vol7/prj-2007-fall-release   (everyone)
> > /vol/vol0/tina                    (everyone)
> > /vol/vol0/software                (everyone)
> > /vol/vol0/rti_tools               (everyone)
> > /vol/vol7/prj-2007-hut-dev        (everyone)
> > /vol/vol1/dave-test               ala-doradb2
> > /vol/vol0/sales_video             (everyone)
> > /vol/vol0/jumpstart               (everyone)
> > /vol/vol5/ilt                     (everyone)
> > /vol/vol3/prj-2006-fall-release   (everyone)
> > /vol/vol2/prj-2006-spring-release (everyone)
> > /vol/vol0/jumpstart/redhat/BSD    (everyone)
> > /vol/vol0/vmware-test             (everyone)
> > /vol/vol5/tux                     (everyone)
> > /vol/vol0/ultravox                (everyone)
> > /vol/vol0/ecms                    web-ecms,cadacan,morpheus,wisdom
> > /vol/vol0/docs                    (everyone)
> > /vol/vol0                         morpheus
> > /vol/vol1                         morpheus
> > /vol/vol2                         morpheus
> > /vol/vol3                         morpheus
> > /vol/vol4                         morpheus,ala-toradb2,ala-doradb2
> > /vol/vol5                         morpheus
> > /vol/vol6                         (everyone)
> > /vol/vol7                         (everyone)
> > /vol/vol8                         (everyone)
> > /vol/vol7/prj-2007-hut-release    (everyone)
> > /vol/vol0/web                     (everyone)
> > /vol/vol1/it_laptop_backup        (everyone)
> > /vol/vol6/prj-2007-spring-release (everyone)
> > /vol/vol7/prj-2007-fall-dev       (everyone)
> > /vol/vol0/ithome                  (everyone)
> 
> Looks fine.
> 
> > [root@clifford etc]#
> > [root@clifford etc]# cd /var/log
> > [root@clifford log]# cat debug
> > Mar  6 09:19:31 localhost automount[3453]: Starting automounter version
> > 5.0.1-0.rc3.23, master map auto.master
> 
> There is a correction to the exports lookup code in 0.rc3.25 which you
> should find in the testing directory on the mirrors. I've just requested
> it be moved from testing to final so it should be available as an update
> soon.
> 
> snip ...
> 
> > Mar  6 09:23:53 localhost automount[3579]: mounted indirect mount on
> > /net with timeout 300, freq 75 seconds
> > Mar  6 09:24:01 localhost automount[3579]: handle_packet: type = 3
> > Mar  6 09:24:01 localhost automount[3579]:
> > handle_packet_missing_indirect: token 3, name blue, request pid 3500
> > Mar  6 09:24:01 localhost automount[3579]: attempting to mount entry
> > /net/blue
> > Mar  6 09:24:01 localhost automount[3579]: lookup_mount: lookup(hosts):
> > fetchng export list for blue
> 
> Strange you don't get a SEGV and a core.
> Do you see any core file in the root directory?
> 
> Ian
> 
>