From hsu@clinet.fi Mon Dec 18 07:52:16 1995 Received: from hauki.clinet.fi (root@hauki.clinet.fi [194.100.0.1]) by freefall.freebsd.org (8.7.3/8.7.3) with SMTP id HAA02801 for ; Mon, 18 Dec 1995 07:51:14 -0800 (PST) Received: from katiska.clinet.fi (root@katiska.clinet.fi [194.100.0.4]) by hauki.clinet.fi (8.6.12/8.6.4) with ESMTP id RAA22233 for ; Mon, 18 Dec 1995 17:50:49 +0200 Received: (root@localhost) by katiska.clinet.fi (8.6.12/8.6.4) id RAA24364; Mon, 18 Dec 1995 17:51:00 +0200 Message-Id: <199512181551.RAA24364@katiska.clinet.fi> Date: Mon, 18 Dec 1995 17:51:00 +0200 From: Heikki Suonsivu Reply-To: hsu@clinet.fi To: FreeBSD-gnats-submit@freebsd.org Subject: "The alternate system clock has died" X-Send-Pr-Version: 3.2 >Number: 902 >Category: kern >Synopsis: system becomes very sluggish, odd messages, odd vmstat output >Confidential: no >Severity: serious >Priority: medium >Responsible: freebsd-bugs >State: closed >Quarter: >Keywords: >Date-Required: >Class: sw-bug >Submitter-Id: current-users >Arrival-Date: Mon Dec 18 08:00:02 PST 1995 >Closed-Date: Wed Apr 10 11:10:34 PDT 1996 >Last-Modified: Wed Apr 10 11:12:03 PDT 1996 >Originator: Heikki Suonsivu >Release: FreeBSD 2.2-CURRENT i386 >Organization: Clinet, Espoo, Finland >Environment: kernel is -current from November 26th. This could have been fixed, but I haven't been able to get a stable snapshot out of -current yet to see if it is. machine "i386" cpu "I386_CPU" cpu "I486_CPU" cpu "I586_CPU" # aka Pentium(tm) ident CLINETSERVER maxusers 256 options "NMBCLUSTERS=8192" options "TTYHOG=4096" options "RS_IBUFSIZE=1024" options "CHILD_MAX=512" options "OPEN_MAX=512" options MATH_EMULATE #Support for x87 emulation #new math emulator config kernel root on wd0 swap on wd0 and wd1 and sd0 and sd1 and sd2 and sd3 and vn0 dumps on sd0 options "COMPAT_43" options USER_LDT #allow user-level control of i386 ldt options SYSVSHM options SYSVSEM options SYSVMSG options KTRACE #kernel tracing options DIAGNOSTIC options UCONSOLE options INET #Internet communications protocols pseudo-device ether #Generic Ethernet pseudo-device sppp #Generic Synchronous PPP pseudo-device loop #Network loopback device pseudo-device sl 16 #Serial Line IP pseudo-device ppp 32 #Point-to-point protocol pseudo-device bpfilter 4 #Berkeley packet filter pseudo-device disc #Discard device pseudo-device tun 1 #Tunnel driver(user process ppp) options "TCP_COMPAT_42" #emulate 4.2BSD TCP bugs options GATEWAY #internetwork gateway options MROUTING # Multicast routing options IPFIREWALL #firewall options IPFIREWALL_VERBOSE #print information about # dropped packets options FFS #Fast filesystem options NFS #Network File System options "CD9660" #ISO 9660 filesystem options FDESC #File descriptor filesystem options KERNFS #Kernel filesystem options LFS #Log filesystem options MFS #Memory File System options MSDOSFS #MS DOS File System options NULLFS #NULL filesystem options PORTAL #Portal filesystem options PROCFS #Process filesystem options UMAPFS #UID map filesystem options UNION #Union filesystem options DEVFS #devices filesystem controller scbus0 #base SCSI code device ch0 #SCSI media changers device sd0 #SCSI disks device st0 #SCSI tapes device cd0 #SCSI CD-ROMs disk sd0 at scbus0 target 0 disk sd1 at scbus0 target 1 disk sd2 at scbus0 target 2 disk sd3 at scbus0 target 3 disk sd4 at scbus0 target 4 disk sd5 at scbus0 target 5 disk sd6 at scbus0 target 6 tape st0 at scbus0 target 0 tape st1 at scbus0 target 1 tape st2 at scbus0 target 2 tape st3 at scbus0 target 3 tape st4 at scbus0 target 4 tape st5 at scbus0 target 5 tape st6 at scbus0 target 6 device cd0 at scbus0 target 0 device cd1 at scbus0 target 1 device cd2 at scbus0 target 2 device cd3 at scbus0 target 3 device cd4 at scbus0 target 4 device cd5 at scbus0 target 5 device cd6 at scbus0 target 6 options SCSI_REPORT_GEOMETRY pseudo-device pty 256 #Pseudo ttys - can go as high as 64 pseudo-device speaker #Play IBM BASIC-style noises out your speaker pseudo-device log #Kernel syslog interface (/dev/klog) pseudo-device gzip #Exec gzipped a.out's pseudo-device vn #Vnode driver (turns a file into a device) controller isa0 options "AUTO_EOI_1" options BOUNCE_BUFFERS device vt0 at isa? port "IO_KBD" tty irq 1 vector pcrint options "PCVT_FREEBSD=210" # pcvt running on FreeBSD 2.1 options XSERVER # include code for XFree86 options FAT_CURSOR # start with block cursor options HARDFONTS options MAXCONS=16 device npx0 at isa? port "IO_NPX" irq 13 vector npxintr controller bt0 at isa? port "IO_BT0" bio irq ? vector bt_isa_intr controller aha0 at isa? port "IO_AHA0" bio irq ? drq 5 vector ahaintr 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 tape ft0 at fdc0 drive 2 device lpt0 at isa? port? tty irq 7 vector lptintr device lpt1 at isa? port? tty device sio0 at isa? port "IO_COM1" tty irq 4 vector siointr device sio1 at isa? port "IO_COM2" tty irq 3 vector siointr device sio2 at isa? port "IO_COM3" tty irq 5 vector siointr device sio3 at isa? port "IO_COM4" tty irq 9 vector siointr options COM_MULTIPORT #code for some cards with shared IRQs device ar0 at isa? port 0x300 net irq 10 iomem 0xd0000 vector arintr device ed0 at isa? port 0x280 net irq 5 iomem 0xd8000 vector edintr controller snd0 device pas0 at isa? port 0x388 irq 10 drq 6 vector pasintr device sb0 at isa? port 0x220 irq 7 conflicts drq 1 vector sbintr device sbxvi0 at isa? drq 5 device sbmidi0 at isa? port 0x330 device gus0 at isa? port 0x220 irq 12 drq 1 vector gusintr device mss0 at isa? port 0x530 irq 10 drq 1 vector adintr device opl0 at isa? port 0x388 conflicts device mpu0 at isa? port 0x330 irq 6 drq 0 device uart0 at isa? port 0x330 irq 5 vector "m6850intr" device pca0 at isa? port IO_TIMER1 tty device mcd0 at isa? port 0x300 bio irq 10 vector mcdintr controller matcd0 at isa? port 0x230 bio device cy0 at isa? tty irq 10 iomem 0xd4000 iosiz 0x2000 vector cyintr controller eisa0 controller ahb0 controller ahc0 controller pci0 device ncr1 device de5 options PROBE_VERBOSE options SHOW_BUSYBUFS # List buffers that prevent root unmount options "SCSI_DELAY=10" Dec 17 19:49:42 katiska /kernel: FreeBSD 2.2-CURRENT #2: Sun Nov 26 06:35:44 EET 1995 Dec 17 19:49:42 katiska /kernel: hsu@katiska.clinet.fi:/usr/current/src/sys/compile/CLINETSERVER Dec 17 19:49:42 katiska /kernel: CPU: 90-MHz Pentium 735\90 (Pentium-class CPU) Dec 17 19:49:42 katiska /kernel: Origin = "GenuineIntel" Id = 0x524 Stepping=4 Dec 17 19:49:43 katiska /kernel: Features=0x1bf Dec 17 19:49:43 katiska /kernel: real memory = 67108864 (65536K bytes) Dec 17 19:49:43 katiska /kernel: avail memory = 62394368 (60932K bytes) Dec 17 19:49:43 katiska /kernel: Probing for devices on the ISA bus: Dec 17 19:49:43 katiska /kernel: vt0 at 0x60-0x6f irq 1 on motherboard Dec 17 19:49:43 katiska /kernel: vt0: tvga 8900cl, 80/132 col, mono, 8 scr, mf2-kbd, [R3.20-b24] Dec 17 19:49:43 katiska /kernel: ed0 at 0x280-0x29f irq 5 maddr 0xd8000 msize 16384 on isa Dec 17 19:49:43 katiska /kernel: ed0: address 00:00:c0:cd:b9:a3, type WD8013EPC (16 bit) Dec 17 19:49:43 katiska /kernel: lpt0 at 0x378-0x37f irq 7 on isa Dec 17 19:49:43 katiska /kernel: lpt0: Interrupt-driven port Dec 17 19:49:43 katiska /kernel: lp0: TCP/IP capable interface Dec 17 19:49:43 katiska /kernel: lpt1 not found at 0xffffffff Dec 17 19:49:43 katiska /kernel: lpt2 not found at 0xffffffff Dec 17 19:49:43 katiska /kernel: sio0 at 0x3f8-0x3ff irq 4 on isa Dec 17 19:49:43 katiska /kernel: sio0: type 16550A Dec 17 19:49:43 katiska /kernel: sio1 at 0x2f8-0x2ff irq 3 on isa Dec 17 19:49:43 katiska /kernel: sio1: type 16550A Dec 17 19:49:43 katiska /kernel: sio2 not found at 0x3e8 Dec 17 19:49:44 katiska /kernel: sio3 not found at 0x2e8 Dec 17 19:49:44 katiska /kernel: pca0 on isa Dec 17 19:49:44 katiska /kernel: pca0: PC speaker audio driver Dec 17 19:49:44 katiska /kernel: bt0 not found at 0x330 Dec 17 19:49:44 katiska /kernel: aha0 not found at 0x330 Dec 17 19:49:44 katiska /kernel: wdc0 not found at 0x1f0 Dec 17 19:49:44 katiska /kernel: fdc0 at 0x3f0-0x3f7 irq 6 drq 2 on isa Dec 17 19:49:44 katiska /kernel: fdc0: NEC 72065B Dec 17 19:49:44 katiska /kernel: fd0: 1.44MB 3.5in Dec 17 19:49:44 katiska /kernel: mcd0: timeout getting status Dec 17 19:49:44 katiska /kernel: mcd0 not found at 0x300 Dec 17 19:49:44 katiska /kernel: npx0 on motherboard Dec 17 19:49:44 katiska /kernel: npx0: INT 16 interface Dec 17 19:49:44 katiska /kernel: matcdc0 not found at 0xffffffff Dec 17 19:49:44 katiska /kernel: matcdc1 not found at 0xffffffff Dec 17 19:49:44 katiska /kernel: matcdc2 not found at 0xffffffff Dec 17 19:49:44 katiska /kernel: matcdc3 not found at 0xffffffff Dec 17 19:49:44 katiska /kernel: Probing for devices on the PCI bus: Dec 17 19:49:45 katiska /kernel: chip0 rev 17 on pci0:0 Dec 17 19:49:45 katiska /kernel: chip1 rev 67 on pci0:2 Dec 17 19:49:45 katiska /kernel: ncr0 rev 2 int a irq 9 on pci0:12 Dec 17 19:49:45 katiska /kernel: ncr0 waiting for scsi devices to settle Dec 17 19:49:45 katiska /kernel: (ncr0:0:0): "SEAGATE ST15230N 0298" type 0 fixed SCSI 2 Dec 17 19:49:45 katiska /kernel: sd0(ncr0:0:0): Direct-Access Dec 17 19:49:45 katiska /kernel: sd0(ncr0:0:0): FAST SCSI-2 100ns (10 Mb/sec) offset 8. Dec 17 19:49:45 katiska /kernel: 4095MB (8386733 512 byte sectors) Dec 17 19:49:45 katiska /kernel: sd0(ncr0:0:0): with 3992 cyls, 19 heads, and an average 110 sectors/track Dec 17 19:49:45 katiska /kernel: (ncr0:3:0): "SEAGATE ST31200N 9348" type 0 fixed SCSI 2 Dec 17 19:49:45 katiska /kernel: sd3(ncr0:3:0): Direct-Access Dec 17 19:49:45 katiska /kernel: sd3(ncr0:3:0): FAST SCSI-2 100ns (10 Mb/sec) offset 8. Dec 17 19:49:45 katiska /kernel: 1011MB (2072435 512 byte sectors) Dec 17 19:49:45 katiska /kernel: sd3(ncr0:3:0): with 2700 cyls, 9 heads, and an average 85 sectors/track Dec 17 19:49:45 katiska /kernel: (ncr0:4:0): "HP C1533A 9503" type 1 removable SCSI 2 Dec 17 19:49:45 katiska /kernel: st4(ncr0:4:0): Sequential-Access Dec 17 19:49:45 katiska /kernel: st4(ncr0:4:0): FAST SCSI-2 100ns (10 Mb/sec) offset 8. Dec 17 19:49:45 katiska /kernel: density code 0x24, variable blocks, write-enabled Dec 17 19:49:45 katiska /kernel: ncr1 rev 1 int a irq 9 on pci0:14 Dec 17 19:49:46 katiska /kernel: ncr1 waiting for scsi devices to settle Dec 17 19:49:46 katiska /kernel: (ncr1:3:0): "SEAGATE ST15230N 0168" type 0 fixed SCSI 2 Dec 17 19:49:46 katiska /kernel: sd7(ncr1:3:0): Direct-Access Dec 17 19:49:46 katiska /kernel: sd7(ncr1:3:0): FAST SCSI-2 100ns (10 Mb/sec) offset 8. Dec 17 19:49:46 katiska /kernel: 4095MB (8386733 512 byte sectors) Dec 17 19:49:46 katiska /kernel: sd7(ncr1:3:0): with 3992 cyls, 19 heads, and an average 110 sectors/track Dec 17 19:49:46 katiska /kernel: changing root device to sd0a Dec 17 19:49:46 katiska /kernel: new masks: bio c0000240, tty c00300ba, net c00300ba Dec 17 19:49:46 katiska /kernel: WARNING: / was not properly dismounted. >Description: System becomes very sluggish and vmstat output shows up odd things: procs memory page disks faults cpu r b w avm fre flt re pi po fr sr f0 s0 s3 s7 in sy cs us sy id 6 2 0623128 1120 9824 6 4 5 103 1159 0 22 13 73 601 1651 371 22 36 42 8 7 0630380 2520 455 18 26 65 123 12056 0 6016 5760 256 760 844 501 0 0 0 6 1 0617616 1672 310 17 28 37 82 7180 0 5248 3712 384 627 599 436 0 0 0 1 3 0622408 964 396 7 90 0 201 0 0 8448 2688 640 546 698 397 0 0 0 7 341613984 988 419 3 51 48 121 50088 0 8960 2816 256 846 8529 309 0 0 0 81045629340 3628 750 3 51 33 868 70934 0 13184 5248 2944 1013 9169 594 0 0 0 4 637616900 5868 397 16 54 87 85 78090 0 13184 4992 1664 601 3998 334 0 0 0 6 431626244 7160 597 136 35 138 37 75381 0 13824 7424 384 638 1209 371 0 0 0 12 529626244 7788 321 23 26 160 10 59704 0 16000 7552 0 668 429 324 0 0 0 6 623609280 8072 565 32 41 124 278 41032 0 14592 6272 384 759 3293 494 0 0 0 systat fails with The alternate system clock has died! Reverting to ``pigs'' display. when I try to get vmstat display. I noticed the following messages earlier in messages, but I don't know whether these are the reason for the failure. Dec 18 12:03:55 katiska /kernel: sd7(ncr1:3:0): MEDIUM ERROR info:d0de6 asc:11,0 Unrecovered read error field replaceable unit: d0 sks:80,29 Dec 18 12:03:55 katiska /kernel: , retries:4 Dec 18 12:03:58 katiska /kernel: sd7(ncr1:3:0): MEDIUM ERROR info:d0de6 asc:11,0 Unrecovered read error field replaceable unit: d0 sks:80,29 Dec 18 12:03:58 katiska /kernel: , retries:3 Dec 18 12:04:00 katiska /kernel: sd7(ncr1:3:0): MEDIUM ERROR info:d0de6 asc:11,0 Unrecovered read error field replaceable unit: d0 sks:80,29 Dec 18 12:04:00 katiska /kernel: , retries:2 Dec 18 12:04:02 katiska /kernel: sd7(ncr1:3:0): MEDIUM ERROR info:d0de6 asc:11,0 Unrecovered read error field replaceable unit: d0 sks:80,29 Dec 18 12:04:02 katiska /kernel: , retries:1 Dec 18 12:04:05 katiska /kernel: sd7(ncr1:3:0): MEDIUM ERROR info:d0de6 asc:11,0 Unrecovered read error field replaceable unit: d0 sks:80,29 Dec 18 12:04:05 katiska /kernel: , FAILURE Dec 18 12:04:07 katiska /kernel: sd7(ncr1:3:0): VOLUME OVERFLOW ILI (length mismatch): -555827027 csi:de,c0,ad,de asc:de,c0 Vendor Specific ASC field replaceable unit: ad sks:de,3 Dec 18 12:04:07 katiska /kernel: , retries:4 Dec 18 12:04:09 katiska /kernel: sd7(ncr1:3:0): VOLUME OVERFLOW ILI (length mismatch): -555827027 csi:de,c0,ad,de asc:de,c0 Vendor Specific ASC field replaceable unit: ad sks:de,3 Dec 18 12:04:09 katiska /kernel: , retries:3 Dec 18 12:04:11 katiska /kernel: sd7(ncr1:3:0): VOLUME OVERFLOW ILI (length mismatch): -555827027 csi:de,c0,ad,de asc:de,c0 Vendor Specific ASC field replaceable unit: ad sks:de,3 Dec 18 12:04:12 katiska /kernel: , retries:2 Dec 18 12:04:14 katiska /kernel: sd7(ncr1:3:0): VOLUME OVERFLOW ILI (length mismatch): -555827027 csi:de,c0,ad,de asc:de,c0 Vendor Specific ASC field replaceable unit: ad sks:de,3 Dec 18 12:04:14 katiska /kernel: , retries:1 Dec 18 12:04:16 katiska /kernel: sd7(ncr1:3:0): VOLUME OVERFLOW ILI (length mismatch): -555827027 csi:de,c0,ad,de asc:de,c0 Vendor Specific ASC field replaceable unit: ad sks:de,3 Dec 18 12:04:16 katiska /kernel: , FAILURE The disk in question does not seem to do anything odd, it works. >How-To-Repeat: >Fix: >Release-Note: >Audit-Trail: From: Bruce Evans To: FreeBSD-gnats-submit@FreeBSD.org, hsu@clinet.fi Cc: Subject: Re: kern/902: "The alternate system clock has died" Date: Tue, 19 Dec 1995 09:17:53 +1100 >kernel is -current from November 26th. This could have been fixed, but I >haven't been able to get a stable snapshot out of -current yet to see if it >is. This should have been fixed on Nov 20 in rev.1.57 of isa.c. Bruce State-Changed-From-To: open->closed State-Changed-By: scrappy State-Changed-When: Wed Apr 10 11:10:34 PDT 1996 State-Changed-Why: Originator confirms that this is no longer a problem >Unformatted: