[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 4.20.0-rc4-next-20181128-00009-g44c557177b8d-dirty (anders@compilator) (gcc version 7.3.1 20180425 [linaro-7.3-2018.05 revision d29120a424ecfbc167ef90065c0eeb7f91977701] (Linaro GCC 7.3-2018.05)) #28 SMP Thu Nov 29 18:15:07 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 0xbebf15c0-0xbebf2fff]
[    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+0xe0/0x6ec 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: 993264K/2097152K available (15804K kernel code, 3774K rwdata, 4852K rodata, 6144K init, 23374K bss, 94304K reserved, 16384K cma-reserved)
[    0.000000] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[    0.000000] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] ftrace: allocating 41840 entries in 164 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.000239] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns
[    0.014900] Console: colour dummy device 80x25
[    0.018966] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.019434] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.019797] ... MAX_LOCK_DEPTH:          48
[    0.020151] ... MAX_LOCKDEP_KEYS:        8191
[    0.020519] ... CLASSHASH_SIZE:          4096
[    0.020879] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.021236] ... MAX_LOCKDEP_CHAINS:      65536
[    0.021606] ... CHAINHASH_SIZE:          32768
[    0.022315]  memory used by lock dependency info: 7775 kB
[    0.022692]  per task-struct memory footprint: 2688 bytes
[    0.023100] ------------------------
[    0.023435] | Locking API testsuite:
[    0.023762] ----------------------------------------------------------------------------
[    0.024189]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.024622]   --------------------------------------------------------------------------
[    0.025424]                      A-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.036786]                  A-B-B-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.047640]              A-B-B-C-C-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.058665]              A-B-C-A-B-C deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.070063]          A-B-B-C-C-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.081820]          A-B-C-D-B-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.093853]          A-B-C-D-B-C-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.105544]                     double unlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.115535]                   initialize held:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.125328]   --------------------------------------------------------------------------
[    0.125861]               recursive read-lock:             |  ok  |             |  ok  |
[    0.129429]            recursive read-lock #2:             |  ok  |             |  ok  |
[    0.132632]             mixed read-write-lock:             |  ok  |             |  ok  |
[    0.136295]             mixed write-read-lock:             |  ok  |             |  ok  |
[    0.139782]   mixed read-lock/lock-write ABBA:             |FAILED|             |  ok  |
[    0.143080]    mixed read-lock/lock-read ABBA:             |  ok  |             |  ok  |
[    0.146490]  mixed write-lock/lock-write ABBA:             |  ok  |             |  ok  |
[    0.150183]   --------------------------------------------------------------------------
[    0.151020]      hard-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.156190]      soft-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.161841]      hard-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.166654]      soft-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.171462]        sirq-safe-A => hirqs-on/12:  ok  |  ok  |  ok  |
[    0.176446]        sirq-safe-A => hirqs-on/21:  ok  |  ok  |  ok  |
[    0.181397]          hard-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.186303]          soft-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.191350]          hard-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.196317]          soft-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.201262]     hard-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.206396]     soft-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.211703]     hard-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.216790]     soft-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.222160]     hard-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.227294]     soft-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.232342]     hard-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.237436]     soft-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.242505]     hard-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.247499]     soft-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.252487]     hard-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.257547]     soft-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.262616]     hard-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.267836]     soft-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.272990]     hard-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.278081]     soft-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.283241]     hard-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.288387]     soft-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.293541]     hard-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.298837]     soft-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.303993]     hard-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.309358]     soft-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.314708]     hard-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.319899]     soft-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.325169]       hard-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.330390]       soft-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.335506]       hard-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.340697]       soft-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.345948]       hard-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.351013]       soft-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.356210]       hard-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.361407]       soft-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.366592]       hard-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.371674]       soft-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.376981]       hard-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.382192]       soft-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.387390]       hard-irq read-recursion/123:  ok  |
[    0.389375]       soft-irq read-recursion/123:  ok  |
[    0.391673]       hard-irq read-recursion/132:  ok  |
[    0.393674]       soft-irq read-recursion/132:  ok  |
[    0.395934]       hard-irq read-recursion/213:  ok  |
[    0.397959]       soft-irq read-recursion/213:  ok  |
[    0.400195]       hard-irq read-recursion/231:  ok  |
[    0.402143]       soft-irq read-recursion/231:  ok  |
[    0.404408]       hard-irq read-recursion/312:  ok  |
[    0.406334]       soft-irq read-recursion/312:  ok  |
[    0.408594]       hard-irq read-recursion/321:  ok  |
[    0.410523]       soft-irq read-recursion/321:  ok  |
[    0.412775]   --------------------------------------------------------------------------
[    0.413204]   | Wound/wait tests |
[    0.413544]   ---------------------
[    0.413856]                   ww api failures:  ok  |  ok  |  ok  |
[    0.420635]                ww contexts mixing:  ok  |  ok  |
[    0.423747]              finishing ww context:  ok  |  ok  |  ok  |  ok  |
[    0.430429]                locking mismatches:  ok  |  ok  |  ok  |
[    0.435232]                  EDEADLK handling:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.451560]            spinlock nest unlocked:  ok  |
[    0.453711]   -----------------------------------------------------
[    0.454099]                                  |block | try  |context|
[    0.454470]   -----------------------------------------------------
[    0.454868]                           context:  ok  |  ok  |  ok  |
[    0.459819]                               try:  ok  |  ok  |  ok  |
[    0.464531]                             block:  ok  |  ok  |  ok  |
[    0.469211]                          spinlock:  ok  |  ok  |  ok  |
[    0.474283] -------------------------------------------------------
[    0.474702] Good, all 261 testcases passed! |
[    0.475065] ---------------------------------
[    0.529888] ODEBUG: selftest passed
[    0.534186] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000)
[    0.534955] pid_max: default: 32768 minimum: 301
[    0.544493] LSM: Security Framework initializing
[    0.545606] Yama: becoming mindful.
[    0.547792] LoadPin: ready to pin (currently enforcing)
[    0.548541] SELinux:  Initializing.
[    0.555505] *** VALIDATE SELinux ***
[    0.556348] AppArmor: AppArmor disabled by boot time parameter
[    0.586344] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[    0.598251] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.601093] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)
[    0.602174] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes)
[    0.636701] *** VALIDATE proc ***
[    0.654730] *** VALIDATE cgroup1 ***
[    0.655181] *** VALIDATE cgroup2 ***
[    0.718715] ASID allocator initialised with 32768 entries
[    0.728115] rcu: Hierarchical SRCU implementation.
[    0.800322] EFI services will not be available.
[    0.825465] smp: Bringing up secondary CPUs ...
[    0.826485] smp: Brought up 1 node, 1 CPU
[    0.826881] SMP: Total of 1 processors activated.
[    0.827409] CPU features: detected: 32-bit EL0 Support
[    0.828005] CPU features: detected: CRC32 instructions
[    1.078328] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching
[    1.079173] CPU: All CPU(s) started at EL1
[    1.080406] alternatives: patching kernel code
[    4.785211] node 0 initialised, 248300 pages in 4ms
[    4.792894] pgdatinit0 (15) used greatest stack depth: 13280 bytes left
[    4.865381] devtmpfs: initialized
[    5.038915] gcov: version magic: 0x4137332a
[    5.044144] _warn_unseeded_randomness: 103 callbacks suppressed
[    5.044547] random: get_random_u32 called from bucket_table_alloc+0x130/0x1a8 with crng_init=0
[    5.047738] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[    5.048574] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[    5.062174] Registered cp15_barrier emulation handler
[    5.063213] Registered setend emulation handler
[    5.710968] workqueue: round-robin CPU selection forced, expect performance impact
[    9.544318] DMA-API: preallocated 65536 debug entries
[    9.544799] DMA-API: debugging enabled by kernel config
[    9.546022] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[    9.548551] futex hash table entries: 256 (order: 3, 32768 bytes)
[    9.553653] Running postponed tracer tests:
[    9.558707] Testing tracer function: 
[    9.594278] ftrace_replace_code: 1
[   17.638493] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   17.886356] ftrace_replace_code: 1
[   24.851493] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   24.855361] PASSED
[   24.855742] Testing dynamic ftrace: 
[   26.595709] ftrace_replace_code: 1
[   26.610391] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   26.849342] PASSED
[   26.849916] Testing dynamic ftrace ops #1: 
[   33.785258] ftrace_replace_code: 1
[   33.801235] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   33.805409] (1 0 1 0 0) 
[   33.805597] (1 1 2 0 0) 
[   33.818815] ftrace_replace_code: 1
[   43.986643] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   43.988688] (2 1 3 0 860065) 
[   43.988925] (2 2 4 0 860080) 
[   44.002279] ftrace_replace_code: 1
[   51.890252] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   51.904093] ftrace_replace_code: 1
[   51.917238] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   51.921409] ftrace_replace_code: 1
[   51.934639] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   51.938331] PASSED
[   51.938684] Testing dynamic ftrace ops #2: 
[   58.862518] ftrace_replace_code: 1
[   58.878891] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   58.882720] ftrace_replace_code: 1
[   58.898357] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   58.918714] ftrace_replace_code: 1
[   68.426431] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   68.428240] (1 0 1 838438 0) 
[   68.429538] (1 1 2 838687 0) 
[   68.445611] (2 1 3 1 705) 
[   68.446546] (2 2 4 117 821) 
[   68.484150] ftrace_replace_code: 1
[   75.451522] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   75.453882] PASSED
[   75.454283] Testing ftrace recursion: 
[   77.188694] ftrace_replace_code: 1
[   77.203801] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   77.207763] ftrace_replace_code: 1
[   77.220827] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   77.222397] PASSED
[   77.222749] Testing ftrace recursion safe: 
[   78.954255] ftrace_replace_code: 1
[   78.968399] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   78.972364] ftrace_replace_code: 1
[   78.985775] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   78.987759] PASSED
[   78.988107] Testing ftrace regs(no arch support): 
[   80.722425] ftrace_replace_code: 1
[   80.737141] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   80.741022] ftrace_replace_code: 1
[   80.754262] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   80.756008] PASSED
[   80.756607] Testing tracer nop: PASSED
[   80.758703] Testing tracer irqsoff: 
[   80.775649] ftrace_replace_code: 1
[   88.704697] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   88.735319] ftrace_replace_code: 1
[   95.737319] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[   95.739889] PASSED
[   95.741714] Testing tracer wakeup: 
[   95.771342] ftrace_replace_code: 1
[  103.627048] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  103.659182] ftrace_replace_code: 1
[  110.661972] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  110.670421] PASSED
[  110.671176] Testing tracer wakeup_rt: 
[  110.697834] ftrace_replace_code: 1
[  118.561326] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  118.583536] ftrace_replace_code: 1
[  125.565617] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  125.574077] PASSED
[  125.574832] Testing tracer wakeup_dl: 
[  125.600783] ftrace_replace_code: 1
[  133.464453] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  133.493128] ftrace_replace_code: 1
[  140.473121] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  140.481635] PASSED
[  140.483093] Testing tracer function_graph: 
[  140.483228] ../kernel/trace/trace_selftest.c:766
[  140.484546] ../kernel/trace/trace_selftest.c:768
[  140.484975] ../kernel/trace/trace_selftest.c:770
[  140.508476] ftrace_replace_code: 1
[  148.155971] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  148.160272] ../kernel/trace/trace_selftest.c:773
[  148.192182] ../kernel/trace/trace_selftest.c:778
[  148.443252] ../kernel/trace/trace_selftest.c:780
[  149.400570] ../kernel/trace/trace_selftest.c:792
[  149.418944] ../kernel/trace/trace_selftest.c:794
[  149.421949] ../kernel/trace/trace_selftest.c:797
[  149.436144] ../kernel/trace/trace_selftest.c:799
[  149.457298] ftrace_replace_code: 1
[  157.579166] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  157.582206] ../kernel/trace/trace_selftest.c:802
[  157.582730] ../kernel/trace/trace_selftest.c:804
[  157.583332] PASSED
[  157.656297] _warn_unseeded_randomness: 2 callbacks suppressed
[  157.656525] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  157.658285] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  157.660137] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  157.675534] prandom: seed boundary self test passed
[  157.710854] prandom: 100 self tests passed
[  157.716110] pinctrl core: initialized pinctrl subsystem
[  157.797615] regulator-dummy: Failed to create debugfs directory
[  157.804777] 
[  157.805114] *************************************************************
[  157.805583] **     NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE    **
[  157.806026] **                                                         **
[  157.806459] **  IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL  **
[  157.806942] **                                                         **
[  157.807378] ** This means that this kernel is built to expose internal **
[  157.808212] ** IOMMU data structures, which may compromise security on **
[  157.808658] ** your system.                                            **
[  157.809091] **                                                         **
[  157.809509] ** If you see this message and you are not debugging the   **
[  157.809911] ** kernel, report this immediately to your vendor!         **
[  157.810312] **                                                         **
[  157.810711] **     NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE    **
[  157.811130] *************************************************************
[  157.835304] DMI not present or invalid.
[  157.875843] NET: Registered protocol family 16
[  157.898687] audit: initializing netlink subsys (disabled)
[  158.012794] cpuidle: using governor ladder
[  158.014150] cpuidle: using governor menu
[  158.030021] vdso: 2 pages (1 code @ (____ptrval____), 1 data @ (____ptrval____))
[  158.031428] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers.
[  158.034982] audit: type=2000 audit(136.612:1): state=initialized audit_enabled=0 res=1
[  158.132340] DMA: preallocated 256 KiB pool for atomic allocations
[  158.202549] Serial: AMBA PL011 UART driver
[  158.745068] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 39, base_baud = 0) is a PL011 rev1
[  158.747468] printk: console [ttyAMA0] enabled
[  158.747468] printk: console [ttyAMA0] enabled
[  158.748404] printk: bootconsole [pl11] disabled
[  158.748404] printk: bootconsole [pl11] disabled
[  158.830353] _warn_unseeded_randomness: 42 callbacks suppressed
[  158.830565] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  158.832279] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  159.197687] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  159.242263] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
[  159.348182] kobject: 'renesas,r9a06g032-sysctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000)
[  159.355801] kobject: 'renesas-cpg-mssr' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250)
[  159.397644] arm-v7s io-pgtable: self test ok
[  159.399115] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 32
[  159.406574] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 36
[  159.411192] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 40
[  159.416440] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 42
[  159.422773] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 44
[  159.427924] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 48
[  159.433333] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 32
[  159.441929] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 36
[  159.451947] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 40
[  159.461811] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 42
[  159.471777] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 44
[  159.482121] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 48
[  159.493899] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 32
[  159.520987] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 36
[  159.547672] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 40
[  159.576321] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 42
[  159.607796] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 44
[  159.639502] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 48
[  159.671725] arm-lpae io-pgtable: selftest: completed with 18 PASS 0 FAIL
[  159.695588] vgaarb: loaded
[  159.729486] pps_core: LinuxPPS API ver. 1 registered
[  159.730028] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[  159.733297] PTP clock support registered
[  159.739478] kobject: 'brcmstb-reboot' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500)
[  159.862488] NetLabel: Initializing
[  159.863011] NetLabel:  domain hash size = 128
[  159.863474] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
[  159.870051] NetLabel:  unlabeled traffic allowed by default
[  159.887485] clocksource: Switched to clocksource arch_sys_counter
[  163.724207] _warn_unseeded_randomness: 41 callbacks suppressed
[  163.724423] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  163.725707] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  163.728383] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  163.740305] VFS: Disk quotas dquot_6.6.0
[  163.744273] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[  163.765367] *** VALIDATE hugetlbfs ***
[  164.413385] NET: Registered protocol family 2
[  164.447927] tcp_listen_portaddr_hash hash table entries: 1024 (order: 4, 90112 bytes)
[  164.452319] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[  164.471357] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes)
[  164.482810] TCP: Hash tables configured (established 16384 bind 16384)
[  164.489919] UDP hash table entries: 1024 (order: 5, 196608 bytes)
[  164.495355] UDP-Lite hash table entries: 1024 (order: 5, 196608 bytes)
[  164.512021] NET: Registered protocol family 1
[  164.515955] NET: Registered protocol family 44
[  164.576386] hw perfevents: enabled with armv8_pmuv3 PMU driver, 1 counters available
[  164.585022] kvm [1]: HYP mode not available
[  164.789739] Kprobe smoke test: started
[  165.864040] Kprobe smoke test: passed successfully
[  165.915774] Initialise system trusted keyrings
[  165.917277] _warn_unseeded_randomness: 60 callbacks suppressed
[  165.917509] random: get_random_bytes called from key_alloc+0x380/0x698 with crng_init=0
[  165.923619] Key type blacklist registered
[  165.927915] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=0
[  165.937589] workingset: timestamp_bits=44 max_order=19 bucket_order=0
[  167.448046] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  167.448971] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  167.467513] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  167.620409] 9p: Installing v9fs 9p2000 file system support
[  167.701664] Allocating IMA blacklist keyring.
[  167.714913] cryptomgr_test (37) used greatest stack depth: 12400 bytes left
[  167.732778] kworker/u2:1 (38) used greatest stack depth: 11936 bytes left
[  168.476720] Key type asymmetric registered
[  168.480201] Asymmetric key parser 'x509' registered
[  168.485326] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245)
[  168.496307] _warn_unseeded_randomness: 26 callbacks suppressed
[  168.496522] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  168.497765] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  168.522772] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  168.648669] kobject: 'brcm-gisb-arb' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000)
[  168.721060] kobject: 'armada-37xx-pinctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500)
[  168.861493] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered
[  168.866096] pl061_gpio 9030000.pl061: Unbalanced pm_runtime_enable!
[  168.885443] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered
[  168.904687] kobject: 'stmpe-pwm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250)
[  168.925490] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[  168.983020] pci-host-generic 3f000000.pcie: host bridge /pcie@10000000 ranges:
[  168.985027] pci-host-generic 3f000000.pcie:    IO 0x3eff0000..0x3effffff -> 0x00000000
[  168.987456] pci-host-generic 3f000000.pcie:   MEM 0x10000000..0x3efeffff -> 0x10000000
[  168.988597] pci-host-generic 3f000000.pcie:   MEM 0x8000000000..0xffffffffff -> 0x8000000000
[  168.992004] pci-host-generic 3f000000.pcie: ECAM at [mem 0x3f000000-0x3fffffff] for [bus 00-0f]
[  169.005264] pci-host-generic 3f000000.pcie: PCI host bridge to bus 0000:00
[  169.006865] pci_bus 0000:00: root bus resource [bus 00-0f]
[  169.007715] pci_bus 0000:00: root bus resource [io  0x0000-0xffff]
[  169.008491] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
[  169.009301] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]
[  169.013145] pci 0000:00:00.0: calling  quirk_mmio_always_on+0x0/0x38 @ 1
[  169.014086] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x38 took 73 usecs
[  169.085322] pci 0000:00:01.0: BAR 6: assigned [mem 0x10000000-0x1003ffff pref]
[  169.086998] pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref]
[  169.088258] pci 0000:00:02.0: BAR 4: assigned [mem 0x8000004000-0x8000007fff 64bit pref]
[  169.089385] pci 0000:00:03.0: BAR 4: assigned [mem 0x8000008000-0x800000bfff 64bit pref]
[  169.090861] pci 0000:00:01.0: BAR 1: assigned [mem 0x10040000-0x10040fff]
[  169.091684] pci 0000:00:03.0: BAR 1: assigned [mem 0x10041000-0x10041fff]
[  169.092512] pci 0000:00:03.0: BAR 0: assigned [io  0x1000-0x103f]
[  169.093320] pci 0000:00:01.0: BAR 0: assigned [io  0x1040-0x105f]
[  169.094617] pci 0000:00:02.0: BAR 0: assigned [io  0x1060-0x107f]
[  169.096490] pci 0000:00:00.0: calling  tegra_pcie_relax_enable+0x0/0x40 @ 1
[  169.097427] pci 0000:00:00.0: tegra_pcie_relax_enable+0x0/0x40 took 136 usecs
[  169.099941] pci 0000:00:01.0: calling  tegra_pcie_relax_enable+0x0/0x40 @ 1
[  169.100785] pci 0000:00:01.0: tegra_pcie_relax_enable+0x0/0x40 took 30 usecs
[  169.102125] pci 0000:00:02.0: calling  tegra_pcie_relax_enable+0x0/0x40 @ 1
[  169.103433] pci 0000:00:02.0: tegra_pcie_relax_enable+0x0/0x40 took 29 usecs
[  169.104723] pci 0000:00:03.0: calling  tegra_pcie_relax_enable+0x0/0x40 @ 1
[  169.105563] pci 0000:00:03.0: tegra_pcie_relax_enable+0x0/0x40 took 28 usecs
[  169.142798] kobject: 'layerscape-pcie' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000)
[  169.528455] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)
[  169.552409] _warn_unseeded_randomness: 17 callbacks suppressed
[  169.552648] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  169.553808] kobject: 'virtio0' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  169.567891] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  169.579173] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
[  169.596498] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  169.597295] kobject: 'virtio1' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  169.621709] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
[  169.639100] kobject: 'virtio2' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  173.611888] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[  173.713759] _warn_unseeded_randomness: 3 callbacks suppressed
[  173.714002] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  173.715732] kobject: 'ttyS0' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  173.717467] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  173.725387] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  173.763251] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  173.763991] kobject: 'ttyS1' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  173.764947] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  173.804916] kobject: 'ttyS2' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  173.806602] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  173.847741] kobject: 'ttyS3' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  173.848882] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  173.917264] cacheinfo: Unable to detect cache hierarchy for CPU 0
[  173.928408] KGDB: Registered I/O driver kgdbts
[  173.929416] kgdbts:RUN plant and detach test

Entering kdb (current=0xffffffc03f558040, pid 1) on processor 0 due to Keyboard Entry
[0]kdb> [  173.939685] kgdbts:RUN sw breakpoint test
[  173.955533] kgdbts:RUN bad memory access test
[  173.958815] kgdbts:RUN singlestep test 1000 iterations
[  173.989149] kgdbts:RUN singlestep [0/1000]
[  176.896748] kgdbts:RUN singlestep [100/1000]
[  179.799441] kgdbts:RUN singlestep [200/1000]
[  182.700804] kgdbts:RUN singlestep [300/1000]
[  185.603730] kgdbts:RUN singlestep [400/1000]
[  188.507822] kgdbts:RUN singlestep [500/1000]
[  191.412651] kgdbts:RUN singlestep [600/1000]
[  194.315396] kgdbts:RUN singlestep [700/1000]
[  197.219146] kgdbts:RUN singlestep [800/1000]
[  200.123122] kgdbts:RUN singlestep [900/1000]
[  202.995832] kgdbts:RUN do_fork for 100 breakpoints
[  203.001911] _warn_unseeded_randomness: 5 callbacks suppressed
[  203.003151] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=0
[  204.799279] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  204.800164] kobject: 'rx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750)
[  204.803620] kobject: 'tx-0' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500)
[  204.815702] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  204.836312] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  204.837199] kobject: 'net' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  205.797808] KGDB: Unregistered I/O driver kgdbts, debugger disabled
[  208.047037] kobject: 'queues' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  208.296436] kobject: 'eth0' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  208.309106] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  208.439662] ledtrig-cpu: registered to indicate activity on CPUs
[  208.443000] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  208.443930] kobject: '44' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  208.445610] kobject: '45' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  208.450022] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  208.457636] kobject: 'meson-sm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250)
[  208.468803] kobject: '46' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  208.519560] ashmem: initialized
[  208.679746] 9pnet: Installing 9P2000 support
[  209.143010] kobject: '47' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  209.151008] kobject: '48' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  209.192764] registered taskstats version 1
[  209.194543] Running ring buffer tests...
[  219.303761] finished
[  219.304377] CPU 0:
[  219.304804]               events:    7536
[  219.305281]        dropped bytes:    0
[  219.305825]        alloced bytes:    587464
[  219.306946]        written bytes:    575488
[  219.307452]        biggest event:    61
[  219.307911]       smallest event:    0
[  219.591612]          read events:   7536
[  219.592188]          lost events:   0
[  219.592744]         total events:   7536
[  219.593221]   recorded len bytes:   587464
[  219.593740]  recorded size bytes:   575488
[  219.594714] Ring buffer PASSED!
[  219.632941] Running tests on trace events:
[  219.633607] Testing event initcall_finish: OK
[  219.660324] Testing event initcall_start: OK
[  219.684016] Testing event initcall_level: OK
[  219.710926] Testing event sys_exit: OK
[  219.736157] Testing event sys_enter: OK
[  219.764015] Testing event ipi_exit: OK
[  219.791725] Testing event ipi_entry: OK
[  219.816388] Testing event ipi_raise: OK
[  219.843830] Testing event instruction_emulation: OK
[  219.871106] Testing event kvm_halt_poll_ns: OK
[  219.896546] Testing event kvm_age_page: OK
[  219.921713] Testing event kvm_fpu: OK
[  219.944633] Testing event kvm_mmio: OK
[  219.972621] Testing event kvm_ack_irq: OK
[  219.999987] Testing event kvm_set_irq: OK
[  220.027517] Testing event kvm_vcpu_wakeup: OK
[  220.052435] Testing event kvm_userspace_exit: OK
[  220.080001] Testing event kvm_timer_update_irq: OK
[  220.105524] Testing event kvm_toggle_cache: OK
[  220.135162] Testing event kvm_set_way_flush: OK
[  220.159694] Testing event kvm_test_age_hva: OK
[  220.184416] Testing event kvm_age_hva: OK
[  220.208243] Testing event kvm_set_spte_hva: OK
[  220.232274] Testing event kvm_unmap_hva_range: OK
[  220.256261] Testing event kvm_mmio_emulate: OK
[  220.279317] Testing event kvm_irq_line: OK
[  220.304424] Testing event kvm_access_fault: OK
[  220.329725] Testing event kvm_guest_fault: OK
[  220.352753] Testing event kvm_exit: OK
[  220.379826] Testing event kvm_entry: OK
[  220.407745] Testing event kvm_set_guest_debug: OK
[  220.432992] Testing event kvm_handle_sys_reg: OK
[  220.460261] Testing event trap_reg: OK
[  220.489407] Testing event kvm_arm_set_regset: OK
[  220.517315] Testing event kvm_arm_set_dreg32: OK
[  220.544884] Testing event kvm_arm_clear_debug: OK
[  220.568443] Testing event kvm_arm_setup_debug: OK
[  220.593918] Testing event kvm_hvc_arm64: OK
[  220.620003] Testing event kvm_wfx_arm64: OK
[  220.648257] Testing event vgic_update_irq_pending: OK
[  220.675244] Testing event task_rename: OK
[  220.701682] Testing event task_newtask: OK
[  220.727806] Testing event cpuhp_exit: OK
[  220.752999] Testing event cpuhp_multi_enter: OK
[  220.781171] Testing event cpuhp_enter: OK
[  220.809427] Testing event softirq_raise: OK
[  220.836649] Testing event softirq_exit: OK
[  220.865204] Testing event softirq_entry: OK
[  220.889749] Testing event irq_handler_exit: OK
[  220.916816] Testing event irq_handler_entry: OK
[  220.945001] Testing event signal_deliver: OK
[  220.971301] Testing event signal_generate: OK
[  220.995878] Testing event workqueue_execute_end: OK
[  221.021931] Testing event workqueue_execute_start: OK
[  221.048171] Testing event workqueue_activate_work: OK
[  221.077539] Testing event workqueue_queue_work: OK
[  221.104565] Testing event sched_wake_idle_without_ipi: OK
[  221.131467] Testing event sched_swap_numa: OK
[  221.157744] Testing event sched_stick_numa: OK
[  221.184566] Testing event sched_move_numa: OK
[  221.209810] Testing event sched_process_hang: OK
[  221.236168] Testing event sched_pi_setprio: OK
[  221.265144] Testing event sched_stat_runtime: 
[  221.268552] Scheduler tracepoints stat_sleep, stat_iowait, stat_blocked and stat_runtime require the kernel parameter schedstats=enable or kernel.sched_schedstats=1
[  221.295806] OK
[  221.296308] Testing event sched_stat_blocked: OK
[  221.324166] Testing event sched_stat_iowait: OK
[  221.351364] Testing event sched_stat_sleep: OK
[  221.376546] Testing event sched_stat_wait: OK
[  221.403413] Testing event sched_process_exec: OK
[  221.431405] Testing event sched_process_fork: OK
[  221.456934] Testing event sched_process_wait: OK
[  221.483477] Testing event sched_wait_task: OK
[  221.507510] Testing event sched_process_exit: OK
[  221.533861] Testing event sched_process_free: OK
[  221.561353] Testing event sched_migrate_task: OK
[  221.587710] Testing event sched_switch: OK
[  221.616458] Testing event sched_wakeup_new: OK
[  221.641804] Testing event sched_wakeup: OK
[  221.669049] Testing event sched_waking: OK
[  221.699214] Testing event sched_kthread_stop_ret: OK
[  221.724044] Testing event sched_kthread_stop: OK
[  221.748270] Testing event lock_acquired: OK
[  221.788775] Testing event lock_contended: OK
[  221.811638] Testing event lock_release: OK
[  221.861180] Testing event lock_acquire: OK
[  221.904663] Testing event console: OK
[  221.928347] Testing event rcu_barrier: OK
[  221.953649] Testing event rcu_torture_read: OK
[  221.976690] Testing event rcu_batch_end: OK
[  222.004114] Testing event rcu_invoke_kfree_callback: OK
[  222.032039] Testing event rcu_invoke_callback: OK
[  222.056947] Testing event rcu_batch_start: OK
[  222.084638] Testing event rcu_kfree_callback: OK
[  222.115317] Testing event rcu_callback: OK
[  222.140354] Testing event rcu_dyntick: OK
[  222.169924] Testing event rcu_fqs: OK
[  222.199418] Testing event rcu_quiescent_state_report: OK
[  222.224692] Testing event rcu_unlock_preempted_task: OK
[  222.248329] Testing event rcu_preempt_task: OK
[  222.272100] Testing event rcu_nocb_wake: OK
[  222.302651] Testing event rcu_exp_funnel_lock: OK
[  222.328876] Testing event rcu_exp_grace_period: OK
[  222.357442] Testing event rcu_grace_period_init: OK
[  222.383515] Testing event rcu_future_grace_period: OK
[  222.409258] Testing event rcu_grace_period: OK
[  222.441788] Testing event rcu_utilization: OK
[  222.471619] Testing event swiotlb_bounced: OK
[  222.495501] Testing event tick_stop: OK
[  222.519423] Testing event itimer_expire: OK
[  222.543511] Testing event itimer_state: OK
[  222.568373] Testing event hrtimer_cancel: OK
[  222.597476] Testing event hrtimer_expire_exit: OK
[  222.623887] Testing event hrtimer_expire_entry: OK
[  222.648429] Testing event hrtimer_start: OK
[  222.675242] Testing event hrtimer_init: OK
[  222.700016] Testing event timer_cancel: OK
[  222.726734] Testing event timer_expire_exit: OK
[  222.752207] Testing event timer_expire_entry: OK
[  222.776293] Testing event timer_start: OK
[  222.804023] Testing event timer_init: OK
[  222.831849] Testing event alarmtimer_cancel: OK
[  222.857149] Testing event alarmtimer_start: OK
[  222.883849] Testing event alarmtimer_fired: OK
[  222.907390] Testing event alarmtimer_suspend: OK
[  222.931424] Testing event module_request: OK
[  222.956783] Testing event module_put: OK
[  222.984821] Testing event module_get: OK
[  223.013511] Testing event module_free: OK
[  223.040432] Testing event module_load: OK
[  223.065558] Testing event cgroup_transfer_tasks: OK
[  223.088578] Testing event cgroup_attach_task: OK
[  223.113911] Testing event cgroup_rename: OK
[  223.140257] Testing event cgroup_release: OK
[  223.167967] Testing event cgroup_rmdir: OK
[  223.195943] Testing event cgroup_mkdir: OK
[  223.221471] Testing event cgroup_remount: OK
[  223.249855] Testing event cgroup_destroy_root: OK
[  223.275816] Testing event cgroup_setup_root: OK
[  223.299518] Testing event irq_enable: OK
[  223.342954] Testing event irq_disable: OK
[  223.380177] Testing event ftrace_test_filter: OK
[  223.403921] Testing event dev_pm_qos_remove_request: OK
[  223.429766] Testing event dev_pm_qos_update_request: OK
[  223.456086] Testing event dev_pm_qos_add_request: OK
[  223.480315] Testing event pm_qos_update_flags: OK
[  223.505905] Testing event pm_qos_update_target: OK
[  223.532197] Testing event pm_qos_update_request_timeout: OK
[  223.560944] Testing event pm_qos_remove_request: OK
[  223.584842] Testing event pm_qos_update_request: OK
[  223.608809] Testing event pm_qos_add_request: OK
[  223.635685] Testing event power_domain_target: OK
[  223.659768] Testing event clock_set_rate: OK
[  223.683417] Testing event clock_disable: OK
[  223.707337] Testing event clock_enable: OK
[  223.732424] Testing event wakeup_source_deactivate: OK
[  223.757905] Testing event wakeup_source_activate: OK
[  223.784079] Testing event suspend_resume: OK
[  223.822605] Testing event device_pm_callback_end: OK
[  223.845468] Testing event device_pm_callback_start: OK
[  223.873138] Testing event cpu_frequency_limits: OK
[  223.900947] Testing event cpu_frequency: OK
[  223.924914] Testing event pstate_sample: OK
[  223.949257] Testing event powernv_throttle: OK
[  223.979049] Testing event cpu_idle: OK
[  224.004489] Testing event rpm_return_int: OK
[  224.031278] Testing event rpm_idle: OK
[  224.056943] Testing event rpm_resume: OK
[  224.084815] Testing event rpm_suspend: OK
[  224.108716] Testing event benchmark_event: OK
[  224.233067] Testing event xdp_devmap_xmit: OK
[  224.261726] Testing event xdp_cpumap_enqueue: OK
[  224.288438] Testing event xdp_cpumap_kthread: OK
[  224.318882] Testing event xdp_redirect_map_err: OK
[  224.343896] Testing event xdp_redirect_map: OK
[  224.368433] Testing event xdp_redirect_err: OK
[  224.393883] Testing event xdp_redirect: OK
[  224.419922] Testing event xdp_exception: OK
[  224.445565] Testing event rseq_ip_fixup: OK
[  224.471622] Testing event rseq_update: OK
[  224.495875] Testing event file_check_and_advance_wb_err: OK
[  224.520389] Testing event filemap_set_wb_err: OK
[  224.545963] Testing event mm_filemap_add_to_page_cache: OK
[  224.572120] Testing event mm_filemap_delete_from_page_cache: OK
[  224.596596] Testing event compact_retry: OK
[  224.624861] Testing event skip_task_reaping: OK
[  224.652208] Testing event finish_task_reaping: OK
[  224.676118] Testing event start_task_reaping: OK
[  224.700470] Testing event wake_reaper: OK
[  224.727751] Testing event mark_victim: OK
[  224.753731] Testing event reclaim_retry_zone: OK
[  224.780595] Testing event oom_score_adj_update: OK
[  224.807616] Testing event mm_lru_activate: OK
[  224.831857] Testing event mm_lru_insertion: OK
[  224.856380] Testing event mm_vmscan_inactive_list_is_low: OK
[  224.882780] Testing event mm_vmscan_lru_shrink_active: OK
[  224.908220] Testing event mm_vmscan_lru_shrink_inactive: OK
[  224.939270] Testing event mm_vmscan_writepage: OK
[  224.964032] Testing event mm_vmscan_lru_isolate: OK
[  224.988774] Testing event mm_shrink_slab_end: OK
[  225.017390] Testing event mm_shrink_slab_start: OK
[  225.042997] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK
[  225.071112] Testing event mm_vmscan_memcg_reclaim_end: OK
[  225.095802] Testing event mm_vmscan_direct_reclaim_end: OK
[  225.120335] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK
[  225.145997] Testing event mm_vmscan_memcg_reclaim_begin: OK
[  225.172129] Testing event mm_vmscan_direct_reclaim_begin: OK
[  225.200056] Testing event mm_vmscan_wakeup_kswapd: OK
[  225.227626] Testing event mm_vmscan_kswapd_wake: OK
[  225.252430] Testing event mm_vmscan_kswapd_sleep: OK
[  225.279974] Testing event percpu_destroy_chunk: OK
[  225.305854] Testing event percpu_create_chunk: OK
[  225.332795] Testing event percpu_alloc_percpu_fail: OK
[  225.361053] Testing event percpu_free_percpu: OK
[  225.387796] Testing event percpu_alloc_percpu: OK
[  225.411569] Testing event mm_page_alloc_extfrag: OK
[  225.436342] Testing event mm_page_pcpu_drain: OK
[  225.460588] Testing event mm_page_alloc_zone_locked: OK
[  225.488159] Testing event mm_page_alloc: OK
[  225.515562] Testing event mm_page_free_batched: OK
[  225.541115] Testing event mm_page_free: OK
[  225.568865] Testing event kmem_cache_free: OK
[  225.600255] Testing event kfree: OK
[  225.624955] Testing event kmem_cache_alloc_node: OK
[  225.652313] Testing event kmalloc_node: OK
[  225.680116] Testing event kmem_cache_alloc: OK
[  225.707895] Testing event kmalloc: OK
[  225.735737] Testing event mm_compaction_kcompactd_wake: OK
[  225.759964] Testing event mm_compaction_wakeup_kcompactd: OK
[  225.784397] Testing event mm_compaction_kcompactd_sleep: OK
[  225.809781] Testing event mm_compaction_defer_reset: OK
[  225.832956] Testing event mm_compaction_defer_compaction: OK
[  225.859905] Testing event mm_compaction_deferred: OK
[  225.883531] Testing event mm_compaction_suitable: OK
[  225.908335] Testing event mm_compaction_finished: OK
[  225.932286] Testing event mm_compaction_try_to_compact_pages: OK
[  225.956340] Testing event mm_compaction_end: OK
[  225.980385] Testing event mm_compaction_begin: OK
[  226.005963] Testing event mm_compaction_migratepages: OK
[  226.031965] Testing event mm_compaction_isolate_freepages: OK
[  226.057934] Testing event mm_compaction_isolate_migratepages: OK
[  226.083933] Testing event mm_migrate_pages: OK
[  226.108482] Testing event mm_collapse_huge_page_swapin: OK
[  226.138892] Testing event mm_collapse_huge_page_isolate: OK
[  226.164696] Testing event mm_collapse_huge_page: OK
[  226.193148] Testing event mm_khugepaged_scan_pmd: OK
[  226.219108] Testing event test_pages_isolated: OK
[  226.247098] Testing event cma_release: OK
[  226.271746] Testing event cma_alloc: OK
[  226.296455] Testing event page_ref_unfreeze: OK
[  226.325968] Testing event page_ref_freeze: OK
[  226.353194] Testing event page_ref_mod_unless: OK
[  226.383433] Testing event page_ref_mod_and_return: OK
[  226.408101] Testing event page_ref_mod_and_test: OK
[  226.539249] Testing event page_ref_mod: OK
[  226.596110] Testing event page_ref_set: OK
[  226.627126] Testing event sb_clear_inode_writeback: OK
[  226.652516] Testing event sb_mark_inode_writeback: OK
[  226.677870] Testing event writeback_dirty_inode_enqueue: OK
[  226.704144] Testing event writeback_lazytime_iput: OK
[  226.728509] Testing event writeback_lazytime: OK
[  226.754767] Testing event writeback_single_inode: OK
[  226.779919] Testing event writeback_single_inode_start: OK
[  226.804408] Testing event writeback_wait_iff_congested: OK
[  226.829664] Testing event writeback_congestion_wait: OK
[  226.852380] Testing event writeback_sb_inodes_requeue: OK
[  226.877957] Testing event balance_dirty_pages: OK
[  226.903728] Testing event bdi_dirty_ratelimit: OK
[  226.928743] Testing event global_dirty_state: OK
[  226.957461] Testing event writeback_queue_io: OK
[  226.984514] Testing event wbc_writepage: OK
[  227.009863] Testing event writeback_bdi_register: OK
[  227.032456] Testing event writeback_wake_background: OK
[  227.057894] Testing event writeback_pages_written: OK
[  227.083748] Testing event writeback_wait: OK
[  227.108664] Testing event writeback_written: OK
[  227.137475] Testing event writeback_start: OK
[  227.164507] Testing event writeback_exec: OK
[  227.189722] Testing event writeback_queue: OK
[  227.216132] Testing event writeback_write_inode: OK
[  227.245094] Testing event writeback_write_inode_start: OK
[  227.269288] Testing event writeback_dirty_inode: OK
[  227.295894] Testing event writeback_dirty_inode_start: OK
[  227.319631] Testing event writeback_mark_inode_dirty: OK
[  227.344526] Testing event writeback_dirty_page: OK
[  227.371941] Testing event dax_writeback_one: OK
[  227.399537] Testing event dax_writeback_range_done: OK
[  227.425137] Testing event dax_writeback_range: OK
[  227.452571] Testing event dax_insert_mapping: OK
[  227.477708] Testing event dax_insert_pfn_mkwrite: OK
[  227.504792] Testing event dax_insert_pfn_mkwrite_no_entry: OK
[  227.532994] Testing event dax_load_hole: OK
[  227.557733] Testing event dax_pte_fault_done: OK
[  227.584580] Testing event dax_pte_fault: OK
[  227.612512] Testing event dax_pmd_insert_mapping: OK
[  227.637606] Testing event dax_pmd_load_hole_fallback: OK
[  227.660377] Testing event dax_pmd_load_hole: OK
[  227.685130] Testing event dax_pmd_fault_done: OK
[  227.711619] Testing event dax_pmd_fault: OK
[  227.735495] Testing event generic_add_lease: OK
[  227.761155] Testing event time_out_leases: OK
[  227.789037] Testing event generic_delete_lease: OK
[  227.812949] Testing event break_lease_unblock: OK
[  227.836740] Testing event break_lease_block: OK
[  227.863921] Testing event break_lease_noblock: OK
[  227.891557] Testing event flock_lock_inode: OK
[  227.917049] Testing event locks_remove_posix: OK
[  227.944270] Testing event fcntl_setlk: OK
[  227.968512] Testing event posix_lock_inode: OK
[  227.993761] Testing event locks_get_lock_context: OK
[  228.020152] Testing event block_rq_remap: OK
[  228.048886] Testing event block_bio_remap: OK
[  228.072728] Testing event block_split: OK
[  228.100245] Testing event block_unplug: OK
[  228.129002] Testing event block_plug: OK
[  228.152849] Testing event block_sleeprq: OK
[  228.176530] Testing event block_getrq: OK
[  228.203857] Testing event block_bio_queue: OK
[  228.229482] Testing event block_bio_frontmerge: OK
[  228.258804] Testing event block_bio_backmerge: OK
[  228.284123] Testing event block_bio_complete: OK
[  228.314959] Testing event block_bio_bounce: OK
[  228.339693] Testing event block_rq_issue: OK
[  228.363490] Testing event block_rq_insert: OK
[  228.388964] Testing event block_rq_complete: OK
[  228.416709] Testing event block_rq_requeue: OK
[  228.443720] Testing event block_dirty_buffer: OK
[  228.467816] Testing event block_touch_buffer: OK
[  228.492745] Testing event wbt_timer: OK
[  228.519771] Testing event wbt_step: OK
[  228.545726] Testing event wbt_lat: OK
[  228.572728] Testing event wbt_stat: OK
[  228.603165] Testing event gpio_value: OK
[  228.628443] Testing event gpio_direction: OK
[  228.655589] Testing event clk_set_duty_cycle_complete: OK
[  228.684457] Testing event clk_set_duty_cycle: OK
[  228.709616] Testing event clk_set_phase_complete: OK
[  228.733490] Testing event clk_set_phase: OK
[  228.763064] Testing event clk_set_parent_complete: OK
[  228.788292] Testing event clk_set_parent: OK
[  228.813919] Testing event clk_set_rate_complete: OK
[  228.840196] Testing event clk_set_rate: OK
[  228.867861] Testing event clk_unprepare_complete: OK
[  228.895834] Testing event clk_unprepare: OK
[  228.920394] Testing event clk_prepare_complete: OK
[  228.947957] Testing event clk_prepare: OK
[  228.973749] Testing event clk_disable_complete: OK
[  229.000803] Testing event clk_disable: OK
[  229.028850] Testing event clk_enable_complete: OK
[  229.053761] Testing event clk_enable: OK
[  229.082956] Testing event rpmh_send_msg: OK
[  229.108025] Testing event rpmh_tx_done: OK
[  229.136029] Testing event regulator_set_voltage_complete: OK
[  229.163533] Testing event regulator_set_voltage: OK
[  229.188389] Testing event regulator_disable_complete: OK
[  229.216042] Testing event regulator_disable: OK
[  229.244480] Testing event regulator_enable_complete: OK
[  229.269605] Testing event regulator_enable_delay: OK
[  229.296591] Testing event regulator_enable: OK
[  229.320885] Testing event urandom_read: OK
[  229.348353] Testing event random_read: OK
[  229.375799] Testing event extract_entropy_user: OK
[  229.401745] Testing event extract_entropy: OK
[  229.428779] Testing event get_random_bytes_arch: OK
[  229.455142] Testing event get_random_bytes: OK
[  229.483553] Testing event xfer_secondary_pool: OK
[  229.508816] Testing event add_disk_randomness: OK
[  229.535156] Testing event add_input_randomness: OK
[  229.560494] Testing event debit_entropy: OK
[  229.587561] Testing event push_to_pool: OK
[  229.611855] Testing event credit_entropy_bits: OK
[  229.636313] Testing event mix_pool_bytes_nolock: OK
[  229.660458] Testing event mix_pool_bytes: OK
[  229.685770] Testing event add_device_randomness: OK
[  229.711967] Testing event io_page_fault: OK
[  229.736331] Testing event unmap: OK
[  229.761877] Testing event map: OK
[  229.788058] Testing event detach_device_from_domain: OK
[  229.817184] Testing event attach_device_to_domain: OK
[  229.840806] Testing event remove_device_from_group: OK
[  229.864854] Testing event add_device_to_group: OK
[  229.891793] Testing event regcache_drop_region: OK
[  229.917787] Testing event regmap_async_complete_done: OK
[  229.944796] Testing event regmap_async_complete_start: OK
[  229.972821] Testing event regmap_async_io_complete: OK
[  229.997771] Testing event regmap_async_write_start: OK
[  230.024800] Testing event regmap_cache_bypass: OK
[  230.052915] Testing event regmap_cache_only: OK
[  230.081282] Testing event regcache_sync: OK
[  230.108826] Testing event regmap_hw_write_done: OK
[  230.137174] Testing event regmap_hw_write_start: OK
[  230.165335] Testing event regmap_hw_read_done: OK
[  230.192476] Testing event regmap_hw_read_start: OK
[  230.217811] Testing event regmap_reg_read_cache: OK
[  230.244171] Testing event regmap_reg_read: OK
[  230.268317] Testing event regmap_reg_write: OK
[  230.293409] Testing event dma_fence_wait_end: OK
[  230.320781] Testing event dma_fence_wait_start: OK
[  230.348875] Testing event dma_fence_signaled: OK
[  230.377507] Testing event dma_fence_enable_signal: OK
[  230.404786] Testing event dma_fence_destroy: OK
[  230.429713] Testing event dma_fence_init: OK
[  230.456089] Testing event dma_fence_emit: OK
[  230.485197] Testing event sync_timeline: OK
[  230.511110] Testing event spi_transfer_stop: OK
[  230.539069] Testing event spi_transfer_start: OK
[  230.563893] Testing event spi_message_done: OK
[  230.588338] Testing event spi_message_start: OK
[  230.614806] Testing event spi_message_submit: OK
[  230.640024] Testing event spi_controller_busy: OK
[  230.664289] Testing event spi_controller_idle: OK
[  230.688519] Testing event rtc_timer_fired: OK
[  230.713775] Testing event rtc_timer_dequeue: OK
[  230.740620] Testing event rtc_timer_enqueue: OK
[  230.771333] Testing event rtc_read_offset: OK
[  230.796189] Testing event rtc_set_offset: OK
[  230.821909] Testing event rtc_alarm_irq_enable: OK
[  230.848037] Testing event rtc_irq_set_state: OK
[  230.872179] Testing event rtc_irq_set_freq: OK
[  230.896482] Testing event rtc_read_alarm: OK
[  230.921860] Testing event rtc_set_alarm: OK
[  230.947906] Testing event rtc_read_time: OK
[  230.972500] Testing event rtc_set_time: OK
[  230.997857] Testing event memory_failure_event: OK
[  231.024160] Testing event aer_event: OK
[  231.048332] Testing event non_standard_event: OK
[  231.072346] Testing event arm_event: OK
[  231.098001] Testing event mc_event: OK
[  231.120135] Testing event binder_return: OK
[  231.145032] Testing event binder_command: OK
[  231.169339] Testing event binder_unmap_kernel_end: OK
[  231.196614] Testing event binder_unmap_kernel_start: OK
[  231.225612] Testing event binder_unmap_user_end: OK
[  231.251779] Testing event binder_unmap_user_start: OK
[  231.279758] Testing event binder_alloc_page_end: OK
[  231.308465] Testing event binder_alloc_page_start: OK
[  231.332539] Testing event binder_free_lru_end: OK
[  231.358769] Testing event binder_free_lru_start: OK
[  231.384279] Testing event binder_alloc_lru_end: OK
[  231.415308] Testing event binder_alloc_lru_start: OK
[  231.440147] Testing event binder_update_page_range: OK
[  231.464493] Testing event binder_transaction_failed_buffer_release: OK
[  231.489736] Testing event binder_transaction_buffer_release: OK
[  231.516336] Testing event binder_transaction_alloc_buf: OK
[  231.545056] Testing event binder_transaction_fd_recv: OK
[  231.568928] Testing event binder_transaction_fd_send: OK
[  231.593158] Testing event binder_transaction_ref_to_ref: OK
[  231.620558] Testing event binder_transaction_ref_to_node: OK
[  231.645734] Testing event binder_transaction_node_to_ref: OK
[  231.672856] Testing event binder_transaction_received: OK
[  231.700975] Testing event binder_transaction: OK
[  231.729294] Testing event binder_wait_for_work: OK
[  231.756662] Testing event binder_read_done: OK
[  231.783233] Testing event binder_write_done: OK
[  231.808287] Testing event binder_ioctl_done: OK
[  231.833696] Testing event binder_unlock: OK
[  231.856568] Testing event binder_locked: OK
[  231.883929] Testing event binder_lock: OK
[  231.909384] Testing event binder_ioctl: OK
[  231.936831] Testing event br_fdb_update: OK
[  231.966975] Testing event fdb_delete: OK
[  231.992059] Testing event br_fdb_external_learn_add: OK
[  232.016091] Testing event br_fdb_add: OK
[  232.039358] Testing event qdisc_dequeue: OK
[  232.064816] Testing event fib_table_lookup: OK
[  232.093075] Testing event tcp_probe: OK
[  232.121335] Testing event tcp_retransmit_synack: OK
[  232.148555] Testing event tcp_rcv_space_adjust: OK
[  232.173735] Testing event tcp_destroy_sock: OK
[  232.196705] Testing event tcp_receive_reset: OK
[  232.224074] Testing event tcp_send_reset: OK
[  232.251484] Testing event tcp_retransmit_skb: OK
[  232.276693] Testing event udp_fail_queue_rcv_skb: OK
[  232.300440] Testing event inet_sock_set_state: OK
[  232.326884] Testing event sock_exceed_buf_limit: OK
[  232.352429] Testing event sock_rcvqueue_full: OK
[  232.383225] Testing event napi_poll: OK
[  232.408310] Testing event netif_rx_ni_entry: OK
[  232.433824] Testing event netif_rx_entry: OK
[  232.461042] Testing event netif_receive_skb_list_entry: OK
[  232.488077] Testing event netif_receive_skb_entry: OK
[  232.514006] Testing event napi_gro_receive_entry: OK
[  232.540638] Testing event napi_gro_frags_entry: OK
[  232.567209] Testing event netif_rx: OK
[  232.595410] Testing event netif_receive_skb: OK
[  232.620976] Testing event net_dev_queue: OK
[  232.651273] Testing event net_dev_xmit: OK
[  232.676126] Testing event net_dev_start_xmit: OK
[  232.700291] Testing event skb_copy_datagram_iovec: OK
[  232.724295] Testing event consume_skb: OK
[  232.750991] Testing event kfree_skb: OK
[  232.775874] Testing event 9p_protocol_dump: OK
[  232.807432] Testing event 9p_client_res: OK
[  232.832477] Testing event 9p_client_req: OK
[  232.858765] Running tests on trace event systems:
[  232.859383] Testing event system 9p: OK
[  232.893017] Testing event system skb: OK
[  232.921488] Testing event system net: OK
[  232.960239] Testing event system napi: OK
[  232.987939] Testing event system sock: OK
[  233.018672] Testing event system udp: OK
[  233.046874] Testing event system tcp: OK
[  233.079433] Testing event system fib: OK
[  233.109095] Testing event system qdisc: OK
[  233.136973] Testing event system bridge: OK
[  233.164624] Testing event system binder: OK
[  233.215738] Testing event system ras: OK
[  233.245559] Testing event system rtc: OK
[  233.286924] Testing event system spi: OK
[  233.317824] Testing event system sync_trace: OK
[  233.347050] Testing event system dma_fence: OK
[  233.379639] Testing event system regmap: OK
[  233.416119] Testing event system iommu: OK
[  233.447229] Testing event system random: OK
[  233.487288] Testing event system regulator: OK
[  233.520578] Testing event system rpmh: OK
[  233.551284] Testing event system clk: OK
[  233.592171] Testing event system gpio: OK
[  233.623854] Testing event system wbt: OK
[  233.656249] Testing event system block: OK
[  233.695655] Testing event system filelock: OK
[  233.732506] Testing event system fs_dax: OK
[  233.768677] Testing event system writeback: OK
[  233.818935] Testing event system page_ref: OK
[  233.996363] Testing event system cma: OK
[  234.028504] Testing event system page_isolation: OK
[  234.056566] Testing event system huge_memory: OK
[  234.086782] Testing event system migrate: OK
[  234.113046] Testing event system compaction: OK
[  234.150868] Testing event system kmem: OK
[  234.187763] Testing event system percpu: OK
[  234.217886] Testing event system vmscan: OK
[  234.258843] Testing event system pagemap: OK
[  234.285251] Testing event system oom: OK
[  234.319497] Testing event system filemap: OK
[  234.349559] Testing event system rseq: OK
[  234.379635] Testing event system xdp: OK
[  234.415209] Testing event system benchmark: OK
[  234.543861] Testing event system rpm: OK
[  234.575923] Testing event system power: OK
[  234.629565] Testing event system test: OK
[  234.656580] Testing event system preemptirq: OK
[  234.736939] Testing event system cgroup: OK
[  234.774644] Testing event system module: OK
[  234.805100] Testing event system alarmtimer: OK
[  234.839493] Testing event system timer: OK
[  234.878910] Testing event system swiotlb: OK
[  234.905823] Testing event system rcu: OK
[  234.965144] Testing event system printk: OK
[  235.001501] Testing event system lock: OK
[  235.109597] Testing event system sched: OK
[  235.162660] Testing event system workqueue: OK
[  235.191087] Testing event system signal: OK
[  235.221512] Testing event system irq: OK
[  235.255893] Testing event system cpuhp: OK
[  235.287405] Testing event system task: OK
[  235.317725] Testing event system kvm: OK
[  235.367268] Testing event system emulation: OK
[  235.393947] Testing event system ipi: OK
[  235.428476] Testing event system raw_syscalls: OK
[  235.455403] Testing event system initcall: OK
[  235.486832] Running tests on all trace events:
[  235.487361] Testing all events: OK
[  238.355100] ftrace_replace_code: 1
[  242.323508] hrtimer: interrupt took 9900416 ns
[  291.967553] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  292.007492] Running tests again, along with the function tracer
[  292.036575] Running tests on trace events:
[  292.046680] Testing event initcall_finish: OK
[  292.422257] Testing event initcall_start: OK
[  292.915720] Testing event initcall_level: OK
[  293.436770] Testing event sys_exit: OK
[  293.911154] Testing event sys_enter: OK
[  294.245956] Testing event ipi_exit: OK
[  295.026821] Testing event ipi_entry: OK
[  295.478575] Testing event ipi_raise: OK
[  295.816841] Testing event instruction_emulation: OK
[  296.305624] Testing event kvm_halt_poll_ns: OK
[  296.683959] Testing event kvm_age_page: OK
[  296.986940] Testing event kvm_fpu: OK
[  297.518928] Testing event kvm_mmio: OK
[  297.923794] Testing event kvm_ack_irq: OK
[  298.318975] Testing event kvm_set_irq: OK
[  298.661850] Testing event kvm_vcpu_wakeup: OK
[  299.107277] Testing event kvm_userspace_exit: OK
[  299.518227] Testing event kvm_timer_update_irq: OK
[  299.923866] Testing event kvm_toggle_cache: OK
[  300.398656] Testing event kvm_set_way_flush: OK
[  300.871582] Testing event kvm_test_age_hva: OK
[  301.352264] Testing event kvm_age_hva: OK
[  301.764601] Testing event kvm_set_spte_hva: OK
[  302.147643] Testing event kvm_unmap_hva_range: OK
[  302.526750] Testing event kvm_mmio_emulate: OK
[  303.045426] Testing event kvm_irq_line: OK
[  303.467902] Testing event kvm_access_fault: OK
[  303.918594] Testing event kvm_guest_fault: OK
[  304.266576] Testing event kvm_exit: OK
[  304.709242] Testing event kvm_entry: OK
[  305.215358] Testing event kvm_set_guest_debug: OK
[  306.227241] Testing event kvm_handle_sys_reg: OK
[  306.500968] Testing event trap_reg: OK
[  306.882987] Testing event kvm_arm_set_regset: OK
[  307.366807] Testing event kvm_arm_set_dreg32: OK
[  307.859455] Testing event kvm_arm_clear_debug: OK
[  308.298207] Testing event kvm_arm_setup_debug: OK
[  308.647717] Testing event kvm_hvc_arm64: OK
[  309.164321] Testing event kvm_wfx_arm64: OK
[  309.535148] Testing event vgic_update_irq_pending: OK
[  309.938301] Testing event task_rename: OK
[  310.346959] Testing event task_newtask: OK
[  310.834422] Testing event cpuhp_exit: OK
[  311.316208] Testing event cpuhp_multi_enter: OK
[  311.743423] Testing event cpuhp_enter: OK
[  312.181773] Testing event softirq_raise: OK
[  312.634011] Testing event softirq_exit: OK
[  313.128246] Testing event softirq_entry: OK
[  313.527639] Testing event irq_handler_exit: OK
[  314.003836] Testing event irq_handler_entry: OK
[  314.448141] Testing event signal_deliver: OK
[  314.795301] Testing event signal_generate: OK
[  315.196885] Testing event workqueue_execute_end: OK
[  315.625628] Testing event workqueue_execute_start: OK
[  315.992802] Testing event workqueue_activate_work: OK
[  316.440424] Testing event workqueue_queue_work: OK
[  316.762898] Testing event sched_wake_idle_without_ipi: OK
[  317.276201] Testing event sched_swap_numa: OK
[  317.709843] Testing event sched_stick_numa: OK
[  318.104478] Testing event sched_move_numa: OK
[  318.487345] Testing event sched_process_hang: OK
[  318.874607] Testing event sched_pi_setprio: OK
[  319.355058] Testing event sched_stat_runtime: OK
[  319.833516] Testing event sched_stat_blocked: OK
[  320.294641] Testing event sched_stat_iowait: OK
[  320.780109] Testing event sched_stat_sleep: OK
[  321.235943] Testing event sched_stat_wait: OK
[  321.762670] Testing event sched_process_exec: OK
[  322.194746] Testing event sched_process_fork: OK
[  322.690689] Testing event sched_process_wait: OK
[  323.119018] Testing event sched_wait_task: OK
[  323.574440] Testing event sched_process_exit: OK
[  324.030325] Testing event sched_process_free: OK
[  324.490098] Testing event sched_migrate_task: OK
[  324.993462] Testing event sched_switch: OK
[  325.404457] Testing event sched_wakeup_new: OK
[  325.872981] Testing event sched_wakeup: OK
[  326.290234] Testing event sched_waking: OK
[  326.757906] Testing event sched_kthread_stop_ret: OK
[  327.183349] Testing event sched_kthread_stop: OK
[  327.558337] Testing event lock_acquired: OK
[  327.934930] Testing event lock_contended: OK
[  328.398306] Testing event lock_release: OK
[  328.934715] Testing event lock_acquire: OK
[  329.432526] Testing event console: OK
[  329.901355] Testing event rcu_barrier: OK
[  330.332841] Testing event rcu_torture_read: OK
[  330.789106] Testing event rcu_batch_end: OK
[  331.129857] Testing event rcu_invoke_kfree_callback: OK
[  331.464289] Testing event rcu_invoke_callback: OK
[  331.963750] Testing event rcu_batch_start: OK
[  332.401187] Testing event rcu_kfree_callback: OK
[  332.878706] Testing event rcu_callback: OK
[  333.255662] Testing event rcu_dyntick: OK
[  333.710510] Testing event rcu_fqs: OK
[  334.190511] Testing event rcu_quiescent_state_report: OK
[  334.587655] Testing event rcu_unlock_preempted_task: OK
[  335.101525] Testing event rcu_preempt_task: OK
[  335.518183] Testing event rcu_nocb_wake: OK
[  336.000198] Testing event rcu_exp_funnel_lock: OK
[  336.428269] Testing event rcu_exp_grace_period: OK
[  336.859987] Testing event rcu_grace_period_init: OK
[  337.360903] Testing event rcu_future_grace_period: OK
[  337.852809] Testing event rcu_grace_period: OK
[  338.384955] Testing event rcu_utilization: OK
[  338.831200] Testing event swiotlb_bounced: OK
[  339.329275] Testing event tick_stop: OK
[  339.724074] Testing event itimer_expire: OK
[  340.187308] Testing event itimer_state: OK
[  340.596580] Testing event hrtimer_cancel: OK
[  341.094366] Testing event hrtimer_expire_exit: OK
[  341.550151] Testing event hrtimer_expire_entry: OK
[  341.970214] Testing event hrtimer_start: OK
[  342.373946] Testing event hrtimer_init: OK
[  342.856293] Testing event timer_cancel: OK
[  343.299960] Testing event timer_expire_exit: OK
[  343.773271] Testing event timer_expire_entry: OK
[  344.142920] Testing event timer_start: OK
[  344.611430] Testing event timer_init: OK
[  345.508550] Testing event alarmtimer_cancel: OK
[  345.841989] Testing event alarmtimer_start: OK
[  346.234868] Testing event alarmtimer_fired: OK
[  346.645509] Testing event alarmtimer_suspend: OK
[  346.971406] Testing event module_request: OK
[  347.392515] Testing event module_put: OK
[  347.802641] Testing event module_get: OK
[  348.213689] Testing event module_free: OK
[  348.628024] Testing event module_load: OK
[  348.929337] Testing event cgroup_transfer_tasks: OK
[  349.547927] Testing event cgroup_attach_task: OK
[  349.926461] Testing event cgroup_rename: OK
[  350.380206] Testing event cgroup_release: OK
[  350.811086] Testing event cgroup_rmdir: OK
[  351.304712] Testing event cgroup_mkdir: OK
[  351.741817] Testing event cgroup_remount: OK
[  352.091132] Testing event cgroup_destroy_root: OK
[  353.001198] Testing event cgroup_setup_root: OK
[  353.419578] Testing event irq_enable: OK
[  354.150662] Testing event irq_disable: OK
[  354.984859] Testing event ftrace_test_filter: OK
[  355.386238] Testing event dev_pm_qos_remove_request: OK
[  355.782955] Testing event dev_pm_qos_update_request: OK
[  356.191822] Testing event dev_pm_qos_add_request: OK
[  356.623143] Testing event pm_qos_update_flags: OK
[  357.093489] Testing event pm_qos_update_target: OK
[  357.544422] Testing event pm_qos_update_request_timeout: OK
[  358.008320] Testing event pm_qos_remove_request: OK
[  358.422323] Testing event pm_qos_update_request: OK
[  358.852829] Testing event pm_qos_add_request: OK
[  359.302963] Testing event power_domain_target: OK
[  359.741437] Testing event clock_set_rate: OK
[  360.185824] Testing event clock_disable: OK
[  360.570448] Testing event clock_enable: OK
[  361.043899] Testing event wakeup_source_deactivate: OK
[  361.444628] Testing event wakeup_source_activate: OK
[  361.944424] Testing event suspend_resume: OK
[  362.411548] Testing event device_pm_callback_end: OK
[  362.879393] Testing event device_pm_callback_start: OK
[  363.394647] Testing event cpu_frequency_limits: OK
[  363.836911] Testing event cpu_frequency: OK
[  364.203100] Testing event pstate_sample: OK
[  364.629516] Testing event powernv_throttle: OK
[  365.122414] Testing event cpu_idle: OK
[  365.697931] Testing event rpm_return_int: OK
[  366.112204] Testing event rpm_idle: OK
[  366.554349] Testing event rpm_resume: OK
[  367.000755] Testing event rpm_suspend: OK
[  367.401829] Testing event benchmark_event: OK
[  368.113637] Testing event xdp_devmap_xmit: OK
[  368.516033] Testing event xdp_cpumap_enqueue: OK
[  369.507709] Testing event xdp_cpumap_kthread: OK
[  369.982941] Testing event xdp_redirect_map_err: OK
[  370.395305] Testing event xdp_redirect_map: OK
[  370.865565] Testing event xdp_redirect_err: OK
[  371.351014] Testing event xdp_redirect: OK
[  371.759566] Testing event xdp_exception: OK
[  372.256245] Testing event rseq_ip_fixup: OK
[  372.670434] Testing event rseq_update: OK
[  373.040644] Testing event file_check_and_advance_wb_err: OK
[  373.430194] Testing event filemap_set_wb_err: OK
[  373.917636] Testing event mm_filemap_add_to_page_cache: OK
[  374.435123] Testing event mm_filemap_delete_from_page_cache: OK
[  374.891674] Testing event compact_retry: OK
[  375.343859] Testing event skip_task_reaping: OK
[  375.822395] Testing event finish_task_reaping: OK
[  376.227501] Testing event start_task_reaping: OK
[  376.627044] Testing event wake_reaper: OK
[  377.110273] Testing event mark_victim: OK
[  377.585296] Testing event reclaim_retry_zone: OK
[  378.039595] Testing event oom_score_adj_update: OK
[  378.489423] Testing event mm_lru_activate: OK
[  378.964670] Testing event mm_lru_insertion: OK
[  379.380418] Testing event mm_vmscan_inactive_list_is_low: OK
[  379.768585] Testing event mm_vmscan_lru_shrink_active: OK
[  380.182963] Testing event mm_vmscan_lru_shrink_inactive: OK
[  380.487605] Testing event mm_vmscan_writepage: OK
[  380.801981] Testing event mm_vmscan_lru_isolate: OK
[  381.324124] Testing event mm_shrink_slab_end: OK
[  381.797742] Testing event mm_shrink_slab_start: OK
[  382.234425] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK
[  382.739569] Testing event mm_vmscan_memcg_reclaim_end: OK
[  383.126138] Testing event mm_vmscan_direct_reclaim_end: OK
[  383.558437] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK
[  384.053486] Testing event mm_vmscan_memcg_reclaim_begin: OK
[  384.504424] Testing event mm_vmscan_direct_reclaim_begin: OK
[  384.853744] Testing event mm_vmscan_wakeup_kswapd: OK
[  385.324798] Testing event mm_vmscan_kswapd_wake: OK
[  385.799072] Testing event mm_vmscan_kswapd_sleep: OK
[  386.295847] Testing event percpu_destroy_chunk: OK
[  386.730539] Testing event percpu_create_chunk: OK
[  387.047224] Testing event percpu_alloc_percpu_fail: OK
[  387.490312] Testing event percpu_free_percpu: OK
[  387.980055] Testing event percpu_alloc_percpu: OK
[  388.452470] Testing event mm_page_alloc_extfrag: OK
[  388.896956] Testing event mm_page_pcpu_drain: OK
[  389.306863] Testing event mm_page_alloc_zone_locked: OK
[  389.796041] Testing event mm_page_alloc: OK
[  390.228570] Testing event mm_page_free_batched: OK
[  390.721091] Testing event mm_page_free: OK
[  391.169620] Testing event kmem_cache_free: OK
[  391.642303] Testing event kfree: OK
[  392.098956] Testing event kmem_cache_alloc_node: OK
[  392.577083] Testing event kmalloc_node: OK
[  392.980231] Testing event kmem_cache_alloc: OK
[  393.439202] Testing event kmalloc: OK
[  393.858895] Testing event mm_compaction_kcompactd_wake: OK
[  394.260020] Testing event mm_compaction_wakeup_kcompactd: OK
[  394.678091] Testing event mm_compaction_kcompactd_sleep: OK
[  395.191034] Testing event mm_compaction_defer_reset: OK
[  395.612853] Testing event mm_compaction_defer_compaction: OK
[  396.002217] Testing event mm_compaction_deferred: OK
[  396.434655] Testing event mm_compaction_suitable: OK
[  396.860040] Testing event mm_compaction_finished: OK
[  397.422173] Testing event mm_compaction_try_to_compact_pages: OK
[  397.812550] Testing event mm_compaction_end: OK
[  398.286419] Testing event mm_compaction_begin: OK
[  398.703239] Testing event mm_compaction_migratepages: OK
[  399.026465] Testing event mm_compaction_isolate_freepages: OK
[  399.539168] Testing event mm_compaction_isolate_migratepages: OK
[  400.050746] Testing event mm_migrate_pages: OK
[  400.487675] Testing event mm_collapse_huge_page_swapin: OK
[  400.961934] Testing event mm_collapse_huge_page_isolate: OK
[  401.403420] Testing event mm_collapse_huge_page: OK
[  401.812548] Testing event mm_khugepaged_scan_pmd: OK
[  402.075461] Testing event test_pages_isolated: OK
[  402.548642] Testing event cma_release: OK
[  403.083519] Testing event cma_alloc: OK
[  403.487303] Testing event page_ref_unfreeze: OK
[  403.874551] Testing event page_ref_freeze: OK
[  404.424256] Testing event page_ref_mod_unless: OK
[  404.903949] Testing event page_ref_mod_and_return: OK
[  405.256169] Testing event page_ref_mod_and_test: OK
[  406.688840] Testing event page_ref_mod: OK
[  407.311201] Testing event page_ref_set: OK
[  407.934064] Testing event sb_clear_inode_writeback: OK
[  408.312908] Testing event sb_mark_inode_writeback: OK
[  409.037284] Testing event writeback_dirty_inode_enqueue: OK
[  409.388466] Testing event writeback_lazytime_iput: OK
[  409.806600] Testing event writeback_lazytime: OK
[  410.312352] Testing event writeback_single_inode: OK
[  410.779997] Testing event writeback_single_inode_start: OK
[  411.136085] Testing event writeback_wait_iff_congested: OK
[  411.497987] Testing event writeback_congestion_wait: OK
[  411.910341] Testing event writeback_sb_inodes_requeue: OK
[  412.341650] Testing event balance_dirty_pages: OK
[  412.810901] Testing event bdi_dirty_ratelimit: OK
[  413.229800] Testing event global_dirty_state: OK
[  413.694554] Testing event writeback_queue_io: OK
[  414.091674] Testing event wbc_writepage: OK
[  414.452086] Testing event writeback_bdi_register: OK
[  414.950319] Testing event writeback_wake_background: OK
[  415.421183] Testing event writeback_pages_written: OK
[  415.843447] Testing event writeback_wait: OK
[  416.262583] Testing event writeback_written: OK
[  416.662003] Testing event writeback_start: OK
[  417.277442] Testing event writeback_exec: OK
[  418.259089] Testing event writeback_queue: OK
[  418.768662] Testing event writeback_write_inode: OK
[  419.203848] Testing event writeback_write_inode_start: OK
[  419.483305] Testing event writeback_dirty_inode: OK
[  419.917846] Testing event writeback_dirty_inode_start: OK
[  420.457962] Testing event writeback_mark_inode_dirty: OK
[  420.909284] Testing event writeback_dirty_page: OK
[  421.418319] Testing event dax_writeback_one: OK
[  421.837264] Testing event dax_writeback_range_done: OK
[  422.276436] Testing event dax_writeback_range: OK
[  422.727571] Testing event dax_insert_mapping: OK
[  423.244362] Testing event dax_insert_pfn_mkwrite: OK
[  423.710739] Testing event dax_insert_pfn_mkwrite_no_entry: OK
[  424.138016] Testing event dax_load_hole: OK
[  424.574390] Testing event dax_pte_fault_done: OK
[  425.007339] Testing event dax_pte_fault: OK
[  425.440637] Testing event dax_pmd_insert_mapping: OK
[  425.896515] Testing event dax_pmd_load_hole_fallback: OK
[  426.369106] Testing event dax_pmd_load_hole: OK
[  426.785386] Testing event dax_pmd_fault_done: OK
[  427.189456] Testing event dax_pmd_fault: OK
[  427.681205] Testing event generic_add_lease: OK
[  428.094082] Testing event time_out_leases: OK
[  428.543904] Testing event generic_delete_lease: OK
[  428.845268] Testing event break_lease_unblock: OK
[  429.406393] Testing event break_lease_block: OK
[  429.814872] Testing event break_lease_noblock: OK
[  430.290794] Testing event flock_lock_inode: OK
[  430.730115] Testing event locks_remove_posix: OK
[  431.212671] Testing event fcntl_setlk: OK
[  431.733977] Testing event posix_lock_inode: OK
[  432.104584] Testing event locks_get_lock_context: OK
[  432.551538] Testing event block_rq_remap: OK
[  433.002391] Testing event block_bio_remap: OK
[  433.441891] Testing event block_split: OK
[  433.885030] Testing event block_unplug: OK
[  434.314853] Testing event block_plug: OK
[  434.759827] Testing event block_sleeprq: OK
[  435.173796] Testing event block_getrq: OK
[  435.594402] Testing event block_bio_queue: OK
[  436.179877] Testing event block_bio_frontmerge: OK
[  436.542335] Testing event block_bio_backmerge: OK
[  436.950189] Testing event block_bio_complete: OK
[  437.252299] Testing event block_bio_bounce: OK
[  437.576451] Testing event block_rq_issue: OK
[  438.045263] Testing event block_rq_insert: OK
[  438.504791] Testing event block_rq_complete: OK
[  438.975332] Testing event block_rq_requeue: OK
[  439.471511] Testing event block_dirty_buffer: OK
[  439.878561] Testing event block_touch_buffer: OK
[  440.243760] Testing event wbt_timer: OK
[  440.566174] Testing event wbt_step: OK
[  441.022737] Testing event wbt_lat: OK
[  441.390048] Testing event wbt_stat: OK
[  442.031298] Testing event gpio_value: OK
[  442.411484] Testing event gpio_direction: OK
[  442.843307] Testing event clk_set_duty_cycle_complete: OK
[  443.351925] Testing event clk_set_duty_cycle: OK
[  443.847734] Testing event clk_set_phase_complete: OK
[  444.270761] Testing event clk_set_phase: OK
[  444.748146] Testing event clk_set_parent_complete: OK
[  445.117367] Testing event clk_set_parent: OK
[  445.639498] Testing event clk_set_rate_complete: OK
[  446.082331] Testing event clk_set_rate: OK
[  446.521923] Testing event clk_unprepare_complete: OK
[  446.918678] Testing event clk_unprepare: OK
[  447.389522] Testing event clk_prepare_complete: OK
[  447.766212] Testing event clk_prepare: OK
[  448.342873] Testing event clk_disable_complete: OK
[  448.631593] Testing event clk_disable: OK
[  449.125926] Testing event clk_enable_complete: OK
[  449.701968] Testing event clk_enable: OK
[  450.103387] Testing event rpmh_send_msg: OK
[  450.573406] Testing event rpmh_tx_done: OK
[  450.898511] Testing event regulator_set_voltage_complete: OK
[  451.334299] Testing event regulator_set_voltage: OK
[  451.759385] Testing event regulator_disable_complete: OK
[  452.169742] Testing event regulator_disable: OK
[  452.491346] Testing event regulator_enable_complete: OK
[  452.846037] Testing event regulator_enable_delay: OK
[  453.316910] Testing event regulator_enable: OK
[  453.736012] Testing event urandom_read: OK
[  454.139459] Testing event random_read: OK
[  454.583540] Testing event extract_entropy_user: OK
[  455.094649] Testing event extract_entropy: OK
[  455.546340] Testing event get_random_bytes_arch: OK
[  456.010231] Testing event get_random_bytes: OK
[  456.417388] Testing event xfer_secondary_pool: OK
[  456.752882] Testing event add_disk_randomness: OK
[  457.203335] Testing event add_input_randomness: OK
[  457.609984] Testing event debit_entropy: OK
[  458.101625] Testing event push_to_pool: OK
[  458.490572] Testing event credit_entropy_bits: OK
[  458.878911] Testing event mix_pool_bytes_nolock: OK
[  459.267212] Testing event mix_pool_bytes: OK
[  459.812860] Testing event add_device_randomness: OK
[  460.236888] Testing event io_page_fault: OK
[  460.613549] Testing event unmap: OK
[  461.037429] Testing event map: OK
[  461.468955] Testing event detach_device_from_domain: OK
[  461.936175] Testing event attach_device_to_domain: OK
[  462.364449] Testing event remove_device_from_group: OK
[  462.903017] Testing event add_device_to_group: OK
[  463.356223] Testing event regcache_drop_region: OK
[  463.772360] Testing event regmap_async_complete_done: OK
[  464.185773] Testing event regmap_async_complete_start: OK
[  464.683445] Testing event regmap_async_io_complete: OK
[  465.188856] Testing event regmap_async_write_start: OK
[  465.610576] Testing event regmap_cache_bypass: OK
[  466.006797] Testing event regmap_cache_only: OK
[  466.426732] Testing event regcache_sync: OK
[  466.831822] Testing event regmap_hw_write_done: OK
[  467.366363] Testing event regmap_hw_write_start: OK
[  467.906480] Testing event regmap_hw_read_done: OK
[  468.263650] Testing event regmap_hw_read_start: OK
[  468.774798] Testing event regmap_reg_read_cache: OK
[  469.233436] Testing event regmap_reg_read: OK
[  469.707994] Testing event regmap_reg_write: OK
[  470.164108] Testing event dma_fence_wait_end: OK
[  470.536810] Testing event dma_fence_wait_start: OK
[  470.898595] Testing event dma_fence_signaled: OK
[  471.342000] Testing event dma_fence_enable_signal: OK
[  471.850137] Testing event dma_fence_destroy: OK
[  472.277900] Testing event dma_fence_init: OK
[  472.759280] Testing event dma_fence_emit: OK
[  473.268174] Testing event sync_timeline: OK
[  473.715113] Testing event spi_transfer_stop: OK
[  474.116950] Testing event spi_transfer_start: OK
[  474.519730] Testing event spi_message_done: OK
[  474.927709] Testing event spi_message_start: OK
[  475.287707] Testing event spi_message_submit: OK
[  475.805032] Testing event spi_controller_busy: OK
[  476.129319] Testing event spi_controller_idle: OK
[  476.589609] Testing event rtc_timer_fired: OK
[  477.053881] Testing event rtc_timer_dequeue: OK
[  477.451619] Testing event rtc_timer_enqueue: OK
[  477.771207] Testing event rtc_read_offset: OK
[  478.209420] Testing event rtc_set_offset: OK
[  478.711737] Testing event rtc_alarm_irq_enable: OK
[  479.134654] Testing event rtc_irq_set_state: OK
[  479.513030] Testing event rtc_irq_set_freq: OK
[  479.993350] Testing event rtc_read_alarm: OK
[  480.348960] Testing event rtc_set_alarm: OK
[  480.869835] Testing event rtc_read_time: OK
[  481.189100] Testing event rtc_set_time: OK
[  481.721573] Testing event memory_failure_event: OK
[  482.152577] Testing event aer_event: OK
[  482.600820] Testing event non_standard_event: OK
[  483.016024] Testing event arm_event: OK
[  483.421566] Testing event mc_event: OK
[  483.846356] Testing event binder_return: OK
[  484.270366] Testing event binder_command: OK
[  484.672549] Testing event binder_unmap_kernel_end: OK
[  485.211997] Testing event binder_unmap_kernel_start: OK
[  485.656509] Testing event binder_unmap_user_end: OK
[  486.195940] Testing event binder_unmap_user_start: OK
[  486.658145] Testing event binder_alloc_page_end: OK
[  487.124249] Testing event binder_alloc_page_start: OK
[  487.524172] Testing event binder_free_lru_end: OK
[  487.931110] Testing event binder_free_lru_start: OK
[  488.374228] Testing event binder_alloc_lru_end: OK
[  488.744477] Testing event binder_alloc_lru_start: OK
[  489.158014] Testing event binder_update_page_range: OK
[  489.677698] Testing event binder_transaction_failed_buffer_release: OK
[  490.005040] Testing event binder_transaction_buffer_release: OK
[  490.347627] Testing event binder_transaction_alloc_buf: OK
[  490.867229] Testing event binder_transaction_fd_recv: OK
[  491.351095] Testing event binder_transaction_fd_send: OK
[  491.896684] Testing event binder_transaction_ref_to_ref: OK
[  492.270237] Testing event binder_transaction_ref_to_node: OK
[  492.764722] Testing event binder_transaction_node_to_ref: OK
[  493.189405] Testing event binder_transaction_received: OK
[  493.585178] Testing event binder_transaction: OK
[  493.991899] Testing event binder_wait_for_work: OK
[  494.421621] Testing event binder_read_done: OK
[  494.910366] Testing event binder_write_done: OK
[  495.342489] Testing event binder_ioctl_done: OK
[  495.848969] Testing event binder_unlock: OK
[  497.122633] Testing event binder_locked: OK
[  497.528831] Testing event binder_lock: OK
[  498.087838] Testing event binder_ioctl: OK
[  498.482685] Testing event br_fdb_update: OK
[  498.914264] Testing event fdb_delete: OK
[  499.350984] Testing event br_fdb_external_learn_add: OK
[  499.765979] Testing event br_fdb_add: OK
[  500.229735] Testing event qdisc_dequeue: OK
[  500.676057] Testing event fib_table_lookup: OK
[  501.105264] Testing event tcp_probe: OK
[  501.544035] Testing event tcp_retransmit_synack: OK
[  501.962536] Testing event tcp_rcv_space_adjust: OK
[  502.394139] Testing event tcp_destroy_sock: OK
[  502.887202] Testing event tcp_receive_reset: OK
[  503.310051] Testing event tcp_send_reset: OK
[  503.694823] Testing event tcp_retransmit_skb: OK
[  504.134257] Testing event udp_fail_queue_rcv_skb: OK
[  504.584199] Testing event inet_sock_set_state: OK
[  504.982764] Testing event sock_exceed_buf_limit: OK
[  505.391853] Testing event sock_rcvqueue_full: OK
[  505.839541] Testing event napi_poll: OK
[  506.290354] Testing event netif_rx_ni_entry: OK
[  506.737915] Testing event netif_rx_entry: OK
[  507.136716] Testing event netif_receive_skb_list_entry: OK
[  507.660690] Testing event netif_receive_skb_entry: OK
[  508.133587] Testing event napi_gro_receive_entry: OK
[  508.587922] Testing event napi_gro_frags_entry: OK
[  509.062241] Testing event netif_rx: OK
[  509.537138] Testing event netif_receive_skb: OK
[  510.031019] Testing event net_dev_queue: OK
[  510.468500] Testing event net_dev_xmit: OK
[  510.786003] Testing event net_dev_start_xmit: OK
[  511.155642] Testing event skb_copy_datagram_iovec: OK
[  511.703377] Testing event consume_skb: OK
[  512.286895] Testing event kfree_skb: OK
[  512.647196] Testing event 9p_protocol_dump: OK
[  513.056441] Testing event 9p_client_res: OK
[  513.519013] Testing event 9p_client_req: OK
[  513.965323] Running tests on trace event systems:
[  513.975499] Testing event system 9p: OK
[  514.473824] Testing event system skb: OK
[  514.947157] Testing event system net: OK
[  515.591089] Testing event system napi: OK
[  516.131109] Testing event system sock: OK
[  516.476482] Testing event system udp: OK
[  516.927471] Testing event system tcp: OK
[  517.520166] Testing event system fib: OK
[  517.948714] Testing event system qdisc: OK
[  518.578221] Testing event system bridge: OK
[  518.923918] Testing event system binder: OK
[  519.822344] Testing event system ras: OK
[  522.193824] Testing event system rtc: OK
[  522.765120] Testing event system spi: OK
[  523.301276] Testing event system sync_trace: OK
[  523.790639] Testing event system dma_fence: OK
[  524.310846] Testing event system regmap: OK
[  525.005992] Testing event system iommu: OK
[  525.584970] Testing event system random: OK
[  526.331873] Testing event system regulator: OK
[  526.959487] Testing event system rpmh: OK
[  527.500567] Testing event system clk: OK
[  528.222547] Testing event system gpio: OK
[  528.833684] Testing event system wbt: OK
[  529.296020] Testing event system block: OK
[  530.007420] Testing event system filelock: OK
[  530.440458] Testing event system fs_dax: OK
[  531.173904] Testing event system writeback: OK
[  532.078466] Testing event system page_ref: OK
[  534.004830] Testing event system cma: OK
[  534.558743] Testing event system page_isolation: OK
[  535.028911] Testing event system huge_memory: OK
[  535.476990] Testing event system migrate: OK
[  535.991071] Testing event system compaction: OK
[  536.535614] Testing event system kmem: OK
[  537.197192] Testing event system percpu: OK
[  537.824618] Testing event system vmscan: OK
[  538.416157] Testing event system pagemap: OK
[  539.055671] Testing event system oom: OK
[  539.579131] Testing event system filemap: OK
[  540.216625] Testing event system rseq: OK
[  540.696207] Testing event system xdp: OK
[  541.209181] Testing event system benchmark: OK
[  541.869089] Testing event system rpm: OK
[  542.339920] Testing event system power: OK
[  543.098427] Testing event system test: OK
[  543.770262] Testing event system preemptirq: OK
[  544.553508] Testing event system cgroup: OK
[  545.154624] Testing event system module: OK
[  545.638505] Testing event system alarmtimer: OK
[  546.044868] Testing event system timer: OK
[  546.794321] Testing event system swiotlb: OK
[  547.320861] Testing event system rcu: OK
[  548.090307] Testing event system printk: OK
[  548.652217] Testing event system lock: OK
[  549.166468] Testing event system sched: OK
[  549.982615] Testing event system workqueue: OK
[  550.546801] Testing event system signal: OK
[  551.092283] Testing event system irq: OK
[  551.655370] Testing event system cpuhp: OK
[  552.076854] Testing event system task: OK
[  553.627889] Testing event system kvm: OK
[  554.523607] Testing event system emulation: OK
[  555.044844] Testing event system ipi: OK
[  555.668286] Testing event system raw_syscalls: OK
[  556.280017] Testing event system initcall: OK
[  556.750753] Running tests on all trace events:
[  556.776884] Testing all events: OK
[  580.507318] ftrace_replace_code: 1
[  588.006088] ../kernel/trace/ftrace.c:2442, loop_counter: 41840
[  588.012730] Testing ftrace filter: OK
[  588.091979] trace_kprobe: Testing kprobe tracing: OK
[  588.766726] Loading compiled-in X.509 certificates
[  588.865969] _warn_unseeded_randomness: 15 callbacks suppressed
[  588.867260] random: get_random_bytes called from key_alloc+0x380/0x698 with crng_init=0
[  588.869149] Loaded X.509 cert 'Build time autogenerated kernel key: ef4425a12675de91b49c005bf61fbcc152bd6e38'
[  588.884240] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  588.885345] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  588.912120] zswap: default zpool zbud not available
[  588.913028] zswap: pool creation failed
[  588.937134] page_owner is disabled
[  589.053829] cryptomgr_probe (1252) used greatest stack depth: 11920 bytes left
[  589.058705] Key type big_key registered
[  589.121086] Key type encrypted registered
[  589.125795] ima: No TPM chip found, activating TPM-bypass!
[  589.127755] ima: Allocated hash algorithm: sha1
[  589.131099] No architecture policies found
[  589.137616] evm: Initialising EVM extended attributes:
[  589.138801] evm: security.selinux
[  589.139328] evm: security.SMACK64
[  589.139889] evm: security.SMACK64EXEC
[  589.140420] evm: security.SMACK64TRANSMUTE
[  589.140948] evm: security.SMACK64MMAP
[  589.141399] evm: security.apparmor
[  589.141837] evm: security.ima
[  589.142713] evm: security.capability
[  589.143193] evm: HMAC attrs: 0x1
[  589.196376] hctosys: unable to open rtc device (rtc0)
[  589.212142] psci_checker: PSCI checker started using 1 CPUs
[  589.212722] psci_checker: Starting hotplug tests
[  589.214495] psci_checker: Trying to turn off and on again all CPUs
[  589.215580] psci_checker: Trying to turn off and on again group 0 (CPUs 0)
[  589.216666] psci_checker: Hotplug tests passed OK
[  589.217254] psci_checker: Starting suspend tests (10 cycles per state)
[  589.218563] psci_checker: cpuidle not available on CPU 0, ignoring
[  589.219438] psci_checker: Could not start suspend tests on any CPU
[  589.220044] psci_checker: PSCI checker completed
[  589.273216] Duplicate name in testcase-data, renamed to "duplicate-name#1"
[  589.429220] ### dt-test ### start of unittest - you will see error messages
[  589.449870] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1
[  589.451580] OF: /testcase-data/phandle-tests/consumer-a: could not get #phandle-cells-missing for /testcase-data/phandle-tests/provider1
[  589.452828] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle
[  589.453800] OF: /testcase-data/phandle-tests/consumer-a: could not find phandle
[  589.455227] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property
[  589.456164] OF: /testcase-data/phandle-tests/consumer-a: arguments longer than property
[  589.469879] OF: /testcase-data/phandle-tests/consumer-b: could not get #phandle-missing-cells for /testcase-data/phandle-tests/provider1
[  589.472209] OF: /testcase-data/phandle-tests/consumer-b: could not find phandle
[  589.473820] OF: /testcase-data/phandle-tests/consumer-b: arguments longer than property
[  589.661406] kobject: 'testcase-data:platform-tests:test-device@1' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  589.674936] kobject: 'testcase-data:platform-tests:test-device@0' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  589.683837] kobject: 'unittest-bus.0' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  589.799946] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest0/status
[  589.839331] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest1/status
[  589.852390] kobject: 'testcase-data:overlay-node:test-bus:test-unittest1' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  589.860629] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest2/status
[  589.870608] _warn_unseeded_randomness: 5 callbacks suppressed
[  589.870846] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  589.900723] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest3/status
[  589.912447] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  589.913379] kobject: 'testcase-data:overlay-node:test-bus:test-unittest3' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  589.921563] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  589.965808] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest5/status
[  590.011544] kobject: 'testcase-data:overlay-node:test-bus:test-unittest5' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  590.020946] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest6/status
[  590.056323] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest7/status
[  590.103118] kobject: 'testcase-data:overlay-node:test-bus:test-unittest7' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  590.115581] kobject: 'testcase-data:overlay-node:test-bus:test-unittest6' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  590.123627] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/status
[  590.158897] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data/overlay-node/test-bus/test-unittest8/property-foo
[  590.160918] OF: overlay: node_overlaps_later_cs: #6 overlaps with #7 @/testcase-data/overlay-node/test-bus/test-unittest8
[  590.161847] OF: overlay: overlay #6 is not topmost
[  590.174769] kobject: 'testcase-data:overlay-node:test-bus:test-unittest8' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  590.364873] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11:test-unittest111' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  590.376142] kobject: 'testcase-data:overlay-node:test-bus:test-unittest11' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  590.377713] 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
[  590.379780] 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
[  590.381600] OF: overlay: remove: Could not find overlay #7
[  590.382822] ### dt-test ### of_unittest_destroy_tracked_overlays: no overlay to destroy for #7
[  590.397127] kobject: 'testcase-data:overlay-node:test-bus:test-unittest10:test-unittest101' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  590.408229] kobject: 'testcase-data:overlay-node:test-bus:test-unittest10' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  590.409786] 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
[  590.411998] 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
[  590.424737] kobject: 'testcase-data:overlay-node:test-bus:test-unittest4' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  590.426625] 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
[  590.468801] kobject: 'testcase-data:overlay-node:test-bus:test-unittest2' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  590.511362] kobject: 'testcase-data:overlay-node:test-bus:test-unittest0' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  590.569154] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/status
[  590.573235] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/status
[  590.575628] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/ride@100/track@30/incline-up
[  590.576973] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/fairway-1/ride@100/track@40/incline-up
[  590.585530] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/status
[  590.587227] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/color
[  590.588348] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/lights@40000/rate
[  590.589967] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/hvac_2
[  590.592042] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200
[  590.593251] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200_left
[  590.595205] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /__symbols__/ride_200_right
[  590.676602] OF: overlay: ERROR: multiple fragments add and/or delete node /testcase-data-2/substation@100/motor-1/controller
[  590.680344] OF: overlay: ERROR: multiple fragments add, update, and/or delete property /testcase-data-2/substation@100/motor-1/controller/name
[  590.681879] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  590.683750] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  590.691212] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/motor-1/rpm_avail
[  590.692470] OF: overlay: WARNING: memory leak will occur if overlay removed, property: /testcase-data-2/substation@100/motor-1/rpm_avail
[  590.693790] OF: overlay: ERROR: multiple fragments add, update, and/or delete property /testcase-data-2/substation@100/motor-1/rpm_avail
[  590.707070] kobject: '(null)' ((____ptrval____)): kobject_release, parent           (null) (delayed 750)
[  590.708400] ### dt-test ### end of unittest - 217 passed, 0 failed
[  590.737213] uart-pl011 9000000.pl011: no DMA platform data
[  590.988437] _warn_unseeded_randomness: 12 callbacks suppressed
[  590.988689] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0
[  590.990091] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0
[  591.029761] VFS: Mounted root (9p filesystem) readonly on device 0:19.
[  591.048594] devtmpfs: mounted
[  591.068579] integrity: Unable to open file: /etc/keys/x509_ima.der (-2)
[  591.081753] integrity: Unable to open file: /etc/keys/x509_evm.der (-2)
[  591.728178] Freeing unused kernel memory: 6144K
[  591.733076] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0
[  591.733873] kobject: 'test-unittest11' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  591.736963] kobject: 'test-unittest4' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  592.140029] Checked W+X mappings: passed, no W+X pages found
[  592.140895] rodata_test: all tests were successful
[  592.141867] Run /sbin/init as init process
[  592.173126] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0
[  592.255238] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=0
[  592.257132] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=0
[  592.420735] kobject: 'test-unittest10' ((____ptrval____)): kobject_release, parent           (null) (delayed 500)
[  593.060626] random: fast init done
[  593.764829] OF: ERROR: memory leak before free overlay changeset,  /testcase-data/overlay-node/test-bus/test-unittest4
[  593.767071] OF: ERROR: memory leak before free overlay changeset,  /testcase-data/overlay-node/test-bus/test-unittest11
[  594.437209] OF: ERROR: memory leak before free overlay changeset,  /testcase-data/overlay-node/test-bus/test-unittest10
[  594.596315] _warn_unseeded_randomness: 5 callbacks suppressed
[  594.596560] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=1
[  594.597743] kobject: 'test-unittest101' ((____ptrval____)): kobject_release, parent           (null) (delayed 1000)
[  594.604894] kobject: 'test-unittest111' ((____ptrval____)): kobject_release, parent           (null) (delayed 250)
[  594.985452] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1
[  595.621529] 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
[  596.588079] systemd[1]: System time before build time, advancing clock.
[  596.997590] systemd[1]: Failed to insert module 'autofs4': No such file or directory
[  598.935526] OF: ERROR: memory leak before free overlay changeset,  /testcase-data/overlay-node/test-bus/test-unittest10/test-unittest101
[  599.653730] random: systemd: uninitialized urandom read (16 bytes read)
[  599.939948] random: systemd: uninitialized urandom read (16 bytes read)
[  599.944572] random: systemd: uninitialized urandom read (16 bytes read)
[  604.481767] systemd[1]: systemd 232 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN)
[  604.551242] systemd[1]: Detected virtualization qemu.
[  604.557735] systemd[1]: Detected architecture arm64.

Welcome to Debian GNU/Linux 9 (stretch)!

[  604.684643] systemd[1]: Set hostname to <compilator>.
[  604.848725] random: get_random_u32 called from bucket_table_alloc+0x130/0x1a8 with crng_init=1
[  604.905970] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1
[  605.496258] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1
[  605.949330] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  605.951156] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  605.951981] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  606.951262] _warn_unseeded_randomness: 21 callbacks suppressed
[  606.951505] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  606.952917] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  606.953718] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  608.003419] random: systemd: uninitialized urandom read (16 bytes read)
[  608.033887] _warn_unseeded_randomness: 9 callbacks suppressed
[  608.034133] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  608.036115] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  608.037010] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  609.619262] _warn_unseeded_randomness: 11 callbacks suppressed
[  609.619505] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  609.620956] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  609.621817] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  612.208204] systemd-hiberna (1268) used greatest stack depth: 8 bytes left
[  613.571587] random: systemd-cryptse: uninitialized urandom read (16 bytes read)
[  614.149254] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read)
[  615.119759] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read)
[  616.817891] random: systemd: uninitialized urandom read (16 bytes read)
[  617.013498] random: systemd: uninitialized urandom read (16 bytes read)
[  617.017991] random: systemd: uninitialized urandom read (16 bytes read)
[  617.092259] _warn_unseeded_randomness: 8 callbacks suppressed
[  617.092533] random: get_random_u32 called from bpf_jit_binary_alloc+0xa0/0x110 with crng_init=1
[  617.207976] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1
[  623.757313] systemd[1]: networking.service: Cannot add dependency job, ignoring: Unit networking.service is masked.
[  623.823503] random: get_random_bytes called from generate_random_uuid+0x20/0x50 with crng_init=1
[  623.870803] systemd[1]: Starting of Arbitrary Executable File Formats File System Automount Point not supported.
[UNSUPP] Starting of Arbitrary Executable Fi…tem Automount Point not supported.
[  623.932691] systemd[1]: Listening on Syslog Socket.
[  OK  ] Listening on Syslog Socket.
[  623.957214] systemd[1]: Listening on udev Kernel Socket.
[  OK  ] Listening on udev Kernel Socket.
[  623.984376] systemd[1]: Listening on Journal Socket (/dev/log).
[  OK  ] Listening on Journal Socket (/dev/log).
[  624.013992] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[  OK  ] Listening on /dev/initctl Compatibility Named Pipe.
[  624.103652] systemd[1]: Created slice System Slice.
[  OK  ] Created slice System Slice.
[  624.118054] systemd[1]: Reached target Remote File Systems.
[  OK  ] Reached target Remote File Systems.
[  624.192663] systemd[1]: Created slice system-getty.slice.
[  OK  ] Created slice system-getty.slice.
[  624.401511] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1
[  624.505110] systemd[1]: Mounting Huge Pages File System...
         Mounting Huge Pages File System...
         Mounting POSIX Message Queue File System...
[  625.187081] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  625.188143] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  625.189051] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  OK  ] Listening on Journal Audit Socket.
         Mounting Debug File System...
[  OK  ] Listening on Journal Socket.
[  626.921193] _warn_unseeded_randomness: 13 callbacks suppressed
[  626.921476] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1
[  627.155595] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  627.157183] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
         Starting Create Static Device Nodes in /dev...
[  628.201228] _warn_unseeded_randomness: 6 callbacks suppressed
[  628.201493] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  628.204611] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  628.205985] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  629.233326] systemd[1]: Starting Load Kernel Modules...
         Starting Load Kernel Modules...
[  630.346932] _warn_unseeded_randomness: 5 callbacks suppressed
[  630.347172] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  630.349506] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  630.351786] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  630.723116] systemd[1]: Starting Journal Service...
         Starting Journal Service...
[  631.493921] systemd[1]: Created slice system-serial\x2dgetty.slice.
[  OK  ] Created slice system-serial\x2dgetty.slice.
[  632.128343] _warn_unseeded_randomness: 4 callbacks suppressed
[  632.128609] random: get_random_u32 called from bpf_jit_binary_alloc+0xa0/0x110 with crng_init=1
[  632.168286] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1
[  632.189778] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1
[  632.807927] systemd[1]: Starting Remount Root and Kernel File Systems...
         Starting Remount Root and Kernel File Systems...
[  632.945215] systemd[1]: Reached target Swap.
[  OK  ] Reached target Swap.
[  633.193971] systemd[1]: Listening on udev Control Socket.
[  OK  ] Listening on udev Control Socket.
[  633.352832] systemd[1]: Reached target Sockets.
[  OK  ] Reached target Sockets.
[  633.609098] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[  OK  ] Started Dispatch Password Requests to Console Directory Watch.
[  633.718706] systemd[1]: Reached target Slices.
[  OK  ] Reached target Slices.
[  633.961319] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Started Forward Password Requests to Wall Directory Watch.
[  OK  ] Reached target Encrypted Volumes.
[  OK  ] Reached target Paths.
[  634.423483] _warn_unseeded_randomness: 16 callbacks suppressed
[  634.423746] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  634.426042] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  634.509514] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1
[  636.525938] systemd[1]: Mounted Debug File System.
[  OK  ] Mounted Debug File System.
[  636.589232] systemd[1]: Mounted Huge Pages File System.
[  OK  ] Mounted Huge Pages File System.
[  636.650000] systemd[1]: Mounted POSIX Message Queue File System.
[  OK  ] Mounted POSIX Message Queue File System.
[  637.532404] systemd[1]: Started Create Static Device Nodes in /dev.
[  OK  ] Started Create Static Device Nodes in /dev.
[  638.124056] systemd[1]: Started Load Kernel Modules.
[  OK  ] Started Load Kernel Modules.
[  638.283237] _warn_unseeded_randomness: 4 callbacks suppressed
[  638.283500] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  638.285759] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  638.287889] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  639.064440] systemd[1]: Mounting Configuration File System...
         Mounting Configuration File System...
[  640.711430] systemd[1]: Starting Apply Kernel Variables...
         Starting Apply Kernel Variables...
[  640.769587] _warn_unseeded_randomness: 3 callbacks suppressed
[  640.769830] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  640.772824] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  640.774227] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  641.916042] _warn_unseeded_randomness: 5 callbacks suppressed
[  641.916284] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  641.919180] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  641.920523] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  642.633858] systemd[1]: Starting udev Kernel Device Manager...
         Starting udev Kernel Device Manager...
[  644.399824] _warn_unseeded_randomness: 3 callbacks suppressed
[  644.400084] random: get_random_u32 called from bpf_jit_binary_alloc+0xa0/0x110 with crng_init=1
[  644.411216] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1
[  644.458020] random: get_random_u32 called from bpf_jit_binary_alloc+0xa0/0x110 with crng_init=1
[  645.481830] systemd[1]: Mounted Configuration File System.
[  OK  ] Mounted Configuration File System.
[  645.611728] _warn_unseeded_randomness: 8 callbacks suppressed
[  645.612008] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1
[  646.141193] systemd[1]: Started Remount Root and Kernel File Systems.
[  OK  ] Started Remount Root and Kernel File Systems.
[  646.845749] systemd[1]: Started Apply Kernel Variables.
[  OK  ] Started Apply Kernel Variables.
[  648.257776] systemd[1]: Starting udev Coldplug all Devices...
         Starting udev Coldplug all Devices...
[  648.393189] systemd[1]: Reached target Local File Systems (Pre).
[  OK  ] Reached target Local File Systems (Pre).
[  648.482848] systemd[1]: Reached target Local File Systems.
[  OK  ] Reached target Local File Systems.
[  649.648613] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  649.650240] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  649.652146] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  650.029326] systemd[1]: Starting Load/Save Random Seed...
         Starting Load/Save Random Seed...
[  651.754029] _warn_unseeded_randomness: 2 callbacks suppressed
[  651.755746] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  651.757103] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  651.904947] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[*     ] (1 of 5) A start job is running for dev-ttyAMA0.device (30s / 30min)
[**    ] (1 of 5) A start job is running for dev-ttyAMA0.device (30s / 30min)
[***   ] (1 of 5) A start job is running for dev-ttyAMA0.device (31s / 30min)
[ ***  ] (2 of 5) A start job is running for…dplug all Devices (31s / no limit)[  655.960024] _warn_unseeded_randomness: 1 callbacks suppressed
[  655.960281] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1
[  656.465069] systemd[1]: Started Load/Save Random Seed.

[  OK  ] Started Load/Save Random Seed.
[  658.096579] systemd[1]: Started udev Kernel Device Manager.
[  OK  ] Started udev Kernel Device Manager.
[  *** ] (2 of 3) A start job is running for…dplug all Devices (39s / no limit)
[   ***] (2 of 3) A start job is running for…dplug all Devices (40s / no limit)
[    **] (3 of 3) A start job is running for Journal Service (40s / 30min 6s)
[     *] (3 of 3) A start job is running for Journal Service (41s / 30min 6s)
[    **] (3 of 3) A start job is running for Journal Service (41s / 30min 6s)
[   ***] (1 of 3) A start job is running for dev-ttyAMA0.device (42s / 30min)
[  *** ] (1 of 3) A start job is running for dev-ttyAMA0.device (42s / 30min)
[ ***  ] (1 of 3) A start job is running for dev-ttyAMA0.device (43s / 30min)
[***   ] (2 of 3) A start job is running for…dplug all Devices (43s / no limit)
[**    ] (2 of 3) A start job is running for…dplug all Devices (44s / no limit)
[*     ] (2 of 3) A start job is running for…dplug all Devices (44s / no limit)
[**    ] (3 of 3) A start job is running for Journal Service (45s / 30min 6s)
[***   ] (3 of 3) A start job is running for Journal Service (45s / 30min 6s)
[ ***  ] (3 of 3) A start job is running for Journal Service (46s / 30min 6s)[  670.189059] systemd[1]: Started Journal Service.

[  OK  ] Started Journal Service.
         Starting Flush Journal to Persistent Storage...
[  672.778775] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  672.780568] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  672.782029] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[  *** ] (1 of 3) A start job is running for dev-ttyAMA0.device (51s / 30min)
[   ***] (1 of 3) A start job is running for dev-ttyAMA0.device (52s / 30min)
[    **] (1 of 3) A start job is running for dev-ttyAMA0.device (52s / 30min)
[     *] (2 of 3) A start job is running for…dplug all Devices (53s / no limit)
[    **] (2 of 3) A start job is running for…dplug all Devices (54s / no limit)
[   ***] (2 of 3) A start job is running for…dplug all Devices (54s / no limit)
[  *** ] (3 of 3) A start job is running for…ersistent Storage (55s / 2min 16s)
[ ***  ] (3 of 3) A start job is running for…ersistent Storage (55s / 2min 16s)
[***   ] (3 of 3) A start job is running for…ersistent Storage (56s / 2min 16s)
[**    ] (1 of 3) A start job is running for dev-ttyAMA0.device (57s / 30min)
[*     ] (1 of 3) A start job is running for dev-ttyAMA0.device (58s / 30min)[  682.003678] _warn_unseeded_randomness: 5 callbacks suppressed
[  682.003928] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  682.005367] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  682.006882] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1

[**    ] (1 of 3) A start job is running for dev-ttyAMA0.device (58s / 30min)
[***   ] (2 of 3) A start job is running for…dplug all Devices (59s / no limit)[  683.316957] _warn_unseeded_randomness: 1 callbacks suppressed
[  683.317236] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=1

[ ***  ] (2 of 3) A start job is running for…dplug all Devices (59s / no limit)
[  *** ] (2 of 3) A start job is running for…plug all Devices (1min / no limit)
[   ***] (3 of 3) A start job is running for…rsistent Storage (1min / 2min 16s)
[    **] (3 of 3) A start job is running for…stent Storage (1min 1s / 2min 16s)
[     *] (3 of 3) A start job is running for…stent Storage (1min 1s / 2min 16s)
[    **] (1 of 3) A start job is running for…v-ttyAMA0.device (1min 2s / 30min)
[   ***] (1 of 3) A start job is running for…v-ttyAMA0.device (1min 2s / 30min)[  686.771478] systemd-journald[1285]: Received request to flush runtime journal from PID 1

[  *** ] (1 of 3) A start job is running for…v-ttyAMA0.device (1min 3s / 30min)
[ ***  ] (2 of 3) A start job is running for…g all Devices (1min 3s / no limit)[  687.447960] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=1

[  OK  ] Started Flush Journal to Persistent Storage.
         Starting Create Volatile Files and Directories...
[  690.811711] random: get_random_u64 called from arch_mmap_rnd+0x98/0xb0 with crng_init=1
[  690.812944] random: get_random_u64 called from randomize_stack_top+0x38/0x80 with crng_init=1
[  690.813859] random: get_random_u32 called from arch_align_stack+0x2c/0x48 with crng_init=1
[***   ] (2 of 3) A start job is running for…v-ttyAMA0.device (1min 9s / 30min)
[**    ] (2 of 3) A start job is running for…v-ttyAMA0.device (1min 9s / 30min)
[*     ] (3 of 3) A start job is running for… all Devices (1min 10s / no limit)
[**    ] (3 of 3) A start job is running for… all Devices (1min 10s / no limit)
[***   ] (3 of 3) A start job is running for… all Devices (1min 11s / no limit)
[ ***  ] (1 of 3) A start job is running for… Directories (1min 11s / no limit)
[  *** ] (1 of 3) A start job is running for… Directories (1min 12s / no limit)
[   ***] (1 of 3) A start job is running for… Directories (1min 12s / no limit)
[    **] (2 of 3) A start job is running for…-ttyAMA0.device (1min 13s / 30min)
[     *] (2 of 3) A start job is running for…-ttyAMA0.device (1min 13s / 30min)
[    **] (2 of 3) A start job is running for…-ttyAMA0.device (1min 14s / 30min)[  698.274664] _warn_unseeded_randomness: 4 callbacks suppressed
[  698.274897] random: get_random_bytes called from __prandom_timer+0x30/0x98 with crng_init=1

[   ***] (3 of 3) A start job is running for… all Devices (1min 14s / no limit)
[  *** ] (3 of 3) A start job is running for… all Devices (1min 15s / no limit)
[ ***  ] (3 of 3) A start job is running for… all Devices (1min 15s / no limit)
[***   ] (1 of 3) A start job is running for… Directories (1min 16s / no limit)
[**    ] (1 of 3) A start job is running for… Directories (1min 16s / no limit)
[*     ] (1 of 3) A start job is running for… Directories (1min 17s / no limit)
[**    ] (2 of 3) A start job is running for…-ttyAMA0.device (1min 17s / 30min)
[***   ] (2 of 3) A start job is running for…-ttyAMA0.device (1min 18s / 30min)
[ ***  ] (2 of 3) A start job is running for…-ttyAMA0.device (1min 18s / 30min)[  702.977571] random: crng init done

[  *** ] (3 of 3) A start job is running for… all Devices (1min 19s / no limit)
[   ***] (3 of 3) A start job is running for… all Devices (1min 19s / no limit)
[    **] (3 of 3) A start job is running for… all Devices (1min 20s / no limit)
[     *] (1 of 3) A start job is running for… Directories (1min 20s / no limit)
[    **] (1 of 3) A start job is running for… Directories (1min 21s / no limit)
[   ***] (1 of 3) A start job is running for… Directories (1min 21s / no limit)
[  *** ] (2 of 3) A start job is running for…-ttyAMA0.device (1min 22s / 30min)
[ ***  ] (2 of 3) A start job is running for…-ttyAMA0.device (1min 22s / 30min)
[***   ] (2 of 3) A start job is running for…-ttyAMA0.device (1min 23s / 30min)
[  OK  ] Started Create Volatile Files and Directories.
         Starting Update UTMP about System Boot/Shutdown...
         Starting Network Time Synchronization...
[**    ] (4 of 4) A start job is running for…oot/Shutdown (1min 29s / no limit)
[*     ] (4 of 4) A start job is running for…oot/Shutdown (1min 29s / no limit)
[**    ] (4 of 4) A start job is running for…oot/Shutdown (1min 30s / no limit)
[***   ] (1 of 4) A start job is running for…-ttyAMA0.device (1min 30s / 30min)
[ ***  ] (1 of 4) A start job is running for…-ttyAMA0.device (1min 31s / 30min)
[  *** ] (1 of 4) A start job is running for…-ttyAMA0.device (1min 32s / 30min)
[   ***] (2 of 4) A start job is running for… all Devices (1min 32s / no limit)
[  OK  ] Started Update UTMP about System Boot/Shutdown.
[    **] (2 of 3) A start job is running for… all Devices (1min 38s / no limit)
[     *] (2 of 3) A start job is running for… all Devices (1min 38s / no limit)
[    **] (3 of 3) A start job is running for…hronization (1min 39s / 31min 27s)
[   ***] (3 of 3) A start job is running for…hronization (1min 39s / 31min 27s)
[  *** ] (3 of 3) A start job is running for…hronization (1min 40s / 31min 27s)
[ ***  ] (1 of 3) A start job is running for…-ttyAMA0.device (1min 40s / 30min)
[***   ] (1 of 3) A start job is running for…-ttyAMA0.device (1min 41s / 30min)
[**    ] (1 of 3) A start job is running for…-ttyAMA0.device (1min 41s / 30min)
[*     ] (2 of 3) A start job is running for… all Devices (1min 42s / no limit)
[**    ] (2 of 3) A start job is running for… all Devices (1min 42s / no limit)
[***   ] (2 of 3) A start job is running for… all Devices (1min 43s / no limit)
[ ***  ] (3 of 3) A start job is running for…hronization (1min 43s / 31min 27s)
[  *** ] (3 of 3) A start job is running for…hronization (1min 44s / 31min 27s)
[   ***] (3 of 3) A start job is running for…hronization (1min 44s / 31min 27s)
[  OK  ] Started Network Time Synchronization.
[  OK  ] Reached target System Time Synchronized.
[    **] (1 of 2) A start job is running for…-ttyAMA0.device (1min 50s / 30min)
[     *] (1 of 2) A start job is running for…-ttyAMA0.device (1min 51s / 30min)
[    **] (1 of 2) A start job is running for…-ttyAMA0.device (1min 51s / 30min)
[   ***] (2 of 2) A start job is running for… all Devices (1min 52s / no limit)
[  *** ] (2 of 2) A start job is running for… all Devices (1min 52s / no limit)
[ ***  ] (2 of 2) A start job is running for… all Devices (1min 53s / no limit)
[***   ] (1 of 2) A start job is running for…-ttyAMA0.device (1min 53s / 30min)
[**    ] (1 of 2) A start job is running for…-ttyAMA0.device (1min 54s / 30min)
[*     ] (1 of 2) A start job is running for…-ttyAMA0.device (1min 54s / 30min)
[**    ] (2 of 2) A start job is running for… all Devices (1min 55s / no limit)
[***   ] (2 of 2) A start job is running for… all Devices (1min 55s / no limit)
[ ***  ] (2 of 2) A start job is running for… all Devices (1min 56s / no limit)
[  *** ] (1 of 2) A start job is running for…-ttyAMA0.device (1min 56s / 30min)
[   ***] (1 of 2) A start job is running for…-ttyAMA0.device (1min 57s / 30min)
[    **] (1 of 2) A start job is running for…-ttyAMA0.device (1min 57s / 30min)
[     *] (2 of 2) A start job is running for… all Devices (1min 58s / no limit)
[    **] (2 of 2) A start job is running for… all Devices (1min 58s / no limit)
[   ***] (2 of 2) A start job is running for… all Devices (1min 59s / no limit)
[  *** ] (1 of 2) A start job is running for…-ttyAMA0.device (1min 59s / 30min)
[ ***  ] (1 of 2) A start job is running for dev-ttyAMA0.device (2min / 30min)
[***   ] (1 of 2) A start job is running for dev-ttyAMA0.device (2min / 30min)
[**    ] (2 of 2) A start job is running for…g all Devices (2min 1s / no limit)
[*     ] (2 of 2) A start job is running for…g all Devices (2min 1s / no limit)
[**    ] (2 of 2) A start job is running for…g all Devices (2min 2s / no limit)
[***   ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 2s / 30min)
[ ***  ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 3s / 30min)
[  *** ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 3s / 30min)
[   ***] (2 of 2) A start job is running for…g all Devices (2min 4s / no limit)
[    **] (2 of 2) A start job is running for…g all Devices (2min 4s / no limit)
[     *] (2 of 2) A start job is running for…g all Devices (2min 5s / no limit)
[    **] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 5s / 30min)
[   ***] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 6s / 30min)
[  *** ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 6s / 30min)
[ ***  ] (2 of 2) A start job is running for…g all Devices (2min 7s / no limit)
[***   ] (2 of 2) A start job is running for…g all Devices (2min 7s / no limit)
[**    ] (2 of 2) A start job is running for…g all Devices (2min 8s / no limit)
[*     ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 8s / 30min)
[**    ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 9s / 30min)
[***   ] (1 of 2) A start job is running for…v-ttyAMA0.device (2min 9s / 30min)
[ ***  ] (2 of 2) A start job is running for… all Devices (2min 10s / no limit)
[  *** ] (2 of 2) A start job is running for… all Devices (2min 10s / no limit)
[   ***] (2 of 2) A start job is running for… all Devices (2min 11s / no limit)
[    **] (1 of 2) A start job is running for…-ttyAMA0.device (2min 11s / 30min)
[     *] (1 of 2) A start job is running for…-ttyAMA0.device (2min 12s / 30min)
[    **] (1 of 2) A start job is running for…-ttyAMA0.device (2min 12s / 30min)
[   ***] (2 of 2) A start job is running for… all Devices (2min 13s / no limit)
[  *** ] (2 of 2) A start job is running for… all Devices (2min 13s / no limit)
[ ***  ] (2 of 2) A start job is running for… all Devices (2min 14s / no limit)
[***   ] (1 of 2) A start job is running for…-ttyAMA0.device (2min 14s / 30min)
[  OK  ] Found device /dev/ttyAMA0.
[  761.984896] virtio_net virtio0 enp0s1: renamed from eth0
[**    ] A start job is running for udev Col… all Devices (2min 21s / no limit)
[*     ] A start job is running for udev Col… all Devices (2min 21s / no limit)
[**    ] A start job is running for udev Col… all Devices (2min 21s / no limit)
[  OK  ] Started udev Coldplug all Devices.
[  OK  ] Reached target System Initialization.
[  OK  ] Reached target Basic System.
         Starting System Logging Service...
         Starting getty on tty2-tty6 if dbus and logind are not available...
[  OK  ] Started Daily Cleanup of Temporary Directories.
[  OK  ] Started Daily apt upgrade and clean activities.
[  OK  ] Reached target Timers.
         Starting Permit User Sessions...
[  OK  ] Started Regular background program processing daemon.
[  OK  ] Started System Logging Service.
[  OK  ] Started Permit User Sessions.
[***   ] A start job is running for getty on…ot available (2min 47s / no limit)
[ ***  ] A start job is running for getty on…ot available (2min 51s / no limit)
[  *** ] A start job is running for getty on…ot available (2min 52s / no limit)
[   ***] A start job is running for getty on…ot available (2min 55s / no limit)
[    **] A start job is running for getty on…ot available (2min 59s / no limit)
[     *] A start job is running for getty on…not available (3min 1s / no limit)
[    **] A start job is running for getty on…not available (3min 3s / no limit)
[   ***] A start job is running for getty on…not available (3min 4s / no limit)
[  OK  ] Started Getty on tty6.
[  OK  ] Started Getty on tty5.
[  OK  ] Started Getty on tty4.
[  OK  ] Started Getty on tty3.
[  OK  ] Started Getty on tty1.
[  OK  ] Started Serial Getty on ttyAMA0.
[  OK  ] Started Getty on tty2.
[  815.959454] kobject: 'vcs6' (0000000068ff6a1e): kobject_release, parent           (null) (delayed 1000)
[  816.014972] kobject: 'vcsu6' (000000000c2de692): kobject_release, parent           (null) (delayed 250)
[  816.068239] kobject: 'vcsa6' (0000000083141253): kobject_release, parent           (null) (delayed 500)
[  OK  ] Started getty on tty2-tty6 if dbus and logind are not available.
[  817.134722] kobject: 'vcs5' (0000000037ee4e7b): kobject_release, parent           (null) (delayed 750)
[  817.189730] kobject: 'vcsu5' (0000000073c46353): kobject_release, parent           (null) (delayed 750)
[  817.242016] kobject: 'vcsa5' (000000006a9b0fbb): kobject_release, parent           (null) (delayed 1000)
[  819.343101] kobject: 'vcs4' (000000006c1fbc17): kobject_release, parent           (null) (delayed 250)
[  819.399023] kobject: 'vcsu4' (00000000cb68df08): kobject_release, parent           (null) (delayed 500)
[  819.451960] kobject: 'vcsa4' (00000000800671e6): kobject_release, parent           (null) (delayed 500)
[  820.671312] kobject: 'vcs2' (00000000b89f38e3): kobject_release, parent           (null) (delayed 1000)
[  820.756117] kobject: 'vcsu2' (00000000d73b1545): kobject_release, parent           (null) (delayed 750)
[  820.829443] kobject: 'vcsa2' (00000000cb362b62): kobject_release, parent           (null) (delayed 750)
[  820.967751] kobject: 'vcs3' (00000000244224de): kobject_release, parent           (null) (delayed 500)
[  821.067527] kobject: 'vcsu3' (00000000068e489c): kobject_release, parent           (null) (delayed 1000)
[  821.155733] kobject: 'vcsa3' (0000000064454cd8): kobject_release, parent           (null) (delayed 1000)


Debian GNU/Linux 9 compilator ttyAMA0

compilator login: