Attachment 590372 Details for Bug 829241 – toy.log

toy.log

toy.log (text/plain), 16.10 KB, created by EricLee on 2012-06-08 08:01:32 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: EricLee

Created: 2012-06-08 08:01:32 UTC

Size: 16.10 KB

patch

obsolete

>2012-06-08 07:54:01.235+0000: starting up
>PATH=/sbin:/usr/sbin:/bin:/usr/bin LIBVIRT_DEBUG=1 LIBVIRT_LOG_FILTERS=1:libvirt 3:event 3:json 1:util 1:qemu  LIBVIRT_LOG_OUTPUTS=1:stderr /usr/libexec/libvirt_lxc --name toy --console 20 --handshake 23 --background --veth veth1
>2012-06-08 07:54:01.236+0000: 3671: info : libvirt version: 0.9.10, package: 21.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2012-05-23-09:15:11, x86-003.build.bos.redhat.com)
>2012-06-08 07:54:01.236+0000: 3671: debug : virCommandHook:2097 : Hook is done 0
>2012-06-08 07:54:01.307+0000: 3706: info : libvirt version: 0.9.10, package: 21.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2012-05-23-09:15:11, x86-003.build.bos.redhat.com)
>2012-06-08 07:54:01.307+0000: 3706: debug : lxcSetupLoopDevices:230 : Setup all loop devices
>2012-06-08 07:54:01.307+0000: 3706: debug : lxcSetContainerCpuAffinity:341 : Setting CPU affinity
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupNew:603 : New group /
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 0:cpu at /cgroup/cpu in 
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 1:cpuacct at /cgroup/cpuacct in 
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 2:cpuset at /cgroup/cpuset in 
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 3:memory at /cgroup/memory in 
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 4:devices at /cgroup/devices in 
>2012-06-08 07:54:01.307+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 5:freezer at /cgroup/freezer in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 6:blkio at /cgroup/blkio in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupNew:603 : New group /libvirt
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 0:cpu at /cgroup/cpu in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 1:cpuacct at /cgroup/cpuacct in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 2:cpuset at /cgroup/cpuset in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 3:memory at /cgroup/memory in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 4:devices at /cgroup/devices in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 5:freezer at /cgroup/freezer in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 6:blkio at /cgroup/blkio in 
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:524 : Make group /libvirt
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpu/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpuacct/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpuset/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/memory/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/devices/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/freezer/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/blkio/libvirt/
>2012-06-08 07:54:01.308+0000: 3706: debug : virCgroupNew:603 : New group /libvirt/lxc
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 0:cpu at /cgroup/cpu in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 1:cpuacct at /cgroup/cpuacct in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 2:cpuset at /cgroup/cpuset in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 3:memory at /cgroup/memory in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 4:devices at /cgroup/devices in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 5:freezer at /cgroup/freezer in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 6:blkio at /cgroup/blkio in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:524 : Make group /libvirt/lxc
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpu/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpuacct/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpuset/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/memory/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/devices/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/freezer/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/blkio/libvirt/lxc/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupNew:603 : New group /libvirt/lxc/toy
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 0:cpu at /cgroup/cpu in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 1:cpuacct at /cgroup/cpuacct in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 2:cpuset at /cgroup/cpuset in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 3:memory at /cgroup/memory in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 4:devices at /cgroup/devices in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 5:freezer at /cgroup/freezer in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupDetect:262 : Detected mount/mapping 6:blkio at /cgroup/blkio in 
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:524 : Make group /libvirt/lxc/toy
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpu/libvirt/lxc/toy/
>2012-06-08 07:54:01.309+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpuacct/libvirt/lxc/toy/
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/cpuset/libvirt/lxc/toy/
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupCpuSetInherit:458 : Setting up inheritance /libvirt/lxc -> /libvirt/lxc/toy
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupGetValueStr:350 : Get value /cgroup/cpuset/libvirt/lxc/cpuset.cpus
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupCpuSetInherit:471 : Inherit cpuset.cpus = 0-3
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/cpuset/libvirt/lxc/toy/cpuset.cpus' to '0-3'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupGetValueStr:350 : Get value /cgroup/cpuset/libvirt/lxc/cpuset.mems
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupCpuSetInherit:471 : Inherit cpuset.mems = 0
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/cpuset/libvirt/lxc/toy/cpuset.mems' to '0'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/memory/libvirt/lxc/toy/
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupGetValueStr:350 : Get value /cgroup/memory/libvirt/lxc/toy/memory.use_hierarchy
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetMemoryUseHierarchy:506 : Setting up /libvirt/lxc/toy/memory.use_hierarchy
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/memory/libvirt/lxc/toy/memory.use_hierarchy' to '1'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/devices/libvirt/lxc/toy/
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/freezer/libvirt/lxc/toy/
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupMakeGroup:546 : Make controller /cgroup/blkio/libvirt/lxc/toy/
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/memory/libvirt/lxc/toy/memory.limit_in_bytes' to '512000000'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.deny' to 'a'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 1:3 rwm'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 1:5 rwm'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 1:7 rwm'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 1:8 rwm'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 1:9 rwm'
>2012-06-08 07:54:01.310+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 5:0 rwm'
>2012-06-08 07:54:01.311+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 5:2 rwm'
>2012-06-08 07:54:01.311+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/devices.allow' to 'c 136:* rwm'
>2012-06-08 07:54:01.311+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/cpu/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.313+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/cpuacct/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.316+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/cpuset/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.319+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/memory/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.322+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/devices/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.326+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/freezer/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.334+0000: 3706: debug : virCgroupSetValueStr:320 : Set value '/cgroup/blkio/libvirt/lxc/toy/tasks' to '3706'
>2012-06-08 07:54:01.342+0000: 3706: debug : lxcControllerRun:1532 : Opening tty on shared /dev/ptmx
>2012-06-08 07:54:01.343+0000: 3706: debug : lxcContainerStart:1456 : Enable network namespaces
>2012-06-08 07:54:01.344+0000: 3706: debug : lxcContainerStart:1462 : clone() completed, new container PID is 3718
>PATH=/bin:/sbin2012-06-08 07:54:01.344+0000: 3706: debug : virCommandRunAsync:2178 : About to run ip link set veth1 netns 3718
> TERM=linux container=lxc-libvirt LIBVIRT_LXC_UUID=386f5b25-43ee-9d62-4ce2-62c3809e47c1 LIBVIRT_LXC_NAME=toy /bin/sh
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerChild:1311 : Container TTY path: /dev/pts/2
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerSetupExtraMounts:1155 : def=0x28416a0
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerSetupExtraMounts:1167 : Mounting config FS
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountAllFS:1018 : Mounting  0
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountAllFS:1030 : Mounted all filesystems
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:456 : Mounting basic filesystems (null) pivotRoot=0
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing proc -> /proc
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount proc on /proc type=proc flags=e, opts=(null)
>2012-06-08 07:54:01.344+0000: 3706: debug : virCommandRunAsync:2196 : Command result 0, with PID 3719
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing /proc/sys -> /proc/sys
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount /proc/sys on /proc/sys type=(null) flags=1000, opts=(null)
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing /proc/sys -> /proc/sys
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount /proc/sys on /proc/sys type=(null) flags=1021, opts=(null)
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing /sys -> /sys
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount /sys on /sys type=(null) flags=1000, opts=(null)
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing /sys -> /sys
>2012-06-08 07:54:01.344+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount /sys on /sys type=(null) flags=1021, opts=(null)
>2012-06-08 07:54:01.345+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing /selinux -> /selinux
>2012-06-08 07:54:01.345+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount /selinux on /selinux type=(null) flags=1000, opts=(null)
>2012-06-08 07:54:01.345+0000: 1: debug : lxcContainerMountBasicFS:463 : Processing /selinux -> /selinux
>2012-06-08 07:54:01.345+0000: 1: debug : lxcContainerMountBasicFS:490 : Mount /selinux on /selinux type=(null) flags=1021, opts=(null)
>2012-06-08 07:54:01.345+0000: 1: debug : lxcContainerMountBasicFS:535 : rc=0
>2012-06-08 07:54:01.345+0000: 1: debug : lxcContainerSetupExtraMounts:1175 : Mounting completed
>2012-06-08 07:54:01.357+0000: 3706: debug : virCommandRun:1998 : Result status 0, stdout: '' stderr: '2012-06-08 07:54:01.344+0000: 3719: info : libvirt version: 0.9.10, package: 21.el6 (Red Hat, Inc. <http://bugzilla.redhat.com/bugzilla>, 2012-05-23-09:15:11, x86-003.build.bos.redhat.com)
>2012-06-08 07:54:01.344+0000: 3719: debug : virCommandHook:2097 : Hook is done 0
>'
>2012-06-08 07:54:01.357+0000: 1: debug : lxcContainerChild:1337 : Received container continue message
>2012-06-08 07:54:01.357+0000: 1: debug : lxcContainerRenameAndEnableInterfaces:277 : Renaming veth1 to eth0
>2012-06-08 07:54:01.358+0000: 1: debug : lxcContainerRenameAndEnableInterfaces:282 : Enabling eth0
>2012-06-08 07:54:01.361+0000: 3706: debug : lxcControllerMain:1139 : serverFd=5 clientFd=6
>2012-06-08 07:54:01.361+0000: 3706: debug : lxcConsoleIO:1000 : IO event watch=6 fd=20 events=8 fromHost=0 fromcont=0
>2012-06-08 07:54:01.361+0000: 3706: debug : lxcConsoleIO:1070 : Got EOF on 6 20
>2012-06-08 07:54:01.361+0000: 3706: debug : lxcConsoleUpdateWatch:863 : Container watch 7=1 host watch 6=0
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleUpdateWatch:878 : newHostEvents=80000001 oldHostEvents=0
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleUpdateWatch:890 : newHostEvents=80000001 oldHostEvents=80000001
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleIO:1000 : IO event watch=7 fd=11 events=1 fromHost=0 fromcont=0
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleUpdateWatch:863 : Container watch 7=1 host watch 6=3
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcEpollIO:953 : IO event watch=5 fd=12 events=1 fromHost=0 fromcont=170
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcEpollIO:973 : fd=20 hostFd=20 contFd=11 hostEpoll=80000001 contEpoll=0
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleIO:1000 : IO event watch=6 fd=20 events=10 fromHost=0 fromcont=170
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleIO:1070 : Got EOF on 6 20
>2012-06-08 07:54:01.362+0000: 3706: debug : lxcConsoleUpdateWatch:863 : Container watch 7=1 host watch 6=0
>2012-06-08 07:54:01.428+0000: 3706: debug : lxcConsoleIO:1000 : IO event watch=7 fd=11 events=1 fromHost=0 fromcont=0
>2012-06-08 07:54:01.428+0000: 3706: debug : lxcConsoleUpdateWatch:863 : Container watch 7=1 host watch 6=3
>2012-06-08 07:54:01.428+0000: 3706: debug : lxcConsoleIO:1000 : IO event watch=6 fd=20 events=10 fromHost=0 fromcont=8
>2012-06-08 07:54:01.428+0000: 3706: debug : lxcConsoleIO:1070 : Got EOF on 6 20
>2012-06-08 07:54:01.428+0000: 3706: debug : lxcConsoleUpdateWatch:863 : Container watch 7=1 host watch 6=0

Actions: View

Attachments on bug 829241: 590371 | 590372