automount never umount

automount never umount

[Farkas Levente]

hi,
i'm just start autofs on my desktop machine. the main reason for this
because smbfs (and also cifs) use a very high network load on my system
and i use these file very seldom, so it'd be very useful if after a few
minutes these fs can be umounted. unfortunately it seems that neither
cifs or smbfs not nfs volumes are never umounted. if they mounted once
they will remain there forever. it seems automount has the right option:
--------------------------------
root      2007  0.0  0.0   1792   696 ?        Ss   Nov16   0:00
/usr/sbin/automount --timeout=60 /smb program /etc/auto.smb
root      2041  0.0  0.0   1788   696 ?        Ss   Nov16   0:00
/usr/sbin/automount --timeout=60 /net program /etc/auto.net
--------------------------------
i try to find out which file can hold /net or /smb but neither fuser nor
lsof can show anything. is there any way to find out something about the
status of automount? eg which files are used what is the timeout when
the timeout fill be left etc?
what can be wrong? any tip?
my system is fedora core 4 full update:
kernel-2.6.14-1.1637_FC4
autofs-4.1.4-5
nfs-utils-1.0.7-12.FC4
samba-client-3.0.14a-2
thank you for your help in advance.
yours.


-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Ian Kent]

On Mon, 21 Nov 2005, Farkas Levente wrote:

> hi,
> i'm just start autofs on my desktop machine. the main reason for this
> because smbfs (and also cifs) use a very high network load on my system
> and i use these file very seldom, so it'd be very useful if after a few
> minutes these fs can be umounted. unfortunately it seems that neither
> cifs or smbfs not nfs volumes are never umounted. if they mounted once
> they will remain there forever. it seems automount has the right option:
> --------------------------------
> root      2007  0.0  0.0   1792   696 ?        Ss   Nov16   0:00
> /usr/sbin/automount --timeout=60 /smb program /etc/auto.smb
> root      2041  0.0  0.0   1788   696 ?        Ss   Nov16   0:00
> /usr/sbin/automount --timeout=60 /net program /etc/auto.net
> --------------------------------
> i try to find out which file can hold /net or /smb but neither fuser nor
> lsof can show anything. is there any way to find out something about the
> status of automount? eg which files are used what is the timeout when
> the timeout fill be left etc?
> what can be wrong? any tip?
> my system is fedora core 4 full update:
> kernel-2.6.14-1.1637_FC4
> autofs-4.1.4-5
> nfs-utils-1.0.7-12.FC4
> samba-client-3.0.14a-2
> thank you for your help in advance.
> yours.

I see this sort of thing from time to time but I have always been 
unable to find out what is causing it.

Are you using a GUI. They are well known for scanning filesystems and 
keeping automounts active.

Maybe I need to alter the autofs definition of busy. I'll think about it.

Ian

Re: automount never umount

[Farkas Levente]

Ian Kent wrote:
> On Mon, 21 Nov 2005, Farkas Levente wrote:
> 
> 
>>hi,
>>i'm just start autofs on my desktop machine. the main reason for this
>>because smbfs (and also cifs) use a very high network load on my system
>>and i use these file very seldom, so it'd be very useful if after a few
>>minutes these fs can be umounted. unfortunately it seems that neither
>>cifs or smbfs not nfs volumes are never umounted. if they mounted once
>>they will remain there forever. it seems automount has the right option:
>>--------------------------------
>>root      2007  0.0  0.0   1792   696 ?        Ss   Nov16   0:00
>>/usr/sbin/automount --timeout=60 /smb program /etc/auto.smb
>>root      2041  0.0  0.0   1788   696 ?        Ss   Nov16   0:00
>>/usr/sbin/automount --timeout=60 /net program /etc/auto.net
>>--------------------------------
>>i try to find out which file can hold /net or /smb but neither fuser nor
>>lsof can show anything. is there any way to find out something about the
>>status of automount? eg which files are used what is the timeout when
>>the timeout fill be left etc?
>>what can be wrong? any tip?
>>my system is fedora core 4 full update:
>>kernel-2.6.14-1.1637_FC4
>>autofs-4.1.4-5
>>nfs-utils-1.0.7-12.FC4
>>samba-client-3.0.14a-2
>>thank you for your help in advance.
>>yours.
> 
> 
> I see this sort of thing from time to time but I have always been 
> unable to find out what is causing it.
> 
> Are you using a GUI. They are well known for scanning filesystems and 
> keeping automounts active.
> 
> Maybe I need to alter the autofs definition of busy. I'll think about it.

the best solution would be some kind of status report. who use it, why
busy, which file(s), when will umount, etc. in this case one can solve
the problem to drop/kill/not use such programs which has such effect.
but without such knowladge i'm just in the dark...

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Ian Kent]

On Tue, 22 Nov 2005, Farkas Levente wrote:

> Ian Kent wrote:
> > On Mon, 21 Nov 2005, Farkas Levente wrote:
> > 
> > 
> >>hi,
> >>i'm just start autofs on my desktop machine. the main reason for this
> >>because smbfs (and also cifs) use a very high network load on my system
> >>and i use these file very seldom, so it'd be very useful if after a few
> >>minutes these fs can be umounted. unfortunately it seems that neither
> >>cifs or smbfs not nfs volumes are never umounted. if they mounted once
> >>they will remain there forever. it seems automount has the right option:
> >>--------------------------------
> >>root      2007  0.0  0.0   1792   696 ?        Ss   Nov16   0:00
> >>/usr/sbin/automount --timeout=60 /smb program /etc/auto.smb
> >>root      2041  0.0  0.0   1788   696 ?        Ss   Nov16   0:00
> >>/usr/sbin/automount --timeout=60 /net program /etc/auto.net
> >>--------------------------------
> >>i try to find out which file can hold /net or /smb but neither fuser nor
> >>lsof can show anything. is there any way to find out something about the
> >>status of automount? eg which files are used what is the timeout when
> >>the timeout fill be left etc?
> >>what can be wrong? any tip?
> >>my system is fedora core 4 full update:
> >>kernel-2.6.14-1.1637_FC4
> >>autofs-4.1.4-5
> >>nfs-utils-1.0.7-12.FC4
> >>samba-client-3.0.14a-2
> >>thank you for your help in advance.
> >>yours.
> > 
> > 
> > I see this sort of thing from time to time but I have always been 
> > unable to find out what is causing it.
> > 
> > Are you using a GUI. They are well known for scanning filesystems and 
> > keeping automounts active.
> > 
> > Maybe I need to alter the autofs definition of busy. I'll think about it.
> 
> the best solution would be some kind of status report. who use it, why
> busy, which file(s), when will umount, etc. in this case one can solve
> the problem to drop/kill/not use such programs which has such effect.
> but without such knowladge i'm just in the dark...

That wasn't what I had in mind.

I was thinking more along the lines of the definition of what constitues 
"use". For example any access, such as a directory listing, will update 
the "last used" value whereas if I change the definition of "last used" to 
"currently in use" then to be busy there would have to be an open file or 
a process working directory set. This may solve the GUI scanning problem 
we see but wouldn't solve immediate remounting that occurs due to the 
scanning as well.

Most of the info you refer to above is either not available or hard to 
get. Basically a lot of work.

Ian

Re: automount never umount

[Farkas Levente]

Ian Kent wrote:
> That wasn't what I had in mind.
> 
> I was thinking more along the lines of the definition of what constitues 
> "use". For example any access, such as a directory listing, will update 
> the "last used" value whereas if I change the definition of "last used" to 
> "currently in use" then to be busy there would have to be an open file or 
> a process working directory set. This may solve the GUI scanning problem 
> we see but wouldn't solve immediate remounting that occurs due to the 
> scanning as well.

that would be useful and may be solve our problem. without it the
current implementation is not usable to umount. think about just the
daily process like slocate database update, tripwire and may be others.

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:

lfarkas> Ian Kent wrote:
>> That wasn't what I had in mind.
>> 
>> I was thinking more along the lines of the definition of what constitues
>> "use". For example any access, such as a directory listing, will update
>> the "last used" value whereas if I change the definition of "last used"
>> to "currently in use" then to be busy there would have to be an open
>> file or a process working directory set. This may solve the GUI scanning
>> problem we see but wouldn't solve immediate remounting that occurs due
>> to the scanning as well.

lfarkas> that would be useful and may be solve our problem. without it the
lfarkas> current implementation is not usable to umount. think about just
lfarkas> the daily process like slocate database update, tripwire and may
lfarkas> be others.

Things that run infrequently are not at fault, here.  I'd really like to
know precisely what is going on, in your case.

Ian, I think it would be easy enough to instrument the autofs4 module.
Simple things, like figuring out which process is triggerring the lookup.
We can either log it, or just keep a ring buffer.

I don't think I'll have time to put together any code this week, but may
next week.

-Jeff

Re: automount never umount

[Farkas Levente]

Jeff Moyer wrote:
> ==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:
> 
> lfarkas> Ian Kent wrote:
> 
>>>That wasn't what I had in mind.
>>>
>>>I was thinking more along the lines of the definition of what constitues
>>>"use". For example any access, such as a directory listing, will update
>>>the "last used" value whereas if I change the definition of "last used"
>>>to "currently in use" then to be busy there would have to be an open
>>>file or a process working directory set. This may solve the GUI scanning
>>>problem we see but wouldn't solve immediate remounting that occurs due
>>>to the scanning as well.
> 
> 
> lfarkas> that would be useful and may be solve our problem. without it the
> lfarkas> current implementation is not usable to umount. think about just
> lfarkas> the daily process like slocate database update, tripwire and may
> lfarkas> be others.
> 
> Things that run infrequently are not at fault, here.  I'd really like to
> know precisely what is going on, in your case.
> 
> Ian, I think it would be easy enough to instrument the autofs4 module.
> Simple things, like figuring out which process is triggerring the lookup.

ps axu can help you?

> We can either log it, or just keep a ring buffer.

i run gnome and nothing special, even if only one terminal and netscape 
is running the autofs never umount.


> I don't think I'll have time to put together any code this week, but may
> next week.

i'll happy to test it.

ps. i try smbfs, cifs, but even nfs is never umount.

-- 
   Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Ian Kent]

On Tue, 22 Nov 2005, Farkas Levente wrote:

> Jeff Moyer wrote:
> > ==> Regarding Re: [autofs] automount never umount; Farkas Levente
> > <lfarkas@bppiac.hu> adds:
> > 
> > lfarkas> Ian Kent wrote:
> > 
> > > > That wasn't what I had in mind.
> > > > 
> > > > I was thinking more along the lines of the definition of what constitues
> > > > "use". For example any access, such as a directory listing, will update
> > > > the "last used" value whereas if I change the definition of "last used"
> > > > to "currently in use" then to be busy there would have to be an open
> > > > file or a process working directory set. This may solve the GUI scanning
> > > > problem we see but wouldn't solve immediate remounting that occurs due
> > > > to the scanning as well.
> > 
> > 
> > lfarkas> that would be useful and may be solve our problem. without it the
> > lfarkas> current implementation is not usable to umount. think about just
> > lfarkas> the daily process like slocate database update, tripwire and may
> > lfarkas> be others.
> > 
> > Things that run infrequently are not at fault, here.  I'd really like to
> > know precisely what is going on, in your case.
> > 
> > Ian, I think it would be easy enough to instrument the autofs4 module.
> > Simple things, like figuring out which process is triggerring the lookup.
> 
> ps axu can help you?

Not really in our case.

> 
> > We can either log it, or just keep a ring buffer.
> 
> i run gnome and nothing special, even if only one terminal and netscape is
> running the autofs never umount.

I spent quite a bit of time on this very same issue some time ago.
I even subscribed to the list but the job was to big for the time I had.
The folks there agreed that that code was in need of work.

In the end I used a work around of setting the mode of the file where 
gnome keeps its files list to 000 so no entries could be added. Didn't 
seem to worry gnome and prevented the timeout/remount cycle.

I'll poke around and see if I can find the details.

As far as the desktop goes this is probably our biggest issue.

Ian

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:

lfarkas> Jeff Moyer wrote:
>> ==> Regarding Re: [autofs] automount never umount; Farkas Levente
>> <lfarkas@bppiac.hu> adds:
>> 
lfarkas> Ian Kent wrote:
>>
>>>> That wasn't what I had in mind.
>>>> 
>>>> I was thinking more along the lines of the definition of what
>>>> constitues "use". For example any access, such as a directory listing,
>>>> will update the "last used" value whereas if I change the definition
>>>> of "last used" to "currently in use" then to be busy there would have
>>>> to be an open file or a process working directory set. This may solve
>>>> the GUI scanning problem we see but wouldn't solve immediate
>>>> remounting that occurs due to the scanning as well.
>>
lfarkas> that would be useful and may be solve our problem. without it the
lfarkas> current implementation is not usable to umount. think about just
lfarkas> the daily process like slocate database update, tripwire and may
lfarkas> be others.
>> Things that run infrequently are not at fault, here.  I'd really like to
>> know precisely what is going on, in your case.
>> 
>> Ian, I think it would be easy enough to instrument the autofs4 module.
>> Simple things, like figuring out which process is triggerring the
>> lookup.

lfarkas> ps axu can help you?

>> We can either log it, or just keep a ring buffer.

lfarkas> i run gnome and nothing special, even if only one terminal and
lfarkas> netscape is running the autofs never umount.


>> I don't think I'll have time to put together any code this week, but may
>> next week.

lfarkas> i'll happy to test it.

Try the kernel rpm located here:

	http://people.redhat.com/jmoyer/farkas/kernel-2.6.14-1.1641_FC4.jmoyertest.1.i686.rpm

It has the potential to generate a good bit of output.  I've attached the
patch that is incorporated there.  You'll want to post the output of dmesg
to this list when you get it.

You'll notice that the second bit of this patch is not related to this
problem.  Ian, you should take that into account if you keep around the
expiry of negative dentries.

Thanks,

Jeff

--- linux-2.6.14/fs/autofs4/root.c.orig	2005-11-22 16:50:30.000000000 -0500
+++ linux-2.6.14/fs/autofs4/root.c	2005-11-22 16:52:51.000000000 -0500
@@ -388,6 +388,9 @@ static int autofs4_revalidate(struct den
 	int flags = nd ? nd->flags : 0;
 	int status = 1;
 
+	printk("%s: revalidate called on behalf of application \"%s\"\n",
+	       __FUNCTION__, current->comm);
+
 	/* Pending dentry */
 	if (autofs4_ispending(dentry)) {
 		if (!oz_mode)
@@ -397,7 +400,7 @@ static int autofs4_revalidate(struct den
 
 	/* Negative dentry.. invalidate if "old" */
 	if (dentry->d_inode == NULL)
-		return (dentry->d_time - jiffies <= 0);
+		return time_after_eq(jiffies, dentry->d_time);
 
 	/* Check for a non-mountpoint directory with no contents */
 	spin_lock(&dcache_lock);

Re: automount never umount

[Farkas Levente]

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

Jeff Moyer wrote:
> lfarkas> i'll happy to test it.
> 
> Try the kernel rpm located here:
> 
> 	http://people.redhat.com/jmoyer/farkas/kernel-2.6.14-1.1641_FC4.jmoyertest.1.i686.rpm
> 
> It has the potential to generate a good bit of output.  I've attached the
> patch that is incorporated there.  You'll want to post the output of dmesg
> to this list when you get it.

output of dmesg or /var/log/daemon? there is nothing in dmesg.
i'm running this kernel currently and mount nfs and smbfs servers.
---------------------------
root      1974  0.0  0.0   1788   736 ?        Ss   10:05   0:00
/usr/sbin/automount --timeout=60 --debug /smb program /etc/auto.smb
root      1976  0.0  0.0   1788   736 ?        Ss   10:05   0:00
/usr/sbin/automount --timeout=60 --debug /net program /etc/auto.net
---------------------------
how long should i wait? as the timeout is 1 minute, they should have to
be umounted, but not. here is the relevant part of daemon log which
don't tell me too much:-(

-- 
  Levente                               "Si vis pacem para bellum!"

[-- Attachment #2: daemon --]
[-- Type: text/plain, Size: 98387 bytes --]

Nov 23 10:05:42 garfield automount[1974]: starting automounter version 4.1.4-5, path = /smb, maptype = program, mapname = /etc/auto.smb
Nov 23 10:05:42 garfield automount[1976]: starting automounter version 4.1.4-5, path = /net, maptype = program, mapname = /etc/auto.net
Nov 23 10:05:42 garfield automount[1974]: mount(bind): bind_works = 1 
Nov 23 10:05:42 garfield automount[1976]: mount(bind): bind_works = 1 
Nov 23 10:05:42 garfield nscd: 1989 invalid persistent database file "/var/db/nscd/hosts": verification failed
Nov 23 10:05:43 garfield smartd[1996]: smartd version 5.33 [i386-redhat-linux-gnu] Copyright (C) 2002-4 Bruce Allen 
Nov 23 10:05:43 garfield automount[1974]: using kernel protocol version 4.07
Nov 23 10:05:43 garfield automount[1976]: using kernel protocol version 4.07
Nov 23 10:05:43 garfield smartd[1996]: Home page is http://smartmontools.sourceforge.net/  
Nov 23 10:05:43 garfield automount[1974]: using timeout 60 seconds; freq 15 secs
Nov 23 10:05:43 garfield automount[1976]: using timeout 60 seconds; freq 15 secs
Nov 23 10:05:43 garfield smartd[1996]: Opened configuration file /etc/smartd.conf 
Nov 23 10:05:43 garfield smartd[1996]: Configuration file /etc/smartd.conf parsed. 
Nov 23 10:05:43 garfield smartd[1996]: Device: /dev/hda, opened 
Nov 23 10:05:43 garfield smartd[1996]: Device: /dev/hda, found in smartd database. 
Nov 23 10:05:43 garfield smartd[1996]: Device: /dev/hda, is SMART capable. Adding to "monitor" list. 
Nov 23 10:05:43 garfield smartd[1996]: Monitoring 1 ATA and 0 SCSI devices 
Nov 23 10:05:44 garfield smartd[2008]: smartd has fork()ed into background mode. New PID=2008. 
Nov 23 10:05:44 garfield ntpdate[2035]: step time server 192.168.0.2 offset -0.499336 sec
Nov 23 10:05:44 garfield ntpd[2043]: ntpd 4.2.0a@1.1190-r Thu Apr 14 07:47:25 EDT 2005 (1)
Nov 23 10:05:45 garfield ntpd[2043]: precision = 1.000 usec
Nov 23 10:05:45 garfield ntpd[2043]: Listening on interface wildcard, 0.0.0.0#123
Nov 23 10:05:45 garfield ntpd[2043]: Listening on interface lo, 127.0.0.1#123
Nov 23 10:05:45 garfield ntpd[2043]: Listening on interface eth0, 192.168.0.50#123
Nov 23 10:05:45 garfield ntpd[2043]: kernel time sync status 0040
Nov 23 10:05:45 garfield ntpd[2043]: frequency initialized -12.897 PPM from /var/lib/ntp/drift
Nov 23 10:06:06 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:06:06 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:06:06 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:06:06 garfield automount[1974]: expire_proc: exp_proc=2559
Nov 23 10:06:06 garfield automount[1974]: handle_child: got pid 2559, sig 0 (0), stat 0 
Nov 23 10:06:06 garfield automount[1974]: sigchld: exp 2559 finished, switching from 2 to 1
Nov 23 10:06:06 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:06:06 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:06:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:06:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:06:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:06:08 garfield automount[1976]: expire_proc: exp_proc=2580
Nov 23 10:06:08 garfield automount[1976]: handle_child: got pid 2580, sig 0 (0), stat 0 
Nov 23 10:06:08 garfield automount[1976]: sigchld: exp 2580 finished, switching from 2 to 1
Nov 23 10:06:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:06:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:06:21 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:06:21 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:06:21 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:06:21 garfield automount[1974]: expire_proc: exp_proc=2587
Nov 23 10:06:21 garfield automount[1974]: handle_child: got pid 2587, sig 0 (0), stat 0 
Nov 23 10:06:21 garfield automount[1974]: sigchld: exp 2587 finished, switching from 2 to 1
Nov 23 10:06:21 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:06:21 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:06:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:06:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:06:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:06:23 garfield automount[1976]: expire_proc: exp_proc=2588
Nov 23 10:06:23 garfield automount[1976]: handle_child: got pid 2588, sig 0 (0), stat 0 
Nov 23 10:06:23 garfield automount[1976]: sigchld: exp 2588 finished, switching from 2 to 1
Nov 23 10:06:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:06:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:06:36 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:06:36 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:06:36 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:06:36 garfield automount[1974]: expire_proc: exp_proc=2589
Nov 23 10:06:36 garfield automount[1974]: handle_child: got pid 2589, sig 0 (0), stat 0 
Nov 23 10:06:36 garfield automount[1974]: sigchld: exp 2589 finished, switching from 2 to 1
Nov 23 10:06:36 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:06:36 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:06:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:06:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:06:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:06:38 garfield automount[1976]: expire_proc: exp_proc=2590
Nov 23 10:06:38 garfield automount[1976]: handle_child: got pid 2590, sig 0 (0), stat 0 
Nov 23 10:06:38 garfield automount[1976]: sigchld: exp 2590 finished, switching from 2 to 1
Nov 23 10:06:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:06:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:06:51 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:06:51 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:06:51 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:06:51 garfield automount[1974]: expire_proc: exp_proc=2591
Nov 23 10:06:51 garfield automount[1974]: handle_child: got pid 2591, sig 0 (0), stat 0 
Nov 23 10:06:51 garfield automount[1974]: sigchld: exp 2591 finished, switching from 2 to 1
Nov 23 10:06:51 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:06:51 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:06:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:06:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:06:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:06:53 garfield automount[1976]: expire_proc: exp_proc=2592
Nov 23 10:06:53 garfield automount[1976]: handle_child: got pid 2592, sig 0 (0), stat 0 
Nov 23 10:06:53 garfield automount[1976]: sigchld: exp 2592 finished, switching from 2 to 1
Nov 23 10:06:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:06:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:07:06 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:07:06 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:07:06 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:07:06 garfield automount[1974]: expire_proc: exp_proc=2593
Nov 23 10:07:06 garfield automount[1974]: handle_child: got pid 2593, sig 0 (0), stat 0 
Nov 23 10:07:06 garfield automount[1974]: sigchld: exp 2593 finished, switching from 2 to 1
Nov 23 10:07:06 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:07:06 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:07:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:07:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:07:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:07:08 garfield automount[1976]: expire_proc: exp_proc=2594
Nov 23 10:07:08 garfield automount[1976]: handle_child: got pid 2594, sig 0 (0), stat 0 
Nov 23 10:07:08 garfield automount[1976]: sigchld: exp 2594 finished, switching from 2 to 1
Nov 23 10:07:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:07:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:07:21 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:07:21 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:07:21 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:07:21 garfield automount[1974]: expire_proc: exp_proc=2595
Nov 23 10:07:21 garfield automount[1974]: handle_child: got pid 2595, sig 0 (0), stat 0 
Nov 23 10:07:21 garfield automount[1974]: sigchld: exp 2595 finished, switching from 2 to 1
Nov 23 10:07:21 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:07:21 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:07:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:07:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:07:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:07:23 garfield automount[1976]: expire_proc: exp_proc=2596
Nov 23 10:07:23 garfield automount[1976]: handle_child: got pid 2596, sig 0 (0), stat 0 
Nov 23 10:07:23 garfield automount[1976]: sigchld: exp 2596 finished, switching from 2 to 1
Nov 23 10:07:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:07:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:07:36 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:07:36 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:07:36 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:07:36 garfield automount[1974]: expire_proc: exp_proc=2597
Nov 23 10:07:36 garfield automount[1974]: handle_child: got pid 2597, sig 0 (0), stat 0 
Nov 23 10:07:36 garfield automount[1974]: sigchld: exp 2597 finished, switching from 2 to 1
Nov 23 10:07:36 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:07:36 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:07:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:07:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:07:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:07:38 garfield automount[1976]: expire_proc: exp_proc=2598
Nov 23 10:07:38 garfield automount[1976]: handle_child: got pid 2598, sig 0 (0), stat 0 
Nov 23 10:07:38 garfield automount[1976]: sigchld: exp 2598 finished, switching from 2 to 1
Nov 23 10:07:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:07:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:07:51 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:07:51 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:07:51 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:07:51 garfield automount[1974]: expire_proc: exp_proc=2599
Nov 23 10:07:51 garfield automount[1974]: handle_child: got pid 2599, sig 0 (0), stat 0 
Nov 23 10:07:51 garfield automount[1974]: sigchld: exp 2599 finished, switching from 2 to 1
Nov 23 10:07:51 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:07:51 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:07:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:07:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:07:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:07:53 garfield automount[1976]: expire_proc: exp_proc=2600
Nov 23 10:07:53 garfield automount[1976]: handle_child: got pid 2600, sig 0 (0), stat 0 
Nov 23 10:07:53 garfield automount[1976]: sigchld: exp 2600 finished, switching from 2 to 1
Nov 23 10:07:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:07:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:08:06 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:08:06 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:08:06 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:08:06 garfield automount[1974]: expire_proc: exp_proc=2601
Nov 23 10:08:06 garfield automount[1974]: handle_child: got pid 2601, sig 0 (0), stat 0 
Nov 23 10:08:06 garfield automount[1974]: sigchld: exp 2601 finished, switching from 2 to 1
Nov 23 10:08:06 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:08:06 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:08:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:08:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:08:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:08:08 garfield automount[1976]: expire_proc: exp_proc=2602
Nov 23 10:08:08 garfield automount[1976]: handle_child: got pid 2602, sig 0 (0), stat 0 
Nov 23 10:08:08 garfield automount[1976]: sigchld: exp 2602 finished, switching from 2 to 1
Nov 23 10:08:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:08:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:08:21 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:08:21 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:08:21 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:08:21 garfield automount[1974]: expire_proc: exp_proc=2603
Nov 23 10:08:21 garfield automount[1974]: handle_child: got pid 2603, sig 0 (0), stat 0 
Nov 23 10:08:21 garfield automount[1974]: sigchld: exp 2603 finished, switching from 2 to 1
Nov 23 10:08:21 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:08:21 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:08:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:08:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:08:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:08:23 garfield automount[1976]: expire_proc: exp_proc=2604
Nov 23 10:08:23 garfield automount[1976]: handle_child: got pid 2604, sig 0 (0), stat 0 
Nov 23 10:08:23 garfield automount[1976]: sigchld: exp 2604 finished, switching from 2 to 1
Nov 23 10:08:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:08:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:08:36 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:08:36 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:08:36 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:08:36 garfield automount[1974]: expire_proc: exp_proc=2605
Nov 23 10:08:36 garfield automount[1974]: handle_child: got pid 2605, sig 0 (0), stat 0 
Nov 23 10:08:36 garfield automount[1974]: sigchld: exp 2605 finished, switching from 2 to 1
Nov 23 10:08:36 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:08:36 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:08:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:08:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:08:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:08:38 garfield automount[1976]: expire_proc: exp_proc=2606
Nov 23 10:08:38 garfield automount[1976]: handle_child: got pid 2606, sig 0 (0), stat 0 
Nov 23 10:08:38 garfield automount[1976]: sigchld: exp 2606 finished, switching from 2 to 1
Nov 23 10:08:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:08:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:08:51 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:08:51 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:08:51 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:08:51 garfield automount[1974]: expire_proc: exp_proc=2607
Nov 23 10:08:51 garfield automount[1974]: handle_child: got pid 2607, sig 0 (0), stat 0 
Nov 23 10:08:51 garfield automount[1974]: sigchld: exp 2607 finished, switching from 2 to 1
Nov 23 10:08:51 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:08:51 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:08:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:08:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:08:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:08:53 garfield automount[1976]: expire_proc: exp_proc=2608
Nov 23 10:08:53 garfield automount[1976]: handle_child: got pid 2608, sig 0 (0), stat 0 
Nov 23 10:08:53 garfield automount[1976]: sigchld: exp 2608 finished, switching from 2 to 1
Nov 23 10:08:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:08:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:09:01 garfield ntpd[2043]: synchronized to LOCAL(0), stratum 10
Nov 23 10:09:01 garfield ntpd[2043]: kernel time sync disabled 0041
Nov 23 10:09:06 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:09:06 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:09:06 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:09:06 garfield automount[1974]: expire_proc: exp_proc=2609
Nov 23 10:09:06 garfield automount[1974]: handle_child: got pid 2609, sig 0 (0), stat 0 
Nov 23 10:09:06 garfield automount[1974]: sigchld: exp 2609 finished, switching from 2 to 1
Nov 23 10:09:06 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:09:06 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:09:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:09:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:09:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:09:08 garfield automount[1976]: expire_proc: exp_proc=2610
Nov 23 10:09:08 garfield automount[1976]: handle_child: got pid 2610, sig 0 (0), stat 0 
Nov 23 10:09:08 garfield automount[1976]: sigchld: exp 2610 finished, switching from 2 to 1
Nov 23 10:09:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:09:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:09:21 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:09:21 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:09:21 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:09:21 garfield automount[1974]: expire_proc: exp_proc=2611
Nov 23 10:09:21 garfield automount[1974]: handle_child: got pid 2611, sig 0 (0), stat 0 
Nov 23 10:09:21 garfield automount[1974]: sigchld: exp 2611 finished, switching from 2 to 1
Nov 23 10:09:21 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:09:21 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:09:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:09:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:09:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:09:23 garfield automount[1976]: expire_proc: exp_proc=2612
Nov 23 10:09:23 garfield automount[1976]: handle_child: got pid 2612, sig 0 (0), stat 0 
Nov 23 10:09:23 garfield automount[1976]: sigchld: exp 2612 finished, switching from 2 to 1
Nov 23 10:09:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:09:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:09:36 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:09:36 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:09:36 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:09:36 garfield automount[1974]: expire_proc: exp_proc=2613
Nov 23 10:09:36 garfield automount[1974]: handle_child: got pid 2613, sig 0 (0), stat 0 
Nov 23 10:09:36 garfield automount[1974]: sigchld: exp 2613 finished, switching from 2 to 1
Nov 23 10:09:36 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:09:36 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:09:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:09:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:09:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:09:38 garfield automount[1976]: expire_proc: exp_proc=2614
Nov 23 10:09:38 garfield automount[1976]: handle_child: got pid 2614, sig 0 (0), stat 0 
Nov 23 10:09:38 garfield automount[1976]: sigchld: exp 2614 finished, switching from 2 to 1
Nov 23 10:09:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:09:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:09:51 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:09:51 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:09:51 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:09:51 garfield automount[1974]: expire_proc: exp_proc=2615
Nov 23 10:09:51 garfield automount[1974]: handle_child: got pid 2615, sig 0 (0), stat 0 
Nov 23 10:09:51 garfield automount[1974]: sigchld: exp 2615 finished, switching from 2 to 1
Nov 23 10:09:51 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:09:51 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:09:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:09:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:09:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:09:53 garfield automount[1976]: expire_proc: exp_proc=2616
Nov 23 10:09:53 garfield automount[1976]: handle_child: got pid 2616, sig 0 (0), stat 0 
Nov 23 10:09:53 garfield automount[1976]: sigchld: exp 2616 finished, switching from 2 to 1
Nov 23 10:09:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:09:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:10:05 garfield ntpd[2043]: synchronized to 192.168.1.3, stratum 3
Nov 23 10:10:05 garfield ntpd[2043]: kernel time sync enabled 0001
Nov 23 10:10:06 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:10:06 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:10:06 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:10:06 garfield automount[1974]: expire_proc: exp_proc=2682
Nov 23 10:10:06 garfield automount[1974]: handle_child: got pid 2682, sig 0 (0), stat 0 
Nov 23 10:10:06 garfield automount[1974]: sigchld: exp 2682 finished, switching from 2 to 1
Nov 23 10:10:06 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:10:06 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:10:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:10:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:10:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:10:08 garfield automount[1976]: expire_proc: exp_proc=2683
Nov 23 10:10:08 garfield automount[1976]: handle_child: got pid 2683, sig 0 (0), stat 0 
Nov 23 10:10:08 garfield automount[1976]: sigchld: exp 2683 finished, switching from 2 to 1
Nov 23 10:10:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:10:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:10:21 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:10:21 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:10:21 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:10:21 garfield automount[1974]: expire_proc: exp_proc=2812
Nov 23 10:10:21 garfield automount[1974]: handle_child: got pid 2812, sig 0 (0), stat 0 
Nov 23 10:10:21 garfield automount[1974]: sigchld: exp 2812 finished, switching from 2 to 1
Nov 23 10:10:21 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:10:21 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:10:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:10:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:10:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:10:23 garfield automount[1976]: expire_proc: exp_proc=2813
Nov 23 10:10:23 garfield automount[1976]: handle_child: got pid 2813, sig 0 (0), stat 0 
Nov 23 10:10:23 garfield automount[1976]: sigchld: exp 2813 finished, switching from 2 to 1
Nov 23 10:10:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:10:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:10:36 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:10:36 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:10:36 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:10:36 garfield automount[1974]: expire_proc: exp_proc=2815
Nov 23 10:10:36 garfield automount[1974]: handle_child: got pid 2815, sig 0 (0), stat 0 
Nov 23 10:10:36 garfield automount[1974]: sigchld: exp 2815 finished, switching from 2 to 1
Nov 23 10:10:36 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:10:36 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:10:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:10:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:10:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:10:38 garfield automount[1976]: expire_proc: exp_proc=2816
Nov 23 10:10:38 garfield automount[1976]: handle_child: got pid 2816, sig 0 (0), stat 0 
Nov 23 10:10:38 garfield automount[1976]: sigchld: exp 2816 finished, switching from 2 to 1
Nov 23 10:10:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:10:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:10:51 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:10:51 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:10:51 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:10:51 garfield automount[1974]: expire_proc: exp_proc=2818
Nov 23 10:10:51 garfield automount[1974]: handle_child: got pid 2818, sig 0 (0), stat 0 
Nov 23 10:10:51 garfield automount[1974]: sigchld: exp 2818 finished, switching from 2 to 1
Nov 23 10:10:51 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:10:51 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:10:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:10:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:10:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:10:53 garfield automount[1976]: expire_proc: exp_proc=2819
Nov 23 10:10:53 garfield automount[1976]: handle_child: got pid 2819, sig 0 (0), stat 0 
Nov 23 10:10:53 garfield automount[1976]: sigchld: exp 2819 finished, switching from 2 to 1
Nov 23 10:10:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:10:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:10:55 garfield automount[1976]: handle_packet: type = 0 
Nov 23 10:10:55 garfield automount[1976]: handle_packet_missing: token 1, name mirror 
Nov 23 10:10:55 garfield automount[1976]: attempting to mount entry /net/mirror
Nov 23 10:10:55 garfield automount[2820]: lookup(program): looking up mirror
Nov 23 10:10:55 garfield automount[2820]: lookup(program): mirror -> -fstype=nfs,hard,intr,nodev,nosuid  	/mnt/md2/download mirror:/mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: parse(sun): expanded entry: -fstype=nfs,hard,intr,nodev,nosuid  	/mnt/md2/download mirror:/mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: parse(sun): dequote("fstype=nfs,hard,intr,nodev,nosuid") -> fstype=nfs,hard,intr,nodev,nosuid
Nov 23 10:10:55 garfield automount[2820]: parse(sun): gathered options: fstype=nfs,hard,intr,nodev,nosuid
Nov 23 10:10:55 garfield automount[2820]: parse(sun): dequote("/mnt/md2/download") -> /mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: parse(sun): dequote("mirror:/mnt/md2/download") -> mirror:/mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: parse(sun): multimount: mirror:/mnt/md2/download on /mnt/md2/download with options fstype=nfs,hard,intr,nodev,nosuid
Nov 23 10:10:55 garfield automount[2820]: parse(sun): mounting root /net/mirror, mountpoint mnt/md2/download, what mirror:/mnt/md2/download, fstype nfs, options hard,intr,nodev,nosuid 
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): root=/net/mirror name=mnt/md2/download what=mirror:/mnt/md2/download, fstype=nfs, options=hard,intr,nodev,nosuid
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): nfs options="hard,intr,nodev,nosuid", nosymlink=0, ro=0
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): is_local_mount: mirror
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): winner = mirror local = 0
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): all hosts timed out for 'mirror:/mnt/md2/download', retrying with longer timeout
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): winner = mirror local = 0
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): from mirror:/mnt/md2/download elected mirror:/mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): calling mkdir_path /net/mirror/mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): calling mount -t nfs -s  -o hard,intr,nodev,nosuid mirror:/mnt/md2/download /net/mirror/mnt/md2/download
Nov 23 10:10:55 garfield automount[2820]: mount(nfs): mounted mirror:/mnt/md2/download on /net/mirror/mnt/md2/download
Nov 23 10:10:55 garfield automount[1976]: handle_child: got pid 2820, sig 0 (0), stat 0 
Nov 23 10:10:55 garfield automount[1976]: sig_child: found pending iop pid 2820: signalled 0 (sig 0), exit status 0
Nov 23 10:10:55 garfield automount[1976]: send_ready: token=1 
Nov 23 10:10:58 garfield automount[1974]: handle_packet: type = 0 
Nov 23 10:10:58 garfield automount[1974]: handle_packet_missing: token 2, name atom 
Nov 23 10:10:58 garfield automount[1974]: attempting to mount entry /smb/atom
Nov 23 10:10:58 garfield automount[2836]: lookup(program): looking up atom
Nov 23 10:10:58 garfield automount[2836]: lookup(program): atom -> -fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755  	 /inf ://atom/inf  	 /install ://atom/install  	 /ellenorz ://atom/ellenorz  	 /fotosok ://atom/fotosok  	 /piac-ujsag ://atom/piac-ujsag  	 /piac-install ://atom/piac-install  	 /piac-egyeb ://atom/piac-egyeb  	 /piac-archive ://atom/piac-archive  	 /nap-archive ://atom/nap-archive  	 /penzugy ://atom/penzugy  	 /program ://atom/program  	 /szerkesztok ://atom/szerkesztok  	 /temp ://atom/temp  	 /ugyfelsz ://atom/ugyfelsz  	 /web ://atom/web
Nov 23 10:10:58 garfield automount[2836]: parse(sun): expanded entry: -fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755  	 /inf ://atom/inf  	 /install ://atom/install  	 /ellenorz ://atom/ellenorz  	 /fotosok ://atom/fotosok  	 /piac-ujsag ://atom/piac-ujsag  	 /piac-install ://atom/piac-install  	 /piac-egyeb ://atom/piac-egyeb  	 /piac-archive ://atom/piac-archive  	 /nap-archive ://atom/nap-archive  	 /penzugy ://atom/penzugy  	 /program ://atom/program  	 /szerkesztok ://atom/szerkesztok  	 /temp ://atom/temp  	 /ugyfelsz ://atom/ugyfelsz  	 /web ://atom/web
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755") -> fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:58 garfield automount[2836]: parse(sun): gathered options: fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/inf") -> /inf
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/inf") -> //atom/inf
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/install") -> /install
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/install") -> //atom/install
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/ellenorz") -> /ellenorz
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/ellenorz") -> //atom/ellenorz
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/fotosok") -> /fotosok
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/fotosok") -> //atom/fotosok
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/piac-ujsag") -> /piac-ujsag
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/piac-ujsag") -> //atom/piac-ujsag
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/piac-install") -> /piac-install
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/piac-install") -> //atom/piac-install
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/piac-egyeb") -> /piac-egyeb
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/piac-egyeb") -> //atom/piac-egyeb
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/piac-archive") -> /piac-archive
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/piac-archive") -> //atom/piac-archive
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/nap-archive") -> /nap-archive
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/nap-archive") -> //atom/nap-archive
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/penzugy") -> /penzugy
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/penzugy") -> //atom/penzugy
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/program") -> /program
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/program") -> //atom/program
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/szerkesztok") -> /szerkesztok
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/szerkesztok") -> //atom/szerkesztok
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/temp") -> /temp
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/temp") -> //atom/temp
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/ugyfelsz") -> /ugyfelsz
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/ugyfelsz") -> //atom/ugyfelsz
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("/web") -> /web
Nov 23 10:10:58 garfield automount[2836]: parse(sun): dequote("//atom/web") -> //atom/web
Nov 23 10:10:58 garfield automount[2836]: parse(sun): multimount: //atom/web on /web with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:58 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint web, what //atom/web, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:58 garfield automount[2836]: do_mount //atom/web /smb/atom/web type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:58 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/web
Nov 23 10:10:58 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/web /smb/atom/web
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/web type smbfs on /smb/atom/web
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/inf on /inf with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint inf, what //atom/inf, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/inf /smb/atom/inf type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/inf
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/inf /smb/atom/inf
Nov 23 10:10:59 garfield mount.smbfs[2842]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2842]:   mount.smbfs: entering daemon mode for service \\atom\web, pid=2842 
Nov 23 10:10:59 garfield mount.smbfs[2855]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2855]:   mount.smbfs: entering daemon mode for service \\atom\inf, pid=2855 
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/inf type smbfs on /smb/atom/inf
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/temp on /temp with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint temp, what //atom/temp, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/temp /smb/atom/temp type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/temp
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/temp /smb/atom/temp
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/temp type smbfs on /smb/atom/temp
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/program on /program with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint program, what //atom/program, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/program /smb/atom/program type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/program
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/program /smb/atom/program
Nov 23 10:10:59 garfield mount.smbfs[2859]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2859]:   mount.smbfs: entering daemon mode for service \\atom\temp, pid=2859 
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/program type smbfs on /smb/atom/program
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/penzugy on /penzugy with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint penzugy, what //atom/penzugy, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/penzugy /smb/atom/penzugy type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/penzugy
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/penzugy /smb/atom/penzugy
Nov 23 10:10:59 garfield mount.smbfs[2863]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2863]:   mount.smbfs: entering daemon mode for service \\atom\program, pid=2863 
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/penzugy type smbfs on /smb/atom/penzugy
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/fotosok on /fotosok with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint fotosok, what //atom/fotosok, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/fotosok /smb/atom/fotosok type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/fotosok
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/fotosok /smb/atom/fotosok
Nov 23 10:10:59 garfield mount.smbfs[2867]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2867]:   mount.smbfs: entering daemon mode for service \\atom\penzugy, pid=2867 
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/fotosok type smbfs on /smb/atom/fotosok
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/install on /install with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint install, what //atom/install, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/install /smb/atom/install type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/install
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/install /smb/atom/install
Nov 23 10:10:59 garfield mount.smbfs[2871]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2871]:   mount.smbfs: entering daemon mode for service \\atom\fotosok, pid=2871 
Nov 23 10:10:59 garfield automount[2836]: mount(generic): mounted //atom/install type smbfs on /smb/atom/install
Nov 23 10:10:59 garfield automount[2836]: parse(sun): multimount: //atom/ugyfelsz on /ugyfelsz with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:10:59 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint ugyfelsz, what //atom/ugyfelsz, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:10:59 garfield automount[2836]: do_mount //atom/ugyfelsz /smb/atom/ugyfelsz type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/ugyfelsz
Nov 23 10:10:59 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/ugyfelsz /smb/atom/ugyfelsz
Nov 23 10:10:59 garfield mount.smbfs[2875]: [2005/11/23 10:10:59, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:10:59 garfield mount.smbfs[2875]:   mount.smbfs: entering daemon mode for service \\atom\install, pid=2875 
Nov 23 10:11:00 garfield mount.smbfs[2879]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2879]:   mount.smbfs: entering daemon mode for service \\atom\ugyfelsz, pid=2879 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/ugyfelsz type smbfs on /smb/atom/ugyfelsz
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/ellenorz on /ellenorz with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint ellenorz, what //atom/ellenorz, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/ellenorz /smb/atom/ellenorz type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/ellenorz
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/ellenorz /smb/atom/ellenorz
Nov 23 10:11:00 garfield mount.smbfs[2883]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2883]:   mount.smbfs: entering daemon mode for service \\atom\ellenorz, pid=2883 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/ellenorz type smbfs on /smb/atom/ellenorz
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/piac-egyeb on /piac-egyeb with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint piac-egyeb, what //atom/piac-egyeb, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/piac-egyeb /smb/atom/piac-egyeb type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/piac-egyeb
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/piac-egyeb /smb/atom/piac-egyeb
Nov 23 10:11:00 garfield mount.smbfs[2887]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2887]:   mount.smbfs: entering daemon mode for service \\atom\piac-egyeb, pid=2887 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/piac-egyeb type smbfs on /smb/atom/piac-egyeb
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/piac-ujsag on /piac-ujsag with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint piac-ujsag, what //atom/piac-ujsag, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/piac-ujsag /smb/atom/piac-ujsag type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/piac-ujsag
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/piac-ujsag /smb/atom/piac-ujsag
Nov 23 10:11:00 garfield mount.smbfs[2891]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2891]:   mount.smbfs: entering daemon mode for service \\atom\piac-ujsag, pid=2891 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/piac-ujsag type smbfs on /smb/atom/piac-ujsag
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/szerkesztok on /szerkesztok with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint szerkesztok, what //atom/szerkesztok, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/szerkesztok /smb/atom/szerkesztok type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/szerkesztok
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/szerkesztok /smb/atom/szerkesztok
Nov 23 10:11:00 garfield mount.smbfs[2895]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2895]:   mount.smbfs: entering daemon mode for service \\atom\szerkesztok, pid=2895 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/szerkesztok type smbfs on /smb/atom/szerkesztok
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/nap-archive on /nap-archive with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint nap-archive, what //atom/nap-archive, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/nap-archive /smb/atom/nap-archive type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/nap-archive
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/nap-archive /smb/atom/nap-archive
Nov 23 10:11:00 garfield mount.smbfs[2899]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2899]:   mount.smbfs: entering daemon mode for service \\atom\nap-archive, pid=2899 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/nap-archive type smbfs on /smb/atom/nap-archive
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/piac-archive on /piac-archive with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint piac-archive, what //atom/piac-archive, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/piac-archive /smb/atom/piac-archive type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/piac-archive
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/piac-archive /smb/atom/piac-archive
Nov 23 10:11:00 garfield mount.smbfs[2903]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2903]:   mount.smbfs: entering daemon mode for service \\atom\piac-archive, pid=2903 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/piac-archive type smbfs on /smb/atom/piac-archive
Nov 23 10:11:00 garfield automount[2836]: parse(sun): multimount: //atom/piac-install on /piac-install with options fstype=smbfs,credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755
Nov 23 10:11:00 garfield automount[2836]: parse(sun): mounting root /smb/atom, mountpoint piac-install, what //atom/piac-install, fstype smbfs, options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 
Nov 23 10:11:00 garfield automount[2836]: do_mount //atom/piac-install /smb/atom/piac-install type smbfs options credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 using module generic
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mkdir_path /smb/atom/piac-install
Nov 23 10:11:00 garfield automount[2836]: mount(generic): calling mount -t smbfs -s -o credentials=/home/lfarkas/.smb/atom.cred,workgroup=BPPIAC,uid=501,gid=501,fmask=0644,dmask=0755 //atom/piac-install /smb/atom/piac-install
Nov 23 10:11:00 garfield mount.smbfs[2907]: [2005/11/23 10:11:00, 0] client/smbmount.c:send_fs_socket(406) 
Nov 23 10:11:00 garfield mount.smbfs[2907]:   mount.smbfs: entering daemon mode for service \\atom\piac-install, pid=2907 
Nov 23 10:11:00 garfield automount[2836]: mount(generic): mounted //atom/piac-install type smbfs on /smb/atom/piac-install
Nov 23 10:11:00 garfield automount[1974]: handle_child: got pid 2836, sig 0 (0), stat 0 
Nov 23 10:11:00 garfield automount[1974]: sig_child: found pending iop pid 2836: signalled 0 (sig 0), exit status 0
Nov 23 10:11:00 garfield automount[1974]: send_ready: token=2 
Nov 23 10:11:06 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:11:06 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:11:06 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:11:06 garfield automount[1974]: expire_proc: exp_proc=2920
Nov 23 10:11:06 garfield automount[2920]: expire_proc: 15 remaining in /smb 
Nov 23 10:11:06 garfield automount[1974]: handle_child: got pid 2920, sig 0 (0), stat 1 
Nov 23 10:11:06 garfield automount[1974]: sigchld: exp 2920 finished, switching from 2 to 1
Nov 23 10:11:06 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:11:06 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:11:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:11:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:11:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:11:08 garfield automount[2921]: expire_proc: 1 remaining in /net 
Nov 23 10:11:08 garfield automount[1976]: expire_proc: exp_proc=2921
Nov 23 10:11:08 garfield automount[1976]: handle_child: got pid 2921, sig 0 (0), stat 1 
Nov 23 10:11:08 garfield automount[1976]: sigchld: exp 2921 finished, switching from 2 to 1
Nov 23 10:11:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:11:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:11:21 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:11:21 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:11:21 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:11:21 garfield automount[1974]: expire_proc: exp_proc=2970
Nov 23 10:11:21 garfield automount[2970]: expire_proc: 15 remaining in /smb 
Nov 23 10:11:21 garfield automount[1974]: handle_child: got pid 2970, sig 0 (0), stat 1 
Nov 23 10:11:21 garfield automount[1974]: sigchld: exp 2970 finished, switching from 2 to 1
Nov 23 10:11:21 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:11:21 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:11:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:11:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:11:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:11:23 garfield automount[2971]: expire_proc: 1 remaining in /net 
Nov 23 10:11:23 garfield automount[1976]: expire_proc: exp_proc=2971
Nov 23 10:11:23 garfield automount[1976]: handle_child: got pid 2971, sig 0 (0), stat 1 
Nov 23 10:11:23 garfield automount[1976]: sigchld: exp 2971 finished, switching from 2 to 1
Nov 23 10:11:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:11:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:11:36 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:11:36 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:11:36 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:11:36 garfield automount[1974]: expire_proc: exp_proc=2979
Nov 23 10:11:36 garfield automount[2979]: expire_proc: 15 remaining in /smb 
Nov 23 10:11:36 garfield automount[1974]: handle_child: got pid 2979, sig 0 (0), stat 1 
Nov 23 10:11:36 garfield automount[1974]: sigchld: exp 2979 finished, switching from 2 to 1
Nov 23 10:11:36 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:11:36 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:11:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:11:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:11:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:11:38 garfield automount[2980]: expire_proc: 1 remaining in /net 
Nov 23 10:11:38 garfield automount[1976]: expire_proc: exp_proc=2980
Nov 23 10:11:38 garfield automount[1976]: handle_child: got pid 2980, sig 0 (0), stat 1 
Nov 23 10:11:38 garfield automount[1976]: sigchld: exp 2980 finished, switching from 2 to 1
Nov 23 10:11:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:11:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:11:51 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:11:51 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:11:51 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:11:51 garfield automount[1974]: expire_proc: exp_proc=2981
Nov 23 10:11:51 garfield automount[2981]: expire_proc: 15 remaining in /smb 
Nov 23 10:11:51 garfield automount[1974]: handle_child: got pid 2981, sig 0 (0), stat 1 
Nov 23 10:11:51 garfield automount[1974]: sigchld: exp 2981 finished, switching from 2 to 1
Nov 23 10:11:51 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:11:51 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:11:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:11:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:11:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:11:53 garfield automount[2982]: expire_proc: 1 remaining in /net 
Nov 23 10:11:53 garfield automount[1976]: expire_proc: exp_proc=2982
Nov 23 10:11:53 garfield automount[1976]: handle_child: got pid 2982, sig 0 (0), stat 1 
Nov 23 10:11:53 garfield automount[1976]: sigchld: exp 2982 finished, switching from 2 to 1
Nov 23 10:11:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:11:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:12:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:12:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:12:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:12:07 garfield automount[1974]: expire_proc: exp_proc=2983
Nov 23 10:12:07 garfield automount[2983]: expire_proc: 15 remaining in /smb 
Nov 23 10:12:07 garfield automount[1974]: handle_child: got pid 2983, sig 0 (0), stat 1 
Nov 23 10:12:07 garfield automount[1974]: sigchld: exp 2983 finished, switching from 2 to 1
Nov 23 10:12:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:12:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:12:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:12:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:12:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:12:08 garfield automount[1976]: expire_proc: exp_proc=2984
Nov 23 10:12:08 garfield automount[2984]: expire_proc: 1 remaining in /net 
Nov 23 10:12:08 garfield automount[1976]: handle_child: got pid 2984, sig 0 (0), stat 1 
Nov 23 10:12:08 garfield automount[1976]: sigchld: exp 2984 finished, switching from 2 to 1
Nov 23 10:12:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:12:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:12:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:12:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:12:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:12:22 garfield automount[1974]: expire_proc: exp_proc=2985
Nov 23 10:12:22 garfield automount[2985]: expire_proc: 15 remaining in /smb 
Nov 23 10:12:22 garfield automount[1974]: handle_child: got pid 2985, sig 0 (0), stat 1 
Nov 23 10:12:22 garfield automount[1974]: sigchld: exp 2985 finished, switching from 2 to 1
Nov 23 10:12:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:12:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:12:23 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:12:23 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:12:23 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:12:23 garfield automount[2986]: expire_proc: 1 remaining in /net 
Nov 23 10:12:23 garfield automount[1976]: expire_proc: exp_proc=2986
Nov 23 10:12:23 garfield automount[1976]: handle_child: got pid 2986, sig 0 (0), stat 1 
Nov 23 10:12:23 garfield automount[1976]: sigchld: exp 2986 finished, switching from 2 to 1
Nov 23 10:12:23 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:12:23 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:12:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:12:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:12:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:12:37 garfield automount[1974]: expire_proc: exp_proc=2987
Nov 23 10:12:37 garfield automount[2987]: expire_proc: 15 remaining in /smb 
Nov 23 10:12:37 garfield automount[1974]: handle_child: got pid 2987, sig 0 (0), stat 1 
Nov 23 10:12:37 garfield automount[1974]: sigchld: exp 2987 finished, switching from 2 to 1
Nov 23 10:12:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:12:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:12:38 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:12:38 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:12:38 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:12:38 garfield automount[2988]: expire_proc: 1 remaining in /net 
Nov 23 10:12:38 garfield automount[1976]: expire_proc: exp_proc=2988
Nov 23 10:12:38 garfield automount[1976]: handle_child: got pid 2988, sig 0 (0), stat 1 
Nov 23 10:12:38 garfield automount[1976]: sigchld: exp 2988 finished, switching from 2 to 1
Nov 23 10:12:38 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:12:38 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:12:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:12:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:12:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:12:52 garfield automount[1974]: expire_proc: exp_proc=2989
Nov 23 10:12:52 garfield automount[2989]: expire_proc: 15 remaining in /smb 
Nov 23 10:12:52 garfield automount[1974]: handle_child: got pid 2989, sig 0 (0), stat 1 
Nov 23 10:12:52 garfield automount[1974]: sigchld: exp 2989 finished, switching from 2 to 1
Nov 23 10:12:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:12:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:12:53 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:12:53 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:12:53 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:12:53 garfield automount[2990]: expire_proc: 1 remaining in /net 
Nov 23 10:12:53 garfield automount[1976]: expire_proc: exp_proc=2990
Nov 23 10:12:53 garfield automount[1976]: handle_child: got pid 2990, sig 0 (0), stat 1 
Nov 23 10:12:53 garfield automount[1976]: sigchld: exp 2990 finished, switching from 2 to 1
Nov 23 10:12:53 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:12:53 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:13:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:13:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:13:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:13:07 garfield automount[1974]: expire_proc: exp_proc=2991
Nov 23 10:13:07 garfield automount[2991]: expire_proc: 15 remaining in /smb 
Nov 23 10:13:07 garfield automount[1974]: handle_child: got pid 2991, sig 0 (0), stat 1 
Nov 23 10:13:07 garfield automount[1974]: sigchld: exp 2991 finished, switching from 2 to 1
Nov 23 10:13:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:13:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:13:08 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:13:08 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:13:08 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:13:08 garfield automount[2992]: expire_proc: 1 remaining in /net 
Nov 23 10:13:08 garfield automount[1976]: expire_proc: exp_proc=2992
Nov 23 10:13:08 garfield automount[1976]: handle_child: got pid 2992, sig 0 (0), stat 1 
Nov 23 10:13:08 garfield automount[1976]: sigchld: exp 2992 finished, switching from 2 to 1
Nov 23 10:13:08 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:13:08 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:13:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:13:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:13:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:13:22 garfield automount[1974]: expire_proc: exp_proc=2998
Nov 23 10:13:22 garfield automount[2998]: expire_proc: 15 remaining in /smb 
Nov 23 10:13:22 garfield automount[1974]: handle_child: got pid 2998, sig 0 (0), stat 1 
Nov 23 10:13:22 garfield automount[1974]: sigchld: exp 2998 finished, switching from 2 to 1
Nov 23 10:13:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:13:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:13:24 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:13:24 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:13:24 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:13:24 garfield automount[2999]: expire_proc: 1 remaining in /net 
Nov 23 10:13:24 garfield automount[1976]: expire_proc: exp_proc=2999
Nov 23 10:13:24 garfield automount[1976]: handle_child: got pid 2999, sig 0 (0), stat 1 
Nov 23 10:13:24 garfield automount[1976]: sigchld: exp 2999 finished, switching from 2 to 1
Nov 23 10:13:24 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:13:24 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:13:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:13:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:13:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:13:37 garfield automount[1974]: expire_proc: exp_proc=3025
Nov 23 10:13:37 garfield automount[3025]: expire_proc: 15 remaining in /smb 
Nov 23 10:13:37 garfield automount[1974]: handle_child: got pid 3025, sig 0 (0), stat 1 
Nov 23 10:13:37 garfield automount[1974]: sigchld: exp 3025 finished, switching from 2 to 1
Nov 23 10:13:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:13:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:13:39 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:13:39 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:13:39 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:13:39 garfield automount[3026]: expire_proc: 1 remaining in /net 
Nov 23 10:13:39 garfield automount[1976]: expire_proc: exp_proc=3026
Nov 23 10:13:39 garfield automount[1976]: handle_child: got pid 3026, sig 0 (0), stat 1 
Nov 23 10:13:39 garfield automount[1976]: sigchld: exp 3026 finished, switching from 2 to 1
Nov 23 10:13:39 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:13:39 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:13:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:13:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:13:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:13:52 garfield automount[1974]: expire_proc: exp_proc=3027
Nov 23 10:13:52 garfield automount[3027]: expire_proc: 15 remaining in /smb 
Nov 23 10:13:52 garfield automount[1974]: handle_child: got pid 3027, sig 0 (0), stat 1 
Nov 23 10:13:52 garfield automount[1974]: sigchld: exp 3027 finished, switching from 2 to 1
Nov 23 10:13:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:13:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:13:54 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:13:54 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:13:54 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:13:54 garfield automount[3028]: expire_proc: 1 remaining in /net 
Nov 23 10:13:54 garfield automount[1976]: expire_proc: exp_proc=3028
Nov 23 10:13:54 garfield automount[1976]: handle_child: got pid 3028, sig 0 (0), stat 1 
Nov 23 10:13:54 garfield automount[1976]: sigchld: exp 3028 finished, switching from 2 to 1
Nov 23 10:13:54 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:13:54 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:14:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:14:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:14:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:14:07 garfield automount[1974]: expire_proc: exp_proc=3029
Nov 23 10:14:07 garfield automount[3029]: expire_proc: 15 remaining in /smb 
Nov 23 10:14:07 garfield automount[1974]: handle_child: got pid 3029, sig 0 (0), stat 1 
Nov 23 10:14:07 garfield automount[1974]: sigchld: exp 3029 finished, switching from 2 to 1
Nov 23 10:14:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:14:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:14:09 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:14:09 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:14:09 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:14:09 garfield automount[3030]: expire_proc: 1 remaining in /net 
Nov 23 10:14:09 garfield automount[1976]: expire_proc: exp_proc=3030
Nov 23 10:14:09 garfield automount[1976]: handle_child: got pid 3030, sig 0 (0), stat 1 
Nov 23 10:14:09 garfield automount[1976]: sigchld: exp 3030 finished, switching from 2 to 1
Nov 23 10:14:09 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:14:09 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:14:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:14:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:14:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:14:22 garfield automount[1974]: expire_proc: exp_proc=3031
Nov 23 10:14:22 garfield automount[3031]: expire_proc: 15 remaining in /smb 
Nov 23 10:14:22 garfield automount[1974]: handle_child: got pid 3031, sig 0 (0), stat 1 
Nov 23 10:14:22 garfield automount[1974]: sigchld: exp 3031 finished, switching from 2 to 1
Nov 23 10:14:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:14:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:14:24 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:14:24 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:14:24 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:14:24 garfield automount[3032]: expire_proc: 1 remaining in /net 
Nov 23 10:14:24 garfield automount[1976]: expire_proc: exp_proc=3032
Nov 23 10:14:24 garfield automount[1976]: handle_child: got pid 3032, sig 0 (0), stat 1 
Nov 23 10:14:24 garfield automount[1976]: sigchld: exp 3032 finished, switching from 2 to 1
Nov 23 10:14:24 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:14:24 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:14:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:14:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:14:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:14:37 garfield automount[1974]: expire_proc: exp_proc=3039
Nov 23 10:14:37 garfield automount[3039]: expire_proc: 15 remaining in /smb 
Nov 23 10:14:37 garfield automount[1974]: handle_child: got pid 3039, sig 0 (0), stat 1 
Nov 23 10:14:37 garfield automount[1974]: sigchld: exp 3039 finished, switching from 2 to 1
Nov 23 10:14:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:14:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:14:39 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:14:39 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:14:39 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:14:39 garfield automount[3040]: expire_proc: 1 remaining in /net 
Nov 23 10:14:39 garfield automount[1976]: expire_proc: exp_proc=3040
Nov 23 10:14:39 garfield automount[1976]: handle_child: got pid 3040, sig 0 (0), stat 1 
Nov 23 10:14:39 garfield automount[1976]: sigchld: exp 3040 finished, switching from 2 to 1
Nov 23 10:14:39 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:14:39 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:14:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:14:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:14:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:14:52 garfield automount[1974]: expire_proc: exp_proc=3041
Nov 23 10:14:52 garfield automount[3041]: expire_proc: 15 remaining in /smb 
Nov 23 10:14:52 garfield automount[1974]: handle_child: got pid 3041, sig 0 (0), stat 1 
Nov 23 10:14:52 garfield automount[1974]: sigchld: exp 3041 finished, switching from 2 to 1
Nov 23 10:14:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:14:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:14:54 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:14:54 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:14:54 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:14:54 garfield automount[3042]: expire_proc: 1 remaining in /net 
Nov 23 10:14:54 garfield automount[1976]: expire_proc: exp_proc=3042
Nov 23 10:14:54 garfield automount[1976]: handle_child: got pid 3042, sig 0 (0), stat 1 
Nov 23 10:14:54 garfield automount[1976]: sigchld: exp 3042 finished, switching from 2 to 1
Nov 23 10:14:54 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:14:54 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:15:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:15:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:15:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:15:07 garfield automount[1974]: expire_proc: exp_proc=3043
Nov 23 10:15:07 garfield automount[3043]: expire_proc: 15 remaining in /smb 
Nov 23 10:15:07 garfield automount[1974]: handle_child: got pid 3043, sig 0 (0), stat 1 
Nov 23 10:15:07 garfield automount[1974]: sigchld: exp 3043 finished, switching from 2 to 1
Nov 23 10:15:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:15:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:15:09 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:15:09 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:15:09 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:15:09 garfield automount[1976]: expire_proc: exp_proc=3044
Nov 23 10:15:09 garfield automount[3044]: expire_proc: 1 remaining in /net 
Nov 23 10:15:09 garfield automount[1976]: handle_child: got pid 3044, sig 0 (0), stat 1 
Nov 23 10:15:09 garfield automount[1976]: sigchld: exp 3044 finished, switching from 2 to 1
Nov 23 10:15:09 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:15:09 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:15:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:15:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:15:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:15:22 garfield automount[1974]: expire_proc: exp_proc=3046
Nov 23 10:15:22 garfield automount[3046]: expire_proc: 15 remaining in /smb 
Nov 23 10:15:22 garfield automount[1974]: handle_child: got pid 3046, sig 0 (0), stat 1 
Nov 23 10:15:22 garfield automount[1974]: sigchld: exp 3046 finished, switching from 2 to 1
Nov 23 10:15:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:15:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:15:24 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:15:24 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:15:24 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:15:24 garfield automount[3047]: expire_proc: 1 remaining in /net 
Nov 23 10:15:24 garfield automount[1976]: expire_proc: exp_proc=3047
Nov 23 10:15:24 garfield automount[1976]: handle_child: got pid 3047, sig 0 (0), stat 1 
Nov 23 10:15:24 garfield automount[1976]: sigchld: exp 3047 finished, switching from 2 to 1
Nov 23 10:15:24 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:15:24 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:15:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:15:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:15:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:15:37 garfield automount[1974]: expire_proc: exp_proc=3048
Nov 23 10:15:37 garfield automount[3048]: expire_proc: 15 remaining in /smb 
Nov 23 10:15:37 garfield automount[1974]: handle_child: got pid 3048, sig 0 (0), stat 1 
Nov 23 10:15:37 garfield automount[1974]: sigchld: exp 3048 finished, switching from 2 to 1
Nov 23 10:15:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:15:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:15:39 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:15:39 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:15:39 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:15:39 garfield automount[3049]: expire_proc: 1 remaining in /net 
Nov 23 10:15:39 garfield automount[1976]: expire_proc: exp_proc=3049
Nov 23 10:15:39 garfield automount[1976]: handle_child: got pid 3049, sig 0 (0), stat 1 
Nov 23 10:15:39 garfield automount[1976]: sigchld: exp 3049 finished, switching from 2 to 1
Nov 23 10:15:39 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:15:39 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:15:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:15:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:15:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:15:52 garfield automount[1974]: expire_proc: exp_proc=3050
Nov 23 10:15:52 garfield automount[3050]: expire_proc: 15 remaining in /smb 
Nov 23 10:15:52 garfield automount[1974]: handle_child: got pid 3050, sig 0 (0), stat 1 
Nov 23 10:15:52 garfield automount[1974]: sigchld: exp 3050 finished, switching from 2 to 1
Nov 23 10:15:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:15:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:15:54 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:15:54 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:15:54 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:15:54 garfield automount[3051]: expire_proc: 1 remaining in /net 
Nov 23 10:15:54 garfield automount[1976]: expire_proc: exp_proc=3051
Nov 23 10:15:54 garfield automount[1976]: handle_child: got pid 3051, sig 0 (0), stat 1 
Nov 23 10:15:54 garfield automount[1976]: sigchld: exp 3051 finished, switching from 2 to 1
Nov 23 10:15:54 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:15:54 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:16:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:16:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:16:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:16:07 garfield automount[1974]: expire_proc: exp_proc=3052
Nov 23 10:16:07 garfield automount[3052]: expire_proc: 15 remaining in /smb 
Nov 23 10:16:07 garfield automount[1974]: handle_child: got pid 3052, sig 0 (0), stat 1 
Nov 23 10:16:07 garfield automount[1974]: sigchld: exp 3052 finished, switching from 2 to 1
Nov 23 10:16:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:16:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:16:09 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:16:09 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:16:09 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:16:09 garfield automount[3053]: expire_proc: 1 remaining in /net 
Nov 23 10:16:09 garfield automount[1976]: expire_proc: exp_proc=3053
Nov 23 10:16:09 garfield automount[1976]: handle_child: got pid 3053, sig 0 (0), stat 1 
Nov 23 10:16:09 garfield automount[1976]: sigchld: exp 3053 finished, switching from 2 to 1
Nov 23 10:16:09 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:16:09 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:16:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:16:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:16:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:16:22 garfield automount[1974]: expire_proc: exp_proc=3054
Nov 23 10:16:22 garfield automount[3054]: expire_proc: 15 remaining in /smb 
Nov 23 10:16:22 garfield automount[1974]: handle_child: got pid 3054, sig 0 (0), stat 1 
Nov 23 10:16:22 garfield automount[1974]: sigchld: exp 3054 finished, switching from 2 to 1
Nov 23 10:16:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:16:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:16:24 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:16:24 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:16:24 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:16:24 garfield automount[3055]: expire_proc: 1 remaining in /net 
Nov 23 10:16:24 garfield automount[1976]: expire_proc: exp_proc=3055
Nov 23 10:16:24 garfield automount[1976]: handle_child: got pid 3055, sig 0 (0), stat 1 
Nov 23 10:16:24 garfield automount[1976]: sigchld: exp 3055 finished, switching from 2 to 1
Nov 23 10:16:24 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:16:24 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:16:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:16:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:16:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:16:37 garfield automount[1974]: expire_proc: exp_proc=3058
Nov 23 10:16:37 garfield automount[3058]: expire_proc: 15 remaining in /smb 
Nov 23 10:16:37 garfield automount[1974]: handle_child: got pid 3058, sig 0 (0), stat 1 
Nov 23 10:16:37 garfield automount[1974]: sigchld: exp 3058 finished, switching from 2 to 1
Nov 23 10:16:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:16:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:16:39 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:16:39 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:16:39 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:16:39 garfield automount[3061]: expire_proc: 1 remaining in /net 
Nov 23 10:16:39 garfield automount[1976]: expire_proc: exp_proc=3061
Nov 23 10:16:39 garfield automount[1976]: handle_child: got pid 3061, sig 0 (0), stat 1 
Nov 23 10:16:39 garfield automount[1976]: sigchld: exp 3061 finished, switching from 2 to 1
Nov 23 10:16:39 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:16:39 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:16:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:16:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:16:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:16:52 garfield automount[1974]: expire_proc: exp_proc=3062
Nov 23 10:16:52 garfield automount[3062]: expire_proc: 15 remaining in /smb 
Nov 23 10:16:52 garfield automount[1974]: handle_child: got pid 3062, sig 0 (0), stat 1 
Nov 23 10:16:52 garfield automount[1974]: sigchld: exp 3062 finished, switching from 2 to 1
Nov 23 10:16:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:16:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:16:54 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:16:54 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:16:54 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:16:54 garfield automount[3063]: expire_proc: 1 remaining in /net 
Nov 23 10:16:54 garfield automount[1976]: expire_proc: exp_proc=3063
Nov 23 10:16:54 garfield automount[1976]: handle_child: got pid 3063, sig 0 (0), stat 1 
Nov 23 10:16:54 garfield automount[1976]: sigchld: exp 3063 finished, switching from 2 to 1
Nov 23 10:16:54 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:16:54 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:17:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:17:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:17:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:17:07 garfield automount[1974]: expire_proc: exp_proc=3064
Nov 23 10:17:07 garfield automount[3064]: expire_proc: 15 remaining in /smb 
Nov 23 10:17:07 garfield automount[1974]: handle_child: got pid 3064, sig 0 (0), stat 1 
Nov 23 10:17:07 garfield automount[1974]: sigchld: exp 3064 finished, switching from 2 to 1
Nov 23 10:17:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:17:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:17:09 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:17:09 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:17:09 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:17:09 garfield automount[3065]: expire_proc: 1 remaining in /net 
Nov 23 10:17:09 garfield automount[1976]: expire_proc: exp_proc=3065
Nov 23 10:17:09 garfield automount[1976]: handle_child: got pid 3065, sig 0 (0), stat 1 
Nov 23 10:17:09 garfield automount[1976]: sigchld: exp 3065 finished, switching from 2 to 1
Nov 23 10:17:09 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:17:09 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:17:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:17:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:17:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:17:22 garfield automount[1974]: expire_proc: exp_proc=3088
Nov 23 10:17:22 garfield automount[3088]: expire_proc: 15 remaining in /smb 
Nov 23 10:17:22 garfield automount[1974]: handle_child: got pid 3088, sig 0 (0), stat 1 
Nov 23 10:17:22 garfield automount[1974]: sigchld: exp 3088 finished, switching from 2 to 1
Nov 23 10:17:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:17:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:17:24 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:17:24 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:17:24 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:17:24 garfield automount[3089]: expire_proc: 1 remaining in /net 
Nov 23 10:17:24 garfield automount[1976]: expire_proc: exp_proc=3089
Nov 23 10:17:24 garfield automount[1976]: handle_child: got pid 3089, sig 0 (0), stat 1 
Nov 23 10:17:24 garfield automount[1976]: sigchld: exp 3089 finished, switching from 2 to 1
Nov 23 10:17:24 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:17:24 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:17:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:17:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:17:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:17:37 garfield automount[1974]: expire_proc: exp_proc=3090
Nov 23 10:17:37 garfield automount[3090]: expire_proc: 15 remaining in /smb 
Nov 23 10:17:37 garfield automount[1974]: handle_child: got pid 3090, sig 0 (0), stat 1 
Nov 23 10:17:37 garfield automount[1974]: sigchld: exp 3090 finished, switching from 2 to 1
Nov 23 10:17:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:17:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:17:39 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:17:39 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:17:39 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:17:39 garfield automount[3091]: expire_proc: 1 remaining in /net 
Nov 23 10:17:39 garfield automount[1976]: expire_proc: exp_proc=3091
Nov 23 10:17:39 garfield automount[1976]: handle_child: got pid 3091, sig 0 (0), stat 1 
Nov 23 10:17:39 garfield automount[1976]: sigchld: exp 3091 finished, switching from 2 to 1
Nov 23 10:17:39 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:17:39 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:17:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:17:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:17:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:17:52 garfield automount[1974]: expire_proc: exp_proc=3092
Nov 23 10:17:52 garfield automount[3092]: expire_proc: 15 remaining in /smb 
Nov 23 10:17:52 garfield automount[1974]: handle_child: got pid 3092, sig 0 (0), stat 1 
Nov 23 10:17:52 garfield automount[1974]: sigchld: exp 3092 finished, switching from 2 to 1
Nov 23 10:17:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:17:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:17:54 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:17:54 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:17:54 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:17:54 garfield automount[3093]: expire_proc: 1 remaining in /net 
Nov 23 10:17:54 garfield automount[1976]: expire_proc: exp_proc=3093
Nov 23 10:17:54 garfield automount[1976]: handle_child: got pid 3093, sig 0 (0), stat 1 
Nov 23 10:17:54 garfield automount[1976]: sigchld: exp 3093 finished, switching from 2 to 1
Nov 23 10:17:54 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:17:54 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:18:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:18:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:18:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:18:07 garfield automount[1974]: expire_proc: exp_proc=3095
Nov 23 10:18:07 garfield automount[3095]: expire_proc: 15 remaining in /smb 
Nov 23 10:18:07 garfield automount[1974]: handle_child: got pid 3095, sig 0 (0), stat 1 
Nov 23 10:18:07 garfield automount[1974]: sigchld: exp 3095 finished, switching from 2 to 1
Nov 23 10:18:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:18:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:18:09 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:18:09 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:18:09 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:18:09 garfield automount[3099]: expire_proc: 1 remaining in /net 
Nov 23 10:18:09 garfield automount[1976]: expire_proc: exp_proc=3099
Nov 23 10:18:09 garfield automount[1976]: handle_child: got pid 3099, sig 0 (0), stat 1 
Nov 23 10:18:09 garfield automount[1976]: sigchld: exp 3099 finished, switching from 2 to 1
Nov 23 10:18:09 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:18:09 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:18:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:18:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:18:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:18:22 garfield automount[1974]: expire_proc: exp_proc=3100
Nov 23 10:18:22 garfield automount[3100]: expire_proc: 15 remaining in /smb 
Nov 23 10:18:22 garfield automount[1974]: handle_child: got pid 3100, sig 0 (0), stat 1 
Nov 23 10:18:22 garfield automount[1974]: sigchld: exp 3100 finished, switching from 2 to 1
Nov 23 10:18:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:18:22 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:18:24 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:18:24 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:18:24 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:18:24 garfield automount[3101]: expire_proc: 1 remaining in /net 
Nov 23 10:18:24 garfield automount[1976]: expire_proc: exp_proc=3101
Nov 23 10:18:24 garfield automount[1976]: handle_child: got pid 3101, sig 0 (0), stat 1 
Nov 23 10:18:24 garfield automount[1976]: sigchld: exp 3101 finished, switching from 2 to 1
Nov 23 10:18:24 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:18:24 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:18:37 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:18:37 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:18:37 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:18:37 garfield automount[1974]: expire_proc: exp_proc=3102
Nov 23 10:18:37 garfield automount[3102]: expire_proc: 15 remaining in /smb 
Nov 23 10:18:37 garfield automount[1974]: handle_child: got pid 3102, sig 0 (0), stat 1 
Nov 23 10:18:37 garfield automount[1974]: sigchld: exp 3102 finished, switching from 2 to 1
Nov 23 10:18:37 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:18:37 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:18:39 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:18:39 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:18:39 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:18:39 garfield automount[3103]: expire_proc: 1 remaining in /net 
Nov 23 10:18:39 garfield automount[1976]: expire_proc: exp_proc=3103
Nov 23 10:18:39 garfield automount[1976]: handle_child: got pid 3103, sig 0 (0), stat 1 
Nov 23 10:18:39 garfield automount[1976]: sigchld: exp 3103 finished, switching from 2 to 1
Nov 23 10:18:39 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:18:39 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:18:52 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:18:52 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:18:52 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:18:52 garfield automount[1974]: expire_proc: exp_proc=3104
Nov 23 10:18:52 garfield automount[3104]: expire_proc: 15 remaining in /smb 
Nov 23 10:18:52 garfield automount[1974]: handle_child: got pid 3104, sig 0 (0), stat 1 
Nov 23 10:18:52 garfield automount[1974]: sigchld: exp 3104 finished, switching from 2 to 1
Nov 23 10:18:52 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:18:52 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:18:54 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:18:54 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:18:54 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:18:54 garfield automount[3105]: expire_proc: 1 remaining in /net 
Nov 23 10:18:54 garfield automount[1976]: expire_proc: exp_proc=3105
Nov 23 10:18:54 garfield automount[1976]: handle_child: got pid 3105, sig 0 (0), stat 1 
Nov 23 10:18:54 garfield automount[1976]: sigchld: exp 3105 finished, switching from 2 to 1
Nov 23 10:18:54 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:18:54 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:19:07 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:19:07 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:19:07 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:19:07 garfield automount[1974]: expire_proc: exp_proc=3108
Nov 23 10:19:07 garfield automount[3108]: expire_proc: 15 remaining in /smb 
Nov 23 10:19:07 garfield automount[1974]: handle_child: got pid 3108, sig 0 (0), stat 1 
Nov 23 10:19:07 garfield automount[1974]: sigchld: exp 3108 finished, switching from 2 to 1
Nov 23 10:19:07 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:19:07 garfield automount[1974]: st_ready(): state = 2 
Nov 23 10:19:09 garfield automount[1976]: sig 14 switching from 1 to 2
Nov 23 10:19:09 garfield automount[1976]: get_pkt: state 1, next 2
Nov 23 10:19:09 garfield automount[1976]: st_expire(): state = 1 
Nov 23 10:19:09 garfield automount[3109]: expire_proc: 1 remaining in /net 
Nov 23 10:19:09 garfield automount[1976]: expire_proc: exp_proc=3109
Nov 23 10:19:09 garfield automount[1976]: handle_child: got pid 3109, sig 0 (0), stat 1 
Nov 23 10:19:09 garfield automount[1976]: sigchld: exp 3109 finished, switching from 2 to 1
Nov 23 10:19:09 garfield automount[1976]: get_pkt: state 2, next 1
Nov 23 10:19:09 garfield automount[1976]: st_ready(): state = 2 
Nov 23 10:19:22 garfield automount[1974]: sig 14 switching from 1 to 2
Nov 23 10:19:22 garfield automount[1974]: get_pkt: state 1, next 2
Nov 23 10:19:22 garfield automount[1974]: st_expire(): state = 1 
Nov 23 10:19:22 garfield automount[1974]: expire_proc: exp_proc=3113
Nov 23 10:19:22 garfield automount[3113]: expire_proc: 15 remaining in /smb 
Nov 23 10:19:22 garfield automount[1974]: handle_child: got pid 3113, sig 0 (0), stat 1 
Nov 23 10:19:22 garfield automount[1974]: sigchld: exp 3113 finished, switching from 2 to 1
Nov 23 10:19:22 garfield automount[1974]: get_pkt: state 2, next 1
Nov 23 10:19:22 garfield automount[1974]: st_ready(): state = 2 

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

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

Re: automount never umount

[Ian Kent]

On Wed, 23 Nov 2005, Farkas Levente wrote:

> Jeff Moyer wrote:
> > lfarkas> i'll happy to test it.
> > 
> > Try the kernel rpm located here:
> > 
> > 	http://people.redhat.com/jmoyer/farkas/kernel-2.6.14-1.1641_FC4.jmoyertest.1.i686.rpm
> > 
> > It has the potential to generate a good bit of output.  I've attached the
> > patch that is incorporated there.  You'll want to post the output of dmesg
> > to this list when you get it.
> 
> output of dmesg or /var/log/daemon? there is nothing in dmesg.
> i'm running this kernel currently and mount nfs and smbfs servers.
> ---------------------------
> root      1974  0.0  0.0   1788   736 ?        Ss   10:05   0:00
> /usr/sbin/automount --timeout=60 --debug /smb program /etc/auto.smb
> root      1976  0.0  0.0   1788   736 ?        Ss   10:05   0:00
> /usr/sbin/automount --timeout=60 --debug /net program /etc/auto.net
> ---------------------------
> how long should i wait? as the timeout is 1 minute, they should have to
> be umounted, but not. here is the relevant part of daemon log which
> don't tell me too much:-(

You've waited long enough. Your timeout was 60 seconds.

This is really strange. We didn't catch any activity from the patch so I 
don't know why it isn't expiring. Come to think of it we we should have 
at least got some kernel messages?

What version was the kernel you originally saw this on?
Jeff, I'm wondering if this is a regression from the latest patch.
Was that in the above kernel?

Farkas, if your willing the next step in this process is likely to 
generate even more output but hopefully will give us more info.

Ian

Re: automount never umount

[Farkas Levente]

Ian Kent wrote:
> On Wed, 23 Nov 2005, Farkas Levente wrote:
>>Jeff Moyer wrote:
>>output of dmesg or /var/log/daemon? there is nothing in dmesg.
>>i'm running this kernel currently and mount nfs and smbfs servers.
>>---------------------------
>>root      1974  0.0  0.0   1788   736 ?        Ss   10:05   0:00
>>/usr/sbin/automount --timeout=60 --debug /smb program /etc/auto.smb
>>root      1976  0.0  0.0   1788   736 ?        Ss   10:05   0:00
>>/usr/sbin/automount --timeout=60 --debug /net program /etc/auto.net
>>---------------------------
>>how long should i wait? as the timeout is 1 minute, they should have to
>>be umounted, but not. here is the relevant part of daemon log which
>>don't tell me too much:-(
> 
> 
> You've waited long enough. Your timeout was 60 seconds.
> 
> This is really strange. We didn't catch any activity from the patch so I 
> don't know why it isn't expiring. Come to think of it we we should have 
> at least got some kernel messages?
> 
> What version was the kernel you originally saw this on?

# rpm -q kernel
kernel-2.6.14-1.1637_FC4
kernel-2.6.14-1.1641_FC4.jmoyertest.1


> Jeff, I'm wondering if this is a regression from the latest patch.
> Was that in the above kernel?
> 
> Farkas, if your willing the next step in this process is likely to 
> generate even more output but hopefully will give us more info.

what should i do?


-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:

lfarkas> Ian Kent wrote:
>> On Wed, 23 Nov 2005, Farkas Levente wrote:
>>> Jeff Moyer wrote: output of dmesg or /var/log/daemon? there is nothing
>>> in dmesg.  i'm running this kernel currently and mount nfs and smbfs
>>> servers.
>>> ---------------------------
>>> root 1974 0.0 0.0 1788 736 ?  Ss 10:05 0:00 /usr/sbin/automount
>>> --timeout=60 --debug /smb program /etc/auto.smb root 1976 0.0 0.0 1788
>>> 736 ?  Ss 10:05 0:00 /usr/sbin/automount --timeout=60 --debug /net
>>> program /etc/auto.net
>>> ---------------------------
>>> how long should i wait? as the timeout is 1 minute, they should have to
>>> be umounted, but not. here is the relevant part of daemon log which
>>> don't tell me too much:-(
>> 
>> 
>> You've waited long enough. Your timeout was 60 seconds.
>> 
>> This is really strange. We didn't catch any activity from the patch so I
>> don't know why it isn't expiring. Come to think of it we we should have
>> at least got some kernel messages?
>> 
>> What version was the kernel you originally saw this on?

lfarkas> # rpm -q kernel kernel-2.6.14-1.1637_FC4
lfarkas> kernel-2.6.14-1.1641_FC4.jmoyertest.1


>> Jeff, I'm wondering if this is a regression from the latest patch.  Was
>> that in the above kernel?
>> 
>> Farkas, if your willing the next step in this process is likely to
>> generate even more output but hopefully will give us more info.

lfarkas> what should i do?

Well, I shouldn't be rolling kernels so late in the day.  I didn't even
apply the patch!  I'll roll another for you to try.  ;)

-Jeff

Re: automount never umount

[Ian Kent]

On Wed, 23 Nov 2005, Jeff Moyer wrote:

> ==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:
> 
> lfarkas> Ian Kent wrote:
> >> On Wed, 23 Nov 2005, Farkas Levente wrote:
> >>> Jeff Moyer wrote: output of dmesg or /var/log/daemon? there is nothing
> >>> in dmesg.  i'm running this kernel currently and mount nfs and smbfs
> >>> servers.
> >>> ---------------------------
> >>> root 1974 0.0 0.0 1788 736 ?  Ss 10:05 0:00 /usr/sbin/automount
> >>> --timeout=60 --debug /smb program /etc/auto.smb root 1976 0.0 0.0 1788
> >>> 736 ?  Ss 10:05 0:00 /usr/sbin/automount --timeout=60 --debug /net
> >>> program /etc/auto.net
> >>> ---------------------------
> >>> how long should i wait? as the timeout is 1 minute, they should have to
> >>> be umounted, but not. here is the relevant part of daemon log which
> >>> don't tell me too much:-(
> >> 
> >> 
> >> You've waited long enough. Your timeout was 60 seconds.
> >> 
> >> This is really strange. We didn't catch any activity from the patch so I
> >> don't know why it isn't expiring. Come to think of it we we should have
> >> at least got some kernel messages?
> >> 
> >> What version was the kernel you originally saw this on?
> 
> lfarkas> # rpm -q kernel kernel-2.6.14-1.1637_FC4
> lfarkas> kernel-2.6.14-1.1641_FC4.jmoyertest.1
> 
> 
> >> Jeff, I'm wondering if this is a regression from the latest patch.  Was
> >> that in the above kernel?
> >> 
> >> Farkas, if your willing the next step in this process is likely to
> >> generate even more output but hopefully will give us more info.
> 
> lfarkas> what should i do?
> 
> Well, I shouldn't be rolling kernels so late in the day.  I didn't even
> apply the patch!  I'll roll another for you to try.  ;)

The interesting thing about the log is that there was no timeout and 
instant remount activity which is characteristic of the GUI scaning 
problem. AFAICT the reason that this happens is because the GUI 
scaning springs into life when it sees the umount activity.

Ian

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Ian Kent <raven@themaw.net> adds:

raven> On Wed, 23 Nov 2005, Jeff Moyer wrote:
>> ==> Regarding Re: [autofs] automount never umount; Farkas Levente
>> <lfarkas@bppiac.hu> adds:
>> 
lfarkas> Ian Kent wrote:
>> >> On Wed, 23 Nov 2005, Farkas Levente wrote: >>> Jeff Moyer wrote:
>> output of dmesg or /var/log/daemon? there is nothing >>> in dmesg.  i'm
>> running this kernel currently and mount nfs and smbfs >>> servers.
>> >>> ---------------------------
>> >>> root 1974 0.0 0.0 1788 736 ?  Ss 10:05 0:00 /usr/sbin/automount >>>
>> --timeout=60 --debug /smb program /etc/auto.smb root 1976 0.0 0.0 1788
>> >>> 736 ?  Ss 10:05 0:00 /usr/sbin/automount --timeout=60 --debug /net
>> >>> program /etc/auto.net
>> >>> ---------------------------
>> >>> how long should i wait? as the timeout is 1 minute, they should have
>> to >>> be umounted, but not. here is the relevant part of daemon log
>> which >>> don't tell me too much:-(
>> >> 
>> >> 
>> >> You've waited long enough. Your timeout was 60 seconds.
>> >> 
>> >> This is really strange. We didn't catch any activity from the patch
>> so I >> don't know why it isn't expiring. Come to think of it we we
>> should have >> at least got some kernel messages?
>> >> 
>> >> What version was the kernel you originally saw this on?
>> 
lfarkas> # rpm -q kernel kernel-2.6.14-1.1637_FC4
lfarkas> kernel-2.6.14-1.1641_FC4.jmoyertest.1
>> 
>> 
>> >> Jeff, I'm wondering if this is a regression from the latest patch.
>> Was >> that in the above kernel?
>> >> 
>> >> Farkas, if your willing the next step in this process is likely to >>
>> generate even more output but hopefully will give us more info.
>> 
lfarkas> what should i do?
>> Well, I shouldn't be rolling kernels so late in the day.  I didn't even
>> apply the patch!  I'll roll another for you to try.  ;)

raven> The interesting thing about the log is that there was no timeout and
raven> instant remount activity which is characteristic of the GUI scaning
raven> problem. AFAICT the reason that this happens is because the GUI
raven> scaning springs into life when it sees the umount activity.

Good point.  Can we get the output of lsof and fuser -v?

-Jeff

Re: automount never umount

[Farkas Levente]

Jeff Moyer wrote:
> ==> Regarding Re: [autofs] automount never umount; Ian Kent <raven@themaw.net> adds:
> 
> raven> On Wed, 23 Nov 2005, Jeff Moyer wrote:
> 
>>>==> Regarding Re: [autofs] automount never umount; Farkas Levente
>>><lfarkas@bppiac.hu> adds:
>>>
> 
> lfarkas> Ian Kent wrote:
> 
>>>>>On Wed, 23 Nov 2005, Farkas Levente wrote: >>> Jeff Moyer wrote:
>>>
>>>output of dmesg or /var/log/daemon? there is nothing >>> in dmesg.  i'm
>>>running this kernel currently and mount nfs and smbfs >>> servers.
>>>
>>>>>>---------------------------
>>>>>>root 1974 0.0 0.0 1788 736 ?  Ss 10:05 0:00 /usr/sbin/automount >>>
>>>
>>>--timeout=60 --debug /smb program /etc/auto.smb root 1976 0.0 0.0 1788
>>>
>>>>>>736 ?  Ss 10:05 0:00 /usr/sbin/automount --timeout=60 --debug /net
>>>>>>program /etc/auto.net
>>>>>>---------------------------
>>>>>>how long should i wait? as the timeout is 1 minute, they should have
>>>
>>>to >>> be umounted, but not. here is the relevant part of daemon log
>>>which >>> don't tell me too much:-(
>>>
>>>>>
>>>>>You've waited long enough. Your timeout was 60 seconds.
>>>>>
>>>>>This is really strange. We didn't catch any activity from the patch
>>>
>>>so I >> don't know why it isn't expiring. Come to think of it we we
>>>should have >> at least got some kernel messages?
>>>
>>>>>What version was the kernel you originally saw this on?
>>>
> lfarkas> # rpm -q kernel kernel-2.6.14-1.1637_FC4
> lfarkas> kernel-2.6.14-1.1641_FC4.jmoyertest.1
> 
>>>
>>>>>Jeff, I'm wondering if this is a regression from the latest patch.
>>>
>>>Was >> that in the above kernel?
>>>
>>>>>Farkas, if your willing the next step in this process is likely to >>
>>>
>>>generate even more output but hopefully will give us more info.
>>>
> 
> lfarkas> what should i do?
> 
>>>Well, I shouldn't be rolling kernels so late in the day.  I didn't even
>>>apply the patch!  I'll roll another for you to try.  ;)
> 
> 
> raven> The interesting thing about the log is that there was no timeout and
> raven> instant remount activity which is characteristic of the GUI scaning
> raven> problem. AFAICT the reason that this happens is because the GUI
> raven> scaning springs into life when it sees the umount activity.
> 
> Good point.  Can we get the output of lsof and fuser -v?

a full lsof ? fuser -v for what?


-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:

lfarkas> Jeff Moyer wrote:
>> ==> Regarding Re: [autofs] automount never umount; Ian Kent
>> <raven@themaw.net> adds:
>> 
raven> On Wed, 23 Nov 2005, Jeff Moyer wrote:
>>
>>>> ==> Regarding Re: [autofs] automount never umount; Farkas Levente
>>>> <lfarkas@bppiac.hu> adds:
>>>> 
>>
lfarkas> Ian Kent wrote:
>>
>>>>>> On Wed, 23 Nov 2005, Farkas Levente wrote: >>> Jeff Moyer wrote:
>>>> output of dmesg or /var/log/daemon? there is nothing >>> in dmesg.
>>>> i'm running this kernel currently and mount nfs and smbfs >>> servers.
>>>> 
>>>>>>> --------------------------- root 1974 0.0 0.0 1788 736 ?  Ss 10:05
>>>>>>> 0:00 /usr/sbin/automount >>>
>>>> --timeout=60 --debug /smb program /etc/auto.smb root 1976 0.0 0.0 1788
>>>> 
>>>>>>> 736 ?  Ss 10:05 0:00 /usr/sbin/automount --timeout=60 --debug /net
>>>>>>> program /etc/auto.net
>>>>>>> ---------------------------
>>>>>>> how long should i wait? as the timeout is 1 minute, they should
>>>>>>> have
>>>> to >>> be umounted, but not. here is the relevant part of daemon log
>>>> which >>> don't tell me too much:-(
>>>> 
>>>>>> You've waited long enough. Your timeout was 60 seconds.
>>>>>> 
>>>>>> This is really strange. We didn't catch any activity from the patch
>>>> so I >> don't know why it isn't expiring. Come to think of it we we
>>>> should have >> at least got some kernel messages?
>>>> 
>>>>>> What version was the kernel you originally saw this on?
>>>>
lfarkas> # rpm -q kernel kernel-2.6.14-1.1637_FC4
lfarkas> kernel-2.6.14-1.1641_FC4.jmoyertest.1
>>
>>>>
>>>>>> Jeff, I'm wondering if this is a regression from the latest patch.
>>>> Was >> that in the above kernel?
>>>> 
>>>>>> Farkas, if your willing the next step in this process is likely to
>>>>>> >>
>>>> generate even more output but hopefully will give us more info.
>>>> 
>>
lfarkas> what should i do?
>>
>>>> Well, I shouldn't be rolling kernels so late in the day.  I didn't
>>>> even apply the patch!  I'll roll another for you to try.  ;)
>>
raven> The interesting thing about the log is that there was no timeout and
raven> instant remount activity which is characteristic of the GUI scaning
raven> problem. AFAICT the reason that this happens is because the GUI
raven> scaning springs into life when it sees the umount activity.
>> Good point.  Can we get the output of lsof and fuser -v?

lfarkas> a full lsof ? fuser -v for what?

For the mount points in question.  I guess something like:

fuser -v -m <automountpoint>

lsof +D <automountpoint>

-Jeff

Re: automount never umount

[Farkas Levente]

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

Jeff Moyer wrote:
> lfarkas> a full lsof ? fuser -v for what?
> 
> For the mount points in question.  I guess something like:
> 
> fuser -v -m <automountpoint>
> 
> lsof +D <automountpoint>

ok now i use only nfs and no smbfs, uprgade to
kernel-2.6.14-1.1641_FC4.jmoyertest.2 but it doesn't show me any
difference. so here is the current daemon log and that's all:-(
-------------------------------
[root@garfield ~]# fuser -v -m /net/

                     USER        PID ACCESS COMMAND
/net/                root       1919 f....  automount
[root@garfield ~]# lsof +D /net/
COMMAND    PID USER   FD   TYPE DEVICE SIZE NODE NAME
automount 1919 root    5r   DIR   0,20    0 5471 /net/
-------------------------------
new tips?

ps. the main problem when i wake up you stiull sleep, and when you
answer i almost go home...


-- 
  Levente                               "Si vis pacem para bellum!"

[-- Attachment #2: daemon --]
[-- Type: text/plain, Size: 43781 bytes --]

Nov 24 10:52:02 garfield rpc.statd[1740]: Version 1.0.7 Starting
Nov 24 10:52:05 garfield automount[1917]: starting automounter version 4.1.4-5, path = /smb, maptype = program, mapname = /etc/auto.smb
Nov 24 10:52:05 garfield automount[1919]: starting automounter version 4.1.4-5, path = /net, maptype = program, mapname = /etc/auto.net
Nov 24 10:52:05 garfield automount[1917]: mount(bind): bind_works = 1 
Nov 24 10:52:05 garfield automount[1919]: mount(bind): bind_works = 1 
Nov 24 10:52:05 garfield smartd[1945]: smartd version 5.33 [i386-redhat-linux-gnu] Copyright (C) 2002-4 Bruce Allen 
Nov 24 10:52:05 garfield automount[1917]: using kernel protocol version 4.07
Nov 24 10:52:05 garfield automount[1919]: using kernel protocol version 4.07
Nov 24 10:52:05 garfield smartd[1945]: Home page is http://smartmontools.sourceforge.net/  
Nov 24 10:52:05 garfield automount[1917]: using timeout 60 seconds; freq 15 secs
Nov 24 10:52:05 garfield automount[1919]: using timeout 60 seconds; freq 15 secs
Nov 24 10:52:05 garfield smartd[1945]: Opened configuration file /etc/smartd.conf 
Nov 24 10:52:06 garfield smartd[1945]: Configuration file /etc/smartd.conf parsed. 
Nov 24 10:52:06 garfield smartd[1945]: Device: /dev/hda, opened 
Nov 24 10:52:06 garfield smartd[1945]: Device: /dev/hda, found in smartd database. 
Nov 24 10:52:06 garfield smartd[1945]: Device: /dev/hda, is SMART capable. Adding to "monitor" list. 
Nov 24 10:52:06 garfield smartd[1945]: Monitoring 1 ATA and 0 SCSI devices 
Nov 24 10:52:06 garfield smartd[1951]: smartd has fork()ed into background mode. New PID=1951. 
Nov 24 10:52:07 garfield ntpdate[1980]: step time server 192.168.0.2 offset -0.470773 sec
Nov 24 10:52:07 garfield ntpd[1986]: ntpd 4.2.0a@1.1190-r Thu Apr 14 07:47:25 EDT 2005 (1)
Nov 24 10:52:07 garfield ntpd[1986]: precision = 1.000 usec
Nov 24 10:52:07 garfield ntpd[1986]: Listening on interface wildcard, 0.0.0.0#123
Nov 24 10:52:08 garfield ntpd[1986]: Listening on interface lo, 127.0.0.1#123
Nov 24 10:52:08 garfield ntpd[1986]: Listening on interface eth0, 192.168.0.50#123
Nov 24 10:52:08 garfield ntpd[1986]: kernel time sync status 0040
Nov 24 10:52:08 garfield ntpd[1986]: frequency initialized -12.994 PPM from /var/lib/ntp/drift
Nov 24 10:52:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:52:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:52:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:52:32 garfield automount[1917]: expire_proc: exp_proc=2536
Nov 24 10:52:32 garfield automount[1917]: handle_child: got pid 2536, sig 0 (0), stat 0 
Nov 24 10:52:32 garfield automount[1917]: sigchld: exp 2536 finished, switching from 2 to 1
Nov 24 10:52:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:52:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:52:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:52:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:52:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:52:34 garfield automount[1919]: expire_proc: exp_proc=2537
Nov 24 10:52:34 garfield automount[1919]: handle_child: got pid 2537, sig 0 (0), stat 0 
Nov 24 10:52:34 garfield automount[1919]: sigchld: exp 2537 finished, switching from 2 to 1
Nov 24 10:52:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:52:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:52:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:52:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:52:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:52:47 garfield automount[1917]: expire_proc: exp_proc=2543
Nov 24 10:52:47 garfield automount[1917]: handle_child: got pid 2543, sig 0 (0), stat 0 
Nov 24 10:52:47 garfield automount[1917]: sigchld: exp 2543 finished, switching from 2 to 1
Nov 24 10:52:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:52:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:52:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:52:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:52:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:52:49 garfield automount[1919]: expire_proc: exp_proc=2544
Nov 24 10:52:49 garfield automount[1919]: handle_child: got pid 2544, sig 0 (0), stat 0 
Nov 24 10:52:49 garfield automount[1919]: sigchld: exp 2544 finished, switching from 2 to 1
Nov 24 10:52:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:52:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:53:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:53:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:53:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:53:02 garfield automount[1917]: expire_proc: exp_proc=2545
Nov 24 10:53:02 garfield automount[1917]: handle_child: got pid 2545, sig 0 (0), stat 0 
Nov 24 10:53:02 garfield automount[1917]: sigchld: exp 2545 finished, switching from 2 to 1
Nov 24 10:53:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:53:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:53:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:53:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:53:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:53:04 garfield automount[1919]: expire_proc: exp_proc=2546
Nov 24 10:53:04 garfield automount[1919]: handle_child: got pid 2546, sig 0 (0), stat 0 
Nov 24 10:53:04 garfield automount[1919]: sigchld: exp 2546 finished, switching from 2 to 1
Nov 24 10:53:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:53:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:53:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:53:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:53:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:53:17 garfield automount[1917]: expire_proc: exp_proc=2547
Nov 24 10:53:17 garfield automount[1917]: handle_child: got pid 2547, sig 0 (0), stat 0 
Nov 24 10:53:17 garfield automount[1917]: sigchld: exp 2547 finished, switching from 2 to 1
Nov 24 10:53:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:53:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:53:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:53:19 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:53:19 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:53:19 garfield automount[1919]: expire_proc: exp_proc=2548
Nov 24 10:53:19 garfield automount[1919]: handle_child: got pid 2548, sig 0 (0), stat 0 
Nov 24 10:53:19 garfield automount[1919]: sigchld: exp 2548 finished, switching from 2 to 1
Nov 24 10:53:19 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:53:19 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:53:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:53:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:53:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:53:32 garfield automount[1917]: expire_proc: exp_proc=2549
Nov 24 10:53:32 garfield automount[1917]: handle_child: got pid 2549, sig 0 (0), stat 0 
Nov 24 10:53:32 garfield automount[1917]: sigchld: exp 2549 finished, switching from 2 to 1
Nov 24 10:53:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:53:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:53:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:53:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:53:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:53:34 garfield automount[1919]: expire_proc: exp_proc=2550
Nov 24 10:53:34 garfield automount[1919]: handle_child: got pid 2550, sig 0 (0), stat 0 
Nov 24 10:53:34 garfield automount[1919]: sigchld: exp 2550 finished, switching from 2 to 1
Nov 24 10:53:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:53:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:53:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:53:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:53:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:53:47 garfield automount[1917]: expire_proc: exp_proc=2551
Nov 24 10:53:47 garfield automount[1917]: handle_child: got pid 2551, sig 0 (0), stat 0 
Nov 24 10:53:47 garfield automount[1917]: sigchld: exp 2551 finished, switching from 2 to 1
Nov 24 10:53:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:53:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:53:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:53:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:53:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:53:49 garfield automount[1919]: expire_proc: exp_proc=2552
Nov 24 10:53:49 garfield automount[1919]: handle_child: got pid 2552, sig 0 (0), stat 0 
Nov 24 10:53:49 garfield automount[1919]: sigchld: exp 2552 finished, switching from 2 to 1
Nov 24 10:53:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:53:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:54:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:54:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:54:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:54:02 garfield automount[1917]: expire_proc: exp_proc=2553
Nov 24 10:54:02 garfield automount[1917]: handle_child: got pid 2553, sig 0 (0), stat 0 
Nov 24 10:54:02 garfield automount[1917]: sigchld: exp 2553 finished, switching from 2 to 1
Nov 24 10:54:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:54:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:54:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:54:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:54:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:54:04 garfield automount[1919]: expire_proc: exp_proc=2554
Nov 24 10:54:04 garfield automount[1919]: handle_child: got pid 2554, sig 0 (0), stat 0 
Nov 24 10:54:04 garfield automount[1919]: sigchld: exp 2554 finished, switching from 2 to 1
Nov 24 10:54:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:54:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:54:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:54:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:54:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:54:17 garfield automount[1917]: expire_proc: exp_proc=2555
Nov 24 10:54:17 garfield automount[1917]: handle_child: got pid 2555, sig 0 (0), stat 0 
Nov 24 10:54:17 garfield automount[1917]: sigchld: exp 2555 finished, switching from 2 to 1
Nov 24 10:54:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:54:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:54:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:54:19 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:54:19 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:54:19 garfield automount[1919]: expire_proc: exp_proc=2556
Nov 24 10:54:19 garfield automount[1919]: handle_child: got pid 2556, sig 0 (0), stat 0 
Nov 24 10:54:19 garfield automount[1919]: sigchld: exp 2556 finished, switching from 2 to 1
Nov 24 10:54:19 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:54:19 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:54:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:54:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:54:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:54:32 garfield automount[1917]: expire_proc: exp_proc=2557
Nov 24 10:54:32 garfield automount[1917]: handle_child: got pid 2557, sig 0 (0), stat 0 
Nov 24 10:54:32 garfield automount[1917]: sigchld: exp 2557 finished, switching from 2 to 1
Nov 24 10:54:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:54:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:54:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:54:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:54:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:54:34 garfield automount[1919]: expire_proc: exp_proc=2558
Nov 24 10:54:34 garfield automount[1919]: handle_child: got pid 2558, sig 0 (0), stat 0 
Nov 24 10:54:34 garfield automount[1919]: sigchld: exp 2558 finished, switching from 2 to 1
Nov 24 10:54:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:54:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:54:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:54:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:54:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:54:47 garfield automount[1917]: expire_proc: exp_proc=2559
Nov 24 10:54:47 garfield automount[1917]: handle_child: got pid 2559, sig 0 (0), stat 0 
Nov 24 10:54:47 garfield automount[1917]: sigchld: exp 2559 finished, switching from 2 to 1
Nov 24 10:54:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:54:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:54:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:54:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:54:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:54:49 garfield automount[1919]: expire_proc: exp_proc=2560
Nov 24 10:54:49 garfield automount[1919]: handle_child: got pid 2560, sig 0 (0), stat 0 
Nov 24 10:54:49 garfield automount[1919]: sigchld: exp 2560 finished, switching from 2 to 1
Nov 24 10:54:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:54:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:55:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:55:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:55:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:55:02 garfield automount[1917]: expire_proc: exp_proc=2561
Nov 24 10:55:02 garfield automount[1917]: handle_child: got pid 2561, sig 0 (0), stat 0 
Nov 24 10:55:02 garfield automount[1917]: sigchld: exp 2561 finished, switching from 2 to 1
Nov 24 10:55:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:55:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:55:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:55:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:55:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:55:04 garfield automount[1919]: expire_proc: exp_proc=2562
Nov 24 10:55:04 garfield automount[1919]: handle_child: got pid 2562, sig 0 (0), stat 0 
Nov 24 10:55:04 garfield automount[1919]: sigchld: exp 2562 finished, switching from 2 to 1
Nov 24 10:55:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:55:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:55:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:55:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:55:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:55:17 garfield automount[1917]: expire_proc: exp_proc=2563
Nov 24 10:55:17 garfield automount[1917]: handle_child: got pid 2563, sig 0 (0), stat 0 
Nov 24 10:55:17 garfield automount[1917]: sigchld: exp 2563 finished, switching from 2 to 1
Nov 24 10:55:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:55:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:55:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:55:19 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:55:19 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:55:19 garfield automount[1919]: expire_proc: exp_proc=2564
Nov 24 10:55:19 garfield automount[1919]: handle_child: got pid 2564, sig 0 (0), stat 0 
Nov 24 10:55:19 garfield automount[1919]: sigchld: exp 2564 finished, switching from 2 to 1
Nov 24 10:55:19 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:55:19 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:55:25 garfield ntpd[1986]: synchronized to LOCAL(0), stratum 10
Nov 24 10:55:25 garfield ntpd[1986]: kernel time sync disabled 0041
Nov 24 10:55:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:55:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:55:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:55:32 garfield automount[1917]: expire_proc: exp_proc=2565
Nov 24 10:55:32 garfield automount[1917]: handle_child: got pid 2565, sig 0 (0), stat 0 
Nov 24 10:55:32 garfield automount[1917]: sigchld: exp 2565 finished, switching from 2 to 1
Nov 24 10:55:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:55:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:55:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:55:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:55:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:55:34 garfield automount[1919]: expire_proc: exp_proc=2566
Nov 24 10:55:34 garfield automount[1919]: handle_child: got pid 2566, sig 0 (0), stat 0 
Nov 24 10:55:34 garfield automount[1919]: sigchld: exp 2566 finished, switching from 2 to 1
Nov 24 10:55:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:55:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:55:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:55:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:55:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:55:47 garfield automount[1917]: expire_proc: exp_proc=2567
Nov 24 10:55:47 garfield automount[1917]: handle_child: got pid 2567, sig 0 (0), stat 0 
Nov 24 10:55:47 garfield automount[1917]: sigchld: exp 2567 finished, switching from 2 to 1
Nov 24 10:55:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:55:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:55:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:55:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:55:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:55:49 garfield automount[1919]: expire_proc: exp_proc=2568
Nov 24 10:55:49 garfield automount[1919]: handle_child: got pid 2568, sig 0 (0), stat 0 
Nov 24 10:55:49 garfield automount[1919]: sigchld: exp 2568 finished, switching from 2 to 1
Nov 24 10:55:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:55:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:56:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:56:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:56:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:56:02 garfield automount[1917]: expire_proc: exp_proc=2569
Nov 24 10:56:02 garfield automount[1917]: handle_child: got pid 2569, sig 0 (0), stat 0 
Nov 24 10:56:02 garfield automount[1917]: sigchld: exp 2569 finished, switching from 2 to 1
Nov 24 10:56:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:56:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:56:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:56:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:56:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:56:04 garfield automount[1919]: expire_proc: exp_proc=2570
Nov 24 10:56:04 garfield automount[1919]: handle_child: got pid 2570, sig 0 (0), stat 0 
Nov 24 10:56:04 garfield automount[1919]: sigchld: exp 2570 finished, switching from 2 to 1
Nov 24 10:56:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:56:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:56:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:56:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:56:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:56:17 garfield automount[1917]: expire_proc: exp_proc=2571
Nov 24 10:56:17 garfield automount[1917]: handle_child: got pid 2571, sig 0 (0), stat 0 
Nov 24 10:56:17 garfield automount[1917]: sigchld: exp 2571 finished, switching from 2 to 1
Nov 24 10:56:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:56:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:56:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:56:19 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:56:19 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:56:19 garfield automount[1919]: expire_proc: exp_proc=2572
Nov 24 10:56:19 garfield automount[1919]: handle_child: got pid 2572, sig 0 (0), stat 0 
Nov 24 10:56:19 garfield automount[1919]: sigchld: exp 2572 finished, switching from 2 to 1
Nov 24 10:56:19 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:56:19 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:56:28 garfield ntpd[1986]: synchronized to 192.168.1.3, stratum 3
Nov 24 10:56:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:56:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:56:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:56:32 garfield automount[1917]: expire_proc: exp_proc=2710
Nov 24 10:56:32 garfield automount[1917]: handle_child: got pid 2710, sig 0 (0), stat 0 
Nov 24 10:56:32 garfield automount[1917]: sigchld: exp 2710 finished, switching from 2 to 1
Nov 24 10:56:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:56:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:56:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:56:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:56:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:56:34 garfield automount[1919]: expire_proc: exp_proc=2719
Nov 24 10:56:34 garfield automount[1919]: handle_child: got pid 2719, sig 0 (0), stat 0 
Nov 24 10:56:34 garfield automount[1919]: sigchld: exp 2719 finished, switching from 2 to 1
Nov 24 10:56:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:56:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:56:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:56:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:56:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:56:47 garfield automount[1917]: expire_proc: exp_proc=2765
Nov 24 10:56:47 garfield automount[1917]: handle_child: got pid 2765, sig 0 (0), stat 0 
Nov 24 10:56:47 garfield automount[1917]: sigchld: exp 2765 finished, switching from 2 to 1
Nov 24 10:56:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:56:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:56:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:56:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:56:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:56:49 garfield automount[1919]: expire_proc: exp_proc=2766
Nov 24 10:56:49 garfield automount[1919]: handle_child: got pid 2766, sig 0 (0), stat 0 
Nov 24 10:56:49 garfield automount[1919]: sigchld: exp 2766 finished, switching from 2 to 1
Nov 24 10:56:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:56:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:57:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:57:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:57:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:57:02 garfield automount[1917]: expire_proc: exp_proc=2785
Nov 24 10:57:02 garfield automount[1917]: handle_child: got pid 2785, sig 0 (0), stat 0 
Nov 24 10:57:02 garfield automount[1917]: sigchld: exp 2785 finished, switching from 2 to 1
Nov 24 10:57:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:57:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:57:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:57:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:57:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:57:04 garfield automount[1919]: expire_proc: exp_proc=2793
Nov 24 10:57:04 garfield automount[1919]: handle_child: got pid 2793, sig 0 (0), stat 0 
Nov 24 10:57:04 garfield automount[1919]: sigchld: exp 2793 finished, switching from 2 to 1
Nov 24 10:57:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:57:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:57:10 garfield automount[1919]: handle_packet: type = 0 
Nov 24 10:57:10 garfield automount[1919]: handle_packet_missing: token 1, name mirror 
Nov 24 10:57:10 garfield automount[1919]: attempting to mount entry /net/mirror
Nov 24 10:57:10 garfield automount[2795]: lookup(program): looking up mirror
Nov 24 10:57:10 garfield automount[2795]: lookup(program): mirror -> -fstype=nfs,hard,intr,nodev,nosuid  	/mnt/md2/download mirror:/mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: parse(sun): expanded entry: -fstype=nfs,hard,intr,nodev,nosuid  	/mnt/md2/download mirror:/mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: parse(sun): dequote("fstype=nfs,hard,intr,nodev,nosuid") -> fstype=nfs,hard,intr,nodev,nosuid
Nov 24 10:57:10 garfield automount[2795]: parse(sun): gathered options: fstype=nfs,hard,intr,nodev,nosuid
Nov 24 10:57:10 garfield automount[2795]: parse(sun): dequote("/mnt/md2/download") -> /mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: parse(sun): dequote("mirror:/mnt/md2/download") -> mirror:/mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: parse(sun): multimount: mirror:/mnt/md2/download on /mnt/md2/download with options fstype=nfs,hard,intr,nodev,nosuid
Nov 24 10:57:10 garfield automount[2795]: parse(sun): mounting root /net/mirror, mountpoint mnt/md2/download, what mirror:/mnt/md2/download, fstype nfs, options hard,intr,nodev,nosuid 
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): root=/net/mirror name=mnt/md2/download what=mirror:/mnt/md2/download, fstype=nfs, options=hard,intr,nodev,nosuid
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): nfs options="hard,intr,nodev,nosuid", nosymlink=0, ro=0
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): is_local_mount: mirror
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): winner = mirror local = 0
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): all hosts timed out for 'mirror:/mnt/md2/download', retrying with longer timeout
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): winner = mirror local = 0
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): from mirror:/mnt/md2/download elected mirror:/mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): calling mkdir_path /net/mirror/mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): calling mount -t nfs -s  -o hard,intr,nodev,nosuid mirror:/mnt/md2/download /net/mirror/mnt/md2/download
Nov 24 10:57:10 garfield automount[2795]: mount(nfs): mounted mirror:/mnt/md2/download on /net/mirror/mnt/md2/download
Nov 24 10:57:10 garfield automount[1919]: handle_child: got pid 2795, sig 0 (0), stat 0 
Nov 24 10:57:10 garfield automount[1919]: sig_child: found pending iop pid 2795: signalled 0 (sig 0), exit status 0
Nov 24 10:57:10 garfield automount[1919]: send_ready: token=1 
Nov 24 10:57:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:57:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:57:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:57:17 garfield automount[1917]: expire_proc: exp_proc=2811
Nov 24 10:57:17 garfield automount[1917]: handle_child: got pid 2811, sig 0 (0), stat 0 
Nov 24 10:57:17 garfield automount[1917]: sigchld: exp 2811 finished, switching from 2 to 1
Nov 24 10:57:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:57:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:57:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:57:19 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:57:19 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:57:19 garfield automount[1919]: expire_proc: exp_proc=2812
Nov 24 10:57:19 garfield automount[2812]: expire_proc: 1 remaining in /net 
Nov 24 10:57:19 garfield automount[1919]: handle_child: got pid 2812, sig 0 (0), stat 1 
Nov 24 10:57:19 garfield automount[1919]: sigchld: exp 2812 finished, switching from 2 to 1
Nov 24 10:57:19 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:57:19 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:57:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:57:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:57:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:57:32 garfield automount[1917]: expire_proc: exp_proc=2814
Nov 24 10:57:32 garfield automount[1917]: handle_child: got pid 2814, sig 0 (0), stat 0 
Nov 24 10:57:32 garfield automount[1917]: sigchld: exp 2814 finished, switching from 2 to 1
Nov 24 10:57:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:57:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:57:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:57:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:57:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:57:34 garfield automount[1919]: expire_proc: exp_proc=2816
Nov 24 10:57:34 garfield automount[2816]: expire_proc: 1 remaining in /net 
Nov 24 10:57:34 garfield automount[1919]: handle_child: got pid 2816, sig 0 (0), stat 1 
Nov 24 10:57:34 garfield automount[1919]: sigchld: exp 2816 finished, switching from 2 to 1
Nov 24 10:57:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:57:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:57:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:57:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:57:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:57:47 garfield automount[1917]: expire_proc: exp_proc=2846
Nov 24 10:57:47 garfield automount[1917]: handle_child: got pid 2846, sig 0 (0), stat 0 
Nov 24 10:57:47 garfield automount[1917]: sigchld: exp 2846 finished, switching from 2 to 1
Nov 24 10:57:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:57:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:57:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:57:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:57:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:57:49 garfield automount[1919]: expire_proc: exp_proc=2849
Nov 24 10:57:49 garfield automount[2849]: expire_proc: 1 remaining in /net 
Nov 24 10:57:49 garfield automount[1919]: handle_child: got pid 2849, sig 0 (0), stat 1 
Nov 24 10:57:49 garfield automount[1919]: sigchld: exp 2849 finished, switching from 2 to 1
Nov 24 10:57:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:57:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:58:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:58:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:58:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:58:02 garfield automount[1917]: expire_proc: exp_proc=2856
Nov 24 10:58:02 garfield automount[1917]: handle_child: got pid 2856, sig 0 (0), stat 0 
Nov 24 10:58:02 garfield automount[1917]: sigchld: exp 2856 finished, switching from 2 to 1
Nov 24 10:58:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:58:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:58:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:58:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:58:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:58:04 garfield automount[1919]: expire_proc: exp_proc=2857
Nov 24 10:58:04 garfield automount[2857]: expire_proc: 1 remaining in /net 
Nov 24 10:58:04 garfield automount[1919]: handle_child: got pid 2857, sig 0 (0), stat 1 
Nov 24 10:58:04 garfield automount[1919]: sigchld: exp 2857 finished, switching from 2 to 1
Nov 24 10:58:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:58:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:58:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:58:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:58:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:58:17 garfield automount[1917]: expire_proc: exp_proc=2858
Nov 24 10:58:17 garfield automount[1917]: handle_child: got pid 2858, sig 0 (0), stat 0 
Nov 24 10:58:17 garfield automount[1917]: sigchld: exp 2858 finished, switching from 2 to 1
Nov 24 10:58:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:58:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:58:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:58:19 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:58:19 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:58:19 garfield automount[1919]: expire_proc: exp_proc=2859
Nov 24 10:58:19 garfield automount[2859]: expire_proc: 1 remaining in /net 
Nov 24 10:58:19 garfield automount[1919]: handle_child: got pid 2859, sig 0 (0), stat 1 
Nov 24 10:58:19 garfield automount[1919]: sigchld: exp 2859 finished, switching from 2 to 1
Nov 24 10:58:19 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:58:19 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:58:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:58:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:58:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:58:32 garfield automount[1917]: expire_proc: exp_proc=2860
Nov 24 10:58:32 garfield automount[1917]: handle_child: got pid 2860, sig 0 (0), stat 0 
Nov 24 10:58:32 garfield automount[1917]: sigchld: exp 2860 finished, switching from 2 to 1
Nov 24 10:58:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:58:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:58:34 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:58:34 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:58:34 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:58:34 garfield automount[1919]: expire_proc: exp_proc=2861
Nov 24 10:58:34 garfield automount[2861]: expire_proc: 1 remaining in /net 
Nov 24 10:58:34 garfield automount[1919]: handle_child: got pid 2861, sig 0 (0), stat 1 
Nov 24 10:58:34 garfield automount[1919]: sigchld: exp 2861 finished, switching from 2 to 1
Nov 24 10:58:34 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:58:34 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:58:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:58:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:58:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:58:47 garfield automount[1917]: expire_proc: exp_proc=2862
Nov 24 10:58:47 garfield automount[1917]: handle_child: got pid 2862, sig 0 (0), stat 0 
Nov 24 10:58:47 garfield automount[1917]: sigchld: exp 2862 finished, switching from 2 to 1
Nov 24 10:58:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:58:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:58:49 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:58:49 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:58:49 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:58:49 garfield automount[1919]: expire_proc: exp_proc=2863
Nov 24 10:58:49 garfield automount[2863]: expire_proc: 1 remaining in /net 
Nov 24 10:58:49 garfield automount[1919]: handle_child: got pid 2863, sig 0 (0), stat 1 
Nov 24 10:58:49 garfield automount[1919]: sigchld: exp 2863 finished, switching from 2 to 1
Nov 24 10:58:49 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:58:49 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:59:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:59:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:59:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:59:02 garfield automount[1917]: expire_proc: exp_proc=2865
Nov 24 10:59:02 garfield automount[1917]: handle_child: got pid 2865, sig 0 (0), stat 0 
Nov 24 10:59:02 garfield automount[1917]: sigchld: exp 2865 finished, switching from 2 to 1
Nov 24 10:59:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:59:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:59:04 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:59:04 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:59:04 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:59:04 garfield automount[1919]: expire_proc: exp_proc=2867
Nov 24 10:59:04 garfield automount[2867]: expire_proc: 1 remaining in /net 
Nov 24 10:59:04 garfield automount[1919]: handle_child: got pid 2867, sig 0 (0), stat 1 
Nov 24 10:59:04 garfield automount[1919]: sigchld: exp 2867 finished, switching from 2 to 1
Nov 24 10:59:04 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:59:04 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:59:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:59:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:59:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:59:17 garfield automount[1917]: expire_proc: exp_proc=2868
Nov 24 10:59:17 garfield automount[1917]: handle_child: got pid 2868, sig 0 (0), stat 0 
Nov 24 10:59:17 garfield automount[1917]: sigchld: exp 2868 finished, switching from 2 to 1
Nov 24 10:59:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:59:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:59:19 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:59:20 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:59:20 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:59:20 garfield automount[1919]: expire_proc: exp_proc=2870
Nov 24 10:59:20 garfield automount[2870]: expire_proc: 1 remaining in /net 
Nov 24 10:59:20 garfield automount[1919]: handle_child: got pid 2870, sig 0 (0), stat 1 
Nov 24 10:59:20 garfield automount[1919]: sigchld: exp 2870 finished, switching from 2 to 1
Nov 24 10:59:20 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:59:20 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:59:32 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:59:32 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:59:32 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:59:32 garfield automount[1917]: expire_proc: exp_proc=2942
Nov 24 10:59:32 garfield automount[1917]: handle_child: got pid 2942, sig 0 (0), stat 0 
Nov 24 10:59:32 garfield automount[1917]: sigchld: exp 2942 finished, switching from 2 to 1
Nov 24 10:59:32 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:59:32 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:59:35 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:59:35 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:59:35 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:59:35 garfield automount[2943]: expire_proc: 1 remaining in /net 
Nov 24 10:59:35 garfield automount[1919]: expire_proc: exp_proc=2943
Nov 24 10:59:40 garfield automount[1919]: handle_child: got pid 2943, sig 0 (0), stat 1 
Nov 24 10:59:40 garfield automount[1919]: sigchld: exp 2943 finished, switching from 2 to 1
Nov 24 10:59:40 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:59:40 garfield automount[1919]: st_ready(): state = 2 
Nov 24 10:59:47 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 10:59:47 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 10:59:47 garfield automount[1917]: st_expire(): state = 1 
Nov 24 10:59:47 garfield automount[1917]: expire_proc: exp_proc=2944
Nov 24 10:59:47 garfield automount[1917]: handle_child: got pid 2944, sig 0 (0), stat 0 
Nov 24 10:59:47 garfield automount[1917]: sigchld: exp 2944 finished, switching from 2 to 1
Nov 24 10:59:47 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 10:59:47 garfield automount[1917]: st_ready(): state = 2 
Nov 24 10:59:55 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 10:59:55 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 10:59:55 garfield automount[1919]: st_expire(): state = 1 
Nov 24 10:59:55 garfield automount[1919]: expire_proc: exp_proc=2945
Nov 24 10:59:55 garfield automount[2945]: expire_proc: 1 remaining in /net 
Nov 24 10:59:55 garfield automount[1919]: handle_child: got pid 2945, sig 0 (0), stat 1 
Nov 24 10:59:55 garfield automount[1919]: sigchld: exp 2945 finished, switching from 2 to 1
Nov 24 10:59:55 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 10:59:55 garfield automount[1919]: st_ready(): state = 2 
Nov 24 11:00:02 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 11:00:02 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 11:00:02 garfield automount[1917]: st_expire(): state = 1 
Nov 24 11:00:02 garfield automount[1917]: expire_proc: exp_proc=2949
Nov 24 11:00:02 garfield automount[1917]: handle_child: got pid 2949, sig 0 (0), stat 0 
Nov 24 11:00:02 garfield automount[1917]: sigchld: exp 2949 finished, switching from 2 to 1
Nov 24 11:00:02 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 11:00:02 garfield automount[1917]: st_ready(): state = 2 
Nov 24 11:00:10 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 11:00:10 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 11:00:10 garfield automount[1919]: st_expire(): state = 1 
Nov 24 11:00:10 garfield automount[1919]: expire_proc: exp_proc=2950
Nov 24 11:00:10 garfield automount[2950]: expire_proc: 1 remaining in /net 
Nov 24 11:00:10 garfield automount[1919]: handle_child: got pid 2950, sig 0 (0), stat 1 
Nov 24 11:00:10 garfield automount[1919]: sigchld: exp 2950 finished, switching from 2 to 1
Nov 24 11:00:10 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 11:00:10 garfield automount[1919]: st_ready(): state = 2 
Nov 24 11:00:17 garfield automount[1917]: sig 14 switching from 1 to 2
Nov 24 11:00:17 garfield automount[1917]: get_pkt: state 1, next 2
Nov 24 11:00:17 garfield automount[1917]: st_expire(): state = 1 
Nov 24 11:00:17 garfield automount[1917]: expire_proc: exp_proc=2951
Nov 24 11:00:17 garfield automount[1917]: handle_child: got pid 2951, sig 0 (0), stat 0 
Nov 24 11:00:17 garfield automount[1917]: sigchld: exp 2951 finished, switching from 2 to 1
Nov 24 11:00:17 garfield automount[1917]: get_pkt: state 2, next 1
Nov 24 11:00:17 garfield automount[1917]: st_ready(): state = 2 
Nov 24 11:00:25 garfield automount[1919]: sig 14 switching from 1 to 2
Nov 24 11:00:25 garfield automount[1919]: get_pkt: state 1, next 2
Nov 24 11:00:25 garfield automount[1919]: st_expire(): state = 1 
Nov 24 11:00:25 garfield automount[1919]: expire_proc: exp_proc=2952
Nov 24 11:00:25 garfield automount[2952]: expire_proc: 1 remaining in /net 
Nov 24 11:00:25 garfield automount[1919]: handle_child: got pid 2952, sig 0 (0), stat 1 
Nov 24 11:00:25 garfield automount[1919]: sigchld: exp 2952 finished, switching from 2 to 1
Nov 24 11:00:25 garfield automount[1919]: get_pkt: state 2, next 1
Nov 24 11:00:25 garfield automount[1919]: st_ready(): state = 2 

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

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

Re: automount never umount

[Ian Kent]

On Thu, 24 Nov 2005, Farkas Levente wrote:

> Jeff Moyer wrote:
> > lfarkas> a full lsof ? fuser -v for what?
> > 
> > For the mount points in question.  I guess something like:
> > 
> > fuser -v -m <automountpoint>
> > 
> > lsof +D <automountpoint>
> 
> ok now i use only nfs and no smbfs, uprgade to
> kernel-2.6.14-1.1641_FC4.jmoyertest.2 but it doesn't show me any
> difference. so here is the current daemon log and that's all:-(
> -------------------------------
> [root@garfield ~]# fuser -v -m /net/
> 
>                      USER        PID ACCESS COMMAND
> /net/                root       1919 f....  automount
> [root@garfield ~]# lsof +D /net/
> COMMAND    PID USER   FD   TYPE DEVICE SIZE NODE NAME
> automount 1919 root    5r   DIR   0,20    0 5471 /net/
> -------------------------------
> new tips?

These's still no printk output?

So no explanation of what is wrong.

Jeff we could enable DEBUG in the kernel module.
What do you think.

If it would be better I could take the source from the kernel you have and 
put together a tarball. Farkas could then compile and install it so that 
the original module can restored with a "make uninstall" when we are done.

Ian

Re: automount never umount

[Farkas Levente]

Ian Kent wrote:
> On Thu, 24 Nov 2005, Farkas Levente wrote:
> 
> 
>>Jeff Moyer wrote:
>>
>>>lfarkas> a full lsof ? fuser -v for what?
>>>
>>>For the mount points in question.  I guess something like:
>>>
>>>fuser -v -m <automountpoint>
>>>
>>>lsof +D <automountpoint>
>>
>>ok now i use only nfs and no smbfs, uprgade to
>>kernel-2.6.14-1.1641_FC4.jmoyertest.2 but it doesn't show me any
>>difference. so here is the current daemon log and that's all:-(
>>-------------------------------
>>[root@garfield ~]# fuser -v -m /net/
>>
>>                     USER        PID ACCESS COMMAND
>>/net/                root       1919 f....  automount
>>[root@garfield ~]# lsof +D /net/
>>COMMAND    PID USER   FD   TYPE DEVICE SIZE NODE NAME
>>automount 1919 root    5r   DIR   0,20    0 5471 /net/
>>-------------------------------
>>new tips?
> 
> 
> These's still no printk output?
> 
> So no explanation of what is wrong.
> 
> Jeff we could enable DEBUG in the kernel module.
> What do you think.
> 
> If it would be better I could take the source from the kernel you have and 
> put together a tarball. Farkas could then compile and install it so that 
> the original module can restored with a "make uninstall" when we are done.

i try what you want, althugh i prefer rpms.

-- 
   Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Ian Kent <raven@themaw.net> adds:

raven> On Thu, 24 Nov 2005, Farkas Levente wrote:
>> Jeff Moyer wrote: > lfarkas> a full lsof ? fuser -v for what?
>> > 
>> > For the mount points in question.  I guess something like:
>> > 
>> > fuser -v -m <automountpoint>
>> > 
>> > lsof +D <automountpoint>
>> 
>> ok now i use only nfs and no smbfs, uprgade to
>> kernel-2.6.14-1.1641_FC4.jmoyertest.2 but it doesn't show me any
>> difference. so here is the current daemon log and that's all:-(
>> -------------------------------
>> [root@garfield ~]# fuser -v -m /net/
>> 
>> USER PID ACCESS COMMAND /net/ root 1919 f....  automount [root@garfield
>> ~]# lsof +D /net/ COMMAND PID USER FD TYPE DEVICE SIZE NODE NAME
>> automount 1919 root 5r DIR 0,20 0 5471 /net/
>> -------------------------------
>> new tips?

raven> These's still no printk output?

I find that difficult to believe.  Farkas, are you using the `dmesg'
command to look for the printk output?  Please do, as I'm certain there are
a *lot* of messages generated.

raven> So no explanation of what is wrong.

raven> Jeff we could enable DEBUG in the kernel module.  What do you think.

raven> If it would be better I could take the source from the kernel you
raven> have and put together a tarball. Farkas could then compile and
raven> install it so that the original module can restored with a "make
raven> uninstall" when we are done.

Sure, you could enable debug.  I just didn't want to get too much
information.  However, at this point, it's probably better that we get as
much as possible so Farkas doesn't have to keep trying new patches.

Farkas, please look at the output of dmesg and let us know what you find.
You should see something like this:

autofs4_revalidate: revalidate called on behalf of application "mount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application "ls"
autofs4_revalidate: revalidate called on behalf of application "ls"
autofs4_revalidate: revalidate called on behalf of application "ls"
autofs4_revalidate: revalidate called on behalf of application "ls"

-Jeff

Re: automount never umount

[Ian Kent]

On Mon, 28 Nov 2005, Jeff Moyer wrote:

> ==> Regarding Re: [autofs] automount never umount; Ian Kent <raven@themaw.net> adds:
> 
> raven> On Thu, 24 Nov 2005, Farkas Levente wrote:
> >> Jeff Moyer wrote: > lfarkas> a full lsof ? fuser -v for what?
> >> > 
> >> > For the mount points in question.  I guess something like:
> >> > 
> >> > fuser -v -m <automountpoint>
> >> > 
> >> > lsof +D <automountpoint>
> >> 
> >> ok now i use only nfs and no smbfs, uprgade to
> >> kernel-2.6.14-1.1641_FC4.jmoyertest.2 but it doesn't show me any
> >> difference. so here is the current daemon log and that's all:-(
> >> -------------------------------
> >> [root@garfield ~]# fuser -v -m /net/
> >> 
> >> USER PID ACCESS COMMAND /net/ root 1919 f....  automount [root@garfield
> >> ~]# lsof +D /net/ COMMAND PID USER FD TYPE DEVICE SIZE NODE NAME
> >> automount 1919 root 5r DIR 0,20 0 5471 /net/
> >> -------------------------------
> >> new tips?
> 
> raven> These's still no printk output?
> 
> I find that difficult to believe.  Farkas, are you using the `dmesg'
> command to look for the printk output?  Please do, as I'm certain there are
> a *lot* of messages generated.

Absolutely, revalidate is called frequently.
There should be heaps of output.

What facility are kernel messages again, LOG_KERN?
Perhaps there is no kern.<level> line in syslog.conf?
daemon.<level> would get the output we are seeing.

Ian

Re: automount never umount

[Farkas Levente]

Jeff Moyer wrote:
> ==> Regarding Re: [autofs] automount never umount; Ian Kent <raven@themaw.net> adds:
> 
> raven> On Thu, 24 Nov 2005, Farkas Levente wrote:
> 
>>>Jeff Moyer wrote: > lfarkas> a full lsof ? fuser -v for what?
>>>
>>>>For the mount points in question.  I guess something like:
>>>>
>>>>fuser -v -m <automountpoint>
>>>>
>>>>lsof +D <automountpoint>
>>>
>>>ok now i use only nfs and no smbfs, uprgade to
>>>kernel-2.6.14-1.1641_FC4.jmoyertest.2 but it doesn't show me any
>>>difference. so here is the current daemon log and that's all:-(
>>>-------------------------------
>>>[root@garfield ~]# fuser -v -m /net/
>>>
>>>USER PID ACCESS COMMAND /net/ root 1919 f....  automount [root@garfield
>>>~]# lsof +D /net/ COMMAND PID USER FD TYPE DEVICE SIZE NODE NAME
>>>automount 1919 root 5r DIR 0,20 0 5471 /net/
>>>-------------------------------
>>>new tips?
> 
> 
> raven> These's still no printk output?
> 
> I find that difficult to believe.  Farkas, are you using the `dmesg'
> command to look for the printk output?  Please do, as I'm certain there are
> a *lot* of messages generated.

opps. sorry i'm just look into daemon log while these are go into kern
log:-(

> Sure, you could enable debug.  I just didn't want to get too much
> information.  However, at this point, it's probably better that we get as
> much as possible so Farkas doesn't have to keep trying new patches.
> 
> Farkas, please look at the output of dmesg and let us know what you find.
> You should see something like this:

# dmesg |sort|uniq

autofs4_revalidate: revalidate called on behalf of application "automount"
autofs4_revalidate: revalidate called on behalf of application
"multiload-apple"

so what can i do? no longer use multiload-applet ? this is a standard
gnome applet included in fc4: "System Monitor 2.10.1"

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Farkas Levente]

Farkas Levente wrote:
> Jeff Moyer wrote:
>>Sure, you could enable debug.  I just didn't want to get too much
>>information.  However, at this point, it's probably better that we get as
>>much as possible so Farkas doesn't have to keep trying new patches.
>>
>>Farkas, please look at the output of dmesg and let us know what you find.
>>You should see something like this:
> 
> 
> # dmesg |sort|uniq
> 
> autofs4_revalidate: revalidate called on behalf of application "automount"
> autofs4_revalidate: revalidate called on behalf of application
> "multiload-apple"
> 
> so what can i do? no longer use multiload-applet ? this is a standard
> gnome applet included in fc4: "System Monitor 2.10.1"

so what is the conclusion now?
will autofs be modified to umount even in such case or ...?
thnaks.

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Ian Kent]

On Thu, 1 Dec 2005, Farkas Levente wrote:

> Farkas Levente wrote:
> > Jeff Moyer wrote:
> >>Sure, you could enable debug.  I just didn't want to get too much
> >>information.  However, at this point, it's probably better that we get as
> >>much as possible so Farkas doesn't have to keep trying new patches.
> >>
> >>Farkas, please look at the output of dmesg and let us know what you find.
> >>You should see something like this:
> > 
> > 
> > # dmesg |sort|uniq
> > 
> > autofs4_revalidate: revalidate called on behalf of application "automount"
> > autofs4_revalidate: revalidate called on behalf of application
> > "multiload-apple"
> > 
> > so what can i do? no longer use multiload-applet ? this is a standard
> > gnome applet included in fc4: "System Monitor 2.10.1"
> 
> so what is the conclusion now?
> will autofs be modified to umount even in such case or ...?
> thnaks.

I'm not familiar with this applet.
Can someone help ot?

Ian

Re: automount never umount

[Farkas Levente]

Ian Kent wrote:
> On Thu, 1 Dec 2005, Farkas Levente wrote:
> 
> 
>>Farkas Levente wrote:
>>
>>>Jeff Moyer wrote:
>>>
>>>>Sure, you could enable debug.  I just didn't want to get too much
>>>>information.  However, at this point, it's probably better that we get as
>>>>much as possible so Farkas doesn't have to keep trying new patches.
>>>>
>>>>Farkas, please look at the output of dmesg and let us know what you find.
>>>>You should see something like this:
>>>
>>>
>>># dmesg |sort|uniq
>>>
>>>autofs4_revalidate: revalidate called on behalf of application "automount"
>>>autofs4_revalidate: revalidate called on behalf of application
>>>"multiload-apple"
>>>
>>>so what can i do? no longer use multiload-applet ? this is a standard
>>>gnome applet included in fc4: "System Monitor 2.10.1"
>>
>>so what is the conclusion now?
>>will autofs be modified to umount even in such case or ...?
>>thnaks.
> 
> 
> I'm not familiar with this applet.
> Can someone help ot?

which kind of distro do you use? on fedora/redhat it's in gnome-applets
package and anyway in:
http://cvs.gnome.org/viewcvs/gnome-applets/multiload/

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Jeff Moyer]

==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:

lfarkas> Ian Kent wrote:
>> On Thu, 1 Dec 2005, Farkas Levente wrote:
>> 
>> 
>>> Farkas Levente wrote:
>>> 
>>>> Jeff Moyer wrote:
>>>> 
>>>>> Sure, you could enable debug.  I just didn't want to get too much
>>>>> information.  However, at this point, it's probably better that we
>>>>> get as much as possible so Farkas doesn't have to keep trying new
>>>>> patches.
>>>>> 
>>>>> Farkas, please look at the output of dmesg and let us know what you
>>>>> find.  You should see something like this:
>>>> 
>>>> 
>>>> # dmesg |sort|uniq
>>>> 
>>>> autofs4_revalidate: revalidate called on behalf of application
>>>> "automount" autofs4_revalidate: revalidate called on behalf of
>>>> application "multiload-apple"
>>>> 
>>>> so what can i do? no longer use multiload-applet ? this is a standard
>>>> gnome applet included in fc4: "System Monitor 2.10.1"
>>> so what is the conclusion now?  will autofs be modified to umount even
>>> in such case or ...?  thnaks.
>> 
>> 
>> I'm not familiar with this applet.  Can someone help ot?

lfarkas> which kind of distro do you use? on fedora/redhat it's in
lfarkas> gnome-applets package and anyway in:
lfarkas> http://cvs.gnome.org/viewcvs/gnome-applets/multiload/

I'm not convinced it's the culprit.  As Ian mentioned earlier in this
thread, there is no flurry of mount/umount activity.  The file system gets
mounted, and then never unmounted, right?  If that is the case, and lsof
shows no users, then this is likely an autofs bug.

-Jeff

Re: automount never umount

[Farkas Levente]

Jeff Moyer wrote:
>>>>># dmesg |sort|uniq
>>>>>
>>>>>autofs4_revalidate: revalidate called on behalf of application
>>>>>"automount" autofs4_revalidate: revalidate called on behalf of
>>>>>application "multiload-apple"
>>>>>
>>>>>so what can i do? no longer use multiload-applet ? this is a standard
>>>>>gnome applet included in fc4: "System Monitor 2.10.1"
>>>>
>>>>so what is the conclusion now?  will autofs be modified to umount even
>>>>in such case or ...?  thnaks.
>>>
>>>
>>>I'm not familiar with this applet.  Can someone help ot?
> 
> 
> lfarkas> which kind of distro do you use? on fedora/redhat it's in
> lfarkas> gnome-applets package and anyway in:
> lfarkas> http://cvs.gnome.org/viewcvs/gnome-applets/multiload/
> 
> I'm not convinced it's the culprit.  As Ian mentioned earlier in this
> thread, there is no flurry of mount/umount activity.  The file system gets
> mounted, and then never unmounted, right?  If that is the case, and lsof

right.

> shows no users, then this is likely an autofs bug.

no users.
so i also assume it's an autofs bug, that's why i wrote my first post.
since i'm sure there is not any file on the nfs partition which is used
for hours. the given nfs partition is our mirror server of centos,
fedora, dag, etc.. so we only use it to manualy install new packages.
even the daily updates run through ftp in order not use this nfs.

so i'd be happy to see some fixes:-)

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Ian Kent]

On Thu, 1 Dec 2005, Farkas Levente wrote:

> Jeff Moyer wrote:
> >>>>># dmesg |sort|uniq
> >>>>>
> >>>>>autofs4_revalidate: revalidate called on behalf of application
> >>>>>"automount" autofs4_revalidate: revalidate called on behalf of
> >>>>>application "multiload-apple"
> >>>>>
> >>>>>so what can i do? no longer use multiload-applet ? this is a standard
> >>>>>gnome applet included in fc4: "System Monitor 2.10.1"
> >>>>
> >>>>so what is the conclusion now?  will autofs be modified to umount even
> >>>>in such case or ...?  thnaks.
> >>>
> >>>
> >>>I'm not familiar with this applet.  Can someone help ot?
> > 
> > 
> > lfarkas> which kind of distro do you use? on fedora/redhat it's in
> > lfarkas> gnome-applets package and anyway in:
> > lfarkas> http://cvs.gnome.org/viewcvs/gnome-applets/multiload/
> > 
> > I'm not convinced it's the culprit.  As Ian mentioned earlier in this
> > thread, there is no flurry of mount/umount activity.  The file system gets
> > mounted, and then never unmounted, right?  If that is the case, and lsof
> 
> right.
> 
> > shows no users, then this is likely an autofs bug.
> 
> no users.
> so i also assume it's an autofs bug, that's why i wrote my first post.
> since i'm sure there is not any file on the nfs partition which is used
> for hours. the given nfs partition is our mirror server of centos,
> fedora, dag, etc.. so we only use it to manualy install new packages.
> even the daily updates run through ftp in order not use this nfs.

Then I must be able to duplicate it.
The kernel includes the latest patch we have in test right Jeff?

Ian

Re: automount never umount

[Ian Kent]

On Thu, 1 Dec 2005, Farkas Levente wrote:

> Ian Kent wrote:
> > On Thu, 1 Dec 2005, Farkas Levente wrote:
> > 
> > 
> >>Farkas Levente wrote:
> >>
> >>>Jeff Moyer wrote:
> >>>
> >>>>Sure, you could enable debug.  I just didn't want to get too much
> >>>>information.  However, at this point, it's probably better that we get as
> >>>>much as possible so Farkas doesn't have to keep trying new patches.
> >>>>
> >>>>Farkas, please look at the output of dmesg and let us know what you find.
> >>>>You should see something like this:
> >>>
> >>>
> >>># dmesg |sort|uniq
> >>>
> >>>autofs4_revalidate: revalidate called on behalf of application "automount"
> >>>autofs4_revalidate: revalidate called on behalf of application
> >>>"multiload-apple"
> >>>
> >>>so what can i do? no longer use multiload-applet ? this is a standard
> >>>gnome applet included in fc4: "System Monitor 2.10.1"
> >>
> >>so what is the conclusion now?
> >>will autofs be modified to umount even in such case or ...?
> >>thnaks.
> > 
> > 
> > I'm not familiar with this applet.
> > Can someone help ot?
> 
> which kind of distro do you use? on fedora/redhat it's in gnome-applets
> package and anyway in:
> http://cvs.gnome.org/viewcvs/gnome-applets/multiload/

I'll have a look about.

Dev machine has Aurora 2.0, a Gentoo and a Debian install. Only the Aurora 
is really working.

Other machines have an FC3 and an FC4 (which is broken atm) and an 
old Debian install.

Ian

Re: automount never umount

[Farkas Levente]

Ian Kent wrote:
>>>I'm not familiar with this applet.
>>>Can someone help ot?
>>
>>which kind of distro do you use? on fedora/redhat it's in gnome-applets
>>package and anyway in:
>>http://cvs.gnome.org/viewcvs/gnome-applets/multiload/
> 
> 
> I'll have a look about.
> 
> Dev machine has Aurora 2.0, a Gentoo and a Debian install. Only the Aurora 
> is really working.

aurora is almost the same:-)
fyi: there is a new centos 4.2beta for sparc on beta.centos.org we use
it for a weeks and seems to ok.

-- 
  Levente                               "Si vis pacem para bellum!"

Re: automount never umount

[Ian Kent]

On Thu, 1 Dec 2005, Farkas Levente wrote:

> Ian Kent wrote:
> >>>I'm not familiar with this applet.
> >>>Can someone help ot?
> >>
> >>which kind of distro do you use? on fedora/redhat it's in gnome-applets
> >>package and anyway in:
> >>http://cvs.gnome.org/viewcvs/gnome-applets/multiload/
> > 
> > 
> > I'll have a look about.
> > 
> > Dev machine has Aurora 2.0, a Gentoo and a Debian install. Only the Aurora 
> > is really working.
> 
> aurora is almost the same:-)
> fyi: there is a new centos 4.2beta for sparc on beta.centos.org we use
> it for a weeks and seems to ok.

OK. Must check that out.
But not till get some more of the autofs stuff done.
There's quite a bit going on just now.

Ian

Re: automount never umount

[Ian Kent]

On Tue, 22 Nov 2005, Jeff Moyer wrote:

> 
> Try the kernel rpm located here:
> 
> 	http://people.redhat.com/jmoyer/farkas/kernel-2.6.14-1.1641_FC4.jmoyertest.1.i686.rpm
> 
> It has the potential to generate a good bit of output.  I've attached the
> patch that is incorporated there.  You'll want to post the output of dmesg
> to this list when you get it.
> 
> You'll notice that the second bit of this patch is not related to this
> problem.  Ian, you should take that into account if you keep around the
> expiry of negative dentries.

Good one. Thanks.

Ian

Re: automount never umount

[Ian Kent]

On Tue, 22 Nov 2005, Jeff Moyer wrote:

> ==> Regarding Re: [autofs] automount never umount; Farkas Levente <lfarkas@bppiac.hu> adds:
> 
> lfarkas> Ian Kent wrote:
> >> That wasn't what I had in mind.
> >> 
> >> I was thinking more along the lines of the definition of what constitues
> >> "use". For example any access, such as a directory listing, will update
> >> the "last used" value whereas if I change the definition of "last used"
> >> to "currently in use" then to be busy there would have to be an open
> >> file or a process working directory set. This may solve the GUI scanning
> >> problem we see but wouldn't solve immediate remounting that occurs due
> >> to the scanning as well.
> 
> lfarkas> that would be useful and may be solve our problem. without it the
> lfarkas> current implementation is not usable to umount. think about just
> lfarkas> the daily process like slocate database update, tripwire and may
> lfarkas> be others.
> 
> Things that run infrequently are not at fault, here.  I'd really like to
> know precisely what is going on, in your case.

Knowing what's going on would be good. Yes.

> 
> Ian, I think it would be easy enough to instrument the autofs4 module.
> Simple things, like figuring out which process is triggerring the lookup.
> We can either log it, or just keep a ring buffer.

Yep.

I probably won't get to it till the weekend.

Ian