while doing
$ diskrescue -R ./.res -b 1m -o /dev/rsd0c -r /dev/rsd1c recover
the machine crashed for five times now.
Inteldrm is disabled via ukc, see my previous message.
Both sd0 and sd1 are connected via USB.
The "BBB" messages were expected since sd1 is a broken disk.
Willing to provide further info...
Bye, Marcus
CONSOLE
umass1: BBB reset failed, TIMEOUT
umass1: BBB bulk-in clear stall failed, TIMEOUT
umass1: BBB bulk-out clear stall failed, TIMEOUT
umass1: BBB reset failed, TIMEOUT
umass1: BBB bulk-in clear stall failed, TIMEOUT
umass1: BBB bulk-out clear stall failed, TIMUT
ehci_idone: ex=0xd2fba000 is done!
umass1: BBB reset failed, TIMEOUT
umass1: BBB bulk-in clear stall failed, TIMEOUT
umass1: BBB bulk, TIMEOUT
umass1: BBB reset failed, TIMEOUT
umass1: BBB bulk-in clear stall failed, TIMEOUT
umass1: BBB bulk-out clear stall failed, TIMEOUT
umass1: BBB reset failed, TIMEOUT
umass1: BBB bulk-in clear stall failed, TIMEOUT
umass1: BBB bulk-out clear stall failed, TIMEOUT
umass1: BBB reset failed, TIMEOUT
umass1: BBB bulk-in clear stall failed, TIMEOUT
panic: ehci_device_clear_toggle: queue active
Stopped at Debugger+0x4: popl %ebp
DDB
ddb> trace
Debugger(d099a9b9,f543feb8,d096bdbc,f543feb8,d0200020) at Debugger+0x4
panic(d096bdbc,d08aa380,f543feec,d08aa388,d2fb4380) at panic+0x67
ehci_device_clear_toggle(d2fb4380,d2fb3414,d0940212,d03369cf,d2f32800) at ehci_
device_clear_toggle+0x29
umass_clear_endpoint_stall(d2fb3400,1,d2fba200,d096c354,40) at umass_clear_endp
oint_stall+0x28
usb_transfer_complete(d2fba100,16,d096c354,0,f) at usb_transfer_complete+0x247
ehci_abort_xfer(d2fba100,f,1,1,d2fba154) at ehci_abort_xfer+0x218
ehci_timeout_task(d2fba100,20,d0a8856b,0,d8f0f900) at ehci_timeout_task+0x2d
usb_abort_task_thread(d8f0f900) at usb_abort_task_thread+0xb1
Bad frame pointer: 0xd0cabe58
ddb> ps
PID PPID PGRP UID S FLAGS WAIT COMMAND
4221 14919 15149 32767 3 0x82 nanosleep sleep
11327 16590 15149 32767 3 0x82 nanosleep sleep
881 17560 881 1000 3 0x83 nanosleep less
17560 28476 17560 1000 3 0x8b pause ksh
28476 3725 3725 1000 3 0x90 select sshd
3725 1690 3725 0 3 0x92 poll sshd
32290 16371 32290 1000 3 0x83 select iostat
16371 17325 16371 1000 3 0x8b pause ksh
17325 16717 16717 1000 3 0x90 select sshd
16717 1690 16717 0 3 0x92 poll sshd
30424 32643 30424 1000 3 0x83 kqread tail
32643 12261 32643 1000 3 0x8b pause ksh
12261 29259 29259 1000 3 0x90 select sshd
29259 1690 29259 0 3 0x92 poll sshd
16591 5022 5022 0 3 0x3 physio diskrescue
5022 26909 5022 1000 3 0x8b pause sh
26909 18046 26909 1000 3 0x8b pause ksh
18046 645 645 1000 3 0x90 select sshd
645 1690 645 0 3 0x92 poll sshd
7344 1 7344 0 3 0x83 ttyin getty
22041 1 22041 0 3 0x83 ttyin getty
26704 1 26704 0 3 0x83 ttyin getty
3120 1 3120 0 3 0x83 ttyin getty
26615 1 26615 0 3 0x83 ttyin getty
15942 1 15942 0 3 0x83 ttyin getty
14576 1 14576 0 3 0x80 select cron
19629 1 19629 0 3 0x80 htplev hotplugd
18243 1 18243 0 3 0x80 nanosleep sensorsd
11383 1 11383 0 3 0x80 kqread apmd
19377 16590 15149 32767 3 0xbb pause netstat
31001 16590 15149 32767 3 0x83 piperd logger
16590 1 15149 32767 3 0x89 pause sh
5694 14919 15149 32767 3 0x83 select iostat
2012 14919 15149 32767 3 0x83 piperd logger
14919 1 15149 32767 3 0x89 pause sh
14147 23217 23217 601 3 0x90 kqread unbound
30041 23217 23217 601 3 0x90 kqread unbound
23217 1 23217 601 3 0x90 kqread unbound
28281 1 28281 99 3 0x90 poll sndiod
21448 1 21448 62 3 0x90 bpf spamlogd
4171 11813 11813 62 3 0x90 piperd spamd
28633 11813 11813 62 3 0x90 select spamd
11813 1 11813 62 3 0x90 nanosleep spamd
32151 22382 22382 95 3 0x90 kqread smtpd
27566 22382 22382 95 3 0x90 kqread smtpd
18341 22382 22382 95 3 0x90 kqread smtpd
9920 22382 22382 95 3 0x90 kqread smtpd
27619 22382 22382 95 3 0x90 kqread smtpd
27624 22382 22382 95 3 0x90 kqread smtpd
10595 22382 22382 95 3 0x90 kqread smtpd
3305 22382 22382 95 3 0x90 kqread smtpd
22382 1 22382 0 3 0x80 kqread smtpd
1690 1 1690 0 3 0x80 select sshd
14509 0 0 0 3 0x4200 acct acct
24359 17022 24898 83 3 0x90 poll ntpd
17022 24898 24898 83 3 0x90 poll ntpd
24898 1 24898 0 3 0x80 poll ntpd
5170 32602 32602 74 3 0x90 bpf pflogd
32602 1 32602 0 3 0x80 netio pflogd
1193 24904 24904 73 2 0x90 syslogd
24904 1 24904 0 3 0x80 netio syslogd
27719 1 27719 77 3 0x90 poll dhclient
29533 1 29533 0 3 0x80 poll dhclient
12983 1 12983 0 3 0x80 mfsidl mount_mfs
18421 0 0 0 3 0x4200 aiodoned aiodoned
12154 0 0 0 3 0x4200 syncer update
19065 0 0 0 3 0x4200 cleaner cleaner
16526 0 0 0 3 0x4200 reaper reaper
3207 0 0 0 3 0x4200 pgdaemon pagedaemon
2191 0 0 0 3 0x4200 bored crypto
11777 0 0 0 3 0x4200 pftm pfpurge
21272 0 0 0 3 0x4200 usbtsk usbtask
* 237 0 0 0 7 0x4200 usbatsk
16728 0 0 0 3 0x40004200 acpi0 acpi0
4284 0 0 0 3 0x4200 bored systq
14354 0 0 0 3 0x4200 bored syswq
23621 0 0 0 3 0x40004200 idle0
10223 0 0 0 3 0x4200 kmalloc kmthread
1 0 1 0 3 0x82 wait init
0 -1 0 0 3 0x200 scheduler swapper
DDB2 (another occurrence)
ddb> trace
Debugger(d099a9b9,f5984eb8,d096bdbc,f5984eb8,d0200020) at Debugger+0x4
panic(d096bdbc,d08aabc2,f5984eec,d08aa388,d2fda480) at panic+0x67
ehci_device_clear_toggle(d2fda480,d2fd9414,d0940212,d03369cf,d2f4f800) at ehci_
device_clear_toggle+0x29
umass_clear_endpoint_stall(d2fd9400,1,d2fdf600,d096c354,40) at
umass_clear_endpoint_stall+0x28
usb_transfer_complete(d2fdf500,16,d096c354,0,f) at usb_transfer_complete+0x247
ehci_abort_xfer(d2fdf500,f,1,1,d2fdf554) at ehci_abort_xfer+0x218
ehci_timeout_task(d2fdf500,20,d0a8856b,0,d8f0da80) at ehci_timeout_task+0x2d
usb_abort_task_thread(d8f0da80) at usb_abort_task_thread+0xb1
Bad frame pointer: 0xd0cabe58
ddb> ps
PID PPID PGRP UID S FLAGS WAIT COMMAND
3741 14439 26568 32767 3 0x82 nanosleep sleep
26426 1926 26568 32767 3 0x82 nanosleep sleep
21151 5787 21151 1000 3 0x83 kqread tail
5787 5763 5787 1000 3 0x8b pause ksh
5763 12234 12234 1000 3 0x90 select sshd
12234 17448 12234 0 3 0x92 poll sshd
233 5671 5671 0 3 0x3 physio diskrescue
5671 949 5671 1000 3 0x8b pause sh
4453 2899 4453 1000 3 0x83 nanosleep less
2899 4989 2899 1000 3 0x8b pause ksh
4989 13972 13972 1000 3 0x90 select sshd
13972 17448 13972 0 3 0x92 poll sshd
949 10864 949 1000 3 0x8b pause ksh
10864 216 216 1000 3 0x90 select sshd
216 17448 216 0 3 0x92 poll sshd
18313 1 18313 0 3 0x83 ttyin getty
11244 1 11244 0 3 0x83 ttyin getty
13583 1 13583 0 3 0x83 ttyin getty
3938 1 3938 0 3 0x83 ttyin getty
14209 1 14209 0 3 0x83 ttyin getty
6878 1 6878 0 3 0x83 ttyin getty
8618 1 8618 0 3 0x80 select cron
2396 1 2396 0 3 0x80 htplev hotplugd
27216 1 27216 0 3 0x80 nanosleep sensorsd
16951 1 16951 0 3 0x80 kqread apmd
11350 14439 26568 32767 3 0xbb pause netstat
22619 14439 26568 32767 3 0x83 piperd logger
14439 1 26568 32767 3 0x89 pause sh
22284 1926 26568 32767 3 0x83 select iostat
912 1926 26568 32767 3 0x83 piperd logger
1926 1 26568 32767 3 0x89 pause sh
18905 14341 14341 601 3 0x90 kqread unbound
8838 14341 14341 601 3 0x90 kqread unbound
14341 1 14341 601 3 0x90 kqread unbound
15198 1 15198 99 3 0x90 poll sndiod
1548 1 1548 62 3 0x90 bpf spamlogd
267 30828 30828 62 3 0x90 piperd spamd
9571 30828 30828 62 3 0x90 select spamd
30828 1 30828 62 3 0x90 nanosleep spamd
791 18333 18333 95 3 0x90 kqread smtpd
9255 18333 18333 95 3 0x90 kqread smtpd
21255 18333 18333 95 3 0x90 kqread smtpd
2901 18333 18333 95 3 0x90 kqread smtpd
32017 18333 18333 95 3 0x90 kqread smtpd
11705 18333 18333 95 3 0x90 kqread smtpd
22798 18333 18333 95 3 0x90 kqread smtpd
12383 18333 18333 95 3 0x90 kqread smtpd
18333 1 18333 0 3 0x80 kqread smtpd
17448 1 17448 0 3 0x80 select sshd
31438 0 0 0 3 0x4200 acct acct
4530 12689 31026 83 3 0x90 poll ntpd
12689 31026 31026 83 3 0x90 poll ntpd
31026 1 31026 0 3 0x80 poll ntpd
32556 19472 19472 74 3 0x90 bpf pflogd
19472 1 19472 0 3 0x80 netio pflogd
17165 1753 1753 73 2 0x90 syslogd
1753 1 1753 0 3 0x80 netio syslogd
3947 1 3947 77 3 0x90 poll dhclient
2728 1 2728 0 3 0x80 poll dhclient
24963 1 24963 0 3 0x80 mfsidl mount_mfs
30249 0 0 0 3 0x4200 aiodoned aiodoned
24444 0 0 0 3 0x4200 syncer update
28994 0 0 0 3 0x4200 cleaner cleaner
22507 0 0 0 3 0x4200 reaper reaper
22874 0 0 0 3 0x4200 pgdaemon pagedaemon
27121 0 0 0 3 0x4200 bored crypto
14598 0 0 0 3 0x4200 pftm pfpurge
20255 0 0 0 3 0x4200 usbtsk usbtask
* 6333 0 0 0 7 0x4200 usbatsk
4022 0 0 0 3 0x4200 bored intelrel
15879 0 0 0 3 0x40004200 acpi0 acpi0
24937 0 0 0 3 0x4200 bored systq
4418 0 0 0 3 0x4200 bored syswq
29134 0 0 0 3 0x40004200 idle0
12226 0 0 0 3 0x4200 kmalloc kmthread
1 0 1 0 3 0x82 wait init
0 -1 0 0 3 0x200 scheduler swapper
DMESG
OpenBSD 5.5-beta (GENERIC) #244: Mon Feb 3 08:13:59 MST 2014
[email protected]:/usr/src/sys/arch/i386/compile/GENERIC
cpu0: Intel(R) Pentium(R) 4 CPU 2.00GHz ("GenuineIntel" 686-class) 2 GHz
cpu0:
FPU,V86,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,DS,ACPI,MMX,FXSR,SSE,SSE2,SS,HTT,TM,PBE,CNXT-ID,PERF
real mem = 2138497024 (2039MB)
avail mem = 2091667456 (1994MB)
mainbus0 at root
bios0 at mainbus0: AT/286+ BIOS, date 08/15/02, BIOS32 rev. 0 @ 0xeba00, SMBIOS
rev. 2.3 @ 0xfd486 (46 entries)
bios0: vendor Compaq version "686O2 v2.14" date 08/15/2002
bios0: Compaq Evo D510 SFF
acpi0 at bios0: rev 0
acpi0: sleep states S0 S1 S3 S4 S5
acpi0: tables DSDT FACP SSDT SSDT SSDT SSDT SSDT SSDT SSDT APIC SSDT SSDT SSDT
SSDT SSDT SSDT SSDT SSDT SSDT
acpi0: wakeup devices PCI0(S4) HUB_(S4) COM1(S4) COM2(S4) USB1(S3) USB2(S3)
USB3(S3) EUSB(S3) PBTN(S4)
acpitimer0 at acpi0: 3579545 Hz, 24 bits
acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat
cpu0 at mainbus0: apid 0 (boot processor)
mtrr: Pentium Pro MTRR support, 8 var ranges, 88 fixed ranges
cpu0: apic clock running at 99MHz
ioapic0 at mainbus0: apid 8 pa 0xfec00000, version 20, 24 pins
ioapic0: misconfigured as apic 0, remapped to apid 8
acpiprt0 at acpi0: bus 5 (HUB_)
acpiprt1 at acpi0: bus 0 (PCI0)
acpicpu0 at acpi0
acpibtn0 at acpi0: PBTN
bios0: ROM list: 0xc0000/0xac00! 0xcac00/0x1800 0xcc400/0x800 0xeaa00/0x5600!
pci0 at mainbus0 bus 0: configuration mode 1 (bios)
pchb0 at pci0 dev 0 function 0 "Intel 82845G Host" rev 0x01
vga1 at pci0 dev 2 function 0 "Intel 82845G Video" rev 0x01
intagp0 at vga1
agp0 at intagp0: aperture at 0xf0000000, size 0x8000000
wsdisplay0 at vga1 mux 1: console (80x25, vt100 emulation)
wsdisplay0: screen 1-5 added (80x25, vt100 emulation)
uhci0 at pci0 dev 29 function 0 "Intel 82801DB USB" rev 0x01: apic 8 int 16
uhci1 at pci0 dev 29 function 1 "Intel 82801DB USB" rev 0x01: apic 8 int 19
ehci0 at pci0 dev 29 function 7 "Intel 82801DB USB" rev 0x01: apic 8 int 23
usb0 at ehci0: USB revision 2.0
uhub0 at usb0 "Intel EHCI root hub" rev 2.00/1.00 addr 1
ppb0 at pci0 dev 30 function 0 "Intel 82801BA Hub-to-PCI" rev 0x81
pci1 at ppb0 bus 5
xl0 at pci1 dev 4 function 0 "3Com 3c905C 100Base-TX" rev 0x74: apic 8 int 16,
address 00:01:02:db:f8:18
bmtphy0 at xl0 phy 24: 3C905C internal PHY, rev. 6
fxp0 at pci1 dev 8 function 0 "Intel PRO/100 VM" rev 0x81, i82562: apic 8 int
20, address 00:08:02:f9:47:8e
inphy0 at fxp0 phy 1: i82562EM 10/100 PHY, rev. 0
xl1 at pci1 dev 9 function 0 "3Com 3c905C 100Base-TX" rev 0x74: apic 8 int 18,
address 00:02:1e:f2:4d:b2
bmtphy1 at xl1 phy 24: 3C905C internal PHY, rev. 6
ichpcib0 at pci0 dev 31 function 0 "Intel 82801DB LPC" rev 0x01
pciide0 at pci0 dev 31 function 1 "Intel 82801DB IDE" rev 0x01: DMA, channel 0
configured to compatibility, channel 1 configured to compatibility
wd0 at pciide0 channel 0 drive 0: <WDC WD3200AAJB-00J3A0>
wd0: 16-sector PIO, LBA48, 305245MB, 625142448 sectors
wd0(pciide0:0:0): using PIO mode 4, Ultra-DMA mode 5
atapiscsi0 at pciide0 channel 1 drive 0
scsibus0 at atapiscsi0: 2 targets
cd0 at scsibus0 targ 0 lun 0: <HL-DT-ST, CD-ROM GCR-8480B, 1.00> ATAPI 5/cdrom
removable
cd0(pciide0:1:0): using PIO mode 4, DMA mode 2
auich0 at pci0 dev 31 function 5 "Intel 82801DB AC97" rev 0x01: apic 8 int 17,
ICH4 AC97
ac97: codec id 0x41445372 (Analog Devices AD1981A)
ac97: codec features headphone, 20 bit DAC, No 3D Stereo
audio0 at auich0
usb1 at uhci0: USB revision 1.0
uhub1 at usb1 "Intel UHCI root hub" rev 1.00/1.00 addr 1
usb2 at uhci1: USB revision 1.0
uhub2 at usb2 "Intel UHCI root hub" rev 1.00/1.00 addr 1
isa0 at ichpcib0
isadma0 at isa0
com0 at isa0 port 0x3f8/8 irq 4: ns16550a, 16 byte fifo
com0: console
com1 at isa0 port 0x2f8/8 irq 3: ns16550a, 16 byte fifo
pckbc0 at isa0 port 0x60/5
pckbd0 at pckbc0 (kbd slot)
pckbc0: using irq 1 for kbd slot
wskbd0 at pckbd0: console keyboard, using wsdisplay0
pcppi0 at isa0 port 0x61
spkr0 at pcppi0
lpt0 at isa0 port 0x378/4 irq 7
npx0 at isa0 port 0xf0/16: reported by CPUID; using exception 16
umass0 at uhub0 port 1 configuration 1 interface 0 "Intenso USB 3.0 Device" rev
2.10/1.00 addr 2
umass0: using SCSI over Bulk-Only
scsibus1 at umass0: 2 targets, initiator 0
sd0 at scsibus1 targ 1 lun 0: <Intenso, USB 3.0 Device, 0> SCSI4 0/direct fixed
serial.174c55aa000000001F1F
sd0: 2861588MB, 4096 bytes/sector, 732566646 sectors
urtw0 at uhub0 port 3 "Realtek RTL8187" rev 2.00/1.00 addr 3
urtw0: RTL8187 rev 0x04, RFv2, address 00:18:e7:1d:c6:72
umass1 at uhub0 port 4 configuration 1 interface 0 "Genesys Logic USB Storage"
rev 2.00/0.41 addr 4
umass1: using SCSI over Bulk-Only
scsibus2 at umass1: 2 targets, initiator 0
sd1 at scsibus2 targ 1 lun 0: <Hitachi, HDS721010CLA332, 0041> SCSI0 0/direct
fixed serial.05e30718000000000033
sd1: 953869MB, 512 bytes/sector, 1953525168 sectors
vscsi0 at root
scsibus3 at vscsi0: 256 targets
softraid0 at root
scsibus4 at softraid0: 256 targets
root on wd0a (d90416083594dc7d.a) swap on wd0b dump on wd0b
WARNING: / was not properly unmounted