From owner-freebsd-current@FreeBSD.ORG Fri Sep 7 15:38:06 2007 Return-Path: Delivered-To: current@FreeBSD.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:4f8:fff6::34]) by hub.freebsd.org (Postfix) with ESMTP id 9D9B516A41B for ; Fri, 7 Sep 2007 15:38:06 +0000 (UTC) (envelope-from marck@rinet.ru) Received: from woozle.rinet.ru (woozle.rinet.ru [195.54.192.68]) by mx1.freebsd.org (Postfix) with ESMTP id 320EC13C491 for ; Fri, 7 Sep 2007 15:38:04 +0000 (UTC) (envelope-from marck@rinet.ru) Received: from localhost (localhost [127.0.0.1]) by woozle.rinet.ru (8.14.1/8.14.1) with ESMTP id l87Fc3hC029835 for ; Fri, 7 Sep 2007 19:38:03 +0400 (MSD) (envelope-from marck@rinet.ru) Date: Fri, 7 Sep 2007 19:38:03 +0400 (MSD) From: Dmitry Morozovsky To: current@FreeBSD.org Message-ID: <20070907192152.V98273@woozle.rinet.ru> X-NCC-RegID: ru.rinet X-OpenPGP-Key-ID: 6B691B03 MIME-Version: 1.0 Content-Type: TEXT/PLAIN; charset=US-ASCII X-Greylist: Sender IP whitelisted, not delayed by milter-greylist-3.0 (woozle.rinet.ru [0.0.0.0]); Fri, 07 Sep 2007 19:38:03 +0400 (MSD) Cc: Subject: Possible 7.0 showstopper: SATA/eSATA are unable to init hot-plugs X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.5 Precedence: list List-Id: Discussions about the use of FreeBSD-current List-Unsubscribe: , List-Archive: List-Post: List-Help: List-Subscribe: , X-List-Received-Date: Fri, 07 Sep 2007 15:38:06 -0000 Dear colleagues, on most (possibly all, but I'm not fully sure and a bit limited in testing) motherboard/controller configuration I've tested so far -current is unable to properly attach hot-plugged disks. Sometimes even atacontrol detach/atacontrol attach sequence can't bring disk into working state (only reboot does). One example (today's current/amd64, verbose boot): [attach on the fly to eSATA port] Sep 7 16:56:08 hamster kernel: ata7: CONNECT requested Sep 7 16:56:08 hamster kernel: ata7: CONNECTED Sep 7 16:56:08 hamster kernel: ata7: SATA connect time=0ms Sep 7 16:56:08 hamster kernel: ata7: reset tp1 mask=00 ostat0=ff ostat1=00 Sep 7 16:56:24 hamster kernel: ata7: DISCONNECT requested Sep 7 16:56:24 hamster kernel: ata7: DISCONNECTED Sep 7 16:56:33 hamster kernel: ata7: CONNECT requested Sep 7 16:56:33 hamster kernel: ata7: CONNECTED Sep 7 16:56:33 hamster kernel: ata7: SATA connect time=0ms Sep 7 16:56:33 hamster kernel: ata7: reset tp1 mask=00 ostat0=ff ostat1=00 Sep 7 16:57:00 hamster kernel: ata7: SATA connect time=0ms Sep 7 16:57:00 hamster kernel: ata7: reset tp1 mask=01 ostat0=50 ostat1=00 Sep 7 16:57:00 hamster kernel: ata7: stat0=0x50 err=0x01 lsb=0x00 msb=0x00 Sep 7 16:57:00 hamster kernel: ata7: reset tp2 stat0=50 stat1=00 devices=0x1 Sep 7 16:57:00 hamster kernel: ata7: [MPSAFE] Sep 7 16:57:00 hamster kernel: ata7: [ITHREAD] Sep 7 16:57:34 hamster kernel: ata7: reiniting channel .. Sep 7 16:57:34 hamster kernel: ata7: SATA connect time=0ms Sep 7 16:57:34 hamster kernel: ata7: reset tp1 mask=01 ostat0=58 ostat1=00 Sep 7 16:57:34 hamster kernel: ata7: stat0=0xd8 err=0x00 lsb=0x00 msb=0x00 Sep 7 16:57:34 hamster last message repeated 232 times Sep 7 16:57:34 hamster kernel: ata7: stat0=0xd8 err=0x00 lsb=0x00 msb=0x00 Sep 7 16:57:34 hamster last message repeated 76 times Sep 7 16:57:34 hamster kernel: ata7: reset tp2 stat0=d8 stat1=00 devices=0x0 Sep 7 16:57:34 hamster kernel: ata7: reinit done .. Sep 7 16:57:34 hamster kernel: unknown: timeout waiting to issue command Sep 7 16:57:34 hamster kernel: unknown: error issuing ATA_IDENTIFY command Sep 7 16:58:14 hamster kernel: ata7: SATA connect time=0ms Sep 7 16:58:14 hamster kernel: ata7: reset tp1 mask=01 ostat0=d8 ostat1=00 Sep 7 16:58:14 hamster kernel: ata7: stat0=0xd8 err=0x00 lsb=0x00 msb=0x00 Sep 7 16:58:14 hamster last message repeated 309 times Sep 7 16:58:14 hamster kernel: ata7: reset tp2 stat0=d8 stat1=00 devices=0x0 Sep 7 16:58:14 hamster kernel: ata7: [MPSAFE] Sep 7 16:58:14 hamster kernel: ata7: [ITHREAD] Sep 7 17:08:02 hamster kernel: ata7: DISCONNECT requested Sep 7 17:08:02 hamster kernel: ata7: DISCONNECTED Sep 7 17:08:28 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:08:28 hamster kernel: ata7: reset tp1 mask=00 ostat0=ff ostat1=00 Sep 7 17:08:28 hamster kernel: ata7: [MPSAFE] Sep 7 17:08:28 hamster kernel: ata7: [ITHREAD] Sep 7 17:08:36 hamster kernel: ata7: reiniting channel .. Sep 7 17:08:36 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:08:36 hamster kernel: ata7: reset tp1 mask=00 ostat0=ff ostat1=00 Sep 7 17:08:36 hamster kernel: ata7: reinit done .. Sep 7 17:08:42 hamster kernel: ata7: DISCONNECT requested Sep 7 17:08:42 hamster kernel: ata7: DISCONNECTED Sep 7 17:08:46 hamster kernel: ata7: CONNECT requested Sep 7 17:08:46 hamster kernel: ata7: CONNECTED Sep 7 17:08:46 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:08:46 hamster kernel: ata7: reset tp1 mask=00 ostat0=ff ostat1=00 [reboot] Sep 7 17:13:27 hamster kernel: atapci3: port 0xa800-0xa87f,0xa400-0xa4ff mem 0xfdffe000-0xfdffefff,0xfdfc0000-0xfdfdffff irq 16 at device 7.0 on pci1 Sep 7 17:13:27 hamster kernel: pci1: child atapci3 requested type 4 for rid 0x20, but the BAR says it is an memio Sep 7 17:13:27 hamster kernel: ioapic0: routing intpin 16 (PCI IRQ 16) to vector 53 Sep 7 17:13:27 hamster kernel: atapci3: [MPSAFE] Sep 7 17:13:27 hamster kernel: atapci3: [ITHREAD] Sep 7 17:13:27 hamster kernel: atapci3: Reserved 0x20000 bytes for rid 0x20 type 3 at 0xfdfc0000 Sep 7 17:13:27 hamster kernel: atapci3: Reserved 0x1000 bytes for rid 0x1c type 3 at 0xfdffe000 Sep 7 17:13:27 hamster kernel: ioapic0: routing intpin 16 (PCI IRQ 16) to vector 53 Sep 7 17:13:27 hamster kernel: atapci3: [MPSAFE] Sep 7 17:13:27 hamster kernel: atapci3: [ITHREAD] Sep 7 17:13:27 hamster kernel: ata7: on atapci3 Sep 7 17:13:27 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:13:27 hamster kernel: ata7: reset tp1 mask=01 ostat0=50 ostat1=00 Sep 7 17:13:27 hamster kernel: ata7: stat0=0x50 err=0x01 lsb=0x00 msb=0x00 Sep 7 17:13:27 hamster kernel: ata7: reset tp2 stat0=50 stat1=00 devices=0x1 Sep 7 17:13:27 hamster kernel: ata7: [MPSAFE] Sep 7 17:13:27 hamster kernel: ata7: [ITHREAD] Sep 7 17:13:27 hamster kernel: ata7-master: pio=PIO4 wdma=WDMA2 udma=UDMA133 cable=40 wire Sep 7 17:13:27 hamster kernel: ad14: 381554MB at ata7-master SATA150 Sep 7 17:13:27 hamster kernel: ad14: 781422768 sectors [775221C/16H/63S] 16 sectors/interrupt 1 depth queue Sep 7 17:13:27 hamster kernel: GEOM: new disk ad14 Sep 7 17:16:35 hamster kernel: ad14: detached Sep 7 17:16:40 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:16:40 hamster kernel: ata7: reset tp1 mask=01 ostat0=50 ostat1=00 Sep 7 17:16:40 hamster kernel: ata7: stat0=0x50 err=0x01 lsb=0x00 msb=0x00 Sep 7 17:16:40 hamster kernel: ata7: reset tp2 stat0=50 stat1=00 devices=0x1 Sep 7 17:16:40 hamster kernel: ata7: [MPSAFE] Sep 7 17:16:40 hamster kernel: ata7: [ITHREAD] Sep 7 17:17:14 hamster kernel: ata7: reiniting channel .. Sep 7 17:17:14 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:17:14 hamster kernel: ata7: reset tp1 mask=01 ostat0=58 ostat1=00 Sep 7 17:17:14 hamster kernel: ata7: stat0=0xd8 err=0x00 lsb=0x00 msb=0x00 Sep 7 17:17:14 hamster kernel: ata7: reset tp2 stat0=d8 stat1=00 devices=0x0 Sep 7 17:17:14 hamster kernel: ata7: reinit done .. Sep 7 17:22:27 hamster kernel: ata7: reiniting channel .. Sep 7 17:22:27 hamster kernel: ata7: SATA connect time=0ms Sep 7 17:22:27 hamster kernel: ata7: reset tp1 mask=01 ostat0=d8 ostat1=00 Sep 7 17:22:27 hamster kernel: ata7: stat0=0xd8 err=0x00 lsb=0x00 msb=0x00 Sep 7 17:22:27 hamster kernel: ata7: reset tp2 stat0=d8 stat1=00 devices=0x0 Sep 7 17:22:27 hamster kernel: ata7: reinit done .. RELENG_6 usually does attach successfully (can't check right now, but hopefully will do this weekend). Any hints? Sincerely, D.Marck [DM5020, MCK-RIPE, DM3-RIPN] [ FreeBSD committer: marck@FreeBSD.org ] ------------------------------------------------------------------------ *** Dmitry Morozovsky --- D.Marck --- Wild Woozle --- marck@rinet.ru *** ------------------------------------------------------------------------