From owner-freebsd-current@freebsd.org Sat Feb 20 05:19:55 2016 Return-Path: Delivered-To: freebsd-current@mailman.ysv.freebsd.org Received: from mx1.freebsd.org (mx1.freebsd.org [IPv6:2001:1900:2254:206a::19:1]) by mailman.ysv.freebsd.org (Postfix) with ESMTP id 013D4AAE4BA for ; Sat, 20 Feb 2016 05:19:55 +0000 (UTC) (envelope-from ler@lerctr.org) Received: from thebighonker.lerctr.org (thebighonker.lerctr.org [IPv6:2001:470:1f0f:3ad:223:7dff:fe9e:6e8a]) (using TLSv1.2 with cipher ECDHE-RSA-AES256-GCM-SHA384 (256/256 bits)) (Client CN "thebighonker.lerctr.org", Issuer "COMODO RSA Domain Validation Secure Server CA" (verified OK)) by mx1.freebsd.org (Postfix) with ESMTPS id D62A37B3 for ; Sat, 20 Feb 2016 05:19:54 +0000 (UTC) (envelope-from ler@lerctr.org) DKIM-Signature: v=1; a=rsa-sha256; q=dns/txt; c=relaxed/relaxed; d=lerctr.org; s=lerami; h=Content-Type:MIME-Version:Message-ID:Subject:To:From:Date; bh=gnonUayHy1IjQP49vmts3WbioyR7koLY0ku/hG/uRGc=; b=ckqy+eT89+y4elnhkR9UvNg2qV ZuQT9MC63e/cd0LtjleMX50hd7KIf3u1ruMUksX2UwOT4Q0/URmUzXydzjI2EeMy+0Tg8YDtOek7x VCObGT6sCsa91o+FDx2mEh6ei8bjVo0LX+n7IQegl9j8KbXz+L8hVCkMLpTeTm7Du0rE=; Received: from [2605:6000:ec17:200:2247:47ff:fe73:75f] (port=46354 helo=lrosenman-dell.lerctr.org) by thebighonker.lerctr.org with esmtpsa (TLSv1.2:ECDHE-RSA-AES256-GCM-SHA384:256) (Exim 4.86 (FreeBSD)) (envelope-from ) id 1aWzxR-00076Z-K1 for freebsd-current@freebsd.org; Fri, 19 Feb 2016 23:19:54 -0600 Date: Fri, 19 Feb 2016 23:19:51 -0600 From: Larry Rosenman To: freebsd-current@freebsd.org Subject: new computer, strange usb messages at boot Message-ID: <20160220051951.GA47875@lrosenman-dell.lerctr.org> Mail-Followup-To: freebsd-current@freebsd.org MIME-Version: 1.0 Content-Type: text/plain; charset=us-ascii Content-Disposition: inline User-Agent: Mutt/1.5.24 (2015-08-30) X-Spam-Score: -1.0 (-) X-LERCTR-Spam-Score: -1.0 (-) X-Spam-Report: SpamScore (-1.0/5.0) ALL_TRUSTED=-1,SHORTCIRCUIT=-0.0001 X-LERCTR-Spam-Report: SpamScore (-1.0/5.0) ALL_TRUSTED=-1, SHORTCIRCUIT=-0.0001 X-BeenThere: freebsd-current@freebsd.org X-Mailman-Version: 2.1.20 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: Sat, 20 Feb 2016 05:19:55 -0000 Does any of this look weird? What can I provide to help? Dell Inspiron 15 7559 Copyright (c) 1992-2016 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 is a registered trademark of The FreeBSD Foundation. FreeBSD 11.0-CURRENT #0 r295683: Wed Feb 17 02:07:17 UTC 2016 root@releng2.nyi.freebsd.org:/usr/obj/usr/src/sys/GENERIC amd64 FreeBSD clang version 3.7.1 (tags/RELEASE_371/final 255217) 20151225 WARNING: WITNESS option enabled, expect reduced performance. VT(efifb): resolution 2048x1200 CPU: Intel(R) Core(TM) i7-6700HQ CPU @ 2.60GHz (2592.13-MHz K8-class CPU) Origin="GenuineIntel" Id=0x506e3 Family=0x6 Model=0x5e Stepping=3 Features=0xbfebfbff Features2=0x7ffafbbf AMD Features=0x2c100800 AMD Features2=0x121 Structured Extended Features=0x29c6fbf XSAVE Features=0xf VT-x: PAT,HLT,MTF,PAUSE,EPT,UG,VPID TSC: P-state invariant, performance statistics real memory = 17179869184 (16384 MB) avail memory = 16396095488 (15636 MB) Event timer "LAPIC" quality 600 ACPI APIC Table: FreeBSD/SMP: Multiprocessor System Detected: 8 CPUs FreeBSD/SMP: 1 package(s) x 4 core(s) x 2 SMT threads cpu0 (BSP): APIC ID: 0 cpu1 (AP): APIC ID: 1 cpu2 (AP): APIC ID: 2 cpu3 (AP): APIC ID: 3 cpu4 (AP): APIC ID: 4 cpu5 (AP): APIC ID: 5 cpu6 (AP): APIC ID: 6 cpu7 (AP): APIC ID: 7 random: unblocking device. ioapic0 irqs 0-119 on motherboard random: entropy device external interface kbd1 at kbdmux0 netmap: loaded module module_register_init: MOD_LOAD (vesa, 0xffffffff80ee1ef0, 0) error 19 random: registering fast source Intel Secure Key RNG random: fast provider: "Intel Secure Key RNG" cryptosoft0: on motherboard acpi0: on motherboard acpi0: Power Button (fixed) cpu0: on acpi0 cpu1: on acpi0 cpu2: on acpi0 cpu3: on acpi0 cpu4: on acpi0 cpu5: on acpi0 cpu6: on acpi0 cpu7: on acpi0 hpet0: iomem 0xfed00000-0xfed003ff on acpi0 Timecounter "HPET" frequency 24000000 Hz quality 950 Event timer "HPET" frequency 24000000 Hz quality 550 atrtc0: port 0x70-0x77 irq 8 on acpi0 atrtc0: Warning: Couldn't map I/O. Event timer "RTC" frequency 32768 Hz quality 0 attimer0: port 0x40-0x43,0x50-0x53 irq 0 on acpi0 Timecounter "i8254" frequency 1193182 Hz quality 0 Event timer "i8254" frequency 1193182 Hz quality 100 Timecounter "ACPI-fast" frequency 3579545 Hz quality 900 acpi_timer0: <24-bit timer at 3.579545MHz> port 0x1808-0x180b on acpi0 acpi_ec0: port 0x62,0x66 on acpi0 pcib0: port 0xcf8-0xcff on acpi0 pci0: on pcib0 pcib1: irq 16 at device 1.0 on pci0 pci1: on pcib1 pcib2: irq 16 at device 1.1 on pci0 pci2: on pcib2 vgapci0: port 0xe000-0xe07f mem 0xde000000-0xdeffffff,0xc0000000-0xcfffffff,0xd0000000-0xd1ffffff irq 17 at device 0.0 on pci2 nvidia0: on vgapci0 vgapci0: child nvidia0 requested pci_enable_io vgapci0: child nvidia0 requested pci_enable_io vgapci1: port 0xf000-0xf03f mem 0xdd000000-0xddffffff,0xb0000000-0xbfffffff irq 16 at device 2.0 on pci0 vgapci1: Boot video device xhci0: mem 0xdf410000-0xdf41ffff irq 16 at device 20.0 on pci0 xhci0: 32 bytes context size, 64-bit DMA usbus0: waiting for BIOS to give up control usbus0 on xhci0 pci0: at device 22.0 (no driver attached) ahci0: port 0xf090-0xf097,0xf080-0xf083,0xf060-0xf07f mem 0xdf430000-0xdf431fff,0xdf434000-0xdf4340ff,0xdf433000-0xdf4337ff irq 16 at device 23.0 on pci0 ahci0: AHCI v1.31 with 2 6Gbps ports, Port Multiplier not supported ahcich0: at channel 0 on ahci0 ahcich1: at channel 1 on ahci0 ahciem0: on ahci0 pcib3: irq 16 at device 28.0 on pci0 pci3: on pcib3 pcib4: irq 16 at device 28.4 on pci0 pci4: on pcib4 re0: port 0xd000-0xd0ff mem 0xdf304000-0xdf304fff,0xdf300000-0xdf303fff irq 16 at device 0.0 on pci4 re0: Using 1 MSI-X message re0: turning off MSI enable bit. re0: ASPM disabled re0: Chip rev. 0x50800000 re0: MAC rev. 0x00100000 miibus0: on re0 rgephy0: PHY 1 on miibus0 rgephy0: none, 10baseT, 10baseT-FDX, 10baseT-FDX-flow, 100baseTX, 100baseTX-FDX, 100baseTX-FDX-flow, 1000baseT-FDX, 1000baseT-FDX-master, 1000baseT-FDX-flow, 1000baseT-FDX-flow-master, auto, auto-flow re0: Using defaults for TSO: 65518/35/2048 re0: Ethernet address: 20:47:47:73:07:5f re0: netmap queues/slots: TX 1/256, RX 1/256 pcib5: irq 17 at device 28.5 on pci0 pci5: on pcib5 pci5: at device 0.0 (no driver attached) pcib6: irq 18 at device 28.6 on pci0 pci6: on pcib6 pci6: at device 0.0 (no driver attached) isab0: at device 31.0 on pci0 isa0: on isab0 pci0: at device 31.2 (no driver attached) hdac0: mem 0xdf428000-0xdf42bfff,0xdf400000-0xdf40ffff irq 16 at device 31.3 on pci0 acpi_button0: on acpi0 acpi_button1: on acpi0 acpi_lid0: on acpi0 acpi_tz0: on acpi0 acpi_tz1: on acpi0 atkbdc0: port 0x60,0x64 irq 1 on acpi0 atkbd0: irq 1 on atkbdc0 kbd0 at atkbd0 atkbd0: [GIANT-LOCKED] psm0: irq 12 on atkbdc0 psm0: [GIANT-LOCKED] psm0: model Generic PS/2 mouse, device ID 0 acpi_acad0: on acpi0 battery0: on acpi0 orm0: at iomem 0xd0000-0xd0fff on isa0 ppc0: cannot reserve I/O port range est0: on cpu0 est1: on cpu1 est2: on cpu2 est3: on cpu3 est4: on cpu4 est5: on cpu5 est6: on cpu6 est7: on cpu7 ZFS filesystem version: 5 ZFS storage pool version: features support (5000) Timecounters tick every 1.000 msec IPsec: Initialized Security Association Processing. hdacc0: at cad 0 on hdac0 hdaa0: at nid 1 on hdacc0 pcm0: at nid 20 and 18 on hdaa0 pcm1: at nid 33 on hdaa0 hdacc1: at cad 2 on hdac0 hdaa1: at nid 1 on hdacc1 pcm2: at nid 3 on hdaa1 usbus0: 5.0Gbps Super Speed USB v3.0 ugen0.1: <0x8086> at usbus0 uhub0: <0x8086 XHCI root HUB, class 9/0, rev 3.00/1.00, addr 1> on usbus0 ses0 at ahciem0 bus 0 scbus2 target 0 lun 0 ses0: SEMB S-E-S 2.00 device ses0: SEMB SES Device ada0 at ahcich0 bus 0 scbus0 target 0 lun 0 ada0: ACS-2 ATA SATA 3.x device ada0: Serial Number 154595406259 ada0: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 512bytes) ada0: Command Queueing enabled ada0: 122104MB (250069680 512 byte sectors) ada1 at ahcich1 bus 0 scbus1 target 0 lun 0 ada1: ATA8-ACS SATA 3.x device ada1: Serial Number S314JB0GA02416 ada1: 600.000MB/s transfers (SATA 3.x, UDMA6, PIO 8192bytes) ada1: Command Queueing enabled ada1: 953869MB (1953525168 512 byte sectors) SMP: AP CPU #1 Launched! SMP: AP CPU #4 Launched! SMP: AP CPU #5 Launched! SMP: AP CPU #7 Launched! SMP: AP CPU #6 Launched! SMP: AP CPU #3 Launched! SMP: AP CPU #2 Launched! Sleeping on "acmtx" with the following non-sleepable locks held: exclusive sleep mutex intr sources (intr sources) r = 0 (0xffffffff81c7f630) locked @ /usr/src/sys/x86/x86/intr_machdep.c:549 stack backtrace: #0 0xffffffff80a7f790 at witness_debugger+0x70 #1 0xffffffff80a80aa7 at witness_warn+0x3d7 #2 0xffffffff80a2e26d at _sleep+0x6d #3 0xffffffff80399ff8 at AcpiOsAcquireMutex+0xc8 #4 0xffffffff8036891a at AcpiUtAcquireMutex+0x3a #5 0xffffffff80355f2b at AcpiExEnterInterpreter+0xb #6 0xffffffff8035a2fb at AcpiNsEvaluate+0x1cb #7 0xffffffff8035d7b4 at AcpiEvaluateObject+0x174 #8 0xffffffff8039ac0d at acpi_GetInteger+0x3d #9 0xffffffff80f94c01 at dmar_find_hpet+0x81 #10 0xffffffff80f9d54d at iommu_map_msi_intr+0x2d #11 0xffffffff80fb2f91 at msi_map+0x171 #12 0xffffffff80e73035 at hpet_remap_intr+0xb5 #13 0xffffffff80fb2627 at msi_assign_cpu+0x1c7 #14 0xffffffff80fa9733 at intr_shuffle_irqs+0x73 #15 0xffffffff809c3a38 at mi_startup+0x108 #16 0xffffffff802fb02c at btext+0x2c lock order reversal: (Giant after non-sleepable) 1st 0xffffffff81c7f630 intr sources (intr sources) @ /usr/src/sys/x86/x86/intr_machdep.c:549 2nd 0xffffffff81cd4d60 Giant (Giant) @ /usr/src/sys/kern/kern_synch.c:244 stack backtrace: #0 0xffffffff80a7f790 at witness_debugger+0x70 #1 0xffffffff80a7f691 at witness_checkorder+0xTrying to mount root from zfs:zroot/ROOT/default []... e71 #2 0xffffffff80a06f94 at __mtx_lock_flags+0xa4 #3 0xffffffff80a2e5ba at _sleep+0x3ba #4 0xffffffff80399ff8 at AcpiOsAcquireMutex+0xc8 #5 0xffffffff8036891a at AcpiUtAcquireMutex+0x3a #6 0xffffffff80355f2b at AcpiExEnterInterpreter+0xb #7 0xffffffff8035a2fb at AcpiNsEvaluate+0x1cb #8 0xffffffff8035d7b4 at AcpiEvaluateObject+0x174 #9 0xffffffff8039ac0d at acpi_GetInteger+0x3d #10 0xffffffff80f94c01 at dmar_find_hpet+0x81 #11 0xffffffff80f9d54d at iommu_map_msi_intr+0x2d #12 0xffffffff80fb2f91 at msi_map+0x171 #13 0xffffffff80e73035 at hpet_remap_intr+0xb5 #14 0xffffffff80fb2627 at msi_assign_cpu+0x1c7 #15 0xffffffff80fa9733 at intr_shuffle_irqs+0x73 #16 0xffffffff809c3a38 at mi_startup+0x108 #17 0xffffffff802fb02c at btext+0x2c Timecounter "TSC-low" frequency 1296064094 Hz quality 1000 WARNING: WITNESS option enabled, expect reduced performance. Root mount waiting for: usbus0 uhub0: 24 ports with 24 removable, self powered Root mount waiting for: usbus0 ugen0.2: at usbus0 Root mount waiting for: usbus0 usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR Root mount waiting for: usbus0 usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR Root mount waiting for: usbus0 Root mount waiting for: usbus0 usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR Root mount waiting for: usbus0 usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR Root mount waiting for: usbus0 Root mount waiting for: usbus0 usbd_setup_device_desc: getting device descriptor at addr 2 failed, USB_ERR_IOERROR ugen0.3: at usbus0 (disconnected) uhub_reattach_port: could not allocate new device Root mount waiting for: usbus0 ugen0.3: at usbus0 hid_get_item: Number of items truncated to 255 re0: link state changed to DOWN re0: link state changed to UP uhid0: on usbus0 hid_get_item: Number of items truncated to 255 uhid1: on usbus0 hid_get_item: Number of items truncated to 255 hid_get_item: Number of items truncated to 255 hid_get_item: Number of items truncated to 255