kernel-packages team mailing list archive
-
kernel-packages team
-
Mailing list archive
-
Message #163787
[Bug 1531768] Re: [arm64] locks up a few minutes after booting
I re-tried with the current kernel 4.4.0-8, and merely booting a
pristine cloud image with "nova boot --poll --image ubuntu/ubuntu-
xenial-daily-arm64-server-20160227-uefi1.img --flavor m1.large" and
letting it sit there for some 20 minutes is still auto-destructing:
[2J[01;01H[=3h[2J[01;01H[2J[01;01H[=3h[2J[01;01H[2J[01;01H[=3h[2J[01;01H[2J[01;01H[=3h[2J[01;01H[2J[01;01H[=3h[2J[01;01H[2J[01;01H[=3h[2J[01;01H[0m[35m[40m[2J[01;01H[0m[37m[40merror: no suitable video mode found.
EFI stub: Booting Linux Kernel...
EFI stub: Using DTB from configuration table
EFI stub: Exiting boot services and installing virtual address map...
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.4.0-8-generic (buildd@beebe) (gcc version 5.3.1 20160222 (Ubuntu/Linaro 5.3.1-9ubuntu3) ) #23-Ubuntu SMP Wed Feb 24 20:51:39 UTC 2016 (Ubuntu 4.4.0-8.23-generic 4.4.2)
[ 0.000000] Boot CPU: AArch64 Processor [500f0001]
[ 0.000000] efi: Getting EFI parameters from FDT:
[ 0.000000] EFI v2.40 by EDK II
[ 0.000000] efi:
[ 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] PERCPU: Embedded 17 pages/cpu @ffff8001fff7d000 s31128 r8192 d30312 u69632
[ 0.000000] Detected PIPT I-cache on CPU0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 2064384
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.4.0-8-generic root=LABEL=cloudimg-rootfs vt.handoff=7
[ 0.000000] log_buf_len individual max cpu contribution: 4096 bytes
[ 0.000000] log_buf_len total cpu_extra contributions: 12288 bytes
[ 0.000000] log_buf_len min size: 16384 bytes
[ 0.000000] log_buf_len: 32768 bytes
[ 0.000000] early log buf free: 14588(89%)
[ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.000000] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[ 0.000000] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.000000] software IO TLB [mem 0xfbffb000-0xffffb000] (64MB) mapped at [ffff8000bbffb000-ffff8000bfffafff]
[ 0.000000] Memory: 8142020K/8388608K available (8552K kernel code, 1007K rwdata, 3736K rodata, 748K init, 783K bss, 246588K reserved, 0K cma-reserved)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vmalloc : 0xffff000000000000 - 0xffff7bffbfff0000 (126974 GB)
[ 0.000000] vmemmap : 0xffff7bffc0000000 - 0xffff7fffc0000000 ( 4096 GB maximum)
[ 0.000000] 0xffff7bffc1000000 - 0xffff7bffc9000000 ( 128 MB actual)
[ 0.000000] fixed : 0xffff7ffffa7fd000 - 0xffff7ffffac00000 ( 4108 KB)
[ 0.000000] PCI I/O : 0xffff7ffffae00000 - 0xffff7ffffbe00000 ( 16 MB)
[ 0.000000] modules : 0xffff7ffffc000000 - 0xffff800000000000 ( 64 MB)
[ 0.000000] memory : 0xffff800000000000 - 0xffff800200000000 ( 8192 MB)
[ 0.000000] .init : 0xffff800000c82000 - 0xffff800000d3d000 ( 748 KB)
[ 0.000000] .text : 0xffff800000080000 - 0xffff800000c82000 ( 12296 KB)
[ 0.000000] .data : 0xffff800000d4e000 - 0xffff800000e49e00 ( 1008 KB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] Build-time adjustment of leaf fanout to 64.
[ 0.000000] RCU restricting CPUs from NR_CPUS=128 to nr_cpu_ids=4.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=4
[ 0.000000] NR_IRQS:64 nr_irqs:64 0
[ 0.000000] Architected cp15 timer(s) running at 50.00MHz (virt).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0xb8812736b, max_idle_ns: 440795202655 ns
[ 0.000002] sched_clock: 56 bits at 50MHz, resolution 20ns, wraps every 4398046511100ns
[ 0.000048] vt handoff: transparent VT on vt#7
[ 0.000060] Console: colour dummy device 80x25
[ 0.000105] console [tty0] enabled
[ 0.000116] Calibrating delay loop (skipped), value calculated using timer frequency.. 100.00 BogoMIPS (lpj=200000)
[ 0.000122] pid_max: default: 32768 minimum: 301
[ 0.000151] Security Framework initialized
[ 0.000156] Yama: becoming mindful.
[ 0.000182] AppArmor: AppArmor initialized
[ 0.000242] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.000246] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes)
[ 0.000522] Initializing cgroup subsys io
[ 0.000530] Initializing cgroup subsys memory
[ 0.000540] Initializing cgroup subsys devices
[ 0.000545] Initializing cgroup subsys freezer
[ 0.000550] Initializing cgroup subsys net_cls
[ 0.000554] Initializing cgroup subsys perf_event
[ 0.000558] Initializing cgroup subsys net_prio
[ 0.000562] Initializing cgroup subsys hugetlb
[ 0.000567] Initializing cgroup subsys pids
[ 0.000583] ftrace: allocating 29997 entries in 118 pages
[ 0.026742] Remapping and enabling EFI services.
[ 0.026750] EFI remap 0x0000000004000000 => 0000000040000000
[ 0.026757] EFI remap 0x0000000009010000 => 0000000044000000
[ 0.026761] EFI remap 0x000000023711d000 => 000000004401d000
[ 0.026771] EFI remap 0x000000023fb05000 => 00000000440e5000
[ 0.026774] EFI remap 0x000000023fb19000 => 00000000440f9000
[ 0.026778] EFI remap 0x000000023fb4e000 => 000000004413e000
[ 0.026780] EFI remap 0x000000023fb66000 => 0000000044146000
[ 0.026788] ASID allocator initialised with 65536 entries
[ 0.035737] Detected PIPT I-cache on CPU1
[ 0.035845] CPU1: Booted secondary processor [500f0001]
[ 0.044004] Detected PIPT I-cache on CPU2
[ 0.044106] CPU2: Booted secondary processor [500f0001]
[ 0.052247] Detected PIPT I-cache on CPU3
[ 0.052349] CPU3: Booted secondary processor [500f0001]
[ 0.052480] Brought up 4 CPUs
[ 0.052493] SMP: Total of 4 processors activated.
[ 0.052498] CPU: All CPU(s) started at EL1
[ 0.053004] devtmpfs: initialized
[ 0.053575] evm: security.selinux
[ 0.053578] evm: security.SMACK64
[ 0.053580] evm: security.SMACK64EXEC
[ 0.053582] evm: security.SMACK64TRANSMUTE
[ 0.053583] evm: security.SMACK64MMAP
[ 0.053585] evm: security.ima
[ 0.053587] evm: security.capability
[ 0.053780] DMI not present or invalid.
[ 0.053945] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
[ 0.054237] pinctrl core: initialized pinctrl subsystem
[ 0.054630] NET: Registered protocol family 16
[ 0.067045] cpuidle: using governor ladder
[ 0.079119] cpuidle: using governor menu
[ 0.079153] vdso: 2 pages (1 code @ ffff800000d55000, 1 data @ ffff800000d54000)
[ 0.079166] hw-breakpoint: found 4 breakpoint and 4 watchpoint registers.
[ 0.079497] DMA: preallocated 256 KiB pool for atomic allocations
[ 0.079566] Serial: AMBA PL011 UART driver
[ 0.082155] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 37, base_baud = 0) is a PL011 rev1
[ 0.203937] console [ttyAMA0] enabled
[ 0.217441] ACPI: Interpreter disabled.
[ 0.218501] vgaarb: loaded
[ 0.219542] SCSI subsystem initialized
[ 0.220632] usbcore: registered new interface driver usbfs
[ 0.221777] usbcore: registered new interface driver hub
[ 0.222985] usbcore: registered new device driver usb
[ 0.224436] dmi: Firmware registration failed.
[ 0.225836] NetLabel: Initializing
[ 0.226569] NetLabel: domain hash size = 128
[ 0.227464] NetLabel: protocols = UNLABELED CIPSOv4
[ 0.228523] NetLabel: unlabeled traffic allowed by default
[ 0.229830] clocksource: Switched to clocksource arch_sys_counter
[ 0.244770] AppArmor: AppArmor Filesystem Enabled
[ 0.245916] pnp: PnP ACPI: disabled
[ 0.252093] NET: Registered protocol family 2
[ 0.253260] TCP established hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.254952] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 0.256913] TCP: Hash tables configured (established 65536 bind 65536)
[ 0.258339] UDP hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.259677] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
[ 0.261158] NET: Registered protocol family 1
[ 0.262243] Trying to unpack rootfs image as initramfs...
[ 4.632259] Freeing initrd memory: 20584K (ffff800190eb5000 - ffff8001922cf000)
[ 4.634112] kvm [1]: HYP mode not available
[ 4.635386] futex hash table entries: 1024 (order: 5, 131072 bytes)
[ 4.636734] audit: initializing netlink subsys (disabled)
[ 4.637928] audit: type=2000 audit(4.588:1): initialized
[ 4.639178] Initialise system trusted keyring
[ 4.640554] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 4.644379] zbud: loaded
[ 4.645406] VFS: Disk quotas dquot_6.6.0
[ 4.646404] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 4.648861] fuse init (API version 7.23)
[ 4.650029] Key type big_key registered
[ 4.652354] Key type asymmetric registered
[ 4.653226] Asymmetric key parser 'x509' registered
[ 4.654335] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
[ 4.656011] io scheduler noop registered
[ 4.656837] io scheduler deadline registered (default)
[ 4.657995] io scheduler cfq registered
[ 4.659225] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 4.660396] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 4.661783] PCI host bridge /pcie@10000000 ranges:
[ 4.662834] IO 0x3eff0000..0x3effffff -> 0x00000000
[ 4.663896] MEM 0x10000000..0x3efeffff -> 0x10000000
[ 4.665220] pci-host-generic 3f000000.pcie: PCI host bridge to bus 0000:00
[ 4.666667] pci_bus 0000:00: root bus resource [bus 00-0f]
[ 4.667793] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]
[ 4.669048] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]
[ 4.673751] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[ 4.678496] msm_serial: driver initialized
[ 4.679767] Unable to detect cache hierarchy from DT for CPU 0
[ 4.687139] brd: module loaded
[ 4.690926] loop: module loaded
[ 4.694433] GPT:Primary header thinks Alt. header is not at the end of the disk.
[ 4.695956] GPT:4612095 != 167772159
[ 4.696689] GPT:Alternate GPT header not at the end of the disk.
[ 4.697935] GPT:4612095 != 167772159
[ 4.698645] GPT: Use GNU Parted to correct GPT errors.
[ 4.699663] vda: vda1 vda15
[ 4.700975] libphy: Fixed MDIO Bus: probed
[ 4.701880] tun: Universal TUN/TAP device driver, 1.6
[ 4.702921] tun: (C) 1999-2004 Max Krasnyansky <maxk@xxxxxxxxxxxx>
[ 4.705662] PPP generic driver version 2.4.2
[ 4.706812] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 4.708178] ehci-pci: EHCI PCI platform driver
[ 4.709112] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 4.710435] ohci-pci: OHCI PCI platform driver
[ 4.711351] uhci_hcd: USB Universal Host Controller Interface driver
[ 4.712922] mousedev: PS/2 mouse device common for all mice
[ 4.714347] i2c /dev entries driver
[ 4.715419] device-mapper: uevent: version 1.0.3
[ 4.716569] device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised: dm-devel@xxxxxxxxxx
[ 4.718469] ledtrig-cpu: registered to indicate activity on CPUs
[ 4.719666] EFI Variables Facility v0.08 2004-May-17
[ 4.721394] NET: Registered protocol family 10
[ 4.722850] NET: Registered protocol family 17
[ 4.723812] Key type dns_resolver registered
[ 4.724755] Registered cp15_barrier emulation handler
[ 4.725822] Registered setend emulation handler
[ 4.727196] registered taskstats version 1
[ 4.728091] Loading compiled-in X.509 certificates
[ 4.730530] Loaded X.509 cert 'Build time autogenerated kernel key: 3041370e3aa1d4aaa0059da5d744f35af150019e'
[ 4.732588] zswap: loaded using pool lzo/zbud
[ 4.737198] Key type trusted registered
[ 4.751223] Key type encrypted registered
[ 4.752128] AppArmor: AppArmor sha1 policy hashing enabled
[ 4.753254] ima: No TPM chip found, activating TPM-bypass!
[ 4.754494] evm: HMAC attrs: 0x1
[ 4.755439] hctosys: unable to open rtc device (rtc0)
[ 4.757008] uart-pl011 9000000.pl011: no DMA platform data
[ 4.758375] Freeing unused kernel memory: 748K (ffff800000c82000 - ffff800000d3d000)
[ 4.759903] Freeing alternatives memory: 48K (ffff800000d3d000 - ffff800000d49000)
Loading, please wait...
[ 4.878551] random: nonblocking pool is initialized
[ 6.114586] irq 37: nobody cared (try booting with the "irqpoll" option)
[ 6.116064] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 4.4.0-8-generic #23-Ubuntu
[ 6.117653] Hardware name: linux,dummy-virt (DT)
[ 6.118654] Call trace:
[ 6.119203] [<ffff80000008a6d8>] dump_backtrace+0x0/0x1b0
[ 6.120373] [<ffff80000008a8ac>] show_stack+0x24/0x30
[ 6.121470] [<ffff80000043859c>] dump_stack+0x88/0xa4
[ 6.122583] [<ffff800000119270>] __report_bad_irq+0x40/0xf0
[ 6.123789] [<ffff800000119610>] note_interrupt+0x218/0x2f8
[ 6.124994] [<ffff8000001162f8>] handle_irq_event_percpu+0xc8/0x1a0
[ 6.126346] [<ffff800000116424>] handle_irq_event+0x54/0x88
[ 6.127551] [<ffff80000011a2cc>] handle_fasteoi_irq+0xbc/0x1c8
[ 6.128812] [<ffff8000001157cc>] generic_handle_irq+0x34/0x50
[ 6.130054] [<ffff800000115b18>] __handle_domain_irq+0x68/0xc0
[ 6.131310] [<ffff8000000825d4>] gic_handle_irq+0x5c/0xb0
[ 6.132482] Exception stack(0xffff800000d53da0 to 0xffff800000d53ec0)
[ 6.133868] 3da0: ffff800000d50000 ffff800000d56000 ffff800000d53ef0 ffff8000000864f4
[ 6.135548] 3dc0: 0000000000000145 ffff8000008c9378 ffff800000d53ef0 0000000000000000
[ 6.137232] 3de0: 0000000000000000 00000001ff248000 0100000000000000 ffff800000d56b78
[ 6.138915] 3e00: 002aad4b00000000 00000000fffedfa3 ffff800000d620b0 ffff800000d53e70
[ 6.140598] 3e20: 0000000000000890 0000000000000000 ffff800000e21000 0000000000000001
[ 6.142295] 3e40: 000000000000003a 0000ffff9dd63c54 ffff8000000c4828 0000000000463070
[ 6.143977] 3e60: 0000000000000042 ffff800000d50000 ffff800000d56000 ffff800000d56b78
[ 6.145657] 3e80: ffff800000e2a000 0000000000000000 0000000000000000 ffff800000d35ad8
[ 6.147355] 3ea0: ffff800000d53f20 ffff8000008e0000 ffff800000d56000 ffff800000d53ef0
[ 6.149039] [<ffff8000000855a8>] el1_irq+0x68/0xc0
[ 6.150080] [<ffff800000105fcc>] default_idle_call+0x24/0x40
[ 6.151305] [<ffff8000001062ac>] cpu_startup_entry+0x24c/0x288
[ 6.152588] [<ffff8000008c7744>] rest_init+0x7c/0x88
[ 6.153667] [<ffff800000c829fc>] start_kernel+0x3ec/0x418
[ 6.154835] [<00000000408d1000>] 0x408d1000
[ 6.155744] handlers:
[ 6.156252] [<ffff800000583478>] pl011_int
[ 6.157170] Disabling IRQ #37
starting version 229
Begin: Loading essential drivers ... [ 7.313982] md: linear personality registered for level -1
[ 7.319467] md: multipath personality registered for level -4
[ 7.325109] md: raid0 personality registered for level 0
[ 7.330963] md: raid1 personality registered for level 1
[ 7.405868] raid6: int64x1 gen() 1452 MB/s
[ 7.473875] raid6: int64x1 xor() 1145 MB/s
[ 7.541858] raid6: int64x2 gen() 1844 MB/s
[ 7.609862] raid6: int64x2 xor() 1415 MB/s
[ 7.677860] raid6: int64x4 gen() 2820 MB/s
[ 7.745857] raid6: int64x4 xor() 1646 MB/s
[ 7.813865] raid6: int64x8 gen() 2565 MB/s
[ 7.881855] raid6: int64x8 xor() 1567 MB/s
[ 7.949874] raid6: neonx1 gen() 3022 MB/s
[ 8.017871] raid6: neonx1 xor() 1801 MB/s
[ 8.085853] raid6: neonx2 gen() 3082 MB/s
[ 8.153856] raid6: neonx2 xor() 1815 MB/s
[ 8.221866] raid6: neonx4 gen() 3083 MB/s
[ 8.289860] raid6: neonx4 xor() 1835 MB/s
[ 8.357859] raid6: neonx8 gen() 2821 MB/s
[ 8.425891] raid6: neonx8 xor() 1721 MB/s
[ 8.426838] raid6: using algorithm neonx4 gen() 3083 MB/s
[ 8.428001] raid6: .... xor() 1835 MB/s, rmw enabled
[ 8.429019] raid6: using intx1 recovery algorithm
[ 8.432156] xor: measuring software checksum speed
[ 8.469840] 8regs : 8641.000 MB/sec
[ 8.509839] 8regs_prefetch: 7746.000 MB/sec
[ 8.549836] 32regs : 8607.000 MB/sec
[ 8.589835] 32regs_prefetch: 6995.000 MB/sec
[ 8.590770] xor: using function: 8regs (8641.000 MB/sec)
[ 8.593859] async_tx: api initialized (async)
[ 8.606634] md: raid6 personality registered for level 6
[ 8.607995] md: raid5 personality registered for level 5
[ 8.609150] md: raid4 personality registered for level 4
[ 8.619895] md: raid10 personality registered for level 10
done.
Begin: Running /scripts/init-premount ... done.
Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done.
Begin: Running /scripts/local-premount ... [ 8.674153] Btrfs loaded
Scanning for Btrfs filesystems
done.
Warning: fsck not present, so skipping root file system
[ 8.739900] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
done.
Begin: Running /scripts/local-bottom ... done.
Begin: Running /scripts/init-bottom ... Warning: overlayroot: debug is busted
/scripts/init-bottom/plymouth: line 18: /bin/plymouth: not found
done.
[ 8.865534] systemd[1]: System time before build time, advancing clock.
[ 8.890008] systemd[1]: systemd 229 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ -LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN)
[ 8.893772] systemd[1]: Detected virtualization qemu.
[ 8.894894] systemd[1]: Detected architecture arm64.
Welcome to [1mUbuntu 16.04[0m!
[ 8.899870] systemd[1]: Set hostname to <ubuntu>.
[ 8.903861] systemd[1]: Initializing machine ID from random generator.
[ 8.905324] systemd[1]: Installed transient /etc/machine-id file.
[ 8.950974] systemd-sysv-generator[315]: Overwriting existing symlink /run/systemd/generator.late/umountiscsi.service with real service.
[ 9.016448] systemd[1]: Created slice User and Session Slice.
[[0;32m OK [0m] Created slice User and Session Slice.
[ 9.020851] systemd[1]: Listening on Process Core Dump Socket.
[[0;32m OK [0m] Listening on Process Core Dump Socket.
[ 9.023835] systemd[1]: Listening on udev Kernel Socket.
[[0;32m OK [0m] Listening on udev Kernel Socket.
[ 9.026579] systemd[1]: Listening on LVM2 poll daemon socket.
[[0;32m OK [0m] Listening on LVM2 poll daemon socket.
[ 9.029391] systemd[1]: Reached target User and Group Name Lookups.
[[0;32m OK [0m] Reached target User and Group Name Lookups.
[ 9.032607] systemd[1]: Listening on Journal Socket.
[[0;32m OK [0m] Listening on Journal Socket.
[ 9.035308] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[[0;32m OK [0m] Started Forward Password Requests to Wall Directory Watch.
[ 9.038951] systemd[1]: Listening on udev Control Socket.
[[0;32m OK [0m] Listening on udev Control Socket.
[ 9.041521] systemd[1]: Reached target Swap.
[[0;32m OK [0m] Reached target Swap.
[ 9.043947] systemd[1]: Listening on Journal Audit Socket.
[[0;32m OK [0m] Listening on Journal Audit Socket.
[ 9.046728] systemd[1]: Listening on Device-mapper event daemon FIFOs.
[[0;32m OK [0m] Listening on Device-mapper event daemon FIFOs.
[ 9.049880] systemd[1]: Reached target Encrypted Volumes.
[[0;32m OK [0m] Reached target Encrypted Volumes.
[ 9.052786] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[[0;32m OK [0m] Set up automount Arbitrary Executab...ats File System Automount Point.
[ 9.057043] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[[0;32m OK [0m] Listening on /dev/initctl Compatibility Named Pipe.
[ 9.060406] systemd[1]: Listening on LVM2 metadata daemon socket.
[[0;32m OK [0m] Listening on LVM2 metadata daemon socket.
[ 9.063388] systemd[1]: Reached target Remote File Systems (Pre).
[[0;32m OK [0m] Reached target Remote File Systems (Pre).
[ 9.066396] systemd[1]: Reached target Remote File Systems.
[[0;32m OK [0m] Reached target Remote File Systems.
[ 9.069208] systemd[1]: Listening on Journal Socket (/dev/log).
[[0;32m OK [0m] Listening on Journal Socket (/dev/log).
[ 9.072179] systemd[1]: Listening on Syslog Socket.
[[0;32m OK [0m] Listening on Syslog Socket.
[ 9.075295] systemd[1]: Created slice System Slice.
[[0;32m OK [0m] Created slice System Slice.
[ 9.089999] systemd[1]: Mounting Huge Pages File System...
Mounting Huge Pages File System...
[ 9.095235] systemd[1]: Mounting Debug File System...
[ 9.098955] systemd[1]: Starting Journal Service...
Starting Journal Service...
[ 9.103754] systemd[1]: Starting Uncomplicated firewall...
Starting Uncomplicated firewall...
[ 9.110383] systemd[1]: Starting Remount Root and Kernel File Systems...
Starting Remount Root and Kernel File Systems...
[ 9.117696] systemd[1]: Starting Load Kernel Modules...
[ 9.119868] EXT4-fs (vda1): re-mounted. Opts: (null)
Starting Load Kernel Modules...
[ 9.124379] systemd[1]: Mounting POSIX Message Queue File System...
Mounting POSIX Message Queue File System...
[ 9.129258] systemd[1]: Starting Create list of required static device nodes for the current kernel...
Starting Create list of required st... nodes for the current kernel...
[ 9.134799] systemd[1]: Created slice system-serial\x2dgetty.slice.
[[0;32m OK [0m] Created slice system-serial\x2dgetty.slice.
[ 9.138502] systemd[1]: Created slice system-getty.slice.
[[0;32m OK [0m] Created slice system-getty.slice.
[ 9.141127] systemd[1]: Reached target Slices.
[[0;32m OK [0m] Reached target Slices.
[ 9.144837] systemd[1]: Starting Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling...
Starting Monitoring of LVM2 mirrors... dmeventd or progress polling...
[ 9.152679] systemd[1]: Starting Nameserver information manager...
Starting Nameserver information manager...
[ 9.162920] systemd[1]: Mounted POSIX Message Queue File System.
[[0;32m OK [0m] Mounted POSIX Message Queue File System.
[ 9.170746] systemd[1]: Mounted Debug File System.
[[0;32m OK [0m] Mounted Debug File System.
[ 9.175838] systemd[1]: Mounted Huge Pages File System.
[[0;32m OK [0m] Mounted Huge Pages File System.
[ 9.179176] systemd[1]: Started Journal Service.
[[0;32m OK [0m] Started Journal Service.
[[0;32m OK [0m] Started Uncomplicated firewall.
[[0;32m OK [0m] Started Remount Root and Kernel File Systems.
[[0;32m OK [0m] Started Load Kernel Modules.
[[0;32m OK [0m] Started Create list of required sta...ce nodes for the current kernel.
[[0;32m OK [0m] Started Nameserver information manager.
[[0;32m OK [0m] Started LVM2 metadata daemon.
Starting Create Static Device Nodes in /dev...
Mounting FUSE Control File System...
Starting Apply Kernel Variables...
Starting udev Coldplug all Devices...
Starting Load/Save Random Seed...
Starting Flush Journal to Persistent Storage...
[[0;32m OK [0m] Mounted FUSE Control File System.
[[0;32m OK [0m] Started Create Static Device Nodes in /dev.
[[0;32m OK [0m] Started Apply Kernel Variables.
[[0;32m OK [0m] Started Load/Save Random Seed.
[[0;32m OK [0m] Started Flush Journal to Persistent Storage.
Starting udev Kernel Device Manager...
[[0;32m OK [0m] Started udev Coldplug all Devices.
[ 10.843322] irq 37: nobody cared (try booting with the "irqpoll" option)
[ 10.844816] Call trace:
[ 10.845531] handlers:
[ 10.846061] [<ffff800000583478>] pl011_int
[ 10.846984] Disabling IRQ #37
[[0;32m OK [0m] Started udev Kernel Device Manager.
[[0;32m OK [0m] Found device /dev/ttyAMA0.
[[0;32m OK [0m] Found device /dev/disk/by-label/UEFI.
[[0;32m OK [0m] Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Starting LSB: Tune IDE hard disks...
[[0;32m OK [0m] Started Dispatch Password Requests to Console Directory Watch.
[[0;32m OK [0m] Started LSB: Tune IDE hard disks.
[[0;32m OK [0m] Started Monitoring of LVM2 mirrors,...ng dmeventd or progress polling.
[[0;32m OK [0m] Reached target Local File Systems (Pre).
Mounting /boot/efi...
[[0;32m OK [0m] Mounted /boot/efi.
[[0;32m OK [0m] Reached target Local File Systems.
Starting Tell Plymouth To Write Out Runtime Data...
Starting LSB: AppArmor initialization...
Starting Set console keymap...
Starting Commit a transient machine-id on disk...
Starting Create Volatile Files and Directories...
[[0;32m OK [0m] Started Tell Plymouth To Write Out Runtime Data.
[[0;1;31mFAILED[0m] Failed to start Set console keymap.
See 'systemctl status console-setup.service' for details.
[[0;32m OK [0m] Started Create Volatile Files and Directories.
Starting Update UTMP about System Boot/Shutdown...
Starting Network Time Synchronization...
[[0;32m OK [0m] Started Commit a transient machine-id on disk.
[[0;32m OK [0m] Started Update UTMP about System Boot/Shutdown.
[[0;32m OK [0m] Started Network Time Synchronization.
[[0;32m OK [0m] Reached target System Time Synchronized.
[[0;32m OK [0m] Started LSB: AppArmor initialization.
Starting Raise network interfaces...
[[0;32m OK [0m] Started ifup for eth0.
[[0;32m OK [0m] Started Raise network interfaces.
[[0;32m OK [0m] Reached target Network.
[[0;32m OK [0m] Reached target Network is Online.
Starting LSB: Starts and stops the ...nd logs in to default targets...
[[0;32m OK [0m] Started LSB: Starts and stops the i... and logs in to default targets.
[[0;32m OK [0m] Reached target System Initialization.
[[0;32m OK [0m] Started Trigger resolvconf update for networkd DNS.
[[0;32m OK [0m] Started Daily Cleanup of Temporary Directories.
[[0;32m OK [0m] Reached target Timers.
Starting Seed the pseudo random number generator on first boot...
[[0;32m OK [0m] Started ACPI Events Check.
[[0;32m OK [0m] Reached target Paths.
[[0;32m OK [0m] Listening on D-Bus System Message Bus Socket.
Starting LXD - unix socket.
[[0;32m OK [0m] Listening on ACPID Listen Socket.
[[0;32m OK [0m] Listening on UUID daemon activation socket.
[[0;32m OK [0m] Listening on LXD - unix socket.
[[0;32m OK [0m] Reached target Sockets.
[[0;32m OK [0m] Reached target Basic System.
Starting Accounts Service...
[[0;32m OK [0m] Started D-Bus System Message Bus.
Starting LSB: automatic crash report generation...
Starting LSB: Record successful boot for GRUB...
Starting LXC network bridge setup...
Starting /etc/rc.local Compatibility...
[[0;32m OK [0m] Started Regular background program processing daemon.
[[0;32m OK [0m] Started ACPI event daemon.
Starting LSB: daemon to balance interrupts for SMP systems...
Starting LSB: Set the CPU Frequency Scaling governor to "ondemand"...
Starting LSB: MD monitoring daemon...
Starting Initial cloud-init job (pre-networking)...
Starting System Logging Service...
[[0;32m OK [0m] Started Deferred execution scheduler.
Starting Login Service...
[[0;32m OK [0m] Started FUSE filesystem for LXC.
Starting LSB: Postfix Mail Transport Agent...
Starting LXD - container startup/shutdown...
[[0;32m OK [0m] Started /etc/rc.local Compatibility.
[[0;32m OK [0m] Started LSB: automatic crash report generation.
[[0;32m OK [0m] Started LSB: Record successful boot for GRUB.
[[0;32m OK [0m] Started LSB: daemon to balance interrupts for SMP systems.
[[0;32m OK [0m] Started LSB: MD monitoring daemon.
[[0;32m OK [0m] Started LSB: Set the CPU Frequency Scaling governor to "ondemand".
Starting Authenticate and Authorize Users to Run Privileged Tasks...
[[0;32m OK [0m] Started System Logging Service.
[[0;32m OK [0m] Started LXC network bridge setup.
[[0;32m OK [0m] Started Login Service.
[[0;32m OK [0m] Started Authenticate and Authorize Users to Run Privileged Tasks.
[[0;32m OK [0m] Started LXD - container startup/shutdown.
[[0;32m OK [0m] Started Accounts Service.
Starting LXC Container Initialization and Autoboot Code...
[[0;32m OK [0m] Started LXC Container Initialization and Autoboot Code.
[[0;32m OK [0m] Started LSB: Postfix Mail Transport Agent.
[[0;32m OK [0m] Reached target Mail Transport Agent.
[[0;32m OK [0m] Started Seed the pseudo random number generator on first boot.
[ 14.243332] [[0;32m OK [0m] Started Initial cloud-init job (pre-networking).
cloud-init[892]: Cloud-init v. 0.7.7 running 'init-local' at Thu, 11 Feb 2016 16:28:04 +0000. Up 13.72 seconds.
Starting Initial cloud-init job (metadata service crawler)...
[ 27.267091] cloud-init[1225]: Cloud-init v. 0.7.7 running 'init' at Thu, 11 Feb 2016 16:28:07 +0000. Up 16.16 seconds.
[ 27.270354] cloud-init[1225]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++
[ 27.274013] cloud-init[1225]: ci-info: +--------+------+------------------------------+---------------+-------+-------------------+
[ 27.277543] cloud-init[1225]: ci-info: | Device | Up | Address | Mask | Scope | Hw-Address |
[ 27.281102] cloud-init[1225]: ci-info: +--------+------+------------------------------+---------------+-------+-------------------+
[ 27.284657] cloud-init[1225]: ci-info: | lo | True | 127.0.0.1 | 255.0.0.0 | . | . |
[ 27.288184] cloud-init[1225]: ci-info: | lo | True | ::1/128 | . | host | . |
[ 27.291471] cloud-init[1225]: ci-info: | eth0 | True | 10.43.43.122 | 255.255.248.0 | . | fa:16:3e:9f:ea:cd |
[ 27.295075] cloud-init[1225]: ci-info: | eth0 | True | fe80::f816:3eff:fe9f:eacd/64 | . | link | fa:16:3e:9f:ea:cd |
[ 27.298703] cloud-init[1225]: ci-info: | lxcbr0 | True | 10.0.3.1 | 255.255.255.0 | . | e6:32:68:c9:45:3d |
[ 27.302439] cloud-init[1225]: ci-info: | lxcbr0 | True | fe80::e432:68ff:fec9:453d/64 | . | link | e6:32:68:c9:45:3d |
[ 27.306328] cloud-init[1225]: ci-info: +--------+------+------------------------------+---------------+-------+-------------------+
[ 27.309875] cloud-init[1225]: ci-info: ++++++++++++++++++++++++++++Route IPv4 info+++++++++++++++++++++++++++++
[ 27.313167] cloud-init[1225]: ci-info: +-------+-------------+------------+---------------+-----------+-------+
[ 27.316297] cloud-init[1225]: ci-info: | Route | Destination | Gateway | Genmask | Interface | Flags |
[ 27.319212] cloud-init[1225]: ci-info: +-------+-------------+------------+---------------+-----------+-------+
[ 27.322385] cloud-init[1225]: ci-info: | 0 | 0.0.0.0 | 10.43.40.1 | 0.0.0.0 | eth0 | UG |
[ 27.325479] cloud-init[1225]: ci-info: | 1 | 10.0.3.0 | 0.0.0.0 | 255.255.255.0 | lxcbr0 | U |
[ 27.328780] cloud-init[1225]: ci-info: | 2 | 10.43.40.0 | 0.0.0.0 | 255.255.248.0 | eth0 | U |
[ 27.331628] cloud-init[1225]: ci-info: +-------+-------------+------------+---------------+-----------+-------+
[ 27.334956] cloud-init[1225]: Generating public/private rsa key pair.
[ 27.337360] cloud-init[1225]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key.
[ 27.340022] cloud-init[1225]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub.
[ 27.342814] cloud-init[1225]: The key fingerprint is:
[ 27.344840] cloud-init[1225]: SHA256:jFdam8Pa+hElashoMZv1M2xY090M5ATgOdtjUc3uJ7I root@lxd-armhf1
[ 27.347473] cloud-init[1225]: The key's randomart image is:
[ 27.349508] cloud-init[1225]: +---[RSA 2048]----+
[ 27.351272] cloud-init[1225]: | ...o=o |
[ 27.353328] cloud-init[1225]: | . o = +o |
[ 27.355197] cloud-init[1225]: | o . * * +.o |
[ 27.357176] cloud-init[1225]: | O O @ * . |
[ 27.359009] cloud-init[1225]: | = = S X . |
[ 27.360999] cloud-init[1225]: | . + * +. o .|
[ 27.362961] cloud-init[1225]: | . o o o |
[ 27.364934] cloud-init[1225]: | . .E |
[ 27.366750] cloud-init[1225]: | ... |
[ 27.368628] cloud-init[1225]: +----[SHA256]-----+
[ 27.370391] cloud-init[1225]: Generating public/private dsa key pair.
[ 27.372696] cloud-init[1225]: Your identification has been saved in /etc/ssh/ssh_host_dsa_key.
[ 27.375320] cloud-init[1225]: Your public key has been saved in /etc/ssh/ssh_host_dsa_key.pub.
[ 27.378230] cloud-init[1225]: The key fingerprint is:
[ 27.380170] cloud-init[1225]: SHA256:A+dIDBwWTtTCbmnj8lIUmnNcM6wQi+e5uobWh8jVOhY root@lxd-armhf1
[ 27.382956] cloud-init[1225]: The key's randomart image is:
[ 27.385182] cloud-init[1225]: +---[DSA 1024]----+
[ 27.387296] cloud-init[1225]: | .=B= |
[ 27.389172] cloud-init[1225]: | ..==o* |
[ 27.390949] cloud-init[1225]: |. o*.*+o. |
[ 27.393062] cloud-init[1225]: | o+.@. = |
[ 27.394881] cloud-init[1225]: | oB... S |
[ 27.396865] cloud-init[1225]: | .Eo. . |
[ 27.398705] cloud-init[1225]: |o =++ |
[ 27.400625] cloud-init[1225]: |.*.*.. |
[ 27.402612] cloud-init[1225]: |=...o |
[ 27.404478] cloud-init[1225]: +----[SHA256]-----+
[ 27.406302] cloud-init[1225]: Generating public/private ecdsa key pair.
[ 27.408561] cloud-init[1225]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key.
[ 27.411133] cloud-init[1225]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub.
[ 27.414063] cloud-init[1225]: The key fingerprint is:
[ 27.415941] cloud-init[1225]: SHA256:IPdhbdTyjZ+nISO8cj7peQGy3lYDObzhoodqPYaiLXU root@lxd-armhf1
[ 27.418619] cloud-init[1225]: The key's randomart image is:
[ 27.420660] cloud-init[1225]: +---[ECDSA 256]---+
[ 27.422537] cloud-init[1225]: | .. |
[ 27.424380] cloud-init[1225]: | o. . |
[ 27.426192] cloud-init[1225]: | . o o.o+ o |
[ 27.428034] cloud-init[1225]: | o +.oB o . |
[ 27.429860] cloud-init[1225]: | S= * . . |
[ 27.431669] cloud-init[1225]: | . E o = * + .|
[ 27.433676] cloud-init[1225]: | . . o + o = = + |
[ 27.435571] cloud-init[[1225]: [0;32m OK [0m|... o * + B.. . |]
Started Initial cloud-init job (metadata service crawler).[ 27.437873]
cloud-init[1225]: |.o.o.o o *+o |[
[0;32m OK [0m[ 27.440791] ] cloud-initReached target Cloud-config availability.[1225]:
+----[SHA256]-----+
[ 27.443639] cloud-init[1225]: Generating public/private ed25519 key pair.
[ 27.445996] cloud-init[1225]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key.
[ 27.448558] cloud-init[1225]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub.
[ 27.450927] cloud-init[1225]: The key fingerprint is:
[ 27.452757] cloud-init[1225]: SHA256:/vOIUikmJTYeQDmbcy95sC12CWfyuFdJAmo3e8N7JxI root@lxd-armhf1
[ 27.455626] cloud-init[1225]: The key's randomart image is:
[ 27.457634] Starting Apply the settings specified in cloud-config...cloud-init
[1225]: +--[ED25519 256]--+
[ 27.460837] cloud-init[1225]: | ... |
Starting OpenBSD Secure Shell server...[ 27.463109] cloud-init[1225]: | + . |
[ 27.466287] cloud-init[1225]: | * . |
[ 27.468346] cloud-initStarting Permit User Sessions...[1225]:
| * % = . |
[ 27.471794] cloud-init[1225]: | . * ^ +So |
[ 27.474035] cloud-init[1225]: | @ E.= |
[ 27.476142] [cloud-init[0;32m OK [0m[1225]: ] | . X B. |Started Permit User Sessions.
[ 27.478804] cloud-init[1225]: | . = ooo. |
[ 27.480727] cloud-init[1225]: | . +.ooo. |
[ 27.482544] cloud-init[1225]: +----[SHA256]-----+
[[0;32m OK [0m] Started OpenBSD Secure Shell server.
Starting Terminate Plymouth Boot Screen...
Starting Hold until boot process finishes up...
[[0;32m OK [0m] Started Hold until boot process finishes up.
[[0;32m OK [0m] Started Terminate Plymouth Boot Screen.
[[0;32m OK [0m] Started Serial Getty on ttyAMA0.
[[0;32m OK [0m] Started Getty on tty1.
[[0;32m OK [0m] Reached target Login Prompts.
[ 28.669804] cloud-init[1329]: Generating locales...
[ 28.718531] cloud-init[1329]: en_US.UTF-8... up-to-date
[ 28.728072] cloud-init[1329]: Generation complete.
[ 29.393149] cloud-init[1329]: Cloud-init v. 0.7.7 running 'modules:config' at Thu, 11 Feb 2016 16:28:19 +0000. Up 28.21 seconds.
[[0;32m OK [0m] Started Apply the settings specified in cloud-config.
Starting Execute cloud user/final scripts...
ci-info: Authorized keys from /home/ubuntu/.ssh/authorized_keys for user ubuntu
ci-info: +---------+-------------------+---------+---------+
ci-info: | Keytype | Fingerprint (md5) | Options | Comment |
ci-info: +---------+-------------------+---------+---------+
ci-info: +---------+-------------------+---------+---------+
<14>Feb 11 16:28:21 ec2:
<14>Feb 11 16:28:21 ec2: #############################################################
<14>Feb 11 16:28:21 ec2: -----BEGIN SSH HOST KEY FINGERPRINTS-----
<14>Feb 11 16:28:21 ec2: 1024 SHA256:A+dIDBwWTtTCbmnj8lIUmnNcM6wQi+e5uobWh8jVOhY root@lxd-armhf1 (DSA)
<14>Feb 11 16:28:21 ec2: 256 SHA256:IPdhbdTyjZ+nISO8cj7peQGy3lYDObzhoodqPYaiLXU root@lxd-armhf1 (ECDSA)
<14>Feb 11 16:28:21 ec2: 256 SHA256:/vOIUikmJTYeQDmbcy95sC12CWfyuFdJAmo3e8N7JxI root@lxd-armhf1 (ED25519)
<14>Feb 11 16:28:21 ec2: 2048 SHA256:jFdam8Pa+hElashoMZv1M2xY090M5ATgOdtjUc3uJ7I root@lxd-armhf1 (RSA)
<14>Feb 11 16:28:21 ec2: -----END SSH HOST KEY FINGERPRINTS-----
<14>Feb 11 16:28:21 ec2: #############################################################
-----BEGIN SSH HOST KEY KEYS-----
ecdsa-sha2-nistp256 AAAAE2VjZHNhLXNoYTItbmlzdHAyNTYAAAAIbmlzdHAyNTYAAABBBDy68vVyB6NVoBk80zR3qTcgKpVUBhDA48HIr3ORylUIODPFinWCBUuCjytfYoLv/TRn5ayKqm4gJirgN/StO18= root@lxd-armhf1
ssh-ed25519 AAAAC3NzaC1lZDI1NTE5AAAAICyvBa7H8Gyp0drEsjgm065yK3areAs3XDjYjcJ1XRQq root@lxd-armhf1
ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQC4GEOaRbzqGlhU6Nbken7sXWtpiMbFDCmmZHAh8SRodf8ka4iGJx4r12GWUr7jPPKE1ryScjsvLjwCdOWS9V+pgQmChrL/a37c2sBpcLWj1JZw36tBCChzU61VqK9HI2K0gbCXfX7xKVSyqOJf0u2akjBjBxWmC0O5zUPChVxOADffQpsTGgIkttYn2iUeKQPN3H9GcH5H6XdV9KtBzwxJsCMKERWaZRDLHR8huHoPBTYzUnlFwlMONXp/uATan+YzWlSImyin9nl05EpqzW6pCN0vZ45XT9xrvyMbZp6OFj9feQqCUqOsB+byqJN3QFC9cAuMn8+auPqpQzig8iHL root@lxd-armhf1
-----END SSH HOST KEY KEYS-----
[ 30.593085] cloud-init[1419]: Cloud-init v. 0.7.7 running 'modules:final' at Thu, 11 Feb 2016 16:28:21 +0000. Up 30.28 seconds.
[ 30.596898] cloud-init[1419]: Cloud-init v. 0.7.7 finished at Thu, 11 Feb 2016 16:28:21 +0000. Datasource DataSourceOpenStack [net,ver=2]. Up 30.57 seconds
[[0;32m OK [0m] Started Execute cloud user/final scripts.
[[0;32m OK [0m] Reached target Multi-User System.
[[0;32m OK [0m] Reached target Graphical Interface.
Starting Update UTMP about System Runlevel Changes...
[[0;32m OK [0m] Started Update UTMP about System Runlevel Changes.
Ubuntu Xenial Xerus (development branch) lxd-armhf1 ttyAMA0
lxd-armhf1 login: [ 564.359603] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 564.360854] 1-...: (102 GPs behind) idle=944/0/0 softirq=3802/3803 fqs=1
[ 564.362281] (detected by 2, t=15002 jiffies, g=1240, c=1239, q=629)
[ 564.363639] Call trace:
[ 564.364180] rcu_sched kthread starved for 15001 jiffies! g1240 c1239 f0x0 s3 ->state=0x1
[ 684.056248] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 684.057518] 1-...: (120 GPs behind) idle=998/0/0 softirq=3802/3803 fqs=1
[ 684.058933] (detected by 0, t=15002 jiffies, g=1258, c=1257, q=162)
[ 684.060283] Call trace:
[ 684.060822] rcu_sched kthread starved for 15001 jiffies! g1258 c1257 f0x0 s3 ->state=0x1
[ 804.056002] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 804.057224] 1-...: (146 GPs behind) idle=9c6/0/0 softirq=3802/3803 fqs=1
[ 804.058575] (detected by 0, t=15002 jiffies, g=1284, c=1283, q=1062)
[ 804.059876] Call trace:
[ 804.060430] rcu_sched kthread starved for 15001 jiffies! g1284 c1283 f0x0 s3 ->state=0x1
[ 1344.067597] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 1344.068850] 1-...: (0 ticks this GP) idle=7c0/0/0 softirq=4024/4024 fqs=0
[ 1344.070289] 2-...: (0 ticks this GP) idle=0e4/0/0 softirq=4087/4087 fqs=0
[ 1344.071721] (detected by 0, t=15002 jiffies, g=1513, c=1512, q=44)
[ 1344.073071] Call trace:
[ 1344.073614] Call trace:
[ 1344.074145] rcu_sched kthread starved for 15002 jiffies! g1513 c1512 f0x0 s3 ->state=0x1
[ 1413.727530] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 1413.728804] 1-...: (0 ticks this GP) idle=7d0/0/0 softirq=4024/4024 fqs=0
[ 1413.730256] 2-...: (3 GPs behind) idle=0e8/0/0 softirq=4087/4087 fqs=0
[ 1413.731687] 3-...: (3 GPs behind) idle=d3a/0/0 softirq=21590/21591 fqs=0
[ 1413.733131] (detected by 0, t=15002 jiffies, g=1516, c=1515, q=66)
[ 1413.734493] Call trace:
[ 1413.735040] Call trace:
[ 1413.735578] Call trace:
[ 1413.736110] rcu_sched kthread starved for 15002 jiffies! g1516 c1515 f0x0 s3 ->state=0x1
[ 1483.727326] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 1483.728787] 1-...: (0 ticks this GP) idle=7ec/0/0 softirq=4024/4024 fqs=0
[ 1483.730658] 2-...: (6 GPs behind) idle=112/0/0 softirq=4087/4087 fqs=0
[ 1483.732500] 3-...: (6 GPs behind) idle=d60/0/0 softirq=21590/21591 fqs=0
[ 1483.734318] (detected by 0, t=15002 jiffies, g=1519, c=1518, q=898)
[ 1483.736073] Call trace:
[ 1483.736784] Call trace:
[ 1483.737462] Call trace:
[ 1483.738029] rcu_sched kthread starved for 15002 jiffies! g1519 c1518 f0x0 s3 ->state=0x1
[ 1644.070845] INFO: task sd-resolve:594 blocked for more than 120 seconds.
[ 1644.072355] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 1644.073488] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1644.075233] Call trace:
[ 1764.074357] INFO: task sd-resolve:594 blocked for more than 120 seconds.
[ 1764.075868] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 1764.077002] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1764.078761] Call trace:
[ 1884.077795] INFO: task systemd:1 blocked for more than 120 seconds.
[ 1884.079207] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 1884.080345] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1884.082117] Call trace:
[ 1884.083453] INFO: task sd-resolve:594 blocked for more than 120 seconds.
[ 1884.084893] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 1884.086103] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1884.087780] Call trace:
[ 1884.088415] INFO: task (md-udevd):1480 blocked for more than 120 seconds.
[ 1884.089963] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 1884.091156] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1884.092805] Call trace:
[ 2004.089260] INFO: task systemd:1 blocked for more than 120 seconds.
[ 2004.090690] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 2004.091831] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 2004.093608] Call trace:
[ 2004.094828] INFO: task sd-resolve:594 blocked for more than 120 seconds.
[ 2004.096614] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 2004.097859] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 2004.099596] Call trace:
[ 2004.100215] INFO: task (md-udevd):1480 blocked for more than 120 seconds.
[ 2004.101746] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 2004.102945] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 2004.104603] Call trace:
[ 2064.112914] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 2064.114164] 2-...: (248 GPs behind) idle=166/0/0 softirq=4087/4087 fqs=0
[ 2064.115582] 3-...: (0 ticks this GP) idle=db8/0/0 softirq=21591/21591 fqs=0
[ 2064.117036] (detected by 0, t=15002 jiffies, g=1761, c=1760, q=1165)
[ 2064.118358] Call trace:
[ 2064.118875] Call trace:
[ 2064.119383] rcu_sched kthread starved for 15002 jiffies! g1761 c1760 f0x0 s3 ->state=0x1
[ 2124.104651] INFO: task systemd:1 blocked for more than 120 seconds.
[ 2124.106035] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 2124.107174] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 2124.108921] Call trace:
[ 2124.110257] INFO: task sd-resolve:594 blocked for more than 120 seconds.
[ 2124.111697] Not tainted 4.4.0-8-generic #23-Ubuntu
[ 2124.112917] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 2124.114649] Call trace:
[ 2343.723540] INFO: rcu_sched detected stalls on CPUs/tasks:
[ 2343.724812] 2-...: (326 GPs behind) idle=18c/0/0 softirq=4087/4087 fqs=1
[ 2343.726259] (detected by 0, t=15002 jiffies, g=1839, c=1838, q=1383)
[ 2343.727629] Call trace:
[ 2343.728168] rcu_sched kthread starved for 15001 jiffies! g1839 c1838 f0x0 s3 ->state=0x1
... and trying to ssh in just blocks.
** Summary changed:
- [arm64] multithreaded processes get locked up in futexes
+ [arm64] locks up a few minutes after booting
--
You received this bug notification because you are a member of Kernel
Packages, which is subscribed to linux in Ubuntu.
https://bugs.launchpad.net/bugs/1531768
Title:
[arm64] locks up a few minutes after booting
Status in linux package in Ubuntu:
Confirmed
Bug description:
I created an 8 CPU arm64 instance on Canonical's Scalingstack (which I
want to use for armhf autopkgtesting in LXD). I started with wily as
that has lxd available (it's not yet available in trusty nor the PPA
for arm64).
However, pretty much any LXD task that I do (I haven't tried much
else) on this machine takes unbearably long. A simple "lxc profile set
default raw.lxc lxc.seccomp=" or "lxc list" takes several minutes.
I see tons of
[ 1020.971955] rcu_sched kthread starved for 6000 jiffies! g1095 c1094 f0x0
[ 1121.166926] INFO: task fsnotify_mark:69 blocked for more than 120 seconds.
in dmesg (the attached apport info has the complete dmesg).
ProblemType: Bug
DistroRelease: Ubuntu 15.10
Package: linux-image-4.2.0-22-generic 4.2.0-22.27
ProcVersionSignature: User Name 4.2.0-22.27-generic 4.2.6
Uname: Linux 4.2.0-22-generic aarch64
AlsaDevices:
total 0
crw-rw---- 1 root audio 116, 1 Jan 7 09:18 seq
crw-rw---- 1 root audio 116, 33 Jan 7 09:18 timer
AplayDevices: Error: [Errno 2] No such file or directory: 'aplay'
ApportVersion: 2.19.1-0ubuntu5
Architecture: arm64
ArecordDevices: Error: [Errno 2] No such file or directory: 'arecord'
AudioDevicesInUse: Error: command ['fuser', '-v', '/dev/snd/seq', '/dev/snd/timer'] failed with exit code 1:
CRDA: N/A
Date: Thu Jan 7 09:24:01 2016
IwConfig:
eth0 no wireless extensions.
lo no wireless extensions.
lxcbr0 no wireless extensions.
Lspci:
00:00.0 Host bridge [0600]: Red Hat, Inc. Device [1b36:0008]
Subsystem: Red Hat, Inc Device [1af4:1100]
Control: I/O- Mem- BusMaster- SpecCycle- MemWINV- VGASnoop- ParErr- Stepping- SERR- FastB2B- DisINTx-
Status: Cap- 66MHz- UDF- FastB2B- ParErr- DEVSEL=fast >TAbort- <TAbort- <MAbort- >SERR- <PERR- INTx-
Lsusb: Error: command ['lsusb'] failed with exit code 1: unable to initialize libusb: -99
PciMultimedia:
ProcEnviron:
TERM=screen
PATH=(custom, no user)
XDG_RUNTIME_DIR=<set>
LANG=en_US.UTF-8
SHELL=/bin/bash
ProcFB:
ProcKernelCmdLine: BOOT_IMAGE=/boot/vmlinuz-4.2.0-22-generic root=LABEL=cloudimg-rootfs earlyprintk
RelatedPackageVersions:
linux-restricted-modules-4.2.0-22-generic N/A
linux-backports-modules-4.2.0-22-generic N/A
linux-firmware 1.149.3
RfKill: Error: [Errno 2] No such file or directory: 'rfkill'
SourcePackage: linux
UdevLog: Error: [Errno 2] No such file or directory: '/var/log/udev'
UpgradeStatus: No upgrade log present (probably fresh install)
To manage notifications about this bug go to:
https://bugs.launchpad.net/ubuntu/+source/linux/+bug/1531768/+subscriptions
References
