I can not confirm that this _is_ a bug, either in the autofs4 kernel module or the autofs package.
Here are the logs when run in --debug mode:
Jul 5 01:29:16 localhost automount[19019]: starting automounter version
4.1.4, path = /mnt, maptype = file, mapname = /etc/auto.misc
Jul 5 01:29:16 localhost automount[19019]: mount(bind): bind_works = 1
Jul 5 01:29:16 localhost automount[19019]: using kernel protocol version 4.00
Jul 5 01:29:16 localhost automount[19019]: using timeout 30 seconds; freq 8
secs
Jul 5 01:29:16 localhost automount[19019]: ghosting enabled
Jul 5 01:29:27 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:29:27 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:29:27 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:29:27 localhost automount[19019]: expire_proc: exp_proc=19023
Jul 5 01:29:27 localhost automount[19019]: handle_child: got pid 19023, sig 0
(0), stat 0
Jul 5 01:29:27 localhost automount[19019]: sigchld: exp 19023 finished,
switching from 2 to 1
Jul 5 01:29:27 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:29:27 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:29:35 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:29:35 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:29:35 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:29:35 localhost automount[19019]: expire_proc: exp_proc=19027
Jul 5 01:29:35 localhost automount[19019]: handle_child: got pid 19027, sig 0
(0), stat 0
Jul 5 01:29:35 localhost automount[19019]: sigchld: exp 19027 finished,
switching from 2 to 1
Jul 5 01:29:35 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:29:35 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:29:43 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:29:43 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:29:43 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:29:43 localhost automount[19019]: expire_proc: exp_proc=19029
Jul 5 01:29:43 localhost automount[19019]: handle_child: got pid 19029, sig 0
(0), stat 0
Jul 5 01:29:43 localhost automount[19019]: sigchld: exp 19029 finished,
switching from 2 to 1
Jul 5 01:29:43 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:29:44 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:29:49 localhost automount[19019]: handle_packet: type = 0
Jul 5 01:29:49 localhost automount[19019]: handle_packet_missing: token 206,
name windows
Jul 5 01:29:49 localhost automount[19019]: attempting to mount
entry /mnt/windows
Jul 5 01:29:49 localhost automount[19031]: lookup(file):
windows -> -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:29:49 localhost automount[19031]: parse(sun): expanded
entry: -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:29:49 localhost automount[19031]: parse(sun):
dequote("fstype=vfat,uid=1000,umask=0022,user") ->
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:29:49 localhost automount[19031]: parse(sun): gathered options:
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:29:49 localhost automount[19031]: parse(sun):
dequote("/dev/hda2") -> /dev/hda2
Jul 5 01:29:49 localhost automount[19031]: parse(sun): core of entry:
options=fstype=vfat,uid=1000,umask=0022,user, loc=/dev/hda2
Jul 5 01:29:49 localhost automount[19031]: parse(sun): mounting root /mnt,
mountpoint windows, what /dev/hda2, fstype vfat, options
uid=1000,umask=0022,user
Jul 5 01:29:49 localhost automount[19031]: do_mount /dev/hda2 /mnt/windows
type vfat options uid=1000,umask=0022,user using module generic
Jul 5 01:29:49 localhost automount[19031]: mount(generic): calling
mkdir_path /mnt/windows
Jul 5 01:29:49 localhost automount[19031]: mount(generic): calling mount -t
vfat -s -o uid=1000,umask=0022,user /dev/hda2 /mnt/windows
Jul 5 01:29:49 localhost automount[19031]: mount(generic): mounted /dev/hda2
type vfat on /mnt/windows
Jul 5 01:29:49 localhost automount[19019]: handle_child: got pid 19031, sig 0
(0), stat 0
Jul 5 01:29:49 localhost automount[19019]: sig_child: found pending iop pid
19031: signalled 0 (sig 0), exit status 0
Jul 5 01:29:49 localhost automount[19019]: send_ready: token=206
Jul 5 01:29:51 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:29:51 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:29:51 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:29:51 localhost automount[19037]: expire_proc: 1 remaining in /mnt
Jul 5 01:29:51 localhost automount[19019]: expire_proc: exp_proc=19037
Jul 5 01:29:51 localhost automount[19019]: handle_child: got pid 19037, sig 0
(0), stat 1
Jul 5 01:29:51 localhost automount[19019]: sigchld: exp 19037 finished,
switching from 2 to 1
Jul 5 01:29:51 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:29:51 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:29:59 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:29:59 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:29:59 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:29:59 localhost automount[19019]: expire_proc: exp_proc=19038
Jul 5 01:29:59 localhost automount[19038]: expire_proc: 1 remaining in /mnt
Jul 5 01:29:59 localhost automount[19019]: handle_child: got pid 19038, sig 0
(0), stat 1
Jul 5 01:29:59 localhost automount[19019]: sigchld: exp 19038 finished,
switching from 2 to 1
Jul 5 01:29:59 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:29:59 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:07 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:07 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:07 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:07 localhost automount[19039]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:07 localhost automount[19019]: expire_proc: exp_proc=19039
Jul 5 01:30:07 localhost automount[19019]: handle_child: got pid 19039, sig 0
(0), stat 1
Jul 5 01:30:07 localhost automount[19019]: sigchld: exp 19039 finished,
switching from 2 to 1
Jul 5 01:30:07 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:07 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:15 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:15 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:15 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:15 localhost automount[19040]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:15 localhost automount[19019]: expire_proc: exp_proc=19040
Jul 5 01:30:15 localhost automount[19019]: handle_child: got pid 19040, sig 0
(0), stat 1
Jul 5 01:30:15 localhost automount[19019]: sigchld: exp 19040 finished,
switching from 2 to 1
Jul 5 01:30:15 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:15 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:23 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:23 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:23 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:23 localhost automount[19019]: expire_proc: exp_proc=19041
Jul 5 01:30:23 localhost automount[19019]: handle_packet: type = 2
Jul 5 01:30:23 localhost automount[19019]: handle_packet_expire_multi: token
207, name windows
Jul 5 01:30:23 localhost automount[19042]: expiring path /mnt/windows
Jul 5 01:30:23 localhost automount[19042]: umount_multi: path=/mnt/windows
incl=1
Jul 5 01:30:23 localhost automount[19042]: umount_multi: unmounting
dir=/mnt/windows
Jul 5 01:30:23 localhost automount[19042]: expired /mnt/windows
Jul 5 01:30:23 localhost automount[19019]: handle_child: got pid 19042, sig 0
(0), stat 0
Jul 5 01:30:23 localhost automount[19019]: sig_child: found pending iop pid
19042: signalled 0 (sig 0), exit status 0
Jul 5 01:30:23 localhost automount[19019]: send_ready: token=207
Jul 5 01:30:23 localhost automount[19019]: handle_packet: type = 0
Jul 5 01:30:23 localhost automount[19019]: handle_packet_missing: token 208,
name windows
Jul 5 01:30:23 localhost automount[19019]: attempting to mount
entry /mnt/windows
Jul 5 01:30:23 localhost automount[19047]: lookup(file):
windows -> -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:30:23 localhost automount[19047]: parse(sun): expanded
entry: -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:30:23 localhost automount[19047]: parse(sun):
dequote("fstype=vfat,uid=1000,umask=0022,user") ->
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:30:23 localhost automount[19047]: parse(sun): gathered options:
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:30:23 localhost automount[19047]: parse(sun):
dequote("/dev/hda2") -> /dev/hda2
Jul 5 01:30:23 localhost automount[19047]: parse(sun): core of entry:
options=fstype=vfat,uid=1000,umask=0022,user, loc=/dev/hda2
Jul 5 01:30:23 localhost automount[19047]: parse(sun): mounting root /mnt,
mountpoint windows, what /dev/hda2, fstype vfat, options
uid=1000,umask=0022,user
Jul 5 01:30:23 localhost automount[19047]: do_mount /dev/hda2 /mnt/windows
type vfat options uid=1000,umask=0022,user using module generic
Jul 5 01:30:23 localhost automount[19047]: mount(generic): calling
mkdir_path /mnt/windows
Jul 5 01:30:23 localhost automount[19047]: mount(generic): calling mount -t
vfat -s -o uid=1000,umask=0022,user /dev/hda2 /mnt/windows
Jul 5 01:30:23 localhost automount[19047]: mount(generic): mounted /dev/hda2
type vfat on /mnt/windows
Jul 5 01:30:23 localhost automount[19019]: handle_child: got pid 19047, sig 0
(0), stat 0
Jul 5 01:30:23 localhost automount[19019]: sig_child: found pending iop pid
19047: signalled 0 (sig 0), exit status 0
Jul 5 01:30:23 localhost automount[19019]: send_ready: token=208
Jul 5 01:30:23 localhost automount[19041]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:23 localhost automount[19019]: handle_child: got pid 19041, sig 0
(0), stat 1
Jul 5 01:30:23 localhost automount[19019]: sigchld: exp 19041 finished,
switching from 2 to 1
Jul 5 01:30:23 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:23 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:31 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:31 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:31 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:31 localhost automount[19019]: expire_proc: exp_proc=19055
Jul 5 01:30:31 localhost automount[19055]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:31 localhost automount[19019]: handle_child: got pid 19055, sig 0
(0), stat 1
Jul 5 01:30:31 localhost automount[19019]: sigchld: exp 19055 finished,
switching from 2 to 1
Jul 5 01:30:31 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:31 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:39 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:39 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:39 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:39 localhost automount[19019]: expire_proc: exp_proc=19056
Jul 5 01:30:39 localhost automount[19056]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:39 localhost automount[19019]: handle_child: got pid 19056, sig 0
(0), stat 1
Jul 5 01:30:39 localhost automount[19019]: sigchld: exp 19056 finished,
switching from 2 to 1
Jul 5 01:30:39 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:39 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:47 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:47 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:47 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:47 localhost automount[19019]: expire_proc: exp_proc=19058
Jul 5 01:30:47 localhost automount[19058]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:47 localhost automount[19019]: handle_child: got pid 19058, sig 0
(0), stat 1
Jul 5 01:30:47 localhost automount[19019]: sigchld: exp 19058 finished,
switching from 2 to 1
Jul 5 01:30:47 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:47 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:30:55 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:30:55 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:30:55 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:30:55 localhost automount[19019]: expire_proc: exp_proc=19059
Jul 5 01:30:55 localhost automount[19019]: handle_packet: type = 2
Jul 5 01:30:55 localhost automount[19019]: handle_packet_expire_multi: token
209, name windows
Jul 5 01:30:55 localhost automount[19060]: expiring path /mnt/windows
Jul 5 01:30:55 localhost automount[19060]: umount_multi: path=/mnt/windows
incl=1
Jul 5 01:30:55 localhost automount[19060]: umount_multi: unmounting
dir=/mnt/windows
Jul 5 01:30:55 localhost automount[19060]: expired /mnt/windows
Jul 5 01:30:55 localhost automount[19019]: handle_child: got pid 19060, sig 0
(0), stat 0
Jul 5 01:30:55 localhost automount[19019]: sig_child: found pending iop pid
19060: signalled 0 (sig 0), exit status 0
Jul 5 01:30:55 localhost automount[19019]: send_ready: token=209
Jul 5 01:30:55 localhost automount[19019]: handle_packet: type = 0
Jul 5 01:30:55 localhost automount[19019]: handle_packet_missing: token 210,
name windows
Jul 5 01:30:55 localhost automount[19019]: attempting to mount
entry /mnt/windows
Jul 5 01:30:55 localhost automount[19063]: lookup(file):
windows -> -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:30:55 localhost automount[19063]: parse(sun): expanded
entry: -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:30:55 localhost automount[19063]: parse(sun):
dequote("fstype=vfat,uid=1000,umask=0022,user") ->
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:30:55 localhost automount[19063]: parse(sun): gathered options:
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:30:55 localhost automount[19063]: parse(sun):
dequote("/dev/hda2") -> /dev/hda2
Jul 5 01:30:55 localhost automount[19063]: parse(sun): core of entry:
options=fstype=vfat,uid=1000,umask=0022,user, loc=/dev/hda2
Jul 5 01:30:55 localhost automount[19063]: parse(sun): mounting root /mnt,
mountpoint windows, what /dev/hda2, fstype vfat, options
uid=1000,umask=0022,user
Jul 5 01:30:55 localhost automount[19063]: do_mount /dev/hda2 /mnt/windows
type vfat options uid=1000,umask=0022,user using module generic
Jul 5 01:30:55 localhost automount[19063]: mount(generic): calling
mkdir_path /mnt/windows
Jul 5 01:30:55 localhost automount[19063]: mount(generic): calling mount -t
vfat -s -o uid=1000,umask=0022,user /dev/hda2 /mnt/windows
Jul 5 01:30:55 localhost automount[19063]: mount(generic): mounted /dev/hda2
type vfat on /mnt/windows
Jul 5 01:30:55 localhost automount[19019]: handle_child: got pid 19063, sig 0
(0), stat 0
Jul 5 01:30:55 localhost automount[19019]: sig_child: found pending iop pid
19063: signalled 0 (sig 0), exit status 0
Jul 5 01:30:55 localhost automount[19019]: send_ready: token=210
Jul 5 01:30:55 localhost automount[19059]: expire_proc: 1 remaining in /mnt
Jul 5 01:30:55 localhost automount[19019]: handle_child: got pid 19059, sig 0
(0), stat 1
Jul 5 01:30:55 localhost automount[19019]: sigchld: exp 19059 finished,
switching from 2 to 1
Jul 5 01:30:55 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:30:55 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:31:03 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:31:03 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:31:03 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:31:03 localhost automount[19019]: expire_proc: exp_proc=19073
Jul 5 01:31:03 localhost automount[19073]: expire_proc: 1 remaining in /mnt
Jul 5 01:31:03 localhost automount[19019]: handle_child: got pid 19073, sig 0
(0), stat 1
Jul 5 01:31:03 localhost automount[19019]: sigchld: exp 19073 finished,
switching from 2 to 1
Jul 5 01:31:03 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:31:03 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:31:11 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:31:11 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:31:11 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:31:11 localhost automount[19074]: expire_proc: 1 remaining in /mnt
Jul 5 01:31:11 localhost automount[19019]: expire_proc: exp_proc=19074
Jul 5 01:31:11 localhost automount[19019]: handle_child: got pid 19074, sig 0
(0), stat 1
Jul 5 01:31:11 localhost automount[19019]: sigchld: exp 19074 finished,
switching from 2 to 1
Jul 5 01:31:11 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:31:11 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:31:19 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:31:19 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:31:19 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:31:19 localhost automount[19075]: expire_proc: 1 remaining in /mnt
Jul 5 01:31:19 localhost automount[19019]: expire_proc: exp_proc=19075
Jul 5 01:31:19 localhost automount[19019]: handle_child: got pid 19075, sig 0
(0), stat 1
Jul 5 01:31:19 localhost automount[19019]: sigchld: exp 19075 finished,
switching from 2 to 1
Jul 5 01:31:19 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:31:19 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:31:27 localhost automount[19019]: sig 14 switching from 1 to 2
Jul 5 01:31:27 localhost automount[19019]: get_pkt: state 1, next 2
Jul 5 01:31:27 localhost automount[19019]: st_expire(): state = 1
Jul 5 01:31:27 localhost automount[19019]: expire_proc: exp_proc=19076
Jul 5 01:31:27 localhost automount[19019]: handle_packet: type = 2
Jul 5 01:31:27 localhost automount[19019]: handle_packet_expire_multi: token
211, name windows
Jul 5 01:31:27 localhost automount[19077]: expiring path /mnt/windows
Jul 5 01:31:27 localhost automount[19077]: umount_multi: path=/mnt/windows
incl=1
Jul 5 01:31:27 localhost automount[19077]: umount_multi: unmounting
dir=/mnt/windows
Jul 5 01:31:27 localhost automount[19077]: expired /mnt/windows
Jul 5 01:31:27 localhost automount[19019]: handle_child: got pid 19077, sig 0
(0), stat 0
Jul 5 01:31:28 localhost automount[19019]: sig_child: found pending iop pid
19077: signalled 0 (sig 0), exit status 0
Jul 5 01:31:28 localhost automount[19019]: send_ready: token=211
Jul 5 01:31:28 localhost automount[19019]: handle_packet: type = 0
Jul 5 01:31:28 localhost automount[19019]: handle_packet_missing: token 212,
name windows
Jul 5 01:31:28 localhost automount[19019]: attempting to mount
entry /mnt/windows
Jul 5 01:31:28 localhost automount[19082]: lookup(file):
windows -> -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:31:28 localhost automount[19082]: parse(sun): expanded
entry: -fstype=vfat,uid=1000,umask=0022,user^I:/dev/hda2
Jul 5 01:31:28 localhost automount[19082]: parse(sun):
dequote("fstype=vfat,uid=1000,umask=0022,user") ->
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:31:28 localhost automount[19082]: parse(sun): gathered options:
fstype=vfat,uid=1000,umask=0022,user
Jul 5 01:31:28 localhost automount[19082]: parse(sun):
dequote("/dev/hda2") -> /dev/hda2
Jul 5 01:31:28 localhost automount[19082]: parse(sun): core of entry:
options=fstype=vfat,uid=1000,umask=0022,user, loc=/dev/hda2
Jul 5 01:31:28 localhost automount[19082]: parse(sun): mounting root /mnt,
mountpoint windows, what /dev/hda2, fstype vfat, options
uid=1000,umask=0022,user
Jul 5 01:31:28 localhost automount[19082]: do_mount /dev/hda2 /mnt/windows
type vfat options uid=1000,umask=0022,user using module generic
Jul 5 01:31:28 localhost automount[19082]: mount(generic): calling
mkdir_path /mnt/windows
Jul 5 01:31:28 localhost automount[19082]: mount(generic): calling mount -t
vfat -s -o uid=1000,umask=0022,user /dev/hda2 /mnt/windows
Jul 5 01:31:28 localhost automount[19082]: mount(generic): mounted /dev/hda2
type vfat on /mnt/windows
Jul 5 01:31:28 localhost automount[19019]: handle_child: got pid 19082, sig 0
(0), stat 0
Jul 5 01:31:28 localhost automount[19019]: sig_child: found pending iop pid
19082: signalled 0 (sig 0), exit status 0
Jul 5 01:31:28 localhost automount[19019]: send_ready: token=212
Jul 5 01:31:28 localhost automount[19076]: expire_proc: 1 remaining in /mnt
Jul 5 01:31:28 localhost automount[19019]: handle_child: got pid 19076, sig 0
(0), stat 1
Jul 5 01:31:28 localhost automount[19019]: sigchld: exp 19076 finished,
switching from 2 to 1
Jul 5 01:31:28 localhost automount[19019]: get_pkt: state 2, next 1
Jul 5 01:31:28 localhost automount[19019]: st_ready(): state = 2
Jul 5 01:31:31 localhost automount[19019]: sig 12 switching from 1 to 5
Jul 5 01:31:31 localhost automount[19019]: get_pkt: state 1, next 5
Jul 5 01:31:31 localhost automount[19019]: prep_shutdown: state = 1
Jul 5 01:31:31 localhost automount[19019]: signal_children: send 12 to
process group 19019
Jul 5 01:31:31 localhost automount[19019]: expire_proc: exp_proc=19103
Jul 5 01:31:31 localhost automount[19019]: prep_shutdown: expire returns 1
Jul 5 01:31:31 localhost automount[19019]: handle_packet: type = 2
Jul 5 01:31:31 localhost automount[19019]: handle_packet_expire_multi: token
213, name windows
Jul 5 01:31:31 localhost automount[19104]: expiring path /mnt/windows
Jul 5 01:31:31 localhost automount[19104]: umount_multi: path=/mnt/windows
incl=1
Jul 5 01:31:31 localhost automount[19104]: umount_multi: unmounting
dir=/mnt/windows
Jul 5 01:31:31 localhost automount[19104]: rm_unwanted: /mnt/windows
Jul 5 01:31:31 localhost automount[19104]: expired /mnt/windows
Jul 5 01:31:31 localhost automount[19019]: handle_child: got pid 19104, sig 0
(0), stat 0
Jul 5 01:31:31 localhost automount[19019]: sig_child: found pending iop pid
19104: signalled 0 (sig 0), exit status 0
Jul 5 01:31:31 localhost automount[19019]: send_ready: token=213
Jul 5 01:31:31 localhost automount[19019]: handle_packet: type = 0
Jul 5 01:31:31 localhost automount[19019]: handle_packet_missing: token 214,
name windows
Jul 5 01:31:31 localhost automount[19019]: send_fail: token=214
Jul 5 01:31:31 localhost automount[19019]: handle_child: got pid 19103, sig 0
(0), stat 0
Jul 5 01:31:31 localhost automount[19019]: sigchld: exp 19103 finished,
switching from 5 to 6
Jul 5 01:31:31 localhost automount[19019]: get_pkt: state 5, next 6
Jul 5 01:31:31 localhost automount[19019]: umount_multi: path=/mnt incl=0
Jul 5 01:31:31 localhost automount[19019]: umount_multi: no mounts found
under /mnt
Jul 5 01:31:31 localhost automount[19019]: rm_unwanted: /mnt/vfat
Jul 5 01:31:31 localhost automount[19019]: rm_unwanted: /mnt/dvd
Jul 5 01:31:31 localhost automount[19019]: rm_unwanted: /mnt/cdrw
Jul 5 01:31:31 localhost automount[19019]: rm_unwanted: /mnt/cdrom
Jul 5 01:31:31 localhost automount[19019]: rm_unwanted: /mnt/build
Jul 5 01:31:31 localhost automount[19019]: rm_unwanted: /mnt/backup
Jul 5 01:31:31 localhost automount[19019]: shut down, path = /mnt
Jul 5 01:33:03 localhost automount[19547]: starting automounter version
4.1.4, path = /mnt, maptype = file, mapname = /etc/auto.misc
Jul 5 01:33:03 localhost automount[19547]: mount(bind): bind_works = 1
Jul 5 01:33:03 localhost automount[19547]: using kernel protocol version 4.00
Jul 5 01:33:03 localhost automount[19547]: using timeout 30 seconds; freq 8
secs
Jul 5 01:33:03 localhost automount[19547]: ghosting enabled
Jul 5 01:33:14 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:33:14 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:33:14 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:33:14 localhost automount[19547]: expire_proc: exp_proc=19625
Jul 5 01:33:14 localhost automount[19547]: handle_child: got pid 19625, sig 0
(0), stat 0
Jul 5 01:33:14 localhost automount[19547]: sigchld: exp 19625 finished,
switching from 2 to 1
Jul 5 01:33:14 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:33:14 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:33:22 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:33:22 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:33:22 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:33:22 localhost automount[19547]: expire_proc: exp_proc=20037
Jul 5 01:33:22 localhost automount[19547]: handle_child: got pid 20037, sig 0
(0), stat 0
Jul 5 01:33:22 localhost automount[19547]: sigchld: exp 20037 finished,
switching from 2 to 1
Jul 5 01:33:22 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:33:22 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:33:30 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:33:30 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:33:30 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:33:30 localhost automount[19547]: expire_proc: exp_proc=20042
Jul 5 01:33:30 localhost automount[19547]: handle_child: got pid 20042, sig 0
(0), stat 0
Jul 5 01:33:30 localhost automount[19547]: sigchld: exp 20042 finished,
switching from 2 to 1
Jul 5 01:33:30 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:33:30 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:33:38 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:33:38 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:33:38 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:33:38 localhost automount[19547]: expire_proc: exp_proc=20043
Jul 5 01:33:38 localhost automount[19547]: handle_child: got pid 20043, sig 0
(0), stat 0
Jul 5 01:33:38 localhost automount[19547]: sigchld: exp 20043 finished,
switching from 2 to 1
Jul 5 01:33:38 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:33:38 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:33:46 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:33:46 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:33:46 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:33:46 localhost automount[19547]: expire_proc: exp_proc=20045
Jul 5 01:33:46 localhost automount[19547]: handle_child: got pid 20045, sig 0
(0), stat 0
Jul 5 01:33:46 localhost automount[19547]: sigchld: exp 20045 finished,
switching from 2 to 1
Jul 5 01:33:46 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:33:46 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:33:54 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:33:54 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:33:54 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:33:54 localhost automount[19547]: expire_proc: exp_proc=20046
Jul 5 01:33:54 localhost automount[19547]: handle_child: got pid 20046, sig 0
(0), stat 0
Jul 5 01:33:54 localhost automount[19547]: sigchld: exp 20046 finished,
switching from 2 to 1
Jul 5 01:33:54 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:33:54 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:34:02 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:34:02 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:34:02 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:34:02 localhost automount[19547]: expire_proc: exp_proc=20047
Jul 5 01:34:02 localhost automount[19547]: handle_child: got pid 20047, sig 0
(0), stat 0
Jul 5 01:34:02 localhost automount[19547]: sigchld: exp 20047 finished,
switching from 2 to 1
Jul 5 01:34:02 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:34:02 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:34:10 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:34:10 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:34:10 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:34:10 localhost automount[19547]: expire_proc: exp_proc=20048
Jul 5 01:34:10 localhost automount[19547]: handle_child: got pid 20048, sig 0
(0), stat 0
Jul 5 01:34:10 localhost automount[19547]: sigchld: exp 20048 finished,
switching from 2 to 1
Jul 5 01:34:10 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:34:10 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:34:18 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:34:18 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:34:18 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:34:18 localhost automount[19547]: expire_proc: exp_proc=20050
Jul 5 01:34:18 localhost automount[19547]: handle_child: got pid 20050, sig 0
(0), stat 0
Jul 5 01:34:18 localhost automount[19547]: sigchld: exp 20050 finished,
switching from 2 to 1
Jul 5 01:34:18 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:34:18 localhost automount[19547]: st_ready(): state = 2
Jul 5 01:34:26 localhost automount[19547]: sig 14 switching from 1 to 2
Jul 5 01:34:26 localhost automount[19547]: get_pkt: state 1, next 2
Jul 5 01:34:26 localhost automount[19547]: st_expire(): state = 1
Jul 5 01:34:26 localhost automount[19547]: expire_proc: exp_proc=20052
Jul 5 01:34:26 localhost automount[19547]: handle_child: got pid 20052, sig 0
(0), stat 0
Jul 5 01:34:26 localhost automount[19547]: sigchld: exp 20052 finished,
switching from 2 to 1
Jul 5 01:34:26 localhost automount[19547]: get_pkt: state 2, next 1
Jul 5 01:34:26 localhost automount[19547]: st_ready(): state = 2
One thing to notice was that if the mount point (/mnt/build => /dev/sda1) was
made busy with a process (say a `cd` to /mnt/build), the automount process
didn't mount it continuously.
Hope this helps to hunt for the problem.
Ritesh
--
Ritesh Raj Sarraf
RESEARCHUT - http://www.researchut.com
"Necessity is the mother of invention."
"Stealing logic from one person is plagiarism, stealing from many is
research."
"The great are those who achieve the impossible, the petty are those who
cannot - rrs"
pgpBbilTr9VQV.pgp
Description: PGP signature
