← Back to team overview

yahoo-eng-team team mailing list archive

[Bug 1784062] Re: Instance console data is logged at DEBUG

 

** Also affects: nova/queens
   Importance: Undecided
       Status: New

** Changed in: nova/queens
       Status: New => In Progress

** Changed in: nova/queens
   Importance: Undecided => High

** Changed in: nova/queens
     Assignee: (unassigned) => Lee Yarwood (lyarwood)

-- 
You received this bug notification because you are a member of Yahoo!
Engineering Team, which is subscribed to OpenStack Compute (nova).
https://bugs.launchpad.net/bugs/1784062

Title:
  Instance console data is logged at DEBUG

Status in OpenStack Compute (nova):
  Fix Released
Status in OpenStack Compute (nova) queens series:
  In Progress

Bug description:
  Apparently instance console output is being logged at DEBUG by the
  compute node when doing the privsep readpty() routine. This could
  almost be a DoS concern depending on the size, and also is somewhat
  concerning in that it exposes anything that the instance writes to its
  console in the logs. Since credentials or access information could be
  in here, it's not a good idea.

  Here is a recent incident:

  http://logs.openstack.org/63/586363/3/check/legacy-tempest-dsvm-full-
  devstack-plugin-
  ceph/569c574/logs/screen-n-cpu.txt.gz#_Jul_27_18_07_23_550670

  Preserved here since it'll expire at some point:

  Jul 27 18:07:23.537317 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: INFO nova.compute.manager [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] [instance: 7738f8e7-be73-4439-8808-130c8a8f07e3] Get console output
  Jul 27 18:07:23.548472 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: DEBUG oslo.privsep.daemon [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] privsep: request[140593546325360]: (3, 'nova.privsep.libvirt.readpty', ('/dev/pts/3',), {}) {{(pid=29408) loop /usr/local/lib/python2.7/dist-packages/oslo_privsep/daemon.py:443}}
  Jul 27 18:07:23.548723 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: INFO nova.privsep.libvirt [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] Ignored error while reading from instance console pty: [Errno 11] Resource temporarily unavailable
  Jul 27 18:07:23.548961 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: DEBUG oslo.privsep.daemon [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] privsep: reply[140593546325360]: (4, '') {{(pid=29408) loop /usr/local/lib/python2.7/dist-packages/oslo_privsep/daemon.py:456}}
  Jul 27 18:07:23.549199 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: DEBUG oslo.privsep.daemon [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] privsep: request[140593546325360]: (3, 'nova.privsep.path.writefile', (u'/opt/stack/data/nova/instances/7738f8e7-be73-4439-8808-130c8a8f07e3/console.log', 'a+', ''), {}) {{(pid=29408) loop /usr/local/lib/python2.7/dist-packages/oslo_privsep/daemon.py:443}}
  Jul 27 18:07:23.550143 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: DEBUG oslo.privsep.daemon [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] privsep: reply[140593546325360]: (4, None) {{(pid=29408) loop /usr/local/lib/python2.7/dist-packages/oslo_privsep/daemon.py:456}}
  Jul 27 18:07:23.550418 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: DEBUG oslo.privsep.daemon [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] privsep: request[140593546325360]: (3, 'nova.privsep.path.last_bytes', (u'/opt/stack/data/nova/instances/7738f8e7-be73-4439-8808-130c8a8f07e3/console.log', 102400), {}) {{(pid=29408) loop /usr/local/lib/python2.7/dist-packages/oslo_privsep/daemon.py:443}}
  Jul 27 18:07:23.550670 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: DEBUG oslo.privsep.daemon [None req-c4ab97e6-a00c-4cf5-82f2-18ad2cf77d7d tempest-TestNetworkBasicOps-1426085565 tempest-TestNetworkBasicOps-1426085565] privsep: reply[140593546325360]: (4, ('[    0.000000] Initializing cgroup subsys cpuset\r\n[    0.000000] Initializing cgroup subsys cpu\r\n[    0.000000] Linux version 3.2.0-80-virtual (buildd@batsu) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu5) ) #116-Ubuntu SMP Mon Mar 23 17:28:52 UTC 2015 (Ubuntu 3.2.0-80.116-virtual 3.2.68)\r\n[    0.000000] Command line: LABEL=cirros-rootfs ro console=tty1 console=ttyS0\r\n[    0.000000] KERNEL supported cpus:\r\n[    0.000000]   Intel GenuineIntel\r\n[    0.000000]   AMD AuthenticAMD\r\n[    0.000000]   Centaur CentaurHauls\r\n[    0.000000] BIOS-provided physical RAM map:\r\n[    0.000000]  BIOS-e820: 0000000000000000 - 000000000009fc00 (usable)\r\n[    0.000000]  BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved)\r\n[    0.000000]  BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)\r\n[    0.000000]  BIOS-e820: 0000000000100000 - 0000000003fdc000 (usable)\r\n[    0.000000]  BIOS-e820: 0000000003fdc000 - 0000000004000000 (reserved)\r\n[    0.000000]  BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved)\r\n[    0.000000] NX (Execute Disable) protection: active\r\n[    0.000000] SMBIOS 2.8 present.\r\n[    0.000000] No AGP bridge found\r\n[    0.000000] last_pfn = 0x3fdc max_arch_pfn = 0x400000000\r\n[    0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106\r\n[    0.000000] found SMP MP-table at [ffff8800000f6a40] f6a40\r\n[    0.000000] init_memory_mapping: 0000000000000000-0000000003fdc000\r\n[    0.000000] RAMDISK: 03c6d000 - 03fcc000\r\n[    0.000000] ACPI: RSDP 00000000000f6830 00014 (v00 BOCHS )\r\n[    0.000000] ACPI: RSDT 0000000003fe15c9 00030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)\r\n[    0.000000] ACPI: FACP 0000000003fe1425 00074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)\r\n[    0.000000] ACPI: DSDT 0000000003fe
  Jul 27 18:07:23.551422 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: 0040 013E5 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)\r\n[    0.000000] ACPI: FACS 0000000003fe0000 00040\r\n[    0.000000] ACPI: APIC 0000000003fe1519 00078 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)\r\n[    0.000000] ACPI: HPET 0000000003fe1591 00038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)\r\n[    0.000000] No NUMA configuration found\r\n[    0.000000] Faking a node at 0000000000000000-0000000003fdc000\r\n[    0.000000] Initmem setup node 0 0000000000000000-0000000003fdc000\r\n[    0.000000]   NODE_DATA [0000000003fd4000 - 0000000003fd8fff]\r\n[    0.000000] Zone PFN ranges:\r\n[    0.000000]   DMA      0x00000010 -> 0x00001000\r\n[    0.000000]   DMA32    0x00001000 -> 0x00100000\r\n[    0.000000]   Normal   empty\r\n[    0.000000] Movable zone start PFN for each node\r\n[    0.000000] early_node_map[2] active PFN ranges\r\n[    0.000000]     0: 0x00000010 -> 0x0000009f\r\n[    0.000000]     0: 0x00000100 -> 0x00003fdc\r\n[    0.000000] ACPI: PM-Timer IO Port: 0x608\r\n[    0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)\r\n[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])\r\n[    0.000000] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])\r\n[    0.000000] IOAPIC[0]: apic_id 0, version 32, address 0xfec00000, GSI 0-23\r\n[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)\r\n[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)\r\n[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)\r\n[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)\r\n[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)\r\n[    0.000000] Using ACPI (MADT) for SMP configuration information\r\n[    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000\r\n[    0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs\r\n[    0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000\r\n[    0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000\r\n[    0.000000]
  Jul 27 18:07:23.551851 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: PM: Registered nosave memory: 00000000000f0000 - 0000000000100000\r\n[    0.000000] Allocating PCI resources starting at 4000000 (gap: 4000000:fbfc0000)\r\n[    0.000000] Booting paravirtualized kernel on bare hardware\r\n[    0.000000] setup_percpu: NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:1 nr_node_ids:1\r\n[    0.000000] PERCPU: Embedded 27 pages/cpu @ffff880003a00000 s78848 r8192 d23552 u2097152\r\n[    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 15974\r\n[    0.000000] Policy zone: DMA32\r\n[    0.000000] Kernel command line: LABEL=cirros-rootfs ro console=tty1 console=ttyS0\r\n[    0.000000] PID hash table entries: 256 (order: -1, 2048 bytes)\r\n[    0.000000] Checking aperture...\r\n[    0.000000] No AGP bridge found\r\n[    0.000000] Memory: 43560k/65392k available (6576k kernel code, 452k absent, 21380k reserved, 6620k data, 928k init)\r\n[    0.000000] SLUB: Genslabs=15, HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1\r\n[    0.000000] Hierarchical RCU implementation.\r\n[    0.000000] \tRCU dyntick-idle grace-period acceleration is enabled.\r\n[    0.000000] NR_IRQS:4352 nr_irqs:256 16\r\n[    0.000000] Console: colour VGA+ 80x25\r\n[    0.000000] console [tty1] enabled\r\n[    0.000000] console [ttyS0] enabled\r\n[    0.000000] allocated 1048576 bytes of page_cgroup\r\n[    0.000000] please try \'cgroup_disable=memory\' option if you don\'t want memory cgroups\r\n[    0.000000] Fast TSC calibration failed\r\n[    0.000000] TSC: Unable to calibrate against PIT\r\n[    0.000000] TSC: using HPET reference calibration\r\n[    0.000000] Detected 2593.729 MHz processor.\r\n[    0.038636] Calibrating delay loop (skipped), value calculated using timer frequency.. 5187.45 BogoMIPS (lpj=10374916)\r\n[    0.044260] pid_max: default: 32768 minimum: 301\r\n[    0.053535] Security Framework initialized\r\n[    0.059350] AppArmor: AppArmor initialized\r\n[    0.060133] Yama: becoming mindful.\r\n[    0.068570] Dentry cache hash table entries: 8192 (order: 4, 65536 bytes)\r\n[
  Jul 27 18:07:23.552502 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]:    0.071443] Inode-cache hash table entries: 4096 (order: 3, 32768 bytes)\r\n[    0.072876] Mount-cache hash table entries: 256\r\n[    0.097203] Initializing cgroup subsys cpuacct\r\n[    0.099328] Initializing cgroup subsys memory\r\n[    0.100909] Initializing cgroup subsys devices\r\n[    0.102579] Initializing cgroup subsys freezer\r\n[    0.104146] Initializing cgroup subsys blkio\r\n[    0.106376] Initializing cgroup subsys perf_event\r\n[    0.113176] mce: CPU supports 10 MCE banks\r\n[    0.117818] SMP alternatives: switching to UP code\r\n[    0.534046] Freeing SMP alternatives: 24k freed\r\n[    0.537831] ACPI: Core revision 20110623\r\n[    0.581818] ftrace: allocating 26610 entries in 105 pages\r\n[    0.613185] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1\r\n[    0.648039] CPU0: AMD QEMU Virtual CPU version 2.5+ stepping 03\r\n[    0.648039] APIC calibration not consistent with PM-Timer: 102ms instead of 100ms\r\n[    0.648039] APIC delta adjusted to PM-Timer: 6250060 (6375724)\r\n[    0.649750] Performance Events: Broken PMU hardware detected, using software events only.\r\n[    0.672498] NMI watchdog disabled (cpu0): hardware events not enabled\r\n[    0.680601] Brought up 1 CPUs\r\n[    0.681560] Total of 1 processors activated (5187.45 BogoMIPS).\r\n[    0.713658] devtmpfs: initialized\r\n[    0.738619] EVM: security.selinux\r\n[    0.740077] EVM: security.SMACK64\r\n[    0.740912] EVM: security.capability\r\n[    0.758535] print_constraints: dummy: \r\n[    0.761041] RTC time: 18:07:11, date: 07/27/18\r\n[    0.764479] NET: Registered protocol family 16\r\n[    0.774003] ACPI: bus type pci registered\r\n[    0.778246] PCI: Using configuration type 1 for base access\r\n[    0.806145] bio: create slab <bio-0> at 0\r\n[    0.811477] ACPI: Added _OSI(Module Device)\r\n[    0.812123] ACPI: Added _OSI(Processor Device)\r\n[    0.813181] ACPI: Added _OSI(3.0 _SCP Extensions)\r\n[    0.814293] ACPI: Added _OSI(Processor Aggregator Device)\r\n[    0.854970] ACPI: Interpreter enabled\r\n[    0.85
  Jul 27 18:07:23.553126 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: 6175] ACPI: (supports S0 S3 S4 S5)\r\n[    0.858717] ACPI: Using IOAPIC for interrupt routing\r\n[    0.963343] ACPI: No dock devices found.\r\n[    0.964299] HEST: Table not found.\r\n[    0.968689] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug\r\n[    0.974685] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])\r\n[    0.979067] pci_root PNP0A03:00: host bridge window [io  0x0000-0x0cf7]\r\n[    0.980148] pci_root PNP0A03:00: host bridge window [io  0x0d00-0xffff]\r\n[    0.981736] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff]\r\n[    0.984101] pci_root PNP0A03:00: host bridge window [mem 0x04000000-0xfebfffff]\r\n[    0.985714] pci_root PNP0A03:00: host bridge window [mem 0x100000000-0x17fffffff]\r\n[    1.005908] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI\r\n[    1.008173] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB\r\n[    1.461861]  pci0000:00: Unable to request _OSC control (_OSC support mask: 0x1e)\r\n[    1.511794] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)\r\n[    1.521206] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)\r\n[    1.528566] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)\r\n[    1.531628] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)\r\n[    1.533528] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)\r\n[    1.548096] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none\r\n[    1.548096] vgaarb: loaded\r\n[    1.548096] vgaarb: bridge control possible 0000:00:02.0\r\n[    1.548096] i2c-core: driver [aat2870] using legacy suspend method\r\n[    1.548161] i2c-core: driver [aat2870] using legacy resume method\r\n[    1.554343] SCSI subsystem initialized\r\n[    1.567104] usbcore: registered new interface driver usbfs\r\n[    1.568663] usbcore: registered new interface driver hub\r\n[    1.571127] usbcore: registered new device driver usb\r\n[    1.573462] PCI: Using ACPI for IRQ routing\r\n[    1.588098] NetLabel: Initializing\r\n[    1.588164] NetLabel:
  Jul 27 18:07:23.553707 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: domain hash size = 128\r\n[    1.589220] NetLabel:  protocols = UNLABELED CIPSOv4\r\n[    1.593763] NetLabel:  unlabeled traffic allowed by default\r\n[    1.599640] HPET: 3 timers in total, 0 timers will be used for per-cpu timer\r\n[    1.600547] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0\r\n[    1.602148] hpet0: 3 comparators, 64-bit 100.000000 MHz counter\r\n[    1.613014] Switching to clocksource hpet\r\n[    1.795962] AppArmor: AppArmor Filesystem Enabled\r\n[    1.798846] pnp: PnP ACPI init\r\n[    1.800753] ACPI: bus type pnp registered\r\n[    1.818764] pnp: PnP ACPI: found 10 devices\r\n[    1.819798] ACPI: ACPI bus type pnp unregistered\r\n[    1.870079] NET: Registered protocol family 2\r\n[    1.906275] IP route cache hash table entries: 512 (order: 0, 4096 bytes)\r\n[    1.914694] TCP established hash table entries: 2048 (order: 3, 32768 bytes)\r\n[    1.917274] TCP bind hash table entries: 2048 (order: 3, 32768 bytes)\r\n[    1.918979] TCP: Hash tables configured (established 2048 bind 2048)\r\n[    1.921966] TCP reno registered\r\n[    1.923531] UDP hash table entries: 128 (order: 0, 4096 bytes)\r\n[    1.926563] UDP-Lite hash table entries: 128 (order: 0, 4096 bytes)\r\n[    1.930912] NET: Registered protocol family 1\r\n[    1.932904] pci 0000:00:00.0: Limiting direct PCI/PCI transfers\r\n[    1.934984] pci 0000:00:01.0: PIIX3: Enabling Passive Release\r\n[    1.937066] pci 0000:00:01.0: Activating ISA DMA hang workarounds\r\n[    1.943194] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11\r\n[    1.945787] pci 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11\r\n[    1.949481] pci 0000:00:01.2: PCI INT D disabled\r\n[    1.969673] Trying to unpack rootfs image as initramfs...\r\n[    1.993655] audit: initializing netlink socket (disabled)\r\n[    1.996352] type=2000 audit(1532714831.992:1): initialized\r\n[    2.163026] HugeTLB registered 2 MB page size, pre-allocated 0 pages\r\n[    2.264578] VFS: Disk quotas dquot_6.5.2\r\n[    2.270483] Dquot-cache hash table entries: 512
  Jul 27 18:07:23.554374 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: (order 0, 4096 bytes)\r\n[    2.289323] fuse init (API version 7.17)\r\n[    2.301195] msgmni has been set to 85\r\n[    2.339055] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)\r\n[    2.349511] io scheduler noop registered\r\n[    2.352891] io scheduler deadline registered (default)\r\n[    2.356854] io scheduler cfq registered\r\n[    2.364327] pci_hotplug: PCI Hot Plug PCI Core version: 0.5\r\n[    2.371082] pciehp: PCI Express Hot Plug Controller Driver version: 0.4\r\n[    2.379660] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0\r\n[    2.385530] ACPI: Power Button [PWRF]\r\n[    2.457528] ERST: Table is not found!\r\n[    2.461340] GHES: HEST is not enabled!\r\n[    2.473645] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10\r\n[    2.476188] virtio-pci 0000:00:03.0: PCI INT A -> Link[LNKC] -> GSI 10 (level, high) -> IRQ 10\r\n[    2.484192] virtio-pci 0000:00:04.0: PCI INT A -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11\r\n[    2.514967] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10\r\n[    2.520200] virtio-pci 0000:00:05.0: PCI INT A -> Link[LNKA] -> GSI 10 (level, high) -> IRQ 10\r\n[    2.541614] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled\r\n[    2.572692] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A\r\n[    2.691148] 00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A\r\n[    2.732850] Linux agpgart interface v0.103\r\n[    2.806304] brd: module loaded\r\n[    2.827633] loop: module loaded\r\n[    2.891921]  vda: vda1\r\n[    2.944737] scsi0 : ata_piix\r\n[    2.952584] scsi1 : ata_piix\r\n[    2.954539] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0c0 irq 14\r\n[    2.957073] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0c8 irq 15\r\n[    2.967534] Fixed MDIO Bus: probed\r\n[    2.969762] tun: Universal TUN/TAP device driver, 1.6\r\n[    2.972315] tun: (C) 1999-2004 Max Krasnyansky <maxk@xxxxxxxxxxxx>\r\n[    2.974857] Refined TSC clocksource calibration: 2593.711 MHz.\r\n[    2.977181] Switching to clocksource tsc\r\n[
  Jul 27 18:07:23.554994 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]:   2.997516] PPP generic driver version 2.4.2\r\n[    3.020001] ehci_hcd: USB 2.0 \'Enhanced\' Host Controller (EHCI) Driver\r\n[    3.023243] ohci_hcd: USB 1.1 \'Open\' Host Controller (OHCI) Driver\r\n[    3.025383] uhci_hcd: USB Universal Host Controller Interface driver\r\n[    3.027986] uhci_hcd 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 11 (level, high) -> IRQ 11\r\n[    3.034005] uhci_hcd 0000:00:01.2: UHCI Host Controller\r\n[    3.060692] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1\r\n[    3.065454] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c080\r\n[    3.093356] hub 1-0:1.0: USB hub found\r\n[    3.096395] hub 1-0:1.0: 2 ports detected\r\n[    3.101862] usbcore: registered new interface driver libusual\r\n[    3.104876] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12\r\n[    3.131302] serio: i8042 KBD port at 0x60,0x64 irq 1\r\n[    3.141402] serio: i8042 AUX port at 0x60,0x64 irq 12\r\n[    3.236722] mousedev: PS/2 mouse device common for all mice\r\n[    3.255476] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1\r\n[    3.269605] rtc_cmos 00:01: RTC can wake from S4\r\n[    3.288484] Freeing initrd memory: 3452k freed\r\n[    3.298446] rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0\r\n[    3.301952] rtc0: alarms up to one day, y3k, 114 bytes nvram, hpet irqs\r\n[    3.308500] device-mapper: uevent: version 1.0.3\r\n[    3.317295] device-mapper: ioctl: 4.22.0-ioctl (2011-10-19) initialised: dm-devel@xxxxxxxxxx\r\n[    3.322993] cpuidle: using governor ladder\r\n[    3.324518] cpuidle: using governor menu\r\n[    3.325866] EFI Variables Facility v0.08 2004-May-17\r\n[    3.337032] TCP cubic registered\r\n[    3.341972] NET: Registered protocol family 10\r\n[    3.360661] NET: Registered protocol family 17\r\n[    3.362074] Registering the dns_resolver key type\r\n[    3.373515] registered taskstats version 1\r\n[    3.637059]   Magic number: 10:11:141\r\n[    3.638816] block ram6: hash matches\r\n[    3.640
  Jul 27 18:07:23.555618 ubuntu-xenial-rax-iad-0001022690 nova-compute[3841]: 389] acpi device:12: hash matches\r\n[    3.644625] rtc_cmos 00:01: setting system clock to 2018-07-27 18:07:14 UTC (1532714834)\r\n[    3.647476] powernow-k8: Processor cpuid 663 not supported\r\n[    3.652738] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found\r\n[    3.655444] EDD information not available.\r\n[    3.684620] Freeing unused kernel memory: 928k freed\r\n[    3.694350] Write protecting the kernel read-only data: 12288k\r\n[    3.743853] Freeing unused kernel memory: 1596k freed\r\n[    3.786086] Freeing unused kernel memory: 1184k freed\r\n\r\ninfo: initramfs: up at 4.07\r\nNOCHANGE: partition 1 is size 64260. it cannot be grown\r\ninfo: initramfs loading root from /dev/vda1\r\ninfo: /etc/init.d/rc.sysinit: up at 5.64\r\ninfo: container: none\r\nStarting logging: OK\r\nmodprobe: module virtio_blk not found in modules.dep\r\nmodprobe: module virtio_net not found in modules.dep\r\nWARN: /etc/rc3.d/S10-load-modules failed\r\nInitializing random number generator... done.\r\nStarting acpid: OK\r\ncirros-ds \'local\' up at 8.75\r\nno results found for mode=local. up 9.38. searched: nocloud configdrive ec2\r\nStarting network...\r\nudhcpc (v1.20.1) started\r\nSending discover...\r\nSending select for 10.1.0.7...\r\nLease of 10.1.0.7 obtained, lease time 86400\r\nroute: SIOCADDRT: File exists\r\nWARN: failed: route add -net "0.0.0.0/0" gw "10.1.0.1"\r\ncirros-ds \'net\' up at 11.12\r\nchecking http://169.254.169.254/2009-04-04/instance-id\r\n', 0)) {{(pid=29408) loop /usr/local/lib/python2.7/dist-packages/oslo_privsep/daemon.py:456}}

To manage notifications about this bug go to:
https://bugs.launchpad.net/nova/+bug/1784062/+subscriptions


References