From owner-freebsd-current Mon Aug 28 5: 5:46 2000 Delivered-To: freebsd-current@freebsd.org Received: from knight.cons.org (knight.cons.org [194.233.237.86]) by hub.freebsd.org (Postfix) with ESMTP id D705E37B423 for ; Mon, 28 Aug 2000 05:05:25 -0700 (PDT) Received: (from cracauer@localhost) by knight.cons.org (8.9.3/8.9.3) id OAA15476 for current@freebsd.org; Mon, 28 Aug 2000 14:05:23 +0200 (CEST) Date: Mon, 28 Aug 2000 14:05:23 +0200 From: Martin Cracauer To: current@freebsd.org Subject: Re: vn broken? Message-ID: <20000828140522.A15442@cons.org> References: <20000828135346.A15059@cons.org> Mime-Version: 1.0 Content-Type: text/plain; charset=us-ascii X-Mailer: Mutt 1.0.1i In-Reply-To: <20000828135346.A15059@cons.org>; from cracauer@cons.org on Mon, Aug 28, 2000 at 01:53:46PM +0200 Sender: owner-freebsd-current@FreeBSD.ORG Precedence: bulk X-Loop: FreeBSD.ORG I should haven mentioned that this is a SMP machine (i440BX P-III 550 dual) and is running vmware. > -current from Aug, 22, cd9660 image file mounted via vn reports this: > > Aug 28 13:45:51 counter /kernel: unexpected vn driver lock: 0xccf008c0: type VREG, usecount 2, writecount 1, refcount 452, flags (VOBJBUF) > Aug 28 13:45:51 counter /kernel: tag VT_UFS, ino 357635, on dev #da/6 (13, 6) lock type inode: EXCL (count 1) by pid 5 > > This happens when multiple parallel things are done to the iso > filesystem inside the vnode, i.e.:[...] dmesg: Copyright (c) 1992-2000 The FreeBSD Project. Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994 The Regents of the University of California. All rights reserved. FreeBSD 5.0-CURRENT #0: Tue Aug 22 12:47:31 MEST 2000 cracauer@counter.bik-gmbh.de:/usr/src/sys/compile/COUNTER Timecounter "i8254" frequency 1193182 Hz CPU: Pentium III/Pentium III Xeon/Celeron (551.25-MHz 686-class CPU) Origin = "GenuineIntel" Id = 0x673 Stepping = 3 Features=0x383fbff real memory = 268423168 (262132K bytes) avail memory = 257658880 (251620K bytes) Programming 24 pins in IOAPIC #0 IOAPIC #0 intpin 2 -> irq 0 IOAPIC #0 intpin 16 -> irq 11 IOAPIC #0 intpin 18 -> irq 10 IOAPIC #0 intpin 19 -> irq 12 FreeBSD/SMP: Multiprocessor motherboard cpu0 (BSP): apic id: 1, version: 0x00040011, at 0xfee00000 cpu1 (AP): apic id: 0, version: 0x00040011, at 0xfee00000 io0 (APIC): apic id: 2, version: 0x00170011, at 0xfec00000 Preloaded elf kernel "kernel" at 0xc0396000. ccd0-3: Concatenated disk drivers Pentium Pro MTRR support enabled VESA: v2.0, 32768k memory, flags:0x1, mode table:0xc00c6974 (c0006974) VESA: Matrox Graphics Inc. md0: Malloc disk apm0: on motherboard apm0: found APM BIOS v1.2, connected at v1.2 npx0: on motherboard npx0: INT 16 interface pcib0: on motherboard pci0: on pcib0 pci0: at 0.0 pcib1: at device 1.0 on pci0 pci1: on pcib1 pci1: at 0.0 irq 11 isab0: at device 4.0 on pci0 isa0: on isab0 pci0: at 4.1 pci0: at 4.2 irq 12 intpm0: port 0xe800-0xe80f irq 9 at device 4.3 on pci0 intpm0: I/O mapped e800 intpm0: intr IRQ 9 enabled revision 0 smbus0: on intsmb0 smb0: on smbus0 intpm0: PM I/O mapped e400 ahc0: port 0xd000-0xd0ff mem 0xe0000000-0xe0000fff irq 12 at device 6.0 on pci0 ahc0: aic7890/91 Wide Channel A, SCSI Id=7, 32/255 SCBs fxp0: port 0xb800-0xb83f mem 0xdf000000-0xdf0fffff,0xdf800000-0xdf800fff irq 12 at device 9.0 on pci0 fxp0: Ethernet address 00:d0:b7:92:4e:cc ahc1: port 0xb400-0xb4ff mem 0xde800000-0xde800fff irq 10 at device 10.0 on pci0 ahc1: aic7870 Single Channel A, SCSI Id=7, 16/255 SCBs isa0: too many memory ranges fdc0: at port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on isa0 fdc0: FIFO enabled, 8 bytes threshold atkbdc0: at port 0x60,0x64 on isa0 atkbd0: flags 0x1 irq 1 on atkbdc0 kbd0 at atkbd0 vga0: at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0 sc0: at flags 0x100 on isa0 sc0: VGA <16 virtual consoles, flags=0x300> sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0 sio0: type 16550A sio1 at port 0x2f8-0x2ff irq 3 on isa0 sio1: type 16550A ppc0: at port 0x378-0x37f irq 7 on isa0 ppc0: SMC-like chipset (ECP/EPP/PS2/NIBBLE) in COMPATIBLE mode ppc0: FIFO with 16/16/9 bytes threshold plip0: on ppbus0 lpt0: on ppbus0 lpt0: Interrupt-driven port ppi0: on ppbus0 unknown: can't assign resources unknown: can't assign resources unknown: can't assign resources unknown: can't assign resources unknown: can't assign resources unknown: can't assign resources APIC_IO: Testing 8254 interrupt delivery APIC_IO: routing 8254 via IOAPIC #0 intpin 2 SMP: AP CPU #1 Launched! Mounting root from ufs:/dev/da0a da0 at ahc0 bus 0 target 1 lun 0 da0: Fixed Direct Access SCSI-3 device da0: 80.000MB/s transfers (40.000MHz, offset 31, 16bit) da0: 35003MB (71687340 512 byte sectors: 255H 63S/T 4462C) WARNING: / was not properly dismounted cd0 at ahc1 bus 0 target 4 lun 0 cd0: Removable CD-ROM SCSI-2 device cd0: 5.000MB/s transfers (5.000MHz, offset 8) cd0: cd present [352862 x 2048 byte records] /dev/vmmon: Module vmmon: registered with major=200 minor=0 tag=$Name: build-570 $ /dev/vmmon: Module vmmon: initialized (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error /dev/vmmon: Vmx86_DestroyVM: unlocked pages: 11716, unlocked dirty pages: 11665 [more cd error of the same kind deleted] (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present /dev/vmmon: Vmx86_DestroyVM: unlocked pages: 3517994, unlocked dirty pages: 1967598 (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error sa0 at ahc1 bus 0 target 2 lun 0 sa0: Removable Sequential Access SCSI-2 device sa0: 8.064MB/s transfers (8.064MHz, offset 15) sa1 at ahc1 bus 0 target 3 lun 0 sa1: Removable Sequential Access SCSI-2 device sa1: 8.064MB/s transfers (8.064MHz, offset 8) cd1 at ahc1 bus 0 target 6 lun 0 cd1: Removable CD-ROM SCSI-2 device cd1: 3.300MB/s transfers cd1: cd present [1 x 2048 byte records] cd9660: RockRidge Extension /dev/vmmon: Vmx86_DestroyVM: unlocked pages: 1111976, unlocked dirty pages: 696805 (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error /dev/vmmon: Vmx86_DestroyVM: unlocked pages: 462622, unlocked dirty pages: 303701 (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error /dev/vmmon: Vmx86_DestroyVM: unlocked pages: 372415, unlocked dirty pages: 249684 (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error /dev/vmmon: Vmx86_DestroyVM: unlocked pages: 135922, unlocked dirty pages: 73338 (cd0:ahc1:0:4:0): PAUSE/RESUME. CDB: 4b 0 0 0 0 0 0 0 0 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:2c,0 (cd0:ahc1:0:4:0): Command sequence error (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present pid 79277 (tosha), uid 0: exited on signal 11 (core dumped) pid 79278 (tosha), uid 0: exited on signal 11 (core dumped) pid 79719 (tosha), uid 0: exited on signal 11 (core dumped) (cd0:ahc1:0:4:0): READ(10). CDB: 28 0 0 3 93 20 0 0 20 0 (cd0:ahc1:0:4:0): ILLEGAL REQUEST asc:21,0 (cd0:ahc1:0:4:0): Logical block address out of range (cd0:ahc1:0:4:0): cddone: got error 0x16 back cd9660: Joliet Extension unexpected vn driver lock: 0xccf008c0: type VREG, usecount 2, writecount 1, refcount 227, flags (VOBJBUF) tag VT_UFS, ino 357635, on dev #da/6 (13, 6) lock type inode: EXCL (count 1) by pid 5 (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present (cd0:ahc1:0:4:0): READ SUB-CHANNEL. CDB: 42 0 40 1 0 0 0 0 18 0 (cd0:ahc1:0:4:0): NOT READY asc:3a,0 (cd0:ahc1:0:4:0): Medium not present unexpected vn driver lock: 0xccf008c0: type VREG, usecount 2, writecount 1, refcount 452, flags (VOBJBUF) tag VT_UFS, ino 357635, on dev #da/6 (13, 6) lock type inode: EXCL (count 1) by pid 5 unexpected vn driver lock: 0xccf008c0: type VREG, usecount 2, writecount 1, refcount 740, flags (VOBJBUF) tag VT_UFS, ino 357635, on dev #da/6 (13, 6) lock type inode: EXCL (count 1) by pid 82130 unexpected vn driver lock: 0xccf008c0: type VREG, usecount 2, writecount 1, refcount 731, flags (VOBJBUF) tag VT_UFS, ino 357635, on dev #da/6 (13, 6) lock type inode: EXCL (count 1) by pid 82131 [truncated] Martin -- %%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%%% Martin Cracauer http://www.cons.org/cracauer/ BSD User Group Hamburg, Germany http://www.bsdhh.org/ To Unsubscribe: send mail to majordomo@FreeBSD.org with "unsubscribe freebsd-current" in the body of the message