Monday, March 26, 2007, 05:27 PM
Below I have pasted the relevant parts of /var/log/messages and /var/log/xen/xend.log
Here's the pertinent lines of /var/log/messages
(some of the lines are irrelevant):
Mar 26 15:47:43 xen1 smbd[29170]: Unable to connect to CUPS server localhost - Connection refused
Mar 26 15:54:33 xen1 xenagentd[5551]: <8155> SSL Negotiated new session
Mar 26 15:54:33 xen1 xenagentd[5551]: <29686> received = 174; strlen = 175
Mar 26 15:54:33 xen1 xenagentd[5551]: <29686> COMMAND vm_getvnccfg
Mar 26 15:54:33 xen1 xenagentd[5551]: <29686> COMMAND sync(1) vm_getvnccfg SUCCESS
Mar 26 15:54:33 xen1 xenagentd[5551]: <8155> SSL Session was reused
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> received = 139; strlen = 140
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> COMMAND tcp_proxy
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> blocking for 372 bytes
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> tcp_proxy requested proxy to local port 5908
Mar 26 15:54:33 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:33 xen1 last message repeated 8 times
Mar 26 15:54:33 xen1 kernel: #### netback grant fails
Mar 26 15:54:33 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> COMMAND sync(1) tcp_proxy SUCCESS
Mar 26 15:54:33 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> Proxy started
Mar 26 15:54:33 xen1 xenagentd[5551]: <29687> TCP<->SSL proxy starting (fd = 10)
Mar 26 15:54:33 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:33 xen1 last message repeated 7 times
Mar 26 15:54:33 xen1 kernel: #### netback grant fails
Mar 26 15:54:33 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:34 xen1 last message repeated 14 times
Mar 26 15:54:34 xen1 kernel: #### netback grant fails
Mar 26 15:54:34 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:34 xen1 last message repeated 11 times
Mar 26 15:54:34 xen1 kernel: #### netback grant fails
Mar 26 15:54:34 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try write to xen platform mmio space
Mar 26 15:54:34 xen1 last message repeated 10 times
Mar 26 15:54:34 xen1 kernel: #### netback grant fails
Mar 26 15:54:34 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[14704]: Warning: try read from xen platform mmio space
Mar 26 15:54:34 xen1 kernel: xenbr0: port 3(vif8.0) entering disabled state
Mar 26 15:54:34 xen1 kernel: device vif8.0 left promiscuous mode
Mar 26 15:54:34 xen1 kernel: xenbr0: port 3(vif8.0) entering disabled state
Mar 26 15:54:34 xen1 kernel: xenbr1: port 3(vif8.1) entering disabled state
Mar 26 15:54:34 xen1 kernel: device vif8.1 left promiscuous mode
Mar 26 15:54:34 xen1 kernel: xenbr1: port 3(vif8.1) entering disabled state
Mar 26 15:54:35 xen1 net.agent[29744]: remove event not handled
Mar 26 15:54:35 xen1 net.agent[29728]: remove event not handled
Mar 26 15:54:34 xen1 net.agent[29730]: remove event not handled
Mar 26 15:54:35 xen1 net.agent[29745]: remove event not handled
Mar 26 15:54:35 xen1 xenagentd[5551]: <29687> Got EOF from read() 0
Mar 26 15:54:35 xen1 xenagentd[5551]: <29687> TCP<->SSL proxy exiting (fd = 10)
Mar 26 15:54:35 xen1 xenagentd[5551]: <29687> Proxy exiting
Mar 26 15:54:36 xen1 kernel: netbk: WARNING: device 'vif10.0' has non-zero queue length (32)!
Mar 26 15:54:36 xen1 kernel: netbk: WARNING: device 'vif10.1' has non-zero queue length (32)!
Mar 26 15:54:37 xen1 HVMXEN-[30102]: domid: 10
Mar 26 15:54:38 xen1 kernel: device vif10.1 entered promiscuous mode
Mar 26 15:54:38 xen1 kernel: ADDRCONF(NETDEV_UP): vif10.1: link is not ready
Mar 26 15:54:38 xen1 logger: /etc/xen/scripts/vif-bridge: iptables -A FORWARD -m physdev --physdev-in vif10.1 -j ACCEPT failed. If you are using iptables, this may affect networking for guest domains.
Mar 26 15:54:39 xen1 kernel: device vif10.0 entered promiscuous mode
Mar 26 15:54:39 xen1 kernel: ADDRCONF(NETDEV_UP): vif10.0: link is not ready
Mar 26 15:54:39 xen1 logger: /etc/xen/scripts/vif-bridge: iptables -A FORWARD -m physdev --physdev-in vif10.0 -j ACCEPT failed. If you are using iptables, this may affect networking for guest domains.
Mar 26 15:54:41 xen1 kernel: device tap0 entered promiscuous mode
Mar 26 15:54:41 xen1 kernel: xenbr0: port 6(tap0) entering learning state
Mar 26 15:54:41 xen1 kernel: device tap1 entered promiscuous mode
Mar 26 15:54:41 xen1 kernel: xenbr0: topology change detected, propagating
Mar 26 15:54:41 xen1 kernel: xenbr0: port 6(tap0) entering forwarding state
Mar 26 15:54:41 xen1 kernel: xenbr1: port 5(tap1) entering learning state
Mar 26 15:54:41 xen1 kernel: xenbr1: topology change detected, propagating
Mar 26 15:54:41 xen1 kernel: xenbr1: port 5(tap1) entering forwarding state
Mar 26 15:54:42 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[7642]: Warning: try write to xen platform mmio space
Mar 26 15:54:42 xen1 last message repeated 5 times
Mar 26 15:54:42 xen1 kernel: #### netback grant fails
Mar 26 15:54:42 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[7642]: Warning: try read from xen platform mmio space
Mar 26 15:54:43 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: shared page at pfn:2efff, mfn: 10cc50
Mar 26 15:54:43 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: buffered io page at pfn:2effd, mfn: 10cc52
Mar 26 15:54:43 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: False I/O request ... in-service already: 0, pvalid: 0, port: 0, data: 0, count: 0, size: 0
Mar 26 15:54:44 xen1 kernel: xenbr0: port 5(vif3.0) entering disabled state
Mar 26 15:54:44 xen1 kernel: device vif3.0 left promiscuous mode
Mar 26 15:54:44 xen1 kernel: xenbr0: port 5(vif3.0) entering disabled state
Mar 26 15:54:44 xen1 net.agent[31076]: remove event not handled
Mar 26 15:54:44 xen1 kernel: xenbr1: port 6(vif3.1) entering disabled state
Mar 26 15:54:44 xen1 kernel: device vif3.1 left promiscuous mode
Mar 26 15:54:44 xen1 kernel: xenbr1: port 6(vif3.1) entering disabled state
Mar 26 15:54:44 xen1 net.agent[31090]: remove event not handled
Mar 26 15:54:44 xen1 net.agent[31099]: remove event not handled
Mar 26 15:54:45 xen1 net.agent[31051]: remove event not handled
Mar 26 15:54:47 xen1 kernel: netbk: WARNING: device 'vif11.0' has non-zero queue length (32)!
Mar 26 15:54:47 xen1 kernel: netbk: WARNING: device 'vif11.1' has non-zero queue length (32)!
Mar 26 15:54:47 xen1 HVMXEN-[31460]: domid: 11
Mar 26 15:54:47 xen1 kernel: device tap2 entered promiscuous mode
Mar 26 15:54:47 xen1 kernel: device tap3 entered promiscuous mode
Mar 26 15:54:47 xen1 kernel: xenbr0: port 5(tap2) entering learning state
Mar 26 15:54:47 xen1 kernel: xenbr0: topology change detected, propagating
Mar 26 15:54:47 xen1 kernel: xenbr0: port 5(tap2) entering forwarding state
Mar 26 15:54:47 xen1 kernel: xenbr1: port 6(tap3) entering learning state
Mar 26 15:54:47 xen1 kernel: xenbr1: topology change detected, propagating
Mar 26 15:54:47 xen1 kernel: xenbr1: port 6(tap3) entering forwarding state
Mar 26 15:54:49 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: shared page at pfn:3f7ff, mfn: 1ba39
Mar 26 15:54:49 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: buffered io page at pfn:3f7fd, mfn: 1ba3b
Mar 26 15:54:49 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: False I/O request ... in-service already: 0, pvalid: 0, port: 0, data: 0, count: 0, size: 0
Mar 26 15:54:49 xen1 kernel: device vif11.0 entered promiscuous mode
Mar 26 15:54:49 xen1 kernel: ADDRCONF(NETDEV_UP): vif11.0: link is not ready
Mar 26 15:54:49 xen1 logger: /etc/xen/scripts/vif-bridge: iptables -A FORWARD -m physdev --physdev-in vif11.0 -j ACCEPT failed. If you are using iptables, this may affect networking for guest domains.
Mar 26 15:54:50 xen1 logger: /etc/xen/scripts/vif-bridge: iptables -A FORWARD -m physdev --physdev-in vif11.1 -j ACCEPT failed. If you are using iptables, this may affect networking for guest domains.
Mar 26 15:54:50 xen1 kernel: device vif11.1 entered promiscuous mode
Mar 26 15:54:50 xen1 kernel: ADDRCONF(NETDEV_UP): vif11.1: link is not ready
Mar 26 15:54:59 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Disconnect IDE hard disk...
Mar 26 15:54:59 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Disconnect netifs...
Mar 26 15:54:59 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Shutdown taps...
Mar 26 15:54:59 xen1 kernel: xenbr1: port 5(tap1) entering disabled state
Mar 26 15:54:59 xen1 kernel: device tap1 left promiscuous mode
Mar 26 15:54:59 xen1 kernel: xenbr1: port 5(tap1) entering disabled state
Mar 26 15:54:59 xen1 kernel: xenbr0: port 6(tap0) entering disabled state
Mar 26 15:54:59 xen1 kernel: device tap0 left promiscuous mode
Mar 26 15:54:59 xen1 kernel: xenbr0: port 6(tap0) entering disabled state
Mar 26 15:54:59 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: switching to PV shutdown mode...
Mar 26 15:54:59 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Done.
Mar 26 15:55:05 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Disconnect IDE hard disk...
Mar 26 15:55:05 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Disconnect netifs...
Mar 26 15:55:05 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Shutdown taps...
Mar 26 15:55:05 xen1 kernel: xenbr1: port 6(tap3) entering disabled state
Mar 26 15:55:05 xen1 kernel: device tap3 left promiscuous mode
Mar 26 15:55:05 xen1 kernel: xenbr1: port 6(tap3) entering disabled state
Mar 26 15:55:05 xen1 kernel: xenbr0: port 5(tap2) entering disabled state
Mar 26 15:55:05 xen1 kernel: device tap2 left promiscuous mode
Mar 26 15:55:05 xen1 kernel: xenbr0: port 5(tap2) entering disabled state
Mar 26 15:55:05 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: switching to PV shutdown mode...
Mar 26 15:55:05 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Done.
Mar 26 15:55:11 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Disconnect IDE hard disk...
Mar 26 15:55:11 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Disconnect netifs...
Mar 26 15:55:11 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Shutdown taps...
Mar 26 15:55:11 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: switching to PV shutdown mode...
Mar 26 15:55:11 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: failed to unregister watch on /local/domain/10/control/shutdown
Mar 26 15:55:11 xen1 HVMXEN-0d4ceb99-264a-4003-bd50-a9a37d98368c[30102]: Done.
Mar 26 15:55:17 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Disconnect IDE hard disk...
Mar 26 15:55:17 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Disconnect netifs...
Mar 26 15:55:17 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Shutdown taps...
Mar 26 15:55:17 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: switching to PV shutdown mode...
Mar 26 15:55:17 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: failed to unregister watch on /local/domain/11/control/shutdown
Mar 26 15:55:17 xen1 HVMXEN-757782e4-1dbc-40ce-802a-f5feb7db0284[31460]: Done.
Mar 26 15:55:25 xen1 kernel: ADDRCONF(NETDEV_CHANGE): vif10.0: link becomes ready
Mar 26 15:55:25 xen1 kernel: xenbr0: port 3(vif10.0) entering learning state
Mar 26 15:55:25 xen1 kernel: xenbr0: topology change detected, propagating
Mar 26 15:55:25 xen1 kernel: xenbr0: port 3(vif10.0) entering forwarding state
Mar 26 15:55:30 xen1 kernel: ADDRCONF(NETDEV_CHANGE): vif11.1: link becomes ready
Mar 26 15:55:30 xen1 kernel: xenbr1: port 7(vif11.1) entering learning state
Mar 26 15:55:30 xen1 kernel: xenbr1: topology change detected, propagating
Mar 26 15:55:30 xen1 kernel: xenbr1: port 7(vif11.1) entering forwarding state
Mar 26 15:55:31 xen1 kernel: ADDRCONF(NETDEV_CHANGE): vif11.0: link becomes ready
Mar 26 15:55:31 xen1 kernel: xenbr0: port 7(vif11.0) entering learning state
Mar 26 15:55:31 xen1 kernel: xenbr0: topology change detected, propagating
Mar 26 15:55:31 xen1 kernel: xenbr0: port 7(vif11.0) entering forwarding state
Mar 26 15:56:13 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:4c:7a:96:08:00 SRC=192.168.131.51 DST=255.255.255.255 LEN=44 TOS=0x00 PREC=0x00 TTL=32 ID=28 PROTO=UDP SPT=1028 DPT=38293 LEN=24
Mar 26 15:56:13 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:4c:7a:96:08:00 SRC=192.168.131.51 DST=255.255.255.255 LEN=44 TOS=0x00 PREC=0x00 TTL=32 ID=29 PROTO=UDP SPT=1028 DPT=38293 LEN=24
Mar 26 15:56:13 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:4c:7a:96:08:00 SRC=192.168.131.51 DST=255.255.255.255 LEN=44 TOS=0x00 PREC=0x00 TTL=32 ID=30 PROTO=UDP SPT=1028 DPT=38293 LEN=24
Mar 26 15:56:13 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:4c:7a:96:08:00 SRC=192.168.131.51 DST=255.255.255.255 LEN=44 TOS=0x00 PREC=0x00 TTL=32 ID=31 PROTO=UDP SPT=1028 DPT=38293 LEN=24
Mar 26 15:56:13 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:4c:7a:96:08:00 SRC=192.168.131.51 DST=255.255.255.255 LEN=44 TOS=0x00 PREC=0x00 TTL=32 ID=32 PROTO=UDP SPT=1028 DPT=38293 LEN=24
Mar 26 15:56:13 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:4c:7a:96:08:00 SRC=192.168.131.51 DST=255.255.255.255 LEN=44 TOS=0x00 PREC=0x00 TTL=32 ID=33 PROTO=UDP SPT=1028 DPT=38293 LEN=24
Mar 26 15:56:24 xen1 smbd[29166]: [2007/03/26 15:56:24, 0] printing/print_cups.c:cups_cache_reload(85)
Mar 26 15:56:24 xen1 smbd[29166]: Unable to connect to CUPS server localhost - Connection refused
Mar 26 15:56:24 xen1 smbd[29166]: [2007/03/26 15:56:24, 0] printing/print_cups.c:cups_cache_reload(85)
Mar 26 15:56:24 xen1 smbd[29166]: Unable to connect to CUPS server localhost - Connection refused
Mar 26 15:56:42 xen1 smbd[29170]: [2007/03/26 15:56:42, 0] lib/util_sock.c:read_data(534)
Mar 26 15:56:42 xen1 smbd[29170]: read_data: read failure for 4 bytes to client 192.168.131.50. Error = Connection reset by peer
Mar 26 15:57:24 xen1 smbd[29166]: [2007/03/26 15:57:24, 0] lib/util_sock.c:read_data(534)
Mar 26 15:57:24 xen1 smbd[29166]: read_data: read failure for 4 bytes to client 192.168.131.51. Error = Connection reset by peer
Mar 26 15:58:13 xen1 xenagentd[5551]: <8157> Bad file descriptor
Mar 26 15:59:31 xen1 kernel: IN=xenbr0 OUT= MAC=ff:ff:ff:ff:ff:ff:00:16:3e:1b:52:5d:08:00 SRC=192.168.131.50 DST=255.255.255.255 LEN=29 TOS=0x00 PREC=0x00 TTL=128 ID=23453 PROTO=UDP SPT=1500 DPT=1434 LEN=9
Mar 26 15:59:58 xen1 sshd(pam_unix)[32320]: authentication failure; logname= uid=0 euid=0 tty=ssh ruser= rhost=192.168.131.101 user=root
Mar 26 16:00:03 xen1 sshd(pam_unix)[32325]: session opened for user root by root(uid=0)
Mar 26 16:00:38 xen1 xenagentd[5551]: <8155> SSL Negotiated new session
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> received = 216; strlen = 217
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> COMMAND sign_on_main
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> Running xenenterprise 3.1.0 (build 1332) on a Xen 3.0.3.0 host
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> AUTH Checking username 'root'
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> AUTH Validated user 'root'
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> READ /var/opt/xen/mh/mh.dat
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> Authorized client at 192.168.131.51:1126
Mar 26 16:00:38 xen1 xenagentd[5551]: <32350> COMMAND sync(1) sign_on_main SUCCESS
Mar 26 16:00:38 xen1 xenagentd[5551]: <8155> SSL Session was reused
Mar 26 16:00:38 xen1 xenagentd[5551]: <32351> received = 212; strlen = 213
Mar 26 16:00:38 xen1 xenagentd[5551]: <32351> COMMAND sign_on_back
Mar 26 16:00:38 xen1 xenagentd[5551]: <32351> client <0x8109768> session 4a53233c-1535-4ff2-93d4-fd69ade44913 from 192.168.131.51 connected.
Mar 26 16:00:38 xen1 xenagentd[5551]: <32351> Talking to controller at 0x81099e8 192.168.131.51:1127
Mar 26 16:00:38 xen1 xenagentd[5551]: <32351> COMMAND sync(1) sign_on_back SUCCESS
Mar 26 16:00:38 xen1 xenagentd[5551]: <8155> SSL Session was reused
Mar 26 16:00:38 xen1 xenagentd[5551]: <32352> received = 100; strlen = 101
Mar 26 16:00:38 xen1 xenagentd[5551]: <32352> Missing payload, checking for old protocol
Mar 26 16:00:38 xen1 xenagentd[5551]: <32352> COMMAND mh_getcfg
Mar 26 16:00:38 xen1 xenagentd[5551]: <32352> Talking to controller at 192.168.131.51:1128
Mar 26 16:00:38 xen1 xenagentd[5551]: <32352> READ /var/opt/xen/mh/mh.dat
Mar 26 16:00:38 xen1 xenagentd[5551]: <32352> COMMAND sync(1) mh_getcfg SUCCESS
Mar 26 16:00:38 xen1 xenagentd[5551]: <8155> SSL Session was reused
Mar 26 16:00:38 xen1 xenagentd[5551]: <32353> received = 105; strlen = 106
Mar 26 16:00:38 xen1 xenagentd[5551]: <32353> Missing payload, checking for old protocol
Mar 26 16:00:38 xen1 xenagentd[5551]: <32353> COMMAND mh_cd_list_get
Mar 26 16:00:38 xen1 xenagentd[5551]: <32353> COMMAND sync(1) mh_cd_list_get SUCCESS
Mar 26 16:00:38 xen1 xenagentd[5551]: <8155> SSL Session was reused
Mar 26 16:00:38 xen1 xenagentd[5551]: <32354> received = 110; strlen = 111
Mar 26 16:00:38 xen1 xenagentd[5551]: <32354> Missing payload, checking for old protocol
Mar 26 16:00:38 xen1 xenagentd[5551]: <32354> COMMAND mh_license_list_get
Mar 26 16:00:38 xen1 xenagentd[5551]: <32354> COMMAND sync(1) mh_license_list_get SUCCESS
Here's the last 500 lines of /var/log/xen/xend.log
(and a few preceding lines just for fun):
[2007-03-21 17:26:29 xend 5241] DEBUG (DevController:143) Waiting for devices tap.
[2007-03-21 17:26:29 xend 5241] DEBUG (DevController:143) Waiting for devices vtpm.
[2007-03-21 17:26:29 xend 5241] INFO (XendDomain:370) Domain 8df935ec-99e4-4168-9b09-33c3d17ee8b3 (9) unpaused.
[2007-03-26 15:54:34 xend.XendDomainInfo 5241] WARNING (XendDomainInfo:874) Domain has crashed: name=0d4ceb99-264a-4003-bd50-a9a37d98368c id=8.
[2007-03-26 15:54:34 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:1442) XendDomainInfo.destroyDomain(8)
[2007-03-26 15:54:35 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:189) XendDomainInfo.create(['domain', ['domid', 8], ['uuid', '0d4ceb99-264a-4003-bd50-a9a37d98368c'], ['vcpus', 1], ['vcpu_avail', 1], ['cpu_weight', 1.0], ['memory', 752], ['shadow_memory', 7], ['maxmem', 752], ['features', ''], ['name', '0d4ceb99-264a-4003-bd50-a9a37d98368c'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['usbdevice', 'tablet'], ['usb', '1'], ['sdl', '0'], ['xauthority', '/root/.Xauthority'], ['device_model', '/usr/lib/xen/bin/qemu-dm'], ['serial', 'pty'], ['vnc', '1'], ['boot', 'cd']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3E:4C:7A:96']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3E:17:C4:4B']]], ['device', ['vbd', ['backend', 0], ['dev', 'hdd:cdrom'], ['uname', 'phy:/dev/cdwriter'], ['mode', 'r']]], ['device', ['vbd', ['backend', 0], ['dev', 'hda:disk'], ['uname', 'phy:/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/0d4ceb99-264a-4003-bd50-a9a37d98368c.hda'], ['mode', 'w']]], ['state', '----c-'], ['shutdown_reason', 'crash'], ['cpu_time', 25787.7720161], ['online_vcpus', 1], ['up_time', '435007.902225'], ['start_time', '1174511066.28'], ['store_mfn', 1232375]])
[2007-03-26 15:54:35 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:295) parseConfig: config is ['domain', ['domid', 8], ['uuid', '0d4ceb99-264a-4003-bd50-a9a37d98368c'], ['vcpus', 1], ['vcpu_avail', 1], ['cpu_weight', 1.0], ['memory', 752], ['shadow_memory', 7], ['maxmem', 752], ['features', ''], ['name', '0d4ceb99-264a-4003-bd50-a9a37d98368c'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['usbdevice', 'tablet'], ['usb', '1'], ['sdl', '0'], ['xauthority', '/root/.Xauthority'], ['device_model', '/usr/lib/xen/bin/qemu-dm'], ['serial', 'pty'], ['vnc', '1'], ['boot', 'cd']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3E:4C:7A:96']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3E:17:C4:4B']]], ['device', ['vbd', ['backend', 0], ['dev', 'hdd:cdrom'], ['uname', 'phy:/dev/cdwriter'], ['mode', 'r']]], ['device', ['vbd', ['backend', 0], ['dev', 'hda:disk'], ['uname', 'phy:/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/0d4ceb99-264a-4003-bd50-a9a37d98368c.hda'], ['mode', 'w']]], ['state', '----c-'], ['shutdown_reason', 'crash'], ['cpu_time', 25787.7720161], ['online_vcpus', 1], ['up_time', '435007.902225'], ['start_time', '1174511066.28'], ['store_mfn', 1232375]]
[2007-03-26 15:54:35 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:394) parseConfig: result is {'shadow_memory': 7, 'uuid': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'on_crash': 'restart', 'on_reboot': 'restart', 'localtime': None, 'image': ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['usbdevice', 'tablet'], ['usb', '1'], ['sdl', '0'], ['xauthority', '/root/.Xauthority'], ['device_model', '/usr/lib/xen/bin/qemu-dm'], ['serial', 'pty'], ['vnc', '1'], ['boot', 'cd']], 'on_poweroff': 'destroy', 'bootloader_args': None, 'cpus': None, 'name': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'backend': [], 'vcpus': 1, 'cpu_weight': 1.0, 'features': '', 'vcpu_avail': 1, 'memory': 752, 'device': [('vif', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3E:4C:7A:96']]), ('vif', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3E:17:C4:4B']]), ('vbd', ['vbd', ['backend', 0], ['dev', 'hdd:cdrom'], ['uname', 'phy:/dev/cdwriter'], ['mode', 'r']]), ('vbd', ['vbd', ['backend', 0], ['dev', 'hda:disk'], ['uname', 'phy:/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/0d4ceb99-264a-4003-bd50-a9a37d98368c.hda'], ['mode', 'w']])], 'bootloader': None, 'cpu': None, 'maxmem': 752}
[2007-03-26 15:54:35 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:1236) XendDomainInfo.construct: None
[2007-03-26 15:54:35 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:1268) XendDomainInfo.initDomain: 10 1.0
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: boot, val: cd
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: fda, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: fdb, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: soundhw, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: localtime, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: serial, val: pty
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: std-vga, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: isa, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: vcpus, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: acpi, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: usb, val: 1
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: usbdevice, val: tablet
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: dumpdir, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (image:387) args: dumpquota, val: None
[2007-03-26 15:54:35 xend 5241] DEBUG (balloon:127) Balloon: 2130540 KiB free; need 791312; done.
[2007-03-26 15:54:35 xend 5241] INFO (image:192) buildDomain os=hvm dom=10 vcpus=1
[2007-03-26 15:54:35 xend 5241] DEBUG (image:338) dom = 10
[2007-03-26 15:54:35 xend 5241] DEBUG (image:339) image = /usr/lib/xen/boot/hvmloader
[2007-03-26 15:54:35 xend 5241] DEBUG (image:340) store_evtchn = 1
[2007-03-26 15:54:35 xend 5241] DEBUG (image:341) memsize = 752
[2007-03-26 15:54:35 xend 5241] DEBUG (image:342) vcpus = 1
[2007-03-26 15:54:35 xend 5241] DEBUG (image:343) pae = 0
[2007-03-26 15:54:35 xend 5241] DEBUG (image:344) acpi = 0
[2007-03-26 15:54:35 xend 5241] DEBUG (image:345) apic = 0
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3E:4C:7A:96', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/10/0'} to /local/domain/10/device/vif/0.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr0', 'domain': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/10/device/vif/0', 'mac': '00:16:3E:4C:7A:96', 'online': '1', 'frontend-id': '10'} to /local/domain/0/backend/vif/10/0.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3E:17:C4:4B', 'handle': '1', 'state': '1', 'backend': '/local/domain/0/backend/vif/10/1'} to /local/domain/10/device/vif/1.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr1', 'domain': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'handle': '1', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/10/device/vif/1', 'mac': '00:16:3E:17:C4:4B', 'online': '1', 'frontend-id': '10'} to /local/domain/0/backend/vif/10/1.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '5696', 'device-type': 'cdrom', 'state': '1', 'backend': '/local/domain/0/backend/vbd/10/5696'} to /local/domain/10/device/vbd/5696.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:112) DevController: writing {'domain': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'frontend': '/local/domain/10/device/vbd/5696', 'dev': 'hdd', 'state': '1', 'params': '/dev/cdwriter', 'mode': 'r', 'online': '1', 'frontend-id': '10', 'type': 'phy'} to /local/domain/0/backend/vbd/10/5696.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/10/768'} to /local/domain/10/device/vbd/768.
[2007-03-26 15:54:36 xend 5241] DEBUG (DevController:112) DevController: writing {'domain': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'frontend': '/local/domain/10/device/vbd/768', 'dev': 'hda', 'state': '1', 'params': '/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/0d4ceb99-264a-4003-bd50-a9a37d98368c.hda', 'mode': 'w', 'online': '1', 'frontend-id': '10', 'type': 'phy'} to /local/domain/0/backend/vbd/10/768.
[2007-03-26 15:54:36 xend 5241] INFO (image:468) spawning device models: /usr/lib/xen/bin/qemu-dm ['/usr/lib/xen/bin/qemu-dm', '-d', '10', '-m', '752', '-boot', 'cd', '-serial', 'pty', '-usb', '-usbdevice', 'tablet', '-domain-name', '0d4ceb99-264a-4003-bd50-a9a37d98368c', '-net', 'nic,vlan=1,macaddr=00:16:3E:4C:7A:96,model=rtl8139', '-net', 'tap,vlan=1,bridge=xenbr0', '-net', 'nic,vlan=2,macaddr=00:16:3E:17:C4:4B,model=rtl8139', '-net', 'tap,vlan=2,bridge=xenbr1', '-vnc', '10', '-k', 'en-us', '-vnclisten', '127.0.0.1']
[2007-03-26 15:54:36 xend 5241] INFO (image:470) device model pid: 30102
[2007-03-26 15:54:36 xend 5241] DEBUG (image:443) Waiting for qemu
[2007-03-26 15:54:36 xend 5241] DEBUG (image:446) status None
[2007-03-26 15:54:37 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:38 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:39 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:40 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:41 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:42 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:43 xend 5241] DEBUG (image:450) status 1
[2007-03-26 15:54:43 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:711) Storing VM details: {'shadow_memory': '7', 'uuid': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'on_reboot': 'restart', 'start_time': '1174946083.57', 'on_poweroff': 'destroy', 'name': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '752', 'on_crash': 'restart', 'image': '(hvm (kernel /usr/lib/xen/boot/hvmloader) (usbdevice tablet) (usb 1) (sdl 0) (xauthority /root/.Xauthority) (device_model /usr/lib/xen/bin/qemu-dm) (serial pty) (vnc 1) (boot cd))', 'maxmem': '752'}
[2007-03-26 15:54:43 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:746) Storing domain details: {'console/port': '2', 'name': '0d4ceb99-264a-4003-bd50-a9a37d98368c', 'console/limit': '1048576', 'vm': '/vm/0d4ceb99-264a-4003-bd50-a9a37d98368c', 'domid': '10', 'cpu/0/availability': 'online', 'memory/target': '770048', 'store/ring-ref': '1100881', 'store/port': '1'}
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices vif.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:149) Waiting for 0.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:149) Waiting for 1.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices usb.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices vbd.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:149) Waiting for 5696.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:149) Waiting for 768.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices irq.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices pci.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices ioports.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices tap.
[2007-03-26 15:54:43 xend 5241] DEBUG (DevController:143) Waiting for devices vtpm.
[2007-03-26 15:54:43 xend.XendDomainInfo 5241] WARNING (XendDomainInfo:874) Domain has crashed: name=757782e4-1dbc-40ce-802a-f5feb7db0284 id=3.
[2007-03-26 15:54:44 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:1442) XendDomainInfo.destroyDomain(3)
[2007-03-26 15:54:46 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:189) XendDomainInfo.create(['domain', ['domid', 3], ['uuid', '757782e4-1dbc-40ce-802a-f5feb7db0284'], ['vcpus', 1], ['vcpu_avail', 1], ['cpu_weight', 1.0], ['memory', 1016], ['shadow_memory', 9], ['maxmem', 1016], ['features', ''], ['name', '757782e4-1dbc-40ce-802a-f5feb7db0284'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['usbdevice', 'tablet'], ['usb', '1'], ['sdl', '0'], ['xauthority', '/root/.Xauthority'], ['device_model', '/usr/lib/xen/bin/qemu-dm'], ['serial', 'pty'], ['vnc', '1'], ['boot', 'cd']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3E:1B:52:5D']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3E:3B:82:BB']]], ['device', ['vbd', ['backend', 0], ['dev', 'hdd:cdrom'], ['uname', 'phy:/dev/cdwriter'], ['mode', 'r']]], ['device', ['vbd', ['backend', 0], ['dev', 'hda:disk'], ['uname', 'phy:/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/757782e4-1dbc-40ce-802a-f5feb7db0284.hda'], ['mode', 'w']]], ['state', '----c-'], ['shutdown_reason', 'crash'], ['cpu_time', 33730.675331537997], ['online_vcpus', 1], ['up_time', '447247.942856'], ['start_time', '1174498836.18'], ['store_mfn', 80860]])
[2007-03-26 15:54:46 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:295) parseConfig: config is ['domain', ['domid', 3], ['uuid', '757782e4-1dbc-40ce-802a-f5feb7db0284'], ['vcpus', 1], ['vcpu_avail', 1], ['cpu_weight', 1.0], ['memory', 1016], ['shadow_memory', 9], ['maxmem', 1016], ['features', ''], ['name', '757782e4-1dbc-40ce-802a-f5feb7db0284'], ['on_poweroff', 'destroy'], ['on_reboot', 'restart'], ['on_crash', 'restart'], ['image', ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['usbdevice', 'tablet'], ['usb', '1'], ['sdl', '0'], ['xauthority', '/root/.Xauthority'], ['device_model', '/usr/lib/xen/bin/qemu-dm'], ['serial', 'pty'], ['vnc', '1'], ['boot', 'cd']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3E:1B:52:5D']]], ['device', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3E:3B:82:BB']]], ['device', ['vbd', ['backend', 0], ['dev', 'hdd:cdrom'], ['uname', 'phy:/dev/cdwriter'], ['mode', 'r']]], ['device', ['vbd', ['backend', 0], ['dev', 'hda:disk'], ['uname', 'phy:/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/757782e4-1dbc-40ce-802a-f5feb7db0284.hda'], ['mode', 'w']]], ['state', '----c-'], ['shutdown_reason', 'crash'], ['cpu_time', 33730.675331537997], ['online_vcpus', 1], ['up_time', '447247.942856'], ['start_time', '1174498836.18'], ['store_mfn', 80860]]
[2007-03-26 15:54:46 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:394) parseConfig: result is {'shadow_memory': 9, 'uuid': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'on_crash': 'restart', 'on_reboot': 'restart', 'localtime': None, 'image': ['hvm', ['kernel', '/usr/lib/xen/boot/hvmloader'], ['usbdevice', 'tablet'], ['usb', '1'], ['sdl', '0'], ['xauthority', '/root/.Xauthority'], ['device_model', '/usr/lib/xen/bin/qemu-dm'], ['serial', 'pty'], ['vnc', '1'], ['boot', 'cd']], 'on_poweroff': 'destroy', 'bootloader_args': None, 'cpus': None, 'name': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'backend': [], 'vcpus': 1, 'cpu_weight': 1.0, 'features': '', 'vcpu_avail': 1, 'memory': 1016, 'device': [('vif', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr0'], ['mac', '00:16:3E:1B:52:5D']]), ('vif', ['vif', ['backend', 0], ['script', 'vif-bridge'], ['bridge', 'xenbr1'], ['mac', '00:16:3E:3B:82:BB']]), ('vbd', ['vbd', ['backend', 0], ['dev', 'hdd:cdrom'], ['uname', 'phy:/dev/cdwriter'], ['mode', 'r']]), ('vbd', ['vbd', ['backend', 0], ['dev', 'hda:disk'], ['uname', 'phy:/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/757782e4-1dbc-40ce-802a-f5feb7db0284.hda'], ['mode', 'w']])], 'bootloader': None, 'cpu': None, 'maxmem': 1016}
[2007-03-26 15:54:46 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:1236) XendDomainInfo.construct: None
[2007-03-26 15:54:46 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:1268) XendDomainInfo.initDomain: 11 1.0
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: boot, val: cd
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: fda, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: fdb, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: soundhw, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: localtime, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: serial, val: pty
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: std-vga, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: isa, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: vcpus, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: acpi, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: usb, val: 1
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: usbdevice, val: tablet
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: dumpdir, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (image:387) args: dumpquota, val: None
[2007-03-26 15:54:46 xend 5241] DEBUG (balloon:127) Balloon: 2403556 KiB free; need 1064328; done.
[2007-03-26 15:54:46 xend 5241] INFO (image:192) buildDomain os=hvm dom=11 vcpus=1
[2007-03-26 15:54:46 xend 5241] DEBUG (image:338) dom = 11
[2007-03-26 15:54:46 xend 5241] DEBUG (image:339) image = /usr/lib/xen/boot/hvmloader
[2007-03-26 15:54:46 xend 5241] DEBUG (image:340) store_evtchn = 1
[2007-03-26 15:54:46 xend 5241] DEBUG (image:341) memsize = 1016
[2007-03-26 15:54:46 xend 5241] DEBUG (image:342) vcpus = 1
[2007-03-26 15:54:46 xend 5241] DEBUG (image:343) pae = 0
[2007-03-26 15:54:46 xend 5241] DEBUG (image:344) acpi = 0
[2007-03-26 15:54:46 xend 5241] DEBUG (image:345) apic = 0
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3E:1B:52:5D', 'handle': '0', 'state': '1', 'backend': '/local/domain/0/backend/vif/11/0'} to /local/domain/11/device/vif/0.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr0', 'domain': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'handle': '0', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/11/device/vif/0', 'mac': '00:16:3E:1B:52:5D', 'online': '1', 'frontend-id': '11'} to /local/domain/0/backend/vif/11/0.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'mac': '00:16:3E:3B:82:BB', 'handle': '1', 'state': '1', 'backend': '/local/domain/0/backend/vif/11/1'} to /local/domain/11/device/vif/1.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:112) DevController: writing {'bridge': 'xenbr1', 'domain': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'handle': '1', 'script': '/etc/xen/scripts/vif-bridge', 'state': '1', 'frontend': '/local/domain/11/device/vif/1', 'mac': '00:16:3E:3B:82:BB', 'online': '1', 'frontend-id': '11'} to /local/domain/0/backend/vif/11/1.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '5696', 'device-type': 'cdrom', 'state': '1', 'backend': '/local/domain/0/backend/vbd/11/5696'} to /local/domain/11/device/vbd/5696.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:112) DevController: writing {'domain': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'frontend': '/local/domain/11/device/vbd/5696', 'dev': 'hdd', 'state': '1', 'params': '/dev/cdwriter', 'mode': 'r', 'online': '1', 'frontend-id': '11', 'type': 'phy'} to /local/domain/0/backend/vbd/11/5696.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:110) DevController: writing {'backend-id': '0', 'virtual-device': '768', 'device-type': 'disk', 'state': '1', 'backend': '/local/domain/0/backend/vbd/11/768'} to /local/domain/11/device/vbd/768.
[2007-03-26 15:54:47 xend 5241] DEBUG (DevController:112) DevController: writing {'domain': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'frontend': '/local/domain/11/device/vbd/768', 'dev': 'hda', 'state': '1', 'params': '/SR-b42931a2-c937-4c54-9171-b097ffa5afb9/images/757782e4-1dbc-40ce-802a-f5feb7db0284.hda', 'mode': 'w', 'online': '1', 'frontend-id': '11', 'type': 'phy'} to /local/domain/0/backend/vbd/11/768.
[2007-03-26 15:54:47 xend 5241] INFO (image:468) spawning device models: /usr/lib/xen/bin/qemu-dm ['/usr/lib/xen/bin/qemu-dm', '-d', '11', '-m', '1016', '-boot', 'cd', '-serial', 'pty', '-usb', '-usbdevice', 'tablet', '-domain-name', '757782e4-1dbc-40ce-802a-f5feb7db0284', '-net', 'nic,vlan=1,macaddr=00:16:3E:1B:52:5D,model=rtl8139', '-net', 'tap,vlan=1,bridge=xenbr0', '-net', 'nic,vlan=2,macaddr=00:16:3E:3B:82:BB,model=rtl8139', '-net', 'tap,vlan=2,bridge=xenbr1', '-vnc', '11', '-k', 'en-us', '-vnclisten', '127.0.0.1']
[2007-03-26 15:54:47 xend 5241] INFO (image:470) device model pid: 31460
[2007-03-26 15:54:47 xend 5241] DEBUG (image:443) Waiting for qemu
[2007-03-26 15:54:47 xend 5241] DEBUG (image:446) status None
[2007-03-26 15:54:48 xend 5241] DEBUG (image:450) status None
[2007-03-26 15:54:49 xend 5241] DEBUG (image:450) status 1
[2007-03-26 15:54:49 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:711) Storing VM details: {'shadow_memory': '9', 'uuid': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'on_reboot': 'restart', 'start_time': '1174946089.47', 'on_poweroff': 'destroy', 'name': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'vcpus': '1', 'vcpu_avail': '1', 'memory': '1016', 'on_crash': 'restart', 'image': '(hvm (kernel /usr/lib/xen/boot/hvmloader) (usbdevice tablet) (usb 1) (sdl 0) (xauthority /root/.Xauthority) (device_model /usr/lib/xen/bin/qemu-dm) (serial pty) (vnc 1) (boot cd))', 'maxmem': '1016'}
[2007-03-26 15:54:49 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:746) Storing domain details: {'console/port': '2', 'name': '757782e4-1dbc-40ce-802a-f5feb7db0284', 'console/limit': '1048576', 'vm': '/vm/757782e4-1dbc-40ce-802a-f5feb7db0284', 'domid': '11', 'cpu/0/availability': 'online', 'memory/target': '1040384', 'store/ring-ref': '113210', 'store/port': '1'}
[2007-03-26 15:54:49 xend 5241] DEBUG (DevController:143) Waiting for devices vif.
[2007-03-26 15:54:49 xend 5241] DEBUG (DevController:149) Waiting for 0.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:149) Waiting for 1.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices usb.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices vbd.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:149) Waiting for 5696.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:149) Waiting for 768.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices irq.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices pci.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices ioports.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices tap.
[2007-03-26 15:54:50 xend 5241] DEBUG (DevController:143) Waiting for devices vtpm.
[2007-03-26 15:54:51 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:923) XendDomainInfo.handleShutdownWatch
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vif/10/0/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vif/10/1/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vbd/10/5696/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vbd/10/768/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend.XendDomainInfo 5241] DEBUG (XendDomainInfo:923) XendDomainInfo.handleShutdownWatch
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vif/11/0/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vif/11/1/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vbd/11/5696/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:476) hotplugStatusCallback /local/domain/0/backend/vbd/11/768/hotplug-status.
[2007-03-26 15:54:51 xend 5241] DEBUG (DevController:490) hotplugStatusCallback 1.
