[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty (anders@compilator) (gcc version 7.3.1 20180425 [linaro-7.3-2018.05 revision d29120a424ecfbc167ef90065c0eeb7f91977701] (Linaro GCC 7.3-2018.05)) #67 SMP Mon Dec 3 15:44:31 CET 2018 [ 0.000000] Machine model: linux,dummy-virt [ 0.000000] earlycon: pl11 at MMIO 0x0000000009000000 (options '') [ 0.000000] printk: bootconsole [pl11] enabled [ 0.000000] efi: Getting EFI parameters from FDT: [ 0.000000] efi: UEFI not found. [ 0.000000] cma: Reserved 16 MiB at 0x00000000bf000000 [ 0.000000] kmemleak: Kernel memory leak detector disabled [ 0.000000] NUMA: No NUMA configuration found [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] NUMA: NODE_DATA [mem 0xbebf6600-0xbebf7fff] [ 0.000000] Zone ranges: [ 0.000000] DMA32 [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv0.2 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] random: get_random_bytes called from start_kernel+0xe4/0x7d4 with crng_init=0 [ 0.000000] percpu: Embedded 490 pages/cpu @(____ptrval____) s1969240 r8192 d29608 u2007040 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: enabling workaround for ARM erratum 843419 [ 0.000000] CPU features: enabling workaround for ARM erratum 845719 [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 516096 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: root=/dev/root rootfstype=9p rootflags=trans=virtio console=ttyAMA0,38400n8 earlycon=pl011,0x9000000 initcall_debug [ 0.000000] Memory: 971224K/2097152K available (24668K kernel code, 16852K rwdata, 4884K rodata, 6144K init, 23473K bss, 116304K reserved, 16384K cma-reserved) [ 0.000000] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 0.000000] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] ODEBUG: selftest passed [ 0.000000] ftrace: allocating 42031 entries in 165 pages [ 0.000000] Running RCU self tests [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] rcu: RCU lockdep checking is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] rcu: RCU debug extended QS entry/exit. [ 0.000000] Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143] [ 0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns [ 0.000271] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns [ 0.020781] Console: colour dummy device 80x25 [ 0.027374] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.028021] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.028558] ... MAX_LOCK_DEPTH: 48 [ 0.029095] ... MAX_LOCKDEP_KEYS: 8191 [ 0.030164] ... CLASSHASH_SIZE: 4096 [ 0.030666] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.031216] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.031752] ... CHAINHASH_SIZE: 32768 [ 0.032314] memory used by lock dependency info: 7775 kB [ 0.032864] per task-struct memory footprint: 2688 bytes [ 0.033402] ------------------------ [ 0.034486] | Locking API testsuite: [ 0.035001] ---------------------------------------------------------------------------- [ 0.035678] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.036334] -------------------------------------------------------------------------- [ 0.037309] A-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.051500] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.065281] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.079975] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.094797] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.111436] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.127723] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.144565] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.155970] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.167315] -------------------------------------------------------------------------- [ 0.168004] recursive read-lock: | ok | | ok | [ 0.172089] recursive read-lock #2: | ok | | ok | [ 0.176262] mixed read-write-lock: | ok | | ok | [ 0.179909] mixed write-read-lock: | ok | | ok | [ 0.184123] mixed read-lock/lock-write ABBA: |FAILED| | ok | [ 0.188244] mixed read-lock/lock-read ABBA: | ok | | ok | [ 0.192765] mixed write-lock/lock-write ABBA: | ok | | ok | [ 0.197339] -------------------------------------------------------------------------- [ 0.198905] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.204793] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.210726] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.216864] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.222833] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.228777] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.235163] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.241063] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.246974] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.253270] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.259158] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.266039] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.272187] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.278968] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.285246] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.291980] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.298153] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.304290] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.311006] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.316918] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.323377] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.329487] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.335590] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.342319] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.348730] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.355414] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.361718] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.368404] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.374715] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.381509] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.387863] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.394646] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.401053] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.407667] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.414001] hard-irq lock-inversion/123: ok | ok | ok | [ 0.420737] soft-irq lock-inversion/123: ok | ok | ok | [ 0.427013] hard-irq lock-inversion/132: ok | ok | ok | [ 0.433707] soft-irq lock-inversion/132: ok | ok | ok | [ 0.439938] hard-irq lock-inversion/213: ok | ok | ok | [ 0.446615] soft-irq lock-inversion/213: ok | ok | ok | [ 0.452929] hard-irq lock-inversion/231: ok | ok | ok | [ 0.459077] soft-irq lock-inversion/231: ok | ok | ok | [ 0.465899] hard-irq lock-inversion/312: ok | ok | ok | [ 0.472095] soft-irq lock-inversion/312: ok | ok | ok | [ 0.479036] hard-irq lock-inversion/321: ok | ok | ok | [ 0.485297] soft-irq lock-inversion/321: ok | ok | ok | [ 0.492081] hard-irq read-recursion/123: ok | [ 0.494956] soft-irq read-recursion/123: ok | [ 0.497454] hard-irq read-recursion/132: ok | [ 0.500402] soft-irq read-recursion/132: ok | [ 0.502820] hard-irq read-recursion/213: ok | [ 0.505724] soft-irq read-recursion/213: ok | [ 0.508171] hard-irq read-recursion/231: ok | [ 0.511122] soft-irq read-recursion/231: ok | [ 0.513607] hard-irq read-recursion/312: ok | [ 0.516515] soft-irq read-recursion/312: ok | [ 0.518955] hard-irq read-recursion/321: ok | [ 0.521885] soft-irq read-recursion/321: ok | [ 0.524383] -------------------------------------------------------------------------- [ 0.525045] | Wound/wait tests | [ 0.526021] --------------------- [ 0.526555] ww api failures: ok | ok | ok | [ 0.535128] ww contexts mixing: ok | ok | [ 0.538757] finishing ww context: ok | ok | ok | ok | [ 0.546695] locking mismatches: ok | ok | ok | [ 0.552513] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.573162] spinlock nest unlocked: ok | [ 0.575225] ----------------------------------------------------- [ 0.575775] |block | try |context| [ 0.576904] ----------------------------------------------------- [ 0.577484] context: ok | ok | ok | [ 0.583595] try: ok | ok | ok | [ 0.589117] block: ok | ok | ok | [ 0.594822] spinlock: ok | ok | ok | [ 0.601583] ------------------------------------------------------- [ 0.602214] Good, all 261 testcases passed! | [ 0.602722] --------------------------------- [ 0.610154] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000) [ 0.611121] pid_max: default: 32768 minimum: 301 [ 0.627844] LSM: Security Framework initializing [ 0.628885] Yama: becoming mindful. [ 0.632858] LoadPin: ready to pin (currently enforcing) [ 0.634024] SELinux: Initializing. [ 0.646216] *** VALIDATE SELinux *** [ 0.647258] AppArmor: AppArmor disabled by boot time parameter [ 0.699603] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.719930] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.724609] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.726716] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.784567] *** VALIDATE proc *** [ 0.815654] *** VALIDATE cgroup1 *** [ 0.816796] *** VALIDATE cgroup2 *** [ 0.923403] ASID allocator initialised with 32768 entries [ 0.939772] rcu: Hierarchical SRCU implementation. [ 1.069445] EFI services will not be available. [ 1.113257] smp: Bringing up secondary CPUs ... [ 1.113977] smp: Brought up 1 node, 1 CPU [ 1.114559] SMP: Total of 1 processors activated. [ 1.115305] CPU features: detected: 32-bit EL0 Support [ 1.116599] CPU features: detected: CRC32 instructions [ 1.479638] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching [ 1.480697] CPU: All CPU(s) started at EL1 [ 1.481975] alternatives: patching kernel code [ 1.483911] _warn_unseeded_randomness: 98 callbacks suppressed [ 1.484377] random: get_random_u64 called from compute_layout+0x138/0x1b8 with crng_init=0 [ 1.541339] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 5.852453] node 0 initialised, 248310 pages in 4ms [ 5.865364] ================================================================================ [ 5.866185] UBSAN: Undefined behaviour in ../kernel/exit.c:735:2 [ 5.866722] member access within misaligned address ffffff80081b97d8 for type 'struct task_struct' [ 5.867196] which requires 64 byte alignment [ 5.867984] CPU: 0 PID: 15 Comm: pgdatinit0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 5.868509] Hardware name: linux,dummy-virt (DT) [ 5.869044] Call trace: [ 5.869537] dump_backtrace+0x0/0x308 [ 5.870076] show_stack+0x28/0x38 [ 5.870507] __dump_stack+0x24/0x2c [ 5.870919] dump_stack+0xf8/0x16c [ 5.871375] ubsan_epilogue+0x18/0x50 [ 5.871846] handle_misaligned_access+0x94/0xc8 [ 5.872328] ubsan_type_mismatch_common+0x60/0x90 [ 5.872827] __ubsan_handle_type_mismatch+0x50/0x74 [ 5.873294] exit_notify+0x568/0x5d0 [ 5.873740] do_exit+0xabc/0xf60 [ 5.874235] __kthread_init_worker+0x0/0x150 [ 5.874716] ret_from_fork+0x10/0x18 [ 5.875170] ================================================================================ [ 5.877193] pgdatinit0 (15) used greatest stack depth: 12720 bytes left [ 5.891711] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 5.999572] devtmpfs: initialized [ 6.335679] gcov: version magic: 0x4137332a [ 6.368206] Registered cp15_barrier emulation handler [ 6.369829] Registered setend emulation handler [ 6.374694] workqueue: round-robin CPU selection forced, expect performance impact [ 17.047782] DMA-API: preallocated 65536 debug entries [ 17.048397] DMA-API: debugging enabled by kernel config [ 17.050732] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 17.053899] futex hash table entries: 256 (order: 3, 32768 bytes) [ 17.062053] Running postponed tracer tests: [ 17.066829] Testing tracer function: [ 17.067997] ================================================================================ [ 17.068938] UBSAN: Undefined behaviour in ../kernel/sched/fair.c:7432:2 [ 17.069438] member access within misaligned address ffffffc07ebe4f68 for type 'struct cfs_rq' [ 17.069882] which requires 64 byte alignment [ 17.070366] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 17.070913] Hardware name: linux,dummy-virt (DT) [ 17.071269] Call trace: [ 17.071667] dump_backtrace+0x0/0x308 [ 17.072097] show_stack+0x28/0x38 [ 17.072562] __dump_stack+0x24/0x2c [ 17.073013] dump_stack+0xf8/0x16c [ 17.073456] ubsan_epilogue+0x18/0x50 [ 17.073969] handle_misaligned_access+0x94/0xc8 [ 17.074490] ubsan_type_mismatch_common+0x60/0x90 [ 17.074983] __ubsan_handle_type_mismatch+0x50/0x74 [ 17.075526] update_blocked_averages+0x24a8/0x2928 [ 17.076044] idle_balance+0x5c8/0xd68 [ 17.076516] pick_next_task_fair+0x760/0x7b8 [ 17.076946] __schedule+0x74c/0x15b8 [ 17.077408] schedule+0x154/0x210 [ 17.077911] schedule_timeout+0xe88/0xef8 [ 17.078407] schedule_timeout_uninterruptible+0x7c/0x90 [ 17.078914] msleep+0x3c/0x58 [ 17.079383] trace_selftest_startup_function+0x140/0x4dc [ 17.079891] run_tracer_selftest+0x300/0x4a4 [ 17.080330] init_trace_selftests+0x29c/0x8b4 [ 17.080763] do_one_initcall+0x4c8/0xa50 [ 17.081254] do_initcall_level+0xbcc/0xca4 [ 17.081731] do_initcalls+0x60/0xa4 [ 17.082171] do_basic_setup+0x44/0x70 [ 17.082624] kernel_init_freeable+0x2d8/0x420 [ 17.083043] kernel_init+0x28/0x140 [ 17.083558] ret_from_fork+0x10/0x18 [ 17.083989] ================================================================================ [ 17.124442] ftrace_replace_code: 1 [ 27.662549] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 27.879333] ftrace_replace_code: 1 [ 37.412122] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 37.417892] PASSED [ 37.418430] Testing dynamic ftrace: [ 39.424298] ftrace_replace_code: 1 [ 39.451238] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 39.700556] PASSED [ 39.701332] Testing dynamic ftrace ops #1: [ 47.691565] ftrace_replace_code: 1 [ 47.720112] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 47.725776] (1 0 1 0 0) [ 47.725980] (1 1 2 0 0) [ 47.745738] ftrace_replace_code: 1 [ 61.164413] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 61.167894] (2 1 3 0 974891) [ 61.168160] (2 2 4 0 974906) [ 61.190554] ftrace_replace_code: 1 [ 71.863781] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 71.883989] ftrace_replace_code: 1 [ 71.908214] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 71.914523] ftrace_replace_code: 1 [ 71.939051] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 71.945827] PASSED [ 71.946328] Testing dynamic ftrace ops #2: [ 79.945116] ftrace_replace_code: 1 [ 79.974040] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 79.979231] ftrace_replace_code: 1 [ 80.012610] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 80.041157] ftrace_replace_code: 1 [ 92.835683] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 92.837565] (1 0 1 963050 0) [ 92.837791] (1 1 2 963065 0) [ 92.862688] (2 1 3 1 1085) [ 92.863695] (2 2 4 117 1201) [ 92.925742] ftrace_replace_code: 1 [ 102.455255] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 102.459195] PASSED [ 102.459688] Testing ftrace recursion: [ 104.456924] ftrace_replace_code: 1 [ 104.483029] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 104.488493] ftrace_replace_code: 1 [ 104.513549] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 104.516534] PASSED [ 104.517061] Testing ftrace recursion safe: [ 106.512963] ftrace_replace_code: 1 [ 106.539472] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 106.545009] ftrace_replace_code: 1 [ 106.569716] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 106.573382] PASSED [ 106.573945] Testing ftrace regs(no arch support): [ 108.569947] ftrace_replace_code: 1 [ 108.596205] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 108.601737] ftrace_replace_code: 1 [ 108.626466] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 108.630311] PASSED [ 108.631348] Testing tracer nop: PASSED [ 108.634433] Testing tracer irqsoff: [ 108.659372] ftrace_replace_code: 1 [ 119.502019] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 119.533074] ftrace_replace_code: 1 [ 129.121625] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 129.125882] PASSED [ 129.128337] Testing tracer wakeup: [ 129.171427] ftrace_replace_code: 1 [ 139.852946] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 139.891615] ftrace_replace_code: 1 [ 149.500072] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 149.511797] PASSED [ 149.513887] Testing tracer wakeup_rt: [ 149.553569] ftrace_replace_code: 1 [ 160.204306] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 160.235522] ftrace_replace_code: 1 [ 169.805992] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 169.816860] PASSED [ 169.817894] Testing tracer wakeup_dl: [ 169.859282] ftrace_replace_code: 1 [ 180.515527] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 180.559811] ftrace_replace_code: 1 [ 180.794508] sched: DL replenish lagged too much [ 190.170655] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 190.182339] PASSED [ 190.185238] Testing tracer function_graph: [ 190.223152] ftrace_replace_code: 1 [ 200.732299] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 201.190866] ftrace_replace_code: 1 [ 212.774339] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 212.779344] PASSED [ 212.995070] _warn_unseeded_randomness: 7 callbacks suppressed [ 212.995354] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 212.996912] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 213.000243] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 213.027036] prandom: seed boundary self test passed [ 213.074864] prandom: 100 self tests passed [ 213.083787] pinctrl core: initialized pinctrl subsystem [ 213.210008] ================================================================================ [ 213.210764] UBSAN: Undefined behaviour in ../drivers/base/devres.c:505:2 [ 213.211280] member access within misaligned address ffffff800814b8d8 for type 'struct devres' [ 213.211796] which requires 128 byte alignment [ 213.212337] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 213.212919] Hardware name: linux,dummy-virt (DT) [ 213.213373] Call trace: [ 213.213829] dump_backtrace+0x0/0x308 [ 213.214291] show_stack+0x28/0x38 [ 213.214724] __dump_stack+0x24/0x2c [ 213.215217] dump_stack+0xf8/0x16c [ 213.215710] ubsan_epilogue+0x18/0x50 [ 213.216245] handle_misaligned_access+0x94/0xc8 [ 213.216728] ubsan_type_mismatch_common+0x60/0x90 [ 213.217193] __ubsan_handle_type_mismatch+0x50/0x74 [ 213.217696] release_nodes+0x94/0x180 [ 213.218162] devres_release_all+0xa0/0xc0 [ 213.218619] really_probe+0x69c/0xd48 [ 213.219094] really_probe_debug+0x3c/0x128 [ 213.219561] driver_probe_device+0x1f8/0x2a0 [ 213.220012] __driver_attach+0x250/0x340 [ 213.220519] bus_for_each_dev+0x110/0x180 [ 213.220987] driver_attach+0x50/0x60 [ 213.221419] bus_add_driver+0x308/0x4f0 [ 213.221865] driver_register+0x2a0/0x330 [ 213.222332] __platform_driver_register+0xcc/0xe0 [ 213.222818] regulator_dummy_init+0x100/0x174 [ 213.223286] regulator_init+0xf0/0x128 [ 213.223735] do_one_initcall+0x4c8/0xa50 [ 213.224238] do_initcall_level+0xbcc/0xca4 [ 213.224730] do_initcalls+0x60/0xa4 [ 213.225192] do_basic_setup+0x44/0x70 [ 213.225693] kernel_init_freeable+0x2d8/0x420 [ 213.226181] kernel_init+0x28/0x140 [ 213.226633] ret_from_fork+0x10/0x18 [ 213.227018] ================================================================================ [ 213.247106] regulator-dummy: Failed to create debugfs directory [ 213.259727] [ 213.260221] ************************************************************* [ 213.260843] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 213.261451] ** ** [ 213.262059] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 213.263269] ** ** [ 213.263878] ** This means that this kernel is built to expose internal ** [ 213.264521] ** IOMMU data structures, which may compromise security on ** [ 213.265187] ** your system. ** [ 213.265783] ** ** [ 213.266340] ** If you see this message and you are not debugging the ** [ 213.266895] ** kernel, report this immediately to your vendor! ** [ 213.268033] ** ** [ 213.268592] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 213.269147] ************************************************************* [ 213.313659] DMI not present or invalid. [ 213.388393] NET: Registered protocol family 16 [ 213.427284] audit: initializing netlink subsys (disabled) [ 213.630690] cpuidle: using governor ladder [ 213.632711] cpuidle: using governor menu [ 213.663889] vdso: 2 pages (1 code @ (____ptrval____), 1 data @ (____ptrval____)) [ 213.666540] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 213.672719] audit: type=2000 audit(182.508:1): state=initialized audit_enabled=0 res=1 [ 213.884047] DMA: preallocated 256 KiB pool for atomic allocations [ 214.007765] Serial: AMBA PL011 UART driver [ 215.116313] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 39, base_baud = 0) is a PL011 rev1 [ 215.120545] printk: console [ttyAMA0] enabled [ 215.120545] printk: console [ttyAMA0] enabled [ 215.121878] printk: bootconsole [pl11] disabled [ 215.121878] printk: bootconsole [pl11] disabled [ 215.271425] _warn_unseeded_randomness: 42 callbacks suppressed [ 215.271691] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 215.274251] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 216.016252] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 216.097698] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 216.295320] kobject: 'renesas,r9a06g032-sysctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 216.310418] kobject: 'renesas-cpg-mssr' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 216.388486] arm-v7s io-pgtable: self test ok [ 216.391131] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 32 [ 216.401212] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 36 [ 216.408364] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 40 [ 216.415855] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 42 [ 216.425327] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 44 [ 216.433227] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 48 [ 216.442029] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 32 [ 216.453956] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 36 [ 216.467569] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 40 [ 216.481412] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 42 [ 216.495883] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 44 [ 216.509803] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 48 [ 216.526876] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 32 [ 216.562881] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 36 [ 216.598138] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 40 [ 216.635825] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 42 [ 216.677617] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 44 [ 216.720715] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 48 [ 216.763410] arm-lpae io-pgtable: selftest: completed with 18 PASS 0 FAIL [ 216.807297] vgaarb: loaded [ 216.831943] _warn_unseeded_randomness: 36 callbacks suppressed [ 216.832216] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 216.833971] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 216.873198] pps_core: LinuxPPS API ver. 1 registered [ 216.873964] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 216.879388] PTP clock support registered [ 216.891485] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 216.892533] kobject: 'brcmstb-reboot' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 217.120688] NetLabel: Initializing [ 217.122006] NetLabel: domain hash size = 128 [ 217.122690] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 217.135392] NetLabel: unlabeled traffic allowed by default [ 217.163820] clocksource: Switched to clocksource arch_sys_counter [ 226.607245] _warn_unseeded_randomness: 4 callbacks suppressed [ 226.607517] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 226.609626] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 226.614000] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 226.636094] VFS: Disk quotas dquot_6.6.0 [ 226.642181] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 226.680554] *** VALIDATE hugetlbfs *** [ 227.900249] _warn_unseeded_randomness: 7 callbacks suppressed [ 227.900516] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 227.902302] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 227.905389] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 227.913074] NET: Registered protocol family 2 [ 227.971752] tcp_listen_portaddr_hash hash table entries: 1024 (order: 4, 90112 bytes) [ 227.978008] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 228.008464] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes) [ 228.021210] TCP: Hash tables configured (established 16384 bind 16384) [ 228.036896] UDP hash table entries: 1024 (order: 5, 196608 bytes) [ 228.044534] UDP-Lite hash table entries: 1024 (order: 5, 196608 bytes) [ 228.070104] NET: Registered protocol family 1 [ 228.076439] NET: Registered protocol family 44 [ 228.197032] hw perfevents: enabled with armv8_pmuv3 PMU driver, 1 counters available [ 228.212104] kvm [1]: HYP mode not available [ 228.623304] Kprobe smoke test: started [ 229.879947] Kprobe smoke test: passed successfully [ 229.974094] Initialise system trusted keyrings [ 229.976981] _warn_unseeded_randomness: 50 callbacks suppressed [ 229.977244] random: get_random_bytes called from key_alloc+0x500/0xa48 with crng_init=0 [ 229.988323] Key type blacklist registered [ 229.996433] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 230.015446] workingset: timestamp_bits=44 max_order=19 bucket_order=0 [ 232.819631] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 232.821132] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 232.853605] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 233.134069] 9p: Installing v9fs 9p2000 file system support [ 233.291340] Allocating IMA blacklist keyring. [ 233.309281] ================================================================================ [ 233.310445] UBSAN: Undefined behaviour in ../crypto/algapi.c:363:2 [ 233.311269] member access within misaligned address ffffff800d213e38 for type 'struct crypto_alg' [ 233.312140] which requires 128 byte alignment [ 233.312838] CPU: 0 PID: 37 Comm: cryptomgr_test Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 233.314027] Hardware name: linux,dummy-virt (DT) [ 233.314690] Call trace: [ 233.315324] dump_backtrace+0x0/0x308 [ 233.316124] show_stack+0x28/0x38 [ 233.316797] __dump_stack+0x24/0x2c [ 233.317437] dump_stack+0xf8/0x16c [ 233.318054] ubsan_epilogue+0x18/0x50 [ 233.318742] handle_misaligned_access+0x94/0xc8 [ 233.319438] ubsan_type_mismatch_common+0x60/0x90 [ 233.320169] __ubsan_handle_type_mismatch+0x50/0x74 [ 233.320901] crypto_remove_final+0x78/0x238 [ 233.321557] crypto_alg_tested+0x450/0x488 [ 233.322355] cryptomgr_test+0x44/0x58 [ 233.323146] kthread+0x260/0x278 [ 233.323857] ret_from_fork+0x10/0x18 [ 233.324456] ================================================================================ [ 233.330094] cryptomgr_test (37) used greatest stack depth: 11712 bytes left [ 233.368390] ================================================================================ [ 233.369389] UBSAN: Undefined behaviour in ../kernel/exit.c:735:2 [ 233.370169] member access within misaligned address ffffff800d2117d8 for type 'struct task_struct' [ 233.371050] which requires 64 byte alignment [ 233.371815] CPU: 0 PID: 38 Comm: kworker/u2:1 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 233.372812] Hardware name: linux,dummy-virt (DT) [ 233.373397] Call trace: [ 233.373985] dump_backtrace+0x0/0x308 [ 233.374671] show_stack+0x28/0x38 [ 233.375354] __dump_stack+0x24/0x2c [ 233.376015] dump_stack+0xf8/0x16c [ 233.376726] ubsan_epilogue+0x18/0x50 [ 233.377420] handle_misaligned_access+0x94/0xc8 [ 233.378231] ubsan_type_mismatch_common+0x60/0x90 [ 233.378953] __ubsan_handle_type_mismatch+0x50/0x74 [ 233.379653] exit_notify+0x448/0x5d0 [ 233.380358] do_exit+0xabc/0xf60 [ 233.380988] call_usermodehelper_exec_async+0x348/0x3b0 [ 233.381706] ret_from_fork+0x10/0x18 [ 233.382250] ================================================================================ [ 233.384599] kworker/u2:1 (38) used greatest stack depth: 11408 bytes left [ 235.198134] Key type asymmetric registered [ 235.201183] Asymmetric key parser 'x509' registered [ 235.210989] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) [ 235.228577] _warn_unseeded_randomness: 28 callbacks suppressed [ 235.228852] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 235.231521] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 235.280041] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 235.512632] kobject: 'brcm-gisb-arb' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 235.654911] kobject: 'armada-37xx-pinctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 235.929247] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 235.932755] ================================================================================ [ 235.933743] UBSAN: Undefined behaviour in ../drivers/base/devres.c:505:2 [ 235.934532] member access within misaligned address ffffff800814b928 for type 'struct devres' [ 235.935306] which requires 128 byte alignment [ 235.935981] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 235.936775] Hardware name: linux,dummy-virt (DT) [ 235.937295] Call trace: [ 235.937840] dump_backtrace+0x0/0x308 [ 235.938425] show_stack+0x28/0x38 [ 235.939058] __dump_stack+0x24/0x2c [ 235.939668] dump_stack+0xf8/0x16c [ 235.940345] ubsan_epilogue+0x18/0x50 [ 235.940980] handle_misaligned_access+0x94/0xc8 [ 235.941648] ubsan_type_mismatch_common+0x60/0x90 [ 235.942338] __ubsan_handle_type_mismatch+0x50/0x74 [ 235.943025] release_nodes+0x11c/0x180 [ 235.943661] devres_release_all+0xa0/0xc0 [ 235.944295] really_probe+0x69c/0xd48 [ 235.944921] really_probe_debug+0x3c/0x128 [ 235.945575] driver_probe_device+0x1f8/0x2a0 [ 235.946317] __driver_attach+0x250/0x340 [ 235.947001] bus_for_each_dev+0x110/0x180 [ 235.947638] driver_attach+0x50/0x60 [ 235.948275] bus_add_driver+0x308/0x4f0 [ 235.948913] driver_register+0x2a0/0x330 [ 235.949573] amba_driver_register+0x120/0x130 [ 235.950253] pl061_gpio_init+0x2c/0x5c [ 235.950886] do_one_initcall+0x4c8/0xa50 [ 235.951558] do_initcall_level+0xbcc/0xca4 [ 235.952236] do_initcalls+0x60/0xa4 [ 235.952869] do_basic_setup+0x44/0x70 [ 235.953527] kernel_init_freeable+0x2d8/0x420 [ 235.954186] kernel_init+0x28/0x140 [ 235.954811] ret_from_fork+0x10/0x18 [ 235.955375] ================================================================================ [ 235.964049] pl061_gpio 9030000.pl061: Unbalanced pm_runtime_enable! [ 236.000000] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 236.039225] kobject: 'stmpe-pwm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 236.077971] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 236.191847] pci-host-generic 3f000000.pcie: host bridge /pcie@10000000 ranges: [ 236.195840] pci-host-generic 3f000000.pcie: IO 0x3eff0000..0x3effffff -> 0x00000000 [ 236.200083] pci-host-generic 3f000000.pcie: MEM 0x10000000..0x3efeffff -> 0x10000000 [ 236.203099] pci-host-generic 3f000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 [ 236.209178] pci-host-generic 3f000000.pcie: ECAM at [mem 0x3f000000-0x3fffffff] for [bus 00-0f] [ 236.233900] pci-host-generic 3f000000.pcie: PCI host bridge to bus 0000:00 [ 236.237266] pci_bus 0000:00: root bus resource [bus 00-0f] [ 236.239732] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 236.240991] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] [ 236.243237] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] [ 236.249544] pci 0000:00:00.0: calling quirk_mmio_always_on+0x0/0x50 @ 1 [ 236.251704] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x50 took 137 usecs [ 236.384635] pci 0000:00:01.0: BAR 6: assigned [mem 0x10000000-0x1003ffff pref] [ 236.386156] pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] [ 236.388756] pci 0000:00:02.0: BAR 4: assigned [mem 0x8000004000-0x8000007fff 64bit pref] [ 236.391241] pci 0000:00:03.0: BAR 4: assigned [mem 0x8000008000-0x800000bfff 64bit pref] [ 236.392812] pci 0000:00:01.0: BAR 1: assigned [mem 0x10040000-0x10040fff] [ 236.394003] pci 0000:00:03.0: BAR 1: assigned [mem 0x10041000-0x10041fff] [ 236.395907] pci 0000:00:03.0: BAR 0: assigned [io 0x1000-0x103f] [ 236.397090] pci 0000:00:01.0: BAR 0: assigned [io 0x1040-0x105f] [ 236.398228] pci 0000:00:02.0: BAR 0: assigned [io 0x1060-0x107f] [ 236.403292] pci 0000:00:00.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 236.404669] pci 0000:00:00.0: tegra_pcie_relax_enable+0x0/0x40 took 219 usecs [ 236.408682] pci 0000:00:01.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 236.409956] pci 0000:00:01.0: tegra_pcie_relax_enable+0x0/0x40 took 88 usecs [ 236.412717] pci 0000:00:02.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 236.414297] pci 0000:00:02.0: tegra_pcie_relax_enable+0x0/0x40 took 114 usecs [ 236.417145] pci 0000:00:03.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 236.419352] pci 0000:00:03.0: tegra_pcie_relax_enable+0x0/0x40 took 88 usecs [ 236.493701] _warn_unseeded_randomness: 15 callbacks suppressed [ 236.493942] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 236.496490] kobject: 'layerscape-pcie' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 236.498234] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 237.293421] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) [ 237.340475] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 237.341598] kobject: 'virtio0' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 237.392026] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) [ 237.428680] kobject: 'virtio1' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 237.479242] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) [ 237.513607] _warn_unseeded_randomness: 3 callbacks suppressed [ 237.513875] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 237.516441] kobject: 'virtio2' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 237.533910] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 245.136868] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 245.354239] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 245.356282] kobject: 'ttyS0' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 245.359674] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 245.360933] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 245.457589] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 245.459478] kobject: 'ttyS1' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 245.461598] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 245.559665] kobject: 'ttyS2' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 245.561727] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 245.657771] kobject: 'ttyS3' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 245.660632] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 245.797821] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 245.816311] KGDB: Registered I/O driver kgdbts [ 245.817601] kgdbts:RUN plant and detach test Entering kdb (current=0xffffffc03f5c8040, pid 1) on processor 0 due to Keyboard Entry [0]kdb> [ 245.829964] kgdbts:RUN sw breakpoint test [ 245.848822] kgdbts:RUN bad memory access test [ 245.852849] kgdbts:RUN singlestep test 1000 iterations [ 245.887657] kgdbts:RUN singlestep [0/1000] [ 249.057663] kgdbts:RUN singlestep [100/1000] [ 252.212135] kgdbts:RUN singlestep [200/1000] [ 255.367652] kgdbts:RUN singlestep [300/1000] [ 258.529669] kgdbts:RUN singlestep [400/1000] [ 261.687625] kgdbts:RUN singlestep [500/1000] [ 264.848625] kgdbts:RUN singlestep [600/1000] [ 268.006898] kgdbts:RUN singlestep [700/1000] [ 271.167841] kgdbts:RUN singlestep [800/1000] [ 274.328691] kgdbts:RUN singlestep [900/1000] [ 277.463963] kgdbts:RUN do_fork for 100 breakpoints [ 277.472376] _warn_unseeded_randomness: 5 callbacks suppressed [ 277.472673] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 277.660289] ================================================================================ [ 277.661484] UBSAN: Undefined behaviour in ../net/core/dev.c:7983:2 [ 277.662053] member access within misaligned address ffffff800814b820 for type 'struct net_device' [ 277.662667] which requires 64 byte alignment [ 277.663248] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 277.663958] Hardware name: linux,dummy-virt (DT) [ 277.664414] Call trace: [ 277.664906] dump_backtrace+0x0/0x308 [ 277.665408] show_stack+0x28/0x38 [ 277.665911] __dump_stack+0x24/0x2c [ 277.666414] dump_stack+0xf8/0x16c [ 277.666916] ubsan_epilogue+0x18/0x50 [ 277.667435] handle_misaligned_access+0x94/0xc8 [ 277.668012] ubsan_type_mismatch_common+0x60/0x90 [ 277.668573] __ubsan_handle_type_mismatch+0x50/0x74 [ 277.669153] rollback_registered_many+0x304/0x900 [ 277.669718] rollback_registered+0xbc/0x158 [ 277.670280] unregister_netdevice_queue+0x234/0x280 [ 277.670847] unregister_netdev+0x2c/0x40 [ 277.671375] virtnet_remove+0x70/0xc8 [ 277.671935] virtio_dev_remove+0x74/0xf0 [ 277.672447] really_probe+0x640/0xd48 [ 277.672955] really_probe_debug+0x3c/0x128 [ 277.673478] driver_probe_device+0x1f8/0x2a0 [ 277.674000] __driver_attach+0x250/0x340 [ 277.674543] bus_for_each_dev+0x110/0x180 [ 277.675054] driver_attach+0x50/0x60 [ 277.675551] bus_add_driver+0x308/0x4f0 [ 277.676088] driver_register+0x2a0/0x330 [ 277.676635] register_virtio_driver+0xa4/0xb8 [ 277.677175] virtio_net_driver_init+0x100/0x17c [ 277.677712] do_one_initcall+0x4c8/0xa50 [ 277.678251] do_initcall_level+0xbcc/0xca4 [ 277.678785] do_initcalls+0x60/0xa4 [ 277.679303] do_basic_setup+0x44/0x70 [ 277.679859] kernel_init_freeable+0x2d8/0x420 [ 277.680386] kernel_init+0x28/0x140 [ 277.680894] ret_from_fork+0x10/0x18 [ 277.681340] ================================================================================ [ 277.683210] ================================================================================ [ 277.683867] UBSAN: Undefined behaviour in ../net/core/dev.c:1495:2 [ 277.684427] member access within misaligned address ffffff800814b7b0 for type 'struct net_device' [ 277.685023] which requires 64 byte alignment [ 277.685591] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 277.686279] Hardware name: linux,dummy-virt (DT) [ 277.686730] Call trace: [ 277.687197] dump_backtrace+0x0/0x308 [ 277.687699] show_stack+0x28/0x38 [ 277.688208] __dump_stack+0x24/0x2c [ 277.688711] dump_stack+0xf8/0x16c [ 277.689211] ubsan_epilogue+0x18/0x50 [ 277.689729] handle_misaligned_access+0x94/0xc8 [ 277.690278] ubsan_type_mismatch_common+0x60/0x90 [ 277.690840] __ubsan_handle_type_mismatch+0x50/0x74 [ 277.691403] dev_close_many+0x1a4/0x388 [ 277.691953] rollback_registered_many+0x428/0x900 [ 277.692520] rollback_registered+0xbc/0x158 [ 277.693077] unregister_netdevice_queue+0x234/0x280 [ 277.693643] unregister_netdev+0x2c/0x40 [ 277.694166] virtnet_remove+0x70/0xc8 [ 277.694699] virtio_dev_remove+0x74/0xf0 [ 277.695207] really_probe+0x640/0xd48 [ 277.695714] really_probe_debug+0x3c/0x128 [ 277.696242] driver_probe_device+0x1f8/0x2a0 [ 277.696764] __driver_attach+0x250/0x340 [ 277.697302] bus_for_each_dev+0x110/0x180 [ 277.697811] driver_attach+0x50/0x60 [ 277.698309] bus_add_driver+0x308/0x4f0 [ 277.698822] driver_register+0x2a0/0x330 [ 277.699368] register_virtio_driver+0xa4/0xb8 [ 277.699912] virtio_net_driver_init+0x100/0x17c [ 277.700454] do_one_initcall+0x4c8/0xa50 [ 277.700995] do_initcall_level+0xbcc/0xca4 [ 277.701530] do_initcalls+0x60/0xa4 [ 277.702048] do_basic_setup+0x44/0x70 [ 277.702582] kernel_init_freeable+0x2d8/0x420 [ 277.703109] kernel_init+0x28/0x140 [ 277.703615] ret_from_fork+0x10/0x18 [ 277.704082] ================================================================================ [ 277.705597] ================================================================================ [ 277.706259] UBSAN: Undefined behaviour in ../net/core/dev.c:1501:2 [ 277.706820] member access within misaligned address ffffff800814b7b0 for type 'struct net_device' [ 277.707417] which requires 64 byte alignment [ 277.707993] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181130-00011-gaa3ac9a7b87a-dirty #67 [ 277.708670] Hardware name: linux,dummy-virt (DT) [ 277.709120] Call trace: [ 277.709589] dump_backtrace+0x0/0x308 [ 277.710088] show_stack+0x28/0x38 [ 277.710587] __dump_stack+0x24/0x2c [ 277.711094] dump_stack+0xf8/0x16c [ 277.711594] ubsan_epilogue+0x18/0x50 [ 277.712143] handle_misaligned_access+0x94/0xc8 [ 277.712693] ubsan_type_mismatch_common+0x60/0x90 [ 277.713250] __ubsan_handle_type_mismatch+0x50/0x74 [ 277.713817] dev_close_many+0x218/0x388 [ 277.714360] rollback_registered_many+0x428/0x900 [ 277.714926] rollback_registered+0xbc/0x158 [ 277.715486] unregister_netdevice_queue+0x234/0x280 [ 277.716079] unregister_netdev+0x2c/0x40 [ 277.716601] virtnet_remove+0x70/0xc8 [ 277.717134] virtio_dev_remove+0x74/0xf0 [ 277.717645] really_probe+0x640/0xd48 [ 277.718150] really_probe_debug+0x3c/0x128 [ 277.718675] driver_probe_device+0x1f8/0x2a0 [ 277.719201] __driver_attach+0x250/0x340 [ 277.719739] bus_for_each_dev+0x110/0x180 [ 277.720272] driver_attach+0x50/0x60 [ 277.720771] bus_add_driver+0x308/0x4f0 [ 277.721282] driver_register+0x2a0/0x330 [ 277.721832] register_virtio_driver+0xa4/0xb8 [ 277.722372] virtio_net_driver_init+0x100/0x17c [ 277.722907] do_one_initcall+0x4c8/0xa50 [ 277.723448] do_initcall_level+0xbcc/0xca4 [ 277.723987] do_initcalls+0x60/0xa4 [ 277.724506] do_basic_setup+0x44/0x70 [ 277.725037] kernel_init_freeable+0x2d8/0x420 [ 277.725561] kernel_init+0x28/0x140 [ 277.726070] ret_from_fork+0x10/0x18 [ 277.726513] ================================================================================ [ 279.557927] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 279.559863] kobject: 'rx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 279.567328] kobject: 'tx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 279.609513] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 279.654220] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 279.656064] kobject: 'net' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 280.547546] KGDB: Unregistered I/O driver kgdbts, debugger disabled [ 282.638039] kobject: 'queues' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 282.896863] kobject: '44' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 282.915594] kobject: '45' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 282.944645] kobject: 'eth0' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 282.978150] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 283.229250] ledtrig-cpu: registered to indicate activity on CPUs [ 283.232054] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 283.232992] kobject: '46' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 283.249659] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 283.260376] kobject: 'meson-sm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 283.371255] ashmem: initialized [ 283.679788] 9pnet: Installing 9P2000 support [ 284.203576] _warn_unseeded_randomness: 9 callbacks suppressed [ 284.203808] random: get_random_bytes called from init_oops_id+0x38/0x60 with crng_init=0 [ 284.224243] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 284.225179] kobject: '47' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 284.236797] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 284.259672] kobject: '48' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 284.333674] registered taskstats version 1 [ 284.336094] Running ring buffer tests... [ 294.666197] finished [ 294.668452] CPU 0: [ 294.669020] events: 5445 [ 294.669645] dropped bytes: 0 [ 294.671152] alloced bytes: 450816 [ 294.671829] written bytes: 415571 [ 294.672466] biggest event: 68 [ 294.673083] smallest event: 0 [ 295.005717] read events: 5445 [ 295.007079] lost events: 0 [ 295.007707] total events: 5445 [ 295.008394] recorded len bytes: 450816 [ 295.009027] recorded size bytes: 415571 [ 295.009685] Ring buffer PASSED! [ 295.121629] Running tests on trace events: [ 295.123182] Testing event initcall_finish: OK [ 295.165372] Testing event initcall_start: OK [ 295.213228] Testing event initcall_level: OK [ 295.259209] Testing event sys_exit: OK [ 295.300335] Testing event sys_enter: OK [ 295.341813] Testing event ipi_exit: OK [ 295.381322] Testing event ipi_entry: OK [ 295.424768] Testing event ipi_raise: OK [ 295.465382] Testing event instruction_emulation: OK [ 295.505886] Testing event kvm_halt_poll_ns: OK [ 295.545308] Testing event kvm_age_page: OK [ 295.589041] Testing event kvm_fpu: OK [ 295.629070] Testing event kvm_mmio: OK [ 295.671465] Testing event kvm_ack_irq: OK [ 295.712967] Testing event kvm_set_irq: OK [ 295.753179] Testing event kvm_vcpu_wakeup: OK [ 295.797308] Testing event kvm_userspace_exit: OK [ 295.837327] Testing event kvm_timer_update_irq: OK [ 295.881262] Testing event kvm_toggle_cache: OK [ 295.921357] Testing event kvm_set_way_flush: OK [ 295.960590] Testing event kvm_test_age_hva: OK [ 295.997133] Testing event kvm_age_hva: OK [ 296.037313] Testing event kvm_set_spte_hva: OK [ 296.081395] Testing event kvm_unmap_hva_range: OK [ 296.121339] Testing event kvm_mmio_emulate: OK [ 296.165044] Testing event kvm_irq_line: OK [ 296.205279] Testing event kvm_access_fault: OK [ 296.243259] Testing event kvm_guest_fault: OK [ 296.281243] Testing event kvm_exit: OK [ 296.324582] Testing event kvm_entry: OK [ 296.365182] Testing event kvm_set_guest_debug: OK [ 296.409196] Testing event kvm_handle_sys_reg: OK [ 296.449202] Testing event trap_reg: OK [ 296.489904] Testing event kvm_arm_set_regset: OK [ 296.529633] Testing event kvm_arm_set_dreg32: OK [ 296.569811] Testing event kvm_arm_clear_debug: OK [ 296.604963] Testing event kvm_arm_setup_debug: OK [ 296.656221] Testing event kvm_hvc_arm64: OK [ 296.696158] Testing event kvm_wfx_arm64: OK [ 296.740804] Testing event vgic_update_irq_pending: OK [ 296.777156] Testing event task_rename: OK [ 296.820065] Testing event task_newtask: OK [ 296.860168] Testing event cpuhp_exit: OK [ 296.901849] Testing event cpuhp_multi_enter: OK [ 296.942088] Testing event cpuhp_enter: OK [ 296.981457] Testing event softirq_raise: OK [ 297.020308] Testing event softirq_exit: OK [ 297.060263] Testing event softirq_entry: OK [ 297.100441] Testing event irq_handler_exit: OK [ 297.141574] Testing event irq_handler_entry: OK [ 297.181614] Testing event signal_deliver: OK [ 297.223956] Testing event signal_generate: OK [ 297.268879] Testing event workqueue_execute_end: OK [ 297.314149] Testing event workqueue_execute_start: OK [ 297.356102] Testing event workqueue_activate_work: OK [ 297.399125] Testing event workqueue_queue_work: OK [ 297.438134] Testing event sched_wake_idle_without_ipi: OK [ 297.480342] Testing event sched_swap_numa: OK [ 297.517812] Testing event sched_stick_numa: OK [ 297.557943] Testing event sched_move_numa: OK [ 297.599447] Testing event sched_process_hang: OK [ 297.637786] Testing event sched_pi_setprio: OK [ 297.679729] Testing event sched_stat_runtime: [ 297.682304] Scheduler tracepoints stat_sleep, stat_iowait, stat_blocked and stat_runtime require the kernel parameter schedstats=enable or kernel.sched_schedstats=1 [ 297.724049] OK [ 297.724676] Testing event sched_stat_blocked: OK [ 297.765483] Testing event sched_stat_iowait: OK [ 297.804579] Testing event sched_stat_sleep: OK [ 297.845480] Testing event sched_stat_wait: OK [ 297.881660] Testing event sched_process_exec: OK [ 297.930003] Testing event sched_process_fork: OK [ 297.972170] Testing event sched_process_wait: OK [ 298.013857] Testing event sched_wait_task: OK [ 298.053372] Testing event sched_process_exit: OK [ 298.096963] Testing event sched_process_free: OK [ 298.137417] Testing event sched_migrate_task: OK [ 298.176877] Testing event sched_switch: OK [ 298.221425] Testing event sched_wakeup_new: OK [ 298.264058] Testing event sched_wakeup: OK [ 298.308593] Testing event sched_waking: OK [ 298.353319] Testing event sched_kthread_stop_ret: OK [ 298.396144] Testing event sched_kthread_stop: OK [ 298.440337] Testing event lock_acquired: OK [ 298.490035] Testing event lock_contended: OK [ 298.529245] Testing event lock_release: OK [ 298.581845] Testing event lock_acquire: OK [ 298.639318] Testing event console: OK [ 298.677287] Testing event rcu_barrier: OK [ 298.720265] Testing event rcu_torture_read: OK [ 298.764716] Testing event rcu_batch_end: OK [ 298.805678] Testing event rcu_invoke_kfree_callback: OK [ 298.842005] Testing event rcu_invoke_callback: OK [ 298.888564] Testing event rcu_batch_start: OK [ 298.929992] Testing event rcu_kfree_callback: OK [ 298.969486] Testing event rcu_callback: OK [ 299.011605] Testing event rcu_dyntick: OK [ 299.059922] Testing event rcu_fqs: OK [ 299.104599] Testing event rcu_quiescent_state_report: OK [ 299.144326] Testing event rcu_unlock_preempted_task: OK [ 299.188590] Testing event rcu_preempt_task: OK [ 299.227415] Testing event rcu_nocb_wake: OK [ 299.277065] Testing event rcu_exp_funnel_lock: OK [ 299.317382] Testing event rcu_exp_grace_period: OK [ 299.359259] Testing event rcu_grace_period_init: OK [ 299.397397] Testing event rcu_future_grace_period: OK [ 299.436491] Testing event rcu_grace_period: OK [ 299.484694] Testing event rcu_utilization: OK [ 299.527259] Testing event swiotlb_bounced: OK [ 299.565496] Testing event tick_stop: OK [ 299.604080] Testing event itimer_expire: OK [ 299.645499] Testing event itimer_state: OK [ 299.684490] Testing event hrtimer_cancel: OK [ 299.725947] Testing event hrtimer_expire_exit: OK [ 299.765643] Testing event hrtimer_expire_entry: OK [ 299.805524] Testing event hrtimer_start: OK [ 299.848442] Testing event hrtimer_init: OK [ 299.889426] Testing event timer_cancel: OK [ 299.930014] Testing event timer_expire_exit: OK [ 299.969434] Testing event timer_expire_entry: OK [ 300.008292] Testing event timer_start: OK [ 300.050034] Testing event timer_init: OK [ 300.089385] Testing event alarmtimer_cancel: OK [ 300.132599] Testing event alarmtimer_start: OK [ 300.173423] Testing event alarmtimer_fired: OK [ 300.212135] Testing event alarmtimer_suspend: OK [ 300.253942] Testing event module_request: OK [ 300.293359] Testing event module_put: OK [ 300.332228] Testing event module_get: OK [ 300.376901] Testing event module_free: OK [ 300.421258] Testing event module_load: OK [ 300.460363] Testing event cgroup_transfer_tasks: OK [ 300.500991] Testing event cgroup_attach_task: OK [ 300.537186] Testing event cgroup_rename: OK [ 300.577517] Testing event cgroup_release: OK [ 300.616886] Testing event cgroup_rmdir: OK [ 300.663455] Testing event cgroup_mkdir: OK [ 300.704312] Testing event cgroup_remount: OK [ 300.748534] Testing event cgroup_destroy_root: OK [ 300.785878] Testing event cgroup_setup_root: OK [ 300.822036] Testing event irq_enable: OK [ 300.863228] Testing event irq_disable: OK [ 300.923375] Testing event ftrace_test_filter: OK [ 300.961772] Testing event dev_pm_qos_remove_request: OK [ 301.001471] Testing event dev_pm_qos_update_request: OK [ 301.044408] Testing event dev_pm_qos_add_request: OK [ 301.082025] Testing event pm_qos_update_flags: OK [ 301.124322] Testing event pm_qos_update_target: OK [ 301.168124] Testing event pm_qos_update_request_timeout: OK [ 301.211844] Testing event pm_qos_remove_request: OK [ 301.252136] Testing event pm_qos_update_request: OK [ 301.296313] Testing event pm_qos_add_request: OK [ 301.339470] Testing event power_domain_target: OK [ 301.377245] Testing event clock_set_rate: OK [ 301.420881] Testing event clock_disable: OK [ 301.461248] Testing event clock_enable: OK [ 301.493880] Testing event wakeup_source_deactivate: OK [ 301.533050] Testing event wakeup_source_activate: OK [ 301.569005] Testing event suspend_resume: OK [ 301.624401] Testing event device_pm_callback_end: OK [ 301.664653] Testing event device_pm_callback_start: OK [ 301.709583] Testing event cpu_frequency_limits: OK [ 301.749411] Testing event cpu_frequency: OK [ 301.788524] Testing event pstate_sample: OK [ 301.827563] Testing event powernv_throttle: OK [ 301.865675] Testing event cpu_idle: OK [ 301.908041] Testing event rpm_return_int: OK [ 301.947296] Testing event rpm_idle: OK [ 301.985840] Testing event rpm_resume: OK [ 302.027562] Testing event rpm_suspend: OK [ 302.065387] Testing event benchmark_event: OK [ 302.202083] Testing event xdp_devmap_xmit: OK [ 302.240479] Testing event xdp_cpumap_enqueue: OK [ 302.280285] Testing event xdp_cpumap_kthread: OK [ 302.324604] Testing event xdp_redirect_map_err: OK [ 302.361340] Testing event xdp_redirect_map: OK [ 302.404235] Testing event xdp_redirect_err: OK [ 302.444304] Testing event xdp_redirect: OK [ 302.487231] Testing event xdp_exception: OK [ 302.525983] Testing event rseq_ip_fixup: OK [ 302.565348] Testing event rseq_update: OK [ 302.608794] Testing event file_check_and_advance_wb_err: OK [ 302.649561] Testing event filemap_set_wb_err: OK [ 302.688646] Testing event mm_filemap_add_to_page_cache: OK [ 302.725158] Testing event mm_filemap_delete_from_page_cache: OK [ 302.766096] Testing event compact_retry: OK [ 302.801939] Testing event skip_task_reaping: OK [ 302.844365] Testing event finish_task_reaping: OK [ 302.886109] Testing event start_task_reaping: OK [ 302.925390] Testing event wake_reaper: OK [ 302.964047] Testing event mark_victim: OK [ 303.004393] Testing event reclaim_retry_zone: OK [ 303.043957] Testing event oom_score_adj_update: OK [ 303.088712] Testing event mm_lru_activate: OK [ 303.132557] Testing event mm_lru_insertion: OK [ 303.173512] Testing event mm_vmscan_inactive_list_is_low: OK [ 303.212288] Testing event mm_vmscan_lru_shrink_active: OK [ 303.251759] Testing event mm_vmscan_lru_shrink_inactive: OK [ 303.293564] Testing event mm_vmscan_writepage: OK [ 303.333407] Testing event mm_vmscan_lru_isolate: OK [ 303.372184] Testing event mm_shrink_slab_end: OK [ 303.413931] Testing event mm_shrink_slab_start: OK [ 303.457144] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 303.497931] Testing event mm_vmscan_memcg_reclaim_end: OK [ 303.537339] Testing event mm_vmscan_direct_reclaim_end: OK [ 303.581473] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 303.621529] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 303.660066] Testing event mm_vmscan_direct_reclaim_begin: OK [ 303.697402] Testing event mm_vmscan_wakeup_kswapd: OK [ 303.740371] Testing event mm_vmscan_kswapd_wake: OK [ 303.779747] Testing event mm_vmscan_kswapd_sleep: OK [ 303.822028] Testing event percpu_destroy_chunk: OK [ 303.861372] Testing event percpu_create_chunk: OK [ 303.900375] Testing event percpu_alloc_percpu_fail: OK [ 303.941366] Testing event percpu_free_percpu: OK [ 303.980500] Testing event percpu_alloc_percpu: OK [ 304.025560] Testing event mm_fragmentation_stall: OK [ 304.069431] Testing event mm_page_alloc_extfrag: OK [ 304.109524] Testing event mm_page_pcpu_drain: OK [ 304.148280] Testing event mm_page_alloc_zone_locked: OK [ 304.189700] Testing event mm_page_alloc: OK [ 304.228519] Testing event mm_page_free_batched: OK [ 304.269469] Testing event mm_page_free: OK [ 304.308767] Testing event kmem_cache_free: OK [ 304.345211] Testing event kfree: OK [ 304.388374] Testing event kmem_cache_alloc_node: OK [ 304.428168] Testing event kmalloc_node: OK [ 304.469923] Testing event kmem_cache_alloc: OK [ 304.509345] Testing event kmalloc: OK [ 304.549862] Testing event mm_compaction_kcompactd_wake: OK [ 304.589394] Testing event mm_compaction_wakeup_kcompactd: OK [ 304.628219] Testing event mm_compaction_kcompactd_sleep: OK [ 304.671180] Testing event mm_compaction_defer_reset: OK [ 304.709452] Testing event mm_compaction_defer_compaction: OK [ 304.752226] Testing event mm_compaction_deferred: OK [ 304.794011] Testing event mm_compaction_suitable: OK [ 304.833438] Testing event mm_compaction_finished: OK [ 304.872268] Testing event mm_compaction_try_to_compact_pages: OK [ 304.913513] Testing event mm_compaction_end: OK [ 304.956071] Testing event mm_compaction_begin: OK [ 304.997960] Testing event mm_compaction_migratepages: OK [ 305.037422] Testing event mm_compaction_isolate_freepages: OK [ 305.080148] Testing event mm_compaction_isolate_migratepages: OK [ 305.125498] Testing event mm_migrate_pages: OK [ 305.166227] Testing event mm_collapse_huge_page_swapin: OK [ 305.211813] Testing event mm_collapse_huge_page_isolate: OK [ 305.252311] Testing event mm_collapse_huge_page: OK [ 305.294127] Testing event mm_khugepaged_scan_pmd: OK [ 305.333416] Testing event test_pages_isolated: OK [ 305.372054] Testing event cma_release: OK [ 305.416521] Testing event cma_alloc: OK [ 305.457487] Testing event page_ref_unfreeze: OK [ 305.501822] Testing event page_ref_freeze: OK [ 305.545327] Testing event page_ref_mod_unless: OK [ 305.593443] Testing event page_ref_mod_and_return: OK [ 305.636386] Testing event page_ref_mod_and_test: OK [ 305.834181] Testing event page_ref_mod: OK [ 305.917467] Testing event page_ref_set: OK [ 305.969849] Testing event sb_clear_inode_writeback: OK [ 306.009376] Testing event sb_mark_inode_writeback: OK [ 306.048193] Testing event writeback_dirty_inode_enqueue: OK [ 306.089935] Testing event writeback_lazytime_iput: OK [ 306.129467] Testing event writeback_lazytime: OK [ 306.172071] Testing event writeback_single_inode: OK [ 306.216488] Testing event writeback_single_inode_start: OK [ 306.259252] Testing event writeback_wait_iff_congested: OK [ 306.297538] Testing event writeback_congestion_wait: OK [ 306.336579] Testing event writeback_sb_inodes_requeue: OK [ 306.383304] Testing event balance_dirty_pages: OK [ 306.424215] Testing event bdi_dirty_ratelimit: OK [ 306.465270] Testing event global_dirty_state: OK [ 306.508037] Testing event writeback_queue_io: OK [ 306.549971] Testing event wbc_writepage: OK [ 306.589522] Testing event writeback_bdi_register: OK [ 306.628354] Testing event writeback_wake_background: OK [ 306.668000] Testing event writeback_pages_written: OK [ 306.712503] Testing event writeback_wait: OK [ 306.754025] Testing event writeback_written: OK [ 306.793440] Testing event writeback_start: OK [ 306.836185] Testing event writeback_exec: OK [ 306.877281] Testing event writeback_queue: OK [ 306.916306] Testing event writeback_write_inode: OK [ 306.955933] Testing event writeback_write_inode_start: OK [ 306.998013] Testing event writeback_dirty_inode: OK [ 307.040494] Testing event writeback_dirty_inode_start: OK [ 307.086077] Testing event writeback_mark_inode_dirty: OK [ 307.126044] Testing event writeback_dirty_page: OK [ 307.165918] Testing event dax_writeback_one: OK [ 307.207536] Testing event dax_writeback_range_done: OK [ 307.241631] Testing event dax_writeback_range: OK [ 307.285280] Testing event dax_insert_mapping: OK [ 307.331239] Testing event dax_insert_pfn_mkwrite: OK [ 307.372130] Testing event dax_insert_pfn_mkwrite_no_entry: OK [ 307.413391] Testing event dax_load_hole: OK [ 307.452186] Testing event dax_pte_fault_done: OK [ 307.497020] Testing event dax_pte_fault: OK [ 307.540989] Testing event dax_pmd_insert_mapping: OK [ 307.578012] Testing event dax_pmd_load_hole_fallback: OK [ 307.617909] Testing event dax_pmd_load_hole: OK [ 307.657706] Testing event dax_pmd_fault_done: OK [ 307.697863] Testing event dax_pmd_fault: OK [ 307.740898] Testing event generic_add_lease: OK [ 307.784552] Testing event time_out_leases: OK [ 307.825792] Testing event generic_delete_lease: OK [ 307.865749] Testing event break_lease_unblock: OK [ 307.904590] Testing event break_lease_block: OK [ 307.951445] Testing event break_lease_noblock: OK [ 307.992650] Testing event flock_lock_inode: OK [ 308.033397] Testing event locks_remove_posix: OK [ 308.073045] Testing event fcntl_setlk: OK [ 308.114079] Testing event posix_lock_inode: OK [ 308.151208] Testing event locks_get_lock_context: OK [ 308.197629] Testing event block_rq_remap: OK [ 308.237757] Testing event block_bio_remap: OK [ 308.279527] Testing event block_split: OK [ 308.313586] Testing event block_unplug: OK [ 308.363344] Testing event block_plug: OK [ 308.404483] Testing event block_sleeprq: OK [ 308.445608] Testing event block_getrq: OK [ 308.484233] Testing event block_bio_queue: OK [ 308.525677] Testing event block_bio_frontmerge: OK [ 308.565399] Testing event block_bio_backmerge: OK [ 308.608982] Testing event block_bio_complete: OK [ 308.649424] Testing event block_bio_bounce: OK [ 308.691946] Testing event block_rq_issue: OK [ 308.733840] Testing event block_rq_insert: OK [ 308.773739] Testing event block_rq_complete: OK [ 308.817166] Testing event block_rq_requeue: OK [ 308.858040] Testing event block_dirty_buffer: OK [ 308.897332] Testing event block_touch_buffer: OK [ 308.941041] Testing event wbt_timer: OK [ 308.981312] Testing event wbt_step: OK [ 309.024754] Testing event wbt_lat: OK [ 309.065522] Testing event wbt_stat: OK [ 309.104256] Testing event gpio_value: OK [ 309.149762] Testing event gpio_direction: OK [ 309.192346] Testing event clk_set_duty_cycle_complete: OK [ 309.233465] Testing event clk_set_duty_cycle: OK [ 309.274249] Testing event clk_set_phase_complete: OK [ 309.317900] Testing event clk_set_phase: OK [ 309.357457] Testing event clk_set_parent_complete: OK [ 309.396369] Testing event clk_set_parent: OK [ 309.442242] Testing event clk_set_rate_complete: OK [ 309.484393] Testing event clk_set_rate: OK [ 309.525464] Testing event clk_unprepare_complete: OK [ 309.564907] Testing event clk_unprepare: OK [ 309.603243] Testing event clk_prepare_complete: OK [ 309.641997] Testing event clk_prepare: OK [ 309.677854] Testing event clk_disable_complete: OK [ 309.725054] Testing event clk_disable: OK [ 309.765474] Testing event clk_enable_complete: OK [ 309.804265] Testing event clk_enable: OK [ 309.845693] Testing event rpmh_send_msg: OK [ 309.881362] Testing event rpmh_tx_done: OK [ 309.930030] Testing event regulator_set_voltage_complete: OK [ 309.972384] Testing event regulator_set_voltage: OK [ 310.013536] Testing event regulator_disable_complete: OK [ 310.054042] Testing event regulator_disable: OK [ 310.098031] Testing event regulator_enable_complete: OK [ 310.140451] Testing event regulator_enable_delay: OK [ 310.177279] Testing event regulator_enable: OK [ 310.221475] Testing event urandom_read: OK [ 310.260199] Testing event random_read: OK [ 310.301422] Testing event extract_entropy_user: OK [ 310.345461] Testing event extract_entropy: OK [ 310.388043] Testing event get_random_bytes_arch: OK [ 310.427763] Testing event get_random_bytes: OK [ 310.468219] Testing event xfer_secondary_pool: OK [ 310.506140] Testing event add_disk_randomness: OK [ 310.545532] Testing event add_input_randomness: OK [ 310.584290] Testing event debit_entropy: OK [ 310.624207] Testing event push_to_pool: OK [ 310.667788] Testing event credit_entropy_bits: OK [ 310.709408] Testing event mix_pool_bytes_nolock: OK [ 310.748168] Testing event mix_pool_bytes: OK [ 310.789432] Testing event add_device_randomness: OK [ 310.833335] Testing event io_page_fault: OK [ 310.879205] Testing event unmap: OK [ 310.920312] Testing event map: OK [ 310.960518] Testing event detach_device_from_domain: OK [ 311.001559] Testing event attach_device_to_domain: OK [ 311.043419] Testing event remove_device_from_group: OK [ 311.083754] Testing event add_device_to_group: OK [ 311.117054] Testing event regcache_drop_region: OK [ 311.159410] Testing event regmap_async_complete_done: OK [ 311.201124] Testing event regmap_async_complete_start: OK [ 311.241891] Testing event regmap_async_io_complete: OK [ 311.281690] Testing event regmap_async_write_start: OK [ 311.318099] Testing event regmap_cache_bypass: OK [ 311.360773] Testing event regmap_cache_only: OK [ 311.401569] Testing event regcache_sync: OK [ 311.444101] Testing event regmap_hw_write_done: OK [ 311.485856] Testing event regmap_hw_write_start: OK [ 311.529541] Testing event regmap_hw_read_done: OK [ 311.573601] Testing event regmap_hw_read_start: OK [ 311.612708] Testing event regmap_reg_read_cache: OK [ 311.657694] Testing event regmap_reg_read: OK [ 311.697492] Testing event regmap_reg_write: OK [ 311.736634] Testing event dma_fence_wait_end: OK [ 311.777779] Testing event dma_fence_wait_start: OK [ 311.817746] Testing event dma_fence_signaled: OK [ 311.858197] Testing event dma_fence_enable_signal: OK [ 311.899926] Testing event dma_fence_destroy: OK [ 311.933161] Testing event dma_fence_init: OK [ 311.981143] Testing event dma_fence_emit: OK [ 312.021233] Testing event sync_timeline: OK [ 312.064790] Testing event spi_transfer_stop: OK [ 312.105942] Testing event spi_transfer_start: OK [ 312.145310] Testing event spi_message_done: OK [ 312.188010] Testing event spi_message_start: OK [ 312.232645] Testing event spi_message_submit: OK [ 312.273522] Testing event spi_controller_busy: OK [ 312.313433] Testing event spi_controller_idle: OK [ 312.352230] Testing event rtc_timer_fired: OK [ 312.393293] Testing event rtc_timer_dequeue: OK [ 312.429787] Testing event rtc_timer_enqueue: OK [ 312.472956] Testing event rtc_read_offset: OK [ 312.516784] Testing event rtc_set_offset: OK [ 312.557469] Testing event rtc_alarm_irq_enable: OK [ 312.597005] Testing event rtc_irq_set_state: OK [ 312.634243] Testing event rtc_irq_set_freq: OK [ 312.671211] Testing event rtc_read_alarm: OK [ 312.713513] Testing event rtc_set_alarm: OK [ 312.750158] Testing event rtc_read_time: OK [ 312.792113] Testing event rtc_set_time: OK [ 312.832249] Testing event memory_failure_event: OK [ 312.873832] Testing event aer_event: OK [ 312.913467] Testing event non_standard_event: OK [ 312.956384] Testing event arm_event: OK [ 312.997544] Testing event mc_event: OK [ 313.035927] Testing event binder_return: OK [ 313.077958] Testing event binder_command: OK [ 313.120268] Testing event binder_unmap_kernel_end: OK [ 313.164532] Testing event binder_unmap_kernel_start: OK [ 313.201349] Testing event binder_unmap_user_end: OK [ 313.245464] Testing event binder_unmap_user_start: OK [ 313.285959] Testing event binder_alloc_page_end: OK [ 313.328056] Testing event binder_alloc_page_start: OK [ 313.368484] Testing event binder_free_lru_end: OK [ 313.409483] Testing event binder_free_lru_start: OK [ 313.448749] Testing event binder_alloc_lru_end: OK [ 313.489517] Testing event binder_alloc_lru_start: OK [ 313.529448] Testing event binder_update_page_range: OK [ 313.568278] Testing event binder_transaction_failed_buffer_release: OK [ 313.609592] Testing event binder_transaction_buffer_release: OK [ 313.648425] Testing event binder_transaction_alloc_buf: OK [ 313.688788] Testing event binder_transaction_fd_recv: OK [ 313.727149] Testing event binder_transaction_fd_send: OK [ 313.768044] Testing event binder_transaction_ref_to_ref: OK [ 313.810088] Testing event binder_transaction_ref_to_node: OK [ 313.849558] Testing event binder_transaction_node_to_ref: OK [ 313.889437] Testing event binder_transaction_received: OK [ 313.932831] Testing event binder_transaction: OK [ 313.973350] Testing event binder_wait_for_work: OK [ 314.017208] Testing event binder_read_done: OK [ 314.057451] Testing event binder_write_done: OK [ 314.093994] Testing event binder_ioctl_done: OK [ 314.140797] Testing event binder_unlock: OK [ 314.181318] Testing event binder_locked: OK [ 314.220242] Testing event binder_lock: OK [ 314.259571] Testing event binder_ioctl: OK [ 314.301574] Testing event br_fdb_update: OK [ 314.341103] Testing event fdb_delete: OK [ 314.384524] Testing event br_fdb_external_learn_add: OK [ 314.425161] Testing event br_fdb_add: OK [ 314.463668] Testing event qdisc_dequeue: OK [ 314.507239] Testing event fib_table_lookup: OK [ 314.548733] Testing event tcp_probe: OK [ 314.589570] Testing event tcp_retransmit_synack: OK [ 314.628805] Testing event tcp_rcv_space_adjust: OK [ 314.665228] Testing event tcp_destroy_sock: OK [ 314.709284] Testing event tcp_receive_reset: OK [ 314.748263] Testing event tcp_send_reset: OK [ 314.790173] Testing event tcp_retransmit_skb: OK [ 314.829318] Testing event udp_fail_queue_rcv_skb: OK [ 314.872751] Testing event inet_sock_set_state: OK [ 314.913662] Testing event sock_exceed_buf_limit: OK [ 314.952705] Testing event sock_rcvqueue_full: OK [ 314.993797] Testing event napi_poll: OK [ 315.033859] Testing event netif_rx_ni_entry: OK [ 315.077523] Testing event netif_rx_entry: OK [ 315.122115] Testing event netif_receive_skb_list_entry: OK [ 315.164143] Testing event netif_receive_skb_entry: OK [ 315.205578] Testing event napi_gro_receive_entry: OK [ 315.244564] Testing event napi_gro_frags_entry: OK [ 315.285746] Testing event netif_rx: OK [ 315.325675] Testing event netif_receive_skb: OK [ 315.365613] Testing event net_dev_queue: OK [ 315.407707] Testing event net_dev_xmit: OK [ 315.451999] Testing event net_dev_start_xmit: OK [ 315.485192] Testing event skb_copy_datagram_iovec: OK [ 315.527009] Testing event consume_skb: OK [ 315.566236] Testing event kfree_skb: OK [ 315.607812] Testing event 9p_protocol_dump: OK [ 315.653521] Testing event 9p_client_res: OK [ 315.696631] Testing event 9p_client_req: OK [ 315.741332] Running tests on trace event systems: [ 315.743304] Testing event system 9p: OK [ 315.796878] Testing event system skb: OK [ 315.843561] Testing event system net: OK [ 315.900118] Testing event system napi: OK [ 315.949731] Testing event system sock: OK [ 315.993699] Testing event system udp: OK [ 316.036611] Testing event system tcp: OK [ 316.081559] Testing event system fib: OK [ 316.127710] Testing event system qdisc: OK [ 316.167591] Testing event system bridge: OK [ 316.211460] Testing event system binder: OK [ 316.296032] Testing event system ras: OK [ 316.343255] Testing event system rtc: OK [ 316.425790] Testing event system spi: OK [ 316.481073] Testing event system sync_trace: OK [ 316.526203] Testing event system dma_fence: OK [ 316.579542] Testing event system regmap: OK [ 316.643066] Testing event system iommu: OK [ 316.700422] Testing event system random: OK [ 316.761998] Testing event system regulator: OK [ 316.816620] Testing event system rpmh: OK [ 316.861774] Testing event system clk: OK [ 316.923550] Testing event system gpio: OK [ 316.979330] Testing event system wbt: OK [ 317.027322] Testing event system block: OK [ 317.093112] Testing event system filelock: OK [ 317.155857] Testing event system fs_dax: OK [ 317.213031] Testing event system writeback: OK [ 317.297334] Testing event system page_ref: OK [ 317.558125] Testing event system cma: OK [ 317.623288] Testing event system page_isolation: OK [ 317.663457] Testing event system huge_memory: OK [ 317.708909] Testing event system migrate: OK [ 317.752927] Testing event system compaction: OK [ 317.808724] Testing event system kmem: OK [ 317.878021] Testing event system percpu: OK [ 317.932099] Testing event system vmscan: OK [ 318.000107] Testing event system pagemap: OK [ 318.053353] Testing event system oom: OK [ 318.105549] Testing event system filemap: OK [ 318.155338] Testing event system rseq: OK [ 318.200874] Testing event system xdp: OK [ 318.260638] Testing event system benchmark: OK [ 318.397885] Testing event system rpm: OK [ 318.439071] Testing event system power: OK [ 318.520768] Testing event system test: OK [ 318.576648] Testing event system preemptirq: OK [ 318.649401] Testing event system cgroup: OK [ 318.705787] Testing event system module: OK [ 318.759943] Testing event system alarmtimer: OK [ 318.807262] Testing event system timer: OK [ 318.871595] Testing event system swiotlb: OK [ 318.920686] Testing event system rcu: OK [ 319.011613] Testing event system printk: OK [ 319.061189] Testing event system lock: OK [ 319.155958] Testing event system sched: OK [ 319.239219] Testing event system workqueue: OK [ 319.297992] Testing event system signal: OK [ 319.333477] Testing event system irq: OK [ 319.392573] Testing event system cpuhp: OK [ 319.444528] Testing event system task: OK [ 319.489292] Testing event system kvm: OK [ 319.571845] Testing event system emulation: OK [ 319.641605] Testing event system ipi: OK [ 319.685570] Testing event system syscalls: OK [ 319.767848] Testing event system raw_syscalls: OK [ 319.813574] Testing event system initcall: OK [ 319.858136] Running tests on all trace events: [ 319.859853] Testing all events: OK [ 322.351874] ftrace_replace_code: 1 [ 366.210377] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 366.233012] Running tests again, along with the function tracer [ 366.241187] Running tests on trace events: [ 366.252795] Testing event initcall_finish: OK [ 366.542098] Testing event initcall_start: OK [ 366.785119] Testing event initcall_level: OK [ 367.045350] Testing event sys_exit: OK [ 367.301739] Testing event sys_enter: OK [ 367.573515] Testing event ipi_exit: OK [ 367.894281] Testing event ipi_entry: OK [ 368.101958] Testing event ipi_raise: OK [ 368.365123] Testing event instruction_emulation: OK [ 368.625003] Testing event kvm_halt_poll_ns: OK [ 368.896892] Testing event kvm_age_page: OK [ 369.166211] Testing event kvm_fpu: OK [ 369.440772] Testing event kvm_mmio: OK [ 369.732662] Testing event kvm_ack_irq: OK [ 369.993394] Testing event kvm_set_irq: OK [ 370.246103] Testing event kvm_vcpu_wakeup: OK [ 370.528742] Testing event kvm_userspace_exit: OK [ 370.772664] Testing event kvm_timer_update_irq: OK [ 371.036864] Testing event kvm_toggle_cache: OK [ 371.296765] Testing event kvm_set_way_flush: OK [ 371.552783] Testing event kvm_test_age_hva: OK [ 371.777280] Testing event kvm_age_hva: OK [ 372.037685] Testing event kvm_set_spte_hva: OK [ 372.329191] Testing event kvm_unmap_hva_range: OK [ 372.606029] Testing event kvm_mmio_emulate: OK [ 372.881307] Testing event kvm_irq_line: OK [ 373.140943] Testing event kvm_access_fault: OK [ 373.386030] Testing event kvm_guest_fault: OK [ 373.652798] Testing event kvm_exit: OK [ 373.893086] Testing event kvm_entry: OK [ 374.117590] Testing event kvm_set_guest_debug: OK [ 374.352850] Testing event kvm_handle_sys_reg: OK [ 374.608877] Testing event trap_reg: OK [ 374.877480] Testing event kvm_arm_set_regset: OK [ 375.138224] Testing event kvm_arm_set_dreg32: OK [ 375.433055] Testing event kvm_arm_clear_debug: OK [ 375.682149] Testing event kvm_arm_setup_debug: OK [ 375.941081] Testing event kvm_hvc_arm64: OK [ 376.224711] Testing event kvm_wfx_arm64: OK [ 376.485437] Testing event vgic_update_irq_pending: OK [ 376.755057] Testing event task_rename: OK [ 377.029103] Testing event task_newtask: OK [ 377.316858] Testing event cpuhp_exit: OK [ 377.597288] Testing event cpuhp_multi_enter: OK [ 377.898267] Testing event cpuhp_enter: OK [ 378.141606] Testing event softirq_raise: OK [ 378.401923] Testing event softirq_exit: OK [ 378.670100] Testing event softirq_entry: OK [ 378.941225] Testing event irq_handler_exit: OK [ 379.181558] Testing event irq_handler_entry: OK [ 379.505280] Testing event signal_deliver: OK [ 379.744903] Testing event signal_generate: OK [ 380.016530] Testing event workqueue_execute_end: OK [ 380.336686] Testing event workqueue_execute_start: OK [ 380.593892] Testing event workqueue_activate_work: OK [ 380.849073] Testing event workqueue_queue_work: OK [ 381.100764] Testing event sched_wake_idle_without_ipi: OK [ 381.388858] Testing event sched_swap_numa: OK [ 381.645775] Testing event sched_stick_numa: OK [ 381.913700] Testing event sched_move_numa: OK [ 382.164994] Testing event sched_process_hang: OK [ 382.428734] Testing event sched_pi_setprio: OK [ 382.728917] Testing event sched_stat_runtime: OK [ 383.057102] Testing event sched_stat_blocked: OK [ 383.289414] Testing event sched_stat_iowait: OK [ 383.541493] Testing event sched_stat_sleep: OK [ 383.821302] Testing event sched_stat_wait: OK [ 384.073248] Testing event sched_process_exec: OK [ 384.358004] Testing event sched_process_fork: OK [ 384.616615] Testing event sched_process_wait: OK [ 384.938143] Testing event sched_wait_task: OK [ 385.188900] Testing event sched_process_exit: OK [ 385.425214] Testing event sched_process_free: OK [ 385.678192] Testing event sched_migrate_task: OK [ 385.968801] Testing event sched_switch: OK [ 386.221817] Testing event sched_wakeup_new: OK [ 386.505404] Testing event sched_wakeup: OK [ 386.809511] Testing event sched_waking: OK [ 387.104109] Testing event sched_kthread_stop_ret: OK [ 387.336834] Testing event sched_kthread_stop: OK [ 387.620857] Testing event lock_acquired: OK [ 387.866288] Testing event lock_contended: OK [ 388.111064] Testing event lock_release: OK [ 388.442238] Testing event lock_acquire: OK [ 388.749682] Testing event console: OK [ 388.998076] Testing event rcu_barrier: OK [ 389.237723] Testing event rcu_torture_read: OK [ 389.497092] Testing event rcu_batch_end: OK [ 389.817419] Testing event rcu_invoke_kfree_callback: OK [ 390.068915] Testing event rcu_invoke_callback: OK [ 390.342194] Testing event rcu_batch_start: OK [ 390.609402] Testing event rcu_kfree_callback: OK [ 390.894042] Testing event rcu_callback: OK [ 391.145159] Testing event rcu_dyntick: OK [ 391.426128] Testing event rcu_fqs: OK [ 391.685090] Testing event rcu_quiescent_state_report: OK [ 391.940881] Testing event rcu_unlock_preempted_task: OK [ 392.217717] Testing event rcu_preempt_task: OK [ 392.453755] Testing event rcu_nocb_wake: OK [ 392.758051] Testing event rcu_exp_funnel_lock: OK [ 393.017948] Testing event rcu_exp_grace_period: OK [ 393.300778] Testing event rcu_grace_period_init: OK [ 393.589907] Testing event rcu_future_grace_period: OK [ 393.881691] Testing event rcu_grace_period: OK [ 394.205891] Testing event rcu_utilization: OK [ 394.544707] Testing event swiotlb_bounced: OK [ 394.833462] Testing event tick_stop: OK [ 395.095035] Testing event itimer_expire: OK [ 395.337617] Testing event itimer_state: OK [ 395.597296] Testing event hrtimer_cancel: OK [ 395.886186] Testing event hrtimer_expire_exit: OK [ 396.184876] Testing event hrtimer_expire_entry: OK [ 396.425590] Testing event hrtimer_start: OK [ 396.648995] Testing event hrtimer_init: OK [ 396.912627] Testing event timer_cancel: OK [ 397.173450] Testing event timer_expire_exit: OK [ 397.434110] Testing event timer_expire_entry: OK [ 397.714029] Testing event timer_start: OK [ 397.985894] Testing event timer_init: OK [ 398.253239] Testing event alarmtimer_cancel: OK [ 398.476788] Testing event alarmtimer_start: OK [ 398.761960] Testing event alarmtimer_fired: OK [ 399.013290] Testing event alarmtimer_suspend: OK [ 399.280842] Testing event module_request: OK [ 399.546164] Testing event module_put: OK [ 399.833164] Testing event module_get: OK [ 400.101081] Testing event module_free: OK [ 400.325879] Testing event module_load: OK [ 400.581116] Testing event cgroup_transfer_tasks: OK [ 400.845732] Testing event cgroup_attach_task: OK [ 401.112592] Testing event cgroup_rename: OK [ 401.421772] Testing event cgroup_release: OK [ 401.720750] Testing event cgroup_rmdir: OK [ 402.057326] Testing event cgroup_mkdir: OK [ 402.297342] Testing event cgroup_remount: OK [ 402.566127] Testing event cgroup_destroy_root: OK [ 402.810187] Testing event cgroup_setup_root: OK [ 403.060672] Testing event irq_enable: OK [ 403.413537] Testing event irq_disable: OK [ 403.681247] Testing event ftrace_test_filter: OK [ 403.989572] Testing event dev_pm_qos_remove_request: OK [ 404.280898] Testing event dev_pm_qos_update_request: OK [ 404.544811] Testing event dev_pm_qos_add_request: OK [ 404.782077] Testing event pm_qos_update_flags: OK [ 405.058123] Testing event pm_qos_update_target: OK [ 405.333013] Testing event pm_qos_update_request_timeout: OK [ 405.653065] Testing event pm_qos_remove_request: OK [ 405.885912] Testing event pm_qos_update_request: OK [ 406.113544] Testing event pm_qos_add_request: OK [ 406.372581] Testing event power_domain_target: OK [ 406.658276] Testing event clock_set_rate: OK [ 406.897640] Testing event clock_disable: OK [ 407.157796] Testing event clock_enable: OK [ 407.405255] Testing event wakeup_source_deactivate: OK [ 407.687048] Testing event wakeup_source_activate: OK [ 407.908815] Testing event suspend_resume: OK [ 408.302209] Testing event device_pm_callback_end: OK [ 408.596761] Testing event device_pm_callback_start: OK [ 408.832900] Testing event cpu_frequency_limits: OK [ 409.116759] Testing event cpu_frequency: OK [ 409.386104] Testing event pstate_sample: OK [ 409.669836] Testing event powernv_throttle: OK [ 409.943039] Testing event cpu_idle: OK [ 410.209397] Testing event rpm_return_int: OK [ 410.505944] Testing event rpm_idle: OK [ 410.765618] Testing event rpm_resume: OK [ 411.030103] Testing event rpm_suspend: OK [ 411.294051] Testing event benchmark_event: OK [ 411.648814] Testing event xdp_devmap_xmit: OK [ 411.934260] Testing event xdp_cpumap_enqueue: OK [ 412.145475] Testing event xdp_cpumap_kthread: OK [ 412.413134] Testing event xdp_redirect_map_err: OK [ 412.676852] Testing event xdp_redirect_map: OK [ 412.957976] Testing event xdp_redirect_err: OK [ 413.217682] Testing event xdp_redirect: OK [ 413.482292] Testing event xdp_exception: OK [ 413.764910] Testing event rseq_ip_fixup: OK [ 414.031011] Testing event rseq_update: OK [ 414.318143] Testing event file_check_and_advance_wb_err: OK [ 414.572790] Testing event filemap_set_wb_err: OK [ 414.822270] Testing event mm_filemap_add_to_page_cache: OK [ 415.082037] Testing event mm_filemap_delete_from_page_cache: OK [ 415.326010] Testing event compact_retry: OK [ 415.573262] Testing event skip_task_reaping: OK [ 415.876977] Testing event finish_task_reaping: OK [ 416.148938] Testing event start_task_reaping: OK [ 416.405582] Testing event wake_reaper: OK [ 416.697910] Testing event mark_victim: OK [ 416.938039] Testing event reclaim_retry_zone: OK [ 417.240699] Testing event oom_score_adj_update: OK [ 417.489695] Testing event mm_lru_activate: OK [ 417.739069] Testing event mm_lru_insertion: OK [ 418.000725] Testing event mm_vmscan_inactive_list_is_low: OK [ 418.268968] Testing event mm_vmscan_lru_shrink_active: OK [ 418.562242] Testing event mm_vmscan_lru_shrink_inactive: OK [ 418.828924] Testing event mm_vmscan_writepage: OK [ 419.148678] Testing event mm_vmscan_lru_isolate: OK [ 419.384709] Testing event mm_shrink_slab_end: OK [ 419.664662] Testing event mm_shrink_slab_start: OK [ 419.904785] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 420.204742] Testing event mm_vmscan_memcg_reclaim_end: OK [ 420.464581] Testing event mm_vmscan_direct_reclaim_end: OK [ 420.772914] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 421.005178] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 421.262008] Testing event mm_vmscan_direct_reclaim_begin: OK [ 421.533031] Testing event mm_vmscan_wakeup_kswapd: OK [ 421.788984] Testing event mm_vmscan_kswapd_wake: OK [ 422.060813] Testing event mm_vmscan_kswapd_sleep: OK [ 422.317431] Testing event percpu_destroy_chunk: OK [ 422.546176] Testing event percpu_create_chunk: OK [ 422.789230] Testing event percpu_alloc_percpu_fail: OK [ 423.017557] Testing event percpu_free_percpu: OK [ 423.295070] Testing event percpu_alloc_percpu: OK [ 423.586115] Testing event mm_fragmentation_stall: OK [ 423.837819] Testing event mm_page_alloc_extfrag: OK [ 424.201574] Testing event mm_page_pcpu_drain: OK [ 424.448722] Testing event mm_page_alloc_zone_locked: OK [ 424.717078] Testing event mm_page_alloc: OK [ 424.957906] Testing event mm_page_free_batched: OK [ 425.268708] Testing event mm_page_free: OK [ 425.501421] Testing event kmem_cache_free: OK [ 425.754017] Testing event kfree: OK [ 426.037955] Testing event kmem_cache_alloc_node: OK [ 426.330218] Testing event kmalloc_node: OK [ 426.605267] Testing event kmem_cache_alloc: OK [ 426.859004] Testing event kmalloc: OK [ 427.121149] Testing event mm_compaction_kcompactd_wake: OK [ 427.380584] Testing event mm_compaction_wakeup_kcompactd: OK [ 427.624891] Testing event mm_compaction_kcompactd_sleep: OK [ 427.942141] Testing event mm_compaction_defer_reset: OK [ 428.212807] Testing event mm_compaction_defer_compaction: OK [ 428.433130] Testing event mm_compaction_deferred: OK [ 428.692640] Testing event mm_compaction_suitable: OK [ 429.032901] Testing event mm_compaction_finished: OK [ 429.284773] Testing event mm_compaction_try_to_compact_pages: OK [ 429.576894] Testing event mm_compaction_end: OK [ 429.837971] Testing event mm_compaction_begin: OK [ 430.072776] Testing event mm_compaction_migratepages: OK [ 430.358267] Testing event mm_compaction_isolate_freepages: OK [ 430.649473] Testing event mm_compaction_isolate_migratepages: OK [ 430.953893] Testing event mm_migrate_pages: OK [ 431.249427] Testing event mm_collapse_huge_page_swapin: OK [ 431.449828] Testing event mm_collapse_huge_page_isolate: OK [ 431.716975] Testing event mm_collapse_huge_page: OK [ 432.004743] Testing event mm_khugepaged_scan_pmd: OK [ 432.237316] Testing event test_pages_isolated: OK [ 432.513727] Testing event cma_release: OK [ 432.770088] Testing event cma_alloc: OK [ 433.036602] Testing event page_ref_unfreeze: OK [ 433.333779] Testing event page_ref_freeze: OK [ 433.642053] Testing event page_ref_mod_unless: OK [ 433.976910] Testing event page_ref_mod_and_return: OK [ 434.273276] Testing event page_ref_mod_and_test: OK [ 435.322123] Testing event page_ref_mod: OK [ 435.829969] Testing event page_ref_set: OK [ 436.161503] Testing event sb_clear_inode_writeback: OK [ 436.441990] Testing event sb_mark_inode_writeback: OK [ 436.673029] Testing event writeback_dirty_inode_enqueue: OK [ 436.946020] Testing event writeback_lazytime_iput: OK [ 437.244888] Testing event writeback_lazytime: OK [ 437.517970] Testing event writeback_single_inode: OK [ 437.773437] Testing event writeback_single_inode_start: OK [ 438.020823] Testing event writeback_wait_iff_congested: OK [ 438.241265] Testing event writeback_congestion_wait: OK [ 438.496565] Testing event writeback_sb_inodes_requeue: OK [ 438.800997] Testing event balance_dirty_pages: OK [ 439.032764] Testing event bdi_dirty_ratelimit: OK [ 439.369590] Testing event global_dirty_state: OK [ 439.620812] Testing event writeback_queue_io: OK [ 439.896547] Testing event wbc_writepage: OK [ 440.128627] Testing event writeback_bdi_register: OK [ 440.404636] Testing event writeback_wake_background: OK [ 440.658215] Testing event writeback_pages_written: OK [ 440.973969] Testing event writeback_wait: OK [ 441.223033] Testing event writeback_written: OK [ 441.458041] Testing event writeback_start: OK [ 441.717727] Testing event writeback_exec: OK [ 441.980679] Testing event writeback_queue: OK [ 442.228569] Testing event writeback_write_inode: OK [ 442.453205] Testing event writeback_write_inode_start: OK [ 442.762285] Testing event writeback_dirty_inode: OK [ 442.978075] Testing event writeback_dirty_inode_start: OK [ 443.277093] Testing event writeback_mark_inode_dirty: OK [ 443.512891] Testing event writeback_dirty_page: OK [ 443.765756] Testing event dax_writeback_one: OK [ 444.021164] Testing event dax_writeback_range_done: OK [ 444.332745] Testing event dax_writeback_range: OK [ 444.592588] Testing event dax_insert_mapping: OK [ 444.829059] Testing event dax_insert_pfn_mkwrite: OK [ 445.072902] Testing event dax_insert_pfn_mkwrite_no_entry: OK [ 445.368881] Testing event dax_load_hole: OK [ 445.605809] Testing event dax_pte_fault_done: OK [ 445.846210] Testing event dax_pte_fault: OK [ 446.128738] Testing event dax_pmd_insert_mapping: OK [ 446.406126] Testing event dax_pmd_load_hole_fallback: OK [ 446.654215] Testing event dax_pmd_load_hole: OK [ 446.921782] Testing event dax_pmd_fault_done: OK [ 447.193926] Testing event dax_pmd_fault: OK [ 447.481458] Testing event generic_add_lease: OK [ 447.689494] Testing event time_out_leases: OK [ 447.966102] Testing event generic_delete_lease: OK [ 448.208770] Testing event break_lease_unblock: OK [ 448.488775] Testing event break_lease_block: OK [ 448.716641] Testing event break_lease_noblock: OK [ 449.021735] Testing event flock_lock_inode: OK [ 449.290147] Testing event locks_remove_posix: OK [ 449.545180] Testing event fcntl_setlk: OK [ 449.773169] Testing event posix_lock_inode: OK [ 450.093524] Testing event locks_get_lock_context: OK [ 450.376847] Testing event block_rq_remap: OK [ 450.618083] Testing event block_bio_remap: OK [ 450.893077] Testing event block_split: OK [ 451.182129] Testing event block_unplug: OK [ 451.449104] Testing event block_plug: OK [ 451.733118] Testing event block_sleeprq: OK [ 451.945951] Testing event block_getrq: OK [ 452.194131] Testing event block_bio_queue: OK [ 452.425156] Testing event block_bio_frontmerge: OK [ 452.676593] Testing event block_bio_backmerge: OK [ 452.912793] Testing event block_bio_complete: OK [ 453.146112] Testing event block_bio_bounce: OK [ 453.425790] Testing event block_rq_issue: OK [ 453.703070] Testing event block_rq_insert: OK [ 453.961693] Testing event block_rq_complete: OK [ 454.218218] Testing event block_rq_requeue: OK [ 454.424975] Testing event block_dirty_buffer: OK [ 454.705478] Testing event block_touch_buffer: OK [ 454.985823] Testing event wbt_timer: OK [ 455.270084] Testing event wbt_step: OK [ 455.509718] Testing event wbt_lat: OK [ 455.798250] Testing event wbt_stat: OK [ 456.026050] Testing event gpio_value: OK [ 456.338240] Testing event gpio_direction: OK [ 456.633408] Testing event clk_set_duty_cycle_complete: OK [ 456.960799] Testing event clk_set_duty_cycle: OK [ 457.248581] Testing event clk_set_phase_complete: OK [ 457.506289] Testing event clk_set_phase: OK [ 457.760955] Testing event clk_set_parent_complete: OK [ 457.997548] Testing event clk_set_parent: OK [ 458.236802] Testing event clk_set_rate_complete: OK [ 458.493723] Testing event clk_set_rate: OK [ 458.742211] Testing event clk_unprepare_complete: OK [ 458.997772] Testing event clk_unprepare: OK [ 459.257247] Testing event clk_prepare_complete: OK [ 459.522238] Testing event clk_prepare: OK [ 459.794269] Testing event clk_disable_complete: OK [ 460.086027] Testing event clk_disable: OK [ 460.337400] Testing event clk_enable_complete: OK [ 460.652755] Testing event clk_enable: OK [ 460.893990] Testing event rpmh_send_msg: OK [ 461.137803] Testing event rpmh_tx_done: OK [ 461.405745] Testing event regulator_set_voltage_complete: OK [ 461.646283] Testing event regulator_set_voltage: OK [ 462.017641] Testing event regulator_disable_complete: OK [ 462.264921] Testing event regulator_disable: OK [ 462.500649] Testing event regulator_enable_complete: OK [ 462.788924] Testing event regulator_enable_delay: OK [ 463.020993] Testing event regulator_enable: OK [ 463.293834] Testing event urandom_read: OK [ 463.605700] Testing event random_read: OK [ 463.941813] Testing event extract_entropy_user: OK [ 464.261778] Testing event extract_entropy: OK [ 464.554165] Testing event get_random_bytes_arch: OK [ 464.870289] Testing event get_random_bytes: OK [ 465.201270] Testing event xfer_secondary_pool: OK [ 465.505133] Testing event add_disk_randomness: OK [ 465.749308] Testing event add_input_randomness: OK [ 465.982141] Testing event debit_entropy: OK [ 466.256628] Testing event push_to_pool: OK [ 466.525246] Testing event credit_entropy_bits: OK [ 466.769396] Testing event mix_pool_bytes_nolock: OK [ 467.065018] Testing event mix_pool_bytes: OK [ 467.322299] Testing event add_device_randomness: OK [ 467.568752] Testing event io_page_fault: OK [ 467.841860] Testing event unmap: OK [ 468.142070] Testing event map: OK [ 468.397807] Testing event detach_device_from_domain: OK [ 468.616736] Testing event attach_device_to_domain: OK [ 468.891093] Testing event remove_device_from_group: OK [ 469.177445] Testing event add_device_to_group: OK [ 469.400726] Testing event regcache_drop_region: OK [ 469.673756] Testing event regmap_async_complete_done: OK [ 469.912866] Testing event regmap_async_complete_start: OK [ 470.221974] Testing event regmap_async_io_complete: OK [ 470.440772] Testing event regmap_async_write_start: OK [ 470.733452] Testing event regmap_cache_bypass: OK [ 471.016777] Testing event regmap_cache_only: OK [ 471.256647] Testing event regcache_sync: OK [ 471.502118] Testing event regmap_hw_write_done: OK [ 471.777191] Testing event regmap_hw_write_start: OK [ 472.013610] Testing event regmap_hw_read_done: OK [ 472.316712] Testing event regmap_hw_read_start: OK [ 472.580861] Testing event regmap_reg_read_cache: OK [ 472.817639] Testing event regmap_reg_read: OK [ 473.121502] Testing event regmap_reg_write: OK [ 473.424942] Testing event dma_fence_wait_end: OK [ 473.729900] Testing event dma_fence_wait_start: OK [ 473.984634] Testing event dma_fence_signaled: OK [ 474.220734] Testing event dma_fence_enable_signal: OK [ 474.549929] Testing event dma_fence_destroy: OK [ 474.804817] Testing event dma_fence_init: OK [ 475.030298] Testing event dma_fence_emit: OK [ 475.293548] Testing event sync_timeline: OK [ 475.585615] Testing event spi_transfer_stop: OK [ 475.830285] Testing event spi_transfer_start: OK [ 476.085188] Testing event spi_message_done: OK [ 476.373345] Testing event spi_message_start: OK [ 476.621649] Testing event spi_message_submit: OK [ 476.861261] Testing event spi_controller_busy: OK [ 477.112808] Testing event spi_controller_idle: OK [ 477.343098] Testing event rtc_timer_fired: OK [ 477.613415] Testing event rtc_timer_dequeue: OK [ 477.877686] Testing event rtc_timer_enqueue: OK [ 478.141474] Testing event rtc_read_offset: OK [ 478.456820] Testing event rtc_set_offset: OK [ 478.716599] Testing event rtc_alarm_irq_enable: OK [ 478.940978] Testing event rtc_irq_set_state: OK [ 479.182091] Testing event rtc_irq_set_freq: OK [ 479.433062] Testing event rtc_read_alarm: OK [ 479.697552] Testing event rtc_set_alarm: OK [ 479.949872] Testing event rtc_read_time: OK [ 480.189534] Testing event rtc_set_time: OK [ 480.441891] Testing event memory_failure_event: OK [ 480.698001] Testing event aer_event: OK [ 480.957857] Testing event non_standard_event: OK [ 481.234179] Testing event arm_event: OK [ 481.449426] Testing event mc_event: OK [ 481.713146] Testing event binder_return: OK [ 481.958040] Testing event binder_command: OK [ 482.222091] Testing event binder_unmap_kernel_end: OK [ 482.484964] Testing event binder_unmap_kernel_start: OK [ 482.750112] Testing event binder_unmap_user_end: OK [ 483.021540] Testing event binder_unmap_user_start: OK [ 483.302263] Testing event binder_alloc_page_end: OK [ 483.575090] Testing event binder_alloc_page_start: OK [ 483.832767] Testing event binder_free_lru_end: OK [ 484.146116] Testing event binder_free_lru_start: OK [ 484.493878] Testing event binder_alloc_lru_end: OK [ 484.750285] Testing event binder_alloc_lru_start: OK [ 485.025798] Testing event binder_update_page_range: OK [ 485.277172] Testing event binder_transaction_failed_buffer_release: OK [ 485.493773] Testing event binder_transaction_buffer_release: OK [ 485.764915] Testing event binder_transaction_alloc_buf: OK [ 486.005719] Testing event binder_transaction_fd_recv: OK [ 486.317575] Testing event binder_transaction_fd_send: OK [ 486.557623] Testing event binder_transaction_ref_to_ref: OK [ 486.824961] Testing event binder_transaction_ref_to_node: OK [ 487.064520] Testing event binder_transaction_node_to_ref: OK [ 487.326259] Testing event binder_transaction_received: OK [ 487.545899] Testing event binder_transaction: OK [ 487.796559] Testing event binder_wait_for_work: OK [ 488.061084] Testing event binder_read_done: OK [ 488.309243] Testing event binder_write_done: OK [ 488.543097] Testing event binder_ioctl_done: OK [ 488.801122] Testing event binder_unlock: OK [ 489.033661] Testing event binder_locked: OK [ 489.316982] Testing event binder_lock: OK [ 489.541907] Testing event binder_ioctl: OK [ 489.805727] Testing event br_fdb_update: OK [ 490.057027] Testing event fdb_delete: OK [ 490.305054] Testing event br_fdb_external_learn_add: OK [ 490.561131] Testing event br_fdb_add: OK [ 490.825218] Testing event qdisc_dequeue: OK [ 491.065768] Testing event fib_table_lookup: OK [ 491.374035] Testing event tcp_probe: OK [ 491.614181] Testing event tcp_retransmit_synack: OK [ 491.837044] Testing event tcp_rcv_space_adjust: OK [ 492.122093] Testing event tcp_destroy_sock: OK [ 492.373723] Testing event tcp_receive_reset: OK [ 492.654027] Testing event tcp_send_reset: OK [ 492.937402] Testing event tcp_retransmit_skb: OK [ 493.193436] Testing event udp_fail_queue_rcv_skb: OK [ 493.417088] Testing event inet_sock_set_state: OK [ 493.694293] Testing event sock_exceed_buf_limit: OK [ 493.953027] Testing event sock_rcvqueue_full: OK [ 494.261863] Testing event napi_poll: OK [ 494.525421] Testing event netif_rx_ni_entry: OK [ 494.737661] Testing event netif_rx_entry: OK [ 494.985197] Testing event netif_receive_skb_list_entry: OK [ 495.241999] Testing event netif_receive_skb_entry: OK [ 495.498207] Testing event napi_gro_receive_entry: OK [ 495.781978] Testing event napi_gro_frags_entry: OK [ 496.021752] Testing event netif_rx: OK [ 496.333438] Testing event netif_receive_skb: OK [ 496.561915] Testing event net_dev_queue: OK [ 496.877607] Testing event net_dev_xmit: OK [ 497.133932] Testing event net_dev_start_xmit: OK [ 497.440979] Testing event skb_copy_datagram_iovec: OK [ 497.697534] Testing event consume_skb: OK [ 497.945390] Testing event kfree_skb: OK [ 498.216927] Testing event 9p_protocol_dump: OK [ 498.549363] Testing event 9p_client_res: OK [ 498.793992] Testing event 9p_client_req: OK [ 499.009072] Running tests on trace event systems: [ 499.017325] Testing event system 9p: OK [ 499.369483] Testing event system skb: OK [ 499.678176] Testing event system net: OK [ 500.073368] Testing event system napi: OK [ 500.410201] Testing event system sock: OK [ 500.681112] Testing event system udp: OK [ 500.921926] Testing event system tcp: OK [ 501.249588] Testing event system fib: OK [ 501.565142] Testing event system qdisc: OK [ 501.830000] Testing event system bridge: OK [ 502.073335] Testing event system binder: OK [ 502.600966] Testing event system ras: OK [ 503.021187] Testing event system rtc: OK [ 503.445214] Testing event system spi: OK [ 503.769395] Testing event system sync_trace: OK [ 504.117405] Testing event system dma_fence: OK [ 504.477734] Testing event system regmap: OK [ 504.901919] Testing event system iommu: OK [ 505.293650] Testing event system random: OK [ 505.685806] Testing event system regulator: OK [ 506.137135] Testing event system rpmh: OK [ 506.461469] Testing event system clk: OK [ 506.901953] Testing event system gpio: OK [ 507.249152] Testing event system wbt: OK [ 507.553149] Testing event system block: OK [ 507.974006] Testing event system filelock: OK [ 508.456786] Testing event system fs_dax: OK [ 508.849889] Testing event system writeback: OK [ 509.445328] Testing event system page_ref: OK [ 511.014306] Testing event system cma: OK [ 511.400308] Testing event system page_isolation: OK [ 511.701547] Testing event system huge_memory: OK [ 512.002182] Testing event system migrate: OK [ 512.349726] Testing event system compaction: OK [ 512.694073] Testing event system kmem: OK [ 513.153339] Testing event system percpu: OK [ 513.521981] Testing event system vmscan: OK [ 513.941471] Testing event system pagemap: OK [ 514.309051] Testing event system oom: OK [ 514.660950] Testing event system filemap: OK [ 515.013857] Testing event system rseq: OK [ 515.305292] Testing event system xdp: OK [ 515.709577] Testing event system benchmark: OK [ 516.185819] Testing event system rpm: OK [ 516.501141] Testing event system power: OK [ 517.081025] Testing event system test: OK [ 517.498164] Testing event system preemptirq: OK [ 518.093541] Testing event system cgroup: OK [ 518.574013] Testing event system module: OK [ 518.905993] Testing event system alarmtimer: OK [ 519.194238] Testing event system timer: OK [ 519.717586] Testing event system swiotlb: OK [ 519.957776] Testing event system rcu: OK [ 520.577725] Testing event system printk: OK [ 520.996879] Testing event system lock: OK [ 521.389437] Testing event system sched: OK [ 521.961481] Testing event system workqueue: OK [ 522.449416] Testing event system signal: OK [ 522.769901] Testing event system irq: OK [ 523.037418] Testing event system cpuhp: OK [ 523.393402] Testing event system task: OK [ 523.661183] Testing event system kvm: OK [ 524.209667] Testing event system emulation: OK [ 524.670186] Testing event system ipi: OK [ 525.010235] Testing event system syscalls: OK [ 525.553958] Testing event system raw_syscalls: OK [ 525.837194] Testing event system initcall: OK [ 526.150022] Running tests on all trace events: [ 526.161046] Testing all events: OK [ 560.484421] ftrace_replace_code: 1 [ 571.189232] ../kernel/trace/ftrace.c:2442, loop_counter: 42031 [ 571.199482] Testing ftrace filter: OK [ 571.408333] trace_kprobe: Testing kprobe tracing: OK [ 572.265249] Loading compiled-in X.509 certificates [ 572.424833] _warn_unseeded_randomness: 3 callbacks suppressed [ 572.425150] random: get_random_bytes called from key_alloc+0x500/0xa48 with crng_init=0 [ 572.429264] Loaded X.509 cert 'Build time autogenerated kernel key: ef4425a12675de91b49c005bf61fbcc152bd6e38' [ 572.456505] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 572.457824] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 572.511716] zswap: default zpool zbud not available [ 572.512936] zswap: pool creation failed [ 572.557536] page_owner is disabled [ 572.609016] kworker/u2:1 (1258) used greatest stack depth: 10640 bytes left [ 572.838944] Key type big_key registered [ 572.961816] Key type encrypted registered [ 572.969488] ima: No TPM chip found, activating TPM-bypass! [ 572.972985] ima: Allocated hash algorithm: sha1 [ 572.977580] No architecture policies found [ 572.989860] evm: Initialising EVM extended attributes: [ 572.991324] evm: security.selinux [ 572.992009] evm: security.SMACK64 [ 572.992595] evm: security.SMACK64EXEC [ 572.993191] evm: security.SMACK64TRANSMUTE [ 572.993800] evm: security.SMACK64MMAP [ 572.995111] evm: security.apparmor [ 572.995703] evm: security.ima [ 572.996296] evm: security.capability [ 572.996900] evm: HMAC attrs: 0x1 [ 573.095797] hctosys: unable to open rtc device (rtc0) [ 573.130226] psci_checker: PSCI checker started using 1 CPUs [ 573.131614] psci_checker: Starting hotplug tests [ 573.133479] psci_checker: Trying to turn off and on again all CPUs [ 573.135389] psci_checker: Trying to turn off and on again group 0 (CPUs 0) [ 573.137093] psci_checker: Hotplug tests passed OK [ 573.137769] psci_checker: Starting suspend tests (10 cycles per state) [ 573.139533] psci_checker: cpuidle not available on CPU 0, ignoring [ 573.140782] psci_checker: Could not start suspend tests on any CPU [ 573.141486] psci_checker: PSCI checker completed [ 573.228228] Duplicate name in testcase-data, renamed to "duplicate-name#1" [ 573.551568] ### dt-test ### start of unittest - you will see error messages [ 573.599201] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 573.600545] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 573.601835] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 573.603638] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 573.604793] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property [ 573.605901] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property [ 573.637495] OF: /testcase-data/phandle-tests/consumer-b: could not get #phandle-missing-cells for /testcase-data/phandle-tests/provider1 [ 573.641017] OF: /testcase-data/phandle-tests/consumer-b: could not find phandle [ 573.644423] OF: /testcase-data/phandle-tests/consumer-b: arguments longer than property [ 574.059022] _warn_unseeded_randomness: 2 callbacks suppressed [ 574.059285] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 574.060744] kobject: 'testcase-data:platform-tests:test-device@1' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 574.087285] kobject: 'testcase-data:platform-tests:test-device@0' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 574.105719] kobject: 'unittest-bus.0' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 574.211420] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 574.366171] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest0/status [ 574.452258] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest1/status [ 574.478280] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 574.480222] kobject: 'testcase-data:overlay-node:test-bus:test-unittest1' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 574.495692] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest2/status [ 574.576898] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest3/status [ 574.600502] kobject: 'testcase-data:overlay-node:test-bus:test-unittest3' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 574.711492] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest5/status [ 574.807601] kobject: 'testcase-data:overlay-node:test-bus:test-unittest5' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 574.827855] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest6/status [ 574.903380] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest7/status [ 575.000681] kobject: 'testcase-data:overlay-node:test-bus:test-unittest7' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 575.026096] kobject: 'testcase-data:overlay-node:test-bus:test-unittest6' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 575.043026] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/status [ 575.117463] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/property-foo [ 575.119666] _warn_unseeded_randomness: 6 callbacks suppressed [ 575.119998] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 575.123578] OF: overlay: node_overlaps_later_cs: #6 overlaps with #7 @/testcase-data/overlay-node/test-bus/test-unittest8 [ 575.124829] OF: overlay: overlay #6 is not topmost [ 575.151921] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 575.152987] kobject: 'testcase-data:overlay-node:test-bus:test-unittest8' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 575.169229] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 575.573444] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11:test-unittest111' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 575.596557] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 575.599637] 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 [ 575.603268] 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 [ 575.606210] OF: overlay: remove: Could not find overlay #7 [ 575.607663] ### dt-test ### of_unittest_destroy_tracked_overlays: no overlay to destroy for #7 [ 575.640028] kobject: 'testcase-data:overlay-node:test-bus:test-unittest10:test-unittest101' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 575.662138] kobject: 'testcase-data:overlay-node:test-bus:test-unittest10' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 575.665165] 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-unittest10/test-unittest101 [ 575.668802] 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-unittest10 [ 575.696647] kobject: 'testcase-data:overlay-node:test-bus:test-unittest4' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 575.699645] 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-unittest4 [ 575.793007] kobject: 'testcase-data:overlay-node:test-bus:test-unittest2' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 575.887325] kobject: 'testcase-data:overlay-node:test-bus:test-unittest0' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 576.009208] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/status [ 576.017667] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/status [ 576.021470] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/ride@100/track@30/incline-up [ 576.024175] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/ride@100/track@40/incline-up [ 576.044801] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/status [ 576.047120] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/color [ 576.048807] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/rate [ 576.052008] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/hvac_2 [ 576.053883] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200 [ 576.056707] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200_left [ 576.059293] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200_right [ 576.244410] OF: overlay: ERROR: multiple fragments add and/or delete node /testcase-data-2/substation@100/motor-1/controller [ 576.251509] OF: overlay: ERROR: multiple fragments add, update, and/or delete property /testcase-data-2/substation@100/motor-1/controller/name [ 576.253981] _warn_unseeded_randomness: 4 callbacks suppressed [ 576.254272] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 576.256361] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 576.259288] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 576.272665] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/motor-1/rpm_avail [ 576.275179] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/motor-1/rpm_avail [ 576.277200] OF: overlay: ERROR: multiple fragments add, update, and/or delete property /testcase-data-2/substation@100/motor-1/rpm_avail [ 576.299487] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 576.305031] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 576.305937] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 576.309060] ### dt-test ### end of unittest - 217 passed, 0 failed [ 576.360272] uart-pl011 9000000.pl011: no DMA platform data [ 576.936790] kobject: 'test-unittest4' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 576.985903] VFS: Mounted root (9p filesystem) readonly on device 0:19. [ 577.019571] devtmpfs: mounted [ 577.066117] integrity: Unable to open file: /etc/keys/x509_ima.der (-2) [ 577.096568] integrity: Unable to open file: /etc/keys/x509_evm.der (-2) [ 578.535955] Freeing unused kernel memory: 6144K [ 579.212048] Checked W+X mappings: passed, no W+X pages found [ 579.213022] rodata_test: all tests were successful [ 579.214183] Run /sbin/init as init process [ 579.221323] _warn_unseeded_randomness: 5 callbacks suppressed [ 579.221584] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 579.223737] kobject: 'test-unittest101' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 579.228395] kobject: 'test-unittest11' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 579.232229] kobject: 'test-unittest111' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 579.235908] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest4 [ 579.321217] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 579.472468] random: get_random_u64 called from arch_mmap_rnd+0xb8/0xd0 with crng_init=0 [ 579.843941] kobject: 'test-unittest10' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 580.868318] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest10 [ 581.250294] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest11 [ 581.282642] random: fast init done [ 582.400528] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest11/test-unittest111 [ 582.404542] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest10/test-unittest101 SELinux: Could not open policy file <= /etc/selinux/targeted/policy/policy.31: No such file or directory