early console in setup code early console in extract_kernel input_data: 0x00000000062252c8 input_len: 0x00000000015ef68d output: 0x0000000001000000 output_len: 0x00000000059cf9a8 kernel_total_size: 0x0000000006c26000 trampoline_32bit: 0x000000000009d000 Decompressing Linux... Parsing ELF... done. Booting the kernel. [ 0.000000] Linux version 5.2.0-rc1-00387-g47cdee29 (kbuild@lkp-kbuild06) (gcc version 6.4.0 20171026 (Debian 6.4.0-9)) #1 SMP PREEMPT Tue Jun 4 16:11:00 CST 2019 [ 0.000000] Command line: root=/dev/ram0 hung_task_panic=1 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw link=/cephfs/kbuild/run-queue/yocto-vm-yocto/x86_64-randconfig-ne0-06030921+CONFIG_KASAN/linux-devel:fixup-47cdee29ef9d94e485eb08f962c74943023a5271:47cdee29ef9d94e485eb08f962c74943023a5271:bisect-linux-46/.vmlinuz-47cdee29ef9d94e485eb08f962c74943023a5271-20190604162844-6:yocto-vm-yocto-202 branch=linux-devel/fixup-47cdee29ef9d94e485eb08f962c74943023a5271 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-ne0-06030921+CONFIG_KASAN/gcc-6/47cdee29ef9d94e485eb08f962c74943023a5271/vmlinuz-5.2.0-rc1-00387-g47cdee29 drbd.minor_count=8 rcuperf.shutdown=0 [ 0.000000] x86/fpu: x87 FPU will use FXSAVE [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000001ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000001ffe0000-0x000000001fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] printk: debug: ignoring loglevel setting. [ 0.000000] printk: bootconsole [earlyser0] enabled [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 0.000000] Hypervisor detected: KVM [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000031] kvm-clock: cpu 0, msr 7a01001, primary cpu clock [ 0.000032] kvm-clock: using sched offset of 33565616772 cycles [ 0.009917] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.038400] tsc: Detected 2393.998 MHz processor [ 0.070066] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.082214] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.095370] last_pfn = 0x1ffe0 max_arch_pfn = 0x400000000 [ 0.104737] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC [ 0.114909] Scan for SMP in [mem 0x00000000-0x000003ff] [ 0.122396] Scan for SMP in [mem 0x0009fc00-0x0009ffff] [ 0.129859] Scan for SMP in [mem 0x000f0000-0x000fffff] [ 0.211421] found SMP MP-table at [mem 0x000f6a80-0x000f6a8f] [ 0.222374] mpc: f6a90-f6b74 [ 0.228885] check: Scanning 1 areas for low memory corruption [ 0.240068] BRK [0x07c01000, 0x07c01fff] PGTABLE [ 0.249231] BRK [0x07c02000, 0x07c02fff] PGTABLE [ 0.257665] BRK [0x07c03000, 0x07c03fff] PGTABLE [ 0.268679] BRK [0x07c04000, 0x07c04fff] PGTABLE [ 0.320493] BRK [0x07c05000, 0x07c05fff] PGTABLE [ 0.328925] BRK [0x07c06000, 0x07c06fff] PGTABLE [ 0.338642] RAMDISK: [mem 0x1fa0e000-0x1ffdffff] [ 0.347099] ACPI: Early table checksum verification disabled [ 0.358159] ACPI: RSDP 0x00000000000F6870 000014 (v00 BOCHS ) [ 0.368748] ACPI: RSDT 0x000000001FFE15C9 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.384407] ACPI: FACP 0x000000001FFE149D 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.399468] ACPI: DSDT 0x000000001FFE0040 00145D (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.414865] ACPI: FACS 0x000000001FFE0000 000040 [ 0.422999] ACPI: APIC 0x000000001FFE1511 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.438553] ACPI: HPET 0x000000001FFE1591 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.454048] ACPI: Local APIC address 0xfee00000 [ 0.462045] mapped APIC to ffffffffff5fd000 ( fee00000) [ 0.477308] No NUMA configuration found [ 0.484347] Faking a node at [mem 0x0000000000000000-0x000000001ffdffff] [ 0.496365] NODE_DATA(0) allocated [mem 0x1fa0a000-0x1fa0dfff] [ 0.506671] cma: dma_contiguous_reserve(limit 1ffe0000) [ 0.518754] Zone ranges: [ 0.523326] DMA32 [mem 0x0000000000001000-0x000000001ffdffff] [ 0.534248] Normal empty [ 0.539499] Movable zone start for each node [ 0.547183] Early memory node ranges [ 0.553109] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.563669] node 0: [mem 0x0000000000100000-0x000000001ffdffff] [ 0.576249] Zeroed struct page in unavailable ranges: 98 pages [ 0.576306] Initmem setup node 0 [mem 0x0000000000001000-0x000000001ffdffff] [ 0.597572] On node 0 totalpages: 130942 [ 0.604183] DMA32 zone: 1792 pages used for memmap [ 0.612346] DMA32 zone: 21 pages reserved [ 0.619376] DMA32 zone: 130942 pages, LIFO batch:31 [ 0.819125] kasan: KernelAddressSanitizer initialized [ 0.831968] ACPI: PM-Timer IO Port: 0x608 [ 0.839190] ACPI: Local APIC address 0xfee00000 [ 0.846445] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.854746] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.903940] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.919331] Int: type 0, pol 0, trig 0, bus 00, IRQ 00, APIC ID 0, APIC INT 02 [ 0.932352] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.944052] Int: type 0, pol 1, trig 3, bus 00, IRQ 05, APIC ID 0, APIC INT 05 [ 0.956138] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.967678] Int: type 0, pol 1, trig 3, bus 00, IRQ 09, APIC ID 0, APIC INT 09 [ 0.980414] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.992337] Int: type 0, pol 1, trig 3, bus 00, IRQ 0a, APIC ID 0, APIC INT 0a [ 1.004659] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 1.016843] Int: type 0, pol 1, trig 3, bus 00, IRQ 0b, APIC ID 0, APIC INT 0b [ 1.029736] ACPI: IRQ0 used by override. [ 1.036868] Int: type 0, pol 0, trig 0, bus 00, IRQ 01, APIC ID 0, APIC INT 01 [ 1.048433] Int: type 0, pol 0, trig 0, bus 00, IRQ 03, APIC ID 0, APIC INT 03 [ 1.058477] Int: type 0, pol 0, trig 0, bus 00, IRQ 04, APIC ID 0, APIC INT 04 [ 1.070598] ACPI: IRQ5 used by override. [ 1.075875] Int: type 0, pol 0, trig 0, bus 00, IRQ 06, APIC ID 0, APIC INT 06 [ 1.079126] Int: type 0, pol 0, trig 0, bus 00, IRQ 07, APIC ID 0, APIC INT 07 [ 1.081913] Int: type 0, pol 0, trig 0, bus 00, IRQ 08, APIC ID 0, APIC INT 08 [ 1.090164] ACPI: IRQ9 used by override. [ 1.096932] ACPI: IRQ10 used by override. [ 1.104002] ACPI: IRQ11 used by override. [ 1.110971] Int: type 0, pol 0, trig 0, bus 00, IRQ 0c, APIC ID 0, APIC INT 0c [ 1.121244] Int: type 0, pol 0, trig 0, bus 00, IRQ 0d, APIC ID 0, APIC INT 0d [ 1.131738] Int: type 0, pol 0, trig 0, bus 00, IRQ 0e, APIC ID 0, APIC INT 0e [ 1.143862] Int: type 0, pol 0, trig 0, bus 00, IRQ 0f, APIC ID 0, APIC INT 0f [ 1.157081] Using ACPI (MADT) for SMP configuration information [ 1.168233] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 1.178085] smpboot: Allowing 2 CPUs, 0 hotplug CPUs [ 1.187284] mapped IOAPIC to ffffffffff5fc000 (fec00000) [ 1.197206] [mem 0x20000000-0xfeffbfff] available for PCI devices [ 1.208278] Booting paravirtualized kernel on KVM [ 1.216841] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns [ 9.077066] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:2 nr_node_ids:1 [ 9.121691] percpu: Embedded 514 pages/cpu s2076672 r0 d28672 u4194304 [ 9.133915] pcpu-alloc: s2076672 r0 d28672 u4194304 alloc=2*2097152 [ 9.145510] pcpu-alloc: [0] 0 [0] 1 [ 9.152417] KVM setup async PF for cpu 0 [ 9.159868] kvm-stealtime: cpu 0, msr 199fa040 [ 9.172759] Built 1 zonelists, mobility grouping on. Total pages: 129129 [ 9.185009] Policy zone: DMA32 [ 9.190745] Kernel command line: root=/dev/ram0 hung_task_panic=1 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw link=/cephfs/kbuild/run-queue/yocto-vm-yocto/x86_64-randconfig-ne0-06030921+CONFIG_KASAN/linux-devel:fixup-47cdee29ef9d94e485eb08f962c74943023a5271:47cdee29ef9d94e485eb08f962c74943023a5271:bisect-linux-46/.vmlinuz-47cdee29ef9d94e485eb08f962c74943023a5271-20190604162844-6:yocto-vm-yocto-202 branch=linux-devel/fixup-47cdee29ef9d94e485eb08f962c74943023a5271 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-ne0-06030921+CONFIG_KASAN/gcc-6/47cdee29ef9d94e485eb08f962c74943023a5271/vmlinuz-5.2.0-rc1-00387-g47cdee29 drbd.minor_count=8 rcuperf.shutdown=0 [ 9.353912] sysrq: sysrq always enabled. [ 10.285687] Memory: 151048K/523768K available (47108K kernel code, 12195K rwdata, 14284K rodata, 4620K init, 22724K bss, 212292K reserved, 0K cma-reserved) [ 10.312684] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 10.389617] ODEBUG: selftest passed [ 10.396840] ftrace: allocating 67060 entries in 262 pages [ 10.766574] [ 10.769656] ********************************************************** [ 10.781932] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 10.793667] ** ** [ 10.805242] ** trace_printk() being used. Allocating extra memory. ** [ 10.817095] ** ** [ 10.828665] ** This means that this is a DEBUG kernel and it is ** [ 10.840144] ** unsafe for production use. ** [ 10.851897] ** ** [ 10.864246] ** If you see this message and you are not debugging ** [ 10.876882] ** the kernel, report this immediately to your vendor! ** [ 10.889233] ** ** [ 10.901387] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 10.913769] ********************************************************** [ 11.005666] rcu: Preemptible hierarchical RCU implementation. [ 11.015944] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=2. [ 11.027540] rcu: RCU callback double-/use-after-free debug enabled. [ 11.038493] RCU CPU stall warnings timeout set to 100 (rcu_cpu_stall_timeout). [ 11.051431] Tasks RCU enabled. [ 11.057157] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 11.071000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 [ 11.260087] NR_IRQS: 4352, nr_irqs: 56, preallocated irqs: 16 [ 11.290065] random: get_random_bytes called from start_kernel+0x412/0x79a with crng_init=0 [ 11.308370] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 11.336308] printk: console [ttyS0] enabled [ 11.352088] printk: bootconsole [earlyser0] disabled [ 11.370499] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 11.385377] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 11.393569] ... MAX_LOCK_DEPTH: 48 [ 11.401441] ... MAX_LOCKDEP_KEYS: 8191 [ 11.409613] ... CLASSHASH_SIZE: 4096 [ 11.418101] ... MAX_LOCKDEP_ENTRIES: 32768 [ 11.426328] ... MAX_LOCKDEP_CHAINS: 65536 [ 11.434310] ... CHAINHASH_SIZE: 32768 [ 11.442338] memory used by lock dependency info: 4019 kB [ 11.452612] per task-struct memory footprint: 2688 bytes [ 11.457520] ------------------------ [ 11.459099] | Locking API testsuite: [ 11.460451] ---------------------------------------------------------------------------- [ 11.463153] | spin |wlock |rlock |mutex | wsem | rsem | [ 11.468101] -------------------------------------------------------------------------- [ 11.483136] A-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 11.559388] A-B-B-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 11.639894] A-B-B-C-C-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 11.723237] A-B-C-A-B-C deadlock:failed|failed| ok |failed|failed|failed|failed| [ 11.806097] A-B-B-C-C-D-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 11.898232] A-B-C-D-B-D-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 11.955495] A-B-C-D-B-C-D-A deadlock:failed|failed| ok |failed|failed|failed|failed| [ 12.015365] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 12.087349] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 12.141692] -------------------------------------------------------------------------- [ 12.144468] recursive read-lock: | ok | |failed| [ 12.169883] recursive read-lock #2: | ok | |failed| [ 12.202256] mixed read-write-lock: |failed| |failed| [ 12.232526] mixed write-read-lock: |failed| |failed| [ 12.264955] mixed read-lock/lock-write ABBA: |failed| |failed| [ 12.271888] mixed read-lock/lock-read ABBA: | ok | |failed| [ 12.286033] mixed write-lock/lock-write ABBA: |failed| |failed| [ 12.317301] -------------------------------------------------------------------------- [ 12.345753] hard-irqs-on + irq-safe-A/12:failed|failed| ok | [ 12.380562] soft-irqs-on + irq-safe-A/12:failed|failed| ok | [ 12.392818] hard-irqs-on + irq-safe-A/21:failed|failed| ok | [ 12.417168] soft-irqs-on + irq-safe-A/21:failed|failed| ok | [ 12.452266] sirq-safe-A => hirqs-on/12:failed|failed| ok | [ 12.486944] sirq-safe-A => hirqs-on/21:failed|failed| ok | [ 12.521903] hard-safe-A + irqs-on/12:failed|failed| ok | [ 12.557558] soft-safe-A + irqs-on/12:failed|failed| ok | [ 12.594979] hard-safe-A + irqs-on/21:failed|failed| ok | [ 12.658010] soft-safe-A + irqs-on/21:failed|failed| ok | [ 12.695569] hard-safe-A + unsafe-B #1/123:failed|failed| ok | [ 12.734100] soft-safe-A + unsafe-B #1/123:failed|failed| ok | [ 12.772053] hard-safe-A + unsafe-B #1/132:failed|failed| ok | [ 12.810383] soft-safe-A + unsafe-B #1/132:failed|failed| ok | [ 12.847656] hard-safe-A + unsafe-B #1/213:failed|failed| ok | [ 12.885243] soft-safe-A + unsafe-B #1/213:failed|failed| ok | [ 12.923064] hard-safe-A + unsafe-B #1/231:failed|failed| ok | [ 12.960490] soft-safe-A + unsafe-B #1/231:failed|failed| ok | [ 12.997922] hard-safe-A + unsafe-B #1/312:failed|failed| ok | [ 13.035060] soft-safe-A + unsafe-B #1/312:failed|failed| ok | [ 13.054751] hard-safe-A + unsafe-B #1/321:failed|failed| ok | [ 13.073285] soft-safe-A + unsafe-B #1/321:failed|failed| ok | [ 13.105593] hard-safe-A + unsafe-B #2/123:failed|failed| ok | [ 13.116023] soft-safe-A + unsafe-B #2/123:failed|failed| ok | [ 13.152351] hard-safe-A + unsafe-B #2/132:failed|failed| ok | [ 13.189002] soft-safe-A + unsafe-B #2/132:failed|failed| ok | [ 13.225592] hard-safe-A + unsafe-B #2/213:failed|failed| ok | [ 13.258007] soft-safe-A + unsafe-B #2/213:failed|failed| ok | [ 13.266488] hard-safe-A + unsafe-B #2/231:failed|failed| ok | [ 13.303818] soft-safe-A + unsafe-B #2/231:failed|failed| ok | [ 13.341466] hard-safe-A + unsafe-B #2/312:failed|failed| ok | [ 13.379100] soft-safe-A + unsafe-B #2/312:failed|failed| ok | [ 13.415710] hard-safe-A + unsafe-B #2/321:failed|failed| ok | [ 13.429135] soft-safe-A + unsafe-B #2/321:failed|failed| ok | [ 13.457356] hard-irq lock-inversion/123:failed|failed| ok | [ 13.494010] soft-irq lock-inversion/123:failed|failed| ok | [ 13.530400] hard-irq lock-inversion/132:failed|failed| ok | [ 13.567636] soft-irq lock-inversion/132:failed|failed| ok | [ 13.604710] hard-irq lock-inversion/213:failed|failed| ok | [ 13.639522] soft-irq lock-inversion/213:failed|failed| ok | [ 13.647563] hard-irq lock-inversion/231:failed|failed| ok | [ 13.680924] soft-irq lock-inversion/231:failed|failed| ok | [ 13.692172] hard-irq lock-inversion/312:failed|failed| ok | [ 13.725020] soft-irq lock-inversion/312:failed|failed| ok | [ 13.751060] hard-irq lock-inversion/321:failed|failed| ok | [ 13.762868] soft-irq lock-inversion/321:failed|failed| ok | [ 13.801004] hard-irq read-recursion/123: ok | [ 13.819028] soft-irq read-recursion/123: ok | [ 13.835662] hard-irq read-recursion/132: ok | [ 13.840019] soft-irq read-recursion/132: ok | [ 13.843340] hard-irq read-recursion/213: ok | [ 13.849994] soft-irq read-recursion/213: ok | [ 13.868171] hard-irq read-recursion/231: ok | [ 13.882597] soft-irq read-recursion/231: ok | [ 13.887015] hard-irq read-recursion/312: ok | [ 13.890398] soft-irq read-recursion/312: ok | [ 13.904846] hard-irq read-recursion/321: ok | [ 13.923093] soft-irq read-recursion/321: ok | [ 13.929945] -------------------------------------------------------------------------- [ 13.932841] | Wound/wait tests | [ 13.933933] --------------------- [ 13.934948] ww api failures: ok | ok | ok | [ 13.968389] ww contexts mixing:failed| ok | [ 13.994640] finishing ww context: ok | ok | ok | ok | [ 14.014060] locking mismatches: ok | ok | ok | [ 14.045460] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 14.142922] spinlock nest unlocked: ok | [ 14.146503] ----------------------------------------------------- [ 14.148362] |block | try |context| [ 14.152201] ----------------------------------------------------- [ 14.163443] context:failed| ok | ok | [ 14.201332] try:failed| ok |failed| [ 14.236886] block:failed| ok |failed| [ 14.272496] spinlock:failed| ok |failed| [ 14.310318] -------------------------------------------------------- [ 14.321494] 153 out of 262 testcases failed, as expected. | [ 14.331381] ---------------------------------------------------- [ 14.352341] ACPI: Core revision 20190509 [ 14.370107] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 14.387545] hpet clockevent registered [ 14.396323] APIC: Switch to symmetric I/O mode setup [ 14.407021] enabled ExtINT on CPU#0 [ 14.439431] ENABLING IO-APIC IRQs [ 14.447469] init IO_APIC IRQs [ 14.456954] apic 0 pin 0 not connected [ 14.482006] IOAPIC[0]: Set routing entry (0-1 -> 0xef -> IRQ 1 Mode:0 Active:0 Dest:1) [ 14.504825] IOAPIC[0]: Set routing entry (0-2 -> 0x30 -> IRQ 0 Mode:0 Active:0 Dest:1) [ 14.520186] IOAPIC[0]: Set routing entry (0-3 -> 0xef -> IRQ 3 Mode:0 Active:0 Dest:1) [ 14.541411] IOAPIC[0]: Set routing entry (0-4 -> 0xef -> IRQ 4 Mode:0 Active:0 Dest:1) [ 14.544835] IOAPIC[0]: Set routing entry (0-5 -> 0xef -> IRQ 5 Mode:1 Active:0 Dest:1) [ 14.547561] IOAPIC[0]: Set routing entry (0-6 -> 0xef -> IRQ 6 Mode:0 Active:0 Dest:1) [ 14.553498] IOAPIC[0]: Set routing entry (0-7 -> 0xef -> IRQ 7 Mode:0 Active:0 Dest:1) [ 14.569151] IOAPIC[0]: Set routing entry (0-8 -> 0xef -> IRQ 8 Mode:0 Active:0 Dest:1) [ 14.584869] IOAPIC[0]: Set routing entry (0-9 -> 0xef -> IRQ 9 Mode:1 Active:0 Dest:1) [ 14.600915] IOAPIC[0]: Set routing entry (0-10 -> 0xef -> IRQ 10 Mode:1 Active:0 Dest:1) [ 14.617245] IOAPIC[0]: Set routing entry (0-11 -> 0xef -> IRQ 11 Mode:1 Active:0 Dest:1) [ 14.633251] IOAPIC[0]: Set routing entry (0-12 -> 0xef -> IRQ 12 Mode:0 Active:0 Dest:1) [ 14.649427] IOAPIC[0]: Set routing entry (0-13 -> 0xef -> IRQ 13 Mode:0 Active:0 Dest:1) [ 14.665304] IOAPIC[0]: Set routing entry (0-14 -> 0xef -> IRQ 14 Mode:0 Active:0 Dest:1) [ 14.681378] IOAPIC[0]: Set routing entry (0-15 -> 0xef -> IRQ 15 Mode:0 Active:0 Dest:1) [ 14.697161] apic 0 pin 16 not connected [ 14.704679] apic 0 pin 17 not connected [ 14.712458] apic 0 pin 18 not connected [ 14.720065] apic 0 pin 19 not connected [ 14.727714] apic 0 pin 20 not connected [ 14.735107] apic 0 pin 21 not connected [ 14.742719] apic 0 pin 22 not connected [ 14.750436] apic 0 pin 23 not connected [ 14.761387] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 14.773023] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x22821188adc, max_idle_ns: 440795282349 ns [ 14.801541] Calibrating delay loop (skipped) preset value.. 4787.99 BogoMIPS (lpj=9575992) [ 14.805667] pid_max: default: 4096 minimum: 301 [ 14.822531] LSM: Security Framework initializing [ 14.829988] Yama: becoming mindful. [ 14.838378] LoadPin: ready to pin (currently not enforcing) [ 14.847712] Smack: Initializing. [ 14.849578] Smack: IPv6 port labeling enabled. [ 14.859933] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes) [ 14.867994] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes) [ 14.875601] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 14.878182] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes) [ 14.916420] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 14.917600] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 14.921659] Spectre V2 : Spectre mitigation: kernel not compiled with retpoline; no mitigation available! [ 14.921670] Speculative Store Bypass: Vulnerable [ 14.933702] MDS: Vulnerable: Clear CPU buffers attempted, no microcode [ 14.943993] debug: unmapping init [mem 0xffffffff865c2000-0xffffffff865cefff] [ 14.976675] TSC deadline timer enabled [ 14.977471] smpboot: CPU0: Intel Core Processor (Haswell) (family: 0x6, model: 0x3c, stepping: 0x4) [ 15.002609] Performance Events: unsupported p6 CPU model 60 no PMU driver, software events only. [ 15.013863] rcu: Hierarchical SRCU implementation. [ 15.132426] NMI watchdog: Perf NMI watchdog permanently disabled [ 15.149832] smp: Bringing up secondary CPUs ... [ 15.297471] x86: Booting SMP configuration: [ 15.301662] .... node #0, CPUs: #1 [ 3.457577] kvm-clock: cpu 1, msr 7a01041, secondary cpu clock [ 3.457577] masked ExtINT on CPU#1 [ 15.342540] KVM setup async PF for cpu 1 [ 15.342540] kvm-stealtime: cpu 1, msr 19dfa040 [ 15.385757] smp: Brought up 1 node, 2 CPUs [ 15.390089] smpboot: Max logical packages: 2 [ 15.393666] smpboot: Total of 2 processors activated (9575.99 BogoMIPS) [ 15.417632] node 0 initialised, 40107 pages in 4ms [ 15.425726] pgdatinit0 (19) used greatest stack depth: 30184 bytes left [ 15.427780] devtmpfs: initialized [ 15.443673] x86/mm: Memory block size: 128MB [ 15.562281] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 15.565703] futex hash table entries: 16 (order: -1, 2048 bytes) [ 15.570823] xor: measuring software checksum speed [ 15.609630] prefetch64-sse: 1042.000 MB/sec [ 15.653632] generic_sse: 839.000 MB/sec [ 15.657662] xor: using function: prefetch64-sse (1042.000 MB/sec) [ 15.661767] prandom: seed boundary self test passed [ 15.682374] prandom: 100 self tests passed [ 15.685663] pinctrl core: initialized pinctrl subsystem [ 15.732720] PM: RTC time: 16:29:51, date: 2019-06-04 [ 15.748937] _warn_unseeded_randomness: 6 callbacks suppressed [ 15.749471] random: get_random_u32 called from bucket_table_alloc+0x210/0x286 with crng_init=0 [ 15.754995] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 15.757834] random: get_random_u32 called from bucket_table_alloc+0x210/0x286 with crng_init=0 [ 15.767777] NET: Registered protocol family 16 [ 15.845726] cpuidle: using governor ladder [ 15.852434] ACPI: bus type PCI registered [ 15.853901] PCI: Using configuration type 1 for base access [ 17.234272] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 17.454993] cryptd: max_cpu_qlen set to 1000 [ 17.738508] _warn_unseeded_randomness: 9 callbacks suppressed [ 17.738508] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 17.764774] random: get_random_u64 called from copy_process+0x5b5/0x4642 with crng_init=0 [ 17.788158] raid6: using algorithm sse2x4 gen() 0 MB/s [ 17.789958] raid6: .... xor() 0 MB/s, rmw enabled [ 17.794406] raid6: using ssse3x2 recovery algorithm [ 17.798905] gpio-f7188x: Not a Fintek device at 0x0000002e [ 17.801166] gpio-f7188x: Not a Fintek device at 0x0000004e [ 17.815571] ACPI: Added _OSI(Module Device) [ 17.817664] ACPI: Added _OSI(Processor Device) [ 17.821639] ACPI: Added _OSI(3.0 _SCP Extensions) [ 17.825667] ACPI: Added _OSI(Processor Aggregator Device) [ 17.829965] ACPI: Added _OSI(Linux-Dell-Video) [ 17.833990] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio) [ 17.837953] ACPI: Added _OSI(Linux-HPI-Hybrid-Graphics) [ 18.338881] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 18.537222] ACPI: Interpreter enabled [ 18.542827] ACPI: (supports S0 S5) [ 18.550217] ACPI: Using IOAPIC for interrupt routing [ 18.561388] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [ 18.628838] ACPI: Enabled 2 GPEs in block 00 to 0F [ 20.180587] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 20.190315] acpi PNP0A03:00: _OSC: OS supports [Segments HPX-Type3] [ 20.194907] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 20.199740] PCI host bridge to bus 0000:00 [ 20.209983] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 20.217824] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 20.229924] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 20.241917] pci_bus 0000:00: root bus resource [mem 0x20000000-0xfebfffff window] [ 20.253832] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] [ 20.265858] pci_bus 0000:00: root bus resource [bus 00-ff] [ 20.274986] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 20.340547] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 20.412899] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 [ 20.457792] pci 0000:00:01.1: reg 0x20: [io 0xc040-0xc04f] [ 20.489926] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 20.497517] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 20.499897] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 20.501522] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 20.548257] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 [ 20.559388] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 20.561532] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 20.610937] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 [ 20.633864] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref] [ 20.673795] pci 0000:00:02.0: reg 0x18: [mem 0xfebf0000-0xfebf0fff] [ 20.725770] pci 0000:00:02.0: reg 0x30: [mem 0xfebe0000-0xfebeffff pref] [ 20.803934] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 20.825691] pci 0000:00:03.0: reg 0x10: [mem 0xfebc0000-0xfebdffff] [ 20.849665] pci 0000:00:03.0: reg 0x14: [io 0xc000-0xc03f] [ 20.912927] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref] [ 20.958375] pci 0000:00:04.0: [8086:25ab] type 00 class 0x088000 [ 20.969323] pci 0000:00:04.0: reg 0x10: [mem 0xfebf1000-0xfebf100f] [ 21.201994] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 21.235967] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 21.253167] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 21.286104] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 21.298312] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 21.425849] pci 0000:00:02.0: vgaarb: setting as boot VGA device [ 21.427721] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [ 21.429695] pci 0000:00:02.0: vgaarb: bridge control possible [ 21.433632] vgaarb: loaded [ 21.459900] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 21.476162] ACPI: bus type USB registered [ 21.482314] usbcore: registered new interface driver usbfs [ 21.487894] usbcore: registered new interface driver hub [ 21.492457] usbcore: registered new device driver usb [ 21.512419] media: Linux media interface: v0.10 [ 21.514151] videodev: Linux video capture interface: v2.00 [ 21.518973] pps_core: LinuxPPS API ver. 1 registered [ 21.520396] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 21.530705] random: get_random_u64 called from copy_process+0x5b5/0x4642 with crng_init=0 [ 21.569320] FPGA manager framework [ 21.580095] Advanced Linux Sound Architecture Driver Initialized. [ 21.584322] PCI: Using ACPI for IRQ routing [ 21.585642] PCI: pci_cache_line_size set to 64 bytes [ 21.591999] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 21.593958] e820: reserve RAM buffer [mem 0x1ffe0000-0x1fffffff] [ 21.631260] random: get_random_u32 called from bucket_table_alloc+0x210/0x286 with crng_init=0 [ 21.636518] Bluetooth: Core ver 2.22 [ 21.639707] NET: Registered protocol family 31 [ 21.641724] Bluetooth: HCI device and connection manager initialized [ 21.646025] Bluetooth: HCI socket layer initialized [ 21.649824] Bluetooth: L2CAP socket layer initialized [ 21.654507] Bluetooth: SCO socket layer initialized [ 21.658407] NET: Registered protocol family 8 [ 21.661640] NET: Registered protocol family 20 [ 21.667669] NetLabel: Initializing [ 21.669770] NetLabel: domain hash size = 128 [ 21.673636] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 21.684096] NetLabel: unlabeled traffic allowed by default [ 21.709471] clocksource: Switched to clocksource kvm-clock [ 31.953035] _warn_unseeded_randomness: 1 callbacks suppressed [ 31.953104] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 31.997174] VFS: Disk quotas dquot_6.6.0 [ 32.007093] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 32.027636] FS-Cache: Loaded [ 32.044612] pnp: PnP ACPI init [ 32.065168] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) [ 32.090732] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) [ 32.114617] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) [ 32.130945] pnp 00:03: [dma 2] [ 32.142064] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) [ 32.173466] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active) [ 32.202948] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active) [ 32.232829] pnp 00:06: Plug and Play ACPI device, IDs PNP0501 (active) [ 32.338864] pnp: PnP ACPI: found 7 devices [ 32.440150] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 32.460790] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [ 32.472816] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [ 32.484512] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [ 32.497343] pci_bus 0000:00: resource 7 [mem 0x20000000-0xfebfffff window] [ 32.510441] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] [ 32.548131] NET: Registered protocol family 2 [ 32.558207] random: get_random_u32 called from neigh_hash_alloc+0x11a/0x15d with crng_init=0 [ 32.580492] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 32.628681] tcp_listen_portaddr_hash hash table entries: 256 (order: 2, 22528 bytes) [ 32.646597] TCP established hash table entries: 4096 (order: 3, 32768 bytes) [ 32.663164] TCP bind hash table entries: 4096 (order: 6, 327680 bytes) [ 32.678781] TCP: Hash tables configured (established 4096 bind 4096) [ 32.699519] UDP hash table entries: 256 (order: 3, 49152 bytes) [ 32.712653] UDP-Lite hash table entries: 256 (order: 3, 49152 bytes) [ 32.736721] NET: Registered protocol family 1 [ 32.767956] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 32.778453] pci 0000:00:00.0: quirk_passive_release+0x0/0xdb took 10408 usecs [ 32.790808] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 32.801205] pci 0000:00:00.0: quirk_natoma+0x0/0x92 took 10121 usecs [ 32.812707] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 32.823594] pci 0000:00:01.0: quirk_isa_dma_hangs+0x0/0x63 took 10578 usecs [ 32.836565] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 32.851073] pci 0000:00:02.0: pci_fixup_video+0x0/0x263 took 14460 usecs [ 32.863202] PCI: CLS 0 bytes, default 64 [ 32.883058] Unpacking initramfs... [ 39.822707] debug: unmapping init [mem 0xffff88801fa0e000-0xffff88801ffdffff] [ 39.877988] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x22821188adc, max_idle_ns: 440795282349 ns [ 39.943768] check: Scanning for low memory corruption every 60 seconds [ 40.080176] PCLMULQDQ-NI instructions are not detected. [ 40.109115] AVX or AES-NI instructions are not detected. [ 40.120264] CPU feature 'AVX registers' is not supported. [ 40.130633] CPU feature 'AVX registers' is not supported. [ 40.141065] CPU feature 'AVX registers' is not supported. [ 40.151205] CPU feature 'AVX registers' is not supported. [ 40.160961] AVX2 or AES-NI instructions are not detected. [ 40.170880] AVX2 instructions are not detected. [ 40.183644] spin_lock-torture:--- Start of test [debug]: nwriters_stress=4 nreaders_stress=0 stat_interval=60 verbose=1 shuffle_interval=3 stutter=5 shutdown_secs=0 onoff_interval=0 onoff_holdoff=0 [ 40.214590] spin_lock-torture: Creating torture_shuffle task [ 40.229414] spin_lock-torture: torture_shuffle task started [ 40.230697] spin_lock-torture: Creating torture_stutter task [ 40.266671] spin_lock-torture: Creating lock_torture_writer task [ 40.278563] spin_lock-torture: torture_stutter task started [ 40.284769] spin_lock-torture: Creating lock_torture_writer task [ 40.289968] spin_lock-torture: lock_torture_writer task started [ 40.302844] spin_lock-torture: Creating lock_torture_writer task [ 40.322933] spin_lock-torture: lock_torture_writer task started [ 40.336550] spin_lock-torture: Creating lock_torture_writer task [ 40.349832] spin_lock-torture: lock_torture_writer task started [ 40.364177] spin_lock-torture: Creating lock_torture_stats task [ 40.364323] spin_lock-torture: lock_torture_writer task started [ 40.381808] spin_lock-torture: lock_torture_stats task started [ 40.933910] _warn_unseeded_randomness: 10 callbacks suppressed [ 40.934003] random: get_random_u32 called from get_random_order+0x9a/0x11e with crng_init=0 [ 44.980362] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 44.980436] random: get_random_u32 called from get_random_order+0x9a/0x11e with crng_init=0 [ 45.041161] random: get_random_u32 called from stress_one_work+0x71/0x122 with crng_init=0 [ 47.418658] torture_init_begin: Refusing rcu init: spin_lock running. [ 47.438967] torture_init_begin: One torture test at a time! [ 47.451638] torture_init_begin: Refusing rcu init: spin_lock running. [ 47.463475] torture_init_begin: One torture test at a time! [ 47.507031] _warn_unseeded_randomness: 6 callbacks suppressed [ 47.507121] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 47.667155] random: get_random_u64 called from copy_process+0x5b5/0x4642 with crng_init=0 [ 47.731952] workingset: timestamp_bits=56 max_order=17 bucket_order=0 [ 47.753342] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 47.841839] DLM installed [ 47.864685] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 47.904608] ntfs: driver 2.1.32 [Flags: R/O]. [ 47.919873] QNX4 filesystem 0.2.3 registered. [ 47.952844] orangefs_debugfs_init: called with debug mask: :none: :0: [ 47.975140] orangefs_init: module version upstream loaded [ 47.992438] JFS: nTxBlock = 2433, nTxLock = 19467 [ 48.036389] SGI XFS with security attributes, realtime, no debug enabled [ 48.098599] befs: version: 0.9.3 [ 48.140307] ocfs2: Registered cluster interface user [ 48.155277] OCFS2 User DLM kernel interface loaded [ 48.274537] gfs2: GFS2 installed [ 48.343395] NET: Registered protocol family 38 [ 48.343834] cryptomgr_test (180) used greatest stack depth: 30144 bytes left [ 48.358495] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 243) [ 48.379396] io scheduler mq-deadline registered [ 48.387666] io scheduler kyber registered [ 53.169014] String selftests succeeded [ 53.223130] crc32: CRC_LE_BITS = 32, CRC_BE BITS = 32 [ 53.233144] crc32: self tests passed, processed 225944 bytes in 7290431 nsec [ 53.259779] crc32c: CRC_LE_BITS = 32 [ 53.266937] crc32c: self tests passed, processed 225944 bytes in 3887650 nsec [ 53.810643] crc32_combine: 8373 self tests passed [ 54.349828] crc32c_combine: 8373 self tests passed [ 54.365046] glob: 64 self-tests passed, 0 failed [ 54.374151] _warn_unseeded_randomness: 15 callbacks suppressed [ 54.374285] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 54.457206] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 54.459189] kobject: '104-dio-48e' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 54.471689] kobject: '104-idio-16' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 54.492559] kobject: '104-idi-48' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 54.514849] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 54.540904] kobject: 'gpio-mm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 54.564757] gpio_it87: no device [ 54.584786] gpio_winbond: chip ID at 2e is ffff [ 54.593981] gpio_winbond: not an our chip [ 54.602441] gpio_winbond: chip ID at 4e is ffff [ 54.612166] gpio_winbond: not an our chip [ 54.623951] kobject: 'gpio_winbond.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 54.643403] kobject: 'gpio_winbond' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 54.663946] kobject: 'ws16c48' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 54.728301] no IO addresses supplied [ 54.747101] hgafb: HGA card not detected. [ 54.755942] hgafb: probe of hgafb.0 failed with error -22 [ 54.774669] usbcore: registered new interface driver udlfb [ 54.786984] usbcore: registered new interface driver smscufx [ 54.842791] uvesafb: failed to execute /sbin/v86d [ 54.842824] kworker/u4:4 (182) used greatest stack depth: 28832 bytes left [ 54.864705] uvesafb: make sure that the v86d helper is installed and executable [ 54.903492] uvesafb: Getting VBE info block failed (eax=0x4f00, err=-2) [ 54.915932] uvesafb: vbe_init() failed with -22 [ 54.924520] uvesafb: probe of uvesafb.0 failed with error -22 [ 54.938292] intel_idle: Please enable MWAIT in BIOS SETUP [ 54.959196] IPMI message handler: version 39.2 [ 54.969501] ipmi_si: IPMI System Interface driver [ 54.982697] kobject: 'ipmi_si' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 55.000650] kobject: 'ipmi_si' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 55.039698] ipmi_si: Unable to find any System Interface(s) [ 55.050675] IPMI Watchdog: driver initialized [ 55.058560] IPMI poweroff: Copyright (C) 2004 MontaVista Software - IPMI Powerdown via sys_reboot [ 55.096797] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 55.123779] ACPI: Power Button [PWRF] [ 55.140051] kobject: 'input' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 55.170745] kobject: 'input0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 55.196595] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input1 [ 55.242551] ACPI: Power Button [PWRF] [ 55.269389] kobject: 'thermal' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 55.291282] kobject: 'cooling_device0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 55.351772] kobject: 'cooling_device1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 55.383521] _warn_unseeded_randomness: 12 callbacks suppressed [ 55.383591] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 59.258387] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled [ 59.437862] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 59.462534] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 59.490941] kobject: 'serial0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 59.520180] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 59.592155] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 59.660492] kobject: 'tty' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 59.696001] kobject: 'ttyS0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 59.722452] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 59.754500] printk: console [ttyS0] disabled [ 59.880591] printk: console [ttyS0] enabled [ 59.923974] kobject: 'serial1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 60.038709] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 60.075655] kobject: 'serial2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 60.142118] kobject: 'tty' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.161146] kobject: 'ttyS1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 60.180064] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 60.318963] 00:06: ttyS1 at I/O 0x2f8 (irq = 3, base_baud = 115200) is a 16550A [ 60.339766] kobject: 'serial3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 60.405738] kobject: 'serial4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 60.443424] kobject: 'serial5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 60.474170] _warn_unseeded_randomness: 10 callbacks suppressed [ 60.474307] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 60.561185] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 60.582510] kobject: 'ttyS2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 60.606713] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 60.642684] kobject: 'serial6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.647445] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 60.689810] kobject: 'ttyS3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.706558] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.739077] kobject: 'serial7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.788361] Non-volatile memory driver v1.3 [ 60.810364] telclk_interrupt = 0xf non-mcpbl0010 hw. [ 60.823156] kobject: 'telco_clock' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.846520] Hangcheck: starting hangcheck timer 0.9.1 (tick is 180 seconds, margin is 60 seconds). [ 60.872480] kobject: 'tpm_atmel' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 60.906762] drm_mm: Testing DRM range manger (struct drm_mm), with random_seed=0xb5119d4b max_iterations=8192 max_prime=128 [ 60.927289] drm_mm: igt_sanitycheck - ok! [ 60.935801] igt_debug 0x0000000000000000-0x0000000000000200: 512: free [ 60.949387] igt_debug 0x0000000000000200-0x0000000000000600: 1024: used [ 60.966615] igt_debug 0x0000000000000600-0x0000000000000a00: 1024: free [ 60.980096] igt_debug 0x0000000000000a00-0x0000000000000e00: 1024: used [ 60.992778] igt_debug 0x0000000000000e00-0x0000000000001000: 512: free [ 61.016046] igt_debug total: 4096, used 2048 free 2048 [ 101.750799] Writes: Total: 1264873 Max/Min: 0/0 Fail: 0 [ 163.191383] Writes: Total: 2762560 Max/Min: 0/0 Fail: 0 [ 224.630661] Writes: Total: 4254799 Max/Min: 0/0 Fail: 0 [ 286.070516] Writes: Total: 5762564 Max/Min: 0/0 Fail: 0 [ 347.515145] Writes: Total: 7474930 Max/Min: 0/0 Fail: 0 [ 408.950583] Writes: Total: 9334047 Max/Min: 0/0 Fail: 0 [ 470.390841] Writes: Total: 10816770 Max/Min: 0/0 Fail: 0 [ 531.830342] Writes: Total: 12258160 Max/Min: 0/0 Fail: 0 [ 593.274718] Writes: Total: 13841775 Max/Min: 0/0 Fail: 0 [ 654.710390] Writes: Total: 15530189 Max/Min: 0/0 Fail: 0 [ 716.150948] Writes: Total: 17174432 Max/Min: 0/0 Fail: 0 [ 777.589655] Writes: Total: 18634471 Max/Min: 0/0 Fail: 0 [ 839.030423] Writes: Total: 19930535 Max/Min: 0/0 Fail: 0 [ 900.470380] Writes: Total: 21866713 Max/Min: 0/0 Fail: 0 [ 961.910572] Writes: Total: 23416101 Max/Min: 0/0 Fail: 0 [ 1023.350753] Writes: Total: 25087671 Max/Min: 0/0 Fail: 0 [ 1084.815720] Writes: Total: 26968147 Max/Min: 0/0 Fail: 0 [ 1146.238789] Writes: Total: 28556113 Max/Min: 0/0 Fail: 0 [ 1207.670133] Writes: Total: 30161614 Max/Min: 0/0 Fail: 0 [ 1227.430957] _warn_unseeded_randomness: 10 callbacks suppressed [ 1227.431029] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 1227.509297] [drm] Initialized vgem 1.0.0 20120112 for vgem on minor 0 [ 1227.512732] [drm] Supports vblank timestamp caching Rev 2 (21.10.2013). [ 1227.521916] [drm] Driver supports precise vblank timestamp query. [ 1227.579744] [drm] Initialized vkms 1.0.0 20180514 for vkms on minor 1 [ 1227.653654] dummy-irq: no IRQ given. Use irq=N [ 1227.656360] Silicon Labs C2 port support v. 0.51.0 - (C) 2007 Rodolfo Giometti [ 1227.659891] usbcore: registered new interface driver rtsx_usb [ 1227.687512] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1227.702228] kobject: 'pasic3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1227.722036] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1227.725718] kobject: 'i2c-htcpld' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1227.740900] usbcore: registered new interface driver viperboard [ 1227.764395] usbcore: registered new interface driver dln2 [ 1227.790368] Uniform Multi-Platform E-IDE driver [ 1227.805370] ide-gd driver 1.18 [ 1227.957863] Rounding down aligned max_sectors from 4294967295 to 4294967288 [ 1227.978891] db_root: cannot open: /etc/target [ 1228.022077] SSFDC read-only Flash Translation layer [ 1228.032115] mtdoops: mtd device (mtddev=name/number) must be supplied [ 1228.048446] SBC-GXx flash: IO:0x258-0x259 MEM:0xdc000-0xdffff [ 1228.063739] kobject: 'docg3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1228.347802] No valid DiskOnChip devices found [ 1228.486417] mdio_bus fixed-0: GPIO lookup for consumer reset [ 1228.494285] mdio_bus fixed-0: using lookup tables for GPIO lookup [ 1228.496968] mdio_bus fixed-0: No GPIO consumer reset found [ 1228.499230] libphy: Fixed MDIO Bus: probed [ 1228.570909] vcan: Virtual CAN interface driver [ 1228.579563] vxcan: Virtual CAN Tunnel driver [ 1228.587666] CAN device driver interface [ 1228.598263] usbcore: registered new interface driver usb_8dev [ 1228.600456] usbcore: registered new interface driver ems_usb [ 1228.602395] usbcore: registered new interface driver esd_usb2 [ 1228.607978] usbcore: registered new interface driver kvaser_usb [ 1228.620505] usbcore: registered new interface driver mcba_usb [ 1228.641876] usbcore: registered new interface driver peak_usb [ 1228.646013] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 1228.647500] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 1258.715512] ACPI Error: Aborting method \_SB.PCI0._PRT due to previous error (AE_AML_LOOP_TIMEOUT) (20190509/psparse-531) [ 1258.827035] ACPI Error: Method execution failed \_SB.PCI0._PRT due to previous error (AE_AML_LOOP_TIMEOUT) (20190509/uteval-69) [ 1258.849064] e1000 0000:00:03.0: can't derive routing for PCI INT A [ 1258.852237] e1000 0000:00:03.0: PCI INT A: no GSI [ 1260.295572] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 1260.299213] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 1260.302257] _warn_unseeded_randomness: 9 callbacks suppressed [ 1260.302276] random: get_random_u64 called from copy_process+0x5b5/0x4642 with crng_init=0 [ 1260.345929] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1260.362101] kobject: 'rx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1260.381279] kobject: 'tx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1260.425515] kobject: 'net' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1264.503035] kobject: 'queues' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1264.810417] kobject: 'eth0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1264.854488] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1269.111685] Writes: Total: 32167303 Max/Min: 0/0 Fail: 0 [ 1295.078859] ACPI Error: Aborting method \_SB.PCI0._PRT due to previous error (AE_AML_LOOP_TIMEOUT) (20190509/psparse-531) [ 1295.230302] ACPI Error: Method execution failed \_SB.PCI0._PRT due to previous error (AE_AML_LOOP_TIMEOUT) (20190509/uteval-69) [ 1295.246348] e1000 0000:00:03.0: can't derive routing for PCI INT A [ 1295.262032] e1000 0000:00:03.0: PCI INT A: no GSI [ 1296.853071] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 52:54:00:12:34:56 [ 1296.870105] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 1296.891613] PPP generic driver version 2.4.2 [ 1296.909299] PPP BSD Compression module registered [ 1296.918922] PPP MPPE Compression module registered [ 1296.934901] NET: Registered protocol family 24 [ 1296.953919] DLCI driver v0.35, 4 Jan 1997, mike.mclagan@linux.org. [ 1296.966982] usbcore: registered new interface driver ath6kl_usb [ 1296.985840] usbcore: registered new interface driver usb8xxx [ 1296.997707] libertas_spi: Libertas SPI driver [ 1297.015741] usbcore: registered new interface driver zd1201 [ 1297.027612] usbcore: registered new interface driver rndis_wlan [ 1297.038652] random: get_random_bytes called from virt_wifi_init_module+0x19/0x335 with crng_init=0 [ 1297.074577] usbcore: registered new interface driver kaweth [ 1297.085020] pegasus: v0.9.3 (2013/04/25), Pegasus/Pegasus II USB Ethernet driver [ 1297.101966] usbcore: registered new interface driver pegasus [ 1297.115247] usbcore: registered new interface driver rtl8150 [ 1297.127472] usbcore: registered new interface driver r8152 [ 1297.153116] usbcore: registered new interface driver asix [ 1297.165203] usbcore: registered new interface driver cdc_ether [ 1297.178005] usbcore: registered new interface driver dm9601 [ 1297.195773] usbcore: registered new interface driver sr9700 [ 1297.208483] usbcore: registered new interface driver CoreChips [ 1297.224295] usbcore: registered new interface driver smsc75xx [ 1297.239637] usbcore: registered new interface driver smsc95xx [ 1297.267970] usbcore: registered new interface driver gl620a [ 1297.279827] usbcore: registered new interface driver rndis_host [ 1297.292883] usbcore: registered new interface driver cdc_subset [ 1297.307009] usbcore: registered new interface driver MOSCHIP usb-ethernet driver [ 1297.320563] random: get_random_bytes called from usbnet_init+0x16/0x2b with crng_init=0 [ 1297.336955] usbcore: registered new interface driver int51x1 [ 1297.350667] usbcore: registered new interface driver cdc_phonet [ 1297.364424] usbcore: registered new interface driver kalmia [ 1297.376735] usbcore: registered new interface driver ipheth [ 1297.391449] usbcore: registered new interface driver cx82310_eth [ 1297.405310] usbcore: registered new interface driver cdc_ncm [ 1297.418433] usbcore: registered new interface driver qmi_wwan [ 1297.430871] usbcore: registered new interface driver cdc_mbim [ 1297.455960] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 1297.484861] usbcore: registered new interface driver hwa-rc [ 1297.520298] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 1297.534057] ehci-pci: EHCI PCI platform driver [ 1297.546892] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 1297.562120] ohci-pci: OHCI PCI platform driver [ 1297.572784] ohci-platform: OHCI generic platform driver [ 1297.588532] ehci-fsl: Freescale EHCI Host controller driver [ 1297.613126] usbcore: registered new interface driver cdc_wdm [ 1297.631662] usbcore: registered new interface driver adutux [ 1297.644660] usbcore: registered new interface driver appledisplay [ 1297.658606] usbcore: registered new interface driver cytherm [ 1297.671338] usbcore: registered new interface driver emi26 - firmware loader [ 1297.689302] usbcore: registered new interface driver idmouse [ 1297.742674] usbcore: registered new interface driver iowarrior [ 1297.756651] usbcore: registered new interface driver isight_firmware [ 1297.770126] usbcore: registered new interface driver legousbtower [ 1297.783549] usbcore: registered new interface driver rio500 [ 1297.795700] usbcore: registered new interface driver usbtest [ 1297.814623] usbcore: registered new interface driver trancevibrator [ 1297.828945] usbcore: registered new interface driver usbsevseg [ 1297.847289] usbcore: registered new interface driver chaoskey [ 1297.861102] usbcore: registered new interface driver lvs [ 1297.902817] vhci_hcd: vhci_hcd_probe:1323: name vhci_hcd id 0 [ 1297.912194] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller [ 1297.924606] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 1 [ 1297.939734] vhci_hcd: vhci_start:1155: enter vhci_start [ 1297.952215] vhci_hcd: vhci_start:1197: created sysfs vhci_hcd.0 [ 1298.026687] hub 1-0:1.0: USB hub found [ 1298.042135] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1298.056264] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1298.059592] vhci_hcd: vhci_hub_control:635: port -1 [ 1298.073829] vhci_hcd: vhci_hub_control:643: bye [ 1298.087061] hub 1-0:1.0: 8 ports detected [ 1298.100275] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1298.115050] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1298.117631] vhci_hcd: vhci_hub_control:635: port -1 [ 1298.117631] vhci_hcd: vhci_hub_control:643: bye [ 1298.251770] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1298.265978] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.270375] vhci_hcd: vhci_hub_control:635: port 0 [ 1298.270375] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.270375] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.270375] vhci_hcd: dump_port_status_diff:150: [ 1298.270375] vhci_hcd: vhci_hub_control:643: bye [ 1298.338468] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1298.353209] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.355952] vhci_hcd: vhci_hub_control:635: port 1 [ 1298.355952] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.355952] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.355952] vhci_hcd: dump_port_status_diff:150: [ 1298.355952] vhci_hcd: vhci_hub_control:643: bye [ 1298.428547] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1298.441417] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.445227] vhci_hcd: vhci_hub_control:635: port 2 [ 1298.445227] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.445227] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.445227] vhci_hcd: dump_port_status_diff:150: [ 1298.445227] vhci_hcd: vhci_hub_control:643: bye [ 1298.506709] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1298.530059] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.533671] vhci_hcd: vhci_hub_control:635: port 3 [ 1298.533671] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.533671] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.533671] vhci_hcd: dump_port_status_diff:150: [ 1298.533671] vhci_hcd: vhci_hub_control:643: bye [ 1298.647749] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1298.663263] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.665618] vhci_hcd: vhci_hub_control:635: port 4 [ 1298.665618] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.689237] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.689237] vhci_hcd: dump_port_status_diff:150: [ 1298.689237] vhci_hcd: vhci_hub_control:643: bye [ 1298.732622] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1298.746838] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.749617] vhci_hcd: vhci_hub_control:635: port 5 [ 1298.749617] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.771708] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.771708] vhci_hcd: dump_port_status_diff:150: [ 1298.771708] vhci_hcd: vhci_hub_control:643: bye [ 1298.818849] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1298.836059] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.837599] vhci_hcd: vhci_hub_control:635: port 6 [ 1298.837599] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.837599] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.837599] vhci_hcd: dump_port_status_diff:150: [ 1298.837599] vhci_hcd: vhci_hub_control:643: bye [ 1298.908324] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1298.922421] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1298.931954] vhci_hcd: vhci_hub_control:635: port 7 [ 1298.931954] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1298.931954] vhci_hcd: dump_port_status_diff:142: +POWER [ 1298.931954] vhci_hcd: dump_port_status_diff:150: [ 1298.931954] vhci_hcd: vhci_hub_control:643: bye [ 1299.002426] _warn_unseeded_randomness: 1 callbacks suppressed [ 1299.002497] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1299.030365] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1299.055090] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1299.078361] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1299.089600] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1299.104459] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1299.132309] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1299.149119] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1299.153436] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1299.171554] hub 1-0:1.0: USB hub found [ 1299.180524] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1299.202302] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1299.227258] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1299.229636] vhci_hcd: vhci_hub_control:635: port -1 [ 1299.229636] vhci_hcd: vhci_hub_control:643: bye [ 1299.257912] hub 1-0:1.0: 8 ports detected [ 1299.269346] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1299.283222] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1299.285988] vhci_hcd: vhci_hub_control:635: port -1 [ 1299.285988] vhci_hcd: vhci_hub_control:643: bye [ 1299.388541] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1299.403088] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.405601] vhci_hcd: vhci_hub_control:635: port 0 [ 1299.405601] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.405601] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.405601] vhci_hcd: dump_port_status_diff:150: [ 1299.405601] vhci_hcd: vhci_hub_control:643: bye [ 1299.508024] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1299.541847] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.554129] vhci_hcd: vhci_hub_control:635: port 1 [ 1299.554129] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.570915] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.570915] vhci_hcd: dump_port_status_diff:150: [ 1299.570915] vhci_hcd: vhci_hub_control:643: bye [ 1299.611917] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1299.627273] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.629589] vhci_hcd: vhci_hub_control:635: port 2 [ 1299.641918] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.658929] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.658929] vhci_hcd: dump_port_status_diff:150: [ 1299.658929] vhci_hcd: vhci_hub_control:643: bye [ 1299.697220] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1299.712303] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.714524] vhci_hcd: vhci_hub_control:635: port 3 [ 1299.726534] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.746112] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.746112] vhci_hcd: dump_port_status_diff:150: [ 1299.761791] vhci_hcd: vhci_hub_control:643: bye [ 1299.782759] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1299.823395] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.825831] vhci_hcd: vhci_hub_control:635: port 4 [ 1299.838398] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.838398] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.865890] vhci_hcd: dump_port_status_diff:150: [ 1299.865890] vhci_hcd: vhci_hub_control:643: bye [ 1299.873874] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1299.880489] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.884298] vhci_hcd: vhci_hub_control:635: port 5 [ 1299.884298] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.884298] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.884298] vhci_hcd: dump_port_status_diff:150: [ 1299.884298] vhci_hcd: vhci_hub_control:643: bye [ 1299.947998] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1299.960764] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1299.964441] vhci_hcd: vhci_hub_control:635: port 6 [ 1299.964441] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1299.964441] vhci_hcd: dump_port_status_diff:142: POWER [ 1299.964441] vhci_hcd: dump_port_status_diff:150: [ 1299.964441] vhci_hcd: vhci_hub_control:643: bye [ 1300.007697] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1300.025223] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.025626] vhci_hcd: vhci_hub_control:635: port 7 [ 1300.025626] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.025626] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.025626] vhci_hcd: dump_port_status_diff:150: [ 1300.025626] vhci_hcd: vhci_hub_control:643: bye [ 1300.076430] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1300.088011] kobject: 'ep_81' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1300.127540] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1300.150130] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1300.175216] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1300.200786] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1300.226773] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1300.248544] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1300.270526] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1300.294567] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1300.314641] hub 1-0:1.0: USB hub found [ 1300.316207] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1300.320051] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1300.323591] vhci_hcd: vhci_hub_control:635: port -1 [ 1300.323591] vhci_hcd: vhci_hub_control:643: bye [ 1300.354783] hub 1-0:1.0: 8 ports detected [ 1300.366041] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1300.367970] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1300.369491] vhci_hcd: vhci_hub_control:635: port -1 [ 1300.369491] vhci_hcd: vhci_hub_control:643: bye [ 1300.398306] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1300.499604] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1300.514809] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.517611] vhci_hcd: vhci_hub_control:635: port 0 [ 1300.517611] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.517611] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.517611] vhci_hcd: dump_port_status_diff:150: [ 1300.517611] vhci_hcd: vhci_hub_control:643: bye [ 1300.613412] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1300.626701] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.630853] vhci_hcd: vhci_hub_control:635: port 1 [ 1300.630853] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.630853] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.630853] vhci_hcd: dump_port_status_diff:150: [ 1300.630853] vhci_hcd: vhci_hub_control:643: bye [ 1300.673837] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1300.685322] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.689090] vhci_hcd: vhci_hub_control:635: port 2 [ 1300.689090] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.689090] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.713604] vhci_hcd: dump_port_status_diff:150: [ 1300.713604] vhci_hcd: vhci_hub_control:643: bye [ 1300.718411] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1300.720710] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.731272] vhci_hcd: vhci_hub_control:635: port 3 [ 1300.737786] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.737786] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.737786] vhci_hcd: dump_port_status_diff:150: [ 1300.737786] vhci_hcd: vhci_hub_control:643: bye [ 1300.770706] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1300.772864] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.774134] vhci_hcd: vhci_hub_control:635: port 4 [ 1300.774134] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.774134] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.774134] vhci_hcd: dump_port_status_diff:150: [ 1300.774134] vhci_hcd: vhci_hub_control:643: bye [ 1300.815674] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1300.817928] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.821894] vhci_hcd: vhci_hub_control:635: port 5 [ 1300.829910] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.846250] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.847017] vhci_hcd: dump_port_status_diff:150: [ 1300.847017] vhci_hcd: vhci_hub_control:643: bye [ 1300.878095] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1300.887647] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.890694] vhci_hcd: vhci_hub_control:635: port 6 [ 1300.891538] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.891538] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.891538] vhci_hcd: dump_port_status_diff:150: [ 1300.897792] vhci_hcd: vhci_hub_control:643: bye [ 1300.915846] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1300.928647] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1300.932480] vhci_hcd: vhci_hub_control:635: port 7 [ 1300.932480] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1300.937582] vhci_hcd: dump_port_status_diff:142: POWER [ 1300.937582] vhci_hcd: dump_port_status_diff:150: [ 1300.937582] vhci_hcd: vhci_hub_control:643: bye [ 1300.951334] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1300.967406] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1301.022484] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1301.043389] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1301.050786] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1301.054567] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1301.096644] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1301.101757] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1301.105239] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1301.126679] hub 1-0:1.0: USB hub found [ 1301.150665] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1301.152713] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1301.153492] vhci_hcd: vhci_hub_control:635: port -1 [ 1301.153492] vhci_hcd: vhci_hub_control:643: bye [ 1301.187101] hub 1-0:1.0: 8 ports detected [ 1301.192090] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1301.194876] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1301.196665] vhci_hcd: vhci_hub_control:635: port -1 [ 1301.198119] vhci_hcd: vhci_hub_control:643: bye [ 1301.202638] _warn_unseeded_randomness: 2 callbacks suppressed [ 1301.202728] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1301.299594] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1301.314367] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.317620] vhci_hcd: vhci_hub_control:635: port 0 [ 1301.317620] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.317620] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.317620] vhci_hcd: dump_port_status_diff:150: [ 1301.317620] vhci_hcd: vhci_hub_control:643: bye [ 1301.382514] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1301.402524] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.405616] vhci_hcd: vhci_hub_control:635: port 1 [ 1301.405616] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.405616] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.405616] vhci_hcd: dump_port_status_diff:150: [ 1301.405616] vhci_hcd: vhci_hub_control:643: bye [ 1301.471290] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1301.484317] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.490740] vhci_hcd: vhci_hub_control:635: port 2 [ 1301.490740] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.490740] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.490740] vhci_hcd: dump_port_status_diff:150: [ 1301.490740] vhci_hcd: vhci_hub_control:643: bye [ 1301.554410] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1301.560798] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.563547] vhci_hcd: vhci_hub_control:635: port 3 [ 1301.564626] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.564626] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.564626] vhci_hcd: dump_port_status_diff:150: [ 1301.564626] vhci_hcd: vhci_hub_control:643: bye [ 1301.598276] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1301.638358] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.642086] vhci_hcd: vhci_hub_control:635: port 4 [ 1301.657797] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.657797] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.657797] vhci_hcd: dump_port_status_diff:150: [ 1301.657797] vhci_hcd: vhci_hub_control:643: bye [ 1301.687084] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1301.689203] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.690346] vhci_hcd: vhci_hub_control:635: port 5 [ 1301.702323] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.702323] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.721798] vhci_hcd: dump_port_status_diff:150: [ 1301.721798] vhci_hcd: vhci_hub_control:643: bye [ 1301.760946] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1301.773934] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.777580] vhci_hcd: vhci_hub_control:635: port 6 [ 1301.793767] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.797886] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.797886] vhci_hcd: dump_port_status_diff:150: [ 1301.797886] vhci_hcd: vhci_hub_control:643: bye [ 1301.840405] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1301.895583] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1301.909947] vhci_hcd: vhci_hub_control:635: port 7 [ 1301.909947] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1301.909947] vhci_hcd: dump_port_status_diff:142: POWER [ 1301.967112] vhci_hcd: dump_port_status_diff:150: [ 1301.967112] vhci_hcd: vhci_hub_control:643: bye [ 1301.976980] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1301.978676] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller [ 1301.981211] kobject: '1-0:1.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1302.010471] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 2 [ 1302.017594] vhci_hcd: vhci_start:1155: enter vhci_start [ 1302.020070] vhci_hcd: vhci_hub_control:336: typeReq 8006 wValue f00 wIndex 0 [ 1302.023233] vhci_hcd: vhci_hub_control:635: port -1 [ 1302.026195] vhci_hcd: vhci_hub_control:643: bye [ 1302.046244] vhci_hcd: vhci_hub_control:336: typeReq 8006 wValue f00 wIndex 0 [ 1302.063639] vhci_hcd: vhci_hub_control:635: port -1 [ 1302.065629] vhci_hcd: vhci_hub_control:643: bye [ 1302.085253] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 1302.100980] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 1 [ 1302.114347] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1302.121855] vhci_hcd: vhci_hub_control:431: GetPortStatus port 1 [ 1302.125603] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.125603] vhci_hcd: vhci_hub_control:635: port 0 [ 1302.125603] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.125603] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.125603] vhci_hcd: dump_port_status_diff:150: [ 1302.125603] vhci_hcd: vhci_hub_control:643: bye [ 1302.170957] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 2 [ 1302.176401] hub 2-0:1.0: USB hub found [ 1302.186258] vhci_hcd: vhci_hub_control:431: GetPortStatus port 2 [ 1302.194363] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1302.189608] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.189608] vhci_hcd: vhci_hub_control:635: port 1 [ 1302.189608] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.189608] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.189608] vhci_hcd: dump_port_status_diff:150: [ 1302.189608] vhci_hcd: vhci_hub_control:643: bye [ 1302.204853] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 3 [ 1302.219954] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1302.219992] vhci_hcd: vhci_hub_control:635: port -1 [ 1302.220055] vhci_hcd: vhci_hub_control:643: bye [ 1302.236275] vhci_hcd: vhci_hub_control:431: GetPortStatus port 3 [ 1302.333801] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.345986] vhci_hcd: vhci_hub_control:635: port 2 [ 1302.345986] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.364129] hub 2-0:1.0: 8 ports detected [ 1302.362966] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.362966] vhci_hcd: dump_port_status_diff:150: [ 1302.362966] vhci_hcd: vhci_hub_control:643: bye [ 1302.389512] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 4 [ 1302.396695] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1302.403613] vhci_hcd: vhci_hub_control:431: GetPortStatus port 4 [ 1302.405956] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.405956] vhci_hcd: vhci_hub_control:635: port 3 [ 1302.405956] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.405956] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.405956] vhci_hcd: dump_port_status_diff:150: [ 1302.405956] vhci_hcd: vhci_hub_control:643: bye [ 1302.477598] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1302.477598] vhci_hcd: vhci_hub_control:635: port -1 [ 1302.477598] vhci_hcd: vhci_hub_control:643: bye [ 1302.597320] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1302.611708] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1302.614080] vhci_hcd: vhci_hub_control:635: port 0 [ 1302.614080] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1302.614080] vhci_hcd: dump_port_status_diff:142: +POWER [ 1302.614080] vhci_hcd: dump_port_status_diff:150: [ 1302.614080] vhci_hcd: vhci_hub_control:643: bye [ 1302.666854] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 5 [ 1302.677909] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1302.700401] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1302.703977] vhci_hcd: vhci_hub_control:635: port 1 [ 1302.703977] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1302.703977] vhci_hcd: dump_port_status_diff:142: +POWER [ 1302.703977] vhci_hcd: dump_port_status_diff:150: [ 1302.703977] vhci_hcd: vhci_hub_control:643: bye [ 1302.705597] vhci_hcd: vhci_hub_control:431: GetPortStatus port 5 [ 1302.752778] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1302.752343] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.752343] vhci_hcd: vhci_hub_control:635: port 4 [ 1302.752343] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.752343] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.752343] vhci_hcd: dump_port_status_diff:150: [ 1302.752343] vhci_hcd: vhci_hub_control:643: bye [ 1302.758117] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1302.805226] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 6 [ 1302.804877] vhci_hcd: vhci_hub_control:635: port 2 [ 1302.804877] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1302.804877] vhci_hcd: dump_port_status_diff:142: +POWER [ 1302.804877] vhci_hcd: dump_port_status_diff:150: [ 1302.804877] vhci_hcd: vhci_hub_control:643: bye [ 1302.810704] vhci_hcd: vhci_hub_control:431: GetPortStatus port 6 [ 1302.861125] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1302.858630] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.858630] vhci_hcd: vhci_hub_control:635: port 5 [ 1302.858630] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.858630] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.858630] vhci_hcd: dump_port_status_diff:150: [ 1302.858630] vhci_hcd: vhci_hub_control:643: bye [ 1302.869776] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 7 [ 1302.878810] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1302.882588] vhci_hcd: vhci_hub_control:635: port 3 [ 1302.882588] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1302.882588] vhci_hcd: dump_port_status_diff:142: +POWER [ 1302.882588] vhci_hcd: dump_port_status_diff:150: [ 1302.882588] vhci_hcd: vhci_hub_control:643: bye [ 1302.895320] vhci_hcd: vhci_hub_control:431: GetPortStatus port 7 [ 1303.022607] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1302.895320] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1302.895320] vhci_hcd: vhci_hub_control:635: port 6 [ 1302.895320] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1302.895320] vhci_hcd: dump_port_status_diff:142: POWER [ 1302.895320] vhci_hcd: dump_port_status_diff:150: [ 1302.895320] vhci_hcd: vhci_hub_control:643: bye [ 1303.030745] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1303.078629] vhci_hcd: vhci_hub_control:635: port 4 [ 1303.078629] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1303.078629] vhci_hcd: dump_port_status_diff:142: +POWER [ 1303.078629] vhci_hcd: dump_port_status_diff:150: [ 1303.078629] vhci_hcd: vhci_hub_control:643: bye [ 1303.148363] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1303.163267] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1303.165652] vhci_hcd: vhci_hub_control:635: port 5 [ 1303.165652] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1303.165652] vhci_hcd: dump_port_status_diff:142: +POWER [ 1303.165652] vhci_hcd: dump_port_status_diff:150: [ 1303.165652] vhci_hcd: vhci_hub_control:643: bye [ 1303.230866] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1303.243665] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1303.247505] vhci_hcd: vhci_hub_control:635: port 6 [ 1303.247505] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1303.278836] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 8 [ 1303.247505] vhci_hcd: dump_port_status_diff:142: +POWER [ 1303.247505] vhci_hcd: dump_port_status_diff:150: [ 1303.247505] vhci_hcd: vhci_hub_control:643: bye [ 1303.296866] vhci_hcd: vhci_hub_control:431: GetPortStatus port 8 [ 1303.323910] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1303.296866] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1303.296866] vhci_hcd: vhci_hub_control:635: port 7 [ 1303.296866] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1303.296866] vhci_hcd: dump_port_status_diff:142: POWER [ 1303.296866] vhci_hcd: dump_port_status_diff:150: [ 1303.296866] vhci_hcd: vhci_hub_control:643: bye [ 1303.335022] usb usb1: vhci_bus_suspend [ 1303.343708] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1303.346603] vhci_hcd: vhci_hub_control:635: port 7 [ 1303.346603] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1303.346603] vhci_hcd: dump_port_status_diff:142: +POWER [ 1303.346603] vhci_hcd: dump_port_status_diff:150: [ 1303.346603] vhci_hcd: vhci_hub_control:643: bye [ 1303.493067] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1303.514453] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1303.537134] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1303.573403] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1303.596835] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1303.642326] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1303.664780] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1303.688115] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1303.711638] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1303.735426] hub 2-0:1.0: USB hub found [ 1303.743720] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1303.763847] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1303.779431] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1303.781621] vhci_hcd: vhci_hub_control:635: port -1 [ 1303.781621] vhci_hcd: vhci_hub_control:643: bye [ 1303.809896] hub 2-0:1.0: 8 ports detected [ 1303.821860] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1303.828904] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1303.831103] vhci_hcd: vhci_hub_control:635: port -1 [ 1303.832830] vhci_hcd: vhci_hub_control:643: bye [ 1303.947640] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1303.963395] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1303.965603] vhci_hcd: vhci_hub_control:635: port 0 [ 1303.978272] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1303.998012] vhci_hcd: dump_port_status_diff:142: POWER [ 1303.998012] vhci_hcd: dump_port_status_diff:150: [ 1304.013816] vhci_hcd: vhci_hub_control:643: bye [ 1304.035297] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1304.075448] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.077575] vhci_hcd: vhci_hub_control:635: port 1 [ 1304.090295] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.110648] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.110648] vhci_hcd: dump_port_status_diff:150: [ 1304.125786] vhci_hcd: vhci_hub_control:643: bye [ 1304.146997] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1304.162432] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.165777] vhci_hcd: vhci_hub_control:635: port 2 [ 1304.177898] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.195038] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.205858] vhci_hcd: dump_port_status_diff:150: [ 1304.205858] vhci_hcd: vhci_hub_control:643: bye [ 1304.235017] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1304.250934] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.253602] vhci_hcd: vhci_hub_control:635: port 3 [ 1304.269862] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.286548] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.290023] vhci_hcd: dump_port_status_diff:150: [ 1304.301751] vhci_hcd: vhci_hub_control:643: bye [ 1304.353300] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1304.367133] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.370940] vhci_hcd: vhci_hub_control:635: port 4 [ 1304.382800] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.397765] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.397765] vhci_hcd: dump_port_status_diff:150: [ 1304.397765] vhci_hcd: vhci_hub_control:643: bye [ 1304.439209] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1304.455115] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.457628] vhci_hcd: vhci_hub_control:635: port 5 [ 1304.469971] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.487107] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.525839] vhci_hcd: dump_port_status_diff:150: [ 1304.525839] vhci_hcd: vhci_hub_control:643: bye [ 1304.556841] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1304.574566] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.577860] vhci_hcd: vhci_hub_control:635: port 6 [ 1304.590386] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.606944] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.606944] vhci_hcd: dump_port_status_diff:150: [ 1304.606944] vhci_hcd: vhci_hub_control:643: bye [ 1304.631806] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1304.634270] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1304.636477] vhci_hcd: vhci_hub_control:635: port 7 [ 1304.638233] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1304.638233] vhci_hcd: dump_port_status_diff:142: POWER [ 1304.638233] vhci_hcd: dump_port_status_diff:150: [ 1304.638233] vhci_hcd: vhci_hub_control:643: bye [ 1304.696877] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1304.712982] kobject: 'ep_81' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1304.750666] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1304.773448] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1304.797439] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1304.821447] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1304.844937] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1304.869327] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1304.892950] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1304.918396] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1304.947474] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1304.975819] hub 2-0:1.0: USB hub found [ 1304.986102] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1305.000999] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1305.004357] vhci_hcd: vhci_hub_control:635: port -1 [ 1305.004357] vhci_hcd: vhci_hub_control:643: bye [ 1305.034510] hub 2-0:1.0: 8 ports detected [ 1305.046443] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1305.054758] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1305.057131] vhci_hcd: vhci_hub_control:635: port -1 [ 1305.058711] vhci_hcd: vhci_hub_control:643: bye [ 1305.123368] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1305.137983] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.141598] vhci_hcd: vhci_hub_control:635: port 0 [ 1305.141598] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.141598] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.141598] vhci_hcd: dump_port_status_diff:150: [ 1305.141598] vhci_hcd: vhci_hub_control:643: bye [ 1305.216507] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1305.230548] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.238806] vhci_hcd: vhci_hub_control:635: port 1 [ 1305.238806] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.238806] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.238806] vhci_hcd: dump_port_status_diff:150: [ 1305.238806] vhci_hcd: vhci_hub_control:643: bye [ 1305.301851] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1305.304603] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.305522] vhci_hcd: vhci_hub_control:635: port 2 [ 1305.305522] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.305522] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.305522] vhci_hcd: dump_port_status_diff:150: [ 1305.305522] vhci_hcd: vhci_hub_control:643: bye [ 1305.380262] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1305.466066] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.469647] vhci_hcd: vhci_hub_control:635: port 3 [ 1305.469647] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.469647] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.469647] vhci_hcd: dump_port_status_diff:150: [ 1305.469647] vhci_hcd: vhci_hub_control:643: bye [ 1305.502119] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1305.503922] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.505513] vhci_hcd: vhci_hub_control:635: port 4 [ 1305.505513] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.505513] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.505513] vhci_hcd: dump_port_status_diff:150: [ 1305.505513] vhci_hcd: vhci_hub_control:643: bye [ 1305.547077] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1305.549074] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.550712] vhci_hcd: vhci_hub_control:635: port 5 [ 1305.550712] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.550712] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.550712] vhci_hcd: dump_port_status_diff:150: [ 1305.550712] vhci_hcd: vhci_hub_control:643: bye [ 1305.605341] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1305.618920] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.622010] vhci_hcd: vhci_hub_control:635: port 6 [ 1305.622010] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.622010] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.622010] vhci_hcd: dump_port_status_diff:150: [ 1305.622010] vhci_hcd: vhci_hub_control:643: bye [ 1305.687746] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1305.700767] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1305.704384] vhci_hcd: vhci_hub_control:635: port 7 [ 1305.704384] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1305.704384] vhci_hcd: dump_port_status_diff:142: POWER [ 1305.704384] vhci_hcd: dump_port_status_diff:150: [ 1305.704384] vhci_hcd: vhci_hub_control:643: bye [ 1305.746557] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1305.755134] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1305.793336] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1305.802814] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1305.806759] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1305.815348] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1305.838484] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1305.873389] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1305.894518] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1305.899265] hub 2-0:1.0: USB hub found [ 1305.900542] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1305.914280] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1305.928731] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1305.939018] vhci_hcd: vhci_hub_control:635: port -1 [ 1305.941866] vhci_hcd: vhci_hub_control:643: bye [ 1305.986128] hub 2-0:1.0: 8 ports detected [ 1305.998344] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1306.012045] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1306.017763] vhci_hcd: vhci_hub_control:635: port -1 [ 1306.025801] vhci_hcd: vhci_hub_control:643: bye [ 1306.137310] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1306.156489] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.157605] vhci_hcd: vhci_hub_control:635: port 0 [ 1306.157605] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.157605] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.157605] vhci_hcd: dump_port_status_diff:150: [ 1306.157605] vhci_hcd: vhci_hub_control:643: bye [ 1306.224806] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1306.237891] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.241703] vhci_hcd: vhci_hub_control:635: port 1 [ 1306.241703] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.241703] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.241703] vhci_hcd: dump_port_status_diff:150: [ 1306.241703] vhci_hcd: vhci_hub_control:643: bye [ 1306.304751] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1306.318424] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.321806] vhci_hcd: vhci_hub_control:635: port 2 [ 1306.321806] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.321806] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.321806] vhci_hcd: dump_port_status_diff:150: [ 1306.321806] vhci_hcd: vhci_hub_control:643: bye [ 1306.386352] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1306.400635] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.402989] vhci_hcd: vhci_hub_control:635: port 3 [ 1306.402989] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.402989] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.402989] vhci_hcd: dump_port_status_diff:150: [ 1306.402989] vhci_hcd: vhci_hub_control:643: bye [ 1306.468567] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1306.481426] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.485263] vhci_hcd: vhci_hub_control:635: port 4 [ 1306.485263] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.485263] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.485263] vhci_hcd: dump_port_status_diff:150: [ 1306.485263] vhci_hcd: vhci_hub_control:643: bye [ 1306.549119] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1306.563549] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.565957] vhci_hcd: vhci_hub_control:635: port 5 [ 1306.565957] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.565957] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.565957] vhci_hcd: dump_port_status_diff:150: [ 1306.565957] vhci_hcd: vhci_hub_control:643: bye [ 1306.633997] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1306.647828] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.650864] vhci_hcd: vhci_hub_control:635: port 6 [ 1306.650864] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.650864] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.650864] vhci_hcd: dump_port_status_diff:150: [ 1306.650864] vhci_hcd: vhci_hub_control:643: bye [ 1306.708573] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1306.711194] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1306.713471] vhci_hcd: vhci_hub_control:635: port 7 [ 1306.714799] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1306.715156] vhci_hcd: dump_port_status_diff:142: POWER [ 1306.715156] vhci_hcd: dump_port_status_diff:150: [ 1306.715156] vhci_hcd: vhci_hub_control:643: bye [ 1306.754840] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1306.755538] vhci_hcd: vhci_hcd_probe:1360: bye [ 1306.758926] kobject: '2-0:1.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1306.776454] vhci_hcd vhci_hcd.0: remove, state 1 [ 1306.786884] usb usb2: USB disconnect, device number 1 [ 1306.799815] kobject: 'ep_81' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1306.846224] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1306.867363] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1306.889240] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1306.900214] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1306.904356] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1306.920840] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1306.946084] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1306.963129] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1306.979629] kobject: 'ep_00' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1306.999043] kobject: '2-0:1.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1307.054008] vhci_hcd: vhci_stop:1208: stop VHCI controller [ 1307.066701] usbip_core: event_handler:71: pending event 7 [ 1307.102122] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.114509] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.130314] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.142988] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 0 [ 1307.155239] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.178246] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.192436] usbip_core: event_handler:71: pending event 7 [ 1307.203457] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.206534] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.215737] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.241216] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 1 [ 1307.255242] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.269078] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.295822] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.302392] usbip_core: event_handler:71: pending event 7 [ 1307.321033] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.333278] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.346238] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 2 [ 1307.359101] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.372653] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.384801] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.385093] usbip_core: event_handler:71: pending event 7 [ 1307.410043] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.422396] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.434713] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 3 [ 1307.447118] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.460536] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.472855] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.473109] usbip_core: event_handler:71: pending event 7 [ 1307.496544] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.506939] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.518474] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 4 [ 1307.530926] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.544469] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.558244] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.559662] usbip_core: event_handler:71: pending event 7 [ 1307.582125] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.594468] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.606885] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 5 [ 1307.619276] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.634038] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.646964] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.647320] usbip_core: event_handler:71: pending event 7 [ 1307.713825] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.726009] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.738899] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 6 [ 1307.751575] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.780095] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.795555] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1307.795837] usbip_core: event_handler:71: pending event 7 [ 1307.804375] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1307.806649] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1307.808643] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 7 [ 1307.831568] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1307.844515] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1307.866250] vhci_hcd vhci_hcd.0: USB bus 2 deregistered [ 1307.877457] vhci_hcd vhci_hcd.0: remove, state 4 [ 1307.886860] usb usb1: USB disconnect, device number 1 [ 1307.891658] kobject: 'ep_81' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1307.898289] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1307.912677] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1307.937299] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1307.947558] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1307.951384] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1307.962930] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1308.000534] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1308.028442] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1308.038820] kobject: '1-0:1.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1308.042634] kobject: 'ep_00' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1308.065378] vhci_hcd: vhci_stop:1208: stop VHCI controller [ 1308.098526] usbip_core: event_handler:71: pending event 7 [ 1308.109770] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.123705] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.136348] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.163507] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 0 [ 1308.176111] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.189458] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.202650] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.245943] usbip_core: event_handler:71: pending event 7 [ 1308.256579] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.267786] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.274785] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 1 [ 1308.277360] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.279571] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.281421] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.290787] usbip_core: event_handler:71: pending event 7 [ 1308.307347] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.321834] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.329621] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 2 [ 1308.331534] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.337003] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.350482] usbip_core: event_handler:71: pending event 7 [ 1308.363090] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.375693] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.387808] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.399705] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 3 [ 1308.411661] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.422855] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.434805] usbip_core: event_handler:71: pending event 7 [ 1308.446771] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.457246] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.460554] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 4 [ 1308.462864] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.466415] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.493106] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.600858] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.601109] usbip_core: event_handler:71: pending event 7 [ 1308.625387] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.636564] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.649434] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 5 [ 1308.660908] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.673504] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.684816] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.686475] usbip_core: event_handler:71: pending event 7 [ 1308.691771] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.693852] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.695724] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 6 [ 1308.705855] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.718620] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.743829] usbip_core: usbip_stop_eh:114: usbip_eh waiting completion 5 [ 1308.744067] usbip_core: event_handler:71: pending event 7 [ 1308.768469] vhci_hcd: vhci_shutdown_connection:1018: stop threads [ 1308.779845] vhci_hcd: vhci_shutdown_connection:1026: release socket [ 1308.792518] vhci_hcd: rh_port_disconnect:195: rh_port_disconnect 7 [ 1308.809774] vhci_hcd: vhci_shutdown_connection:1052: disconnect device [ 1308.823339] usbip_core: usbip_stop_eh:117: usbip_eh has stopped [ 1308.835588] vhci_hcd vhci_hcd.0: USB bus 1 deregistered [ 1308.848977] vhci_hcd: vhci_hcd_probe:1323: name vhci_hcd id 0 [ 1308.853696] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller [ 1308.856090] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 1 [ 1308.858705] vhci_hcd: vhci_start:1155: enter vhci_start [ 1308.867831] vhci_hcd: vhci_start:1197: created sysfs vhci_hcd.0 [ 1308.894576] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1308.989297] hub 1-0:1.0: USB hub found [ 1309.004334] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1309.019690] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1309.021679] vhci_hcd: vhci_hub_control:635: port -1 [ 1309.038777] vhci_hcd: vhci_hub_control:643: bye [ 1309.056346] hub 1-0:1.0: 8 ports detected [ 1309.068006] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1309.081324] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1309.085764] vhci_hcd: vhci_hub_control:635: port -1 [ 1309.085764] vhci_hcd: vhci_hub_control:643: bye [ 1309.173973] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1309.188044] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.189784] vhci_hcd: vhci_hub_control:635: port 0 [ 1309.189784] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.189784] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.189784] vhci_hcd: dump_port_status_diff:150: [ 1309.189784] vhci_hcd: vhci_hub_control:643: bye [ 1309.228889] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1309.231782] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.235615] vhci_hcd: vhci_hub_control:635: port 1 [ 1309.235615] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.235615] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.235615] vhci_hcd: dump_port_status_diff:150: [ 1309.235615] vhci_hcd: vhci_hub_control:643: bye [ 1309.300764] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1309.313796] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.325856] vhci_hcd: vhci_hub_control:635: port 2 [ 1309.333824] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.349862] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.357904] vhci_hcd: dump_port_status_diff:150: [ 1309.365867] vhci_hcd: vhci_hub_control:643: bye [ 1309.385382] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1309.418083] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.421563] vhci_hcd: vhci_hub_control:635: port 3 [ 1309.433926] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.465910] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.473883] vhci_hcd: dump_port_status_diff:150: [ 1309.473883] vhci_hcd: vhci_hub_control:643: bye [ 1309.502234] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1309.515649] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.523004] vhci_hcd: vhci_hub_control:635: port 4 [ 1309.523004] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.523004] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.523004] vhci_hcd: dump_port_status_diff:150: [ 1309.523004] vhci_hcd: vhci_hub_control:643: bye [ 1309.563798] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1309.578769] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.599057] vhci_hcd: vhci_hub_control:635: port 5 [ 1309.606030] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.609567] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.609567] vhci_hcd: dump_port_status_diff:150: [ 1309.613546] vhci_hcd: vhci_hub_control:643: bye [ 1309.620941] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1309.633868] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.637705] vhci_hcd: vhci_hub_control:635: port 6 [ 1309.637705] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.637705] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.637705] vhci_hcd: dump_port_status_diff:150: [ 1309.637705] vhci_hcd: vhci_hub_control:643: bye [ 1309.708301] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1309.725765] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1309.729579] vhci_hcd: vhci_hub_control:635: port 7 [ 1309.729579] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000100 [ 1309.729579] vhci_hcd: dump_port_status_diff:142: +POWER [ 1309.773859] vhci_hcd: dump_port_status_diff:150: [ 1309.773859] vhci_hcd: vhci_hub_control:643: bye [ 1309.797223] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1309.811291] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1309.834175] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1309.837429] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1309.874548] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1309.904622] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1309.926274] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1309.963511] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1309.992415] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1310.016915] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1310.042967] hub 1-0:1.0: USB hub found [ 1310.056351] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1310.065358] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1310.067750] vhci_hcd: vhci_hub_control:635: port -1 [ 1310.069300] vhci_hcd: vhci_hub_control:643: bye [ 1310.071226] hub 1-0:1.0: 8 ports detected [ 1310.073819] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1310.086683] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1310.095424] vhci_hcd: vhci_hub_control:635: port -1 [ 1310.102073] vhci_hcd: vhci_hub_control:643: bye [ 1310.177288] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1310.187408] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.190453] vhci_hcd: vhci_hub_control:635: port 0 [ 1310.191340] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.193587] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.193587] vhci_hcd: dump_port_status_diff:150: [ 1310.193587] vhci_hcd: vhci_hub_control:643: bye [ 1310.223983] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1310.232796] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.236070] vhci_hcd: vhci_hub_control:635: port 1 [ 1310.236743] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.236743] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.236743] vhci_hcd: dump_port_status_diff:150: [ 1310.251125] vhci_hcd: vhci_hub_control:643: bye [ 1310.272454] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1310.286383] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.289610] vhci_hcd: vhci_hub_control:635: port 2 [ 1310.289610] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.289610] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.289610] vhci_hcd: dump_port_status_diff:150: [ 1310.289610] vhci_hcd: vhci_hub_control:643: bye [ 1310.308125] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1310.321964] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.326985] vhci_hcd: vhci_hub_control:635: port 3 [ 1310.343250] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.357983] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.365857] vhci_hcd: dump_port_status_diff:150: [ 1310.373865] vhci_hcd: vhci_hub_control:643: bye [ 1310.390067] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1310.403386] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.409880] vhci_hcd: vhci_hub_control:635: port 4 [ 1310.409880] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.409880] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.409880] vhci_hcd: dump_port_status_diff:150: [ 1310.409880] vhci_hcd: vhci_hub_control:643: bye [ 1310.471966] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1310.485057] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.488864] vhci_hcd: vhci_hub_control:635: port 5 [ 1310.488864] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.488864] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.526109] vhci_hcd: dump_port_status_diff:150: [ 1310.526109] vhci_hcd: vhci_hub_control:643: bye [ 1310.563774] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1310.584127] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.589793] vhci_hcd: vhci_hub_control:635: port 6 [ 1310.589793] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.589793] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.589793] vhci_hcd: dump_port_status_diff:150: [ 1310.589793] vhci_hcd: vhci_hub_control:643: bye [ 1310.617942] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1310.629356] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1310.632872] vhci_hcd: vhci_hub_control:635: port 7 [ 1310.632872] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1310.632872] vhci_hcd: dump_port_status_diff:142: POWER [ 1310.632872] vhci_hcd: dump_port_status_diff:150: [ 1310.632872] vhci_hcd: vhci_hub_control:643: bye [ 1310.695501] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1310.697969] kobject: 'ep_81' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1310.718433] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1310.739622] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1310.764287] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1310.787938] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1310.809006] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1310.831560] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1310.859105] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1310.896406] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1310.935556] hub 1-0:1.0: USB hub found [ 1310.943657] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1310.963610] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1311.023207] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1311.025624] vhci_hcd: vhci_hub_control:635: port -1 [ 1311.025624] vhci_hcd: vhci_hub_control:643: bye [ 1311.053961] hub 1-0:1.0: 8 ports detected [ 1311.065923] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1311.078182] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1311.080640] vhci_hcd: vhci_hub_control:635: port -1 [ 1311.081898] vhci_hcd: vhci_hub_control:643: bye [ 1311.093977] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1311.106350] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1311.135127] kobject: 'usb2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1311.157386] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1311.171879] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.174415] vhci_hcd: vhci_hub_control:635: port 0 [ 1311.174415] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.174415] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.174415] vhci_hcd: dump_port_status_diff:150: [ 1311.174415] vhci_hcd: vhci_hub_control:643: bye [ 1311.210018] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1311.215307] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.219078] vhci_hcd: vhci_hub_control:635: port 1 [ 1311.219078] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.219078] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.219078] vhci_hcd: dump_port_status_diff:150: [ 1311.219078] vhci_hcd: vhci_hub_control:643: bye [ 1311.255794] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1311.259820] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.263629] vhci_hcd: vhci_hub_control:635: port 2 [ 1311.263629] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.263629] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.263629] vhci_hcd: dump_port_status_diff:150: [ 1311.263629] vhci_hcd: vhci_hub_control:643: bye [ 1311.320962] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1311.334915] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.338520] vhci_hcd: vhci_hub_control:635: port 3 [ 1311.338520] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.344294] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.344294] vhci_hcd: dump_port_status_diff:150: [ 1311.344294] vhci_hcd: vhci_hub_control:643: bye [ 1311.367045] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1311.380688] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.384517] vhci_hcd: vhci_hub_control:635: port 4 [ 1311.384517] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.384517] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.384517] vhci_hcd: dump_port_status_diff:150: [ 1311.384517] vhci_hcd: vhci_hub_control:643: bye [ 1311.410580] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1311.425327] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.438321] vhci_hcd: vhci_hub_control:635: port 5 [ 1311.438321] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.438321] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.438321] vhci_hcd: dump_port_status_diff:150: [ 1311.438321] vhci_hcd: vhci_hub_control:643: bye [ 1311.478312] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1311.485616] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.488070] vhci_hcd: vhci_hub_control:635: port 6 [ 1311.489518] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.489534] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.517898] vhci_hcd: dump_port_status_diff:150: [ 1311.517898] vhci_hcd: vhci_hub_control:643: bye [ 1311.532208] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1311.534533] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.542382] vhci_hcd: vhci_hub_control:635: port 7 [ 1311.542382] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.542382] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.542382] vhci_hcd: dump_port_status_diff:150: [ 1311.542382] vhci_hcd: vhci_hub_control:643: bye [ 1311.614454] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1311.628864] kobject: 'usb1-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1311.633827] kobject: 'usb1-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1311.637227] kobject: 'usb1-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1311.656933] kobject: 'usb1-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1311.682163] kobject: 'usb1-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1311.686115] kobject: 'usb1-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1311.704041] kobject: 'usb1-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1311.727400] kobject: 'usb1-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1311.754576] hub 1-0:1.0: USB hub found [ 1311.756398] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2900 wIndex 0 [ 1311.758619] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1311.762343] vhci_hcd: vhci_hub_control:635: port -1 [ 1311.762585] vhci_hcd: vhci_hub_control:643: bye [ 1311.783305] hub 1-0:1.0: 8 ports detected [ 1311.795834] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1311.799200] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1311.801192] vhci_hcd: vhci_hub_control:635: port -1 [ 1311.802755] vhci_hcd: vhci_hub_control:643: bye [ 1311.846684] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1311.848677] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.849499] vhci_hcd: vhci_hub_control:635: port 0 [ 1311.849499] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.849499] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.849499] vhci_hcd: dump_port_status_diff:150: [ 1311.849499] vhci_hcd: vhci_hub_control:643: bye [ 1311.890855] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1311.893151] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.894327] vhci_hcd: vhci_hub_control:635: port 1 [ 1311.897790] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.897790] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.897790] vhci_hcd: dump_port_status_diff:150: [ 1311.897790] vhci_hcd: vhci_hub_control:643: bye [ 1311.938077] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1311.963772] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1311.967444] vhci_hcd: vhci_hub_control:635: port 2 [ 1311.967444] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1311.967444] vhci_hcd: dump_port_status_diff:142: POWER [ 1311.967444] vhci_hcd: dump_port_status_diff:150: [ 1311.967444] vhci_hcd: vhci_hub_control:643: bye [ 1312.000680] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1312.017821] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1312.029875] vhci_hcd: vhci_hub_control:635: port 3 [ 1312.037848] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.041589] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.045560] vhci_hcd: dump_port_status_diff:150: [ 1312.045560] vhci_hcd: vhci_hub_control:643: bye [ 1312.049212] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1312.064951] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1312.068014] vhci_hcd: vhci_hub_control:635: port 4 [ 1312.068014] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.068014] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.068014] vhci_hcd: dump_port_status_diff:150: [ 1312.068014] vhci_hcd: vhci_hub_control:643: bye [ 1312.106906] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1312.108843] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1312.109523] vhci_hcd: vhci_hub_control:635: port 5 [ 1312.109523] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.109523] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.109523] vhci_hcd: dump_port_status_diff:150: [ 1312.109523] vhci_hcd: vhci_hub_control:643: bye [ 1312.248083] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1312.253873] _warn_unseeded_randomness: 1 callbacks suppressed [ 1312.253947] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1312.261429] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1312.273225] kobject: 'usb1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1312.272866] vhci_hcd: vhci_hub_control:635: port 6 [ 1312.272866] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.272866] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.272866] vhci_hcd: dump_port_status_diff:150: [ 1312.272866] vhci_hcd: vhci_hub_control:643: bye [ 1312.290338] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1312.362777] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1312.365512] vhci_hcd: vhci_hub_control:635: port 7 [ 1312.379242] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.393956] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.401857] vhci_hcd: dump_port_status_diff:150: [ 1312.413853] vhci_hcd: vhci_hub_control:643: bye [ 1312.423285] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1312.428118] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1312.428760] vhci_hcd vhci_hcd.0: USB/IP Virtual Host Controller [ 1312.432080] kobject: '1-0:1.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1312.442748] vhci_hcd vhci_hcd.0: new USB bus registered, assigned bus number 2 [ 1312.489263] vhci_hcd: vhci_start:1155: enter vhci_start [ 1312.528448] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 1 [ 1312.551749] vhci_hcd: vhci_hub_control:336: typeReq 8006 wValue f00 wIndex 0 [ 1312.559446] vhci_hcd: vhci_hub_control:431: GetPortStatus port 1 [ 1312.561624] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1312.561624] vhci_hcd: vhci_hub_control:635: port 0 [ 1312.561624] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.561624] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.561624] vhci_hcd: dump_port_status_diff:150: [ 1312.561624] vhci_hcd: vhci_hub_control:643: bye [ 1312.577591] vhci_hcd: vhci_hub_control:635: port -1 [ 1312.643565] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 2 [ 1312.640387] vhci_hcd: vhci_hub_control:643: bye [ 1312.652072] vhci_hcd: vhci_hub_control:336: typeReq 8006 wValue f00 wIndex 0 [ 1312.654078] vhci_hcd: vhci_hub_control:431: GetPortStatus port 2 [ 1312.657980] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1312.657980] vhci_hcd: vhci_hub_control:635: port 1 [ 1312.657980] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.657980] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.657980] vhci_hcd: dump_port_status_diff:150: [ 1312.657980] vhci_hcd: vhci_hub_control:643: bye [ 1312.662417] vhci_hcd: vhci_hub_control:635: port -1 [ 1312.736687] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 3 [ 1312.735487] vhci_hcd: vhci_hub_control:643: bye [ 1312.745573] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM. [ 1312.752005] vhci_hcd: vhci_hub_control:431: GetPortStatus port 3 [ 1312.755693] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1312.761749] vhci_hcd: vhci_hub_control:635: port 2 [ 1312.761749] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.781256] hub 2-0:1.0: USB hub found [ 1312.761749] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.761749] vhci_hcd: dump_port_status_diff:150: [ 1312.761749] vhci_hcd: vhci_hub_control:643: bye [ 1312.797012] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 4 [ 1312.805793] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1312.812234] vhci_hcd: vhci_hub_control:431: GetPortStatus port 4 [ 1312.815397] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1312.815397] vhci_hcd: vhci_hub_control:635: port 3 [ 1312.815397] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.815397] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.815397] vhci_hcd: dump_port_status_diff:150: [ 1312.815397] vhci_hcd: vhci_hub_control:643: bye [ 1312.823990] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1312.931944] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 5 [ 1312.930034] vhci_hcd: vhci_hub_control:635: port -1 [ 1312.930034] vhci_hcd: vhci_hub_control:643: bye [ 1312.940085] hub 2-0:1.0: 8 ports detected [ 1312.946175] vhci_hcd: vhci_hub_control:431: GetPortStatus port 5 [ 1312.948785] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1312.949648] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1312.949648] vhci_hcd: vhci_hub_control:635: port 4 [ 1312.949648] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1312.949648] vhci_hcd: dump_port_status_diff:142: POWER [ 1312.949648] vhci_hcd: dump_port_status_diff:150: [ 1312.949648] vhci_hcd: vhci_hub_control:643: bye [ 1312.953747] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1313.024811] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 6 [ 1313.023454] vhci_hcd: vhci_hub_control:635: port -1 [ 1313.023454] vhci_hcd: vhci_hub_control:643: bye [ 1313.070081] vhci_hcd: vhci_hub_control:431: GetPortStatus port 6 [ 1313.073624] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1313.073624] vhci_hcd: vhci_hub_control:635: port 5 [ 1313.100126] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1313.073624] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1313.073624] vhci_hcd: dump_port_status_diff:142: POWER [ 1313.073624] vhci_hcd: dump_port_status_diff:150: [ 1313.073624] vhci_hcd: vhci_hub_control:643: bye [ 1313.118053] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.157225] vhci_hcd: vhci_hub_control:635: port 0 [ 1313.176215] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 7 [ 1313.174725] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.174725] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.188813] vhci_hcd: dump_port_status_diff:150: [ 1313.188813] vhci_hcd: vhci_hub_control:643: bye [ 1313.192654] vhci_hcd: vhci_hub_control:431: GetPortStatus port 7 [ 1313.192654] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1313.192654] vhci_hcd: vhci_hub_control:635: port 6 [ 1313.192654] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1313.192654] vhci_hcd: dump_port_status_diff:142: POWER [ 1313.192654] vhci_hcd: dump_port_status_diff:150: [ 1313.192654] vhci_hcd: vhci_hub_control:643: bye [ 1313.269440] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1313.283379] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.284252] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 8 [ 1313.286542] vhci_hcd: vhci_hub_control:635: port 1 [ 1313.286542] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.286542] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.286542] vhci_hcd: dump_port_status_diff:150: [ 1313.286542] vhci_hcd: vhci_hub_control:643: bye [ 1313.299454] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1313.310924] vhci_hcd: vhci_hub_control:431: GetPortStatus port 8 [ 1313.313818] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 100 0 [ 1313.313818] vhci_hcd: vhci_hub_control:635: port 7 [ 1313.313818] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000100 -> 00000100 [ 1313.313818] vhci_hcd: dump_port_status_diff:142: POWER [ 1313.313818] vhci_hcd: dump_port_status_diff:150: [ 1313.313818] vhci_hcd: vhci_hub_control:643: bye [ 1313.333587] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.444543] usb usb1: vhci_bus_suspend [ 1313.333587] vhci_hcd: vhci_hub_control:635: port 2 [ 1313.333587] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.333587] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.333587] vhci_hcd: dump_port_status_diff:150: [ 1313.333587] vhci_hcd: vhci_hub_control:643: bye [ 1313.451588] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1313.517930] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.521696] vhci_hcd: vhci_hub_control:635: port 3 [ 1313.521696] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.521696] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.521696] vhci_hcd: dump_port_status_diff:150: [ 1313.521696] vhci_hcd: vhci_hub_control:643: bye [ 1313.620525] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1313.635105] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.638723] vhci_hcd: vhci_hub_control:635: port 4 [ 1313.638723] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.638723] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.638723] vhci_hcd: dump_port_status_diff:150: [ 1313.638723] vhci_hcd: vhci_hub_control:643: bye [ 1313.723515] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1313.751733] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.753699] vhci_hcd: vhci_hub_control:635: port 5 [ 1313.753699] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.753699] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.753699] vhci_hcd: dump_port_status_diff:150: [ 1313.753699] vhci_hcd: vhci_hub_control:643: bye [ 1313.841500] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1313.876790] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.891050] vhci_hcd: vhci_hub_control:635: port 6 [ 1313.894553] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.913897] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.921834] vhci_hcd: dump_port_status_diff:150: [ 1313.931720] vhci_hcd: vhci_hub_control:643: bye [ 1313.945459] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1313.960661] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1313.965783] vhci_hcd: vhci_hub_control:635: port 7 [ 1313.965783] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000000 -> 00000200 [ 1313.965783] vhci_hcd: dump_port_status_diff:142: +POWER [ 1313.965783] vhci_hcd: dump_port_status_diff:150: [ 1313.965783] vhci_hcd: vhci_hub_control:643: bye [ 1314.051268] _warn_unseeded_randomness: 1 callbacks suppressed [ 1314.051359] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1314.092389] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1314.138891] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1314.161998] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1314.186280] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1314.207957] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1314.233528] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1314.256986] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1314.281453] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1314.319300] hub 2-0:1.0: USB hub found [ 1314.328671] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1314.342380] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1314.350244] vhci_hcd: vhci_hub_control:635: port -1 [ 1314.350244] vhci_hcd: vhci_hub_control:643: bye [ 1314.373840] hub 2-0:1.0: 8 ports detected [ 1314.384085] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1314.398242] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1314.401601] vhci_hcd: vhci_hub_control:635: port -1 [ 1314.401601] vhci_hcd: vhci_hub_control:643: bye [ 1314.460653] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1314.555727] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1314.615938] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1314.617574] vhci_hcd: vhci_hub_control:635: port 0 [ 1314.630304] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1314.647276] vhci_hcd: dump_port_status_diff:142: POWER [ 1314.661858] vhci_hcd: dump_port_status_diff:150: [ 1314.669830] vhci_hcd: vhci_hub_control:643: bye [ 1314.684578] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1314.700407] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1314.702889] vhci_hcd: vhci_hub_control:635: port 1 [ 1314.702889] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1314.702889] vhci_hcd: dump_port_status_diff:142: POWER [ 1314.713989] vhci_hcd: dump_port_status_diff:150: [ 1314.713989] vhci_hcd: vhci_hub_control:643: bye [ 1314.734569] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1314.748043] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1314.753906] vhci_hcd: vhci_hub_control:635: port 2 [ 1314.764307] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1314.765564] vhci_hcd: dump_port_status_diff:142: POWER [ 1314.769557] vhci_hcd: dump_port_status_diff:150: [ 1314.769557] vhci_hcd: vhci_hub_control:643: bye [ 1314.784370] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1314.797399] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1314.815418] vhci_hcd: vhci_hub_control:635: port 3 [ 1314.822705] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1314.837849] vhci_hcd: dump_port_status_diff:142: POWER [ 1314.849897] vhci_hcd: dump_port_status_diff:150: [ 1314.857869] vhci_hcd: vhci_hub_control:643: bye [ 1314.872677] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1314.886289] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1314.890030] vhci_hcd: vhci_hub_control:635: port 4 [ 1314.890030] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1314.890030] vhci_hcd: dump_port_status_diff:142: POWER [ 1314.890030] vhci_hcd: dump_port_status_diff:150: [ 1314.890030] vhci_hcd: vhci_hub_control:643: bye [ 1314.943083] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1314.956240] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1314.959948] vhci_hcd: vhci_hub_control:635: port 5 [ 1314.959948] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1314.959948] vhci_hcd: dump_port_status_diff:142: POWER [ 1314.959948] vhci_hcd: dump_port_status_diff:150: [ 1314.997628] vhci_hcd: vhci_hub_control:643: bye [ 1314.999996] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1315.002078] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1315.006043] vhci_hcd: vhci_hub_control:635: port 6 [ 1315.022019] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1315.033866] vhci_hcd: dump_port_status_diff:142: POWER [ 1315.045854] vhci_hcd: dump_port_status_diff:150: [ 1315.053863] vhci_hcd: vhci_hub_control:643: bye [ 1315.068390] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1315.080933] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1315.084744] vhci_hcd: vhci_hub_control:635: port 7 [ 1315.084744] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1315.084744] vhci_hcd: dump_port_status_diff:142: POWER [ 1315.084744] vhci_hcd: dump_port_status_diff:150: [ 1315.084744] vhci_hcd: vhci_hub_control:643: bye [ 1315.174841] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1315.191397] kobject: 'ep_81' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1315.216765] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1315.241340] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1315.264327] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1315.307571] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1315.329340] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1315.357085] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1315.380355] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1315.402264] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1315.433714] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1315.476371] hub 2-0:1.0: USB hub found [ 1315.486095] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1315.499349] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1315.503118] vhci_hcd: vhci_hub_control:635: port -1 [ 1315.516459] vhci_hcd: vhci_hub_control:643: bye [ 1315.530065] hub 2-0:1.0: 8 ports detected [ 1315.549941] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1315.562964] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1315.566774] vhci_hcd: vhci_hub_control:635: port -1 [ 1315.590273] vhci_hcd: vhci_hub_control:643: bye [ 1315.683394] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1315.696455] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1315.706850] vhci_hcd: vhci_hub_control:635: port 0 [ 1315.713751] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1315.729753] vhci_hcd: dump_port_status_diff:142: POWER [ 1315.741909] vhci_hcd: dump_port_status_diff:150: [ 1315.750921] vhci_hcd: vhci_hub_control:643: bye [ 1315.766899] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1315.809900] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1315.813577] vhci_hcd: vhci_hub_control:635: port 1 [ 1315.813577] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1315.813577] vhci_hcd: dump_port_status_diff:142: POWER [ 1315.813577] vhci_hcd: dump_port_status_diff:150: [ 1315.813577] vhci_hcd: vhci_hub_control:643: bye [ 1315.884369] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1315.897433] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1315.910712] vhci_hcd: vhci_hub_control:635: port 2 [ 1315.911098] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1315.934462] vhci_hcd: dump_port_status_diff:142: POWER [ 1315.941821] vhci_hcd: dump_port_status_diff:150: [ 1315.949805] vhci_hcd: vhci_hub_control:643: bye [ 1315.967420] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1315.980386] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1315.986542] vhci_hcd: vhci_hub_control:635: port 3 [ 1315.986542] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1315.986542] vhci_hcd: dump_port_status_diff:142: POWER [ 1315.986542] vhci_hcd: dump_port_status_diff:150: [ 1315.986542] vhci_hcd: vhci_hub_control:643: bye [ 1316.056051] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1316.068721] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.072536] vhci_hcd: vhci_hub_control:635: port 4 [ 1316.072536] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.072536] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.072536] vhci_hcd: dump_port_status_diff:150: [ 1316.118211] vhci_hcd: vhci_hub_control:643: bye [ 1316.146761] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1316.160468] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.161736] vhci_hcd: vhci_hub_control:635: port 5 [ 1316.161736] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.161736] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.161736] vhci_hcd: dump_port_status_diff:150: [ 1316.161736] vhci_hcd: vhci_hub_control:643: bye [ 1316.227807] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1316.240352] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.244097] vhci_hcd: vhci_hub_control:635: port 6 [ 1316.258136] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.274094] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.285767] vhci_hcd: dump_port_status_diff:150: [ 1316.297847] vhci_hcd: vhci_hub_control:643: bye [ 1316.313500] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1316.326361] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.336407] vhci_hcd: vhci_hub_control:635: port 7 [ 1316.336407] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.336407] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.336407] vhci_hcd: dump_port_status_diff:150: [ 1316.336407] vhci_hcd: vhci_hub_control:643: bye [ 1316.403074] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1316.418274] kobject: 'usb2-port8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1316.439403] kobject: 'usb2-port7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1316.460858] kobject: 'usb2-port6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1316.482380] kobject: 'usb2-port5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1316.505275] kobject: 'usb2-port4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1316.525012] kobject: 'usb2-port3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1316.548904] kobject: 'usb2-port2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1316.554802] kobject: 'usb2-port1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1316.558779] hub 2-0:1.0: USB hub found [ 1316.562981] vhci_hcd: vhci_hub_control:336: typeReq a006 wValue 2a00 wIndex 0 [ 1316.586503] vhci_hcd: vhci_hub_control:404: GetHubDescriptor [ 1316.589662] vhci_hcd: vhci_hub_control:635: port -1 [ 1316.589662] vhci_hcd: vhci_hub_control:643: bye [ 1316.616995] hub 2-0:1.0: 8 ports detected [ 1316.628764] vhci_hcd: vhci_hub_control:336: typeReq a000 wValue 0 wIndex 0 [ 1316.643089] vhci_hcd: vhci_hub_control:427: GetHubStatus [ 1316.645758] vhci_hcd: vhci_hub_control:635: port -1 [ 1316.645758] vhci_hcd: vhci_hub_control:643: bye [ 1316.675136] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1316.761044] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 1 [ 1316.774854] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.777975] vhci_hcd: vhci_hub_control:635: port 0 [ 1316.777975] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.777975] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.777975] vhci_hcd: dump_port_status_diff:150: [ 1316.777975] vhci_hcd: vhci_hub_control:643: bye [ 1316.843352] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 2 [ 1316.856314] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.864869] vhci_hcd: vhci_hub_control:635: port 1 [ 1316.864869] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.864869] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.864869] vhci_hcd: dump_port_status_diff:150: [ 1316.864869] vhci_hcd: vhci_hub_control:643: bye [ 1316.924310] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 3 [ 1316.938033] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1316.941678] vhci_hcd: vhci_hub_control:635: port 2 [ 1316.941678] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1316.941678] vhci_hcd: dump_port_status_diff:142: POWER [ 1316.941678] vhci_hcd: dump_port_status_diff:150: [ 1316.941678] vhci_hcd: vhci_hub_control:643: bye [ 1316.981340] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 4 [ 1317.010053] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1317.013911] vhci_hcd: vhci_hub_control:635: port 3 [ 1317.013911] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.013911] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.013911] vhci_hcd: dump_port_status_diff:150: [ 1317.013911] vhci_hcd: vhci_hub_control:643: bye [ 1317.055875] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 5 [ 1317.071683] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1317.082086] vhci_hcd: vhci_hub_control:635: port 4 [ 1317.089897] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.105906] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.113848] vhci_hcd: dump_port_status_diff:150: [ 1317.117583] vhci_hcd: vhci_hub_control:643: bye [ 1317.121819] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 6 [ 1317.124092] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1317.125523] vhci_hcd: vhci_hub_control:635: port 5 [ 1317.125523] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.125523] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.125523] vhci_hcd: dump_port_status_diff:150: [ 1317.125523] vhci_hcd: vhci_hub_control:643: bye [ 1317.174976] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 7 [ 1317.193969] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1317.197643] vhci_hcd: vhci_hub_control:635: port 6 [ 1317.197643] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.197643] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.197643] vhci_hcd: dump_port_status_diff:150: [ 1317.197643] vhci_hcd: vhci_hub_control:643: bye [ 1317.258723] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 8 wIndex 8 [ 1317.270999] vhci_hcd: vhci_hub_control:541: SetPortFeature: USB_PORT_FEAT_POWER [ 1317.282246] vhci_hcd: vhci_hub_control:635: port 7 [ 1317.289862] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.301821] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.313841] vhci_hcd: dump_port_status_diff:150: [ 1317.321845] vhci_hcd: vhci_hub_control:643: bye [ 1317.344091] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1317.365877] vhci_hcd: vhci_hcd_probe:1360: bye [ 1317.370464] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 1317.373604] kobject: '2-0:1.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1317.390381] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 1317.409238] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 1317.440313] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 1 [ 1317.465853] vhci_hcd: vhci_hub_control:431: GetPortStatus port 1 [ 1317.481823] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1317.497783] vhci_hcd: vhci_hub_control:635: port 0 [ 1317.513849] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.537856] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.553860] vhci_hcd: dump_port_status_diff:150: [ 1317.565852] vhci_hcd: vhci_hub_control:643: bye [ 1317.591746] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 2 [ 1317.595568] evbug: Connected device: input1 (Power Button at LNXPWRBN/button/input0) [ 1317.615636] vhci_hcd: vhci_hub_control:431: GetPortStatus port 2 [ 1317.615698] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1317.615760] vhci_hcd: vhci_hub_control:635: port 1 [ 1317.668480] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.693247] usbcore: registered new interface driver appletouch [ 1317.668480] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.668480] vhci_hcd: dump_port_status_diff:150: [ 1317.668480] vhci_hcd: vhci_hub_control:643: bye [ 1317.710942] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 3 [ 1317.718750] usbcore: registered new interface driver synaptics_usb [ 1317.729372] vhci_hcd: vhci_hub_control:431: GetPortStatus port 3 [ 1317.766639] i2c /dev entries driver [ 1317.753969] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1317.753969] vhci_hcd: vhci_hub_control:635: port 2 [ 1317.753969] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.753969] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.753969] vhci_hcd: dump_port_status_diff:150: [ 1317.753969] vhci_hcd: vhci_hub_control:643: bye [ 1317.775133] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 4 [ 1317.812714] usbcore: registered new interface driver i2c-diolan-u2c [ 1317.814957] vhci_hcd: vhci_hub_control:431: GetPortStatus port 4 [ 1317.857023] i2c-parport-light: adapter type unspecified [ 1317.817923] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1317.817923] vhci_hcd: vhci_hub_control:635: port 3 [ 1317.817923] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.817923] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.817923] vhci_hcd: dump_port_status_diff:150: [ 1317.817923] vhci_hcd: vhci_hub_control:643: bye [ 1317.871255] usbcore: registered new interface driver i2c-tiny-usb [ 1317.882332] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 5 [ 1317.899082] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2 [ 1317.901451] vhci_hcd: vhci_hub_control:431: GetPortStatus port 5 [ 1317.923460] evbug: Connected device: input2 (AT Translated Set 2 keyboard at isa0060/serio0/input0) [ 1317.913275] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1317.913275] vhci_hcd: vhci_hub_control:635: port 4 [ 1317.913275] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1317.913275] vhci_hcd: dump_port_status_diff:142: POWER [ 1317.913275] vhci_hcd: dump_port_status_diff:150: [ 1317.913275] vhci_hcd: vhci_hub_control:643: bye [ 1317.954367] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 6 [ 1318.083086] IR NEC protocol handler initialized [ 1318.095920] vhci_hcd: vhci_hub_control:431: GetPortStatus port 6 [ 1318.111087] _warn_unseeded_randomness: 1 callbacks suppressed [ 1318.111247] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1318.104444] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1318.104444] vhci_hcd: vhci_hub_control:635: port 5 [ 1318.104444] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1318.104444] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.104444] vhci_hcd: dump_port_status_diff:150: [ 1318.104444] vhci_hcd: vhci_hub_control:643: bye [ 1318.122012] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 7 [ 1318.145826] IR RC5(x/sz) protocol handler initialized [ 1318.156970] vhci_hcd: vhci_hub_control:431: GetPortStatus port 7 [ 1318.157012] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1318.171682] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1318.171465] vhci_hcd: vhci_hub_control:635: port 6 [ 1318.171465] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1318.171465] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.171465] vhci_hcd: dump_port_status_diff:150: [ 1318.171465] vhci_hcd: vhci_hub_control:643: bye [ 1318.179853] vhci_hcd: vhci_hub_control:336: typeReq a300 wValue 0 wIndex 8 [ 1318.191680] IR JVC protocol handler initialized [ 1318.202215] vhci_hcd: vhci_hub_control:431: GetPortStatus port 8 [ 1318.206644] evbug: Disconnected device: input2 [ 1318.205636] vhci_hcd: vhci_hub_control:487: GetPortStatus bye 200 0 [ 1318.205636] vhci_hcd: vhci_hub_control:635: port 7 [ 1318.213650] IR Sony protocol handler initialized [ 1318.205636] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 00000200 [ 1318.205636] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.205636] vhci_hcd: dump_port_status_diff:150: [ 1318.205636] vhci_hcd: vhci_hub_control:643: bye [ 1318.225210] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 1 [ 1318.236588] kobject: 'input' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1318.243426] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.243464] vhci_hcd: vhci_hub_control:635: port 0 [ 1318.243524] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.243561] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.243619] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.243654] vhci_hcd: dump_port_status_diff:150: [ 1318.243693] vhci_hcd: vhci_hub_control:643: bye [ 1318.254906] IR SANYO protocol handler initialized [ 1318.262076] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 2 [ 1318.266246] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1318.267782] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.269364] IR XMP protocol handler initialized [ 1318.271713] vhci_hcd: vhci_hub_control:635: port 1 [ 1318.271713] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.271713] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.271713] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.271713] vhci_hcd: dump_port_status_diff:150: [ 1318.271713] vhci_hcd: vhci_hub_control:643: bye [ 1318.278969] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 3 [ 1318.291083] ir_imon_decoder: IR iMON protocol handler initialized [ 1318.300773] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.308812] IR RCMM protocol handler initialized [ 1318.301929] vhci_hcd: vhci_hub_control:635: port 2 [ 1318.301929] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.301929] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.301929] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.301929] vhci_hcd: dump_port_status_diff:150: [ 1318.301929] vhci_hcd: vhci_hub_control:643: bye [ 1318.323240] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 4 [ 1318.335253] Driver for 1-wire Dallas network protocol. [ 1318.342693] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.354826] usbcore: registered new interface driver DS9490R [ 1318.350359] vhci_hcd: vhci_hub_control:635: port 3 [ 1318.350359] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.350359] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.350359] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.350359] vhci_hcd: dump_port_status_diff:150: [ 1318.350359] vhci_hcd: vhci_hub_control:643: bye [ 1318.363318] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 5 [ 1318.373918] w1_f0d_init() [ 1318.380854] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.456872] applesmc: supported laptop not found! [ 1318.426848] vhci_hcd: vhci_hub_control:635: port 4 [ 1318.426848] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.426848] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.426848] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.426848] vhci_hcd: dump_port_status_diff:150: [ 1318.470134] applesmc: driver init failed (ret=-19)! [ 1318.426848] vhci_hcd: vhci_hub_control:643: bye [ 1318.508020] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 6 [ 1318.529434] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input3 [ 1318.530990] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.556050] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1318.541331] vhci_hcd: vhci_hub_control:635: port 5 [ 1318.541331] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.541331] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.541331] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.541331] vhci_hcd: dump_port_status_diff:150: [ 1318.541331] vhci_hcd: vhci_hub_control:643: bye [ 1318.570563] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 7 [ 1318.587584] evbug: Connected device: input3 (AT Translated Set 2 keyboard at isa0060/serio0/input0) [ 1318.601279] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.610859] kobject: 'it87' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1318.604725] vhci_hcd: vhci_hub_control:635: port 6 [ 1318.604725] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.604725] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.604725] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.604725] vhci_hcd: dump_port_status_diff:150: [ 1318.604725] vhci_hcd: vhci_hub_control:643: bye [ 1318.623248] vhci_hcd: vhci_hub_control:336: typeReq 2303 wValue 1b wIndex 8 [ 1318.647730] kobject: 'input4' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1318.650080] vhci_hcd: vhci_hub_control:591: SetPortFeature: default 27 [ 1318.689763] kobject: 'mc13783-adc' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1318.681789] vhci_hcd: vhci_hub_control:635: port 7 [ 1318.681789] vhci_hcd: dump_port_status_diff:128: status prev -> new: 00000200 -> 08000200 [ 1318.681789] vhci_hcd: dump_port_status_diff:142: POWER [ 1318.681789] vhci_hcd: dump_port_status_diff:142: +R27 [ 1318.681789] vhci_hcd: dump_port_status_diff:150: [ 1318.681789] vhci_hcd: vhci_hub_control:643: bye [ 1318.727982] usb usb2: vhci_bus_suspend [ 1318.771526] kobject: 'nct6683' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1319.292240] kobject: 'nct6775' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1319.330901] _warn_unseeded_randomness: 6 callbacks suppressed [ 1319.330968] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1319.438889] usbcore: registered new interface driver pcwd_usb [ 1319.454502] wafer5823wdt: WDT driver for Wafer 5823 single board computer initialising [ 1319.476856] wafer5823wdt: initialized. timeout=60 sec (nowayout=0) [ 1319.513867] it87_wdt: no device [ 1319.515107] sc1200wdt: build 20020303 [ 1319.516390] sc1200wdt: io parameter must be specified [ 1319.525301] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1319.540024] kobject: 'scl200wdt' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1319.579978] sbc60xxwdt: I/O address 0x0443 already in use [ 1319.590469] cpu5wdt: misc_register failed [ 1319.598736] smsc37b787_wdt: SMsC 37B787 watchdog component driver 1.1 initialising... [ 1319.616113] smsc37b787_wdt: Unable to register miscdev on minor 130 [ 1319.632341] w83977f_wdt: driver v1.00 [ 1319.639762] w83977f_wdt: cannot register miscdev on minor=130 (err=-16) [ 1319.652337] sbc_epx_c3: cannot register miscdev on minor=130 (err=-16) [ 1319.679523] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1319.716274] md-cluster: support raid1 and raid10 (limited support) [ 1319.733775] Registering Cluster MD functions [ 1319.766865] usbcore: registered new interface driver bpa10x [ 1319.781829] intel_pstate: CPU model not supported [ 1319.808559] kobject: 'mc13xxx-led' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1319.928912] kobject: '32' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1319.949855] kobject: '33' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1319.961882] kobject: '34' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1319.965522] kobject: '35' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1319.968282] kobject: '36' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1319.976696] kobject: '37' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1319.994066] kobject: '38' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1320.025858] kobject: '39' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1320.044420] kobject: '40' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1320.061922] kobject: '41' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1320.080068] kobject: '42' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1320.098278] kobject: '43' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1320.131105] kobject: 'acpi' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1320.145112] kobject: 'smbios' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1320.159654] kobject: 'tpm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1320.175701] kobject: 'etc' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1320.207130] kobject: 'genroms' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1320.225276] kobject: 'by_name' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1320.280532] fw_cfg: probe of QEMU0002:00 failed with error -16 [ 1320.297743] hidraw: raw HID events driver (C) Jiri Kosina [ 1320.346637] _warn_unseeded_randomness: 5 callbacks suppressed [ 1320.346705] random: get_random_u64 called from copy_process+0x5b5/0x4642 with crng_init=0 [ 1320.488874] usbcore: registered new interface driver usbhid [ 1320.507765] usbhid: USB HID core driver [ 1320.537062] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1320.568432] kobject: 'chromeos_pstore' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1320.590071] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1320.633110] fake-fmc-carrier: mezzanine 0 [ 1320.643412] Manufacturer: fake-vendor [ 1320.652034] Product name: fake-design-for-testing [ 1320.671022] fmc fake-design-for-testing-f001: Driver has no ID: matches all [ 1320.685899] fmc_write_eeprom fake-design-for-testing-f001: fmc_write_eeprom: no busid passed, refusing all cards [ 1320.718878] gnss: GNSS driver registered with major 236 [ 1320.751497] drop_monitor: Initializing network drop monitor service [ 1320.771723] NET: Registered protocol family 26 [ 1320.799043] ipip: IPv4 and MPLS over IPv4 tunneling driver [ 1320.815108] NET: Registered protocol family 10 [ 1320.898043] Segment Routing with IPv6 [ 1320.909034] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 1320.999673] bpfilter: Loaded bpfilter_umh pid 206 Started bpfilter [ 1321.040834] NET: Registered protocol family 5 [ 1321.060437] NET: Unregistered protocol family 5 [ 1321.067242] NET: Registered protocol family 9 [ 1321.078488] X25: Linux Version 0.2 [ 1321.084120] can: controller area network core (rev 20170425 abi 9) [ 1321.095211] NET: Registered protocol family 29 [ 1321.096724] can: netlink gateway (rev 20170425) max_hops=1 [ 1321.099028] Bluetooth: BNEP (Ethernet Emulation) ver 1.3 [ 1321.100857] Bluetooth: BNEP filters: multicast [ 1321.102044] Bluetooth: BNEP socket layer initialized [ 1321.122350] NET: Registered protocol family 33 [ 1321.132233] Key type rxrpc registered [ 1321.139814] Key type rxrpc_s registered [ 1321.153030] NET: Registered protocol family 35 [ 1321.165055] 8021q: 802.1Q VLAN Support v1.8 [ 1321.177725] sctp: Hash tables configured (bind 32/51) [ 1321.206957] lib80211: common routines for IEEE802.11 drivers [ 1321.218327] lib80211_crypt: registered algorithm 'NULL' [ 1321.228478] lib80211_crypt: registered algorithm 'WEP' [ 1321.245969] lib80211_crypt: registered algorithm 'CCMP' [ 1321.287652] lib80211_crypt: registered algorithm 'TKIP' [ 1321.297916] tipc: Activated (version 2.0.0) [ 1321.315059] NET: Registered protocol family 30 [ 1321.334351] kobject: 'event1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1321.336612] tipc: Started in single node mode [ 1321.363319] 9pnet: Installing 9P2000 support [ 1321.375303] NET: Registered protocol family 37 [ 1321.387622] Key type ceph registered [ 1321.407096] _warn_unseeded_randomness: 32 callbacks suppressed [ 1321.407263] random: get_random_u64 called from copy_process+0x5b5/0x4642 with crng_init=0 [ 1321.474417] random: get_random_u64 called from cache_random_seq_create+0x54/0xe9 with crng_init=0 [ 1321.479742] libceph: loaded (mon/osd proto 15/24) [ 1321.484688] ... APIC ID: 00000000 (0) [ 1321.485490] ... APIC VERSION: 00050014 [ 1321.485490] 0000000000000000000000000000000000000000000000000000000000000000 [ 1321.485490] 0000000000000000000000000000000000000000000000000000000000001000 [ 1321.533792] number of MP IRQ sources: 15. [ 1321.542215] number of IO-APIC #0 registers: 24. [ 1321.551101] testing the IO APIC....................... [ 1321.561926] IO APIC #0...... [ 1321.573781] .... register #00: 00000000 [ 1321.581262] ....... : physical APIC id: 00 [ 1321.590009] ....... : Delivery Type: 0 [ 1321.591982] ....... : LTS : 0 [ 1321.593750] .... register #01: 00170011 [ 1321.595204] ....... : max redirection entries: 17 [ 1321.596841] ....... : PRQ implemented: 0 [ 1321.598188] ....... : IO APIC version: 11 [ 1321.599405] .... register #02: 00000000 [ 1321.604634] ....... : arbitration: 00 [ 1321.612470] .... IRQ redirection table: [ 1321.619891] IOAPIC 0: [ 1321.625177] pin00, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.636559] pin01, enabled , edge , high, V(22), IRR(0), S(0), logical , D(02), M(0) [ 1321.640269] pin02, enabled , edge , high, V(30), IRR(0), S(0), logical , D(01), M(0) [ 1321.642922] pin03, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.645132] pin04, enabled , edge , high, V(22), IRR(0), S(0), logical , D(01), M(0) [ 1321.658495] pin05, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.674655] pin06, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.683626] pin07, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.687082] pin08, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.689648] pin09, enabled , level, high, V(21), IRR(0), S(0), logical , D(02), M(0) [ 1321.691836] pin0a, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.703543] pin0b, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.718776] pin0c, enabled , edge , high, V(21), IRR(0), S(0), logical , D(01), M(0) [ 1321.742077] pin0d, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.756820] pin0e, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.772040] pin0f, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.810086] pin10, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.827531] pin11, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.843562] pin12, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.858606] pin13, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.867521] pin14, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.870911] pin15, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.873707] pin16, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.887868] pin17, disabled, edge , high, V(00), IRR(0), S(0), physical, D(00), M(0) [ 1321.904274] IRQ to pin mappings: [ 1321.911329] IRQ0 -> 0:2 [ 1321.916451] IRQ1 -> 0:1 [ 1321.921963] IRQ3 -> 0:3 [ 1321.927800] IRQ4 -> 0:4 [ 1321.932945] IRQ5 -> 0:5 [ 1321.950672] IRQ6 -> 0:6 [ 1321.955991] IRQ7 -> 0:7 [ 1321.961277] IRQ8 -> 0:8 [ 1321.968073] IRQ9 -> 0:9 [ 1321.973393] IRQ10 -> 0:10 [ 1321.979386] IRQ11 -> 0:11 [ 1321.985053] IRQ12 -> 0:12 [ 1321.993835] IRQ13 -> 0:13 [ 1321.999998] IRQ14 -> 0:14 [ 1322.010494] IRQ15 -> 0:15 [ 1322.016461] .................................... done. [ 1322.029552] random: get_random_bytes called from init_oops_id+0x22/0x31 with crng_init=0 [ 1322.046046] sched_clock: Marking stable (1318591984963, 3453577371)->(1323905114948, -1859552614) [ 1322.154024] PM: Magic number: 7:921:488 [ 1322.163812] regulator regulator.0: hash matches [ 1322.205122] Duplicate name in testcase-data, renamed to "duplicate-name#1" [ 1322.424808] ### dt-test ### start of unittest - you will see error messages [ 1322.452056] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 1322.477820] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 1322.502551] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 1322.516350] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 1322.527402] OF: /testcase-data/phandle-tests/consumer-a: #phandle-cells = 3 found 0 [ 1322.530709] OF: /testcase-data/phandle-tests/consumer-a: #phandle-cells = 3 found 0 [ 1322.535260] OF: /testcase-data/phandle-tests/consumer-b: could not get #phandle-missing-cells for /testcase-data/phandle-tests/provider1 [ 1322.588717] OF: /testcase-data/phandle-tests/consumer-b: could not find phandle [ 1322.604344] OF: /testcase-data/phandle-tests/consumer-b: #phandle-cells = 2 found 0 [ 1322.761027] _warn_unseeded_randomness: 2 callbacks suppressed [ 1322.761118] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1322.789125] kobject: 'testcase-data:platform-tests:test-device@0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1322.819869] kobject: 'testcase-data:platform-tests:test-device@1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1322.849077] kobject: 'unittest-bus.0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1322.887087] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1322.931724] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest0/status [ 1322.983877] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest1/status [ 1323.016411] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1323.032576] kobject: 'testcase-data:overlay-node:test-bus:test-unittest1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1323.064245] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest2/status [ 1323.123310] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest3/status [ 1323.157045] kobject: 'testcase-data:overlay-node:test-bus:test-unittest3' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1323.211250] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest5/status [ 1323.262667] kobject: 'testcase-data:overlay-node:test-bus:test-unittest5' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1323.295691] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest6/status [ 1323.321686] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest7/status [ 1323.382458] ================================================================== [ 1323.396303] BUG: KASAN: use-after-free in kobject_uevent_env+0x1b6/0xb19 [ 1323.409096] Read of size 8 at addr ffff888015bea418 by task kworker/0:1/12 [ 1323.422359] [ 1323.425722] CPU: 0 PID: 12 Comm: kworker/0:1 Not tainted 5.2.0-rc1-00387-g47cdee29 #1 [ 1323.440730] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 1323.456710] Workqueue: events kobject_delayed_cleanup [ 1323.466558] Call Trace: [ 1323.471586] dump_stack+0x15a/0x215 [ 1323.478551] ? kobject_uevent_env+0x1b6/0xb19 [ 1323.487268] print_address_description+0x67/0x1f5 [ 1323.496245] ? kobject_uevent_env+0x1b6/0xb19 [ 1323.504760] ? kobject_uevent_env+0x1b6/0xb19 [ 1323.513348] __kasan_report+0x183/0x1b3 [ 1323.517658] ? kobject_uevent_env+0x1b6/0xb19 [ 1323.519841] kobject_uevent_env+0x1b6/0xb19 [ 1323.521639] ? lock_acquire+0x1c3/0x2d3 [ 1323.523030] ? process_one_work+0x6ac/0xd23 [ 1323.524433] kobject_delayed_cleanup+0x199/0x2e1 [ 1323.527592] process_one_work+0x79d/0xd23 [ 1323.535571] ? pwq_dec_nr_in_flight+0x23a/0x23a [ 1323.544512] worker_thread+0x5ee/0x7ce [ 1323.551903] kthread+0x33f/0x34e [ 1323.558288] ? process_scheduled_works+0x6d/0x6d [ 1323.567296] ? __kthread_create_on_node+0x346/0x346 [ 1323.576889] ret_from_fork+0x24/0x30 [ 1323.583919] [ 1323.587061] Allocated by task 1: [ 1323.590922] __kasan_kmalloc+0x38/0x91 [ 1323.593098] kmem_cache_alloc_trace+0x1b8/0x260 [ 1323.594999] fw_cfg_register_dir_entries+0x3ec/0x58b [ 1323.596779] fw_cfg_sysfs_probe+0x389/0x3f8 [ 1323.598183] platform_drv_probe+0xb6/0x127 [ 1323.601994] really_probe+0x366/0xa6a [ 1323.608955] driver_probe_device+0x255/0x2ae [ 1323.617317] device_driver_attach+0xe1/0x11c [ 1323.625328] __driver_attach+0x212/0x21c [ 1323.632882] bus_for_each_dev+0x100/0x13f [ 1323.640363] bus_add_driver+0x2f8/0x48f [ 1323.647682] driver_register+0x263/0x2d7 [ 1323.655305] fw_cfg_sysfs_init+0x5c/0x7e [ 1323.662758] do_one_initcall+0x101/0x394 [ 1323.670529] kernel_init_freeable+0x3e3/0x549 [ 1323.678952] kernel_init+0xc/0x108 [ 1323.685541] ret_from_fork+0x24/0x30 [ 1323.692639] [ 1323.695749] Freed by task 12: [ 1323.700022] __kasan_slab_free+0x120/0x191 [ 1323.702320] kfree+0x129/0x1a1 [ 1323.703737] kobject_delayed_cleanup+0x2a6/0x2e1 [ 1323.705530] process_one_work+0x79d/0xd23 [ 1323.706927] worker_thread+0x5ee/0x7ce [ 1323.708135] kthread+0x33f/0x34e [ 1323.709115] ret_from_fork+0x24/0x30 [ 1323.713212] [ 1323.716446] The buggy address belongs to the object at ffff888015bea2c0 [ 1323.716446] which belongs to the cache kmalloc-512 of size 512 [ 1323.740817] The buggy address is located 344 bytes inside of [ 1323.740817] 512-byte region [ffff888015bea2c0, ffff888015bea4c0) [ 1323.763056] The buggy address belongs to the page: [ 1323.772353] page:ffffea00004c1b30 refcount:1 mapcount:0 mapping:ffff888000098400 index:0x0 [ 1323.787970] flags: 0xfffc0000000200(slab) [ 1323.795913] raw: 00fffc0000000200 ffffea0000444740 ffffea00004c17b8 ffff888000098400 [ 1323.810821] raw: 0000000000000000 ffff888015bea040 0000000100000006 [ 1323.820507] page dumped because: kasan: bad access detected [ 1323.823051] [ 1323.823744] Memory state around the buggy address: [ 1323.825548] ffff888015bea300: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 1323.827869] ffff888015bea380: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 1323.830471] >ffff888015bea400: fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb fb [ 1323.844431] ^ [ 1323.852436] ffff888015bea480: fb fb fb fb fb fb fb fb fc fc fc fc fc fc fc fc [ 1323.866540] ffff888015bea500: fc fc fc fc fc fc fc fc fb fb fb fb fb fb fb fb [ 1323.880570] ================================================================== [ 1323.890228] Disabling lock debugging due to kernel taint [ 1323.898856] _warn_unseeded_randomness: 5 callbacks suppressed [ 1323.898918] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1323.927949] kobject: 'testcase-data:overlay-node:test-bus:test-unittest7' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1323.949021] kobject: 'testcase-data:overlay-node:test-bus:test-unittest6' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1323.953835] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1323.958811] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/status [ 1324.002594] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/property-foo [ 1324.027126] OF: overlay: node_overlaps_later_cs: #6 overlaps with #7 @/testcase-data/overlay-node/test-bus/test-unittest8 [ 1324.053640] OF: overlay: overlay #6 is not topmost [ 1324.068415] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1324.078431] kobject: 'testcase-data:overlay-node:test-bus:test-unittest8' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1324.150336] kobject: 'by_key' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1324.222796] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11:test-unittest111' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1324.255392] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1324.282127] OF: ERROR: memory leak, expected refcount 1 instead of 2, of_node_get()/of_node_put() unbalanced - destroy cset entry: attach overlay node /testcase-data/overlay-node/test-bus/test-unittest11/test-unittest111 [ 1324.320526] OF: ERROR: memory leak, expected refcount 1 instead of 2, of_node_get()/of_node_put() unbalanced - destroy cset entry: attach overlay node /testcase-data/overlay-node/test-bus/test-unittest11 [ 1324.423219] kobject: '0-0009' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1324.447267] kobject: '0-000a' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1324.466361] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1324.485318] ------------[ cut here ]------------ [ 1324.494253] ODEBUG: free active (active state 0) object type: timer_list hint: delayed_work_timer_fn+0x0/0x6b [ 1324.513020] WARNING: CPU: 0 PID: 1 at lib/debugobjects.c:328 debug_print_object+0x169/0x181 [ 1324.532042] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G B 5.2.0-rc1-00387-g47cdee29 #1 [ 1324.548347] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 1324.564033] RIP: 0010:debug_print_object+0x169/0x181 [ 1324.573655] Code: 3c 02 00 74 05 e8 f1 39 48 ff 48 8b 14 dd 60 68 2f 84 4d 89 e9 49 89 e8 44 89 f1 4c 89 e6 48 c7 c7 c0 5a 2f 84 e8 ce f9 12 ff <0f> 0b 5b ff 05 bb f7 9b 03 5d 41 5c 41 5d 41 5e c3 ff 05 ad f7 9b [ 1324.608552] RSP: 0000:ffff88800ff676d0 EFLAGS: 00010082 [ 1324.618466] RAX: 0000000000000000 RBX: 0000000000000003 RCX: 0000000000000000 [ 1324.632020] RDX: 1ffffffff0dde404 RSI: 0000000000000004 RDI: ffffed1001fececf [ 1324.645369] RBP: ffffffff8408fb00 R08: fffffbfff09eac51 R09: fffffbfff09eac50 [ 1324.658850] R10: ffffed1001fececf R11: 0000000000000000 R12: ffffffff842f5e40 [ 1324.672591] R13: ffffffff8118ec80 R14: 0000000000000000 R15: 0000000000000000 [ 1324.686031] FS: 0000000000000000(0000) GS:ffff888019800000(0000) knlGS:0000000000000000 [ 1324.701597] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1324.712639] CR2: 00007ffc4dc4ef88 CR3: 000000001430a003 CR4: 00000000000206b0 [ 1324.722429] Call Trace: [ 1324.723670] __debug_check_no_obj_freed+0x165/0x30d [ 1324.725792] kfree+0x116/0x1a1 [ 1324.726945] i2cdev_detach_adapter+0x8f/0xf3 [ 1324.728396] notifier_call_chain+0xae/0xf4 [ 1324.729700] __blocking_notifier_call_chain+0x78/0x90 [ 1324.732973] device_del+0x178/0x7f5 [ 1324.739909] ? __pm_runtime_disable+0x22e/0x256 [ 1324.748884] ? klist_children_put+0x39/0x39 [ 1324.757045] ? lockdep_init_map+0x216/0x5af [ 1324.765317] ? lockdep_init_map+0x216/0x5af [ 1324.773089] device_unregister+0x83/0x8c [ 1324.775258] i2c_del_adapter+0x489/0x501 [ 1324.777063] unittest_i2c_bus_remove+0x8c/0x91 [ 1324.778802] platform_drv_remove+0x6b/0x86 [ 1324.780244] really_probe+0x556/0xa6a [ 1324.781460] ? device_driver_attach+0x11c/0x11c [ 1324.782846] driver_probe_device+0x255/0x2ae [ 1324.788548] ? device_driver_attach+0x11c/0x11c [ 1324.797095] device_driver_attach+0xe1/0x11c [ 1324.805654] __driver_attach+0x212/0x21c [ 1324.813342] ? do_raw_spin_unlock+0x5f/0x1a9 [ 1324.821667] bus_for_each_dev+0x100/0x13f [ 1324.829346] ? bus_remove_file+0x5c/0x5c [ 1324.837060] bus_add_driver+0x2f8/0x48f [ 1324.844575] driver_register+0x263/0x2d7 [ 1324.852455] of_unittest_overlay+0xa24/0xdf3 [ 1324.860814] ? of_unittest_apply_overlay_check+0x185/0x185 [ 1324.871379] ? preempt_count_sub+0x168/0x176 [ 1324.879610] ? _raw_spin_unlock_irqrestore+0xb8/0xcc [ 1324.889234] of_unittest+0x1928/0x220d [ 1324.896690] ? of_unittest_overlay+0xdf3/0xdf3 [ 1324.905563] ? kfree+0x167/0x1a1 [ 1324.911954] ? kfree+0x167/0x1a1 [ 1324.918716] ? kobject_uevent_env+0xa76/0xb19 [ 1324.927239] ? kobject_uevent_env+0xa76/0xb19 [ 1324.935634] ? bus_add_driver+0x3ef/0x48f [ 1324.943481] ? of_unittest_overlay+0xdf3/0xdf3 [ 1324.951937] do_one_initcall+0x101/0x394 [ 1324.959678] ? start_kernel+0x79a/0x79a [ 1324.967038] ? lock_downgrade+0x519/0x558 [ 1324.974789] kernel_init_freeable+0x3e3/0x549 [ 1324.983279] ? rest_init+0x165/0x165 [ 1324.989951] kernel_init+0xc/0x108 [ 1324.996664] ? rest_init+0x165/0x165 [ 1325.003431] ret_from_fork+0x24/0x30 [ 1325.010400] ---[ end trace 58c9c5f1671602e0 ]--- [ 1325.045816] kobject: 'i2c-dev' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1325.059371] kobject: 'i2c-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1325.063368] kobject: 'i2c-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1325.429905] kobject: 'input2' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 1326.273766] kobject: 'test-unittest111' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1327.486526] kobject: 'test-unittest11' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1329.314442] _warn_unseeded_randomness: 6 callbacks suppressed [ 1329.314510] random: get_random_u32 called from cache_grow_begin+0x244/0x43f with crng_init=0 [ 1329.474562] i2c i2c-0: Added multiplexed i2c bus 1 [ 1329.499120] random: get_random_u32 called from kobject_put+0x8d/0x22d with crng_init=0 [ 1329.514579] kobject: '1-0020' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 1329.531762] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest11 [ 1329.552236] kobject: '(null)' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1329.569868] ------------[ cut here ]------------ [ 1329.578490] ODEBUG: free active (active state 0) object type: timer_list hint: delayed_work_timer_fn+0x0/0x6b [ 1329.596372] WARNING: CPU: 0 PID: 1 at lib/debugobjects.c:328 debug_print_object+0x169/0x181 [ 1329.614753] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G B W 5.2.0-rc1-00387-g47cdee29 #1 [ 1329.626605] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014 [ 1329.630068] RIP: 0010:debug_print_object+0x169/0x181 [ 1329.631751] Code: 3c 02 00 74 05 e8 f1 39 48 ff 48 8b 14 dd 60 68 2f 84 4d 89 e9 49 89 e8 44 89 f1 4c 89 e6 48 c7 c7 c0 5a 2f 84 e8 ce f9 12 ff <0f> 0b 5b ff 05 bb f7 9b 03 5d 41 5c 41 5d 41 5e c3 ff 05 ad f7 9b [ 1329.652450] RSP: 0000:ffff88800ff675f8 EFLAGS: 00010092 [ 1329.661652] RAX: 0000000000000000 RBX: 0000000000000003 RCX: 0000000000000000 [ 1329.669941] RDX: 1ffffffff0dde404 RSI: 0000000000000004 RDI: ffffed1001feceb4 [ 1329.672829] RBP: ffffffff8408fb00 R08: fffffbfff09eac51 R09: fffffbfff09eac50 [ 1329.675255] R10: ffffed1001feceb4 R11: 0000000000000000 R12: ffffffff842f5e40 [ 1329.677299] R13: ffffffff8118ec80 R14: 0000000000000000 R15: 0000000000000000 [ 1329.687450] FS: 0000000000000000(0000) GS:ffff888019800000(0000) knlGS:0000000000000000 [ 1329.701806] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 1329.711942] CR2: 00007ffc4dc4ef88 CR3: 000000001430a003 CR4: 00000000000206b0 [ 1329.724549] Call Trace: [ 1329.729054] __debug_check_no_obj_freed+0x165/0x30d [ 1329.737966] kfree+0x116/0x1a1 [ 1329.743737] i2cdev_detach_adapter+0x8f/0xf3 [ 1329.751778] notifier_call_chain+0xae/0xf4 [ 1329.759257] __blocking_notifier_call_chain+0x78/0x90 [ 1329.768304] device_del+0x178/0x7f5 [ 1329.774719] ? __pm_runtime_disable+0x22e/0x256 [ 1329.783044] ? klist_children_put+0x39/0x39 [ 1329.790885] ? lockdep_init_map+0x216/0x5af [ 1329.797357] ? lockdep_init_map+0x216/0x5af [ 1329.799710] device_unregister+0x83/0x8c [ 1329.801359] i2c_del_adapter+0x489/0x501 [ 1329.802795] i2c_mux_del_adapters+0x18f/0x1dc [ 1329.804373] ? i2c_mux_add_adapter+0xca3/0xca3 [ 1329.805808] ? unittest_i2c_mux_remove+0x90/0x90 [ 1329.813495] ? acpi_dev_pm_attach+0x43/0x136 [ 1329.821464] unittest_i2c_mux_remove+0x8b/0x90 [ 1329.829893] i2c_device_remove+0xc3/0x1b8 [ 1329.837384] really_probe+0x556/0xa6a [ 1329.843671] ? device_driver_attach+0x11c/0x11c [ 1329.850363] driver_probe_device+0x255/0x2ae [ 1329.852398] ? device_driver_attach+0x11c/0x11c [ 1329.854249] device_driver_attach+0xe1/0x11c [ 1329.855822] __driver_attach+0x212/0x21c [ 1329.857182] ? do_raw_spin_unlock+0x5f/0x1a9 [ 1329.858511] bus_for_each_dev+0x100/0x13f [ 1329.865749] ? bus_remove_file+0x5c/0x5c [ 1329.872595] bus_add_driver+0x2f8/0x48f [ 1329.879591] driver_register+0x263/0x2d7 [ 1329.886910] i2c_register_driver+0xd3/0x12c [ 1329.894857] of_unittest_overlay+0xb36/0xdf3 [ 1329.902275] ? of_unittest_apply_overlay_check+0x185/0x185 [ 1329.912517] ? preempt_count_sub+0x168/0x176 [ 1329.920362] ? _raw_spin_unlock_irqrestore+0xb8/0xcc [ 1329.928723] of_unittest+0x1928/0x220d [ 1329.934515] ? of_unittest_overlay+0xdf3/0xdf3 [ 1329.942424] ? kfree+0x167/0x1a1 [ 1329.947803] ? kfree+0x167/0x1a1 [ 1329.954128] ? kobject_uevent_env+0xa76/0xb19 [ 1329.962263] ? kobject_uevent_env+0xa76/0xb19 [ 1329.970429] ? bus_add_driver+0x3ef/0x48f [ 1329.973384] ? of_unittest_overlay+0xdf3/0xdf3 [ 1329.975442] do_one_initcall+0x101/0x394 [ 1329.977027] ? start_kernel+0x79a/0x79a [ 1329.978355] ? lock_downgrade+0x519/0x558 [ 1329.979525] kernel_init_freeable+0x3e3/0x549 [ 1329.980823] ? rest_init+0x165/0x165 [ 1329.987391] kernel_init+0xc/0x108 [ 1329.993871] ? rest_init+0x165/0x165 [ 1330.000068] ret_from_fork+0x24/0x30 [ 1330.006617] ---[ end trace 58c9c5f1671602e1 ]--- [ 1330.029282] kobject: 'i2c-dev' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1330.053778] kobject: 'i2c-1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 1330.074985] kobject: 'i2c-1' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 1330.550325] Writes: Total: 34055267 Max/Min: 0/0 Fail: 0 [ 1330.550651] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest11/test-unittest111 Elapsed time: 1320 kvm=( qemu-system-x86_64 -enable-kvm -cpu Haswell,+smep,+smap -kernel $kernel -initrd /osimage/yocto/yocto-trinity-x86_64.cgz -m 512 -smp 2 -device e1000,netdev=net0 -netdev user,id=net0 -boot order=nc -no-reboot -watchdog i6300esb -watchdog-action debug -rtc base=localtime -serial stdio -display none -monitor null ) append=( root=/dev/ram0 hung_task_panic=1 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_ramdisk=2 prompt_ramdisk=0 drbd.minor_count=8 systemd.log_level=err ignore_loglevel console=tty0 earlyprintk=ttyS0,115200 console=ttyS0,115200 vga=normal rw branch=linux-devel/fixup-47cdee29ef9d94e485eb08f962c74943023a5271 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-ne0-06030921+CONFIG_KASAN/gcc-6/47cdee29ef9d94e485eb08f962c74943023a5271/vmlinuz-5.2.0-rc1-00387-g47cdee29 drbd.minor_count=8 rcuperf.shutdown=0 ) "${kvm[@]}" -append "${append[*]}"