Subject: weird timing with current
To: None <current-users@sun-lamp.cs.berkeley.edu>
From: Alex R.N. Wetmore <aw2t+@andrew.cmu.edu>
List: current-users
Date: 11/17/1993 22:09:39
I just upgraded to the netbsd-current kernel today (without changing
anything else), originally to try and play around with Wine (I never got
that far).  The only change that I made to the system is the addition of
syscons (instead of pccons) because I used the virtual terminal feature.

Here is what happened:  The machine got very very slow, almost as if the
scheduler was running at 1hz instead of 100hz.  At first I thought that
the entire system had crashed, but then I noticed that things were
running really slowly.  I telnetted into the machine from another
machine in the room to see if something was causing it to trash, but
there wasn't anything in the ps listing (I'll include a copy of it at
the end of my post).  I shutdown the machine and rebooted.

I don't think it was disk latency of some kind because stuff that
doesn't access the disk (like the copyright lines spit out by login) had
a large break in between them (about 5 seconds from the first line to
the second).  It wasn't network latency because things were just as slow
from console or a telnet session.

Here is the ps file from the time:
USER       PID %CPU %MEM   VSZ  RSS TT  STAT STARTED       TIME COMMAND
alex     11703  0.0  0.7  1512  108 ??  R    31Dec69    0:00.03 /usr/yabbs/bin/
root     11699  0.0  0.5   104   84 p2  D<   31Dec69    0:00.03 sh -c /usr/bin/
root     11698  0.0  0.6   104   92 p2  S<   31Dec69    0:00.04 sh -c /usr/bin/
ftp      11678  0.0  1.4   332  248 ??  D    31Dec69    0:00.10 - to psuvm.psu.
root     11676  0.0  1.2   268  200 p2  R+   31Dec69    0:00.33 ps aux
root     11675  0.0  0.7   144  112 p2  S<   31Dec69    0:00.03 shutdown -r +2
root     11674  0.0  1.2   232  200 p6  Ss+  31Dec69    0:00.08 login -h msuaca
root     11666  0.0  0.7   124  120 ??  S    31Dec69    0:00.32 telnetd
syon     11595  0.0  2.5   508  432 p4  Ss+  31Dec69    0:00.84 -tcsh (tcsh)
root     11538  0.0  0.7   124  120 ??  S    31Dec69    0:00.30 telnetd
root     11504  0.0  1.2   248  196 p2  S    31Dec69    0:00.60 -su (csh)
syon     11483  0.0  0.8   116  124 pa  I+   31Dec69    0:00.13 less -m -H -+E 
root     11479  0.0  0.4   100   56 v1  Is+  31Dec69    0:00.17 /usr/libexec/ge
syon     11475  0.0  2.0   456  332 pa  I+   31Dec69    0:00.38 -usr/local/bin/
syon     11472  0.0  0.6   112   96 pa  I+   31Dec69    0:00.05 sh -c /usr/loca
syon     11355  0.0  0.7   124  120 pa  I+   31Dec69    0:00.26 less
alex     11325  0.0  2.9   552  492 p2  Is   31Dec69    0:01.15 -zsh (zsh)
root     11324  0.0  0.8   132  124 ??  S    31Dec69    0:00.61 telnetd
syon     11317  0.0  2.2   408  372 pa  D    31Dec69   11:00.28 gzip -9 Radianc
bbs      11311  0.0  1.1   696  192 p1  Rs+  31Dec69    0:04.73 login -h cat.oh
root     11310  0.0  0.7   124  120 ??  S    31Dec69    0:01.65 bbsd
alex     11301  0.0  2.6   512  444 v0  S+   31Dec69    0:09.07 ezmail -ep -b
syon     11273  0.0  1.2   708  200 p5  I+   31Dec69    0:03.88 bbs
syon     11271  0.0  2.6   516  436 p5  Is   31Dec69    0:00.45 -usr/local/bin/
syon     11268  0.0  2.8   532  480 pa  Is   31Dec69    0:00.83 -usr/local/bin/
root     11266  0.0  2.2   496  372 ??  Is   31Dec69    0:19.70 SCREEN
bbs       9933  0.0  1.2   704  196 p0  Is+  31Dec69    0:07.29 -yabbs (yabbs)
root      9931  0.0  0.8   128  124 ??  I    31Dec69    0:09.45 telnetd
alex      8948  0.0  2.9   552  488 v0  Is   31Dec69    0:01.17 -zsh (zsh)
root      3995  0.0  0.9   176  152 ??  Is   31Dec69    0:00.14 mountd
root      3652  0.0  0.4   100   56 v2  Is+  31Dec69    0:00.09 /usr/libexec/ge
alex       244  0.0  2.7  1512  464 v2- S    31Dec69    2:50.31 /usr/yabbs/bin/
root        95  0.0  0.3   100   52  1  Is+  31Dec69    0:00.05 /usr/libexec/ge
root        94  0.0  0.4   100   56 v3  Is+  31Dec69    0:00.02 /usr/libexec/ge
root        87  0.0  0.2    32   24 ??  I    31Dec69    0:00.00 nfsiod 4
root        86  0.0  0.2    32   24 ??  I    31Dec69    0:00.00 nfsiod 4
root        85  0.0  0.2    32   24 ??  I    31Dec69    0:00.01 nfsiod 4
root        83  0.0  0.2    32   20 ??  Is   31Dec69    0:00.02 nfsiod 4
root        82  0.0  0.1    72   16 ??  I    31Dec69    0:00.00  (nfsd)
root        81  0.0  0.1    72   16 ??  I    31Dec69    0:00.01  (nfsd)
root        80  0.0  0.1    72   16 ??  I    31Dec69    0:00.00  (nfsd)
root        79  0.0  0.1    72   16 ??  I    31Dec69    0:00.06  (nfsd)
root        77  0.0  0.1    72   16 ??  Is   31Dec69    0:00.06  (nfsd)
root        73  0.0  0.5   112   84 ??  Is   31Dec69    0:02.72 portmap
root        69  0.0  0.6   324  100 ??  S    31Dec69    0:02.99 -waiting for co
root        62  0.0  0.6   184   92 ??  Ss   31Dec69    0:02.96 inetd
root        60  0.0  1.1   468  176 ??  Is   31Dec69    0:04.92 sendmail: accep
root        56  0.0  0.3   172   52 ??  Is   31Dec69    0:00.09 lpd
root        53  0.0  1.7   376  292 ??  S    31Dec69    0:21.41 /usr/local/etc/
root        48  0.0  0.4   152   60 ??  Ss   31Dec69    0:04.28 routed -q
root        44  0.0  0.7   220  108 ??  S    31Dec69    0:00.19 /usr/libexec/cr
root        42  0.0  0.2    16   28 ??  Ss   31Dec69    0:02.77 update
root        28  0.0  0.7   116  112 ??  Ss   31Dec69    0:01.14 syslogd
root         2  0.0  0.1     0   12 ??  DL   31Dec69    0:00.64 (pagedaemon)
root         1  0.0  0.9   200  152 ??  Ss   31Dec69    0:01.24 init --
root         0  0.0  0.0     0    0 ??  DLs  31Dec69    0:00.03 (swapper)
(also, any ideas why processes always are dated as starting 31Dec69? 
They started getting listed that way about a week or two ago.  My clock
is set right, and so is the time zone).

Here is my config file:
machine "i386"
cpu		"I386_CPU"
cpu		"I486_CPU"
ident		PHRED
timezone	5 dst
maxusers	10
options		INET
options		SWAPPAGER
options		VNODEPAGER
options		DEVPAGER
options		FIFO
options		NFSCLIENT
options		FASTLINKS
options		NFSSERVER
options		"COMPAT_43"
options		"TCP_COMPAT_42"
options		FFS
options		XSERVER
options		UCONSOLE
options		MSDOSFS
options		KERNFS
options		"MATH_EMULATE"
options		"COMPAT_NOMID"
#options	DDB

config		netbsd	root on wd0 swap on wd0 and wd1

controller	isa0
controller	wdc0	at isa? port "IO_WD1" bio irq 14 vector wdintr
disk		wd0	at wdc0 drive 0
disk		wd1	at wdc0 drive 1

controller	fdc0	at isa? port "IO_FD1" bio irq 6 drq 2 vector fdintr
disk		fd0	at fdc0 drive 0
disk		fd1	at fdc0 drive 1

#device		pc0	at isa? port "IO_KBD" tty irq 1 vector pcrint
device		sc0 at isa? port "IO_KBD" tty irq 1 vector scintr
device		npx0	at isa? port "IO_NPX" irq 13 vector npxintr
device		com0	at isa? port "IO_COM1" tty irq 4 vector comintr
device		com1	at isa? port "IO_COM2" tty irq 3 vector comintr
device		com2	at isa? port "IO_COM3" tty irq 5 vector comintr
#device		com3	at isa? port "IO_COM4" tty irq 9 vector comintr

#device		lpt0	at isa? port "IO_LPT3" tty irq 7 vector lptintr
device		lpa0	at isa? port "IO_LPT1" tty
#device		lpa1	at isa? port "IO_LPT2" tty

device ed0 at isa? port 0x280 net irq 15 iomem 0xd0000 vector edintr
device ed1 at isa? port 0x250 net irq 9 iomem 0xd8000 vector edintr
#device we0 at isa? port 0x280 net irq 9 iomem 0xd0000 iosiz 8192 vector weintr
#device ec0 at isa? port 0x250 net irq 9 iomem 0xd8000 iosiz 8192 vector ecintr
#device ne0 at isa? port 0x300 net irq 9 vector neintr
#device is0 at isa? port 0x320 net irq 10 drq 7 vector isintr

#device		wt0	at isa? port 0x1e8 bio irq 12 drq 1 vector wtintr

pseudo-device	ether
pseudo-device	log
pseudo-device	loop
pseudo-device	pty		32
pseudo-device	sl		1
pseudo-device	bpfilter	4
pseudo-device	speaker

pseudo-device	swappager
pseudo-device	vnodepager
pseudo-device	devpager

thanks,
alex



------------------------------------------------------------------------------