[ 0.000000] Booting Linux on physical CPU 0x0000000000 [0x410fd034] [ 0.000000] Linux version 4.20.0-rc5-next-20181204-00011-g04c35bf41f8a-dirty (anders@compilator) (gcc version 7.3.1 20180425 [linaro-7.3-2018.05 revision d29120a424ecfbc167ef90065c0eeb7f91977701] (Linaro GCC 7.3-2018.05)) #71 SMP Tue Dec 4 09:07: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 0xbebf6600-0xbebf7fff] [ 0.000000] Zone ranges: [ 0.000000] DMA32 [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv0.2 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] random: get_random_bytes called from start_kernel+0xe4/0x7d8 with crng_init=0 [ 0.000000] percpu: Embedded 490 pages/cpu @(____ptrval____) s1969240 r8192 d29608 u2007040 [ 0.000000] Detected VIPT I-cache on CPU0 [ 0.000000] CPU features: enabling workaround for ARM erratum 843419 [ 0.000000] CPU features: enabling workaround for ARM erratum 845719 [ 0.000000] CPU features: detected: Kernel page table isolation (KPTI) [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 516096 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: root=/dev/root rootfstype=9p rootflags=trans=virtio console=ttyAMA0,38400n8 earlycon=pl011,0x9000000 initcall_debug [ 0.000000] Memory: 970992K/2097152K available (24888K kernel code, 16866K rwdata, 4884K rodata, 6144K init, 23472K bss, 116536K reserved, 16384K cma-reserved) [ 0.000000] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 0.000000] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] ODEBUG: selftest passed [ 0.000000] ftrace: allocating 42037 entries in 165 pages [ 0.000000] Running RCU self tests [ 0.000000] rcu: Hierarchical RCU implementation. [ 0.000000] rcu: RCU event tracing is enabled. [ 0.000000] rcu: RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] rcu: RCU lockdep checking is enabled. [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=1. [ 0.000000] rcu: RCU callback double-/use-after-free debug enabled. [ 0.000000] rcu: RCU debug extended QS entry/exit. [ 0.000000] Tasks RCU enabled. [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies. [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143] [ 0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns [ 0.000427] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns [ 0.045200] Console: colour dummy device 80x25 [ 0.063917] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.074715] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.081553] ... MAX_LOCK_DEPTH: 48 [ 0.088884] ... MAX_LOCKDEP_KEYS: 8191 [ 0.095962] ... CLASSHASH_SIZE: 4096 [ 0.103185] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.110723] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.117501] ... CHAINHASH_SIZE: 32768 [ 0.122858] memory used by lock dependency info: 7775 kB [ 0.128100] per task-struct memory footprint: 2688 bytes [ 0.133173] ------------------------ [ 0.138564] | Locking API testsuite: [ 0.143627] ---------------------------------------------------------------------------- [ 0.149660] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.156309] -------------------------------------------------------------------------- [ 0.162850] A-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.200876] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.237965] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.277282] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.319989] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.372501] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.423175] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | ok | [ 0.476249] double unlock: ok | ok | ok | ok | ok | ok | ok | [ 0.516713] initialize held: ok | ok | ok | ok | ok | ok | ok | [ 0.555593] -------------------------------------------------------------------------- [ 0.568552] recursive read-lock: | ok | | ok | [ 0.588893] recursive read-lock #2: | ok | | ok | [ 0.609971] mixed read-write-lock: | ok | | ok | [ 0.629654] mixed write-read-lock: | ok | | ok | [ 0.648447] mixed read-lock/lock-write ABBA: |FAILED| | ok | [ 0.658203] mixed read-lock/lock-read ABBA: | ok | | ok | [ 0.677169] mixed write-lock/lock-write ABBA: | ok | | ok | [ 0.697143] -------------------------------------------------------------------------- [ 0.724680] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.748162] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.771852] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.795007] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.817650] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.841007] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.864989] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.888227] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.911741] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.935260] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.959076] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.979939] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 1.004414] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 1.029616] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 1.057359] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 1.084215] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 1.111765] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 1.138063] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 1.165282] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 1.191255] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 1.215527] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 1.240335] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 1.267176] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 1.293806] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 1.321641] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 1.349512] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 1.376695] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 1.403433] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 1.427830] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 1.454866] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 1.483277] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 1.510469] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 1.537119] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 1.564110] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 1.591410] hard-irq lock-inversion/123: ok | ok | ok | [ 1.618429] soft-irq lock-inversion/123: ok | ok | ok | [ 1.645380] hard-irq lock-inversion/132: ok | ok | ok | [ 1.670551] soft-irq lock-inversion/132: ok | ok | ok | [ 1.702882] hard-irq lock-inversion/213: ok | ok | ok | [ 1.750693] soft-irq lock-inversion/213: ok | ok | ok | [ 1.792435] hard-irq lock-inversion/231: ok | ok | ok | [ 1.832119] soft-irq lock-inversion/231: ok | ok | ok | [ 1.874657] hard-irq lock-inversion/312: ok | ok | ok | [ 1.903842] soft-irq lock-inversion/312: ok | ok | ok | [ 1.958352] hard-irq lock-inversion/321: ok | ok | ok | [ 1.985948] soft-irq lock-inversion/321: ok | ok | ok | [ 2.013706] hard-irq read-recursion/123: ok | [ 2.029765] soft-irq read-recursion/123: ok | [ 2.046141] hard-irq read-recursion/132: ok | [ 2.061830] soft-irq read-recursion/132: ok | [ 2.078095] hard-irq read-recursion/213: ok | [ 2.094476] soft-irq read-recursion/213: ok | [ 2.110793] hard-irq read-recursion/231: ok | [ 2.127010] soft-irq read-recursion/231: ok | [ 2.143281] hard-irq read-recursion/312: ok | [ 2.160947] soft-irq read-recursion/312: ok | [ 2.201363] hard-irq read-recursion/321: ok | [ 2.207820] soft-irq read-recursion/321: ok | [ 2.224243] -------------------------------------------------------------------------- [ 2.226263] | Wound/wait tests | [ 2.228757] --------------------- [ 2.230207] ww api failures: ok | ok | ok | [ 2.286234] ww contexts mixing: ok | ok | [ 2.310565] finishing ww context: ok | ok | ok | ok | [ 2.354396] locking mismatches: ok | ok | ok | [ 2.385342] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok | [ 2.441310] spinlock nest unlocked: ok | [ 2.447669] ----------------------------------------------------- [ 2.451705] |block | try |context| [ 2.454494] ----------------------------------------------------- [ 2.463155] context: ok | ok | ok | [ 2.496944] try: ok | ok | ok | [ 2.542338] block: ok | ok | ok | [ 2.577486] spinlock: ok | ok | ok | [ 2.603696] ------------------------------------------------------- [ 2.605376] Good, all 261 testcases passed! | [ 2.607823] --------------------------------- [ 2.619588] _warn_unseeded_randomness: 15 callbacks suppressed [ 2.620756] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 2.642412] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 2.657873] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 2.677886] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000) [ 2.693388] pid_max: default: 32768 minimum: 301 [ 2.741984] LSM: Security Framework initializing [ 2.752516] Yama: becoming mindful. [ 2.768401] LoadPin: ready to pin (currently enforcing) [ 2.780616] SELinux: Initializing. [ 2.824595] *** VALIDATE SELinux *** [ 2.833603] AppArmor: AppArmor disabled by boot time parameter [ 3.044103] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 3.123539] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 3.159278] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 3.183190] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 3.468565] *** VALIDATE proc *** [ 3.557937] *** VALIDATE cgroup1 *** [ 3.566433] *** VALIDATE cgroup2 *** [ 3.893841] ASID allocator initialised with 32768 entries [ 3.946035] rcu: Hierarchical SRCU implementation. [ 4.405584] EFI services will not be available. [ 4.536890] smp: Bringing up secondary CPUs ... [ 4.546696] smp: Brought up 1 node, 1 CPU [ 4.548749] SMP: Total of 1 processors activated. [ 4.552189] CPU features: detected: 32-bit EL0 Support [ 4.554312] CPU features: detected: CRC32 instructions [ 5.966201] CPU features: emulated: Privileged Access Never (PAN) using TTBR0_EL1 switching [ 5.971744] CPU: All CPU(s) started at EL1 [ 5.976751] alternatives: patching kernel code [ 5.981890] _warn_unseeded_randomness: 80 callbacks suppressed [ 5.982396] random: get_random_u64 called from compute_layout+0x138/0x1b8 with crng_init=0 [ 6.304124] random: get_random_u64 called from dup_task_struct+0x164/0x7f0 with crng_init=0 [ 17.470399] node 0 initialised, 248310 pages in 4ms [ 17.550797] ================================================================================ [ 17.553353] UBSAN: Undefined behaviour in ../kernel/exit.c:735:2 [ 17.554888] member access within misaligned address ffffff800cf797d8 for type 'struct task_struct' [ 17.556773] which requires 64 byte alignment [ 17.558742] CPU: 0 PID: 15 Comm: pgdatinit0 Tainted: G T 4.20.0-rc5-next-20181204-00011-g04c35bf41f8a-dirty #71 [ 17.561394] Hardware name: linux,dummy-virt (DT) [ 17.563933] Call trace: [ 17.565087] dump_backtrace+0x0/0x308 [ 17.566489] show_stack+0x28/0x38 [ 17.567844] __dump_stack+0x24/0x2c [ 17.569214] dump_stack+0xf8/0x16c [ 17.570566] ubsan_epilogue+0x18/0x50 [ 17.571992] handle_misaligned_access+0x94/0xc8 [ 17.573588] ubsan_type_mismatch_common+0x60/0x90 [ 17.575218] __ubsan_handle_type_mismatch+0x50/0x74 [ 17.576906] exit_notify+0x568/0x5d0 [ 17.579266] do_exit+0xabc/0xf60 [ 17.581489] __kthread_init_worker+0x0/0x150 [ 17.584097] ret_from_fork+0x10/0x18 [ 17.586405] ================================================================================ [ 17.592184] pgdatinit0 (15) used greatest stack depth: 12720 bytes left [ 17.629434] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 18.133785] devtmpfs: initialized [ 19.355397] gcov: version magic: 0x4137332a [ 19.379158] _warn_unseeded_randomness: 2 callbacks suppressed [ 19.379728] random: get_random_u32 called from bucket_table_alloc+0x210/0x310 with crng_init=0 [ 19.410726] random: get_random_u64 called from kmem_cache_open+0x78/0x3c8 with crng_init=0 [ 19.425563] random: get_random_u64 called from cache_random_seq_create+0xd0/0x1a8 with crng_init=0 [ 19.465705] workqueue: round-robin CPU selection forced, expect performance impact [ 19.531072] Registered cp15_barrier emulation handler [ 19.542703] Registered setend emulation handler [ 46.409765] watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [swapper/0:1] [ 46.412101] Modules linked in: [ 46.413239] irq event stamp: 162974 [ 46.414706] hardirqs last enabled at (162973): [] __slab_alloc+0x6c/0x88 [ 46.416817] hardirqs last disabled at (162974): [] el1_irq+0xa8/0x1c0 [ 46.419165] softirqs last enabled at (21652): [] __do_softirq+0x1130/0x1210 [ 46.421554] softirqs last disabled at (21643): [] irq_exit+0x208/0x338 [ 46.423821] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G T 4.20.0-rc5-next-20181204-00011-g04c35bf41f8a-dirty #71 [ 46.425565] Hardware name: linux,dummy-virt (DT) [ 46.426839] pstate: 40400005 (nZcv daif +PAN -UAO) [ 46.428096] pc : __slab_alloc+0x70/0x88 [ 46.429166] lr : __slab_alloc+0x6c/0x88 [ 46.430064] sp : ffffff800814ba70 [ 46.430985] x29: ffffff800814ba70 x28: ffffff800aa9db48 [ 46.432506] x27: 0000000000000090 x26: ffffff800a616000 [ 46.433890] x25: ffffff80084634a4 x24: ffffffc07ebe7e10 [ 46.435266] x23: ffffff80084634a4 x22: 00000000ffffffff [ 46.436726] x21: 00000000006080c0 x20: ffffffc079cdef80 [ 46.438106] x19: 0000000000000000 x18: 0000000000000000 [ 46.439471] x17: 0000000000000000 x16: 0fffc00000010201 [ 46.440855] x15: 0000000000000000 x14: 0000000000000000 [ 46.442224] x13: 00000000000a0004 x12: ffffff800aa999d8 [ 46.443600] x11: ffffffc03f5c8058 x10: ffffff800a615df8 [ 46.445052] x9 : 000000000000000f x8 : ffffffc03fc00580 [ 46.446539] x7 : ffffff800a616000 x6 : 0000000000000000 [ 46.447994] x5 : ffffff800a616718 x4 : 0000000000000000 [ 46.449618] x3 : 0000000000015ac5 x2 : 0000000000015ac5 [ 46.451242] x1 : 764128db26714c00 x0 : 0000000000000000 [ 46.452959] Call trace: [ 46.454204] __slab_alloc+0x70/0x88 [ 46.455375] kmem_cache_alloc_trace+0x320/0xe58 [ 46.456678] prealloc_memory+0x84/0x2d0 [ 46.457779] dma_debug_init+0x164/0x210 [ 46.458907] do_one_initcall+0x4c8/0xa50 [ 46.460122] do_initcall_level+0xbcc/0xca4 [ 46.461258] do_initcalls+0x64/0xa8 [ 46.462313] do_basic_setup+0x44/0x70 [ 46.463402] kernel_init_freeable+0x2d8/0x420 [ 46.464580] kernel_init+0x28/0x140 [ 46.465753] ret_from_fork+0x10/0x18 [ 46.467065] Kernel panic - not syncing: softlockup: hung tasks [ 46.468574] CPU: 0 PID: 1 Comm: swapper/0 Tainted: G L T 4.20.0-rc5-next-20181204-00011-g04c35bf41f8a-dirty #71 [ 46.470295] Hardware name: linux,dummy-virt (DT) [ 46.471240] Call trace: [ 46.472134] dump_backtrace+0x0/0x308 [ 46.473148] show_stack+0x28/0x38 [ 46.474136] __dump_stack+0x24/0x2c [ 46.475141] dump_stack+0xf8/0x16c [ 46.476100] panic+0x24c/0x50c [ 46.477108] watchdog_timer_fn+0x43c/0x4b8 [ 46.478160] __run_hrtimer+0xadc/0x10a0 [ 46.479189] __hrtimer_run_queues+0x15c/0x1b8 [ 46.480288] hrtimer_run_queues+0x234/0x260 [ 46.481412] run_local_timers+0x34/0xc0 [ 46.482506] update_process_times+0x30/0x88 [ 46.483588] tick_periodic+0x150/0x168 [ 46.484657] tick_handle_periodic+0x74/0x160 [ 46.485783] arch_timer_handler_virt+0x60/0x80 [ 46.486924] handle_percpu_devid_irq+0x6dc/0xce8 [ 46.488127] generic_handle_irq+0x60/0x80 [ 46.489261] __handle_domain_irq+0xf8/0x170 [ 46.490457] gic_handle_irq+0x8c/0xe8 [ 46.491694] el1_irq+0xec/0x1c0 [ 46.492890] __slab_alloc+0x70/0x88 [ 46.494076] kmem_cache_alloc_trace+0x320/0xe58 [ 46.495330] prealloc_memory+0x84/0x2d0 [ 46.496496] dma_debug_init+0x164/0x210 [ 46.497599] do_one_initcall+0x4c8/0xa50 [ 46.498748] do_initcall_level+0xbcc/0xca4 [ 46.499843] do_initcalls+0x64/0xa8 [ 46.500860] do_basic_setup+0x44/0x70 [ 46.501912] kernel_init_freeable+0x2d8/0x420 [ 46.503040] kernel_init+0x28/0x140 [ 46.504088] ret_from_fork+0x10/0x18 [ 46.507313] ---[ end Kernel panic - not syncing: softlockup: hung tasks ]---