can't ssh an instance

Asked by adair on 2013-03-01

I can ping 10.0.0.2
PING 10.0.0.2 (10.0.0.2) 56(84) bytes of data.
64 bytes from 10.0.0.2: icmp_req=1 ttl=64 time=5.06 ms
64 bytes from 10.0.0.2: icmp_req=2 ttl=64 time=0.567 ms
64 bytes from 10.0.0.2: icmp_req=3 ttl=64 time=0.761 ms

but I can neither login an instance on the dashboard nor ssh an instance,likessh cirros@10.0.0.2,it will show
ssh: connect to host 10.0.0.2 port 22: Connection refused

my nova-secgoup is :nova secgroup-list-rules default,show
| IP Protocol | From Port | To Port | IP Range | Source Group |
+-------------+-----------+---------+-----------+--------------+
| icmp | -1 | -1 | 0.0.0.0/0 | |
| tcp | 22 | 22 | 0.0.0.0/0 | |
| udp | 22 | 22 | 0.0.0.0/0 | |
+-------------+-----------+---------+-----------+--------------+

so what's the problem ??????thank you

Question information

Language:
English Edit question
Status:
Answered
For:
OpenStack Compute (nova) Edit question
Assignee:
No assignee Edit question
Last query:
2013-03-03
Last reply:
2013-03-06
Russell Bryant (russellb) said : #1

I'm converting this bug into a question. Hopefully someone can help you debug your setup there. Thanks!

Jason (zzs) said : #2

Can you post the log of the instance booting which you can get from dashboard, what did happen when you try to log in from dashboard.

adair (787590563-o) said : #3

my Instance Console Log:

/ /__ / // __// __// /_/ /\ \
\___//_//_/ /_/ \____/___/
 http://launchpad.net/cirros

login as 'cirros' user. default password: 'cubswin:)'. use 'sudo' for root.

cirros login: [75308.741486] Restarting system.
[75308.743475] machine restart
[75308.744391] general protection fault: fffa [#1] SMP
[75308.744391] Modules linked in: vfat fat isofs ip_tables x_tables pcnet32 8139cp ne2k_pci 8390 e1000 acpiphp
[75308.744391]
[75308.744391] Pid: 6505, comm: init Not tainted 3.0.0-12-virtual #20-Ubuntu Bochs Bochs
[75308.744391] EIP: 0060:[<c0122ac3>] EFLAGS: 00000246 CPU: 0
[75308.744391] EIP is at native_stop_other_cpus.part.3+0x73/0x80
[75308.744391] EAX: 00000246 EBX: 00000246 ECX: fffff000 EDX: 000000ff
[75308.744391] ESI: c08f7238 EDI: 00000001 EBP: debd5e5c ESP: debd5e50
[75308.744391] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[75308.744391] Process init (pid: 6505, ti=debd4000 task=de993300 task.ti=debd4000)
[75308.744391] Stack:
[75308.744391] 00000000 01234567 28121969 debd5e64 c0122ae7 debd5e6c c012227c debd5e78
[75308.744391] c0122207 c07d29b9 debd5e80 c01224ce debd5e94 c0165778 c07e0493 fee1dead
[75308.744391] 00000000 debd5fac c01658f1 00000000 00000000 00000000 00000000 00000000
[75308.744391] Call Trace:
[75308.744391] [<c0122ae7>] native_stop_other_cpus+0x17/0x20
[75308.744391] [<c012227c>] native_machine_shutdown+0x5c/0x90
[75308.744391] [<c0122207>] native_machine_restart+0x27/0x40
[75308.744391] [<c01224ce>] machine_restart+0xe/0x10
[75308.744391] [<c0165778>] kernel_restart+0x38/0x50
[75308.744391] [<c01658f1>] sys_reboot+0x141/0x1d0
[75308.744391] [<c0140730>] ? finish_task_switch+0x40/0xc0
[75308.744391] [<c065aa94>] syscall_call+0x7/0xb
[75308.744391] Code: 00 00 e8 c1 f9 26 00 0f b6 06 f3 0f b8 c0 90 83 f8 01 77 dc 9c 58 8d 74 26 00 89 c3 fa 90 8d 74 26 00 e8 f1 10 00 00 89 d8 50 9d <8d> 74 26 00 5b 5e 5f 5d c3 8d 74 26 00 55 89 e5 3e 8d 74 26 00
[75308.744391] EIP: [<c0122ac3>] native_stop_other_cpus.part.3+0x73/0x80 SS:ESP 0068:debd5e50
[75308.744391] ---[ end trace 7d517b9e34687b49 ]---

thank you

Jason (zzs) said : #4

It looks like you VM booted and restarted, no sure what was happening.
can you post the output of
nova console-log <your server name or ID>

adair (787590563-o) said : #5

my nova console-log cloud01:
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 3.0.0-12-virtual (buildd@vernadsky) (gcc version 4.6.1 (Ubuntu/Linaro 4.6.1-9ubuntu3) ) #20-Ubuntu SMP Fri Oct 7 18:25:20 UTC 2011 (Ubuntu 3.0.0-12.20-virtual 3.0.4)
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 0.000000] NSC Geode by NSC
[ 0.000000] Cyrix CyrixInstead
[ 0.000000] Centaur CentaurHauls
[ 0.000000] Transmeta GenuineTMx86
[ 0.000000] Transmeta TransmetaCPU
[ 0.000000] UMC UMC UMC UMC
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009dc00 (usable)
[ 0.000000] BIOS-e820: 000000000009dc00 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000001fffd000 (usable)
[ 0.000000] BIOS-e820: 000000001fffd000 - 0000000020000000 (reserved)
[ 0.000000] BIOS-e820: 00000000fffc0000 - 0000000100000000 (reserved)
[ 0.000000] Notice: NX (Execute Disable) protection missing in CPU!
[ 0.000000] NX (Execute Disable) protection: approximated by x86 segment limits
[ 0.000000] DMI 2.4 present.
[ 0.000000] last_pfn = 0x1fffd max_arch_pfn = 0x1000000
[ 0.000000] found SMP MP-table at [c00fdaf0] fdaf0
[ 0.000000] init_memory_mapping: 0000000000000000-000000001fffd000
[ 0.000000] RAMDISK: 1fe37000 - 1ffed000
[ 0.000000] ACPI: RSDP 000fd990 00014 (v00 BOCHS )
[ 0.000000] ACPI: RSDT 1fffd7b0 00034 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: FACP 1fffff80 00074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.000000] ACPI: DSDT 1fffd9b0 02589 (v01 BXPC BXDSDT 00000001 INTL 20100528)
[ 0.000000] ACPI: FACS 1fffff40 00040
[ 0.000000] ACPI: SSDT 1fffd910 0009E (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001)
[ 0.000000] ACPI: APIC 1fffd830 00072 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.000000] ACPI: HPET 1fffd7f0 00038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.000000] 0MB HIGHMEM available.
[ 0.000000] 511MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 1fffd000
[ 0.000000] low ram: 0 - 1fffd000
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000010 -> 0x00001000
[ 0.000000] Normal 0x00001000 -> 0x0001fffd
[ 0.000000] HighMem empty
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[2] active PFN ranges
[ 0.000000] 0: 0x00000010 -> 0x0000009d
[ 0.000000] 0: 0x00000100 -> 0x0001fffd
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0xb008
[ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[ 0.000000] ACPI: IOAPIC (id[0x01] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 1, version 17, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] SMP: Allowing 1 CPUs, 0 hotplug CPUs
[ 0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
[ 0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[ 0.000000] Allocating PCI resources starting at 20000000 (gap: 20000000:dffc0000)
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 13 pages/cpu @df800000 s29952 r0 d23296 u2097152
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 129930
[ 0.000000] Kernel command line: LABEL=cirros-rootfs ro console=tty0 console=ttyS0 console=hvc0
[ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Initializing CPU#0
[ 0.000000] allocated 2096848 bytes of page_cgroup
[ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
[ 0.000000] Initializing HighMem for node 0 (00000000:00000000)
[ 0.000000] Memory: 505624k/524276k available (5515k kernel code, 18192k reserved, 2655k data, 720k init, 0k highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xfff16000 - 0xfffff000 ( 932 kB)
[ 0.000000] pkmap : 0xffc00000 - 0xffe00000 (2048 kB)
[ 0.000000] vmalloc : 0xe07fd000 - 0xffbfe000 ( 500 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xdfffd000 ( 511 MB)
[ 0.000000] .init : 0xc08fb000 - 0xc09af000 ( 720 kB)
[ 0.000000] .data : 0xc0662c3c - 0xc08fab00 (2655 kB)
[ 0.000000] .text : 0xc0100000 - 0xc0662c3c (5515 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] SLUB: Genslabs=15, HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU dyntick-idle grace-period acceleration is enabled.
[ 0.000000] NR_IRQS:2304 nr_irqs:256 16
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] console [ttyS0] enabled
[ 0.000000] Fast TSC calibration using PIT
[ 0.000000] Detected 1994.705 MHz processor.
[ 0.012626] Calibrating delay loop (skipped), value calculated using timer frequency.. 3989.41 BogoMIPS (lpj=7978820)
[ 0.016303] pid_max: default: 32768 minimum: 301
[ 0.017924] Security Framework initialized
[ 0.021506] AppArmor: AppArmor initialized
[ 0.021915] Yama: becoming mindful.
[ 0.026818] Mount-cache hash table entries: 512
[ 0.040558] Initializing cgroup subsys cpuacct
[ 0.041266] Initializing cgroup subsys memory
[ 0.042387] Initializing cgroup subsys devices
[ 0.042866] Initializing cgroup subsys freezer
[ 0.043310] Initializing cgroup subsys net_cls
[ 0.043767] Initializing cgroup subsys blkio
[ 0.044181] Initializing cgroup subsys perf_event
[ 0.061073] SMP alternatives: switching to UP code
[ 0.185095] Freeing SMP alternatives: 24k freed
[ 0.187632] ACPI: Core revision 20110413
[ 0.248311] ftrace: allocating 25648 entries in 51 pages
[ 0.280716] Enabling APIC mode: Flat. Using 1 I/O APICs
[ 0.286665] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.327376] CPU0: Intel QEMU Virtual CPU version 1.0 stepping 03
[ 0.332020] Performance Events: Broken PMU hardware detected, using software events only.
[ 0.344523] Brought up 1 CPUs
[ 0.344913] Total of 1 processors activated (3989.41 BogoMIPS).
[ 0.355305] devtmpfs: initialized
[ 0.393213] print_constraints: dummy:
[ 0.394468] Time: 8:09:28 Date: 03/01/13
[ 0.397199] NET: Registered protocol family 16
[ 0.404968] EISA bus registered
[ 0.405691] ACPI: bus type pci registered
[ 0.410374] PCI: PCI BIOS revision 2.10 entry at 0xfc89d, last bus=0
[ 0.411034] PCI: Using configuration type 1 for base access
[ 0.438858] bio: create slab <bio-0> at 0
[ 0.516402] ACPI: Interpreter enabled
[ 0.516755] ACPI: (supports S0 S3 S4 S5)
[ 0.518425] ACPI: Using IOAPIC for interrupt routing
[ 0.610966] ACPI: No dock devices found.
[ 0.611438] HEST: Table not found.
[ 0.612176] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[ 0.616926] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.627359] pci 0000:00:01.3: quirk: [io 0xb000-0xb03f] claimed by PIIX4 ACPI
[ 0.628090] pci 0000:00:01.3: quirk: [io 0xb100-0xb10f] claimed by PIIX4 SMB
[ 0.648885] pci0000:00: Unable to request _OSC control (_OSC support mask: 0x1e)
[ 0.770356] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[ 0.772797] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[ 0.774265] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[ 0.776444] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[ 0.778425] ACPI: PCI Interrupt Link [LNKS] (IRQs 9) *0
[ 0.787575] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.788166] vgaarb: loaded
[ 0.788452] vgaarb: bridge control possible 0000:00:02.0
[ 0.795748] SCSI subsystem initialized
[ 0.799203] usbcore: registered new interface driver usbfs
[ 0.800694] usbcore: registered new interface driver hub
[ 0.801684] usbcore: registered new device driver usb
[ 0.805419] PCI: Using ACPI for IRQ routing
[ 0.817108] NetLabel: Initializing
[ 0.817407] NetLabel: domain hash size = 128
[ 0.817730] NetLabel: protocols = UNLABELED CIPSOv4
[ 0.819570] NetLabel: unlabeled traffic allowed by default
[ 0.974177] AppArmor: AppArmor Filesystem Enabled
[ 0.976349] pnp: PnP ACPI init
[ 0.976865] ACPI: bus type pnp registered
[ 0.996202] pnp: PnP ACPI: found 8 devices
[ 0.996684] ACPI: ACPI bus type pnp unregistered
[ 0.997137] PnPBIOS: Disabled by ACPI PNP
[ 1.068669] Switching to clocksource acpi_pm
[ 1.071938] Switched to NOHz mode on CPU #0
[ 1.074655] NET: Registered protocol family 2
[ 1.079524] IP route cache hash table entries: 4096 (order: 2, 16384 bytes)
[ 1.087077] TCP established hash table entries: 16384 (order: 5, 131072 bytes)
[ 1.088674] TCP bind hash table entries: 16384 (order: 5, 131072 bytes)
[ 1.090067] TCP: Hash tables configured (established 16384 bind 16384)
[ 1.090761] TCP reno registered
[ 1.091242] UDP hash table entries: 256 (order: 1, 8192 bytes)
[ 1.092089] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[ 1.095123] NET: Registered protocol family 1
[ 1.095905] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[ 1.096717] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[ 1.097542] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[ 1.113455] Trying to unpack rootfs image as initramfs...
[ 1.126601] audit: initializing netlink socket (disabled)
[ 1.127948] type=2000 audit(1362125369.124:1): initialized
[ 1.458213] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 1.530396] VFS: Disk quotas dquot_6.5.2
[ 1.532947] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 1.574772] fuse init (API version 7.16)
[ 1.578025] msgmni has been set to 987
[ 1.609672] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 1.611467] io scheduler noop registered
[ 1.611929] io scheduler deadline registered
[ 1.612883] io scheduler cfq registered (default)
[ 1.621206] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 1.623302] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 1.636450] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
[ 1.638026] ACPI: Power Button [PWRF]
[ 1.692953] ERST: Table is not found!
[ 1.700243] isapnp: Scanning for PnP cards...
[ 1.711434] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[ 1.761858] virtio-pci 0000:00:03.0: PCI INT A -> Link[LNKC] -> GSI 11 (level, high) -> IRQ 11
[ 1.770933] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10
[ 1.771412] virtio-pci 0000:00:04.0: PCI INT A -> Link[LNKD] -> GSI 10 (level, high) -> IRQ 10
[ 1.774132] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
[ 1.774590] virtio-pci 0000:00:05.0: PCI INT A -> Link[LNKA] -> GSI 10 (level, high) -> IRQ 10
[ 1.781635] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
[ 1.806787] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 1.857084] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 1.988812] 00:05: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 2.080189] 00:06: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 2.108916] Refined TSC clocksource calibration: 1995.164 MHz.
[ 2.109698] Switching to clocksource tsc
[ 2.161977] hpet_acpi_add: no address or irqs in _CRS
[ 2.162720] Linux agpgart interface v0.103
[ 2.219806] brd: module loaded
[ 2.287028] loop: module loaded
[ 2.359037] vda: vda1
[ 2.452545] scsi0 : ata_piix
[ 2.454936] scsi1 : ata_piix
[ 2.456479] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0a0 irq 14
[ 2.457044] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0a8 irq 15
[ 2.484399] Fixed MDIO Bus: probed
[ 2.489192] PPP generic driver version 2.4.2
[ 2.490523] tun: Universal TUN/TAP device driver, 1.6
[ 2.490908] tun: (C) 1999-2004 Max Krasnyansky <email address hidden>
[ 2.496627] Freeing initrd memory: 1752k freed
[ 2.513224] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 2.514071] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 2.514910] uhci_hcd: USB Universal Host Controller Interface driver
[ 2.515812] uhci_hcd 0000:00:01.2: PCI INT D -> Link[LNKD] -> GSI 10 (level, high) -> IRQ 10
[ 2.561439] uhci_hcd 0000:00:01.2: UHCI Host Controller
[ 2.563276] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
[ 2.565212] uhci_hcd 0000:00:01.2: irq 10, io base 0x0000c040
[ 2.578852] hub 1-0:1.0: USB hub found
[ 2.579905] hub 1-0:1.0: 2 ports detected
[ 2.586601] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 2.591691] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 2.592930] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 2.596983] mousedev: PS/2 mouse device common for all mice
[ 2.603616] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
[ 2.605554] rtc_cmos 00:01: RTC can wake from S4
[ 2.655110] isapnp: No Plug & Play device found
[ 2.662980] rtc_cmos 00:01: rtc core: registered rtc_cmos as rtc0
[ 2.664500] rtc0: alarms up to one day, 114 bytes nvram
[ 2.666719] device-mapper: uevent: version 1.0.3
[ 2.669357] device-mapper: ioctl: 4.20.0-ioctl (2011-02-02) initialised: <email address hidden>
[ 2.670961] EISA: Probing bus 0 at eisa.0
[ 2.672614] EISA: Detected 0 cards.
[ 2.674385] cpufreq-nforce2: No nForce2 chipset.
[ 2.675017] cpuidle: using governor ladder
[ 2.675600] cpuidle: using governor menu
[ 2.675932] EFI Variables Facility v0.08 2004-May-17
[ 2.683027] TCP cubic registered
[ 2.686990] NET: Registered protocol family 10
[ 2.709808] NET: Registered protocol family 17
[ 2.710872] Registering the dns_resolver key type
[ 2.713558] Using IPI No-Shortcut mode
[ 2.716579] registered taskstats version 1
[ 2.892609] usb 1-1: new full speed USB device number 2 using uhci_hcd
[ 2.963540] Magic number: 5:517:168
[ 2.964521] acpi device:31: hash matches
[ 2.965961] rtc_cmos 00:01: setting system clock to 2013-03-01 08:09:31 UTC (1362125371)
[ 2.969302] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[ 2.969852] EDD information not available.
[ 2.977218] Freeing unused kernel memory: 720k freed
[ 3.009107] Write protecting the kernel text: 5516k
[ 3.010508] Write protecting the kernel read-only data: 2236k

info: initramfs: up at 3.19
NOCHANGE: partition 1 is size 64260. it cannot be grown
info: initramfs loading root from /dev/vda1
info: /etc/init.d/rc.sysinit: up at 4.57
[ 4.616810] EXT3-fs (vda1): warning: checktime reached, running e2fsck is recommended
Starting logging: OK
Initializing random number generator... done.
Starting network...
udhcpc (v1.18.5) started
Sending discover...
Sending select for 10.0.0.2...
Lease of 10.0.0.2 obtained, lease time 120
deleting routers
route: SIOCDELRT: No such process
adding dns 10.0.0.1
cloud-setup: checking http://169.254.169.254/2009-04-04/meta-data/instance-id
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 1/30: up 7.49. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 2/30: up 197.87. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 3/30: up 388.34. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 4/30: up 578.81. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 5/30: up 769.28. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 6/30: up 959.74. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 7/30: up 1150.20. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 8/30: up 1340.67. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 9/30: up 1531.15. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 10/30: up 1721.62. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 11/30: up 1912.06. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 12/30: up 2102.55. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 13/30: up 2292.96. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 14/30: up 2483.44. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 15/30: up 2673.91. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 16/30: up 2864.37. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 17/30: up 3054.84. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 18/30: up 3245.30. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 19/30: up 3435.78. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 20/30: up 3626.22. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 21/30: up 3816.69. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 22/30: up 4007.17. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 23/30: up 4197.63. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 24/30: up 4388.10. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 25/30: up 4578.56. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 26/30: up 4769.02. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 27/30: up 4959.48. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 28/30: up 5149.95. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 29/30: up 5340.43. request failed
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-setup: failed 30/30: up 5530.89. request failed
cloud-setup: after 30 fails, debugging
cloud-setup: running debug (30 tries reached)
############ debug start ##############
### /etc/rc.d/init.d/sshd start
/etc/rc3.d/S45-cloud-setup: line 66: /etc/rc.d/init.d/sshd: not found
### ifconfig -a
eth0 Link encap:Ethernet HWaddr FA:16:3E:34:2A:C4
          inet addr:10.0.0.2 Bcast:10.0.0.31 Mask:255.255.255.224
          inet6 addr: fe80::f816:3eff:fe34:2ac4/64 Scope:Link
          UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1
          RX packets:6312 errors:0 dropped:686 overruns:0 frame:0
          TX packets:581 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:1000
          RX bytes:693470 (677.2 KiB) TX bytes:91350 (89.2 KiB)

lo Link encap:Local Loopback
          inet addr:127.0.0.1 Mask:255.0.0.0
          inet6 addr: ::1/128 Scope:Host
          UP LOOPBACK RUNNING MTU:16436 Metric:1
          RX packets:0 errors:0 dropped:0 overruns:0 frame:0
          TX packets:0 errors:0 dropped:0 overruns:0 carrier:0
          collisions:0 txqueuelen:0
          RX bytes:0 (0.0 B) TX bytes:0 (0.0 B)

### route -n
Kernel IP routing table
Destination Gateway Genmask Flags Metric Ref Use Iface
0.0.0.0 10.0.0.1 0.0.0.0 UG 0 0 0 eth0
10.0.0.0 0.0.0.0 255.255.255.224 U 0 0 0 eth0
### cat /etc/resolv.conf
search novalocal
nameserver 10.0.0.1
### ping -c 5 10.0.0.1
PING 10.0.0.1 (10.0.0.1): 56 data bytes
64 bytes from 10.0.0.1: seq=0 ttl=64 time=6.463 ms
64 bytes from 10.0.0.1: seq=1 ttl=64 time=1.156 ms
64 bytes from 10.0.0.1: seq=2 ttl=64 time=0.901 ms
64 bytes from 10.0.0.1: seq=3 ttl=64 time=0.757 ms
64 bytes from 10.0.0.1: seq=4 ttl=64 time=0.873 ms

--- 10.0.0.1 ping statistics ---
5 packets transmitted, 5 packets received, 0% packet loss
round-trip min/avg/max = 0.757/2.030/6.463 ms
### pinging nameservers
#### ping -c 5 10.0.0.1
PING 10.0.0.1 (10.0.0.1): 56 data bytes
64 bytes from 10.0.0.1: seq=0 ttl=64 time=0.978 ms
64 bytes from 10.0.0.1: seq=1 ttl=64 time=0.974 ms
64 bytes from 10.0.0.1: seq=2 ttl=64 time=0.746 ms
64 bytes from 10.0.0.1: seq=3 ttl=64 time=0.773 ms
64 bytes from 10.0.0.1: seq=4 ttl=64 time=0.838 ms

--- 10.0.0.1 ping statistics ---
5 packets transmitted, 5 packets received, 0% packet loss
round-trip min/avg/max = 0.746/0.861/0.978 ms
### uname -a
Linux cirros 3.0.0-12-virtual #20-Ubuntu SMP Fri Oct 7 18:25:20 UTC 2011 i686 GNU/Linux
### lsmod
Module Size Used by Not tainted
vfat 17308 0
fat 55577 1 vfat
isofs 39549 0
ip_tables 18106 0
x_tables 21975 1 ip_tables
pcnet32 36981 0
8139cp 26762 0
ne2k_pci 13389 0
8390 18400 1 ne2k_pci
e1000 101773 0
acpiphp 23408 0
### dmesg | tail
[ 5.823209] acpiphp: Slot [29] registered
[ 5.823742] acpiphp: Slot [30] registered
[ 5.827077] acpiphp: Slot [31] registered
[ 5.913550] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
[ 5.913615] e1000: Copyright (c) 1999-2006 Intel Corporation.
[ 5.966076] ne2k-pci.c:v1.03 9/22/2003 D. Becker/P. Gortmaker
[ 6.003415] 8139cp: 8139cp: 10/100 PCI Ethernet driver v1.3 (Mar 22, 2004)
[ 6.046724] pcnet32: pcnet32.c:v1.35 21.Apr.2008 <email address hidden>
[ 6.102799] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 7.558554] eth0: IPv6 duplicate address fe80::f816:3eff:fe34:2ac4 detected!
### tail -n 25 /var/log/messages
Mar 1 01:09:34 cirros kern.info kernel: [ 5.797863] acpiphp: Slot [14] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.798378] acpiphp: Slot [15] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.798871] acpiphp: Slot [16] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.799385] acpiphp: Slot [17] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.799881] acpiphp: Slot [18] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.811341] acpiphp: Slot [19] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.811893] acpiphp: Slot [20] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.814565] acpiphp: Slot [21] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.815000] acpiphp: Slot [22] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.815595] acpiphp: Slot [23] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.816086] acpiphp: Slot [24] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.819369] acpiphp: Slot [25] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.819891] acpiphp: Slot [26] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.822095] acpiphp: Slot [27] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.822702] acpiphp: Slot [28] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.823209] acpiphp: Slot [29] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.823742] acpiphp: Slot [30] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.827077] acpiphp: Slot [31] registered
Mar 1 01:09:34 cirros kern.info kernel: [ 5.913550] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI
Mar 1 01:09:34 cirros kern.info kernel: [ 5.913615] e1000: Copyright (c) 1999-2006 Intel Corporation.
Mar 1 01:09:34 cirros kern.info kernel: [ 5.966076] ne2k-pci.c:v1.03 9/22/2003 D. Becker/P. Gortmaker
Mar 1 01:09:34 cirros kern.info kernel: [ 6.003415] 8139cp: 8139cp: 10/100 PCI Ethernet driver v1.3 (Mar 22, 2004)
Mar 1 01:09:34 cirros kern.info kernel: [ 6.046724] pcnet32: pcnet32.c:v1.35 21.Apr.2008 <email address hidden>
Mar 1 01:09:34 cirros kern.info kernel: [ 6.102799] ip_tables: (C) 2000-2006 Netfilter Core Team
Mar 1 01:09:36 cirros kern.info kernel: [ 7.558554] eth0: IPv6 duplicate address fe80::f816:3eff:fe34:2ac4 detected!
############ debug end ##############
cloud-setup: failed to read iid from metadata. tried 30
WARN: /etc/rc3.d/S45-cloud-setup failed
Starting dropbear sshd: generating rsa key... generating dsa key... OK
===== cloud-final: system completely up in 5740.05 seconds ====
wget: can't connect to remote host (169.254.169.254): Connection timed out
wget: can't connect to remote host (169.254.169.254): Connection timed out
wget: can't connect to remote host (169.254.169.254): Connection timed out
  instance-id:
  public-ipv4:
  local-ipv4 :
wget: can't connect to remote host (169.254.169.254): Connection timed out
cloud-userdata: failed to read instance id
WARN: /etc/rc3.d/S99-cloud-userdata failed
  ____ ____ ____
 / __/ __ ____ ____ / __ \/ __/
/ /__ / // __// __// /_/ /\ \
\___//_//_/ /_/ \____/___/
 http://launchpad.net/cirros

login as 'cirros' user. default password: 'cubswin:)'. use 'sudo' for root.

cirros login: [75308.741486] Restarting system.
[75308.743475] machine restart
[75308.744391] general protection fault: fffa [#1] SMP
[75308.744391] Modules linked in: vfat fat isofs ip_tables x_tables pcnet32 8139cp ne2k_pci 8390 e1000 acpiphp
[75308.744391]
[75308.744391] Pid: 6505, comm: init Not tainted 3.0.0-12-virtual #20-Ubuntu Bochs Bochs
[75308.744391] EIP: 0060:[<c0122ac3>] EFLAGS: 00000246 CPU: 0
[75308.744391] EIP is at native_stop_other_cpus.part.3+0x73/0x80
[75308.744391] EAX: 00000246 EBX: 00000246 ECX: fffff000 EDX: 000000ff
[75308.744391] ESI: c08f7238 EDI: 00000001 EBP: debd5e5c ESP: debd5e50
[75308.744391] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[75308.744391] Process init (pid: 6505, ti=debd4000 task=de993300 task.ti=debd4000)
[75308.744391] Stack:
[75308.744391] 00000000 01234567 28121969 debd5e64 c0122ae7 debd5e6c c012227c debd5e78
[75308.744391] c0122207 c07d29b9 debd5e80 c01224ce debd5e94 c0165778 c07e0493 fee1dead
[75308.744391] 00000000 debd5fac c01658f1 00000000 00000000 00000000 00000000 00000000
[75308.744391] Call Trace:
[75308.744391] [<c0122ae7>] native_stop_other_cpus+0x17/0x20
[75308.744391] [<c012227c>] native_machine_shutdown+0x5c/0x90
[75308.744391] [<c0122207>] native_machine_restart+0x27/0x40
[75308.744391] [<c01224ce>] machine_restart+0xe/0x10
[75308.744391] [<c0165778>] kernel_restart+0x38/0x50
[75308.744391] [<c01658f1>] sys_reboot+0x141/0x1d0
[75308.744391] [<c0140730>] ? finish_task_switch+0x40/0xc0
[75308.744391] [<c065aa94>] syscall_call+0x7/0xb
[75308.744391] Code: 00 00 e8 c1 f9 26 00 0f b6 06 f3 0f b8 c0 90 83 f8 01 77 dc 9c 58 8d 74 26 00 89 c3 fa 90 8d 74 26 00 e8 f1 10 00 00 89 d8 50 9d <8d> 74 26 00 5b 5e 5f 5d c3 8d 74 26 00 55 89 e5 3e 8d 74 26 00
[75308.744391] EIP: [<c0122ac3>] native_stop_other_cpus.part.3+0x73/0x80 SS:ESP 0068:debd5e50
[75308.744391] ---[ end trace 7d517b9e34687b49 ]---

Khanh Nguyen (ndquockhanh) said : #6

From your ouput , I see that vm couldn't connect to metadata service to retrieve instance-specific data.

To allow instances to reach the metadata service, the nova-network service will configure iptables to NAT port 80 of the 169.254.169.254 address to the IP address specified in metadata_host (default $my_ip, which is the IP address of the nova-network service) and port specified in metadata_port (default 8775) in /etc/nova/nova.conf.

check with iptables -t nat -S and make sure the presence of the line below

-A nova-network-PREROUTING -d 169.254.169.254/32 -p tcp -m tcp --dport 80 -j DNAT --to-destination <metadata_host_ip>:8775

Can you help with this problem?

Provide an answer of your own, or ask adair for more information if necessary.

To post a message you must log in.