Skip site navigation (1)Skip section navigation (2)
Date:      Sat, 30 Oct 2004 16:28:26 +0300 (EEST)
From:      Heikki Suonsivu <hsu@bbnetworks.net>
To:        FreeBSD-gnats-submit@FreeBSD.org
Subject:   kern/73313: Maxtor Onetouch drivers hang when used with firewire.
Message-ID:  <200410301328.i9UDSQod067234@hsu.bbnetworks.net>
Resent-Message-ID: <200410301330.i9UDUIrE042663@freefall.freebsd.org>

next in thread | raw e-mail | index | archive | help

>Number:         73313
>Category:       kern
>Synopsis:       Maxtor Onetouch drivers hang when used with firewire.
>Confidential:   no
>Severity:       serious
>Priority:       medium
>Responsible:    freebsd-bugs
>State:          open
>Quarter:        
>Keywords:       
>Date-Required:
>Class:          sw-bug
>Submitter-Id:   current-users
>Arrival-Date:   Sat Oct 30 13:30:17 GMT 2004
>Closed-Date:
>Last-Modified:
>Originator:     Heikki Suonsivu
>Release:        FreeBSD 4.10-STABLE i386
>Organization:
bbnetworks.net
>Environment:

System: FreeBSD hsu.bbnetworks.net 4.10-STABLE FreeBSD 4.10-STABLE #14: Mon Sep 27 15:32:20 EEST 2004 hsu@hsu.bbnetworks.net:/usr/obj/usr/src/sys/CAT i386

Three Maxtor Onetouch 300G external disks with firewire. 

Oct  4 14:03:32 hsu /kernel: Copyright (c) 1992-2004 The FreeBSD Project.
Oct  4 14:03:32 hsu /kernel: Copyright (c) 1979, 1980, 1983, 1986, 1988, 1989, 1991, 1992, 1993, 1994
Oct  4 14:03:32 hsu /kernel: The Regents of the University of California. All rights reserved.
Oct  4 14:03:32 hsu /kernel: FreeBSD 4.10-STABLE #14: Mon Sep 27 15:32:20 EEST 2004
Oct  4 14:03:32 hsu /kernel: hsu@hsu.bbnetworks.net:/usr/obj/usr/src/sys/CAT
Oct  4 14:03:32 hsu /kernel: Timecounter "i8254"  frequency 1193182 Hz
Oct  4 14:03:32 hsu /kernel: Timecounter "TSC"  frequency 548738652 Hz
Oct  4 14:03:32 hsu /kernel: CPU: Pentium III/Pentium III Xeon/Celeron (548.74-MHz 686-class CPU)
Oct  4 14:03:32 hsu /kernel: Origin = "GenuineIntel"  Id = 0x673  Stepping = 3
Oct  4 14:03:32 hsu /kernel: Features=0x383f9ff<FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,MMX,FXSR,SSE>
Oct  4 14:03:32 hsu /kernel: real memory  = 536858624 (524276K bytes)
Oct  4 14:03:32 hsu /kernel: avail memory = 517386240 (505260K bytes)
Oct  4 14:03:32 hsu /kernel: Preloaded elf kernel "kernel" at 0xc0517000.
Oct  4 14:03:32 hsu /kernel: ccd0-3: Concatenated disk drivers
Oct  4 14:03:32 hsu /kernel: Pentium Pro MTRR support enabled
Oct  4 14:03:32 hsu /kernel: md0: Malloc disk
Oct  4 14:03:32 hsu /kernel: Using $PIR table, 9 entries at 0xc00fdf30
Oct  4 14:03:32 hsu /kernel: npx0: <math processor> on motherboard
Oct  4 14:03:32 hsu /kernel: npx0: INT 16 interface
Oct  4 14:03:32 hsu /kernel: pcib0: <Intel 82443BX (440 BX) host to PCI bridge> on motherboard
Oct  4 14:03:32 hsu /kernel: pci0: <PCI bus> on pcib0
Oct  4 14:03:32 hsu /kernel: pcib1: <Intel 82443BX (440 BX) PCI-PCI (AGP) bridge> at device 1.0 on pci0
Oct  4 14:03:32 hsu /kernel: pci1: <PCI bus> on pcib1
Oct  4 14:03:32 hsu /kernel: pci1: <Matrox MGA G550 AGP graphics accelerator> at 0.0 irq 11
Oct  4 14:03:32 hsu /kernel: isab0: <Intel 82371AB PCI to ISA bridge> at device 7.0 on pci0
Oct  4 14:03:32 hsu /kernel: isa0: <ISA bus> on isab0
Oct  4 14:03:32 hsu /kernel: atapci0: <Intel PIIX4 ATA33 controller> port 0x14a0-0x14af at device 7.1 on pci0
Oct  4 14:03:32 hsu /kernel: ata0: at 0x1f0 irq 14 on atapci0
Oct  4 14:03:32 hsu /kernel: ata1: at 0x170 irq 15 on atapci0
Oct  4 14:03:32 hsu /kernel: uhci0: <Intel 82371AB/EB (PIIX4) USB controller> port 0x1480-0x149f irq 9 at device 7.2 on pci0
Oct  4 14:03:32 hsu /kernel: usb0: <Intel 82371AB/EB (PIIX4) USB controller> on uhci0
Oct  4 14:03:32 hsu /kernel: usb0: USB revision 1.0
Oct  4 14:03:32 hsu /kernel: uhub0: Intel UHCI root hub, class 9/0, rev 1.00/1.00, addr 1
Oct  4 14:03:32 hsu /kernel: uhub0: 2 ports with 2 removable, self powered
Oct  4 14:03:32 hsu /kernel: ums0: Logitech USB Receiver, rev 1.10/23.02, addr 2, iclass 3/1
Oct  4 14:03:32 hsu /kernel: ums0: 7 buttons and Z dir.
Oct  4 14:03:32 hsu /kernel: uhub1: Genesys Logic USB Hub, class 9/0, rev 1.01/0.12, addr 3
Oct  4 14:03:32 hsu /kernel: uhub1: 4 ports with 4 removable, self powered
Oct  4 14:03:32 hsu /kernel: chip1: <Intel 82371AB Power management controller> port 0x7000-0x700f at device 7.3 on pci0
Oct  4 14:03:32 hsu /kernel: pcm0: <Yamaha DS-1E (YMF740C)> mem 0xf4000000-0xf4007fff irq 10 at device 12.0 on pci0
Oct  4 14:03:32 hsu /kernel: pcm0: <Analog Devices AD1819 AC97 Codec>
Oct  4 14:03:32 hsu /kernel: de0: <Digital 21140A Fast Ethernet> port 0x1400-0x147f mem 0xf4010800-0xf401087f irq 11 at device 13.0 on pci0
Oct  4 14:03:32 hsu /kernel: de0: 21140A [10-100Mb/s] pass 2.2
Oct  4 14:03:32 hsu /kernel: de0: address 00:80:c8:f6:95:45
Oct  4 14:03:32 hsu /kernel: atapci1: <Promise TX2 ATA133 controller> port 0x14b0-0x14bf,0x14c0-0x14c3,0x14c8-0x14cf,0x14c4-0x14c7,0x14d0-0x14d7 mem 0xf4008000-0xf400bfff irq 5 at device 14.0 on pci0
Oct  4 14:03:32 hsu /kernel: ata2: at 0x14d0 on atapci1
Oct  4 14:03:32 hsu /kernel: ata3: at 0x14c8 on atapci1
Oct  4 14:03:32 hsu /kernel: ahc0: <Adaptec 2940 SCSI adapter> port 0x1000-0x10ff mem 0xf400c000-0xf400cfff irq 10 at device 15.0 on pci0
Oct  4 14:03:32 hsu /kernel: aic7870: Single Channel A, SCSI Id=7, 16/253 SCBs
Oct  4 14:03:32 hsu /kernel: ohci0: <AcerLabs M5237 (Aladdin-V) USB controller> mem 0xf400d000-0xf400dfff irq 11 at device 16.0 on pci0
Oct  4 14:03:32 hsu /kernel: usb1: OHCI version 1.0, legacy support
Oct  4 14:03:32 hsu /kernel: usb1: <AcerLabs M5237 (Aladdin-V) USB controller> on ohci0
Oct  4 14:03:32 hsu /kernel: usb1: USB revision 1.0
Oct  4 14:03:32 hsu /kernel: uhub2: AcerLabs OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
Oct  4 14:03:32 hsu /kernel: uhub2: 2 ports with 2 removable, self powered
Oct  4 14:03:32 hsu /kernel: ohci1: <AcerLabs M5237 (Aladdin-V) USB controller> mem 0xf400e000-0xf400efff irq 11 at device 16.1 on pci0
Oct  4 14:03:32 hsu /kernel: usb2: OHCI version 1.0, legacy support
Oct  4 14:03:32 hsu /kernel: usb2: <AcerLabs M5237 (Aladdin-V) USB controller> on ohci1
Oct  4 14:03:32 hsu /kernel: usb2: USB revision 1.0
Oct  4 14:03:32 hsu /kernel: uhub3: AcerLabs OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
Oct  4 14:03:32 hsu /kernel: uhub3: 2 ports with 2 removable, self powered
Oct  4 14:03:32 hsu /kernel: ohci2: <AcerLabs M5237 (Aladdin-V) USB controller> mem 0xf400f000-0xf400ffff irq 11 at device 16.2 on pci0
Oct  4 14:03:32 hsu /kernel: usb3: OHCI version 1.0, legacy support
Oct  4 14:03:32 hsu /kernel: usb3: <AcerLabs M5237 (Aladdin-V) USB controller> on ohci2
Oct  4 14:03:32 hsu /kernel: usb3: USB revision 1.0
Oct  4 14:03:32 hsu /kernel: uhub4: AcerLabs OHCI root hub, class 9/0, rev 1.00/1.00, addr 1
Oct  4 14:03:32 hsu /kernel: uhub4: 2 ports with 2 removable, self powered
Oct  4 14:03:32 hsu /kernel: ehci0: <EHCI (generic) USB 2.0 controller> mem 0xf4010c00-0xf4010cff irq 9 at device 16.3 on pci0
Oct  4 14:03:32 hsu /kernel: ehci_pci_attach: companion usb1
Oct  4 14:03:32 hsu /kernel: ehci_pci_attach: companion usb2
Oct  4 14:03:32 hsu /kernel: ehci_pci_attach: companion usb3
Oct  4 14:03:32 hsu /kernel: usb4: EHCI version 1.0
Oct  4 14:03:32 hsu /kernel: usb4: companion controllers, 2 ports each: usb1 usb2 usb3
Oct  4 14:03:32 hsu /kernel: usb4: <EHCI (generic) USB 2.0 controller> on ehci0
Oct  4 14:03:32 hsu /kernel: usb4: USB revision 2.0
Oct  4 14:03:32 hsu /kernel: uhub5: AcerLabs EHCI root hub, class 9/0, rev 2.00/1.00, addr 1
Oct  4 14:03:32 hsu /kernel: uhub5: 6 ports with 6 removable, self powered
Oct  4 14:03:32 hsu /kernel: fwohci0: vendor=10b9, dev=5253
Oct  4 14:03:32 hsu /kernel: fwohci0: <1394 Open Host Controller Interface> mem 0xf4010000-0xf40107ff irq 5 at device 16.4 on pci0
Oct  4 14:03:32 hsu /kernel: fwohci0: OHCI version 1.10 (ROM=1)
Oct  4 14:03:32 hsu /kernel: fwohci0: No. of Isochronous channel is 4.
Oct  4 14:03:32 hsu /kernel: fwohci0: EUI64 00:90:e6:00:00:00:02:d1
Oct  4 14:03:32 hsu /kernel: fwohci0: Phy 1394a available S400, 2 ports.
Oct  4 14:03:32 hsu /kernel: fwohci0: Link S400, max_rec 2048 bytes.
Oct  4 14:03:32 hsu /kernel: firewire0: <IEEE1394(FireWire) bus> on fwohci0
Oct  4 14:03:32 hsu /kernel: sbp0: <SBP-2/SCSI over FireWire> on firewire0
Oct  4 14:03:32 hsu /kernel: fwe0: <Ethernet over FireWire> on firewire0
Oct  4 14:03:32 hsu /kernel: if_fwe0: Fake Ethernet address: 02:90:e6:00:02:d1
Oct  4 14:03:32 hsu /kernel: fwohci0: Initiate bus reset
Oct  4 14:03:32 hsu /kernel: fwohci0: node_id=0xc800ffc2, gen=1, CYCLEMASTER mode
Oct  4 14:03:32 hsu /kernel: firewire0: 3 nodes, maxhop <= 2, cable IRM = 2 (me)
Oct  4 14:03:32 hsu /kernel: firewire0: bus manager 2 (me)
Oct  4 14:03:32 hsu /kernel: vt0 on isa0
Oct  4 14:03:32 hsu /kernel: vt0: generic, 80 col, color, 8 scr, mf2-kbd, [R3.20-b24]
Oct  4 14:03:32 hsu /kernel: vt0: driver is using old-style compatability shims
Oct  4 14:03:32 hsu /kernel: orm0: <Option ROMs> at iomem 0xc0000-0xc8fff,0xc9000-0xccfff,0xcd000-0xcf7ff,0xe0000-0xe3fff,0xe4000-0xeffff on isa0
Oct  4 14:03:32 hsu /kernel: pmtimer0 on isa0
Oct  4 14:03:32 hsu /kernel: atkbdc0: <Keyboard controller (i8042)> at port 0x60,0x64 on isa0
Oct  4 14:03:32 hsu /kernel: atkbd0: <AT Keyboard> irq 1 on atkbdc0
Oct  4 14:03:32 hsu /kernel: vga0: <Generic ISA VGA> at port 0x3c0-0x3df iomem 0xa0000-0xbffff on isa0
Oct  4 14:03:32 hsu /kernel: fdc0: <NEC 72065B or clone> at port 0x3f0-0x3f5,0x3f7 irq 6 drq 2 on isa0
Oct  4 14:03:32 hsu /kernel: fdc0: FIFO enabled, 8 bytes threshold
Oct  4 14:03:32 hsu /kernel: fd0: <1440-KB 3.5" drive> on fdc0 drive 0
Oct  4 14:03:32 hsu /kernel: sio0 at port 0x3f8-0x3ff irq 4 flags 0x10 on isa0
Oct  4 14:03:32 hsu /kernel: sio0: type 16550A
Oct  4 14:03:32 hsu /kernel: sio1 at port 0x2f8-0x2ff irq 3 on isa0
Oct  4 14:03:32 hsu /kernel: sio1: type 16550A
Oct  4 14:03:32 hsu /kernel: pca0 at port 0x40 on isa0
Oct  4 14:03:32 hsu /kernel: joy0 at port 0x201 on isa0
Oct  4 14:03:32 hsu /kernel: ppc0: <Parallel port> at port 0x378-0x37f irq 7 on isa0
Oct  4 14:03:32 hsu /kernel: ppc0: Generic chipset (EPP/NIBBLE) in COMPATIBLE mode
Oct  4 14:03:32 hsu /kernel: lpt0: <Printer> on ppbus0
Oct  4 14:03:32 hsu /kernel: lpt0: Interrupt-driven port
Oct  4 14:03:32 hsu /kernel: IP packet filtering initialized, divert enabled, rule-based forwarding enabled, default to accept, logging limited to 10000 packets/entry by default
Oct  4 14:03:32 hsu /kernel: DUMMYNET initialized (011031)
Oct  4 14:03:32 hsu /kernel: IPv6 packet filtering initialized, default to accept, logging limited to 10000 packets/entry
Oct  4 14:03:32 hsu /kernel: IPsec: Initialized Security Association Processing.
Oct  4 14:03:32 hsu /kernel: ad0: 76319MB <MAXTOR 4K080H4> [155061/16/63] at ata0-master UDMA33
Oct  4 14:03:32 hsu /kernel: ad1: 117246MB <Maxtor 4G120J6> [238216/16/63] at ata0-slave UDMA33
Oct  4 14:03:32 hsu /kernel: ad2: 239372MB <Maxtor 4A250J0> [486344/16/63] at ata1-master UDMA33
Oct  4 14:03:32 hsu /kernel: Waiting 8 seconds for SCSI devices to settle
Oct  4 14:03:32 hsu /kernel: firewire0: New S400 device ID:0010b92000d5db66
Oct  4 14:03:32 hsu /kernel: firewire0: New S400 device ID:0010b92000e56413
Oct  4 14:03:32 hsu /kernel: de0: enabling Full Duplex 100baseTX port
Oct  4 14:03:32 hsu /kernel: pt0 at ahc0 bus 0 target 2 lun 0
Oct  4 14:03:32 hsu /kernel: pt0: <HP C7670A 3925> Fixed Processor SCSI-2 device 
Oct  4 14:03:32 hsu /kernel: pt0: 3.300MB/s transfers
Oct  4 14:03:32 hsu /kernel: da0 at sbp0 bus 0 target 0 lun 0
Oct  4 14:03:32 hsu /kernel: da0: <Maxtor OneTouch 0000> Fixed Direct Access SCSI-4 device 
Oct  4 14:03:32 hsu /kernel: da0: 50.000MB/s transfers
Oct  4 14:03:32 hsu /kernel: da0: 286103MB (585938944 512 byte sectors: 255H 63S/T 36473C)
Oct  4 14:03:32 hsu /kernel: da1 at sbp0 bus 0 target 1 lun 0
Oct  4 14:03:32 hsu /kernel: da1: <Maxtor OneTouch 0000> Fixed Direct Access SCSI-4 device 
Oct  4 14:03:32 hsu /kernel: da1: 50.000MB/s transfers
Oct  4 14:03:32 hsu /kernel: da1: 286103MB (585938944 512 byte sectors: 255H 63S/T 36473C)
Oct  4 14:03:32 hsu /kernel: Mounting root from ufs:/dev/ad0s1a

>Description:

Oct 30 14:51:05 hsu /kernel: fwohci0: BUS reset
Oct 30 14:51:05 hsu /kernel: fwohci0: node_id=0xc800ffc3, gen=2, CYCLEMASTER mode
Oct 30 14:51:05 hsu /kernel: firewire0: 4 nodes, maxhop <= 3, cable IRM = 3 (me)
Oct 30 14:51:05 hsu /kernel: firewire0: bus manager 3 (me)
Oct 30 14:51:05 hsu /kernel: firewire0: New S400 device ID:0010b9f7011523d1
Oct 30 14:51:06 hsu /kernel: da2 at sbp0 bus 0 target 2 lun 0
Oct 30 14:51:06 hsu /kernel: da2: <Maxtor OneTouch 0000> Fixed Direct Access SCSI-4 device 
Oct 30 14:51:06 hsu /kernel: da2: 50.000MB/s transfers
Oct 30 14:51:06 hsu /kernel: da2: 286103MB (585938944 512 byte sectors: 255H 63S/T 36473C)
Oct 30 15:09:27 hsu /kernel: da2: cannot find label (no disk label)
Oct 30 15:09:27 hsu /kernel: da2s1: cannot find label (no disk label)
Oct 30 15:09:27 hsu /kernel: da2: cannot find label (no disk label)
Oct 30 15:09:27 hsu /kernel: da2s1: cannot find label (no disk label)
Oct 30 15:30:45 hsu /kernel: Unknown service addr 0x0000:0x04f14800 WREQB(1) src=0xffc2 data=8
Oct 30 15:32:39 hsu /kernel: Unknown service addr 0x0000:0x03b83800 WREQB(1) src=0xffc2 data=8
Oct 30 15:32:54 hsu /kernel: Unknown service addr 0x0000:0x1761b800 WREQB(1) src=0xffc2 data=8
Oct 30 15:32:54 hsu /kernel: Unknown service addr 0x0000:0x16242800 WREQB(1) src=0xffc2 data=8
Oct 30 15:32:59 hsu /kernel: Unknown service addr 0x0000:0x0dddb000 WREQB(1) src=0xffc2 data=8
Oct 30 15:33:00 hsu /kernel: Unknown service addr 0x0000:0x10ade800 WREQB(1) src=0xffc2 data=8
Oct 30 15:33:39 hsu /kernel: Unknown service addr 0x0000:0x0cd09800 WREQB(1) src=0xffc2 data=8
Oct 30 15:40:22 hsu /kernel: Unknown service addr 0x0000:0x1580f800 WREQB(1) src=0xffc2 data=8
Oct 30 15:45:05 hsu /kernel: Unknown service addr 0x0000:0x1d314800 WREQB(1) src=0xffc2 data=8
Oct 30 15:45:59 hsu /kernel: Unknown service addr 0x0000:0x12f46000 WREQB(1) src=0xffc2 data=8
Oct 30 15:46:05 hsu /kernel: Unknown service addr 0x0000:0x0cddd000 WREQB(1) src=0xffc2 data=8
Oct 30 15:46:11 hsu /kernel: Unknown service addr 0x0000:0x1a37c000 WREQB(1) src=0xffc2 data=8
Oct 30 15:46:36 hsu /kernel: Unknown service addr 0x0000:0x07719000 WREQB(1) src=0xffc2 data=8
Oct 30 15:47:18 hsu /kernel: Unknown service addr 0x0000:0x1c7a4000 WREQB(1) src=0xffc2 data=8
Oct 30 15:48:20 hsu /kernel: Unknown service addr 0x0000:0x02acb000 WREQB(1) src=0xffc2 data=8
Oct 30 15:48:25 hsu /kernel: Unknown service addr 0x0000:0x0d9b4800 WREQB(1) src=0xffc2 data=8
Oct 30 15:48:32 hsu /kernel: Unknown service addr 0x0000:0x1895c000 WREQB(1) src=0xffc2 data=8
Oct 30 15:49:04 hsu /kernel: Unknown service addr 0x0000:0x138c3800 WREQB(1) src=0xffc2 data=8
Oct 30 15:49:05 hsu /kernel: Unknown service addr 0x0000:0x05100000 WREQB(1) src=0xffc2 data=8
Oct 30 15:49:43 hsu /kernel: Unknown service addr 0x0000:0x07277800 WREQB(1) src=0xffc2 data=8
Oct 30 15:49:45 hsu /kernel: Unknown service addr 0x0000:0x15ce3800 WREQB(1) src=0xffc2 data=8
Oct 30 15:49:50 hsu /kernel: Unknown service addr 0x0000:0x1282f000 WREQB(1) src=0xffc2 data=8
Oct 30 15:49:55 hsu /kernel: Unknown service addr 0x0000:0x0356b000 WREQB(1) src=0xffc2 data=8
Oct 30 15:50:56 hsu /kernel: Unknown service addr 0x0000:0x109ad000 WREQB(1) src=0xffc2 data=8
Oct 30 15:51:22 hsu /kernel: Unknown service addr 0x0000:0x1100a000 WREQB(1) src=0xffc2 data=8
Oct 30 15:51:24 hsu /kernel: Unknown service addr 0x0000:0x17b93000 WREQB(1) src=0xffc2 data=8
Oct 30 15:51:28 hsu /kernel: Unknown service addr 0x0000:0x1047d000 WREQB(1) src=0xffc2 data=8
Oct 30 15:51:34 hsu /kernel: Unknown service addr 0x0000:0x0859b800 WREQB(1) src=0xffc2 data=8
Oct 30 15:52:19 hsu /kernel: Unknown service addr 0x0000:0x06066000 WREQB(1) src=0xffc2 data=8
Oct 30 15:52:23 hsu /kernel: Unknown service addr 0x0000:0x0dda9000 WREQB(1) src=0xffc2 data=8
Oct 30 15:53:07 hsu /kernel: Unknown service addr 0x0000:0x17e05800 WREQB(1) src=0xffc2 data=8
Oct 30 15:53:10 hsu /kernel: Unknown service addr 0x0000:0x0c013000 WREQB(1) src=0xffc2 data=8
Oct 30 15:53:14 hsu /kernel: Unknown service addr 0x0000:0x0a112800 WREQB(1) src=0xffc2 data=8
Oct 30 15:53:54 hsu /kernel: Unknown service addr 0x0000:0x165b3000 WREQB(1) src=0xffc2 data=8
Oct 30 15:53:57 hsu /kernel: Unknown service addr 0x0000:0x0cc91000 WREQB(1) src=0xffc2 data=8
Oct 30 15:53:57 hsu /kernel: Unknown service addr 0x0000:0x1d0ba800 WREQB(1) src=0xffc2 data=8
Oct 30 15:54:07 hsu /kernel: Unknown service addr 0x0000:0x0b577000 WREQB(1) src=0xffc2 data=8
Oct 30 15:54:11 hsu /kernel: Unknown service addr 0x0000:0x18d8e800 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu /kernel: Unknown service addr 0x0000:0x1bfcb000 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu /kernel: Unknown service addr 0x0000:0x1bfcb000 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu /kernel: Unknown service addr 0x0000:0x1bfcb800 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu last message repeated 15 times
Oct 30 15:55:27 hsu /kernel: sbp0:1:0 Obj: Data buffer, Error: Time-out error
Oct 30 15:55:27 hsu /kernel: Unknown service addr 0x0000:0x05749000 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu last message repeated 15 times
Oct 30 15:55:27 hsu /kernel: sbp0:1:0 Obj: Data buffer, Error: Time-out error
Oct 30 15:55:27 hsu /kernel: Unknown service addr 0x0000:0x05749000 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu last message repeated 15 times
Oct 30 15:55:27 hsu /kernel: sbp0:1:0 Obj: Data buffer, Error: Time-out error
Oct 30 15:55:27 hsu /kernel: Unknown service addr 0x0000:0x05749000 WREQB(1) src=0xffc2 data=8
Oct 30 15:55:27 hsu last message repeated 15 times
Oct 30 15:55:27 hsu /kernel: sbp0:1:0 Obj: Data buffer, Error: Time-out error
Oct 30 15:56:27 hsu /kernel: sbp0:1:0 request timeout(cmd orb:0x1caca8a4) ... agent reset
Oct 30 15:57:27 hsu /kernel: sbp0:1:0 request timeout(cmd orb:0x1caca9dc) ... target reset
Oct 30 15:58:27 hsu /kernel: sbp0:1:0 request timeout(cmd orb:0x1cacac4c) ... reset start
Oct 30 15:58:27 hsu /kernel: Unknown service addr 0x0000:0x1caca000 WREQB(1) src=0xffc2 data=1000
Oct 30 15:58:27 hsu last message repeated 15 times
Oct 30 15:58:27 hsu /kernel: sbp0:1:0 Obj: Operation request block (ORB), Error: Time-out error
Oct 30 15:58:27 hsu /kernel: sbp0:1:0 login failed
Oct 30 15:58:27 hsu /kernel: firewire0: split transaction timeout dst=0xffc2 tl=0x28 state=10
Oct 30 15:58:27 hsu /kernel: sbp0:1:0 sbp_reset_start failed: resp=60

>How-To-Repeat:

Apparently connecting two firewire disks and copying tens of gigabytes
of data from one to another triggers this easier, but I do not see any
clear pattern.  When these disks are fed data slowly, I have not seen
hangs for several weeks.  They do happen, eventually.

We use the disks as backup tapes.

I think with USB2 I was seeing hangs practically immediately.  USB1
works apparently reliably (but you can not feed data to disks at any
meaningful speed to trigger anything timing-related :-/ )

>Fix:




>Release-Note:
>Audit-Trail:
>Unformatted:



Want to link to this message? Use this URL: <https://mail-archive.FreeBSD.org/cgi/mid.cgi?200410301328.i9UDSQod067234>