[ 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)) #20 SMP Thu Nov 29 11:46:23 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: 992844K/2097152K available (16224K kernel code, 3774K rwdata, 4852K rodata, 6144K init, 23374K bss, 94724K 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 41939 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.000233] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns [ 0.015287] Console: colour dummy device 80x25 [ 0.019526] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.019972] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.020359] ... MAX_LOCK_DEPTH: 48 [ 0.020778] ... MAX_LOCKDEP_KEYS: 8191 [ 0.021191] ... CLASSHASH_SIZE: 4096 [ 0.021616] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.022020] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.022684] ... CHAINHASH_SIZE: 32768 [ 0.023054] memory used by lock dependency info: 7775 kB [ 0.023467] per task-struct memory footprint: 2688 bytes [ 0.023958] ------------------------ [ 0.024345] | Locking API testsuite: [ 0.024765] ---------------------------------------------------------------------------- [ 0.025259] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.025723] -------------------------------------------------------------------------- [ 0.026830] A-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.037947] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.048738] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.060361] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.071711] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.083875] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.095775] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.107884] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.117981] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.127883] -------------------------------------------------------------------------- [ 0.128398] recursive read-lock: | ok | | ok | [ 0.131903] recursive read-lock #2: | ok | | ok | [ 0.135224] mixed read-write-lock: | ok | | ok | [ 0.138763] mixed write-read-lock: | ok | | ok | [ 0.142369] mixed read-lock/lock-write ABBA: |FAILED| | ok | [ 0.145630] mixed read-lock/lock-read ABBA: | ok | | ok | [ 0.149060] mixed write-lock/lock-write ABBA: | ok | | ok | [ 0.153419] -------------------------------------------------------------------------- [ 0.154590] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.159560] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.164722] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.169655] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.174624] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.179578] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.184526] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.189508] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.194478] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.199381] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.204544] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.209798] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.215454] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.220569] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.225639] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.230730] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.235875] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.241034] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.246139] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.251154] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.256133] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.261199] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.266301] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.271504] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.276703] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.281850] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.286986] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.292306] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.297510] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.302815] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.308028] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.313245] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.318517] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.323649] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.328794] hard-irq lock-inversion/123: ok | ok | ok | [ 0.333959] soft-irq lock-inversion/123: ok | ok | ok | [ 0.339261] hard-irq lock-inversion/132: ok | ok | ok | [ 0.344392] soft-irq lock-inversion/132: ok | ok | ok | [ 0.349552] hard-irq lock-inversion/213: ok | ok | ok | [ 0.354765] soft-irq lock-inversion/213: ok | ok | ok | [ 0.360021] hard-irq lock-inversion/231: ok | ok | ok | [ 0.365180] soft-irq lock-inversion/231: ok | ok | ok | [ 0.370332] hard-irq lock-inversion/312: ok | ok | ok | [ 0.375491] soft-irq lock-inversion/312: ok | ok | ok | [ 0.380744] hard-irq lock-inversion/321: ok | ok | ok | [ 0.385911] soft-irq lock-inversion/321: ok | ok | ok | [ 0.391257] hard-irq read-recursion/123: ok | [ 0.393262] soft-irq read-recursion/123: ok | [ 0.395684] hard-irq read-recursion/132: ok | [ 0.397731] soft-irq read-recursion/132: ok | [ 0.400059] hard-irq read-recursion/213: ok | [ 0.402069] soft-irq read-recursion/213: ok | [ 0.404436] hard-irq read-recursion/231: ok | [ 0.406491] soft-irq read-recursion/231: ok | [ 0.408798] hard-irq read-recursion/312: ok | [ 0.410811] soft-irq read-recursion/312: ok | [ 0.413164] hard-irq read-recursion/321: ok | [ 0.415228] soft-irq read-recursion/321: ok | [ 0.417583] -------------------------------------------------------------------------- [ 0.418023] | Wound/wait tests | [ 0.418386] --------------------- [ 0.418764] ww api failures: ok | ok | ok | [ 0.425349] ww contexts mixing: ok | ok | [ 0.428889] finishing ww context: ok | ok | ok | ok | [ 0.435434] locking mismatches: ok | ok | ok | [ 0.440299] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 0.456997] spinlock nest unlocked: ok | [ 0.458941] ----------------------------------------------------- [ 0.459371] |block | try |context| [ 0.459818] ----------------------------------------------------- [ 0.460216] context: ok | ok | ok | [ 0.465565] try: ok | ok | ok | [ 0.470301] block: ok | ok | ok | [ 0.475231] spinlock: ok | ok | ok | [ 0.480465] ------------------------------------------------------- [ 0.480875] Good, all 261 testcases passed! | [ 0.481265] --------------------------------- [ 0.541562] ODEBUG: selftest passed [ 0.545962] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000) [ 0.546736] pid_max: default: 32768 minimum: 301 [ 0.557144] LSM: Security Framework initializing [ 0.557933] Yama: becoming mindful. [ 0.560186] LoadPin: ready to pin (currently enforcing) [ 0.561367] SELinux: Initializing. [ 0.568567] *** VALIDATE SELinux *** [ 0.569450] AppArmor: AppArmor disabled by boot time parameter [ 0.601258] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.613446] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.616056] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.617561] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.652720] *** VALIDATE proc *** [ 0.671346] *** VALIDATE cgroup1 *** [ 0.671881] *** VALIDATE cgroup2 *** [ 0.738377] ASID allocator initialised with 32768 entries [ 0.748580] rcu: Hierarchical SRCU implementation. [ 0.827594] EFI services will not be available. [ 0.854589] smp: Bringing up secondary CPUs ... [ 0.855247] smp: Brought up 1 node, 1 CPU [ 0.855695] SMP: Total of 1 processors activated. [ 0.856176] CPU features: detected: 32-bit EL0 Support [ 0.856662] CPU features: detected: CRC32 instructions [ 1.117066] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching [ 1.118382] CPU: All CPU(s) started at EL1 [ 1.119255] alternatives: patching kernel code [ 5.011480] node 0 initialised, 248300 pages in 4ms [ 5.019428] pgdatinit0 (15) used greatest stack depth: 13280 bytes left [ 5.034799] _warn_unseeded_randomness: 100 callbacks suppressed [ 5.035238] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 5.036374] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 5.044763] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=0 [ 5.097679] devtmpfs: initialized [ 5.287423] gcov: version magic: 0x4137332a [ 5.308070] Registered cp15_barrier emulation handler [ 5.308743] Registered setend emulation handler [ 5.904316] workqueue: round-robin CPU selection forced, expect performance impact [ 10.659890] DMA-API: preallocated 65536 debug entries [ 10.660577] DMA-API: debugging enabled by kernel config [ 10.662601] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 10.666010] futex hash table entries: 256 (order: 3, 32768 bytes) [ 10.671985] Running postponed tracer tests: [ 10.678037] Testing tracer function: [ 10.711733] ftrace_replace_code: 1 [ 18.987027] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 19.242684] ftrace_replace_code: 1 [ 26.268591] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 26.273122] PASSED [ 26.273669] Testing dynamic ftrace: [ 28.016660] ftrace_replace_code: 1 [ 28.032058] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 28.275162] PASSED [ 28.275902] Testing dynamic ftrace ops #1: [ 35.220705] ftrace_replace_code: 1 [ 35.237212] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 35.242483] (1 0 1 0 0) [ 35.242662] (1 1 2 0 0) [ 35.256712] ftrace_replace_code: 1 [ 46.161626] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 46.166277] (2 1 3 0 944681) [ 46.166548] (2 2 4 0 944702) [ 46.180435] ftrace_replace_code: 1 [ 54.221546] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 54.237018] ftrace_replace_code: 1 [ 54.250313] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 54.255794] ftrace_replace_code: 1 [ 54.269040] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 54.273537] PASSED [ 54.274028] Testing dynamic ftrace ops #2: [ 61.217058] ftrace_replace_code: 1 [ 61.234031] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 61.238816] ftrace_replace_code: 1 [ 61.254953] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 61.276582] ftrace_replace_code: 1 [ 71.380267] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 71.384431] (1 0 1 918390 0) [ 71.384656] (1 1 2 918411 0) [ 71.401590] (2 1 3 1 753) [ 71.404196] (2 2 4 385 1137) [ 71.443228] ftrace_replace_code: 1 [ 78.589521] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 78.591844] PASSED [ 78.592200] Testing ftrace recursion: [ 80.329545] ftrace_replace_code: 1 [ 80.344155] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 80.348439] ftrace_replace_code: 1 [ 80.361710] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 80.363707] PASSED [ 80.364039] Testing ftrace recursion safe: [ 82.099035] ftrace_replace_code: 1 [ 82.113156] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 82.117392] ftrace_replace_code: 1 [ 82.130657] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 82.132227] PASSED [ 82.132609] Testing ftrace regs(no arch support): [ 83.867906] ftrace_replace_code: 1 [ 83.882617] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 83.886991] ftrace_replace_code: 1 [ 83.901191] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 83.902967] PASSED [ 83.903579] Testing tracer nop: PASSED [ 83.905718] Testing tracer irqsoff: [ 83.922772] ftrace_replace_code: 1 [ 91.970276] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 92.001551] ftrace_replace_code: 1 [ 99.057102] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 99.059216] PASSED [ 99.061509] Testing tracer wakeup: [ 99.091189] ftrace_replace_code: 1 [ 107.101223] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 107.134296] ftrace_replace_code: 1 [ 114.246968] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 114.255366] PASSED [ 114.256884] Testing tracer wakeup_rt: [ 114.284099] ftrace_replace_code: 1 [ 122.318820] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 122.354457] ftrace_replace_code: 1 [ 129.390751] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 129.398468] PASSED [ 129.399237] Testing tracer wakeup_dl: [ 129.425698] ftrace_replace_code: 1 [ 137.441097] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 137.478604] ftrace_replace_code: 1 [ 144.641605] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 144.649199] PASSED [ 144.650711] Testing tracer function_graph: [ 144.650841] ../kernel/trace/trace_selftest.c:766 [ 144.653354] ../kernel/trace/trace_selftest.c:768 [ 144.653794] ../kernel/trace/trace_selftest.c:770 [ 144.678199] ftrace_replace_code: 1 [ 152.506384] ../kernel/trace/ftrace.c:2442, loop_counter: 41939 [ 152.512240] ../kernel/trace/trace_selftest.c:773 [ 152.877135] ../kernel/trace/trace_selftest.c:778 [ 153.005689] BUG: Function graph tracer hang! [ 153.009299] ../kernel/trace/trace_selftest.c:780 [ 153.139127] FAILED! [ 153.142165] WARNING: CPU: 0 PID: 1 at ../kernel/trace/trace.c:1513 run_tracer_selftest+0x264/0x384 [ 153.143473] Modules linked in: [ 153.145188] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc4-next-20181128-00009-g44c557177b8d-dirty #20 [ 153.146620] Hardware name: linux,dummy-virt (DT) [ 153.147839] pstate: 40400005 (nZcv daif +PAN -UAO) [ 153.149028] pc : run_tracer_selftest+0x264/0x384 [ 153.150205] lr : run_tracer_selftest+0x258/0x384 [ 153.150846] sp : ffffff800800bbc0 [ 153.151451] x29: ffffff800800bbc0 x28: ffffff8009371278 [ 153.152278] x27: ffffff800ac5b910 x26: ffffff8009cb82b0 [ 153.153098] x25: ffffff8009cb8000 x24: ffffff8009c16a80 [ 153.153965] x23: ffffff8009f63420 x22: 00000000ffffffff [ 153.154778] x21: ffffff8009cb8000 x20: ffffff800ac57518 [ 153.155576] x19: ffffff800ac56000 x18: 0000000034f4d91d [ 153.156370] x17: 0000000000000000 x16: 0000000000000000 [ 153.157165] x15: ffffff8009c6a580 x14: ffffff8009c69000 [ 153.157965] x13: ffffff8009c69fe0 x12: ffffff8009c15ea8 [ 153.158774] x11: ffffff800800bbc0 x10: ffffff800800bbc0 [ 153.159599] x9 : ffffff8009c16000 x8 : ffffff800abb7d27 [ 153.160400] x7 : ffffff8008198f40 x6 : 0000000000000001 [ 153.161195] x5 : ffffffc03f558040 x4 : ffffff800804f2bc [ 153.161989] x3 : 00000000000066dd x2 : 82ddc961efb98d00 [ 153.162794] x1 : 0000000000000000 x0 : 0000000000000001 [ 153.163655] Call trace: [ 153.164341] run_tracer_selftest+0x264/0x384 [ 153.165094] register_tracer+0x488/0x6a8 [ 153.165798] init_graph_trace+0x148/0x170 [ 153.166515] do_one_initcall+0x324/0x6e8 [ 153.167238] do_initcall_level+0x898/0x970 [ 153.167934] do_initcalls+0x64/0xa8 [ 153.168611] do_basic_setup+0x44/0x70 [ 153.169303] kernel_init_freeable+0x178/0x2bc [ 153.169998] kernel_init+0x28/0x140 [ 153.170712] ret_from_fork+0x10/0x18 [ 153.171379] irq event stamp: 1772168 [ 153.172215] hardirqs last enabled at (1772167): [] console_unlock+0x3c0/0x400 [ 153.173148] hardirqs last disabled at (1772168): [] do_debug_exception+0x58/0x178 [ 153.174086] softirqs last enabled at (1771640): [] __do_softirq+0x9a8/0x9f0 [ 153.175023] softirqs last disabled at (1771543): [] irq_exit+0x128/0x1b8 [ 153.175942] _warn_unseeded_randomness: 5 callbacks suppressed [ 153.176231] random: get_random_bytes called from init_oops_id+0x38/0x60 with crng_init=0 [ 153.177623] ---[ end trace f5cc273d861a972c ]--- [ 153.352829] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 153.354198] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 153.388203] prandom: seed boundary self test passed [ 153.427920] prandom: 100 self tests passed [ 153.438618] pinctrl core: initialized pinctrl subsystem [ 153.616130] regulator-dummy: Failed to create debugfs directory [ 153.629849] [ 153.630437] ************************************************************* [ 153.631190] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 153.631917] ** ** [ 153.632643] ** IOMMU DebugFS SUPPORT HAS BEEN ENABLED IN THIS KERNEL ** [ 153.634181] ** ** [ 153.634903] ** This means that this kernel is built to expose internal ** [ 153.635627] ** IOMMU data structures, which may compromise security on ** [ 153.636350] ** your system. ** [ 153.637049] ** ** [ 153.637751] ** If you see this message and you are not debugging the ** [ 153.639260] ** kernel, report this immediately to your vendor! ** [ 153.639971] ** ** [ 153.640676] ** NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE NOTICE ** [ 153.641380] ************************************************************* [ 153.690803] DMI not present or invalid. [ 153.778088] NET: Registered protocol family 16 [ 153.830372] audit: initializing netlink subsys (disabled) [ 154.078437] cpuidle: using governor ladder [ 154.081381] cpuidle: using governor menu [ 154.118229] vdso: 2 pages (1 code @ (____ptrval____), 1 data @ (____ptrval____)) [ 154.120900] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 154.126270] audit: type=2000 audit(132.088:1): state=initialized audit_enabled=0 res=1 [ 154.368565] DMA: preallocated 256 KiB pool for atomic allocations [ 154.372281] _warn_unseeded_randomness: 32 callbacks suppressed [ 154.372621] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 154.374572] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 154.381471] random: get_random_bytes called from kcmp_cookies_init+0x60/0x238 with crng_init=0 [ 154.525987] Serial: AMBA PL011 UART driver [ 155.792407] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 39, base_baud = 0) is a PL011 rev1 [ 155.796653] printk: console [ttyAMA0] enabled [ 155.796653] printk: console [ttyAMA0] enabled [ 155.798592] printk: bootconsole [pl11] disabled [ 155.798592] printk: bootconsole [pl11] disabled [ 155.987704] _warn_unseeded_randomness: 8 callbacks suppressed [ 155.988019] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 155.992458] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 156.874763] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 156.977513] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 157.217911] _warn_unseeded_randomness: 29 callbacks suppressed [ 157.218232] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 157.222048] kobject: 'renesas,r9a06g032-sysctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 157.239141] kobject: 'renesas-cpg-mssr' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 157.249819] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0 [ 157.304297] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=0 [ 157.330104] arm-v7s io-pgtable: self test ok [ 157.333339] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 32 [ 157.350630] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 36 [ 157.363726] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 40 [ 157.379173] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 42 [ 157.394716] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 44 [ 157.409343] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x40201000, IAS 48 [ 157.424296] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 32 [ 157.457443] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 36 [ 157.492912] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 40 [ 157.527788] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 42 [ 157.563365] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 44 [ 157.598213] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x02004000, IAS 48 [ 157.635896] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 32 [ 157.750006] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 36 [ 157.864177] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 40 [ 157.979712] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 42 [ 158.099495] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 44 [ 158.220112] arm-lpae io-pgtable: selftest: pgsize_bitmap 0x20010000, IAS 48 [ 158.341442] arm-lpae io-pgtable: selftest: completed with 18 PASS 0 FAIL [ 158.394903] vgaarb: loaded [ 158.423783] _warn_unseeded_randomness: 2 callbacks suppressed [ 158.426351] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 158.428474] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 158.476393] pps_core: LinuxPPS API ver. 1 registered [ 158.478546] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti [ 158.485377] PTP clock support registered [ 158.498523] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 158.500287] kobject: 'brcmstb-reboot' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 158.770961] NetLabel: Initializing [ 158.772040] NetLabel: domain hash size = 128 [ 158.773984] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [ 158.788457] NetLabel: unlabeled traffic allowed by default [ 158.827982] clocksource: Switched to clocksource arch_sys_counter [ 167.252076] _warn_unseeded_randomness: 6 callbacks suppressed [ 167.252390] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 167.256728] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 167.262356] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 167.303956] VFS: Disk quotas dquot_6.6.0 [ 167.311917] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 167.356484] *** VALIDATE hugetlbfs *** [ 169.016119] _warn_unseeded_randomness: 7 callbacks suppressed [ 169.016432] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 169.021063] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 169.025440] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 169.037059] NET: Registered protocol family 2 [ 169.116449] tcp_listen_portaddr_hash hash table entries: 1024 (order: 4, 90112 bytes) [ 169.128565] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 169.188367] TCP bind hash table entries: 16384 (order: 8, 1310720 bytes) [ 169.234110] TCP: Hash tables configured (established 16384 bind 16384) [ 169.254103] UDP hash table entries: 1024 (order: 5, 196608 bytes) [ 169.271718] UDP-Lite hash table entries: 1024 (order: 5, 196608 bytes) [ 169.310221] NET: Registered protocol family 1 [ 169.318327] NET: Registered protocol family 44 [ 169.457606] hw perfevents: enabled with armv8_pmuv3 PMU driver, 1 counters available [ 169.476146] kvm [1]: HYP mode not available [ 170.012163] Kprobe smoke test: started [ 171.500202] Kprobe smoke test: passed successfully [ 171.625079] Initialise system trusted keyrings [ 171.628820] _warn_unseeded_randomness: 50 callbacks suppressed [ 171.629116] random: get_random_bytes called from key_alloc+0x380/0x698 with crng_init=0 [ 171.645774] Key type blacklist registered [ 171.657288] random: get_random_u64 called from dup_task_struct+0xdc/0x3d0 with crng_init=0 [ 171.681159] workingset: timestamp_bits=44 max_order=19 bucket_order=0 [ 175.915833] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 175.918250] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 175.968891] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 176.408310] 9p: Installing v9fs 9p2000 file system support [ 176.640888] Allocating IMA blacklist keyring. [ 176.676600] cryptomgr_test (37) used greatest stack depth: 11920 bytes left [ 176.721808] kworker/u2:0 (38) used greatest stack depth: 11456 bytes left [ 178.837513] Key type asymmetric registered [ 178.841327] Asymmetric key parser 'x509' registered [ 178.853348] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 245) [ 178.879460] _warn_unseeded_randomness: 26 callbacks suppressed [ 178.879784] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 178.884300] random: get_random_u64 called from cache_random_seq_create+0x64/0x110 with crng_init=0 [ 178.950346] random: get_random_u64 called from kmem_cache_open+0x38/0x1d8 with crng_init=0 [ 179.270095] kobject: 'brcm-gisb-arb' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 250) [ 179.437639] kobject: 'armada-37xx-pinctrl' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 750) [ 179.761559] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 179.773649] pl061_gpio 9030000.pl061: Unbalanced pm_runtime_enable! [ 179.820699] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 179.864758] kobject: 'stmpe-pwm' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 1000) [ 179.915726] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 [ 180.045054] pci-host-generic 3f000000.pcie: host bridge /pcie@10000000 ranges: [ 180.051820] pci-host-generic 3f000000.pcie: IO 0x3eff0000..0x3effffff -> 0x00000000 [ 180.056909] pci-host-generic 3f000000.pcie: MEM 0x10000000..0x3efeffff -> 0x10000000 [ 180.060854] pci-host-generic 3f000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000 [ 180.069419] pci-host-generic 3f000000.pcie: ECAM at [mem 0x3f000000-0x3fffffff] for [bus 00-0f] [ 180.103404] pci-host-generic 3f000000.pcie: PCI host bridge to bus 0000:00 [ 180.105604] pci_bus 0000:00: root bus resource [bus 00-0f] [ 180.108396] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 180.110209] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] [ 180.113238] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] [ 180.121261] pci 0000:00:00.0: calling quirk_mmio_always_on+0x0/0x38 @ 1 [ 180.124348] pci 0000:00:00.0: quirk_mmio_always_on+0x0/0x38 took 88 usecs [ 180.300756] pci 0000:00:01.0: BAR 6: assigned [mem 0x10000000-0x1003ffff pref] [ 180.304131] pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] [ 180.307785] pci 0000:00:02.0: BAR 4: assigned [mem 0x8000004000-0x8000007fff 64bit pref] [ 180.310359] pci 0000:00:03.0: BAR 4: assigned [mem 0x8000008000-0x800000bfff 64bit pref] [ 180.313733] pci 0000:00:01.0: BAR 1: assigned [mem 0x10040000-0x10040fff] [ 180.316774] pci 0000:00:03.0: BAR 1: assigned [mem 0x10041000-0x10041fff] [ 180.319717] pci 0000:00:03.0: BAR 0: assigned [io 0x1000-0x103f] [ 180.321602] pci 0000:00:01.0: BAR 0: assigned [io 0x1040-0x105f] [ 180.324466] pci 0000:00:02.0: BAR 0: assigned [io 0x1060-0x107f] [ 180.329226] pci 0000:00:00.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 180.332407] pci 0000:00:00.0: tegra_pcie_relax_enable+0x0/0x40 took 163 usecs [ 180.337308] pci 0000:00:01.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 180.340429] pci 0000:00:01.0: tegra_pcie_relax_enable+0x0/0x40 took 52 usecs [ 180.344166] pci 0000:00:02.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 180.346255] pci 0000:00:02.0: tegra_pcie_relax_enable+0x0/0x40 took 54 usecs [ 180.349976] pci 0000:00:03.0: calling tegra_pcie_relax_enable+0x0/0x40 @ 1 [ 180.352986] pci 0000:00:03.0: tegra_pcie_relax_enable+0x0/0x40 took 52 usecs [ 180.436542] _warn_unseeded_randomness: 15 callbacks suppressed [ 180.436853] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 180.441030] kobject: 'layerscape-pcie' ((____ptrval____)): kobject_release, parent (____ptrval____) (delayed 500) [ 180.489041] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0 [ 181.325943] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) [ 181.386422] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 181.389519] kobject: 'virtio0' ((____ptrval____)): kobject_release, parent (null) (delayed 250) [ 181.448706] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) [ 181.493259] _warn_unseeded_randomness: 1 callbacks suppressed [ 181.493599] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 181.497890] kobject: 'virtio1' ((____ptrval____)): kobject_release, parent (null) (delayed 750) [ 181.504582] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0 [ 181.563706] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) [ 181.608097] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 181.609993] kobject: 'virtio2' ((____ptrval____)): kobject_release, parent (null) (delayed 1000) [ 192.028078] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 192.289541] _warn_unseeded_randomness: 1 callbacks suppressed [ 192.289874] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 192.294338] kobject: 'ttyS0' ((____ptrval____)): kobject_release, parent (null) (delayed 500) [ 192.298278] random: get_random_u32 called from shuffle_freelist+0x64/0x218 with crng_init=0 [ 192.303601] random: get_random_u32 called from kobject_release+0x24/0xf8 with crng_init=0 [ 192.305502] kobject: '(null)' ((____ptrval____)): kobject_release, parent (null) (delayed 750)