Skip to content

Instantly share code, notes, and snippets.

@henrysher
Created June 1, 2015 06:22
Show Gist options
  • Save henrysher/f46d3d6830e711ed086f to your computer and use it in GitHub Desktop.
Save henrysher/f46d3d6830e711ed086f to your computer and use it in GitHub Desktop.
[HYPER INFO 0531 20:54:41 26892 hyperd.go] [:50] The config file is
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:201] The config: kernel=/var/lib/hyper/kernel, initrd=/var/lib/hyper/hyper-initrd.img
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:204] The config: bridge=, ip=
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:207] The config: bios=/var/lib/hyper/bios-qboot.bin, cbfs=/var/lib/hyper/cbfs-qboot.rom
[HYPER INFO 0531 20:54:41 26892 network.go] [:191] bridge exist
[HYPER INFO 0531 20:54:41 26892 iptables.go] [:286] /sbin/iptables, [--wait -t nat -C POSTROUTING -s 192.168.123.1/24 ! -o hyper0 -j MASQUERADE]
[HYPER INFO 0531 20:54:41 26892 iptables.go] [:286] /sbin/iptables, [--wait -t filter -C FORWARD -i hyper0 ! -o hyper0 -j ACCEPT]
[HYPER INFO 0531 20:54:41 26892 iptables.go] [:286] /sbin/iptables, [--wait -t filter -C FORWARD -o hyper0 -m conntrack --ctstate RELATED,ESTABLISHED -j ACCEPT]
[HYPER INFO 0531 20:54:41 26892 docker.go] [:173] Finish the client request
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= attach
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= tty
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= create
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= podRm
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= podRun
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= podStop
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= list
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= podStart
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= version
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= podCreate
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= serveapi
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= acceptconnections
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= exec
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= info
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= pull
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= podInfo
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= vmCreate
[HYPER INFO 0531 20:54:41 26892 daemon.go] [:105] Engine Register: name= vmKill
[HYPER INFO 0531 20:54:41 26892 hyperd.go] [:76] Hyper daemon: 0.1 0
[HYPER INFO 0531 20:54:41 26892 job.go] [:78] +job acceptconnections()
[HYPER INFO 0531 20:54:41 26892 job.go] [:84] -job acceptconnections() OK
[HYPER INFO 0531 20:54:41 26892 hyperd.go] [:108] Daemon has completed initialization
[HYPER INFO 0531 20:54:41 26892 job.go] [:78] +job serveapi(unix:///var/run/hyper.sock)
[HYPER INFO 0531 20:54:41 26892 server.go] [:841] Listening for HTTP on unix (/var/run/hyper.sock)
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering OPTIONS,
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering GET, /info
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering GET, /pod/info
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering GET, /version
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering GET, /list
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /exec
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /container/create
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /image/create
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /pod/create
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /pod/start
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /pod/run
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /pod/stop
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /vm/create
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /pod/remove
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /vm/kill
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /attach
[HYPER INFO 0531 20:54:41 26892 server.go] [:704] Registering POST, /tty/resize
[HYPER INFO 0531 20:54:51 26892 server.go] [:604] Calling POST /pod/run
[HYPER INFO 0531 20:54:51 26892 job.go] [:78] +job podRun({
"name": "myweb",
"containers" : [{
"image": "httpd",
"ports": [{
"containerPort": 80,
"hostPort": 8081
}]
}],
"resource": {
"vcpu": 1,
"memory": 512
}
}
)
[HYPER INFO 0531 20:54:51 26892 pod.go] [:130] {
"name": "myweb",
"containers" : [{
"image": "httpd",
"ports": [{
"containerPort": 80,
"hostPort": 8081
}]
}],
"resource": {
"vcpu": 1,
"memory": 512
}
}
[HYPER INFO 0531 20:54:51 26892 pod.go] [:279] The config: kernel=/var/lib/hyper/kernel, initrd=/var/lib/hyper/hyper-initrd.img
[HYPER INFO 0531 20:54:51 26892 pod.go] [:186] leveldb: not found
[HYPER INFO 0531 20:54:51 26892 pod.go] [:194] Process the Containers section in POD SPEC
[HYPER INFO 0531 20:54:51 26892 create.go] [:108] The Repository is httpd, and the tag is latest
[HYPER INFO 0531 20:54:51 26892 context.go] [:254] kvm not exist change to no kvm mode
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:228] cmdline arguments: -machine pc-i440fx-2.0,usb=off -cpu core2duo -drive if=pflash,file=/var/lib/hyper/bios-qboot.bin,readonly=on -drive if=pflash,file=/var/lib/hyper/cbfs-qboot.rom,readonly=on -realtime mlock=off -no-user-config -nodefaults -no-hpet -rtc base=utc,driftfix=slew -no-reboot -display none -boot strict=on -m 512 -smp 1 -qmp unix:/var/run/hyper/vm-HeYMmNmHhU/qmp.sock,server,nowait -serial unix:/var/run/hyper/vm-HeYMmNmHhU/console.sock,server,nowait -device virtio-serial-pci,id=virtio-serial0,bus=pci.0,addr=0x2 -device virtio-scsi-pci,id=scsi0,bus=pci.0,addr=0x3 -chardev socket,id=charch0,path=/var/run/hyper/vm-HeYMmNmHhU/hyper.sock,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=1,chardev=charch0,id=channel0,name=sh.hyper.channel.0 -chardev socket,id=charch1,path=/var/run/hyper/vm-HeYMmNmHhU/tty.sock,server,nowait -device virtserialport,bus=virtio-serial0.0,nr=2,chardev=charch1,id=channel1,name=sh.hyper.channel.1 -fsdev local,id=virtio9p,path=/var/run/hyper/vm-HeYMmNmHhU/share_dir,security_model=none -device virtio-9p-pci,fsdev=virtio9p,mount_tag=share_dir
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:111] I am the parent, exit, ps: child 26913
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:159] qemu daemon pid 26913.
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:142] collect child 26912
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:260] starting daemon with pid: 26913
[HYPER INFO 0531 20:54:51 26892 init_comm.go] [:77] Wating for init messages...
[HYPER INFO 0531 20:54:51 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:54:51 26892 tty.go] [:126] tty socket connected
[HYPER INFO 0531 20:54:51 26892 tty.go] [:69] tty: trying to read 12 bytes
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:163] connected to /var/run/hyper/vm-HeYMmNmHhU/qmp.sock
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:169] begin qmp init...
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:38] connected to /var/run/hyper/vm-HeYMmNmHhU/console.sock
[HYPER INFO 0531 20:54:51 26892 qemu_process.go] [:45] connected /var/run/hyper/vm-HeYMmNmHhU/console.sock as telnet mode.
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:178] got qmp welcome, now sending command qmp_capabilities
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:193] waiting for response
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:99] got a message {"return": {}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:202] got for response
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:205] QMP connection initialized
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:341] QMP initialzed, go into main QMP loop
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:133] Begin receive QMP message
[HYPER INFO 0531 20:54:51 26892 docker.go] [:173] Finish the client request
[HYPER INFO 0531 20:54:51 26892 create.go] [:110] The returned status code is 201!
[HYPER INFO 0531 20:54:51 26892 container.go] [:62] ready to get the container(2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8) info
[HYPER INFO 0531 20:54:51 26892 docker.go] [:173] Finish the client request
[HYPER INFO 0531 20:54:51 26892 aufs.go] [:228] Ready to unmount the target : /var/run/hyper/docker-aufs-union097114522
[HYPER INFO 0531 20:54:51 26892 pod.go] [:436] Parsing envs for container 0: 4 Evs
[HYPER INFO 0531 20:54:51 26892 pod.go] [:437] The fs type is dir
[HYPER INFO 0531 20:54:51 26892 pod.go] [:438] WorkingDir is /usr/local/apache2
[HYPER INFO 0531 20:54:51 26892 pod.go] [:439] Image is /2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs
[HYPER INFO 0531 20:54:51 26892 pod.go] [:450] Container Info is
&{2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8 /2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs dir /usr/local/apache2 [] [httpd-foreground] map[PATH:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin HTTPD_PREFIX:/usr/local/apache2 HTTPD_VERSION:2.4.12 HTTPD_BZ2_URL:https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2]}
[HYPER INFO 0531 20:54:51 26892 pod.go] [:452] container 0 created 2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8, workdir /usr/local/apache2, env: map[PATH:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin HTTPD_PREFIX:/usr/local/apache2 HTTPD_VERSION:2.4.12 HTTPD_BZ2_URL:https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2]
POD id is pod-okluVlSwOh
[HYPER INFO 0531 20:54:51 26892 qemu.go] [:27] main event loop got message 20(COMMAND_RUN_POD)
[HYPER INFO 0531 20:54:51 26892 vm_states.go] [:288] got spec, prepare devices
[HYPER INFO 0531 20:54:51 26892 context.go] [:311] #0 Container Info:
[HYPER INFO 0531 20:54:51 26892 context.go] [:314]
{
...| "Id": "2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8",
...| "Rootfs": "",
...| "Image": "/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs",
...| "Fstype": "dir",
...| "Workdir": "/usr/local/apache2",
...| "Entrypoint": null,
...| "Cmd": [
...| "httpd-foreground"
...| ],
...| "Envs": {
...| "HTTPD_BZ2_URL": "https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2",
...| "HTTPD_PREFIX": "/usr/local/apache2",
...| "HTTPD_VERSION": "2.4.12",
...| "PATH": "/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin"
...| }
...|}
[HYPER INFO 0531 20:54:51 26892 vm_states.go] [:51] initial vm spec: {
"hostname": "2swg24sgf5",
"containers": [
{
"id": "2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8",
"rootfs": "",
"image": "/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs",
"workdir": "/usr/local/apache2",
"cmd": [
"httpd-foreground"
],
"envs": [
{
"env": "PATH",
"value": "/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin"
},
{
"env": "HTTPD_PREFIX",
"value": "/usr/local/apache2"
},
{
"env": "HTTPD_VERSION",
"value": "2.4.12"
},
{
"env": "HTTPD_BZ2_URL",
"value": "https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2"
}
],
"restartPolicy": "never"
}
],
"interfaces": null,
"routes": null,
"shareDir": "share_dir"
}
[HYPER INFO 0531 20:54:51 26892 context.go] [:237] VM vm-HeYMmNmHhU: state change from to 'STARTING'
[HYPER INFO 0531 20:54:51 26892 qemu.go] [:27] main event loop got message 12(EVENT_INTERFACE_ADD)
[HYPER INFO 0531 20:54:51 26892 qmp_wrapper.go] [:77] send net to qemu at 20
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:288] got new session
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:217] Begin process command session
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:230] send cmd with scm (24 bytes) (1) {"execute":"getfd","arguments":{"fdname":"fdeth0"}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:99] got a message {"return": {}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:235] sending command (1) {"execute":"netdev_add","arguments":{"fd":"fdeth0","id":"eth0","type":"tap"}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:99] got a message {"return": {}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:235] sending command (1) {"execute":"device_add","arguments":{"addr":"0x5","bus":"pci.0","driver":"virtio-net-pci","id":"eth0","mac":"52:54:7e:de:ea:44","netdev":"eth0"}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:99] got a message {"return": {}}
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:294] session finished, buffer size 1
[HYPER INFO 0531 20:54:51 26892 qmp_handler.go] [:297] success
[HYPER INFO 0531 20:54:51 26892 qemu.go] [:27] main event loop got message 14(EVENT_INTERFACE_INSERTED)
[HYPER INFO 0531 20:54:51 26892 vm_states.go] [:304] device ready, could run pod.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Initializing cgroup subsys cpu
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Linux version 4.0.0-rc5+ (root@thinkdonkey) (gcc version 4.9.2 20150212 (Red Hat 4.9.2-6) (GCC) ) #15 SMP Sat Apr 11 13:03:47 CST 2015
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Command line: console=ttyS0,panic=1
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] e820: BIOS-provided physical RAM map:
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] BIOS-e820: [mem 0x00000000000d0000-0x00000000000effff] ACPI NVS
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] BIOS-e820: [mem 0x0000000000100000-0x000000001fffffff] usable
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] NX (Execute Disable) protection: active
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] DMI not present or invalid.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] e820: last_pfn = 0x20000 max_arch_pfn = 0x400000000
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PAT configuration [0-7]: WB WC UC- UC WB WC UC- UC
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] CPU MTRRs all blank - virtualized system.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] init_memory_mapping: [mem 0x00000000-0x000fffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] init_memory_mapping: [mem 0x1fc00000-0x1fdfffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] init_memory_mapping: [mem 0x00100000-0x1fbfffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] init_memory_mapping: [mem 0x1fe00000-0x1fffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] RAMDISK: [mem 0x1ff09000-0x1fffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Early table checksum verification disabled
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: RSDP 0x00000000000F2AE0 000014 (v00 BOCHS )
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: RSDT 0x00000000000EF828 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: FACP 0x00000000000EEB37 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: DSDT 0x00000000000EE040 000AF7 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: FACS 0x00000000000EE000 000040
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: SSDT 0x00000000000EEBAB 000C05 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: APIC 0x00000000000EF7B0 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] No NUMA configuration found
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Faking a node at [mem 0x0000000000000000-0x000000001fffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] NODE_DATA(0) allocated [mem 0x1fef5000-0x1ff08fff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Zone ranges:
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] DMA32 [mem 0x0000000001000000-0x000000001fffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Normal empty
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Movable zone start for each node
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Early memory node ranges
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] node 0: [mem 0x0000000000001000-0x000000000009efff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] node 0: [mem 0x0000000000100000-0x000000001fffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Initmem setup node 0 [mem 0x0000000000001000-0x000000001fffffff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PM-Timer IO Port: 0x608
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: IOAPIC (id[0x00] address[0xfec00000] gsi_base[0])
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Using ACPI (MADT) for SMP configuration information
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] e820: [mem 0x20000000-0xffffffff] available for PCI devices
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Booting paravirtualized kernel on bare hardware
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] setup_percpu: NR_CPUS:8 nr_cpumask_bits:8 nr_cpu_ids:1 nr_node_ids:1
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PERCPU: Embedded 28 pages/cpu @ffff88001fc00000 s77144 r8192 d29352 u2097152
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Built 1 zonelists in Node order, mobility grouping on. Total pages: 129161
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Policy zone: DMA32
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Kernel command line: console=ttyS0,panic=1
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PID hash table entries: 2048 (order: 2, 16384 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Memory: 508632K/523896K available (3566K kernel code, 437K rwdata, 1160K rodata, 892K init, 680K bss, 15264K reserved, 0K cma-reserved)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Hierarchical RCU implementation.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] RCU dyntick-idle grace-period acceleration is enabled.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] RCU restricting CPUs from NR_CPUS=8 to nr_cpu_ids=1.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] NR_IRQS:4352 nr_irqs:256 16
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Offload RCU callbacks from all CPUs
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Offload RCU callbacks from CPUs: 0.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Console: colour *CGA 80x25
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] console [ttyS0] enabled
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] tsc: Fast TSC calibration using PIT
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] tsc: Detected 2399.990 MHz processor
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Calibrating delay loop (skipped), value calculated using timer frequency.. 4799.98 BogoMIPS (lpj=2399990)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pid_max: default: 32768 minimum: 301
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Core revision 20150204
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: All ACPI Tables successfully acquired
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Freeing SMP alternatives memory: 16K (ffffffff815ed000 - ffffffff815f1000)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] smpboot: CPU0: Intel(R) Core(TM)2 Duo CPU T7700 @ 2.40GHz (fam: 06, model: 0f, stepping: 0b)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Performance Events: unsupported p6 CPU model 15 no PMU driver, software events only.
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] x86: Booted up 1 node, 1 CPUs
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] smpboot: Total of 1 processors activated (4799.98 BogoMIPS)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] devtmpfs: initialized
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] NET: Registered protocol family 16
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: bus type PCI registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PCI: Using configuration type 1 for base access
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Added _OSI(Module Device)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Added _OSI(Processor Device)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Added _OSI(3.0 _SCP Extensions)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Added _OSI(Processor Aggregator Device)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Interpreter enabled
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: (supports S0 S5)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Using IOAPIC for interrupt routing
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [2] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [3] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [4] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [5] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [6] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [7] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [8] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [9] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [10] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [11] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [12] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [13] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [14] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [15] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [16] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [17] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [18] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [19] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [20] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [21] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [22] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [23] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [24] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [25] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [26] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [27] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [28] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [29] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [30] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] acpiphp: Slot [31] registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PCI host bridge to bus 0000:00
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [bus 00-ff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [io 0x0d00-0xadff window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [io 0xae0f-0xaeff window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [io 0xaf20-0xafdf window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [io 0xafe4-0xffff window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci_bus 0000:00: root bus resource [mem 0x20000000-0xfebfffff window]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] ACPI: Enabled 16 GPEs in block 00 to 0F
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] vgaarb: loaded
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] SCSI subsystem initialized
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] PCI: Using ACPI for IRQ routing
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Switched to clocksource refined-jiffies
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pnp: PnP ACPI init
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pnp: PnP ACPI: found 5 devices
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Switched to clocksource acpi_pm
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:05.0: BAR 6: assigned [mem 0x20000000-0x2003ffff pref]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:02.0: BAR 1: assigned [mem 0x20040000-0x20040fff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:03.0: BAR 1: assigned [mem 0x20041000-0x20041fff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:04.0: BAR 1: assigned [mem 0x20042000-0x20042fff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:05.0: BAR 1: assigned [mem 0x20043000-0x20043fff]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:03.0: BAR 0: assigned [io 0x1000-0x103f]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:04.0: BAR 0: assigned [io 0x1040-0x107f]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:02.0: BAR 0: assigned [io 0x1080-0x109f]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:05.0: BAR 0: assigned [io 0x10a0-0x10bf]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.1: BAR 4: assigned [io 0x10c0-0x10cf]
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] NET: Registered protocol family 2
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] TCP: Hash tables configured (established 4096 bind 4096)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] TCP: reno registered
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] UDP hash table entries: 256 (order: 1, 8192 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] NET: Registered protocol family 1
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.0: PIIX3: Enabling Passive Release
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] pci 0000:00:01.0: Activating ISA DMA hang workarounds
[HYPER INFO 0531 20:54:52 26892 qemu_process.go] [:53] [console] Trying to unpack rootfs image as initramfs...
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] Freeing initrd memory: 988K (ffff88001ff09000 - ffff880020000000)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] futex hash table entries: 256 (order: 2, 16384 bytes)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] 9p: Installing v9fs 9p2000 file system support
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] alg: No test for stdrng (krng)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] io scheduler noop registered
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] io scheduler cfq registered (default)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:02.0: virtio_pci: leaving for legacy driver
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver
[HYPER INFO 0531 20:54:53 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] tsc: Refined TSC clocksource calibration: 2399.999 MHz
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] brd: module loaded
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] loop: module loaded
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] scsi host0: Virtio SCSI HBA
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] serio: i8042 KBD port at 0x60,0x64 irq 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] serio: i8042 AUX port at 0x60,0x64 irq 12
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] device-mapper: uevent: version 1.0.3
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] device-mapper: ioctl: 4.30.0-ioctl (2014-12-22) initialised: [email protected]
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] TCP: cubic registered
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] NET: Registered protocol family 17
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 9pnet: Installing 9P2000 support
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] registered taskstats version 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] Freeing unused kernel memory: 892K (ffffffff8150e000 - ffffffff815ed000)
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /dev
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /sys
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /proc
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] uptime 2.36 0.21
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console]
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /dev/pts
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /dev
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] open hyper channel /dev/vport0p1
[HYPER INFO 0531 20:54:54 26892 qmp_handler.go] [:99] got a message {"timestamp": {"seconds": 1433120094, "microseconds": 894748}, "event": "VSERPORT_CHANGE", "data": {"open": true, "id": "channel0"}}
[HYPER INFO 0531 20:54:54 26892 qmp_handler.go] [:103] got event: VSERPORT_CHANGE
[HYPER INFO 0531 20:54:54 26892 qemu.go] [:27] main event loop got message 5(EVENT_QMP_EVENT)
[HYPER WARN 0531 20:54:54 26892 vm_states.go] [:361] got event during pod initiating
[HYPER INFO 0531 20:54:54 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:54:54 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:54:54 26892 init_comm.go] [:87] Get init ready message
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] send ready message
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper send type 8, len 0
[HYPER INFO 0531 20:54:54 26892 qemu.go] [:27] main event loop got message 4(EVENT_INIT_CONNECTED)
[HYPER INFO 0531 20:54:54 26892 vm_states.go] [:318] begin to wait vm commands
[HYPER INFO 0531 20:54:54 26892 init_comm.go] [:179] send command 1 to init, payload: '{"hostname":"2swg24sgf5","containers":[{"id":"2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8","rootfs":"","image":"/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs","workdir":"/usr/local/apache2","cmd":["httpd-foreground"],"envs":[{"env":"PATH","value":"/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin"},{"env":"HTTPD_PREFIX","value":"/usr/local/apache2"},{"env":"HTTPD_VERSION","value":"2.4.12"},{"env":"HTTPD_BZ2_URL","value":"https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2"}],"restartPolicy":"never"}],"interfaces":[{"device":"eth0","ipAddress":"192.168.123.2","netMask":"255.255.255.0"}],"routes":[{"dest":"0.0.0.0/0","gateway":"192.168.123.1","device":"eth0"}],"shareDir":"share_dir"}'.
[HYPER INFO 0531 20:54:54 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:54:54 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:54:54 26892 pod.go] [:609] Get the response from QEMU, VM id is vm-HeYMmNmHhU!
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] channel sh.hyper.channel.1, directory sh.hyper.channel.0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console]
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] open hyper channel /dev/vport0p2
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_init_event hyper channel event 0x60e518, ops 0x60e300, fd 4
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 4, 0x60e300
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_init_event hyper ttyfd event 0x60e4f0, ops 0x60e2e0, fd 5
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 5, 0x60e2e0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_init_event hyper signal event 0x60e4c8, ops 0x60e2c0, fd 3
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 3, 0x60e2c0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] read 783 bytes data, total data 0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] get length 783
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 0 0 0 1 0 0 3 f 7b 22 68 6f 73 74 6e 61 6d 65 22 3a 22 32 73 77 67 32 34 73 67 66 35 22 2c 22 63 6f 6e 74 61 69 6e 65 72 73 22 3a 5b 7b 22 69 64 22 3a 22 32 65 36 30 64 39 31 36 62 62 31 36 36 35 35 37 34 36 38 33 30 64 38 39 65 31 35 30 33 63 37 30 36 37 65 66 31 33 35 36 30 38 38 33 61 36 62 61 36 32 61 37 37 66 31 31 63 34 34 63 61 64 63 38 22 2c 22 72 6f 6f 74 66 73 22 3a 22 22 2c 22 69 6d 61 67 65 22 3a 22 2f 32 65 36 30 64 39 31 36 62 62 31 36 36 35 35 37 34 36 38 33 30 64 38 39 65 31 35 30 33 63 37 30 36 37 65 66 31 33 35 36 30 38 38 33 61 36 62 61 36 32 61 37 37 66 31 31 63 34 34 63 61 64 63 38 2f 72 6f 6f 74 66 73 22 2c 22 77 6f 72 6b 64 69 72 22 3a 22 2f 75 73 72 2f 6c 6f 63 61 6c 2f 61 70 61 63 68 65 32 22 2c 22 63 6d 64 22 3a 5b 22 68 74 74 70 64 2d 66 6f 72 65 67 72 6f 75 6e 64 22 5d 2c 22 65 6e 76 73 22 3a 5b 7b 22 65 6e 76 22 3a 22 50 41 54 48 22 2c 22 76 61 6c 75 65 22 3a 22 2f 75 73 72 2f 6c 6f 63 61 6c 2f 73 62 69 6e 3a 2f 75 73 72 2f 6c 6f 63 61 6c 2f 62 69 6e 3a 2f 75 73 72 2f 73 62 69 6e 3a 2f 75 73 72 2f 62 69 6e 3a 2f 73 62 69 6e 3a 2f 62 69 6e 3a 2f 75 73 72 2f 6c 6f 63 61 6c 2f 61 70 61 63 68 65 32 2f 62 69 6e 22 7d 2c 7b 22 65 6e 76 22 3a 22 48 54 54 50 44 5f 50 52 45 46 49 58 22 2c 22 76 61 6c 75 65 22 3a 22 2f 75 73 72 2f 6c 6f 63 61 6c 2f 61 70 61 63 68 65 32 22 7d 2c 7b 22 65 6e 76 22 3a 22 48 54 54 50 44 5f 56 45 52 53 49 4f 4e 22 2c 22 76 61 6c 75 65 22 3a 22 32 2e 34 2e 31 32 22 7d 2c 7b 22 65 6e 76 22 3a 22 48 54 54 50 44 5f 42 5a 32 5f 55 52 4c 22 2c 22 76 61 6c 75 65 22 3a 22 68 74 74 70 73 3a 2f 2f 77 77 77 2e 61 70 61 63 68 65 2e 6f 72 67 2f 64 69 73 74 2f 68 74 74 70 64 2f 68 74 74 70 64 2d 32 2e 34 2e 31 32 2e 74 61 72 2e 62 7a 32 22 7d 5d 2c 22 72 65 73 74 61 72 74 50 6f 6c 69 63 79 22 3a 22 6e 65 76 65 72 22 7d 5d 2c 22 69 6e 74 65 72 66 61 63 65 73 22 3a 5b 7b 22 64 65 76 69 63 65 22 3a 22 65 74 68 30 22 2c 22 69 70 41 64 64 72 65 73 73 22 3a 22 31 39 32 2e 31 36 38 2e 31 32 33 2e 32 22 2c 22 6e 65 74 4d 61 73 6b 22 3a 22 32 35 35 2e 32 35 35 2e 32 35 35 2e 30 22 7d 5d 2c 22 72 6f 75 74 65 73 22 3a 5b 7b 22 64 65 73 74 22 3a 22 30 2e 30 2e 30 2e 30 2f 30 22 2c 22 67 61 74 65 77 61 79 22 3a 22 31 39 32 2e 31 36 38 2e 31 32 33 2e 31 22 2c 22 64 65 76 69 63 65 22 3a 22 65 74 68 30 22 7d 5d 2c 22 73 68 61 72 65 44 69 72 22 3a 22 73 68 61 72 65 5f 64 69 72 22 7d
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 1, len 783
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] call hyper_start_pod, json {"hostname":"2swg24sgf5","containers":[{"id":"2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8","rootfs":"","image":"/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs","workdir":"/usr/local/apache2","cmd":["httpd-foreground"],"envs":[{"env":"PATH","value":"/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin"},{"env":"HTTPD_PREFIX","value":"/usr/local/apache2"},{"env":"HTTPD_VERSION","value":"2.4.12"},{"env":"HTTPD_BZ2_URL","value":"https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2"}],"restartPolicy":"never"}],"interfaces":[{"device":"eth0","ipAddress":"192.168.123.2","netMask":"255.255.255.0"}],"routes":[{"dest":"0.0.0.0/0","gateway":"192.168.123.1","device":"eth0"}],"shareDir":"share_dir"}, len 775
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] call hyper_start_pod, json {"hostname":"2swg24sgf5","containers":[{"id":"2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8","rootfs":"","image":"/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs","workdir":"/usr/local/apache2","cmd":["httpd-foreground"],"envs":[{"env":"PATH","value":"/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin"},{"env":"HTTPD_PREFIX","value":"/usr/local/apache2"},{"env":"HTTPD_VERSION","value":"2.4.12"},{"env":"HTTPD_BZ2_URL","value":"https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2"}],"restartPolicy":"never"}],"interfaces":[{"device":"eth0","ipAddress":"192.168.123.2","netMask":"255.255.255.0"}],"routes":[{"dest":"0.0.0.0/0","gateway":"192.168.123.1","device":"eth0"}],"shareDir":"share_dir"}, len 775
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] jsmn parse successed, n is 61
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] token 0, type is 1, size is 5
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] token 1, type is 3, size is 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] hostname is 2swg24sgf5
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] token 3, type is 3, size is 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] container count 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] next container 7
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 2 name id
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] container id 2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 4 name rootfs
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] container rootfs
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 6 name image
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] container image /2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 8 name workdir
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] container workdir /usr/local/apache2
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 10 name cmd
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] container init arg 0 httpd-foreground
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 13 name envs
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs num 4
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 0 env PATH
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 0 value /usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/local/apache2/bin
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 1 env HTTPD_PREFIX
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 1 value /usr/local/apache2
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 2 env HTTPD_VERSION
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 2 value 2.4.12
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 3 env HTTPD_BZ2_URL
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] envs 3 value https://www.apache.org/dist/httpd/httpd-2.4.12.tar.bz2
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 35 name restartPolicy
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] restartPolicy never
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] token 41, type is 3, size is 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] network interfaces num 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] net device is eth0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] net ipaddress is 192.168.123.2
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] net mask is 255.255.255.0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] token 50, type is 3, size is 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] network routes num 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] route 0 dest is 0.0.0.0/0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] route 0 gateway is 192.168.123.1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] route 0 device is eth0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] token 59, type is 3, size is 1
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] 9p tag is share_dir
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/proc
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] create directory /tmp
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] finish rescan
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] net device eth0
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] net device sys path is /sys/class/net/eth0/ifindex
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] get ifindex 2
[HYPER INFO 0531 20:54:54 26892 qemu_process.go] [:53] [console] interface get netamsk 24 255.255.255.0
[HYPER INFO 0531 20:54:54 26892 qmp_handler.go] [:99] got a message {"timestamp": {"seconds": 1433120094, "microseconds": 996495}, "event": "NIC_RX_FILTER_CHANGED", "data": {"name": "eth0", "path": "/machine/peripheral/eth0/virtio-backend"}}
[HYPER INFO 0531 20:54:54 26892 qmp_handler.go] [:103] got event: NIC_RX_FILTER_CHANGED
[HYPER INFO 0531 20:54:54 26892 qemu.go] [:27] main event loop got message 5(EVENT_QMP_EVENT)
[HYPER WARN 0531 20:54:54 26892 vm_states.go] [:361] got event during pod initiating
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] net device eth0
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] net device sys path is /sys/class/net/eth0/ifindex
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] get ifindex 2
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/shared
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/devpts/
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/devpts
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] pod init pid 35
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_container_init in
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] path /sys/class/scsi_host/host0/scan
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] finish scan scsi
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] container root directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] src directory /tmp/hyper/shared//2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs/
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] root directory for container is /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root//, init task httpd-foreground
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] list /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get .
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get ..
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get .dockerenv
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get dev
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get etc
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get .dockerinit
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get usr
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get bin
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get lib
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get var
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get root
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get tmp
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get proc
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get opt
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get srv
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get home
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get boot
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get media
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get sbin
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get sys
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get lib64
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get mnt
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root/ get run
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root///.oldroot
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root//
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] create directory /dev/pts
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/root
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/proc
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/tmp/hyper/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/devpts
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/tmp/hyper/shared
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/dev/pts
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/dev
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot/sys
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] umount /.oldroot
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] setup pty device /dev/null for exec
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] ioctl pty device for execcmd failed: Inappropriate ioctl for device
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] setup tty failed
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper send type 10, len 0
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] wait for container started failed
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] container 2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8 init exit code -1
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] pod ctl_pipe 8
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper send type 8, len 0
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_init_event pod ctl pipe event 0x60e420, ops 0x60e360, fd 8
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 8, 0x60e360
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_init_event pod signal event 0x60e3f8, ops 0x60e340, fd 3
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_init_event pod signal event 0x60e3f8, ops 0x60e340, fd 3
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_init_event container pts event 0x21ce8b0, ops 0x60e460, fd 0
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 0, 0x60e460
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_init_event hyper ctl pipe fd 7
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 7, 0x60e320
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_add_event add event fd 3, 0x60e340
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] pod_init_loop epoll_wait 1
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] signal_loop write to 8
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] uptime 2.87 0.23
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console]
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper send type 9, len 0
[HYPER INFO 0531 20:54:55 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:54:55 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:54:55 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:54:55 26892 init_comm.go] [:145] ack got, clear pong timer
[HYPER INFO 0531 20:54:55 26892 qemu.go] [:27] main event loop got message 29(COMMAND_ACK)
[HYPER INFO 0531 20:54:55 26892 vm_states.go] [:332] [starting] got init ack to 1
[HYPER INFO 0531 20:54:55 26892 context.go] [:237] VM vm-HeYMmNmHhU: state change from STARTING to 'RUNNING'
[HYPER INFO 0531 20:54:55 26892 vm_states.go] [:345] pod start success
[HYPER INFO 0531 20:54:55 26892 pod.go] [:609] Get the response from QEMU, VM id is vm-HeYMmNmHhU!
[HYPER INFO 0531 20:54:55 26892 daemon.go] [:530] Add or Update the VM info for pod(pod-okluVlSwOh)
[HYPER INFO 0531 20:54:55 26892 daemon.go] [:548] success to add or update the VM info for pod(pod-okluVlSwOh)
[HYPER INFO 0531 20:54:55 26892 job.go] [:84] -job podRun({
"name": "myweb",
"containers" : [{
"image": "httpd",
"ports": [{
"containerPort": 80,
"hostPort": 8081
}]
}],
"resource": {
"vcpu": 1,
"memory": 512
}
}
) OK
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] pid 2 exit normally, status 255
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper send type 7, len 5
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] get length 13
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] get length 13
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] read 5 bytes data, total data 8
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] hyper_ctl_pipe_handle
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] exec pid 0, pid 2
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] can not find exec whose pid is 2
[HYPER INFO 0531 20:54:55 26892 qemu_process.go] [:53] [console] Switched to clocksource tsc
[HYPER INFO 0531 20:54:55 26892 qmp_handler.go] [:99] got a message {"timestamp": {"seconds": 1433120094, "microseconds": 910581}, "event": "VSERPORT_CHANGE", "data": {"open": true, "id": "channel1"}}
[HYPER INFO 0531 20:54:55 26892 qmp_handler.go] [:103] got event: VSERPORT_CHANGE
[HYPER INFO 0531 20:54:55 26892 qemu.go] [:27] main event loop got message 5(EVENT_QMP_EVENT)
[HYPER WARN 0531 20:54:55 26892 vm_states.go] [:406] got unexpected event during pod running
[HYPER INFO 0531 20:55:09 26892 server.go] [:604] Calling GET /list
[HYPER INFO 0531 20:55:09 26892 server.go] [:179] List type is pod
[HYPER INFO 0531 20:55:09 26892 job.go] [:78] +job list(pod)
[HYPER INFO 0531 20:55:09 26892 job.go] [:84] -job list(pod) OK
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:152] Send ping message to init
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:179] send command 12 to init, payload: ''.
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] get length 8
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] 0 0 0 c 0 0 0 8
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 12, len 8
[HYPER INFO 0531 20:55:25 26892 qemu_process.go] [:53] [console] hyper send type 9, len 0
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:55:25 26892 init_comm.go] [:145] ack got, clear pong timer
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:152] Send ping message to init
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:179] send command 12 to init, payload: ''.
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] get length 8
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] 0 0 0 c 0 0 0 8
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 12, len 8
[HYPER INFO 0531 20:55:55 26892 qemu_process.go] [:53] [console] hyper send type 9, len 0
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:55:55 26892 init_comm.go] [:145] ack got, clear pong timer
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:152] Send ping message to init
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:179] send command 12 to init, payload: ''.
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] get length 8
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] 0 0 0 c 0 0 0 8
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 12, len 8
[HYPER INFO 0531 20:56:25 26892 qemu_process.go] [:53] [console] hyper send type 9, len 0
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:56:25 26892 init_comm.go] [:145] ack got, clear pong timer
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:152] Send ping message to init
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:179] send command 12 to init, payload: ''.
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] get length 8
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] 0 0 0 c 0 0 0 8
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 12, len 8
[HYPER INFO 0531 20:56:55 26892 qemu_process.go] [:53] [console] hyper send type 9, len 0
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:56:55 26892 init_comm.go] [:145] ack got, clear pong timer
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:152] Send ping message to init
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:179] send command 12 to init, payload: ''.
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] get length 8
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] 0 0 0 c 0 0 0 8
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 12, len 8
[HYPER INFO 0531 20:57:25 26892 qemu_process.go] [:53] [console] hyper send type 9, len 0
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:54] data length is 8
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:57:25 26892 init_comm.go] [:145] ack got, clear pong timer
[HYPER INFO 0531 20:57:26 26892 daemon.go] [:739] The daemon will stop all pod
[HYPER INFO 0531 20:57:26 26892 stop.go] [:35] Prepare to stop the POD: pod-okluVlSwOh
[HYPER INFO 0531 20:57:26 26892 qemu.go] [:27] main event loop got message 23(COMMAND_SHUTDOWN)
[HYPER INFO 0531 20:57:26 26892 vm_states.go] [:190] got shutdown command, shutting down
[HYPER INFO 0531 20:57:26 26892 context.go] [:237] VM vm-HeYMmNmHhU: state change from RUNNING to 'TERMINATING'
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:179] send command 4 to init, payload: ''.
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:182] Sending shutdown command, last round of command to init
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:188] message sent, set pong timer
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] hyper_loop epoll_wait 1
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] hyper_event_read
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] read 8 bytes data, total data 0
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] get length 8
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] 0 0 0 4 0 0 0 8
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] hyper_channel_handle, type 4, len 8
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] get DESTROYPOD message
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] hyper send type 13, len 4
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:50] read 8/8 [length = 0]
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:54] data length is 12
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:40] trying to read 4 bytes
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:50] read 12/12 [length = 12]
[HYPER INFO 0531 20:57:26 26892 init_comm.go] [:40] trying to read 8 bytes
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] umount /tmp/hyper/shared
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] Sending SIGTERM
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 35
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] pod_init_loop epoll_wait -1
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 34
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 33
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 32
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 31
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 30
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 29
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 23
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 22
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 21
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 20
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 19
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 18
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 17
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 16
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 15
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 14
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 13
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 12
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 11
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 10
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 9
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 8
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 7
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 6
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 5
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 4
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 3
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] kill process 2
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] ACPI: Preparing to enter system sleep state S5
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:53] [console] reboot: Power down
[HYPER INFO 0531 20:57:26 26892 qmp_handler.go] [:99] got a message {"timestamp": {"seconds": 1433120246, "microseconds": 540454}, "event": "SHUTDOWN"}
[HYPER INFO 0531 20:57:26 26892 qmp_handler.go] [:103] got event: SHUTDOWN
[HYPER INFO 0531 20:57:26 26892 qmp_handler.go] [:149] Shutdown, quit QMP receiver
[HYPER INFO 0531 20:57:26 26892 qmp_handler.go] [:321] got QMP shutdown event, quit...
[HYPER INFO 0531 20:57:26 26892 qemu.go] [:27] main event loop got message 5(EVENT_QMP_EVENT)
[HYPER INFO 0531 20:57:26 26892 vm_states.go] [:452] Got QMP shutdown event while terminating, go to cleaning up
[HYPER INFO 0531 20:57:26 26892 vm_states.go] [:11] qemu has exit...
[HYPER INFO 0531 20:57:26 26892 devicemap.go] [:387] need unmount aufs/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs
[HYPER INFO 0531 20:57:26 26892 devicemap.go] [:416] remove network card 0: 192.168.123.2
[HYPER INFO 0531 20:57:26 26892 context.go] [:237] VM vm-HeYMmNmHhU: state change from TERMINATING to 'DESTROYING'
[HYPER INFO 0531 20:57:26 26892 qemu_process.go] [:75] quit watch dog.
[HYPER INFO 0531 20:57:26 26892 stop.go] [:64] Got response: 2: qemu shut down
[HYPER INFO 0531 20:57:26 26892 daemon.go] [:565] success to delete the VM info for pod(pod-okluVlSwOh)
[HYPER INFO 0531 20:57:26 26892 daemon.go] [:767] The daemon will be shutdown
[HYPER INFO 0531 20:57:26 26892 daemon.go] [:768] Shutdown all VMs
[HYPER INFO 0531 20:57:26 26892 job.go] [:84] -job serveapi(unix:///var/run/hyper.sock) OK
[HYPER INFO 0531 20:57:26 26892 aufs.go] [:228] Ready to unmount the target : /var/run/hyper/vm-HeYMmNmHhU/share_dir/2e60d916bb16655746830d89e1503c7067ef13560883a6ba62a77f11c44cadc8/rootfs
[HYPER INFO 0531 20:57:26 26892 tty.go] [:304] Input byte chan closed, close the output string chan
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment