The kernel throws this message when kern.splassert=2 and when i don't
run X and stay in console looking at my mouse repeated usb
disconnection / reconnection.
I was able to see that before, but without the splassert warnings.
Jun 22 20:02:44 thinkc /bsd: splassert: usb_transfer_complete: want 5 have 6
Jun 22 20:02:44 thinkc /bsd: Starting stack trace...
Jun 22 20:02:44 thinkc /bsd:
usb_transfer_complete(ffffff022f6e3000,ffffff022f6e3000,ffff800022055d88,1,0,ffff8000000bf000)
at usb_transfer_complete+0x51
Jun 22 20:02:44 thinkc /bsd:
ohci_intr1(ffff8000000bf000,ffff800000099840,ffffffff8196e5a0,ffff8000000a5000,0,ffff8000000a4900)
at ohci_intr1+0x226
Jun 22 20:02:44 thinkc /bsd:
intr_handler(ffff800022055d88,ffff8000000a5000,0,ffff8000000a4880,0,6)
at intr_handler+0x6f
Jun 22 20:02:44 thinkc /bsd: Xintr_ioapic_level10() at Xintr_ioapic_level10+0xcd
Jun 22 20:02:44 thinkc /bsd: --- interrupt ---
Jun 22 20:02:44 thinkc /bsd:
acpicpu_idle(ffff800022040470,ffffffff8196e5a0,ffffffff8196e5b0,0,b2b7b0dafc322f5b,286)
at acpicpu_idle+0xec
Jun 22 20:02:44 thinkc /bsd:
cpu_idle_cycle(ffffffff8196e5a0,2a2,0,ffffffff8196e5a0,ffffffff815645d0,0)
at cpu_idle_cycle+0x10
Jun 22 20:02:44 thinkc /bsd: end trace frame: 0x0, count: 251
Jun 22 20:02:44 thinkc /bsd: End of stack trace.
Jun 22 20:02:44 thinkc /bsd: wsmouse0 detached
Jun 22 20:02:44 thinkc /bsd: ums0 detached
Jun 22 20:02:44 thinkc /bsd: uhidev0 detached
Jun 22 20:02:44 thinkc /bsd: splassert: usb_transfer_complete: want 5 have 6
Jun 22 20:02:44 thinkc /bsd: Starting stack trace...
Jun 22 20:02:44 thinkc /bsd:
usb_transfer_complete(ffffff022f6e3000,ffffff022f6e3000,ffff800023338d48,1,0,ffff8000000bf000)
at usb_transfer_complete+0x51
Jun 22 20:02:44 thinkc /bsd:
ohci_intr1(ffff8000000bf000,ffffffff8120f8aa,ffffffff8196e5a0,ffff8000000a5000,0,ffff8000000a4900)
at ohci_intr1+0x226
Jun 22 20:02:44 thinkc /bsd:
intr_handler(ffff800023338d48,ffff8000000a5000,79,ffff8000000a4880,0,6)
at intr_handler+0x6f
Jun 22 20:02:44 thinkc /bsd: Xintr_ioapic_level10() at Xintr_ioapic_level10+0xcd
Jun 22 20:02:44 thinkc /bsd: --- interrupt ---
Jun 22 20:02:44 thinkc /bsd:
___mp_lock(ffffffff819f7200,45,ffff8000232efab0,1,10,ffff800023338e20)
at ___mp_lock+0x42
Jun 22 20:02:44 thinkc /bsd: syscall() at syscall+0x328
Jun 22 20:02:44 thinkc /bsd: --- syscall (number 121) ---
Jun 22 20:02:44 thinkc /bsd: end of kernel
Jun 22 20:02:44 thinkc /bsd: end trace frame: 0x1bf8d09c9000, count: 251
Jun 22 20:02:44 thinkc /bsd: 0x1bf88fea4cfa:
Jun 22 20:02:44 thinkc /bsd: End of stack trace.
Jun 22 20:02:46 thinkc /bsd: splassert: usb_transfer_complete: want 5 have 6
Jun 22 20:02:47 thinkc /bsd: Starting stack trace...
Jun 22 20:02:47 thinkc /bsd:
usb_transfer_complete(ffffff022f6e3000,ffffff022f6e3000,ffff800022055ae8,1,0,ffff8000000bf000)
at usb_transfer_complete+0x51
Jun 22 20:02:47 thinkc /bsd:
ohci_intr1(ffff8000000bf000,ffff800022055ab0,ffffffff8196e5a0,ffff8000000a5000,4,ffff8000000a4900)
at ohci_intr1+0x226
Jun 22 20:02:47 thinkc /bsd:
intr_handler(ffff800022055ae8,ffff8000000a5000,0,ffff8000000a4880,4,6)
at intr_handler+0x6f
Jun 22 20:02:47 thinkc /bsd: Xintr_ioapic_level10() at Xintr_ioapic_level10+0xcd
Jun 22 20:02:47 thinkc /bsd: --- interrupt ---
Jun 22 20:02:47 thinkc /bsd:
Xspllower(4,ffffffff810af682,0,b2b7b0dafc322f5b,ffff800000092900,c71d01b0198a3bfa)
at Xspllower+0xc
Jun 22 20:02:47 thinkc /bsd:
__mtx_leave(0,1617060e,ffffffff81a0d760,175d,b2b7b0dafc322f5b,ffff8000000bf000)
at __mtx
_leave+0x34
Jun 22 20:02:47 thinkc /bsd:
rdrand(ffffffff81a0d760,4,ffffffff814f4b00,ffffffff81a0d760,b2b7b0dafc322f5b,ffffffff815b26a0)
at rdrand+0x75
Jun 22 20:02:47 thinkc /bsd:
timeout_run(ffffffff81a0d760,ffff800000014400,ffffffff819e9bd8,1,ffffffff81602524,ffff800022055ce8)
at timeout_run+0x4c
Jun 22 20:02:47 thinkc /bsd:
softclock(0,4,ffff800000099840,ffff800000099840,286,ffff800022055d20)
at softclock+0x146
Jun 22 20:02:47 thinkc /bsd:
softintr_dispatch(0,0,0,ffffffff8196e5a0,ffffffff8105d2d0,ffff80000001a9c0)
at softintr_dispatch+0x9f
Jun 22 20:02:47 thinkc /bsd: Xsoftclock() at Xsoftclock+0x1f
Jun 22 20:02:47 thinkc /bsd: --- interrupt ---
Jun 22 20:02:47 thinkc /bsd: end of kernel
Jun 22 20:02:47 thinkc /bsd: end trace frame: 0x1388, count: 246
Jun 22 20:02:47 thinkc /bsd: 0x8:
Jun 22 20:02:47 thinkc /bsd: End of stack trace.
Jun 22 20:02:47 thinkc /bsd: splassert: usb_transfer_complete: want 5 have 6
Jun 22 20:02:47 thinkc /bsd: Starting stack trace...
Jun 22 20:02:47 thinkc /bsd:
usb_transfer_complete(ffffff022f6e3000,ffffff022f6e3000,ffff800022055da0,1,0,ffff8000000bf000)
at usb_transfer_complete+0x51
Jun 22 20:02:47 thinkc /bsd:
ohci_intr1(ffff8000000bf000,ffff800022055d80,ffffffff8196e5a0,ffff8000000a5000,0,ffff8000000a4900)
at ohci_intr1+0x226
Jun 22 20:02:47 thinkc /bsd:
intr_handler(ffff800022055da0,ffff8000000a5000,0,ffff8000000a4880,0,6)
at intr_handler+0x6f
Jun 22 20:02:47 thinkc /bsd: Xintr_ioapic_level10() at Xintr_ioapic_level10+0xcd
Jun 22 20:02:47 thinkc /bsd: --- interrupt ---
Jun 22 20:02:47 thinkc /bsd:
Xspllower(0,ffff800022040470,0,ffffffff8196e5b0,286,b2b7b0dafc322f5b)
at Xspllower+0xc
Jun 22 20:02:47 thinkc /bsd:
sched_idle(ffffffff8196e5a0,2a2,0,ffffffff8196e5a0,ffffffff815645d0,0)
at sched_idle+0x1fa
Jun 22 20:02:47 thinkc /bsd: end trace frame: 0x0, count: 251
Jun 22 20:02:47 thinkc /bsd: End of stack trace.
Jun 22 20:02:47 thinkc /bsd: splassert: usb_transfer_complete: want 5 have 6
Jun 22 20:02:47 thinkc /bsd: Starting stack trace...
Jun 22 20:02:47 thinkc /bsd:
usb_transfer_complete(ffffff022f6e3000,ffffff022f6e3000,ffff800022055da0,1,0,ffff8000000bf000)
at usb_transfer_complete+0x51
Jun 22 20:02:47 thinkc /bsd:
ohci_intr1(ffff8000000bf000,ffff800022055d80,ffffffff8196e5a0,ffff8000000a5000,0,ffff8000000a4900)
at ohci_intr1+0x226
Jun 22 20:02:47 thinkc /bsd:
intr_handler(ffff800022055da0,ffff8000000a5000,0,ffff8000000a4880,0,6)
at intr_handler+0x6f
Jun 22 20:02:47 thinkc /bsd: Xintr_ioapic_level10() at Xintr_ioapic_level10+0xcd
Jun 22 20:02:47 thinkc /bsd: --- interrupt ---
Jun 22 20:02:47 thinkc /bsd:
Xspllower(0,ffff800022040470,0,ffffffff8196e5b0,286,b2b7b0dafc322f5b)
at Xspllower+0xc
Jun 22 20:02:47 thinkc /bsd:
sched_idle(ffffffff8196e5a0,2a2,0,ffffffff8196e5a0,ffffffff815645d0,0)
at sched_idle+0x1fa
Jun 22 20:02:47 thinkc /bsd: end trace frame: 0x0, count: 251
Jun 22 20:02:47 thinkc /bsd: End of stack trace.
Jun 22 20:02:47 thinkc /bsd: uhidev0 at uhub3 port 5 configuration 1
interface 0 "Genius USB Optical Mouse" rev 2.00/1.00 addr 2
Jun 22 20:02:47 thinkc /bsd: uhidev0: iclass 3/1
Jun 22 20:02:48 thinkc /bsd: ums0 at uhidev0: 3 buttons, Z dir
Jun 22 20:02:48 thinkc /bsd: wsmouse0 at ums0 mux 0
=== dmesg ===
OpenBSD 6.1-current (GENERIC.MP) #21: Mon Jun 19 17:43:48 MDT 2017
dera...@amd64.openbsd.org:/usr/src/sys/arch/amd64/compile/GENERIC.MP
real mem = 8029429760 (7657MB)
avail mem = 7780290560 (7419MB)
mpath0 at root
scsibus0 at mpath0: 256 targets
mainbus0 at root
bios0 at mainbus0: SMBIOS rev. 2.6 @ 0xeebc0 (57 entries)
bios0: vendor LENOVO version "9VKT33AUS" date 09/11/2013
bios0: LENOVO 1990RZ2
acpi0 at bios0: rev 2
acpi0: sleep states S0 S3 S4 S5
acpi0: tables DSDT FACP APIC TCPA MCFG SLIC MCFG HPET SSDT
acpi0: wakeup devices PCE2(S4) PCE3(S4) PCE4(S4) PCE5(S4) PCE6(S4)
PCE7(S4) PCE9(S4) PCEA(S4) PCEB(S4) PCEC(S4) SBAZ(S4) P0PC(S4)
PE20(S4) PE21(S4) PE22(S4) PE23(S4) [...]
acpitimer0 at acpi0: 3579545 Hz, 32 bits
acpimadt0 at acpi0 addr 0xfee00000: PC-AT compat
cpu0 at mainbus0: apid 0 (boot processor)
cpu0: AMD Athlon(tm) II X2 B26 Processor, 3194.50 MHz
cpu0:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,MMX,FXSR,SSE,SSE2,HTT,SSE3,MWAIT,CX16,POPCNT,NXE,MMXX,FFXSR,PAGE1GB,RDTSCP,LONG,3DNOW2,3DNOW,LAHF,CMPLEG,SVM,EAPICSP,AMCR8,ABM,SSE4A,MASSE,3DNOWP,OSVW,IBS,SKINIT,NODEID,ITSC
cpu0: 64KB 64b/line 2-way I-cache, 64KB 64b/line 2-way D-cache, 1MB
64b/line 16-way L2 cache
cpu0: ITLB 32 4KB entries fully associative, 16 4MB entries fully associative
cpu0: DTLB 48 4KB entries fully associative, 48 4MB entries fully associative
cpu0: AMD erratum 721 detected and fixed
cpu0: TSC frequency 3194499360 Hz
cpu0: smt 0, core 0, package 0
mtrr: Pentium Pro MTRR support, 8 var ranges, 88 fixed ranges
cpu0: apic clock running at 199MHz
cpu0: mwait min=64, max=64, IBE
cpu1 at mainbus0: apid 1 (application processor)
cpu1: AMD Athlon(tm) II X2 B26 Processor, 3192.02 MHz
cpu1:
FPU,VME,DE,PSE,TSC,MSR,PAE,MCE,CX8,APIC,SEP,MTRR,PGE,MCA,CMOV,PAT,PSE36,CFLUSH,MMX,FXSR,SSE,SSE2,HTT,SSE3,MWAIT,CX16,POPCNT,NXE,MMXX,FFXSR,PAGE1GB,RDTSCP,LONG,3DNOW2,3DNOW,LAHF,CMPLEG,SVM,EAPICSP,AMCR8,ABM,SSE4A,MASSE,3DNOWP,OSVW,IBS,SKINIT,NODEID,ITSC
cpu1: 64KB 64b/line 2-way I-cache, 64KB 64b/line 2-way D-cache, 1MB
64b/line 16-way L2 cache
cpu1: ITLB 32 4KB entries fully associative, 16 4MB entries fully associative
cpu1: DTLB 48 4KB entries fully associative, 48 4MB entries fully associative
cpu1: AMD erratum 721 detected and fixed
cpu1: smt 0, core 1, package 0
ioapic0 at mainbus0: apid 3 pa 0xfec00000, version 21, 24 pins
acpimcfg0 at acpi0 addr 0xe0000000, bus 0-255
acpimcfg1 at acpi0 addr 0xe0000000, bus 0-255
acpihpet0 at acpi0: 14318180 Hz
acpiprt0 at acpi0: bus 0 (PCI0)
acpiprt1 at acpi0: bus 1 (P0P1)
acpiprt2 at acpi0: bus -1 (PCE2)
acpiprt3 at acpi0: bus -1 (PCE3)
acpiprt4 at acpi0: bus -1 (PCE4)
acpiprt5 at acpi0: bus -1 (PCE5)
acpiprt6 at acpi0: bus -1 (PCE6)
acpiprt7 at acpi0: bus -1 (PCE7)
acpiprt8 at acpi0: bus -1 (PCE9)
acpiprt9 at acpi0: bus -1 (PCEA)
acpiprt10 at acpi0: bus 2 (P0PC)
acpiprt11 at acpi0: bus 3 (PE20)
acpiprt12 at acpi0: bus -1 (PE21)
acpiprt13 at acpi0: bus -1 (PE22)
acpiprt14 at acpi0: bus 4 (PE23)
acpicpu0 at acpi0: C1(@1 halt!), PSS
acpicpu1 at acpi0: C1(@1 halt!), PSS
"PNP0501" at acpi0 not configured
acpibtn0 at acpi0: PWRB
cpu0: 3194 MHz: speeds: 3200 2500 1900 800 MHz
pci0 at mainbus0 bus 0
pchb0 at pci0 dev 0 function 0 "AMD RS880 Host" rev 0x00
ppb0 at pci0 dev 1 function 0 vendor "Lenovo", unknown product 0x9602 rev 0x00
pci1 at ppb0 bus 1
radeondrm0 at pci1 dev 5 function 0 "ATI Radeon HD 4250" rev 0x00
drm0 at radeondrm0
radeondrm0: apic 3 int 18
ahci0 at pci0 dev 17 function 0 "ATI SBx00 SATA" rev 0x00: apic 3 int
19, AHCI 1.2
ahci0: port 0: 3.0Gb/s
ahci0: port 1: 1.5Gb/s
scsibus1 at ahci0: 32 targets
sd0 at scsibus1 targ 0 lun 0: <ATA, WDC WD3200AAKS-0, 40.0> SCSI3
0/direct fixed naa.50014ee1018094dc
sd0: 305245MB, 512 bytes/sector, 625142448 sectors
cd0 at scsibus1 targ 1 lun 0: <PLDS, DVD-RW DH16ABSH, YL32> ATAPI
5/cdrom removable
ohci0 at pci0 dev 18 function 0 "ATI SB700 USB" rev 0x00: apic 3 int
18, version 1.0, legacy support
ehci0 at pci0 dev 18 function 2 "ATI SB700 USB2" rev 0x00: apic 3 int 17
usb0 at ehci0: USB revision 2.0
uhub0 at usb0 configuration 1 interface 0 "ATI EHCI root hub" rev
2.00/1.00 addr 1
ohci1 at pci0 dev 19 function 0 "ATI SB700 USB" rev 0x00: apic 3 int
18, version 1.0, legacy support
ehci1 at pci0 dev 19 function 2 "ATI SB700 USB2" rev 0x00: apic 3 int 17
usb1 at ehci1: USB revision 2.0
uhub1 at usb1 configuration 1 interface 0 "ATI EHCI root hub" rev
2.00/1.00 addr 1
piixpm0 at pci0 dev 20 function 0 "ATI SBx00 SMBus" rev 0x42: polling
iic0 at piixpm0
spdmem0 at iic0 addr 0x52: 4GB DDR3 SDRAM PC3-10600
spdmem1 at iic0 addr 0x53: 4GB DDR3 SDRAM PC3-10600
azalia0 at pci0 dev 20 function 2 "ATI SBx00 HD Audio" rev 0x40: apic 3 int 16
azalia0: codecs: Realtek ALC662
audio0 at azalia0
pcib0 at pci0 dev 20 function 3 "ATI SB700 ISA" rev 0x40
ppb1 at pci0 dev 20 function 4 "ATI SB600 PCI" rev 0x40
pci2 at ppb1 bus 2
ohci2 at pci0 dev 20 function 5 "ATI SB700 USB" rev 0x00: apic 3 int
18, version 1.0, legacy support
ppb2 at pci0 dev 21 function 0 "ATI SB800 PCIE" rev 0x00
pci3 at ppb2 bus 3
ppb3 at pci0 dev 21 function 3 "ATI SB800 PCIE" rev 0x00
pci4 at ppb3 bus 4
bge0 at pci4 dev 0 function 0 "Broadcom BCM5761" rev 0x10, BCM5761 A1
(0x5761100): msi, address c8:9c:dc:b2:8f:1d
brgphy0 at bge0 phy 1: BCM5761 10/100/1000baseT PHY, rev. 0
ohci3 at pci0 dev 22 function 0 "ATI SB700 USB" rev 0x00: apic 3 int
18, version 1.0, legacy support
ehci2 at pci0 dev 22 function 2 "ATI SB700 USB2" rev 0x00: apic 3 int 17
usb2 at ehci2: USB revision 2.0
uhub2 at usb2 configuration 1 interface 0 "ATI EHCI root hub" rev
2.00/1.00 addr 1
pchb1 at pci0 dev 24 function 0 "AMD AMD64 10h HyperTransport" rev 0x00
pchb2 at pci0 dev 24 function 1 "AMD AMD64 10h Address Map" rev 0x00
pchb3 at pci0 dev 24 function 2 "AMD AMD64 10h DRAM Cfg" rev 0x00
km0 at pci0 dev 24 function 3 "AMD AMD64 10h Misc Cfg" rev 0x00
pchb4 at pci0 dev 24 function 4 "AMD AMD64 10h Link Cfg" rev 0x00
usb3 at ohci0: USB revision 1.0
uhub3 at usb3 configuration 1 interface 0 "ATI OHCI root hub" rev
1.00/1.00 addr 1
usb4 at ohci1: USB revision 1.0
uhub4 at usb4 configuration 1 interface 0 "ATI OHCI root hub" rev
1.00/1.00 addr 1
isa0 at pcib0
isadma0 at isa0
com0 at isa0 port 0x3f8/8 irq 4: ns16550a, 16 byte fifo
pckbc0 at isa0 port 0x60/5 irq 1 irq 12
pckbd0 at pckbc0 (kbd slot)
wskbd0 at pckbd0: console keyboard
pcppi0 at isa0 port 0x61
spkr0 at pcppi0
usb5 at ohci2: USB revision 1.0
uhub5 at usb5 configuration 1 interface 0 "ATI OHCI root hub" rev
1.00/1.00 addr 1
usb6 at ohci3: USB revision 1.0
uhub6 at usb6 configuration 1 interface 0 "ATI OHCI root hub" rev
1.00/1.00 addr 1
vmm0 at mainbus0: SVM/RVI
splassert: usb_transfer_complete: want 5 have 6
splassert: usb_transfer_complete: want 5 have 6
splassert: usb_transfer_complete: want 5 have 6
splassert: usb_transfer_complete: want 5 have 6
uvideo0 at uhub0 port 4 configuration 1 interface 0 "vendor 0x046d
Webcam C170" rev 2.00/28.25 addr 2
video0 at uvideo0
uaudio0 at uhub0 port 4 configuration 1 interface 2 "vendor 0x046d
Webcam C170" rev 2.00/28.25 addr 2
uaudio0: audio rev 1.00, 2 mixer controls
audio1 at uaudio0
splassert: usb_transfer_complete: want 5 have 6
splassert: usb_transfer_complete: want 5 have 6
umass0 at uhub2 port 1 configuration 1 interface 0 "SanDisk Cruzer
Fit" rev 2.00/1.26 addr 2
umass0: using SCSI over Bulk-Only
scsibus2 at umass0: 2 targets, initiator 0
sd1 at scsibus2 targ 1 lun 0: <SanDisk, Cruzer Fit, 1.26> SCSI4
0/direct fixed serial.07815571010812120514
sd1: 30532MB, 512 bytes/sector, 62530624 sectors
splassert: usb_transfer_complete: want 5 have 6
splassert: usb_transfer_complete: want 5 have 6
uhidev0 at uhub3 port 5 configuration 1 interface 0 "Genius USB
Optical Mouse" rev 2.00/1.00 addr 2
uhidev0: iclass 3/1
ums0 at uhidev0: 3 buttons, Z dir
wsmouse0 at ums0 mux 0
splassert: usb_transfer_complete: want 5 have 6
splassert: usb_transfer_complete: want 5 have 6
uhidev1 at uhub4 port 1 configuration 1 interface 0 "SIGMACH1P USB
Keykoard" rev 1.10/1.10 addr 2
uhidev1: iclass 3/1
ukbd0 at uhidev1: 8 variable keys, 6 key codes
wskbd1 at ukbd0 mux 1
uhidev2 at uhub4 port 1 configuration 1 interface 1 "SIGMACH1P USB
Keykoard" rev 1.10/1.10 addr 2
uhidev2: iclass 3/0, 2 report ids
uhid0 at uhidev2 reportid 1: input=2, output=0, feature=0
uhid1 at uhidev2 reportid 2: input=1, output=0, feature=0
vscsi0 at root
scsibus3 at vscsi0: 256 targets
softraid0 at root
scsibus4 at softraid0: 256 targets
root on sd0a (a7939ead3f92ccc4.a) swap on sd0b dump on sd0b
radeondrm0: 1680x1050, 32bpp
wsdisplay0 at radeondrm0 mux 1: console (std, vt100 emulation), using wskbd0
wskbd1: connecting to wsdisplay0
wsdisplay0: screen 1-5 added (std, vt100 emulation)
uhidev0 at uhub3 port 5 configuration 1 interface 0 "Genius USB
Optical Mouse" rev 2.00/1.00 addr 2
uhidev0: iclass 3/1
ums0 at uhidev0: 3 buttons, Z dir
wsmouse0 at ums0 mux 0
