Package: autofs Version: 5.0.8-2+deb8u1 Severity: normal Dear Maintainer,
I tried to use autofs for nfs mounts. I followed https://wiki.archlinux.org/index.php/Autofs#NFS_network_mounts and added rd@blackbox:/etc$ grep auto.master.d auto.master # Include /etc/auto.master.d/*.autofs +dir:/etc/auto.master.d rd@blackbox:/etc$ and used the BUILTIN MAP -hosts in rd@blackbox:/etc$ cat /etc/auto.master.d/net.autofs /mnt/net -hosts --timeout=60 rd@blackbox:/etc$ When I try to automount, I get a failure rd@blackbox:/etc$ ls -l /mnt/net/home ls: cannot access /mnt/net/home: No such file or directory rd@blackbox:/etc$ I append the automount debug log: Jun 26 09:59:01 blackbox automount[8622]: Starting automounter version 5.0.8, master map /etc/auto.master Jun 26 09:59:01 blackbox automount[8622]: using kernel protocol version 5.02 Jun 26 09:59:01 blackbox automount[8622]: lookup_nss_read_master: reading master file /etc/auto.master Jun 26 09:59:01 blackbox automount[8622]: parse_init: parse(sun): init gathered global options: (null) Jun 26 09:59:01 blackbox automount[8622]: spawn_mount: mtab link detected, passing -n to mount Jun 26 09:59:01 blackbox automount[8622]: spawn_umount: mtab link detected, passing -n to mount Jun 26 09:59:01 blackbox automount[8622]: lookup_read_master: lookup(file): read entry +dir:/etc/auto.master.d Jun 26 09:59:01 blackbox automount[8622]: lookup_nss_read_master: reading master dir /etc/auto.master.d Jun 26 09:59:01 blackbox automount[8622]: lookup_read_master: lookup(dir): scandir: /etc/auto.master.d Jun 26 09:59:01 blackbox automount[8622]: include_file: lookup(dir): include: /etc/auto.master.d/net.autofs Jun 26 09:59:01 blackbox automount[8622]: lookup_nss_read_master: reading master file /etc/auto.master.d/net.autofs Jun 26 09:59:01 blackbox automount[8622]: parse_init: parse(sun): init gathered global options: (null) Jun 26 09:59:01 blackbox automount[8622]: lookup_read_master: lookup(file): read entry /mnt/net Jun 26 09:59:01 blackbox automount[8622]: lookup_read_master: lookup(file): read entry /nfs Jun 26 09:59:01 blackbox automount[8622]: lookup_read_master: lookup(file): read entry +auto.master Jun 26 09:59:01 blackbox automount[8622]: lookup_nss_read_master: reading master files auto.master Jun 26 09:59:01 blackbox automount[8622]: parse_init: parse(sun): init gathered global options: (null) Jun 26 09:59:01 blackbox automount[8622]: lookup(file): failed to read included master map auto.master Jun 26 09:59:01 blackbox automount[8622]: master_do_mount: mounting /mnt/net Jun 26 09:59:01 blackbox automount[8622]: automount_path_to_fifo: fifo name /var/run/autofs.fifo-mnt-net Jun 26 09:59:01 blackbox automount[8622]: lookup_nss_read_map: reading map hosts (null) Jun 26 09:59:01 blackbox automount[8622]: parse_init: parse(sun): init gathered global options: (null) Jun 26 09:59:01 blackbox automount[8622]: spawn_mount: mtab link detected, passing -n to mount Jun 26 09:59:01 blackbox automount[8622]: spawn_umount: mtab link detected, passing -n to mount Jun 26 09:59:01 blackbox automount[8622]: lookup_read_map: lookup(hosts): read hosts map Jun 26 09:59:01 blackbox automount[8622]: lookup_read_map: lookup(hosts): map not browsable, update existing host entries only Jun 26 09:59:01 blackbox automount[8622]: mounted indirect on /mnt/net with timeout 60, freq 15 seconds Jun 26 09:59:01 blackbox automount[8622]: st_ready: st_ready(): state = 0 path /mnt/net Jun 26 09:59:01 blackbox automount[8622]: master_do_mount: mounting /nfs Jun 26 09:59:01 blackbox automount[8622]: automount_path_to_fifo: fifo name /var/run/autofs.fifo-nfs Jun 26 09:59:01 blackbox automount[8622]: lookup_nss_read_map: reading map file /etc/auto.nfs Jun 26 09:59:01 blackbox automount[8622]: parse_init: parse(sun): init gathered global options: (null) Jun 26 09:59:01 blackbox automount[8622]: mounted indirect on /nfs with timeout 300, freq 75 seconds Jun 26 09:59:01 blackbox automount[8622]: st_ready: st_ready(): state = 0 path /nfs Jun 26 09:59:05 blackbox automount[8622]: handle_packet: type = 3 Jun 26 09:59:05 blackbox automount[8622]: handle_packet_missing_indirect: token 8, name home, request pid 8654 Jun 26 09:59:05 blackbox automount[8622]: attempting to mount entry /nfs/home Jun 26 09:59:05 blackbox automount[8622]: lookup_mount: lookup(file): looking up home Jun 26 09:59:05 blackbox automount[8622]: lookup_mount: lookup(file): home -> home:/ Jun 26 09:59:05 blackbox automount[8622]: parse_mount: parse(sun): expanded entry: home:/ Jun 26 09:59:05 blackbox automount[8622]: parse_mount: parse(sun): gathered options: Jun 26 09:59:05 blackbox automount[8622]: parse_mount: parse(sun): dequote("home:/") -> home:/ Jun 26 09:59:05 blackbox automount[8622]: parse_mount: parse(sun): core of entry: options=, loc=home:/ Jun 26 09:59:05 blackbox automount[8622]: sun_mount: parse(sun): mounting root /nfs, mountpoint home, what home:/, fstype nfs, options (null) Jun 26 09:59:05 blackbox automount[8622]: mount_mount: mount(nfs): root=/nfs name=home what=home:/, fstype=nfs, options=(null) Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: called with host home(192.168.178.29) proto 6 version 0x30 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: nfs v3 rpc ping time: 0.000601 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: nfs v2 rpc ping time: 0.000380 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: host home cost 490 weight 0 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: called with host home(192.168.178.29) proto 17 version 0x30 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: nfs v3 rpc ping time: 0.000355 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: nfs v2 rpc ping time: 0.000387 Jun 26 09:59:05 blackbox automount[8622]: get_nfs_info: host home cost 370 weight 0 Jun 26 09:59:05 blackbox automount[8622]: prune_host_list: selected subset of hosts that support NFS3 over TCP Jun 26 09:59:05 blackbox automount[8622]: mount_mount: mount(nfs): calling mkdir_path /nfs/home Jun 26 09:59:05 blackbox automount[8622]: mount_mount: mount(nfs): calling mount -t nfs home:/ /nfs/home Jun 26 09:59:05 blackbox automount[8622]: spawn_mount: mtab link detected, passing -n to mount Jun 26 09:59:05 blackbox automount[8622]: mount_mount: mount(nfs): mounted home:/ on /nfs/home Jun 26 09:59:05 blackbox automount[8622]: dev_ioctl_send_ready: token = 8 Jun 26 09:59:05 blackbox automount[8622]: mounted /nfs/home Jun 26 09:59:27 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 09:59:27 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 09:59:27 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 09:59:27 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 09:59:27 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 09:59:42 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 09:59:42 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 09:59:42 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 09:59:42 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 09:59:42 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 09:59:57 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 09:59:57 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 09:59:57 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 09:59:57 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 09:59:57 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:00:12 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:00:12 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:00:12 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:00:12 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:00:12 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:00:27 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:00:27 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:00:27 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:00:27 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:00:27 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:00:29 blackbox automount[8622]: st_expire: state 1 path /nfs Jun 26 10:00:29 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /nfs Jun 26 10:00:29 blackbox automount[8622]: expire_proc_indirect: expire /nfs/home/home Jun 26 10:00:29 blackbox automount[8622]: expire_proc_indirect: expire /nfs/home Jun 26 10:00:29 blackbox automount[8622]: 2 remaining in /nfs Jun 26 10:00:29 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /nfs stat 4 Jun 26 10:00:29 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:00:29 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /nfs Jun 26 10:00:42 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:00:42 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:00:42 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:00:42 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:00:42 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:00:57 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:00:57 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:00:57 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:00:57 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:00:57 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:01:12 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:01:12 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:01:12 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:01:12 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:01:12 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:01:27 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:01:27 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:01:27 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:01:27 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:01:27 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:01:42 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:01:42 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:01:42 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:01:42 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:01:42 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:01:44 blackbox automount[8622]: st_expire: state 1 path /nfs Jun 26 10:01:44 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /nfs Jun 26 10:01:44 blackbox automount[8622]: expire_proc_indirect: expire /nfs/home/home Jun 26 10:01:44 blackbox automount[8622]: expire_proc_indirect: expire /nfs/home Jun 26 10:01:44 blackbox automount[8622]: 2 remaining in /nfs Jun 26 10:01:44 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /nfs stat 4 Jun 26 10:01:44 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:01:44 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /nfs Jun 26 10:01:57 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:01:57 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:01:57 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:01:57 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:01:57 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:02:12 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:02:12 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:02:12 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:02:12 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:02:12 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:02:27 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:02:27 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:02:27 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:02:27 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:02:27 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:02:32 blackbox automount[8622]: handle_packet: type = 3 Jun 26 10:02:32 blackbox automount[8622]: handle_packet_missing_indirect: token 9, name home, request pid 8999 Jun 26 10:02:32 blackbox automount[8622]: attempting to mount entry /mnt/net/home Jun 26 10:02:32 blackbox automount[8622]: lookup_mount: lookup(hosts): home -> (null) Jun 26 10:02:32 blackbox automount[8622]: get_exports: lookup(hosts): fetchng export list for home Jun 26 10:02:35 blackbox automount[8622]: get_exports: lookup(hosts): exports lookup failed for home Jun 26 10:02:35 blackbox automount[8622]: key "home" not found in map source(s). Jun 26 10:02:35 blackbox automount[8622]: dev_ioctl_send_fail: token = 9 Jun 26 10:02:35 blackbox automount[8622]: failed to mount /mnt/net/home Jun 26 10:02:42 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:02:42 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:02:42 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:02:42 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:02:42 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:02:48 blackbox automount[8622]: handle_packet: type = 3 Jun 26 10:02:48 blackbox automount[8622]: handle_packet_missing_indirect: token 10, name home, request pid 9020 Jun 26 10:02:48 blackbox automount[8622]: dev_ioctl_send_fail: token = 10 Jun 26 10:02:57 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:02:57 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:02:57 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:02:57 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:02:57 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:02:59 blackbox automount[8622]: st_expire: state 1 path /nfs Jun 26 10:02:59 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /nfs Jun 26 10:02:59 blackbox automount[8622]: expire_proc_indirect: expire /nfs/home/home Jun 26 10:02:59 blackbox automount[8622]: expire_proc_indirect: expire /nfs/home Jun 26 10:02:59 blackbox automount[8622]: 2 remaining in /nfs Jun 26 10:02:59 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /nfs stat 4 Jun 26 10:02:59 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:02:59 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /nfs Jun 26 10:03:12 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:03:12 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:03:12 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:03:12 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:03:12 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net Jun 26 10:03:27 blackbox automount[8622]: st_expire: state 1 path /mnt/net Jun 26 10:03:27 blackbox automount[8622]: expire_proc: exp_proc = 3052403520 path /mnt/net Jun 26 10:03:27 blackbox automount[8622]: expire_cleanup: got thid 3052403520 path /mnt/net stat 0 Jun 26 10:03:27 blackbox automount[8622]: expire_cleanup: sigchld: exp 3052403520 finished, switching from 2 to 1 Jun 26 10:03:27 blackbox automount[8622]: st_ready: st_ready(): state = 2 path /mnt/net When I avoid the BUILTIN MAP -hosts and specify explicitly rd@blackbox:/etc$ grep auto.nfs /etc/auto.master /nfs /etc/auto.nfs rd@blackbox:/etc$ cat /etc/auto.nfs home home:/ rd@blackbox:/etc$ the automounter works flawless rd@blackbox:/etc$ ls /nfs/home home rd@blackbox:/etc$ I have seen a similar issue reported against Fedora: https://bugzilla.redhat.com/show_bug.cgi?id=1038356 Many thanks Rainer -- System Information: Debian Release: 8.5 APT prefers stable APT policy: (500, 'stable'), (450, 'proposed-updates'), (400, 'testing'), (300, 'unstable'), (250, 'experimental') Architecture: i386 (i686) Kernel: Linux 3.16.0-4-686-pae (SMP w/2 CPU cores) Locale: LANG=de_DE.UTF-8, LC_CTYPE=de_DE.UTF-8 (charmap=UTF-8) Shell: /bin/sh linked to /bin/dash Init: systemd (via /run/systemd/system) Versions of packages autofs depends on: ii libc6 2.19-18+deb8u4 ii libxml2 2.9.1+dfsg1-5+deb8u2 ii multiarch-support 2.19-18+deb8u4 ii ucf 3.0030 Versions of packages autofs recommends: ii kmod 18-3 ii module-init-tools 18-3 ii nfs-common 1:1.2.8-9 autofs suggests no packages. -- no debconf information
