[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty (anders@compilator) (gcc version 7.3.1 20180425 [linaro-7.3-2018.05 revision d29120a424ecfbc167ef90065c0eeb7f91977701] (Linaro GCC 7.3-2018.05)) #75 SMP Tue Dec 4 13:46:29 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/0x7d8 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: 970112K/2097152K available (25768K kernel code, 16866K rwdata, 4884K rodata, 6144K init, 23472K bss, 117416K 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 42037 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.000263] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns [ 0.021681] Console: colour dummy device 80x25 [ 0.028299] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.029004] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.029587] ... MAX_LOCK_DEPTH: 48 [ 0.030783] ... MAX_LOCKDEP_KEYS: 8191 [ 0.031365] ... CLASSHASH_SIZE: 4096 [ 0.031979] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.032567] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.033159] ... CHAINHASH_SIZE: 32768 [ 0.033745] memory used by lock dependency info: 7775 kB [ 0.034373] per task-struct memory footprint: 2688 bytes [ 0.035518] ------------------------ [ 0.036047] | Locking API testsuite: [ 0.036591] ---------------------------------------------------------------------------- [ 0.037294] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.037996] -------------------------------------------------------------------------- [ 0.039740] A-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.053730] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.067555] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.083090] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.098334] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.115487] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.132879] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.150368] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.162992] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.174537] -------------------------------------------------------------------------- [ 0.175805] recursive read-lock: | ok | | ok | [ 0.180082] recursive read-lock #2: | ok | | ok | [ 0.184335] mixed read-write-lock: | ok | | ok | [ 0.188789] mixed write-read-lock: | ok | | ok | [ 0.193147] mixed read-lock/lock-write ABBA: |FAILED| | ok | [ 0.197322] mixed read-lock/lock-read ABBA: | ok | | ok | [ 0.201947] mixed write-lock/lock-write ABBA: | ok | | ok | [ 0.206626] -------------------------------------------------------------------------- [ 0.207776] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.213655] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.220323] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.226264] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.232314] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.238933] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.245072] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.251156] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.258009] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.264136] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.270838] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.277215] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.284375] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.290880] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.298062] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.304516] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.311725] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.318132] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.325246] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.331257] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.337409] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.344282] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.351346] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.357773] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.364960] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.371372] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.378544] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.384931] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.392076] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.398489] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.405567] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.412054] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.419262] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.425601] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.432547] hard-irq lock-inversion/123: ok | ok | ok | [ 0.439049] soft-irq lock-inversion/123: ok | ok | ok | [ 0.446085] hard-irq lock-inversion/132: ok | ok | ok | [ 0.452478] soft-irq lock-inversion/132: ok | ok | ok | [ 0.459761] hard-irq lock-inversion/213: ok | ok | ok | [ 0.466197] soft-irq lock-inversion/213: ok | ok | ok | [ 0.473407] hard-irq lock-inversion/231: ok | ok | ok | [ 0.479803] soft-irq lock-inversion/231: ok | ok | ok | [ 0.487047] hard-irq lock-inversion/312: ok | ok | ok | [ 0.493404] soft-irq lock-inversion/312: ok | ok | ok | [ 0.500511] hard-irq lock-inversion/321: ok | ok | ok | [ 0.506909] soft-irq lock-inversion/321: ok | ok | ok | [ 0.513949] hard-irq read-recursion/123: ok | [ 0.516434] soft-irq read-recursion/123: ok | [ 0.519546] hard-irq read-recursion/132: ok | [ 0.522054] soft-irq read-recursion/132: ok | [ 0.525157] hard-irq read-recursion/213: ok | [ 0.528179] soft-irq read-recursion/213: ok | [ 0.530814] hard-irq read-recursion/231: ok | [ 0.533813] soft-irq read-recursion/231: ok | [ 0.536837] hard-irq read-recursion/312: ok | [ 0.539363] soft-irq read-recursion/312: ok | [ 0.542418] hard-irq read-recursion/321: ok | [ 0.545396] soft-irq read-recursion/321: ok | [ 0.548014] -------------------------------------------------------------------------- [ 0.549209] | Wound/wait tests | [ 0.549695] --------------------- [ 0.550259] ww api failures: ok | ok | ok | [ 0.558839] ww contexts mixing: ok | ok | [ 0.563170] finishing ww context: ok | ok | ok | ok | [ 0.570844] locking mismatches: ok | ok | ok | [ 0.577304] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.597922] spinlock nest unlocked: ok | [ 0.600694] ----------------------------------------------------- [ 0.601354] |block | try |context| [ 0.601970] ----------------------------------------------------- [ 0.602592] context: ok | ok | ok | [ 0.609496] try: ok | ok | ok | [ 0.615282] block: ok | ok | ok | [ 0.620995] spinlock: ok | ok | ok | [ 0.628077] ------------------------------------------------------- [ 0.628710] Good, all 261 testcases passed! | [ 0.629313] --------------------------------- [ 0.637325] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000) [ 0.638403] pid_max: default: 32768 minimum: 301 [ 0.655622] LSM: Security Framework initializing [ 0.656685] Yama: becoming mindful. [ 0.660738] LoadPin: ready to pin (currently enforcing) [ 0.661947] SELinux: Initializing. [ 0.675622] *** VALIDATE SELinux *** [ 0.677280] AppArmor: AppArmor disabled by boot time parameter [ 0.733086] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.755023] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.759830] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.761508] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.823486] *** VALIDATE proc *** [ 0.855196] *** VALIDATE cgroup1 *** [ 0.855829] *** VALIDATE cgroup2 *** [ 0.966370] ASID allocator initialised with 32768 entries [ 0.983535] rcu: Hierarchical SRCU implementation. [ 1.119418] EFI services will not be available. [ 1.165107] smp: Bringing up secondary CPUs ... [ 1.165868] smp: Brought up 1 node, 1 CPU [ 1.166535] SMP: Total of 1 processors activated. [ 1.167979] CPU features: detected: 32-bit EL0 Support [ 1.168702] CPU features: detected: CRC32 instructions [ 1.540091] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching [ 1.541196] CPU: All CPU(s) started at EL1 [ 1.542526] alternatives: patching kernel code [ 1.544500] _warn_unseeded_randomness: 98 callbacks suppressed [ 1.544983] random: get_random_u64 called from compute_layout+0x138/0x1b8 with crng_init=0 [ 1.605247] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 5.928632] node 0 initialised, 248310 pages in 4ms [ 5.941737] ================================================================================ [ 5.942619] UBSAN: Undefined behaviour in ../kernel/exit.c:735:2 [ 5.943220] member access within misaligned address ffffff80080b97d8 for type 'struct task_struct' [ 5.943758] which requires 64 byte alignment [ 5.944712] CPU: 0 PID: 15 Comm: pgdatinit0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 5.945323] Hardware name: linux,dummy-virt (DT) [ 5.945876] Call trace: [ 5.946362] dump_backtrace+0x0/0x308 [ 5.946842] show_stack+0x28/0x38 [ 5.947278] __dump_stack+0x24/0x2c [ 5.947766] dump_stack+0xf8/0x16c [ 5.948260] ubsan_epilogue+0x18/0x50 [ 5.948743] handle_misaligned_access+0x94/0xc8 [ 5.949259] ubsan_type_mismatch_common+0x60/0x90 [ 5.949785] __ubsan_handle_type_mismatch+0x50/0x74 [ 5.950310] exit_notify+0x568/0x5d0 [ 5.950787] do_exit+0xabc/0xf60 [ 5.951299] __kthread_init_worker+0x0/0x150 [ 5.951810] ret_from_fork+0x10/0x18 [ 5.952279] ================================================================================ [ 5.954519] pgdatinit0 (15) used greatest stack depth: 12720 bytes left [ 5.969875] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 6.084946] devtmpfs: initialized [ 6.384984] workqueue: round-robin CPU selection forced, expect performance impact [ 6.437223] gcov: version magic: 0x4137332a [ 6.474236] Registered cp15_barrier emulation handler [ 6.475375] Registered setend emulation handler [ 17.858238] DMA-API: preallocated 65536 debug entries [ 17.858880] DMA-API: debugging enabled by kernel config [ 17.861362] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 17.865407] futex hash table entries: 256 (order: 3, 32768 bytes) [ 17.873919] Running postponed tracer tests: [ 17.876433] Testing tracer function: [ 17.878097] ================================================================================ [ 17.879066] UBSAN: Undefined behaviour in ../kernel/sched/fair.c:7432:2 [ 17.879559] member access within misaligned address ffffffc07ebe4f68 for type 'struct cfs_rq' [ 17.880076] which requires 64 byte alignment [ 17.880599] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 17.881195] Hardware name: linux,dummy-virt (DT) [ 17.881562] Call trace: [ 17.882000] dump_backtrace+0x0/0x308 [ 17.882453] show_stack+0x28/0x38 [ 17.882912] __dump_stack+0x24/0x2c [ 17.883378] dump_stack+0xf8/0x16c [ 17.883836] ubsan_epilogue+0x18/0x50 [ 17.884299] handle_misaligned_access+0x94/0xc8 [ 17.884770] ubsan_type_mismatch_common+0x60/0x90 [ 17.885276] __ubsan_handle_type_mismatch+0x50/0x74 [ 17.885783] update_blocked_averages+0x24a8/0x2928 [ 17.886318] idle_balance+0x5c8/0xd68 [ 17.886818] pick_next_task_fair+0x760/0x7b8 [ 17.887309] __schedule+0x74c/0x15b8 [ 17.887776] schedule+0x154/0x210 [ 17.888261] schedule_timeout+0xe88/0xef8 [ 17.888789] schedule_timeout_uninterruptible+0x7c/0x90 [ 17.889336] msleep+0x3c/0x58 [ 17.889801] trace_selftest_startup_function+0x140/0x4dc [ 17.890375] run_tracer_selftest+0x300/0x4a4 [ 17.890881] init_trace_selftests+0x29c/0x8b8 [ 17.891380] do_one_initcall+0x4c8/0xa50 [ 17.891887] do_initcall_level+0xbcc/0xca4 [ 17.892392] do_initcalls+0x64/0xa8 [ 17.892882] do_basic_setup+0x44/0x70 [ 17.893353] kernel_init_freeable+0x2d8/0x420 [ 17.893869] kernel_init+0x28/0x140 [ 17.894349] ret_from_fork+0x10/0x18 [ 17.894741] ================================================================================ [ 17.930383] ftrace_replace_code: 1 [ 28.489078] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 28.689138] ftrace_replace_code: 1 [ 38.305581] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 38.310561] PASSED [ 38.311110] Testing dynamic ftrace: [ 40.564324] ftrace_replace_code: 1 [ 40.681267] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 40.927986] PASSED [ 40.928771] Testing dynamic ftrace ops #1: [ 49.905107] ftrace_replace_code: 1 [ 50.028033] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 50.033524] (1 0 1 0 0) [ 50.033743] (1 1 2 0 0) [ 50.051230] ftrace_replace_code: 1 [ 63.564444] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 63.568223] (2 1 3 0 978333) [ 63.568511] (2 2 4 0 978348) [ 63.588009] ftrace_replace_code: 1 [ 74.234885] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 74.254248] ftrace_replace_code: 1 [ 74.368790] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 74.374456] ftrace_replace_code: 1 [ 74.487525] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 74.495337] PASSED [ 74.495839] Testing dynamic ftrace ops #2: [ 83.449633] ftrace_replace_code: 1 [ 83.576890] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 83.582003] ftrace_replace_code: 1 [ 83.696144] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 83.723115] ftrace_replace_code: 1 [ 96.431140] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 96.434534] (1 0 1 962640 0) [ 96.434774] (1 1 2 962655 0) [ 96.455533] (2 1 3 1 705) [ 96.458065] (2 2 4 351 1055) [ 96.511898] ftrace_replace_code: 1 [ 106.111810] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 106.115060] PASSED [ 106.115564] Testing ftrace recursion: [ 108.358653] ftrace_replace_code: 1 [ 108.474596] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 108.479910] ftrace_replace_code: 1 [ 108.593828] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 108.596082] PASSED [ 108.596575] Testing ftrace recursion safe: [ 110.837072] ftrace_replace_code: 1 [ 110.953030] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 110.958413] ftrace_replace_code: 1 [ 111.073164] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 111.075554] PASSED [ 111.076732] Testing ftrace regs(no arch support): [ 113.318689] ftrace_replace_code: 1 [ 113.434874] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 113.440112] ftrace_replace_code: 1 [ 113.553389] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 113.556552] PASSED [ 113.557589] Testing tracer nop: PASSED [ 113.560852] Testing tracer irqsoff: [ 113.583347] ftrace_replace_code: 1 [ 124.230002] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 124.263363] ftrace_replace_code: 1 [ 133.861898] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 133.865435] PASSED [ 133.868590] Testing tracer wakeup: [ 133.909452] ftrace_replace_code: 1 [ 144.563827] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 144.609769] ftrace_replace_code: 1 [ 145.062813] sched: DL replenish lagged too much [ 154.225853] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 154.236476] PASSED [ 154.237519] Testing tracer wakeup_rt: [ 154.276634] ftrace_replace_code: 1 [ 164.933597] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 164.969682] ftrace_replace_code: 1 [ 174.576119] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 174.586066] PASSED [ 174.587149] Testing tracer wakeup_dl: [ 174.625425] ftrace_replace_code: 1 [ 185.309712] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 185.350316] ftrace_replace_code: 1 [ 194.976660] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 194.986555] PASSED [ 194.989642] Testing tracer function_graph: [ 195.026329] ftrace_replace_code: 1 [ 205.581655] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 206.036449] ftrace_replace_code: 1 [ 217.879917] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 217.884193] PASSED [ 218.117797] _warn_unseeded_randomness: 7 callbacks suppressed [ 218.118100] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 218.119822] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 218.123397] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 218.153009] prandom: seed boundary self test passed [ 218.205708] prandom: 100 self tests passed [ 218.214960] pinctrl core: initialized pinctrl subsystem [ 218.350841] ================================================================================ [ 218.351708] UBSAN: Undefined behaviour in ../drivers/base/devres.c:505:2 [ 218.352338] member access within misaligned address ffffff800804b8d8 for type 'struct devres' [ 218.352924] which requires 128 byte alignment [ 218.353506] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 218.354074] Hardware name: linux,dummy-virt (DT) [ 218.354524] Call trace: [ 218.355034] dump_backtrace+0x0/0x308 [ 218.355592] show_stack+0x28/0x38 [ 218.356121] __dump_stack+0x24/0x2c [ 218.356606] dump_stack+0xf8/0x16c [ 218.357086] ubsan_epilogue+0x18/0x50 [ 218.357674] handle_misaligned_access+0x94/0xc8 [ 218.358330] ubsan_type_mismatch_common+0x60/0x90 [ 218.358973] __ubsan_handle_type_mismatch+0x50/0x74 [ 218.359566] release_nodes+0x94/0x180 [ 218.360112] devres_release_all+0xa0/0xc0 [ 218.360638] really_probe+0x69c/0xd48 [ 218.361159] really_probe_debug+0x3c/0x128 [ 218.361696] driver_probe_device+0x1f8/0x2a0 [ 218.362235] __driver_attach+0x250/0x340 [ 218.362807] bus_for_each_dev+0x110/0x180 [ 218.363335] driver_attach+0x50/0x60 [ 218.363833] bus_add_driver+0x308/0x4f0 [ 218.364342] driver_register+0x2a0/0x330 [ 218.364902] __platform_driver_register+0xcc/0xe0 [ 218.365490] regulator_dummy_init+0x100/0x174 [ 218.366060] regulator_init+0xf0/0x128 [ 218.366580] do_one_initcall+0x4c8/0xa50 [ 218.367128] do_initcall_level+0xbcc/0xca4 [ 218.367674] do_initcalls+0x64/0xa8 [ 218.368194] do_basic_setup+0x44/0x70 [ 218.368712] kernel_init_freeable+0x2d8/0x420 [ 218.369244] kernel_init+0x28/0x140 [ 218.369739] ret_from_fork+0x10/0x18 [ 218.370167] ================================================================================ [ 218.392023] regulator-dummy: Failed to create debugfs directory [ 218.405727] [ 218.406907] ************************************************************* [ 218.407575] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 218.408266] ** ** [ 218.408943] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 218.409623] ** ** [ 218.410307] ** This means that this kernel is built to expose internal ** [ 218.411646] ** IOMMU data structures, which may compromise security on ** [ 218.412344] ** your system. ** [ 218.413051] ** ** [ 218.413758] ** If you see this message and you are not debugging the ** [ 218.414470] ** kernel, report this immediately to your vendor! ** [ 218.415161] ** ** [ 218.416421] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 218.417126] ************************************************************* [ 218.462056] DMI not present or invalid. [ 218.540049] NET: Registered protocol family 16 [ 218.581690] audit: initializing netlink subsys (disabled) [ 218.796621] cpuidle: using governor ladder [ 218.799417] cpuidle: using governor menu [ 218.830544] vdso: 2 pages (1 code @ (____ptrval____), 1 data @ (____ptrval____)) [ 218.833416] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 218.838708] audit: type=2000 audit(187.908:1): state=initialized audit_enabled=0 res=1 [ 219.064266] DMA: preallocated 256 KiB pool for atomic allocations [ 219.196137] Serial: AMBA PL011 UART driver [ 220.369182] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 39, base_baud = 0) is a PL011 rev1 [ 220.373447] printk: console [ttyAMA0] enabled [ 220.373447] printk: console [ttyAMA0] enabled [ 220.374901] printk: bootconsole [pl11] disabled [ 220.374901] printk: bootconsole [pl11] disabled [ 220.532758] _warn_unseeded_randomness: 42 callbacks suppressed [ 220.533046] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 220.535943] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 221.317581] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 221.404971] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 221.614420] kobject: 'renesas,r9a06g032-sysctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 221.629857] kobject: 'renesas-cpg-mssr' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 221.645873] _warn_unseeded_randomness: 32 callbacks suppressed [ 221.646152] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 221.688652] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 221.697019] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 221.713330] arm-v7s io-pgtable: self test ok [ 221.716076] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 32 [ 221.726608] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 36 [ 221.734322] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 40 [ 221.742995] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 42 [ 221.753382] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 44 [ 221.761931] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 48 [ 221.771043] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 32 [ 221.784027] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 36 [ 221.799038] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 40 [ 221.814150] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 42 [ 221.830195] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 44 [ 221.845339] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 48 [ 221.863447] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 32 [ 221.902068] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 36 [ 221.940995] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 40 [ 221.981371] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 42 [ 222.028028] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 44 [ 222.074835] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 48 [ 222.121066] arm-lpae io-pgtable: selftest: completed with 18 PASS 0 FAIL [ 222.168726] vgaarb: loaded [ 222.233376] pps_core: LinuxPPS API ver. 1 registered [ 222.234221] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 222.240252] PTP clock support registered [ 222.253182] kobject: 'brcmstb-reboot' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 222.492106] NetLabel: Initializing [ 222.492873] NetLabel: domain hash size = 128 [ 222.493686] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 222.507286] NetLabel: unlabeled traffic allowed by default [ 222.536810] clocksource: Switched to clocksource arch_sys_counter [ 232.408875] _warn_unseeded_randomness: 8 callbacks suppressed [ 232.409161] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 232.411978] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 232.416591] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 232.439716] VFS: Disk quotas dquot_6.6.0 [ 232.446103] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 232.485798] *** VALIDATE hugetlbfs *** [ 233.734277] _warn_unseeded_randomness: 7 callbacks suppressed [ 233.734593] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 233.737201] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 233.740193] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 233.748319] NET: Registered protocol family 2 [ 233.809810] tcp_listen_portaddr_hash hash table entries: 1024 (order: 4, 90112 bytes) [ 233.817180] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 233.851622] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes) [ 233.865150] TCP: Hash tables configured (established 16384 bind 16384) [ 233.878783] UDP hash table entries: 1024 (order: 5, 196608 bytes) [ 233.887399] UDP-Lite hash table entries: 1024 (order: 5, 196608 bytes) [ 233.914133] NET: Registered protocol family 1 [ 233.920975] NET: Registered protocol family 44 [ 234.047492] hw perfevents: enabled with armv8_pmuv3 PMU driver, 1 counters available [ 234.063801] kvm [1]: HYP mode not available [ 234.495792] Kprobe smoke test: started [ 235.904165] Kprobe smoke test: passed successfully [ 236.002568] Initialise system trusted keyrings [ 236.005588] _warn_unseeded_randomness: 50 callbacks suppressed [ 236.005865] random: get_random_bytes called from key_alloc+0x500/0xa48 with crng_init=0 [ 236.017462] Key type blacklist registered [ 236.025646] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 236.045640] workingset: timestamp_bits=44 max_order=19 bucket_order=0 [ 238.933042] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 238.934579] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 238.967982] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 239.256734] 9p: Installing v9fs 9p2000 file system support [ 239.421284] Allocating IMA blacklist keyring. [ 239.440668] ================================================================================ [ 239.441747] UBSAN: Undefined behaviour in ../crypto/algapi.c:363:2 [ 239.442539] member access within misaligned address ffffff800d323e38 for type 'struct crypto_alg' [ 239.443408] which requires 128 byte alignment [ 239.444090] CPU: 0 PID: 37 Comm: cryptomgr_test Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 239.445103] Hardware name: linux,dummy-virt (DT) [ 239.445638] Call trace: [ 239.446227] dump_backtrace+0x0/0x308 [ 239.446881] show_stack+0x28/0x38 [ 239.447524] __dump_stack+0x24/0x2c [ 239.448169] dump_stack+0xf8/0x16c [ 239.448816] ubsan_epilogue+0x18/0x50 [ 239.449489] handle_misaligned_access+0x94/0xc8 [ 239.450216] ubsan_type_mismatch_common+0x60/0x90 [ 239.450969] __ubsan_handle_type_mismatch+0x50/0x74 [ 239.451701] crypto_remove_final+0x78/0x238 [ 239.452394] crypto_alg_tested+0x450/0x488 [ 239.453096] cryptomgr_test+0x44/0x58 [ 239.453777] kthread+0x260/0x278 [ 239.454435] ret_from_fork+0x10/0x18 [ 239.455022] ================================================================================ [ 239.460834] cryptomgr_test (37) used greatest stack depth: 11712 bytes left [ 239.497144] ================================================================================ [ 239.498066] UBSAN: Undefined behaviour in ../kernel/exit.c:735:2 [ 239.498868] member access within misaligned address ffffff800d3217d8 for type 'struct task_struct' [ 239.499739] which requires 64 byte alignment [ 239.500426] CPU: 0 PID: 38 Comm: kworker/u2:0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 239.501245] Hardware name: linux,dummy-virt (DT) [ 239.501803] Call trace: [ 239.502412] dump_backtrace+0x0/0x308 [ 239.503065] show_stack+0x28/0x38 [ 239.503709] __dump_stack+0x24/0x2c [ 239.504349] dump_stack+0xf8/0x16c [ 239.504987] ubsan_epilogue+0x18/0x50 [ 239.505656] handle_misaligned_access+0x94/0xc8 [ 239.506378] ubsan_type_mismatch_common+0x60/0x90 [ 239.507123] __ubsan_handle_type_mismatch+0x50/0x74 [ 239.507846] exit_notify+0x448/0x5d0 [ 239.508512] do_exit+0xabc/0xf60 [ 239.509215] call_usermodehelper_exec_async+0x348/0x3b0 [ 239.509958] ret_from_fork+0x10/0x18 [ 239.510552] ================================================================================ [ 239.512739] kworker/u2:0 (38) used greatest stack depth: 11408 bytes left [ 241.425100] Key type asymmetric registered [ 241.428240] Asymmetric key parser 'x509' registered [ 241.437612] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) [ 241.457754] _warn_unseeded_randomness: 28 callbacks suppressed [ 241.458041] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 241.460905] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 241.511362] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 241.753007] kobject: 'brcm-gisb-arb' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 241.905810] kobject: 'armada-37xx-pinctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 242.198752] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 242.202692] ================================================================================ [ 242.203773] UBSAN: Undefined behaviour in ../drivers/base/devres.c:505:2 [ 242.204574] member access within misaligned address ffffff800804b928 for type 'struct devres' [ 242.205461] which requires 128 byte alignment [ 242.206208] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 242.207199] Hardware name: linux,dummy-virt (DT) [ 242.207768] Call trace: [ 242.208364] dump_backtrace+0x0/0x308 [ 242.209081] show_stack+0x28/0x38 [ 242.209703] __dump_stack+0x24/0x2c [ 242.210347] dump_stack+0xf8/0x16c [ 242.211077] ubsan_epilogue+0x18/0x50 [ 242.211710] handle_misaligned_access+0x94/0xc8 [ 242.212595] ubsan_type_mismatch_common+0x60/0x90 [ 242.213364] __ubsan_handle_type_mismatch+0x50/0x74 [ 242.214169] release_nodes+0x11c/0x180 [ 242.214869] devres_release_all+0xa0/0xc0 [ 242.215520] really_probe+0x69c/0xd48 [ 242.216155] really_probe_debug+0x3c/0x128 [ 242.216825] driver_probe_device+0x1f8/0x2a0 [ 242.217551] __driver_attach+0x250/0x340 [ 242.218319] bus_for_each_dev+0x110/0x180 [ 242.218976] driver_attach+0x50/0x60 [ 242.219638] bus_add_driver+0x308/0x4f0 [ 242.220315] driver_register+0x2a0/0x330 [ 242.220987] amba_driver_register+0x120/0x130 [ 242.221691] pl061_gpio_init+0x2c/0x5c [ 242.222351] do_one_initcall+0x4c8/0xa50 [ 242.223058] do_initcall_level+0xbcc/0xca4 [ 242.223745] do_initcalls+0x64/0xa8 [ 242.224397] do_basic_setup+0x44/0x70 [ 242.225050] kernel_init_freeable+0x2d8/0x420 [ 242.225734] kernel_init+0x28/0x140 [ 242.226384] ret_from_fork+0x10/0x18 [ 242.226994] ================================================================================ [ 242.236233] pl061_gpio 9030000.pl061: Unbalanced pm_runtime_enable! [ 242.272931] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 242.314021] kobject: 'stmpe-pwm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 242.355721] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 242.475534] pci-host-generic 3f000000.pcie: host bridge /pcie@10000000 ranges: [ 242.479770] pci-host-generic 3f000000.pcie: IO 0x3eff0000..0x3effffff -> 0x00000000 [ 242.484384] pci-host-generic 3f000000.pcie: MEM 0x10000000..0x3efeffff -> 0x10000000 [ 242.486502] pci-host-generic 3f000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 [ 242.493343] pci-host-generic 3f000000.pcie: ECAM at [mem 0x3f000000-0x3fffffff] for [bus 00-0f] [ 242.520215] pci-host-generic 3f000000.pcie: PCI host bridge to bus 0000:00 [ 242.521817] pci_bus 0000:00: root bus resource [bus 00-0f] [ 242.523826] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 242.525380] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] [ 242.526624] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] [ 242.533449] pci 0000:00:00.0: calling quirk_mmio_always_on+0x0/0x50 @ 1 [ 242.535596] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x50 took 162 usecs [ 242.672750] pci 0000:00:01.0: BAR 6: assigned [mem 0x10000000-0x1003ffff pref] [ 242.674333] pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] [ 242.676945] pci 0000:00:02.0: BAR 4: assigned [mem 0x8000004000-0x8000007fff 64bit pref] [ 242.679516] pci 0000:00:03.0: BAR 4: assigned [mem 0x8000008000-0x800000bfff 64bit pref] [ 242.681162] pci 0000:00:01.0: BAR 1: assigned [mem 0x10040000-0x10040fff] [ 242.682583] pci 0000:00:03.0: BAR 1: assigned [mem 0x10041000-0x10041fff] [ 242.684566] pci 0000:00:03.0: BAR 0: assigned [io 0x1000-0x103f] [ 242.685802] pci 0000:00:01.0: BAR 0: assigned [io 0x1040-0x105f] [ 242.687783] pci 0000:00:02.0: BAR 0: assigned [io 0x1060-0x107f] [ 242.692792] pci 0000:00:00.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 242.694277] pci 0000:00:00.0: tegra_pcie_relax_enable+0x0/0x40 took 222 usecs [ 242.698621] pci 0000:00:01.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 242.700727] pci 0000:00:01.0: tegra_pcie_relax_enable+0x0/0x40 took 105 usecs [ 242.703594] pci 0000:00:02.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 242.704951] pci 0000:00:02.0: tegra_pcie_relax_enable+0x0/0x40 took 95 usecs [ 242.707813] pci 0000:00:03.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 242.709180] pci 0000:00:03.0: tegra_pcie_relax_enable+0x0/0x40 took 95 usecs [ 242.788273] _warn_unseeded_randomness: 15 callbacks suppressed [ 242.788533] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 242.790240] kobject: 'layerscape-pcie' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 242.792725] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 243.637490] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) [ 243.685720] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 243.687717] kobject: 'virtio0' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 243.737836] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) [ 243.776234] kobject: 'virtio1' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 243.829831] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) [ 243.866328] _warn_unseeded_randomness: 3 callbacks suppressed [ 243.866622] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 243.869598] kobject: 'virtio2' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 243.890802] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 251.706079] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 251.939997] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 251.941446] kobject: 'ttyS0' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 251.943997] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 251.946127] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 251.948022] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 252.051776] kobject: 'ttyS1' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 252.054035] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 252.156859] kobject: 'ttyS2' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 252.159948] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 252.262638] kobject: 'ttyS3' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 252.265557] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 252.410453] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 252.430123] KGDB: Registered I/O driver kgdbts [ 252.432303] kgdbts:RUN plant and detach test Entering kdb (current=0xffffffc03f5c8040, pid 1) on processor 0 due to Keyboard Entry [0]kdb> [ 252.445138] kgdbts:RUN sw breakpoint test [ 252.464307] kgdbts:RUN bad memory access test [ 252.468646] kgdbts:RUN singlestep test 1000 iterations [ 252.505761] kgdbts:RUN singlestep [0/1000] [ 255.990229] kgdbts:RUN singlestep [100/1000] [ 259.440656] kgdbts:RUN singlestep [200/1000] [ 262.888560] kgdbts:RUN singlestep [300/1000] [ 266.334193] kgdbts:RUN singlestep [400/1000] [ 269.781487] kgdbts:RUN singlestep [500/1000] [ 273.227260] kgdbts:RUN singlestep [600/1000] [ 276.672081] kgdbts:RUN singlestep [700/1000] [ 280.118160] kgdbts:RUN singlestep [800/1000] [ 283.565533] kgdbts:RUN singlestep [900/1000] [ 286.977833] kgdbts:RUN do_fork for 100 breakpoints [ 286.988512] _warn_unseeded_randomness: 7 callbacks suppressed [ 286.988825] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 287.178310] ================================================================================ [ 287.179680] UBSAN: Undefined behaviour in ../net/core/dev.c:8006:2 [ 287.180463] member access within misaligned address ffffff800804b820 for type 'struct net_device' [ 287.181299] which requires 64 byte alignment [ 287.181985] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 287.182813] Hardware name: linux,dummy-virt (DT) [ 287.183346] Call trace: [ 287.183914] dump_backtrace+0x0/0x308 [ 287.184527] show_stack+0x28/0x38 [ 287.185174] __dump_stack+0x24/0x2c [ 287.185808] dump_stack+0xf8/0x16c [ 287.186448] ubsan_epilogue+0x18/0x50 [ 287.187108] handle_misaligned_access+0x94/0xc8 [ 287.187811] ubsan_type_mismatch_common+0x60/0x90 [ 287.188527] __ubsan_handle_type_mismatch+0x50/0x74 [ 287.189279] rollback_registered_many+0x304/0x900 [ 287.189996] rollback_registered+0xbc/0x158 [ 287.190738] unregister_netdevice_queue+0x234/0x280 [ 287.191453] unregister_netdev+0x2c/0x40 [ 287.192109] virtnet_remove+0x70/0xc8 [ 287.192738] virtio_dev_remove+0x74/0xf0 [ 287.193398] really_probe+0x640/0xd48 [ 287.194056] really_probe_debug+0x3c/0x128 [ 287.194742] driver_probe_device+0x1f8/0x2a0 [ 287.195432] __driver_attach+0x250/0x340 [ 287.196129] bus_for_each_dev+0x110/0x180 [ 287.196792] driver_attach+0x50/0x60 [ 287.197427] bus_add_driver+0x308/0x4f0 [ 287.198090] driver_register+0x2a0/0x330 [ 287.198777] register_virtio_driver+0xa4/0xb8 [ 287.199497] virtio_net_driver_init+0x100/0x17c [ 287.200211] do_one_initcall+0x4c8/0xa50 [ 287.200925] do_initcall_level+0xbcc/0xca4 [ 287.201623] do_initcalls+0x64/0xa8 [ 287.202306] do_basic_setup+0x44/0x70 [ 287.202955] kernel_init_freeable+0x2d8/0x420 [ 287.203650] kernel_init+0x28/0x140 [ 287.204295] ret_from_fork+0x10/0x18 [ 287.204869] ================================================================================ [ 287.207477] ================================================================================ [ 287.208400] UBSAN: Undefined behaviour in ../net/core/dev.c:1495:2 [ 287.209152] member access within misaligned address ffffff800804b7b0 for type 'struct net_device' [ 287.210015] which requires 64 byte alignment [ 287.210737] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 287.211689] Hardware name: linux,dummy-virt (DT) [ 287.212288] Call trace: [ 287.212869] dump_backtrace+0x0/0x308 [ 287.213535] show_stack+0x28/0x38 [ 287.214179] __dump_stack+0x24/0x2c [ 287.214869] dump_stack+0xf8/0x16c [ 287.215507] ubsan_epilogue+0x18/0x50 [ 287.216194] handle_misaligned_access+0x94/0xc8 [ 287.216922] ubsan_type_mismatch_common+0x60/0x90 [ 287.217670] __ubsan_handle_type_mismatch+0x50/0x74 [ 287.218418] dev_close_many+0x1a4/0x388 [ 287.219173] rollback_registered_many+0x428/0x900 [ 287.219933] rollback_registered+0xbc/0x158 [ 287.220681] unregister_netdevice_queue+0x234/0x280 [ 287.221423] unregister_netdev+0x2c/0x40 [ 287.222082] virtnet_remove+0x70/0xc8 [ 287.222762] virtio_dev_remove+0x74/0xf0 [ 287.223418] really_probe+0x640/0xd48 [ 287.224069] really_probe_debug+0x3c/0x128 [ 287.224748] driver_probe_device+0x1f8/0x2a0 [ 287.225422] __driver_attach+0x250/0x340 [ 287.226141] bus_for_each_dev+0x110/0x180 [ 287.226830] driver_attach+0x50/0x60 [ 287.227475] bus_add_driver+0x308/0x4f0 [ 287.228132] driver_register+0x2a0/0x330 [ 287.228818] register_virtio_driver+0xa4/0xb8 [ 287.229544] virtio_net_driver_init+0x100/0x17c [ 287.230260] do_one_initcall+0x4c8/0xa50 [ 287.230983] do_initcall_level+0xbcc/0xca4 [ 287.231663] do_initcalls+0x64/0xa8 [ 287.232335] do_basic_setup+0x44/0x70 [ 287.232951] kernel_init_freeable+0x2d8/0x420 [ 287.233687] kernel_init+0x28/0x140 [ 287.234333] ret_from_fork+0x10/0x18 [ 287.234914] ================================================================================ [ 287.236784] ================================================================================ [ 287.237670] UBSAN: Undefined behaviour in ../net/core/dev.c:1501:2 [ 287.238447] member access within misaligned address ffffff800804b7b0 for type 'struct net_device' [ 287.239304] which requires 64 byte alignment [ 287.240024] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00012-g2b2ec210ba86-dirty #75 [ 287.240950] Hardware name: linux,dummy-virt (DT) [ 287.241533] Call trace: [ 287.242119] dump_backtrace+0x0/0x308 [ 287.242794] show_stack+0x28/0x38 [ 287.243427] __dump_stack+0x24/0x2c [ 287.244104] dump_stack+0xf8/0x16c [ 287.244761] ubsan_epilogue+0x18/0x50 [ 287.245447] handle_misaligned_access+0x94/0xc8 [ 287.246193] ubsan_type_mismatch_common+0x60/0x90 [ 287.246972] __ubsan_handle_type_mismatch+0x50/0x74 [ 287.247706] dev_close_many+0x218/0x388 [ 287.248440] rollback_registered_many+0x428/0x900 [ 287.249194] rollback_registered+0xbc/0x158 [ 287.249917] unregister_netdevice_queue+0x234/0x280 [ 287.250667] unregister_netdev+0x2c/0x40 [ 287.251322] virtnet_remove+0x70/0xc8 [ 287.251973] virtio_dev_remove+0x74/0xf0 [ 287.252637] really_probe+0x640/0xd48 [ 287.253292] really_probe_debug+0x3c/0x128 [ 287.253977] driver_probe_device+0x1f8/0x2a0 [ 287.254679] __driver_attach+0x250/0x340 [ 287.255411] bus_for_each_dev+0x110/0x180 [ 287.256052] driver_attach+0x50/0x60 [ 287.256722] bus_add_driver+0x308/0x4f0 [ 287.257404] driver_register+0x2a0/0x330 [ 287.258082] register_virtio_driver+0xa4/0xb8 [ 287.258845] virtio_net_driver_init+0x100/0x17c [ 287.259544] do_one_initcall+0x4c8/0xa50 [ 287.260262] do_initcall_level+0xbcc/0xca4 [ 287.260950] do_initcalls+0x64/0xa8 [ 287.261626] do_basic_setup+0x44/0x70 [ 287.262261] kernel_init_freeable+0x2d8/0x420 [ 287.262964] kernel_init+0x28/0x140 [ 287.263615] ret_from_fork+0x10/0x18 [ 287.264185] ================================================================================ [ 289.301028] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 289.302445] kobject: 'rx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 289.310541] kobject: 'tx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 289.356418] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 289.403965] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 289.405364] kobject: 'net' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 290.305997] KGDB: Unregistered I/O driver kgdbts, debugger disabled [ 291.341425] kobject: 'queues' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 291.420161] kobject: '44' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 291.441450] kobject: 'eth0' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 291.474664] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 291.724358] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 291.725559] kobject: '45' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 291.727160] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 291.736340] ledtrig-cpu: registered to indicate activity on CPUs [ 291.740482] kobject: '46' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 291.766478] kobject: 'meson-sm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 291.883322] ashmem: initialized [ 292.208164] 9pnet: Installing 9P2000 support [ 292.786187] _warn_unseeded_randomness: 11 callbacks suppressed [ 292.786438] random: get_random_bytes called from init_oops_id+0x38/0x60 with crng_init=0 [ 292.813501] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 292.815281] kobject: '47' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 292.824000] kobject: '48' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 292.831747] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 292.916429] registered taskstats version 1 [ 292.918388] Running ring buffer tests... [ 303.144288] finished [ 303.145104] CPU 0: [ 303.145862] events: 5227 [ 303.147671] dropped bytes: 0 [ 303.148413] alloced bytes: 432776 [ 303.149186] written bytes: 398963 [ 303.149948] biggest event: 59 [ 303.151432] smallest event: 0 [ 303.451386] read events: 5227 [ 303.452124] lost events: 0 [ 303.452901] total events: 5227 [ 303.453666] recorded len bytes: 432776 [ 303.454465] recorded size bytes: 398963 [ 303.456061] Ring buffer PASSED! [ 303.574651] Running tests on trace events: [ 303.576292] Testing event initcall_finish: OK [ 303.618169] Testing event initcall_start: OK [ 303.664246] Testing event initcall_level: OK [ 303.712321] Testing event sys_exit: OK [ 303.757154] Testing event sys_enter: OK [ 303.798483] Testing event ipi_exit: OK [ 303.838580] Testing event ipi_entry: OK [ 303.880204] Testing event ipi_raise: OK [ 303.920520] Testing event instruction_emulation: OK [ 303.958409] Testing event kvm_halt_poll_ns: OK [ 304.005121] Testing event kvm_age_page: OK [ 304.048986] Testing event kvm_fpu: OK [ 304.089831] Testing event kvm_mmio: OK [ 304.134191] Testing event kvm_ack_irq: OK [ 304.174220] Testing event kvm_set_irq: OK [ 304.217839] Testing event kvm_vcpu_wakeup: OK [ 304.262424] Testing event kvm_userspace_exit: OK [ 304.304905] Testing event kvm_timer_update_irq: OK [ 304.346033] Testing event kvm_toggle_cache: OK [ 304.389683] Testing event kvm_set_way_flush: OK [ 304.432925] Testing event kvm_test_age_hva: OK [ 304.474124] Testing event kvm_age_hva: OK [ 304.514210] Testing event kvm_set_spte_hva: OK [ 304.554682] Testing event kvm_unmap_hva_range: OK [ 304.596193] Testing event kvm_mmio_emulate: OK [ 304.638443] Testing event kvm_irq_line: OK [ 304.679940] Testing event kvm_access_fault: OK [ 304.720238] Testing event kvm_guest_fault: OK [ 304.754100] Testing event kvm_exit: OK [ 304.801107] Testing event kvm_entry: OK [ 304.842183] Testing event kvm_set_guest_debug: OK [ 304.884575] Testing event kvm_handle_sys_reg: OK [ 304.921801] Testing event trap_reg: OK [ 304.965343] Testing event kvm_arm_set_regset: OK [ 305.009598] Testing event kvm_arm_set_dreg32: OK [ 305.052256] Testing event kvm_arm_clear_debug: OK [ 305.092180] Testing event kvm_arm_setup_debug: OK [ 305.126045] Testing event kvm_hvc_arm64: OK [ 305.170220] Testing event kvm_wfx_arm64: OK [ 305.212036] Testing event vgic_update_irq_pending: OK [ 305.252194] Testing event task_rename: OK [ 305.292768] Testing event task_newtask: OK [ 305.329670] Testing event cpuhp_exit: OK [ 305.377881] Testing event cpuhp_multi_enter: OK [ 305.421111] Testing event cpuhp_enter: OK [ 305.462100] Testing event softirq_raise: OK [ 305.502615] Testing event softirq_exit: OK [ 305.544276] Testing event softirq_entry: OK [ 305.584808] Testing event irq_handler_exit: OK [ 305.626420] Testing event irq_handler_entry: OK [ 305.673099] Testing event signal_deliver: OK [ 305.714197] Testing event signal_generate: OK [ 305.756287] Testing event workqueue_execute_end: OK [ 305.798661] Testing event workqueue_execute_start: OK [ 305.842600] Testing event workqueue_activate_work: OK [ 305.890038] Testing event workqueue_queue_work: OK [ 305.932204] Testing event sched_wake_idle_without_ipi: OK [ 305.975788] Testing event sched_swap_numa: OK [ 306.018576] Testing event sched_stick_numa: OK [ 306.058370] Testing event sched_move_numa: OK [ 306.098473] Testing event sched_process_hang: OK [ 306.140288] Testing event sched_pi_setprio: OK [ 306.173765] Testing event sched_stat_runtime: [ 306.177398] Scheduler tracepoints stat_sleep, stat_iowait, stat_blocked and stat_runtime require the kernel parameter schedstats=enable or kernel.sched_schedstats=1 [ 306.221872] OK [ 306.222540] Testing event sched_stat_blocked: OK [ 306.264090] Testing event sched_stat_iowait: OK [ 306.308694] Testing event sched_stat_sleep: OK [ 306.345968] Testing event sched_stat_wait: OK [ 306.384444] Testing event sched_process_exec: OK [ 306.425972] Testing event sched_process_fork: OK [ 306.469188] Testing event sched_process_wait: OK [ 306.505940] Testing event sched_wait_task: OK [ 306.548927] Testing event sched_process_exit: OK [ 306.586184] Testing event sched_process_free: OK [ 306.628825] Testing event sched_migrate_task: OK [ 306.665971] Testing event sched_switch: OK [ 306.701975] Testing event sched_wakeup_new: OK [ 306.752845] Testing event sched_wakeup: OK [ 306.797989] Testing event sched_waking: OK [ 306.841705] Testing event sched_kthread_stop_ret: OK [ 306.885655] Testing event sched_kthread_stop: OK [ 306.925983] Testing event lock_acquired: OK [ 306.978077] Testing event lock_contended: OK [ 307.022201] Testing event lock_release: OK [ 307.075863] Testing event lock_acquire: OK [ 307.117257] Testing event console: OK [ 307.165300] Testing event rcu_barrier: OK [ 307.208983] Testing event rcu_torture_read: OK [ 307.253948] Testing event rcu_batch_end: OK [ 307.297254] Testing event rcu_invoke_kfree_callback: OK [ 307.338554] Testing event rcu_invoke_callback: OK [ 307.382241] Testing event rcu_batch_start: OK [ 307.419709] Testing event rcu_kfree_callback: OK [ 307.463941] Testing event rcu_callback: OK [ 307.504505] Testing event rcu_dyntick: OK [ 307.545716] Testing event rcu_fqs: OK [ 307.591639] Testing event rcu_quiescent_state_report: OK [ 307.634502] Testing event rcu_unlock_preempted_task: OK [ 307.674496] Testing event rcu_preempt_task: OK [ 307.716728] Testing event rcu_nocb_wake: OK [ 307.761568] Testing event rcu_exp_funnel_lock: OK [ 307.802263] Testing event rcu_exp_grace_period: OK [ 307.844759] Testing event rcu_grace_period_init: OK [ 307.890472] Testing event rcu_future_grace_period: OK [ 307.933155] Testing event rcu_grace_period: OK [ 307.983834] Testing event rcu_utilization: OK [ 308.030425] Testing event swiotlb_bounced: OK [ 308.073204] Testing event tick_stop: OK [ 308.114132] Testing event itimer_expire: OK [ 308.163960] Testing event itimer_state: OK [ 308.198452] Testing event hrtimer_cancel: OK [ 308.246459] Testing event hrtimer_expire_exit: OK [ 308.287885] Testing event hrtimer_expire_entry: OK [ 308.333442] Testing event hrtimer_start: OK [ 308.376416] Testing event hrtimer_init: OK [ 308.421960] Testing event timer_cancel: OK [ 308.465446] Testing event timer_expire_exit: OK [ 308.509286] Testing event timer_expire_entry: OK [ 308.550422] Testing event timer_start: OK [ 308.588880] Testing event timer_init: OK [ 308.631913] Testing event alarmtimer_cancel: OK [ 308.674515] Testing event alarmtimer_start: OK [ 308.714345] Testing event alarmtimer_fired: OK [ 308.756091] Testing event alarmtimer_suspend: OK [ 308.790109] Testing event module_request: OK [ 308.837728] Testing event module_put: OK [ 308.881477] Testing event module_get: OK [ 308.922398] Testing event module_free: OK [ 308.962541] Testing event module_load: OK [ 309.004801] Testing event cgroup_transfer_tasks: OK [ 309.049134] Testing event cgroup_attach_task: OK [ 309.090411] Testing event cgroup_rename: OK [ 309.131875] Testing event cgroup_release: OK [ 309.172165] Testing event cgroup_rmdir: OK [ 309.206043] Testing event cgroup_mkdir: OK [ 309.253525] Testing event cgroup_remount: OK [ 309.294235] Testing event cgroup_destroy_root: OK [ 309.334654] Testing event cgroup_setup_root: OK [ 309.376541] Testing event irq_enable: OK [ 309.430482] Testing event irq_disable: OK [ 309.487643] Testing event ftrace_test_filter: OK [ 309.526486] Testing event dev_pm_qos_remove_request: OK [ 309.568241] Testing event dev_pm_qos_update_request: OK [ 309.610623] Testing event dev_pm_qos_add_request: OK [ 309.654331] Testing event pm_qos_update_flags: OK [ 309.696006] Testing event pm_qos_update_target: OK [ 309.738457] Testing event pm_qos_update_request_timeout: OK [ 309.782686] Testing event pm_qos_remove_request: OK [ 309.828789] Testing event pm_qos_update_request: OK [ 309.872974] Testing event pm_qos_add_request: OK [ 309.917031] Testing event power_domain_target: OK [ 309.958028] Testing event clock_set_rate: OK [ 309.994426] Testing event clock_disable: OK [ 310.036522] Testing event clock_enable: OK [ 310.073536] Testing event wakeup_source_deactivate: OK [ 310.118608] Testing event wakeup_source_activate: OK [ 310.159765] Testing event suspend_resume: OK [ 310.216090] Testing event device_pm_callback_end: OK [ 310.261519] Testing event device_pm_callback_start: OK [ 310.303623] Testing event cpu_frequency_limits: OK [ 310.346672] Testing event cpu_frequency: OK [ 310.391909] Testing event pstate_sample: OK [ 310.434149] Testing event powernv_throttle: OK [ 310.474451] Testing event cpu_idle: OK [ 310.517013] Testing event rpm_return_int: OK [ 310.556945] Testing event rpm_idle: OK [ 310.601112] Testing event rpm_resume: OK [ 310.645191] Testing event rpm_suspend: OK [ 310.690067] Testing event benchmark_event: OK [ 310.838101] Testing event xdp_devmap_xmit: OK [ 310.882514] Testing event xdp_cpumap_enqueue: OK [ 310.917856] Testing event xdp_cpumap_kthread: OK [ 310.962051] Testing event xdp_redirect_map_err: OK [ 311.003855] Testing event xdp_redirect_map: OK [ 311.044379] Testing event xdp_redirect_err: OK [ 311.083800] Testing event xdp_redirect: OK [ 311.129114] Testing event xdp_exception: OK [ 311.168229] Testing event rseq_ip_fixup: OK [ 311.213604] Testing event rseq_update: OK [ 311.254183] Testing event file_check_and_advance_wb_err: OK [ 311.295821] Testing event filemap_set_wb_err: OK [ 311.336833] Testing event mm_filemap_add_to_page_cache: OK [ 311.378352] Testing event mm_filemap_delete_from_page_cache: OK [ 311.419905] Testing event compact_retry: OK [ 311.460195] Testing event skip_task_reaping: OK [ 311.500902] Testing event finish_task_reaping: OK [ 311.545218] Testing event start_task_reaping: OK [ 311.586217] Testing event wake_reaper: OK [ 311.628130] Testing event mark_victim: OK [ 311.673430] Testing event reclaim_retry_zone: OK [ 311.714399] Testing event oom_score_adj_update: OK [ 311.754576] Testing event mm_lru_activate: OK [ 311.796203] Testing event mm_lru_insertion: OK [ 311.830093] Testing event mm_vmscan_inactive_list_is_low: OK [ 311.877822] Testing event mm_vmscan_lru_shrink_active: OK [ 311.917107] Testing event mm_vmscan_lru_shrink_inactive: OK [ 311.958344] Testing event mm_vmscan_writepage: OK [ 311.999986] Testing event mm_vmscan_lru_isolate: OK [ 312.040272] Testing event mm_shrink_slab_end: OK [ 312.078602] Testing event mm_shrink_slab_start: OK [ 312.119900] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 312.160418] Testing event mm_vmscan_memcg_reclaim_end: OK [ 312.200907] Testing event mm_vmscan_direct_reclaim_end: OK [ 312.238001] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 312.280910] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 312.325202] Testing event mm_vmscan_direct_reclaim_begin: OK [ 312.369198] Testing event mm_vmscan_wakeup_kswapd: OK [ 312.410367] Testing event mm_vmscan_kswapd_wake: OK [ 312.450668] Testing event mm_vmscan_kswapd_sleep: OK [ 312.492936] Testing event percpu_destroy_chunk: OK [ 312.534190] Testing event percpu_create_chunk: OK [ 312.575942] Testing event percpu_alloc_percpu_fail: OK [ 312.616184] Testing event percpu_free_percpu: OK [ 312.653603] Testing event percpu_alloc_percpu: OK [ 312.696886] Testing event mm_fragmentation_stall: OK [ 312.736975] Testing event mm_page_alloc_extfrag: OK [ 312.780109] Testing event mm_page_pcpu_drain: OK [ 312.818644] Testing event mm_page_alloc_zone_locked: OK [ 312.865018] Testing event mm_page_alloc: OK [ 312.904647] Testing event mm_page_free_batched: OK [ 312.948927] Testing event mm_page_free: OK [ 312.990274] Testing event kmem_cache_free: OK [ 313.031934] Testing event kfree: OK [ 313.072117] Testing event kmem_cache_alloc_node: OK [ 313.106178] Testing event kmalloc_node: OK [ 313.157216] Testing event kmem_cache_alloc: OK [ 313.197615] Testing event kmalloc: OK [ 313.240269] Testing event mm_compaction_kcompactd_wake: OK [ 313.280320] Testing event mm_compaction_wakeup_kcompactd: OK [ 313.320796] Testing event mm_compaction_kcompactd_sleep: OK [ 313.357951] Testing event mm_compaction_defer_reset: OK [ 313.399661] Testing event mm_compaction_defer_compaction: OK [ 313.439769] Testing event mm_compaction_deferred: OK [ 313.486201] Testing event mm_compaction_suitable: OK [ 313.526533] Testing event mm_compaction_finished: OK [ 313.571888] Testing event mm_compaction_try_to_compact_pages: OK [ 313.614449] Testing event mm_compaction_end: OK [ 313.654496] Testing event mm_compaction_begin: OK [ 313.696974] Testing event mm_compaction_migratepages: OK [ 313.741179] Testing event mm_compaction_isolate_freepages: OK [ 313.782442] Testing event mm_compaction_isolate_migratepages: OK [ 313.824062] Testing event mm_migrate_pages: OK [ 313.864798] Testing event mm_collapse_huge_page_swapin: OK [ 313.909767] Testing event mm_collapse_huge_page_isolate: OK [ 313.953289] Testing event mm_collapse_huge_page: OK [ 313.994175] Testing event mm_khugepaged_scan_pmd: OK [ 314.036141] Testing event test_pages_isolated: OK [ 314.080057] Testing event cma_release: OK [ 314.118214] Testing event cma_alloc: OK [ 314.161523] Testing event page_ref_unfreeze: OK [ 314.200989] Testing event page_ref_freeze: OK [ 314.245613] Testing event page_ref_mod_unless: OK [ 314.291776] Testing event page_ref_mod_and_return: OK [ 314.336551] Testing event page_ref_mod_and_test: OK [ 314.536268] Testing event page_ref_mod: OK [ 314.621124] Testing event page_ref_set: OK [ 314.668607] Testing event sb_clear_inode_writeback: OK [ 314.713166] Testing event sb_mark_inode_writeback: OK [ 314.757155] Testing event writeback_dirty_inode_enqueue: OK [ 314.798431] Testing event writeback_lazytime_iput: OK [ 314.838658] Testing event writeback_lazytime: OK [ 314.881523] Testing event writeback_single_inode: OK [ 314.923899] Testing event writeback_single_inode_start: OK [ 314.964303] Testing event writeback_wait_iff_congested: OK [ 315.004945] Testing event writeback_congestion_wait: OK [ 315.041989] Testing event writeback_sb_inodes_requeue: OK [ 315.084914] Testing event balance_dirty_pages: OK [ 315.126460] Testing event bdi_dirty_ratelimit: OK [ 315.166678] Testing event global_dirty_state: OK [ 315.208364] Testing event writeback_queue_io: OK [ 315.242081] Testing event wbc_writepage: OK [ 315.286319] Testing event writeback_bdi_register: OK [ 315.326623] Testing event writeback_wake_background: OK [ 315.368093] Testing event writeback_pages_written: OK [ 315.406695] Testing event writeback_wait: OK [ 315.452554] Testing event writeback_written: OK [ 315.492815] Testing event writeback_start: OK [ 315.529954] Testing event writeback_exec: OK [ 315.572811] Testing event writeback_queue: OK [ 315.617704] Testing event writeback_write_inode: OK [ 315.660804] Testing event writeback_write_inode_start: OK [ 315.706009] Testing event writeback_dirty_inode: OK [ 315.748880] Testing event writeback_dirty_inode_start: OK [ 315.793143] Testing event writeback_mark_inode_dirty: OK [ 315.836518] Testing event writeback_dirty_page: OK [ 315.881079] Testing event dax_writeback_one: OK [ 315.922362] Testing event dax_writeback_range_done: OK [ 315.963831] Testing event dax_writeback_range: OK [ 316.004819] Testing event dax_insert_mapping: OK [ 316.046190] Testing event dax_insert_pfn_mkwrite: OK [ 316.089184] Testing event dax_insert_pfn_mkwrite_no_entry: OK [ 316.133961] Testing event dax_load_hole: OK [ 316.177029] Testing event dax_pte_fault_done: OK [ 316.218303] Testing event dax_pte_fault: OK [ 316.260073] Testing event dax_pmd_insert_mapping: OK [ 316.302120] Testing event dax_pmd_load_hole_fallback: OK [ 316.345158] Testing event dax_pmd_load_hole: OK [ 316.381693] Testing event dax_pmd_fault_done: OK [ 316.424628] Testing event dax_pmd_fault: OK [ 316.462098] Testing event generic_add_lease: OK [ 316.505453] Testing event time_out_leases: OK [ 316.542700] Testing event generic_delete_lease: OK [ 316.583818] Testing event break_lease_unblock: OK [ 316.619641] Testing event break_lease_block: OK [ 316.655949] Testing event break_lease_noblock: OK [ 316.698305] Testing event flock_lock_inode: OK [ 316.738663] Testing event locks_remove_posix: OK [ 316.780199] Testing event fcntl_setlk: OK [ 316.813753] Testing event posix_lock_inode: OK [ 316.858317] Testing event locks_get_lock_context: OK [ 316.902363] Testing event block_rq_remap: OK [ 316.945689] Testing event block_bio_remap: OK [ 316.989893] Testing event block_split: OK [ 317.033060] Testing event block_unplug: OK [ 317.077470] Testing event block_plug: OK [ 317.121467] Testing event block_sleeprq: OK [ 317.162638] Testing event block_getrq: OK [ 317.204609] Testing event block_bio_queue: OK [ 317.247738] Testing event block_bio_frontmerge: OK [ 317.281454] Testing event block_bio_backmerge: OK [ 317.323603] Testing event block_bio_complete: OK [ 317.359791] Testing event block_bio_bounce: OK [ 317.401891] Testing event block_rq_issue: OK [ 317.438567] Testing event block_rq_insert: OK [ 317.479794] Testing event block_rq_complete: OK [ 317.524573] Testing event block_rq_requeue: OK [ 317.567909] Testing event block_dirty_buffer: OK [ 317.608273] Testing event block_touch_buffer: OK [ 317.648843] Testing event wbt_timer: OK [ 317.694014] Testing event wbt_step: OK [ 317.737206] Testing event wbt_lat: OK [ 317.781047] Testing event wbt_stat: OK [ 317.822335] Testing event gpio_value: OK [ 317.868184] Testing event gpio_direction: OK [ 317.910546] Testing event clk_set_duty_cycle_complete: OK [ 317.950553] Testing event clk_set_duty_cycle: OK [ 317.992826] Testing event clk_set_phase_complete: OK [ 318.034218] Testing event clk_set_phase: OK [ 318.080611] Testing event clk_set_parent_complete: OK [ 318.125852] Testing event clk_set_parent: OK [ 318.170111] Testing event clk_set_rate_complete: OK [ 318.210236] Testing event clk_set_rate: OK [ 318.258246] Testing event clk_unprepare_complete: OK [ 318.301050] Testing event clk_unprepare: OK [ 318.342350] Testing event clk_prepare_complete: OK [ 318.392288] Testing event clk_prepare: OK [ 318.430666] Testing event clk_disable_complete: OK [ 318.470635] Testing event clk_disable: OK [ 318.510646] Testing event clk_enable_complete: OK [ 318.556965] Testing event clk_enable: OK [ 318.601894] Testing event rpmh_send_msg: OK [ 318.645140] Testing event rpmh_tx_done: OK [ 318.688886] Testing event regulator_set_voltage_complete: OK [ 318.734127] Testing event regulator_set_voltage: OK [ 318.777077] Testing event regulator_disable_complete: OK [ 318.818165] Testing event regulator_disable: OK [ 318.861245] Testing event regulator_enable_complete: OK [ 318.904329] Testing event regulator_enable_delay: OK [ 318.946516] Testing event regulator_enable: OK [ 318.990571] Testing event urandom_read: OK [ 319.031897] Testing event random_read: OK [ 319.072109] Testing event extract_entropy_user: OK [ 319.114461] Testing event extract_entropy: OK [ 319.158529] Testing event get_random_bytes_arch: OK [ 319.199954] Testing event get_random_bytes: OK [ 319.240239] Testing event xfer_secondary_pool: OK [ 319.273793] Testing event add_disk_randomness: OK [ 319.322146] Testing event add_input_randomness: OK [ 319.364936] Testing event debit_entropy: OK [ 319.409208] Testing event push_to_pool: OK [ 319.450329] Testing event credit_entropy_bits: OK [ 319.490579] Testing event mix_pool_bytes_nolock: OK [ 319.532178] Testing event mix_pool_bytes: OK [ 319.565988] Testing event add_device_randomness: OK [ 319.615848] Testing event io_page_fault: OK [ 319.656851] Testing event unmap: OK [ 319.698071] Testing event map: OK [ 319.742016] Testing event detach_device_from_domain: OK [ 319.782291] Testing event attach_device_to_domain: OK [ 319.824897] Testing event remove_device_from_group: OK [ 319.878471] Testing event add_device_to_group: OK [ 319.924922] Testing event regcache_drop_region: OK [ 319.971708] Testing event regmap_async_complete_done: OK [ 320.012952] Testing event regmap_async_complete_start: OK [ 320.054036] Testing event regmap_async_io_complete: OK [ 320.095931] Testing event regmap_async_write_start: OK [ 320.136977] Testing event regmap_cache_bypass: OK [ 320.178160] Testing event regmap_cache_only: OK [ 320.221253] Testing event regcache_sync: OK [ 320.264549] Testing event regmap_hw_write_done: OK [ 320.310245] Testing event regmap_hw_write_start: OK [ 320.353320] Testing event regmap_hw_read_done: OK [ 320.396473] Testing event regmap_hw_read_start: OK [ 320.438351] Testing event regmap_reg_read_cache: OK [ 320.479892] Testing event regmap_reg_read: OK [ 320.520205] Testing event regmap_reg_write: OK [ 320.553858] Testing event dma_fence_wait_end: OK [ 320.602016] Testing event dma_fence_wait_start: OK [ 320.644771] Testing event dma_fence_signaled: OK [ 320.689240] Testing event dma_fence_enable_signal: OK [ 320.733546] Testing event dma_fence_destroy: OK [ 320.774093] Testing event dma_fence_init: OK [ 320.814567] Testing event dma_fence_emit: OK [ 320.854430] Testing event sync_timeline: OK [ 320.897414] Testing event spi_transfer_stop: OK [ 320.941135] Testing event spi_transfer_start: OK [ 320.982085] Testing event spi_message_done: OK [ 321.018347] Testing event spi_message_start: OK [ 321.065147] Testing event spi_message_submit: OK [ 321.106288] Testing event spi_controller_busy: OK [ 321.152739] Testing event spi_controller_idle: OK [ 321.198067] Testing event rtc_timer_fired: OK [ 321.240974] Testing event rtc_timer_dequeue: OK [ 321.282640] Testing event rtc_timer_enqueue: OK [ 321.329566] Testing event rtc_read_offset: OK [ 321.366613] Testing event rtc_set_offset: OK [ 321.408784] Testing event rtc_alarm_irq_enable: OK [ 321.445986] Testing event rtc_irq_set_state: OK [ 321.490259] Testing event rtc_irq_set_freq: OK [ 321.534508] Testing event rtc_read_alarm: OK [ 321.578622] Testing event rtc_set_alarm: OK [ 321.622601] Testing event rtc_read_time: OK [ 321.664208] Testing event rtc_set_time: OK [ 321.706261] Testing event memory_failure_event: OK [ 321.748203] Testing event aer_event: OK [ 321.792884] Testing event non_standard_event: OK [ 321.837656] Testing event arm_event: OK [ 321.881068] Testing event mc_event: OK [ 321.922008] Testing event binder_return: OK [ 321.960981] Testing event binder_command: OK [ 322.002197] Testing event binder_unmap_kernel_end: OK [ 322.045918] Testing event binder_unmap_kernel_start: OK [ 322.089198] Testing event binder_unmap_user_end: OK [ 322.133285] Testing event binder_unmap_user_start: OK [ 322.174218] Testing event binder_alloc_page_end: OK [ 322.217923] Testing event binder_alloc_page_start: OK [ 322.258316] Testing event binder_free_lru_end: OK [ 322.298669] Testing event binder_free_lru_start: OK [ 322.340289] Testing event binder_alloc_lru_end: OK [ 322.374113] Testing event binder_alloc_lru_start: OK [ 322.422657] Testing event binder_update_page_range: OK [ 322.465138] Testing event binder_transaction_failed_buffer_release: OK [ 322.509064] Testing event binder_transaction_buffer_release: OK [ 322.554459] Testing event binder_transaction_alloc_buf: OK [ 322.597243] Testing event binder_transaction_fd_recv: OK [ 322.640698] Testing event binder_transaction_fd_send: OK [ 322.682557] Testing event binder_transaction_ref_to_ref: OK [ 322.724288] Testing event binder_transaction_ref_to_node: OK [ 322.769333] Testing event binder_transaction_node_to_ref: OK [ 322.813479] Testing event binder_transaction_received: OK [ 322.854323] Testing event binder_transaction: OK [ 322.900838] Testing event binder_wait_for_work: OK [ 322.945013] Testing event binder_read_done: OK [ 322.986172] Testing event binder_write_done: OK [ 323.036236] Testing event binder_ioctl_done: OK [ 323.070100] Testing event binder_unlock: OK [ 323.109639] Testing event binder_locked: OK [ 323.145826] Testing event binder_lock: OK [ 323.190052] Testing event binder_ioctl: OK [ 323.233841] Testing event br_fdb_update: OK [ 323.276964] Testing event fdb_delete: OK [ 323.317891] Testing event br_fdb_external_learn_add: OK [ 323.357930] Testing event br_fdb_add: OK [ 323.401185] Testing event qdisc_dequeue: OK [ 323.442144] Testing event fib_table_lookup: OK [ 323.484346] Testing event tcp_probe: OK [ 323.524193] Testing event tcp_retransmit_synack: OK [ 323.558229] Testing event tcp_rcv_space_adjust: OK [ 323.602402] Testing event tcp_destroy_sock: OK [ 323.642542] Testing event tcp_receive_reset: OK [ 323.684945] Testing event tcp_send_reset: OK [ 323.729137] Testing event tcp_retransmit_skb: OK [ 323.770436] Testing event udp_fail_queue_rcv_skb: OK [ 323.810642] Testing event inet_sock_set_state: OK [ 323.852504] Testing event sock_exceed_buf_limit: OK [ 323.891719] Testing event sock_rcvqueue_full: OK [ 323.932909] Testing event napi_poll: OK [ 323.975902] Testing event netif_receive_skb_list_exit: OK [ 324.021344] Testing event netif_rx_ni_exit: OK [ 324.062385] Testing event netif_rx_exit: OK [ 324.104212] Testing event netif_receive_skb_exit: OK [ 324.148999] Testing event napi_gro_receive_exit: OK [ 324.193111] Testing event napi_gro_frags_exit: OK [ 324.234415] Testing event netif_rx_ni_entry: OK [ 324.274614] Testing event netif_rx_entry: OK [ 324.316998] Testing event netif_receive_skb_list_entry: OK [ 324.360266] Testing event netif_receive_skb_entry: OK [ 324.402558] Testing event napi_gro_receive_entry: OK [ 324.446641] Testing event napi_gro_frags_entry: OK [ 324.490425] Testing event netif_rx: OK [ 324.534624] Testing event netif_receive_skb: OK [ 324.574633] Testing event net_dev_queue: OK [ 324.616302] Testing event net_dev_xmit: OK [ 324.656643] Testing event net_dev_start_xmit: OK [ 324.693847] Testing event skb_copy_datagram_iovec: OK [ 324.736628] Testing event consume_skb: OK [ 324.774256] Testing event kfree_skb: OK [ 324.821094] Testing event 9p_protocol_dump: OK [ 324.874129] Testing event 9p_client_res: OK [ 324.916462] Testing event 9p_client_req: OK [ 324.958202] Running tests on trace event systems: [ 324.960162] Testing event system 9p: OK [ 325.018038] Testing event system skb: OK [ 325.066499] Testing event system net: OK [ 325.131657] Testing event system napi: OK [ 325.172702] Testing event system sock: OK [ 325.216318] Testing event system udp: OK [ 325.264213] Testing event system tcp: OK [ 325.316365] Testing event system fib: OK [ 325.361923] Testing event system qdisc: OK [ 325.410259] Testing event system bridge: OK [ 325.456598] Testing event system binder: OK [ 325.537689] Testing event system ras: OK [ 325.587974] Testing event system rtc: OK [ 325.671793] Testing event system spi: OK [ 325.730642] Testing event system sync_trace: OK [ 325.778054] Testing event system dma_fence: OK [ 325.828593] Testing event system regmap: OK [ 325.893726] Testing event system iommu: OK [ 325.953738] Testing event system random: OK [ 326.019591] Testing event system regulator: OK [ 326.081299] Testing event system rpmh: OK [ 326.130052] Testing event system clk: OK [ 326.194321] Testing event system gpio: OK [ 326.264489] Testing event system wbt: OK [ 326.310535] Testing event system block: OK [ 326.377314] Testing event system filelock: OK [ 326.445214] Testing event system fs_dax: OK [ 326.505951] Testing event system writeback: OK [ 326.591707] Testing event system page_ref: OK [ 326.884019] Testing event system cma: OK [ 326.936285] Testing event system page_isolation: OK [ 326.981061] Testing event system huge_memory: OK [ 327.030108] Testing event system migrate: OK [ 327.082103] Testing event system compaction: OK [ 327.140035] Testing event system kmem: OK [ 327.197865] Testing event system percpu: OK [ 327.264302] Testing event system vmscan: OK [ 327.328751] Testing event system pagemap: OK [ 327.368686] Testing event system oom: OK [ 327.430447] Testing event system filemap: OK [ 327.472465] Testing event system rseq: OK [ 327.529508] Testing event system xdp: OK [ 327.588193] Testing event system benchmark: OK [ 327.731838] Testing event system rpm: OK [ 327.774122] Testing event system power: OK [ 327.857953] Testing event system test: OK [ 327.901167] Testing event system preemptirq: OK [ 327.984653] Testing event system cgroup: OK [ 328.044997] Testing event system module: OK [ 328.096469] Testing event system alarmtimer: OK [ 328.144071] Testing event system timer: OK [ 328.208687] Testing event system swiotlb: OK [ 328.248950] Testing event system rcu: OK [ 328.348669] Testing event system printk: OK [ 328.405973] Testing event system lock: OK [ 328.492633] Testing event system sched: OK [ 328.563440] Testing event system workqueue: OK [ 328.632587] Testing event system signal: OK [ 328.678015] Testing event system irq: OK [ 328.735682] Testing event system cpuhp: OK [ 328.789060] Testing event system task: OK [ 328.840777] Testing event system kvm: OK [ 328.916539] Testing event system emulation: OK [ 328.962532] Testing event system ipi: OK [ 329.021828] Testing event system syscalls: OK [ 329.090333] Testing event system raw_syscalls: OK [ 329.143714] Testing event system initcall: OK [ 329.191726] Running tests on all trace events: [ 329.192497] Testing all events: OK [ 331.604706] ftrace_replace_code: 1 [ 371.335066] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 371.357742] Running tests again, along with the function tracer [ 371.365644] Running tests on trace events: [ 371.374368] Testing event initcall_finish: OK [ 371.608961] Testing event initcall_start: OK [ 371.870575] Testing event initcall_level: OK [ 372.134401] Testing event sys_exit: OK [ 372.372986] Testing event sys_enter: OK [ 372.655507] Testing event ipi_exit: OK [ 372.898486] Testing event ipi_entry: OK [ 373.134531] Testing event ipi_raise: OK [ 373.390237] Testing event instruction_emulation: OK [ 373.701219] Testing event kvm_halt_poll_ns: OK [ 373.934419] Testing event kvm_age_page: OK [ 374.154525] Testing event kvm_fpu: OK [ 374.430705] Testing event kvm_mmio: OK [ 374.686432] Testing event kvm_ack_irq: OK [ 374.925256] Testing event kvm_set_irq: OK [ 375.208971] Testing event kvm_vcpu_wakeup: OK [ 375.457596] Testing event kvm_userspace_exit: OK [ 375.694336] Testing event kvm_timer_update_irq: OK [ 375.930500] Testing event kvm_toggle_cache: OK [ 376.186398] Testing event kvm_set_way_flush: OK [ 376.420952] Testing event kvm_test_age_hva: OK [ 376.633290] Testing event kvm_age_hva: OK [ 376.878437] Testing event kvm_set_spte_hva: OK [ 377.137877] Testing event kvm_unmap_hva_range: OK [ 377.389250] Testing event kvm_mmio_emulate: OK [ 377.615486] Testing event kvm_irq_line: OK [ 377.857541] Testing event kvm_access_fault: OK [ 378.096734] Testing event kvm_guest_fault: OK [ 378.357780] Testing event kvm_exit: OK [ 378.638382] Testing event kvm_entry: OK [ 378.901142] Testing event kvm_set_guest_debug: OK [ 379.177265] Testing event kvm_handle_sys_reg: OK [ 379.448956] Testing event trap_reg: OK [ 379.714250] Testing event kvm_arm_set_regset: OK [ 379.994091] Testing event kvm_arm_set_dreg32: OK [ 380.253297] Testing event kvm_arm_clear_debug: OK [ 380.519451] Testing event kvm_arm_setup_debug: OK [ 380.774571] Testing event kvm_hvc_arm64: OK [ 381.093665] Testing event kvm_wfx_arm64: OK [ 381.377706] Testing event vgic_update_irq_pending: OK [ 381.662331] Testing event task_rename: OK [ 381.918418] Testing event task_newtask: OK [ 382.255499] Testing event cpuhp_exit: OK [ 382.586468] Testing event cpuhp_multi_enter: OK [ 382.846559] Testing event cpuhp_enter: OK [ 383.113766] Testing event softirq_raise: OK [ 383.358580] Testing event softirq_exit: OK [ 383.606238] Testing event softirq_entry: OK [ 383.842146] Testing event irq_handler_exit: OK [ 384.157782] Testing event irq_handler_entry: OK [ 384.358407] Testing event signal_deliver: OK [ 384.633111] Testing event signal_generate: OK [ 384.898158] Testing event workqueue_execute_end: OK [ 385.158714] Testing event workqueue_execute_start: OK [ 385.417755] Testing event workqueue_activate_work: OK [ 385.637342] Testing event workqueue_queue_work: OK [ 385.927504] Testing event sched_wake_idle_without_ipi: OK [ 386.185542] Testing event sched_swap_numa: OK [ 386.437505] Testing event sched_stick_numa: OK [ 386.689191] Testing event sched_move_numa: OK [ 386.925337] Testing event sched_process_hang: OK [ 387.197170] Testing event sched_pi_setprio: OK [ 387.449144] Testing event sched_stat_runtime: OK [ 387.737577] Testing event sched_stat_blocked: OK [ 387.993254] Testing event sched_stat_iowait: OK [ 388.257709] Testing event sched_stat_sleep: OK [ 388.522648] Testing event sched_stat_wait: OK [ 388.785074] Testing event sched_process_exec: OK [ 389.065179] Testing event sched_process_fork: OK [ 389.273466] Testing event sched_process_wait: OK [ 389.517662] Testing event sched_wait_task: OK [ 389.842669] Testing event sched_process_exit: OK [ 390.149325] Testing event sched_process_free: OK [ 390.369201] Testing event sched_migrate_task: OK [ 390.637071] Testing event sched_switch: OK [ 390.872968] Testing event sched_wakeup_new: OK [ 391.133989] Testing event sched_wakeup: OK [ 391.410376] Testing event sched_waking: OK [ 391.650678] Testing event sched_kthread_stop_ret: OK [ 391.901634] Testing event sched_kthread_stop: OK [ 392.169256] Testing event lock_acquired: OK [ 392.453264] Testing event lock_contended: OK [ 392.726162] Testing event lock_release: OK [ 393.066389] Testing event lock_acquire: OK [ 393.364919] Testing event console: OK [ 393.625311] Testing event rcu_barrier: OK [ 393.898402] Testing event rcu_torture_read: OK [ 394.154454] Testing event rcu_batch_end: OK [ 394.401496] Testing event rcu_invoke_kfree_callback: OK [ 394.677232] Testing event rcu_invoke_callback: OK [ 394.913721] Testing event rcu_batch_start: OK [ 395.171468] Testing event rcu_kfree_callback: OK [ 395.462472] Testing event rcu_callback: OK [ 395.687421] Testing event rcu_dyntick: OK [ 395.901301] Testing event rcu_fqs: OK [ 396.162072] Testing event rcu_quiescent_state_report: OK [ 396.426193] Testing event rcu_unlock_preempted_task: OK [ 396.653932] Testing event rcu_preempt_task: OK [ 396.902539] Testing event rcu_nocb_wake: OK [ 397.211441] Testing event rcu_exp_funnel_lock: OK [ 397.465128] Testing event rcu_exp_grace_period: OK [ 397.753677] Testing event rcu_grace_period_init: OK [ 397.993468] Testing event rcu_future_grace_period: OK [ 398.245473] Testing event rcu_grace_period: OK [ 398.565219] Testing event rcu_utilization: OK [ 398.833638] Testing event swiotlb_bounced: OK [ 399.129277] Testing event tick_stop: OK [ 399.377060] Testing event itimer_expire: OK [ 399.629482] Testing event itimer_state: OK [ 399.889543] Testing event hrtimer_cancel: OK [ 400.146465] Testing event hrtimer_expire_exit: OK [ 400.394060] Testing event hrtimer_expire_entry: OK [ 400.660966] Testing event hrtimer_start: OK [ 400.934446] Testing event hrtimer_init: OK [ 401.201386] Testing event timer_cancel: OK [ 401.494518] Testing event timer_expire_exit: OK [ 401.745564] Testing event timer_expire_entry: OK [ 401.985501] Testing event timer_start: OK [ 402.241150] Testing event timer_init: OK [ 402.481427] Testing event alarmtimer_cancel: OK [ 402.729246] Testing event alarmtimer_start: OK [ 403.001280] Testing event alarmtimer_fired: OK [ 403.241472] Testing event alarmtimer_suspend: OK [ 403.521924] Testing event module_request: OK [ 403.754367] Testing event module_put: OK [ 404.026221] Testing event module_get: OK [ 404.326334] Testing event module_free: OK [ 404.565300] Testing event module_load: OK [ 404.805318] Testing event cgroup_transfer_tasks: OK [ 405.081108] Testing event cgroup_attach_task: OK [ 405.349303] Testing event cgroup_rename: OK [ 405.618543] Testing event cgroup_release: OK [ 405.857648] Testing event cgroup_rmdir: OK [ 406.122507] Testing event cgroup_mkdir: OK [ 406.383547] Testing event cgroup_remount: OK [ 406.621735] Testing event cgroup_destroy_root: OK [ 406.873936] Testing event cgroup_setup_root: OK [ 407.141246] Testing event irq_enable: OK [ 407.574661] Testing event irq_disable: OK [ 408.021282] Testing event ftrace_test_filter: OK [ 408.281165] Testing event dev_pm_qos_remove_request: OK [ 408.513637] Testing event dev_pm_qos_update_request: OK [ 408.750311] Testing event dev_pm_qos_add_request: OK [ 408.985281] Testing event pm_qos_update_flags: OK [ 409.249604] Testing event pm_qos_update_target: OK [ 409.505179] Testing event pm_qos_update_request_timeout: OK [ 409.757402] Testing event pm_qos_remove_request: OK [ 410.017258] Testing event pm_qos_update_request: OK [ 410.258191] Testing event pm_qos_add_request: OK [ 410.493175] Testing event power_domain_target: OK [ 410.749289] Testing event clock_set_rate: OK [ 410.994641] Testing event clock_disable: OK [ 411.269279] Testing event clock_enable: OK [ 411.526106] Testing event wakeup_source_deactivate: OK [ 411.757299] Testing event wakeup_source_activate: OK [ 412.041292] Testing event suspend_resume: OK [ 412.417725] Testing event device_pm_callback_end: OK [ 412.724982] Testing event device_pm_callback_start: OK [ 412.981667] Testing event cpu_frequency_limits: OK [ 413.237218] Testing event cpu_frequency: OK [ 413.498315] Testing event pstate_sample: OK [ 413.744970] Testing event powernv_throttle: OK [ 414.001395] Testing event cpu_idle: OK [ 414.261628] Testing event rpm_return_int: OK [ 414.501173] Testing event rpm_idle: OK [ 414.749048] Testing event rpm_resume: OK [ 414.989209] Testing event rpm_suspend: OK [ 415.245195] Testing event benchmark_event: OK [ 415.606752] Testing event xdp_devmap_xmit: OK [ 415.837338] Testing event xdp_cpumap_enqueue: OK [ 416.105918] Testing event xdp_cpumap_kthread: OK [ 416.381902] Testing event xdp_redirect_map_err: OK [ 416.629186] Testing event xdp_redirect_map: OK [ 416.858258] Testing event xdp_redirect_err: OK [ 417.118587] Testing event xdp_redirect: OK [ 417.386334] Testing event xdp_exception: OK [ 417.678324] Testing event rseq_ip_fixup: OK [ 417.905455] Testing event rseq_update: OK [ 418.173395] Testing event file_check_and_advance_wb_err: OK [ 418.417591] Testing event filemap_set_wb_err: OK [ 418.673417] Testing event mm_filemap_add_to_page_cache: OK [ 418.921901] Testing event mm_filemap_delete_from_page_cache: OK [ 419.205289] Testing event compact_retry: OK [ 419.453122] Testing event skip_task_reaping: OK [ 419.725609] Testing event finish_task_reaping: OK [ 420.005069] Testing event start_task_reaping: OK [ 420.253547] Testing event wake_reaper: OK [ 420.497597] Testing event mark_victim: OK [ 420.765083] Testing event reclaim_retry_zone: OK [ 421.021588] Testing event oom_score_adj_update: OK [ 421.273793] Testing event mm_lru_activate: OK [ 421.525247] Testing event mm_lru_insertion: OK [ 421.754702] Testing event mm_vmscan_inactive_list_is_low: OK [ 422.001588] Testing event mm_vmscan_lru_shrink_active: OK [ 422.289259] Testing event mm_vmscan_lru_shrink_inactive: OK [ 422.537798] Testing event mm_vmscan_writepage: OK [ 422.814083] Testing event mm_vmscan_lru_isolate: OK [ 423.077241] Testing event mm_shrink_slab_end: OK [ 423.333198] Testing event mm_shrink_slab_start: OK [ 423.689283] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK [ 423.930656] Testing event mm_vmscan_memcg_reclaim_end: OK [ 424.169318] Testing event mm_vmscan_direct_reclaim_end: OK [ 424.413985] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK [ 424.677315] Testing event mm_vmscan_memcg_reclaim_begin: OK [ 424.945573] Testing event mm_vmscan_direct_reclaim_begin: OK [ 425.193753] Testing event mm_vmscan_wakeup_kswapd: OK [ 425.441769] Testing event mm_vmscan_kswapd_wake: OK [ 425.726133] Testing event mm_vmscan_kswapd_sleep: OK [ 425.961381] Testing event percpu_destroy_chunk: OK [ 426.213947] Testing event percpu_create_chunk: OK [ 426.453069] Testing event percpu_alloc_percpu_fail: OK [ 426.720988] Testing event percpu_free_percpu: OK [ 426.970711] Testing event percpu_alloc_percpu: OK [ 427.253193] Testing event mm_fragmentation_stall: OK [ 427.525366] Testing event mm_page_alloc_extfrag: OK [ 427.765459] Testing event mm_page_pcpu_drain: OK [ 428.026678] Testing event mm_page_alloc_zone_locked: OK [ 428.273344] Testing event mm_page_alloc: OK [ 428.575570] Testing event mm_page_free_batched: OK [ 428.834209] Testing event mm_page_free: OK [ 429.141203] Testing event kmem_cache_free: OK [ 429.394057] Testing event kfree: OK [ 429.645521] Testing event kmem_cache_alloc_node: OK [ 429.893579] Testing event kmalloc_node: OK [ 430.185202] Testing event kmem_cache_alloc: OK [ 430.441657] Testing event kmalloc: OK [ 430.778745] Testing event mm_compaction_kcompactd_wake: OK [ 431.093958] Testing event mm_compaction_wakeup_kcompactd: OK [ 431.393239] Testing event mm_compaction_kcompactd_sleep: OK [ 431.622147] Testing event mm_compaction_defer_reset: OK [ 431.853757] Testing event mm_compaction_defer_compaction: OK [ 432.098471] Testing event mm_compaction_deferred: OK [ 432.365806] Testing event mm_compaction_suitable: OK [ 432.621160] Testing event mm_compaction_finished: OK [ 432.869788] Testing event mm_compaction_try_to_compact_pages: OK [ 433.138449] Testing event mm_compaction_end: OK [ 433.382716] Testing event mm_compaction_begin: OK [ 433.633360] Testing event mm_compaction_migratepages: OK [ 433.917565] Testing event mm_compaction_isolate_freepages: OK [ 434.133539] Testing event mm_compaction_isolate_migratepages: OK [ 434.378729] Testing event mm_migrate_pages: OK [ 434.633030] Testing event mm_collapse_huge_page_swapin: OK [ 434.897934] Testing event mm_collapse_huge_page_isolate: OK [ 435.169311] Testing event mm_collapse_huge_page: OK [ 435.437782] Testing event mm_khugepaged_scan_pmd: OK [ 435.709986] Testing event test_pages_isolated: OK [ 435.973232] Testing event cma_release: OK [ 436.229140] Testing event cma_alloc: OK [ 436.473312] Testing event page_ref_unfreeze: OK [ 436.713530] Testing event page_ref_freeze: OK [ 437.015527] Testing event page_ref_mod_unless: OK [ 437.302523] Testing event page_ref_mod_and_return: OK [ 437.644983] Testing event page_ref_mod_and_test: OK [ 438.578707] Testing event page_ref_mod: OK [ 439.070371] Testing event page_ref_set: OK [ 439.389420] Testing event sb_clear_inode_writeback: OK [ 439.685379] Testing event sb_mark_inode_writeback: OK [ 439.941348] Testing event writeback_dirty_inode_enqueue: OK [ 440.226714] Testing event writeback_lazytime_iput: OK [ 440.457956] Testing event writeback_lazytime: OK [ 440.705748] Testing event writeback_single_inode: OK [ 440.970213] Testing event writeback_single_inode_start: OK [ 441.218118] Testing event writeback_wait_iff_congested: OK [ 441.454233] Testing event writeback_congestion_wait: OK [ 441.717955] Testing event writeback_sb_inodes_requeue: OK [ 441.981495] Testing event balance_dirty_pages: OK [ 442.245018] Testing event bdi_dirty_ratelimit: OK [ 442.501457] Testing event global_dirty_state: OK [ 442.773559] Testing event writeback_queue_io: OK [ 443.041371] Testing event wbc_writepage: OK [ 443.289309] Testing event writeback_bdi_register: OK [ 443.517080] Testing event writeback_wake_background: OK [ 443.754314] Testing event writeback_pages_written: OK [ 444.033175] Testing event writeback_wait: OK [ 444.278433] Testing event writeback_written: OK [ 444.549531] Testing event writeback_start: OK [ 444.761840] Testing event writeback_exec: OK [ 445.022619] Testing event writeback_queue: OK [ 445.277352] Testing event writeback_write_inode: OK [ 445.545597] Testing event writeback_write_inode_start: OK [ 445.810420] Testing event writeback_dirty_inode: OK [ 446.041726] Testing event writeback_dirty_inode_start: OK [ 446.338584] Testing event writeback_mark_inode_dirty: OK [ 446.554279] Testing event writeback_dirty_page: OK [ 446.805678] Testing event dax_writeback_one: OK [ 447.085966] Testing event dax_writeback_range_done: OK [ 447.310437] Testing event dax_writeback_range: OK [ 447.577218] Testing event dax_insert_mapping: OK [ 447.841237] Testing event dax_insert_pfn_mkwrite: OK [ 448.065707] Testing event dax_insert_pfn_mkwrite_no_entry: OK [ 448.318401] Testing event dax_load_hole: OK [ 448.589692] Testing event dax_pte_fault_done: OK [ 448.889023] Testing event dax_pte_fault: OK [ 449.173294] Testing event dax_pmd_insert_mapping: OK [ 449.405216] Testing event dax_pmd_load_hole_fallback: OK [ 449.650039] Testing event dax_pmd_load_hole: OK [ 449.894472] Testing event dax_pmd_fault_done: OK [ 450.166549] Testing event dax_pmd_fault: OK [ 450.394035] Testing event generic_add_lease: OK [ 450.633242] Testing event time_out_leases: OK [ 450.890378] Testing event generic_delete_lease: OK [ 451.126733] Testing event break_lease_unblock: OK [ 451.393254] Testing event break_lease_block: OK [ 451.659507] Testing event break_lease_noblock: OK [ 451.897252] Testing event flock_lock_inode: OK [ 452.145308] Testing event locks_remove_posix: OK [ 452.401231] Testing event fcntl_setlk: OK [ 452.653274] Testing event posix_lock_inode: OK [ 452.890241] Testing event locks_get_lock_context: OK [ 453.176952] Testing event block_rq_remap: OK [ 453.417255] Testing event block_bio_remap: OK [ 453.667467] Testing event block_split: OK [ 453.905640] Testing event block_unplug: OK [ 454.174504] Testing event block_plug: OK [ 454.401389] Testing event block_sleeprq: OK [ 454.641230] Testing event block_getrq: OK [ 454.881695] Testing event block_bio_queue: OK [ 455.177401] Testing event block_bio_frontmerge: OK [ 455.404982] Testing event block_bio_backmerge: OK [ 455.673683] Testing event block_bio_complete: OK [ 455.909845] Testing event block_bio_bounce: OK [ 456.173388] Testing event block_rq_issue: OK [ 456.449782] Testing event block_rq_insert: OK [ 456.682706] Testing event block_rq_complete: OK [ 456.934615] Testing event block_rq_requeue: OK [ 457.189584] Testing event block_dirty_buffer: OK [ 457.421206] Testing event block_touch_buffer: OK [ 457.674021] Testing event wbt_timer: OK [ 457.921010] Testing event wbt_step: OK [ 458.202649] Testing event wbt_lat: OK [ 458.453535] Testing event wbt_stat: OK [ 458.670526] Testing event gpio_value: OK [ 458.941438] Testing event gpio_direction: OK [ 459.213011] Testing event clk_set_duty_cycle_complete: OK [ 459.458088] Testing event clk_set_duty_cycle: OK [ 459.737612] Testing event clk_set_phase_complete: OK [ 459.970725] Testing event clk_set_phase: OK [ 460.274313] Testing event clk_set_parent_complete: OK [ 460.561259] Testing event clk_set_parent: OK [ 460.849234] Testing event clk_set_rate_complete: OK [ 461.157966] Testing event clk_set_rate: OK [ 461.470038] Testing event clk_unprepare_complete: OK [ 461.654113] Testing event clk_unprepare: OK [ 461.953046] Testing event clk_prepare_complete: OK [ 462.166042] Testing event clk_prepare: OK [ 462.481769] Testing event clk_disable_complete: OK [ 462.785513] Testing event clk_disable: OK [ 463.146358] Testing event clk_enable_complete: OK [ 463.398393] Testing event clk_enable: OK [ 463.730122] Testing event rpmh_send_msg: OK [ 464.026631] Testing event rpmh_tx_done: OK [ 464.281261] Testing event regulator_set_voltage_complete: OK [ 464.577717] Testing event regulator_set_voltage: OK [ 464.905265] Testing event regulator_disable_complete: OK [ 465.193806] Testing event regulator_disable: OK [ 465.461206] Testing event regulator_enable_complete: OK [ 465.698021] Testing event regulator_enable_delay: OK [ 465.937913] Testing event regulator_enable: OK [ 466.173396] Testing event urandom_read: OK [ 466.402224] Testing event random_read: OK [ 466.670552] Testing event extract_entropy_user: OK [ 466.909005] Testing event extract_entropy: OK [ 467.149253] Testing event get_random_bytes_arch: OK [ 467.398735] Testing event get_random_bytes: OK [ 467.645287] Testing event xfer_secondary_pool: OK [ 467.861172] Testing event add_disk_randomness: OK [ 468.157348] Testing event add_input_randomness: OK [ 468.425902] Testing event debit_entropy: OK [ 468.666163] Testing event push_to_pool: OK [ 468.934655] Testing event credit_entropy_bits: OK [ 469.198469] Testing event mix_pool_bytes_nolock: OK [ 469.481262] Testing event mix_pool_bytes: OK [ 469.717675] Testing event add_device_randomness: OK [ 469.914686] Testing event io_page_fault: OK [ 470.169634] Testing event unmap: OK [ 470.434351] Testing event map: OK [ 470.722095] Testing event detach_device_from_domain: OK [ 470.982632] Testing event attach_device_to_domain: OK [ 471.217633] Testing event remove_device_from_group: OK [ 471.501203] Testing event add_device_to_group: OK [ 471.768953] Testing event regcache_drop_region: OK [ 471.993652] Testing event regmap_async_complete_done: OK [ 472.254141] Testing event regmap_async_complete_start: OK [ 472.577171] Testing event regmap_async_io_complete: OK [ 472.838007] Testing event regmap_async_write_start: OK [ 473.078171] Testing event regmap_cache_bypass: OK [ 473.313411] Testing event regmap_cache_only: OK [ 473.554490] Testing event regcache_sync: OK [ 473.805504] Testing event regmap_hw_write_done: OK [ 474.061927] Testing event regmap_hw_write_start: OK [ 474.325029] Testing event regmap_hw_read_done: OK [ 474.553893] Testing event regmap_hw_read_start: OK [ 474.801329] Testing event regmap_reg_read_cache: OK [ 475.089457] Testing event regmap_reg_read: OK [ 475.414406] Testing event regmap_reg_write: OK [ 475.733374] Testing event dma_fence_wait_end: OK [ 475.997618] Testing event dma_fence_wait_start: OK [ 476.241468] Testing event dma_fence_signaled: OK [ 476.495421] Testing event dma_fence_enable_signal: OK [ 476.814617] Testing event dma_fence_destroy: OK [ 477.049267] Testing event dma_fence_init: OK [ 477.305180] Testing event dma_fence_emit: OK [ 477.546655] Testing event sync_timeline: OK [ 477.801246] Testing event spi_transfer_stop: OK [ 478.094673] Testing event spi_transfer_start: OK [ 478.390670] Testing event spi_message_done: OK [ 478.646319] Testing event spi_message_start: OK [ 478.893249] Testing event spi_message_submit: OK [ 479.121782] Testing event spi_controller_busy: OK [ 479.369384] Testing event spi_controller_idle: OK [ 479.625710] Testing event rtc_timer_fired: OK [ 479.897192] Testing event rtc_timer_dequeue: OK [ 480.149234] Testing event rtc_timer_enqueue: OK [ 480.421307] Testing event rtc_read_offset: OK [ 480.682657] Testing event rtc_set_offset: OK [ 480.946413] Testing event rtc_alarm_irq_enable: OK [ 481.229133] Testing event rtc_irq_set_state: OK [ 481.517793] Testing event rtc_irq_set_freq: OK [ 481.778252] Testing event rtc_read_alarm: OK [ 481.986364] Testing event rtc_set_alarm: OK [ 482.241079] Testing event rtc_read_time: OK [ 482.470194] Testing event rtc_set_time: OK [ 482.745147] Testing event memory_failure_event: OK [ 482.965372] Testing event aer_event: OK [ 483.213841] Testing event non_standard_event: OK [ 483.473274] Testing event arm_event: OK [ 483.737150] Testing event mc_event: OK [ 484.066696] Testing event binder_return: OK [ 484.329278] Testing event binder_command: OK [ 484.569287] Testing event binder_unmap_kernel_end: OK [ 484.821483] Testing event binder_unmap_kernel_start: OK [ 485.057957] Testing event binder_unmap_user_end: OK [ 485.322574] Testing event binder_unmap_user_start: OK [ 485.590388] Testing event binder_alloc_page_end: OK [ 485.873196] Testing event binder_alloc_page_start: OK [ 486.133341] Testing event binder_free_lru_end: OK [ 486.369250] Testing event binder_free_lru_start: OK [ 486.657267] Testing event binder_alloc_lru_end: OK [ 486.849748] Testing event binder_alloc_lru_start: OK [ 487.098455] Testing event binder_update_page_range: OK [ 487.360913] Testing event binder_transaction_failed_buffer_release: OK [ 487.657815] Testing event binder_transaction_buffer_release: OK [ 487.913140] Testing event binder_transaction_alloc_buf: OK [ 488.145920] Testing event binder_transaction_fd_recv: OK [ 488.401282] Testing event binder_transaction_fd_send: OK [ 488.633615] Testing event binder_transaction_ref_to_ref: OK [ 488.889691] Testing event binder_transaction_ref_to_node: OK [ 489.165176] Testing event binder_transaction_node_to_ref: OK [ 489.445455] Testing event binder_transaction_received: OK [ 489.674130] Testing event binder_transaction: OK [ 489.921467] Testing event binder_wait_for_work: OK [ 490.157013] Testing event binder_read_done: OK [ 490.427641] Testing event binder_write_done: OK [ 490.678628] Testing event binder_ioctl_done: OK [ 490.941994] Testing event binder_unlock: OK [ 491.173449] Testing event binder_locked: OK [ 491.433883] Testing event binder_lock: OK [ 491.773052] Testing event binder_ioctl: OK [ 492.014615] Testing event br_fdb_update: OK [ 492.293958] Testing event fdb_delete: OK [ 492.517617] Testing event br_fdb_external_learn_add: OK [ 492.741950] Testing event br_fdb_add: OK [ 492.974389] Testing event qdisc_dequeue: OK [ 493.241403] Testing event fib_table_lookup: OK [ 493.498684] Testing event tcp_probe: OK [ 493.740959] Testing event tcp_retransmit_synack: OK [ 493.969458] Testing event tcp_rcv_space_adjust: OK [ 494.217011] Testing event tcp_destroy_sock: OK [ 494.502650] Testing event tcp_receive_reset: OK [ 494.745242] Testing event tcp_send_reset: OK [ 494.990372] Testing event tcp_retransmit_skb: OK [ 495.243450] Testing event udp_fail_queue_rcv_skb: OK [ 495.481792] Testing event inet_sock_set_state: OK [ 495.710449] Testing event sock_exceed_buf_limit: OK [ 495.945268] Testing event sock_rcvqueue_full: OK [ 496.197091] Testing event napi_poll: OK [ 496.450042] Testing event netif_receive_skb_list_exit: OK [ 496.694451] Testing event netif_rx_ni_exit: OK [ 496.946205] Testing event netif_rx_exit: OK [ 497.181177] Testing event netif_receive_skb_exit: OK [ 497.462459] Testing event napi_gro_receive_exit: OK [ 497.698099] Testing event napi_gro_frags_exit: OK [ 497.954753] Testing event netif_rx_ni_entry: OK [ 498.174039] Testing event netif_rx_entry: OK [ 498.432946] Testing event netif_receive_skb_list_entry: OK [ 498.689889] Testing event netif_receive_skb_entry: OK [ 498.949588] Testing event napi_gro_receive_entry: OK [ 499.198297] Testing event napi_gro_frags_entry: OK [ 499.446709] Testing event netif_rx: OK [ 499.729690] Testing event netif_receive_skb: OK [ 499.966198] Testing event net_dev_queue: OK [ 500.225591] Testing event net_dev_xmit: OK [ 500.478026] Testing event net_dev_start_xmit: OK [ 500.701150] Testing event skb_copy_datagram_iovec: OK [ 500.969102] Testing event consume_skb: OK [ 501.209606] Testing event kfree_skb: OK [ 501.454057] Testing event 9p_protocol_dump: OK [ 501.737359] Testing event 9p_client_res: OK [ 501.982069] Testing event 9p_client_req: OK [ 502.194437] Running tests on trace event systems: [ 502.205611] Testing event system 9p: OK [ 502.537407] Testing event system skb: OK [ 502.874179] Testing event system net: OK [ 503.274391] Testing event system napi: OK [ 503.662492] Testing event system sock: OK [ 504.026218] Testing event system udp: OK [ 504.313017] Testing event system tcp: OK [ 504.610381] Testing event system fib: OK [ 504.914026] Testing event system qdisc: OK [ 505.150008] Testing event system bridge: OK [ 505.443409] Testing event system binder: OK [ 505.946679] Testing event system ras: OK [ 506.457151] Testing event system rtc: OK [ 506.818609] Testing event system spi: OK [ 507.197027] Testing event system sync_trace: OK [ 507.509350] Testing event system dma_fence: OK [ 507.874242] Testing event system regmap: OK [ 508.305027] Testing event system iommu: OK [ 508.652931] Testing event system random: OK [ 509.069252] Testing event system regulator: OK [ 509.481633] Testing event system rpmh: OK [ 509.770420] Testing event system clk: OK [ 510.156972] Testing event system gpio: OK [ 510.510101] Testing event system wbt: OK [ 510.821876] Testing event system block: OK [ 511.298407] Testing event system filelock: OK [ 511.705275] Testing event system fs_dax: OK [ 512.157985] Testing event system writeback: OK [ 512.645074] Testing event system page_ref: OK [ 514.053258] Testing event system cma: OK [ 514.389570] Testing event system page_isolation: OK [ 514.657396] Testing event system huge_memory: OK [ 514.965431] Testing event system migrate: OK [ 515.241361] Testing event system compaction: OK [ 515.607723] Testing event system kmem: OK [ 515.998536] Testing event system percpu: OK [ 516.394527] Testing event system vmscan: OK [ 516.787435] Testing event system pagemap: OK [ 517.173943] Testing event system oom: OK [ 517.518679] Testing event system filemap: OK [ 517.846438] Testing event system rseq: OK [ 518.167482] Testing event system xdp: OK [ 518.488988] Testing event system benchmark: OK [ 518.906092] Testing event system rpm: OK [ 519.194489] Testing event system power: OK [ 519.773630] Testing event system test: OK [ 520.212967] Testing event system preemptirq: OK [ 520.750426] Testing event system cgroup: OK [ 521.146218] Testing event system module: OK [ 521.513779] Testing event system alarmtimer: OK [ 521.861008] Testing event system timer: OK [ 522.246509] Testing event system swiotlb: OK [ 522.585416] Testing event system rcu: OK [ 523.061237] Testing event system printk: OK [ 523.450461] Testing event system lock: OK [ 523.961694] Testing event system sched: OK [ 524.430650] Testing event system workqueue: OK [ 524.862177] Testing event system signal: OK [ 525.161702] Testing event system irq: OK [ 525.450617] Testing event system cpuhp: OK [ 525.818497] Testing event system task: OK [ 526.041868] Testing event system kvm: OK [ 526.533960] Testing event system emulation: OK [ 526.990405] Testing event system ipi: OK [ 527.233519] Testing event system syscalls: OK [ 527.845552] Testing event system raw_syscalls: OK [ 528.145332] Testing event system initcall: OK [ 528.474270] Running tests on all trace events: [ 528.485138] Testing all events: OK [ 563.262051] ftrace_replace_code: 1 [ 574.085221] ../kernel/trace/ftrace.c:2449, loop_counter: 42037 [ 574.093979] Testing ftrace filter: OK [ 574.316601] trace_kprobe: Testing kprobe tracing: OK [ 575.273103] Loading compiled-in X.509 certificates [ 575.441817] _warn_unseeded_randomness: 1 callbacks suppressed [ 575.442152] random: get_random_bytes called from key_alloc+0x500/0xa48 with crng_init=0 [ 575.446671] Loaded X.509 cert 'Build time autogenerated kernel key: ef4425a12675de91b49c005bf61fbcc152bd6e38' [ 575.475763] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 575.477162] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 575.532379] zswap: default zpool zbud not available [ 575.533680] zswap: pool creation failed [ 575.580075] page_owner is disabled [ 575.872334] cryptomgr_probe (1272) used greatest stack depth: 11376 bytes left [ 575.877791] Key type big_key registered [ 576.012362] Key type encrypted registered [ 576.020289] ima: No TPM chip found, activating TPM-bypass! [ 576.023631] ima: Allocated hash algorithm: sha1 [ 576.028292] No architecture policies found [ 576.041160] evm: Initialising EVM extended attributes: [ 576.041961] evm: security.selinux [ 576.042671] evm: security.SMACK64 [ 576.044030] evm: security.SMACK64EXEC [ 576.044701] evm: security.SMACK64TRANSMUTE [ 576.045390] evm: security.SMACK64MMAP [ 576.046012] evm: security.apparmor [ 576.047360] evm: security.ima [ 576.047985] evm: security.capability [ 576.048665] evm: HMAC attrs: 0x1 [ 576.151982] hctosys: unable to open rtc device (rtc0) [ 576.188001] psci_checker: PSCI checker started using 1 CPUs [ 576.188773] psci_checker: Starting hotplug tests [ 576.191520] psci_checker: Trying to turn off and on again all CPUs [ 576.192797] psci_checker: Trying to turn off and on again group 0 (CPUs 0) [ 576.194616] psci_checker: Hotplug tests passed OK [ 576.196025] psci_checker: Starting suspend tests (10 cycles per state) [ 576.197150] psci_checker: cpuidle not available on CPU 0, ignoring [ 576.198422] psci_checker: Could not start suspend tests on any CPU [ 576.199887] psci_checker: PSCI checker completed [ 576.292341] Duplicate name in testcase-data, renamed to "duplicate-name#1" [ 576.628805] ### dt-test ### start of unittest - you will see error messages [ 576.678577] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 576.680630] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1 [ 576.682033] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 576.683923] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle [ 576.685248] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property [ 576.686643] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property [ 576.720925] OF: /testcase-data/phandle-tests/consumer-b: could not get #phandle-missing-cells for /testcase-data/phandle-tests/provider1 [ 576.724875] OF: /testcase-data/phandle-tests/consumer-b: could not find phandle [ 576.728603] OF: /testcase-data/phandle-tests/consumer-b: arguments longer than property [ 577.172272] _warn_unseeded_randomness: 2 callbacks suppressed [ 577.172555] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 577.174294] kobject: 'testcase-data:platform-tests:test-device@1' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 577.202697] kobject: 'testcase-data:platform-tests:test-device@0' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 577.224205] kobject: 'unittest-bus.0' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 577.336811] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 577.501842] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest0/status [ 577.594121] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest1/status [ 577.622269] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 577.624452] kobject: 'testcase-data:overlay-node:test-bus:test-unittest1' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 577.641093] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest2/status [ 577.728479] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest3/status [ 577.753310] kobject: 'testcase-data:overlay-node:test-bus:test-unittest3' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 577.871688] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest5/status [ 577.974324] kobject: 'testcase-data:overlay-node:test-bus:test-unittest5' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 577.997080] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest6/status [ 578.077808] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest7/status [ 578.181299] _warn_unseeded_randomness: 5 callbacks suppressed [ 578.181580] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 578.184082] kobject: 'testcase-data:overlay-node:test-bus:test-unittest7' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 578.211464] kobject: 'testcase-data:overlay-node:test-bus:test-unittest6' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 578.228703] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/status [ 578.308402] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 578.309739] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/property-foo [ 578.313460] OF: overlay: node_overlaps_later_cs: #6 overlaps with #7 @/testcase-data/overlay-node/test-bus/test-unittest8 [ 578.315729] OF: overlay: overlay #6 is not topmost [ 578.343937] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 578.345078] kobject: 'testcase-data:overlay-node:test-bus:test-unittest8' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 578.791543] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11:test-unittest111' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 578.815947] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 578.818673] 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 [ 578.822657] 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 [ 578.827540] OF: overlay: remove: Could not find overlay #7 [ 578.828436] ### dt-test ### of_unittest_destroy_tracked_overlays: no overlay to destroy for #7 [ 578.863915] kobject: 'testcase-data:overlay-node:test-bus:test-unittest10:test-unittest101' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 578.888259] kobject: 'testcase-data:overlay-node:test-bus:test-unittest10' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 578.891636] 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 [ 578.895889] 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 [ 578.925400] kobject: 'testcase-data:overlay-node:test-bus:test-unittest4' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 578.928785] 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 [ 579.028414] kobject: 'testcase-data:overlay-node:test-bus:test-unittest2' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 579.128895] kobject: 'testcase-data:overlay-node:test-bus:test-unittest0' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 579.257436] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/status [ 579.266494] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/status [ 579.270700] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/ride@100/track@30/incline-up [ 579.273625] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/ride@100/track@40/incline-up [ 579.296072] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/status [ 579.297991] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/color [ 579.300601] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/rate [ 579.304086] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/hvac_2 [ 579.306318] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200 [ 579.309511] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200_left [ 579.312337] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200_right [ 579.507812] OF: overlay: ERROR: multiple fragments add and/or delete node /testcase-data-2/substation@100/motor-1/controller [ 579.515639] OF: overlay: ERROR: multiple fragments add, update, and/or delete property /testcase-data-2/substation@100/motor-1/controller/name [ 579.518600] _warn_unseeded_randomness: 5 callbacks suppressed [ 579.520222] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 579.521278] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 579.524546] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 579.538737] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/motor-1/rpm_avail [ 579.541483] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/motor-1/rpm_avail [ 579.544521] OF: overlay: ERROR: multiple fragments add, update, and/or delete property /testcase-data-2/substation@100/motor-1/rpm_avail [ 579.568163] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 579.574482] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 579.576324] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 579.579748] ### dt-test ### end of unittest - 217 passed, 0 failed [ 579.645414] uart-pl011 9000000.pl011: no DMA platform data [ 580.283553] VFS: Mounted root (9p filesystem) readonly on device 0:19. [ 580.313000] devtmpfs: mounted [ 580.358478] integrity: Unable to open file: /etc/keys/x509_ima.der (-2) [ 580.389893] integrity: Unable to open file: /etc/keys/x509_evm.der (-2) [ 581.909634] Freeing unused kernel memory: 6144K [ 581.932576] _warn_unseeded_randomness: 3 callbacks suppressed [ 581.932861] random: get_random_u32 called from kobject_release+0x44/0x1e8 with crng_init=0 [ 581.935717] kobject: 'test-unittest111' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 581.940965] kobject: 'test-unittest11' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 581.945828] kobject: 'test-unittest101' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 581.950099] kobject: 'test-unittest4' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 581.961587] kobject: 'test-unittest10' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 582.668051] Checked W+X mappings: passed, no W+X pages found [ 582.669204] rodata_test: all tests were successful [ 582.670508] Run /sbin/init as init process [ 582.738466] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 582.909990] random: get_random_u64 called from arch_mmap_rnd+0xb8/0xd0 with crng_init=0 [ 582.975962] _warn_unseeded_randomness: 3 callbacks suppressed [ 582.976270] random: get_random_bytes called from create_elf_tables+0x188/0x17bc with crng_init=0 [ 582.991921] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest4 [ 582.997177] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest10/test-unittest101 [ 583.004449] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest11 [ 583.540383] random: get_random_u32 called from shuffle_freelist+0xb4/0x398 with crng_init=0 [ 584.795225] random: fast init done [ 584.991789] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest10 [ 586.018214] OF: ERROR: memory leak before free overlay changeset, /testcase-data/overlay-node/test-bus/test-unittest11/test-unittest111 SELinux: Could not open policy file <= /etc/selinux/targeted/policy/policy.31: No such file or directory