one-148-broken-state.txt

Stefan Kooman, 12/02/2015 05:21 PM

Download (22 KB)

 
1 
Dec  2 17:38:43 test-oned2 oned[8488]: [Z0][DiM][D]: Powering off VM 148
2 
Dec  2 17:38:43 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is SHUTDOWN_POWEROFF
3 
Dec  2 17:38:43 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is SHUTDOWN_POWEROFF
4 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 0
5 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 0
6 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Successfully execute virtualization driver operation: shutdown.
7 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Successfully execute virtualization driver operation: shutdown.
8 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: clean: Executed "sudo ovs-ofctl del-flows uplink ,in_port=36,dl_src=02:02:ac:11:e4:03".
9 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: clean: Executed "sudo ovs-ofctl del-flows uplink ,in_port=36,dl_src=02:02:ac:11:e4:03".
10 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: clean: Executed "sudo ovs-ofctl del-flows uplink in_port=36".
11 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: clean: Executed "sudo ovs-ofctl del-flows uplink in_port=36".
12 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 0
13 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 0
14 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Successfully execute network driver operation: clean.
15 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Successfully execute network driver operation: clean.
16 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
17 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
18 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
19 
Dec  2 17:38:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
20 
Dec  2 17:38:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
21 
Dec  2 17:38:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
22 
Dec  2 17:38:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
23 
Dec  2 17:38:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
24 
Dec  2 17:38:51 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
25 
Dec  2 17:38:51 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
26 
Dec  2 17:38:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
27 
Dec  2 17:38:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
28 
Dec  2 17:38:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
29 
Dec  2 17:38:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
30 
Dec  2 17:39:19 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
31 
Dec  2 17:39:19 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
32 
Dec  2 17:39:19 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
33 
Dec  2 17:39:19 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
34 
Dec  2 17:39:19 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
35 
Dec  2 17:39:19 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
36 
Dec  2 17:39:20 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
37 
Dec  2 17:39:20 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
38 
Dec  2 17:39:20 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
39 
Dec  2 17:39:20 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
40 
Dec  2 17:39:35 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
41 
Dec  2 17:39:35 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
42 
Dec  2 17:39:35 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
43 
Dec  2 17:39:35 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
44 
Dec  2 17:39:36 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
45 
Dec  2 17:39:36 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
46 
Dec  2 17:39:36 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
47 
Dec  2 17:39:36 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
48 
Dec  2 17:39:36 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
49 
Dec  2 17:39:36 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
50 
Dec  2 17:39:45 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
51 
Dec  2 17:39:45 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
52 
Dec  2 17:39:45 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
53 
Dec  2 17:39:45 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
54 
Dec  2 17:39:45 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
55 
Dec  2 17:39:45 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
56 
Dec  2 17:39:46 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
57 
Dec  2 17:39:46 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
58 
Dec  2 17:39:46 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
59 
Dec  2 17:39:46 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
60 
Dec  2 17:39:48 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
61 
Dec  2 17:39:48 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
62 
Dec  2 17:39:48 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
63 
Dec  2 17:39:48 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
64 
Dec  2 17:39:49 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
65 
Dec  2 17:39:49 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
66 
Dec  2 17:39:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
67 
Dec  2 17:39:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
68 
Dec  2 17:39:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
69 
Dec  2 17:39:49 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
70 
Dec  2 17:39:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
71 
Dec  2 17:39:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
72 
Dec  2 17:39:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
73 
Dec  2 17:39:50 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
74 
Dec  2 17:39:50 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
75 
Dec  2 17:39:50 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
76 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
77 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
78 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
79 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
80 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
81 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
82 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
83 
Dec  2 17:39:51 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
84 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
85 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
86 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
87 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
88 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
89 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
90 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
91 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
92 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
93 
Dec  2 17:39:53 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
94 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: Command execution fail: /var/lib/one/remotes/tm/qcow2/ln test-oned2.test-cloud.dmz.bit.nl:/var/lib/one//datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3 148 104
95 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: Command execution fail: /var/lib/one/remotes/tm/qcow2/ln test-oned2.test-cloud.dmz.bit.nl:/var/lib/one//datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3 148 104
96 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln: Linking /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 in test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3
97 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln: Linking /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 in test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3
98 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][E]: ln: Command "set -ex
99 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][E]: ln: Command "set -ex
100 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: mkdir -p "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap"
101 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: mkdir -p "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap"
102 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: SNAP="$(ls /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap | sort -n | tail -n 1)"
103 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: SNAP="$(ls /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap | sort -n | tail -n 1)"
104 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: if [ -z "${SNAP}" ]; then
105 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: if [ -z "${SNAP}" ]; then
106 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: SNAP=0
107 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: SNAP=0
108 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln -sf "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9" "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap/0"
109 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln -sf "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9" "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap/0"
110 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: fi
111 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: fi
112 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln -sf "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap/$SNAP" "/var/lib/one/datastores/103/148/disk.3"
113 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln -sf "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap/$SNAP" "/var/lib/one/datastores/103/148/disk.3"
114 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln -sf "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap" "/var/lib/one/datastores/103/148/disk.3.snap"" failed: + mkdir -p /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap
115 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln -sf "/var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap" "/var/lib/one/datastores/103/148/disk.3.snap"" failed: + mkdir -p /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap
116 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + ls /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap
117 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + ls /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap
118 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + sort -n
119 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + sort -n
120 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + tail -n 1
121 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + tail -n 1
122 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + SNAP=019e519ccd4cab21fb0af369e6fe8ad9.snap
123 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + SNAP=019e519ccd4cab21fb0af369e6fe8ad9.snap
124 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + [ -z 019e519ccd4cab21fb0af369e6fe8ad9.snap ]
125 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + [ -z 019e519ccd4cab21fb0af369e6fe8ad9.snap ]
126 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + ln -sf /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap/019e519ccd4cab21fb0af369e6fe8ad9.snap /var/lib/one/datastores/103/148/disk.3
127 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: + ln -sf /var/lib/one/datastores/104/019e519ccd4cab21fb0af369e6fe8ad9.snap/019e519ccd4cab21fb0af369e6fe8ad9.snap /var/lib/one/datastores/103/148/disk.3
128 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln: failed to create symbolic link '/var/lib/one/datastores/103/148/disk.3/019e519ccd4cab21fb0af369e6fe8ad9.snap': No such file or directory
129 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ln: failed to create symbolic link '/var/lib/one/datastores/103/148/disk.3/019e519ccd4cab21fb0af369e6fe8ad9.snap': No such file or directory
130 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][E]: Error linking test-oned2.test-cloud.dmz.bit.nl:/var/lib/one//datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 to test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3
131 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][E]: Error linking test-oned2.test-cloud.dmz.bit.nl:/var/lib/one//datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 to test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3
132 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ExitCode: 1
133 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][I]: ExitCode: 1
134 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][E]: Error executing image transfer script: Error linking test-oned2.test-cloud.dmz.bit.nl:/var/lib/one//datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 to test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3
135 
Dec  2 17:39:54 test-oned2 oned[8488]: [VM 148][Z0][TM][E]: Error executing image transfer script: Error linking test-oned2.test-cloud.dmz.bit.nl:/var/lib/one//datastores/104/019e519ccd4cab21fb0af369e6fe8ad9 to test-ha-host1.test-cloud.dmz.bit.nl:/var/lib/one//datastores/103/148/disk.3
136 
Dec  2 17:39:55 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk attach failure.
137 
Dec  2 17:39:55 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk attach failure.
138 
Dec  2 17:39:55 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
139 
Dec  2 17:39:55 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
140 
Dec  2 17:39:55 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
141 
Dec  2 17:39:55 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
142 
Dec  2 17:39:57 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
143 
Dec  2 17:39:57 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
144 
Dec  2 17:39:57 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
145 
Dec  2 17:39:57 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
146 
Dec  2 17:39:58 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
147 
Dec  2 17:39:58 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
148 
Dec  2 17:39:58 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
149 
Dec  2 17:39:58 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
150 
Dec  2 17:39:58 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
151 
Dec  2 17:39:58 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
152 
Dec  2 17:39:59 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
153 
Dec  2 17:39:59 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
154 
Dec  2 17:39:59 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
155 
Dec  2 17:39:59 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_EPILOG_POWEROFF
156 
Dec  2 17:40:00 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
157 
Dec  2 17:40:00 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully detached.
158 
Dec  2 17:40:00 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
159 
Dec  2 17:40:00 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
160 
Dec  2 17:40:00 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
161 
Dec  2 17:40:00 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
162 
Dec  2 17:40:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
163 
Dec  2 17:40:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
164 
Dec  2 17:40:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
165 
Dec  2 17:40:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is HOTPLUG_PROLOG_POWEROFF
166 
Dec  2 17:40:26 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
167 
Dec  2 17:40:26 test-oned2 oned[8488]: [VM 148][Z0][LCM][I]: VM Disk successfully attached.
168 
Dec  2 17:40:27 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
169 
Dec  2 17:40:27 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
170 
Dec  2 17:40:27 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
171 
Dec  2 17:40:27 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
172 
Dec  2 17:43:24 test-oned2 oned[8488]: [Z0][DiM][D]: Resuming VM 148
173 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
174 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is ACTIVE
175 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is BOOT_POWEROFF
176 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is BOOT_POWEROFF
177 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Generating deployment file: /var/lib/one/vms/148/deployment.19
178 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Generating deployment file: /var/lib/one/vms/148/deployment.19
179 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 0
180 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 0
181 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Successfully execute network driver operation: pre.
182 
Dec  2 17:43:24 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Successfully execute network driver operation: pre.
183 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Command execution fail: cat << EOT | /var/tmp/one/vmm/kvm/deploy '/var/lib/one//datastores/103/148/deployment.19' 'test-ha-host1.test-cloud.dmz.bit.nl' 148 test-ha-host1.test-cloud.dmz.bit.nl
184 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Command execution fail: cat << EOT | /var/tmp/one/vmm/kvm/deploy '/var/lib/one//datastores/103/148/deployment.19' 'test-ha-host1.test-cloud.dmz.bit.nl' 148 test-ha-host1.test-cloud.dmz.bit.nl
185 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: error: Failed to create domain from /var/lib/one//datastores/103/148/deployment.19
186 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: error: Failed to create domain from /var/lib/one//datastores/103/148/deployment.19
187 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: error: internal error: process exited while connecting to monitor: libust[10981/10981]: Warning: HOME environment variable not set. Disabling LTTng-UST per-user tracing. (in setup_local_apps() at lttng-ust-comm.c:305)
188 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: error: internal error: process exited while connecting to monitor: libust[10981/10981]: Warning: HOME environment variable not set. Disabling LTTng-UST per-user tracing. (in setup_local_apps() at lttng-ust-comm.c:305)
189 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: qemu-system-x86_64: -drive file=/var/lib/one//datastores/103/148/disk.3,if=none,id=drive-virtio-disk1,format=qcow2,cache=none,aio=native: could not open disk image /var/lib/one//datastores/103/148/disk.3: Could not open '/var/lib/one//datastores/103/148/disk.3': Is a directory
190 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: qemu-system-x86_64: -drive file=/var/lib/one//datastores/103/148/disk.3,if=none,id=drive-virtio-disk1,format=qcow2,cache=none,aio=native: could not open disk image /var/lib/one//datastores/103/148/disk.3: Could not open '/var/lib/one//datastores/103/148/disk.3': Is a directory
191 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][E]: Could not create domain from /var/lib/one//datastores/103/148/deployment.19
192 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][E]: Could not create domain from /var/lib/one//datastores/103/148/deployment.19
193 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 255
194 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: ExitCode: 255
195 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Failed to execute virtualization driver operation: deploy.
196 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][I]: Failed to execute virtualization driver operation: deploy.
197 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][E]: Error deploying virtual machine: Could not create domain from /var/lib/one//datastores/103/148/deployment.19
198 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VMM][E]: Error deploying virtual machine: Could not create domain from /var/lib/one//datastores/103/148/deployment.19
199 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
200 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New state is POWEROFF
201 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT
202 
Dec  2 17:43:25 test-oned2 oned[8488]: [VM 148][Z0][VM][I]: New LCM state is LCM_INIT