[    0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034]
[    0.000000] Linux version 4.20.0-rc5-next-20181205-00014-g23f8559743db (anders@compilator) (gcc version 8.2.0 (Debian 8.2.0-9)) #13 SMP Thu Dec 6 09:47:13 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 0xbebf3600-0xbebf4fff]
[    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+0xa4/0x4a4 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: 992864K/2097152K available (16796K kernel code, 3186K rwdata, 7312K rodata, 4096K init, 23372K bss, 94688K reserved, 16384K cma-reserved)
[    0.000000] random: get_random_u64 called from kmem_cache_open+0x38/0x1d0 with crng_init=0
[    0.000000] random: get_random_u64 called from cache_random_seq_create+0x60/0x110 with crng_init=0
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] ODEBUG: selftest passed
[    0.000000] ftrace: allocating 42046 entries in 165 pages
[    0.000000] Running RCU self tests
[    0.000000] rcu: Hierarchical RCU implementation.
[    0.000000] rcu: 	RCU event tracing is enabled.
[    0.000000] rcu: 	RCU dyntick-idle grace-period acceleration is enabled.
[    0.000000] rcu: 	RCU lockdep checking is enabled.
[    0.000000] rcu: 	RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1.
[    0.000000] rcu: 	RCU callback double-/use-after-free debug enabled.
[    0.000000] rcu: 	RCU debug extended QS entry/exit.
[    0.000000] 	Tasks RCU enabled.
[    0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.
[    0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[    0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0
[    0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143]
[    0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt).
[    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns
[    0.000297] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns
[    0.020072] Console: colour dummy device 80x25
[    0.028027] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[    0.029681] ... MAX_LOCKDEP_SUBCLASSES:  8
[    0.030461] ... MAX_LOCK_DEPTH:          48
[    0.031237] ... MAX_LOCKDEP_KEYS:        8191
[    0.032012] ... CLASSHASH_SIZE:          4096
[    0.032777] ... MAX_LOCKDEP_ENTRIES:     32768
[    0.034031] ... MAX_LOCKDEP_CHAINS:      65536
[    0.034821] ... CHAINHASH_SIZE:          32768
[    0.035606]  memory used by lock dependency info: 7775 kB
[    0.036449]  per task-struct memory footprint: 2688 bytes
[    0.037296] ------------------------
[    0.038471] | Locking API testsuite:
[    0.039214] ----------------------------------------------------------------------------
[    0.040231]                                  | spin |wlock |rlock |mutex | wsem | rsem |
[    0.041229]   --------------------------------------------------------------------------
[    0.043041]                      A-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.057078]                  A-B-B-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.072434]              A-B-B-C-C-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.090183]              A-B-C-A-B-C deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.107218]          A-B-B-C-C-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.126262]          A-B-C-D-B-D-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.145341]          A-B-C-D-B-C-D-A deadlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.164329]                     double unlock:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.177378]                   initialize held:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.189935]   --------------------------------------------------------------------------
[    0.190948]               recursive read-lock:             |  ok  |             |  ok  |
[    0.195867]            recursive read-lock #2:             |  ok  |             |  ok  |
[    0.200663]             mixed read-write-lock:             |  ok  |             |  ok  |
[    0.205669]             mixed write-read-lock:             |  ok  |             |  ok  |
[    0.210667]   mixed read-lock/lock-write ABBA:             |FAILED|             |  ok  |
[    0.215121]    mixed read-lock/lock-read ABBA:             |  ok  |             |  ok  |
[    0.220454]  mixed write-lock/lock-write ABBA:             |  ok  |             |  ok  |
[    0.225782]   --------------------------------------------------------------------------
[    0.227596]      hard-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.234390]      soft-irqs-on + irq-safe-A/12:  ok  |  ok  |  ok  |
[    0.240943]      hard-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.247890]      soft-irqs-on + irq-safe-A/21:  ok  |  ok  |  ok  |
[    0.254458]        sirq-safe-A => hirqs-on/12:  ok  |  ok  |  ok  |
[    0.261608]        sirq-safe-A => hirqs-on/21:  ok  |  ok  |  ok  |
[    0.268319]          hard-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.275332]          soft-safe-A + irqs-on/12:  ok  |  ok  |  ok  |
[    0.281930]          hard-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.288954]          soft-safe-A + irqs-on/21:  ok  |  ok  |  ok  |
[    0.295662]     hard-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.303295]     soft-safe-A + unsafe-B #1/123:  ok  |  ok  |  ok  |
[    0.310523]     hard-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.318009]     soft-safe-A + unsafe-B #1/132:  ok  |  ok  |  ok  |
[    0.325115]     hard-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.332672]     soft-safe-A + unsafe-B #1/213:  ok  |  ok  |  ok  |
[    0.339938]     hard-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.347253]     soft-safe-A + unsafe-B #1/231:  ok  |  ok  |  ok  |
[    0.354192]     hard-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.361199]     soft-safe-A + unsafe-B #1/312:  ok  |  ok  |  ok  |
[    0.367818]     hard-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.375085]     soft-safe-A + unsafe-B #1/321:  ok  |  ok  |  ok  |
[    0.381899]     hard-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.389201]     soft-safe-A + unsafe-B #2/123:  ok  |  ok  |  ok  |
[    0.396336]     hard-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.403648]     soft-safe-A + unsafe-B #2/132:  ok  |  ok  |  ok  |
[    0.410794]     hard-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.418135]     soft-safe-A + unsafe-B #2/213:  ok  |  ok  |  ok  |
[    0.425344]     hard-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.432794]     soft-safe-A + unsafe-B #2/231:  ok  |  ok  |  ok  |
[    0.439948]     hard-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.447377]     soft-safe-A + unsafe-B #2/312:  ok  |  ok  |  ok  |
[    0.454480]     hard-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.461810]     soft-safe-A + unsafe-B #2/321:  ok  |  ok  |  ok  |
[    0.468834]       hard-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.476262]       soft-irq lock-inversion/123:  ok  |  ok  |  ok  |
[    0.483502]       hard-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.490877]       soft-irq lock-inversion/132:  ok  |  ok  |  ok  |
[    0.498017]       hard-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.505430]       soft-irq lock-inversion/213:  ok  |  ok  |  ok  |
[    0.512599]       hard-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.519860]       soft-irq lock-inversion/231:  ok  |  ok  |  ok  |
[    0.526948]       hard-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.534290]       soft-irq lock-inversion/312:  ok  |  ok  |  ok  |
[    0.541395]       hard-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.548703]       soft-irq lock-inversion/321:  ok  |  ok  |  ok  |
[    0.555785]       hard-irq read-recursion/123:  ok  |
[    0.559132]       soft-irq read-recursion/123:  ok  |
[    0.562593]       hard-irq read-recursion/132:  ok  |
[    0.565429]       soft-irq read-recursion/132:  ok  |
[    0.568872]       hard-irq read-recursion/213:  ok  |
[    0.571679]       soft-irq read-recursion/213:  ok  |
[    0.575089]       hard-irq read-recursion/231:  ok  |
[    0.578392]       soft-irq read-recursion/231:  ok  |
[    0.581822]       hard-irq read-recursion/312:  ok  |
[    0.584710]       soft-irq read-recursion/312:  ok  |
[    0.588160]       hard-irq read-recursion/321:  ok  |
[    0.590967]       soft-irq read-recursion/321:  ok  |
[    0.594363]   --------------------------------------------------------------------------
[    0.595909]   | Wound/wait tests |
[    0.596619]   ---------------------
[    0.597331]                   ww api failures:  ok  |  ok  |  ok  |
[    0.606417]                ww contexts mixing:  ok  |  ok  |
[    0.611168]              finishing ww context:  ok  |  ok  |  ok  |  ok  |
[    0.619941]                locking mismatches:  ok  |  ok  |  ok  |
[    0.626469]                  EDEADLK handling:  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |  ok  |
[    0.649481]            spinlock nest unlocked:  ok  |
[    0.652520]   -----------------------------------------------------
[    0.653398]                                  |block | try  |context|
[    0.654296]   -----------------------------------------------------
[    0.655167]                           context:  ok  |  ok  |  ok  |
[    0.662908]                               try:  ok  |  ok  |  ok  |
[    0.669792]                             block:  ok  |  ok  |  ok  |
[    0.676006]                          spinlock:  ok  |  ok  |  ok  |
[    0.683829] -------------------------------------------------------
[    0.684762] Good, all 261 testcases passed! |
[    0.685527] ---------------------------------
[    0.693394] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000)
[    0.694954] pid_max: default: 32768 minimum: 301
[    0.714760] LSM: Security Framework initializing
[    0.715965] Yama: becoming mindful.
[    0.720084] LoadPin: ready to pin (currently enforcing)
[    0.721542] SELinux:  Initializing.
[    0.736763] *** VALIDATE SELinux ***
[    0.737979] AppArmor: AppArmor disabled by boot time parameter
[    0.806406] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[    0.833332] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[    0.839000] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes)
[    0.841753] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes)
[    0.905975] *** VALIDATE proc ***
[    0.940396] *** VALIDATE cgroup1 ***
[    0.941276] *** VALIDATE cgroup2 ***
[    1.047325] ASID allocator initialised with 32768 entries
[    1.065750] rcu: Hierarchical SRCU implementation.
[    1.211885] EFI services will not be available.
[    1.257088] smp: Bringing up secondary CPUs ...
[    1.258049] smp: Brought up 1 node, 1 CPU
[    1.259460] SMP: Total of 1 processors activated.
[    1.260423] CPU features: detected: 32-bit EL0 Support
[    1.261405] CPU features: detected: CRC32 instructions
[    1.662202] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching
[    1.664245] CPU: All CPU(s) started at EL1
[    1.665729] alternatives: patching kernel code
[    1.668273] _warn_unseeded_randomness: 98 callbacks suppressed
[    1.668783] random: get_random_u64 called from compute_layout+0x180/0x208 with crng_init=0
[    1.739048] random: get_random_u64 called from dup_task_struct+0x108/0x380 with crng_init=0
[    6.007972] node 0 initialised, 248304 pages in 4ms
[    6.020685] pgdatinit0 (15) used greatest stack depth: 13392 bytes left
[    6.038176] random: get_random_u64 called from kmem_cache_open+0x38/0x1d0 with crng_init=0
[    6.167055] devtmpfs: initialized
[    6.345968] workqueue: round-robin CPU selection forced, expect performance impact
[    6.567673] gcov: version magic: 0x4138322a
[    6.607227] Registered cp15_barrier emulation handler
[    6.609128] Registered setend emulation handler
[   19.254165] DMA-API: preallocated 65536 debug entries
[   19.255165] DMA-API: debugging enabled by kernel config
[   19.258036] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[   19.262807] futex hash table entries: 256 (order: 3, 32768 bytes)
[   19.272530] Running postponed tracer tests:
[   19.277150] Testing tracer function: PASSED
[   47.080572] Testing dynamic ftrace: PASSED
[   50.658032] Testing dynamic ftrace ops #1: 
[   63.680595] (1 0 1 0 0) 
[   63.681608] (1 1 2 0 0) 
[  102.902910] (2 1 3 0 11871129) 
[  102.912481] (2 2 4 0 11874491) PASSED
[  118.263736] Testing dynamic ftrace ops #2: 
[  165.859820] (1 0 1 10929838 0) 
[  165.869161] (1 1 2 10933316 0) 
[  165.892395] (2 1 3 1 2738) 
[  165.899589] (2 2 4 2493 5230) PASSED
[  177.269133] Testing ftrace recursion: PASSED
[  180.701076] Testing ftrace recursion safe: PASSED
[  184.131038] Testing ftrace regs(no arch support): PASSED
[  187.559959] Testing tracer nop: PASSED
[  187.562937] Testing tracer irqsoff: PASSED
[  216.610946] Testing tracer wakeup: 
[  233.650011] sched: DL replenish lagged too much
[  244.856401] PASSED
[  244.858839] Testing tracer wakeup_rt: PASSED
[  273.121395] Testing tracer wakeup_dl: PASSED