Mijn vraag
Vanmorgen enorme crash van virtuele host (Proxmox Linux KVM server), vrij snel nadat ik extra swap had toegevoegd omdat ik zag dat hij relatief weinig had (maar in principe was er geen acute nood/reden toe)
Mijn vraag: weet iemand wat er mis ging en/of hoe ik hiertoe kan komen? Want de impact was enorm, en ik weet niet eens wat er mis ging c.q. of die server nog wel te vertrouwen is (nadat alles hersteld is)
Bash-log van mijn acties die (mogelijk/vermoedelijk) geleid hebben tot crash:
Wat er gebeurde is dat alle vm's (die ook op /ssd staan) een crash gaven.
Relevante software en hardware die ik gebruik
HP DL380 Gen10 met RAID
HP Smart Array P408i-a SR Gen10 (BBU / alles ok-status)
Linux vrt14 5.0.21-5-pve #1 SMP PVE 5.0.21-10 (Wed, 13 Nov 2019 08:27:10 +0100) x86_64 GNU/Linux
Wat ik al gevonden of geprobeerd heb
fsck gedaan, vele errors laten repareren, niks opgelost, qemu-img check gedaan op de virtuele images, ook fouten, helaas starten ook virtuele servers niet meer en klagen ze (logischerwijs) ook over corrupties en/of root-disks die niet willen starten.
Corrupte VM's dus, je snapt mijn schrik & frustratie...
Vanmorgen enorme crash van virtuele host (Proxmox Linux KVM server), vrij snel nadat ik extra swap had toegevoegd omdat ik zag dat hij relatief weinig had (maar in principe was er geen acute nood/reden toe)
Mijn vraag: weet iemand wat er mis ging en/of hoe ik hiertoe kan komen? Want de impact was enorm, en ik weet niet eens wat er mis ging c.q. of die server nog wel te vertrouwen is (nadat alles hersteld is)
Bash-log van mijn acties die (mogelijk/vermoedelijk) geleid hebben tot crash:
code:
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
| Linux vrt14 5.0.21-5-pve #1 SMP PVE 5.0.21-10 (Wed, 13 Nov 2019 08:27:10 +0100) x86_64 The programs included with the Debian GNU/Linux system are free software; the exact distribution terms for each program are described in the individual files in /usr/share/doc/*/copyright. Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent permitted by applicable law. Last login: Mon Sep 20 08:15:28 2021 from 145.131.206.197 username@vrt14:~$ htop username@vrt14:~$ cd /ssd username@vrt14:/ssd$ sudo su [sudo] password for username: root@vrt14:/ssd# df -h Filesystem Size Used Avail Use% Mounted on udev 126G 0 126G 0% /dev tmpfs 26G 2.6G 23G 11% /run /dev/mapper/pve-root 7.1G 4.4G 2.4G 65% / tmpfs 126G 63M 126G 1% /dev/shm tmpfs 5.0M 0 5.0M 0% /run/lock tmpfs 126G 0 126G 0% /sys/fs/cgroup /dev/mapper/vg--ssd-ssd 1.8T 1.5T 280G 85% /ssd /dev/sda2 253M 288K 252M 1% /boot/efi 192.168.30.13:/virtual-backups 6.0T 5.2T 770G 88% /mnt/pve/virtual-backups 192.168.30.13:/virtual-storage 6.9T 6.6T 361G 95% /mnt/pve/virtual-storage 192.168.30.13:/virtual-machines 4.0T 633G 3.4T 16% /mnt/pve/virtual-machines /dev/fuse 30M 108K 30M 1% /etc/pve /dev/sda4 190G 17G 164G 9% /root2 tmpfs 26G 0 26G 0% /run/user/1000 root@vrt14:/ssd# cd /ssd root@vrt14:/ssd# ls images lost+found root@vrt14:/ssd# fallocate -l 16G swapfile root@vrt14:/ssd# chmod 600 swapfile root@vrt14:/ssd# mkswap swapfile Setting up swapspace version 1, size = 16 GiB (17179865088 bytes) no label, UUID=d6351852-811f-44e4-9237-90d8809dd31e root@vrt14:/ssd# swapon swapfile root@vrt14:/ssd# nano /etc/fstab root@vrt14:/ssd# swapon NAME TYPE SIZE USED PRIO /dev/dm-1 partition 3.6G 3.6G -2 /root2/swapfile file 16G 16G -3 /ssd/swapfile file 16G 3.7G -4 |
Wat er gebeurde is dat alle vm's (die ook op /ssd staan) een crash gaven.
code:
1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
123
124
125
126
127
128
129
130
131
132
133
134
135
136
137
138
139
140
141
142
143
144
145
146
147
148
149
150
151
152
153
154
155
156
157
158
159
160
161
162
163
164
165
166
167
168
169
170
171
172
173
174
175
176
177
178
179
180
181
182
183
184
185
186
187
188
189
190
191
192
193
194
195
196
197
198
199
200
201
202
203
204
205
206
207
208
209
210
211
212
213
214
215
216
217
218
219
220
221
222
223
224
225
226
227
228
229
230
231
232
233
234
235
236
237
238
239
240
241
242
243
244
245
246
247
248
249
250
251
252
253
254
255
256
257
258
259
260
261
262
263
264
265
266
267
268
269
270
271
272
273
274
275
| Oct 26 09:23:17 vrt14 systemd[1]: Started User Manager for UID 1000. Oct 26 09:23:17 vrt14 systemd[1]: Started Session 19945 of user username. Oct 26 09:24:00 vrt14 systemd[1]: Starting Proxmox VE replication runner... Oct 26 09:24:01 vrt14 systemd[1]: pvesr.service: Succeeded. Oct 26 09:24:01 vrt14 systemd[1]: Started Proxmox VE replication runner. Oct 26 09:24:56 vrt14 kernel: [60614064.532920] Adding 16777212k swap on /ssd/swapfile. Priority:-4 extents:23313 across:1875214648k SSFS Oct 26 09:25:00 vrt14 systemd[1]: Starting Proxmox VE replication runner... Oct 26 09:25:01 vrt14 systemd[1]: pvesr.service: Succeeded. Oct 26 09:25:01 vrt14 systemd[1]: Started Proxmox VE replication runner. Oct 26 09:26:00 vrt14 systemd[1]: Starting Proxmox VE replication runner... Oct 26 09:26:01 vrt14 systemd[1]: pvesr.service: Succeeded. Oct 26 09:26:01 vrt14 systemd[1]: Started Proxmox VE replication runner. Oct 26 09:26:11 vrt14 kernel: [60614139.572133] show_signal_msg: 9 callbacks suppressed Oct 26 09:26:11 vrt14 kernel: [60614139.572136] kvm[32423]: segfault at 0 ip 00007efc5ca81709 sp 00007efc4ef7a570 error 4 in libjemalloc.so.2[7efc5ca65000+83000] Oct 26 09:26:11 vrt14 kernel: [60614139.572146] Code: 0f 85 13 02 00 00 48 89 e8 48 c1 e8 09 25 f8 ff 1f 00 48 03 46 08 48 8b 18 4d 8d 5c 24 28 48 c1 e3 10 48 c1 fb 10 48 83 e3 fe <48> 8b 33 48 81 e6 ff ff 03 fc 48 81 ce 00 00 90 00 48 89 33 4d 85 Oct 26 09:26:11 vrt14 kernel: [60614139.616352] fwbr150i1: port 2(tap150i1) entered disabled state Oct 26 09:26:11 vrt14 kernel: [60614139.616789] fwbr150i1: port 2(tap150i1) entered disabled state Oct 26 09:26:13 vrt14 kernel: [60614141.492448] fwbr150i0: port 2(tap150i0) entered disabled state Oct 26 09:26:13 vrt14 kernel: [60614141.492862] fwbr150i0: port 2(tap150i0) entered disabled state Oct 26 09:26:13 vrt14 systemd[1]: 150.scope: Succeeded. Oct 26 09:26:14 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:26:14 vrt14 systemd[1]: Created slice User Slice of UID 0. Oct 26 09:26:14 vrt14 systemd[1]: Starting User Runtime Directory /run/user/0... Oct 26 09:26:14 vrt14 systemd[1]: Started User Runtime Directory /run/user/0. Oct 26 09:26:14 vrt14 systemd[1]: Starting User Manager for UID 0... Oct 26 09:26:14 vrt14 systemd[33629]: Reached target Timers. Oct 26 09:26:14 vrt14 systemd[33629]: Starting D-Bus User Message Bus Socket. Oct 26 09:26:14 vrt14 systemd[33629]: Listening on GnuPG cryptographic agent and passphrase cache. Oct 26 09:26:14 vrt14 systemd[33629]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Oct 26 09:26:14 vrt14 systemd[33629]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 26 09:26:14 vrt14 systemd[33629]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Oct 26 09:26:14 vrt14 systemd[33629]: Listening on GnuPG network certificate management daemon. Oct 26 09:26:14 vrt14 systemd[33629]: Reached target Paths. Oct 26 09:26:14 vrt14 systemd[33629]: Listening on D-Bus User Message Bus Socket. Oct 26 09:26:14 vrt14 systemd[33629]: Reached target Sockets. Oct 26 09:26:14 vrt14 systemd[33629]: Reached target Basic System. Oct 26 09:26:14 vrt14 systemd[33629]: Reached target Default. Oct 26 09:26:14 vrt14 systemd[33629]: Startup finished in 94ms. Oct 26 09:26:14 vrt14 systemd[1]: Started User Manager for UID 0. Oct 26 09:26:14 vrt14 systemd[1]: Started Session 19947 of user root. Oct 26 09:26:14 vrt14 qmeventd[12165]: Starting cleanup for 150 Oct 26 09:26:14 vrt14 kernel: [60614142.302766] fwbr150i0: port 1(fwln150i0) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.303134] vmbr1: port 3(fwpr150p0) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.303521] device fwln150i0 left promiscuous mode Oct 26 09:26:14 vrt14 kernel: [60614142.303523] fwbr150i0: port 1(fwln150i0) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.345142] device fwpr150p0 left promiscuous mode Oct 26 09:26:14 vrt14 kernel: [60614142.345146] vmbr1: port 3(fwpr150p0) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.577896] fwbr150i1: port 1(fwln150i1) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.578102] vmbr0: port 7(fwpr150p1) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.578494] device fwln150i1 left promiscuous mode Oct 26 09:26:14 vrt14 kernel: [60614142.578496] fwbr150i1: port 1(fwln150i1) entered disabled state Oct 26 09:26:14 vrt14 kernel: [60614142.640537] device fwpr150p1 left promiscuous mode Oct 26 09:26:14 vrt14 kernel: [60614142.640540] vmbr0: port 7(fwpr150p1) entered disabled state Oct 26 09:26:15 vrt14 qmeventd[12165]: Finished cleanup for 150 Oct 26 09:26:15 vrt14 qm[33648]: VM 150 qmp command failed - VM 150 not running Oct 26 09:26:15 vrt14 systemd[1]: session-19947.scope: Succeeded. Oct 26 09:26:15 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:26:23 vrt14 pvedaemon[33705]: start VM 150: UPID:vrt14:000083A9:1694AF0AD:6177AD9F:qmstart:150:username@pam: Oct 26 09:26:23 vrt14 pvedaemon[47689]: <username@pam> starting task UPID:vrt14:000083A9:1694AF0AD:6177AD9F:qmstart:150:username@pam: Oct 26 09:26:23 vrt14 systemd[1]: Started 150.scope. Oct 26 09:26:23 vrt14 systemd-udevd[33711]: Using default interface naming scheme 'v240'. Oct 26 09:26:23 vrt14 systemd-udevd[33711]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:23 vrt14 systemd-udevd[33711]: Could not generate persistent MAC address for tap150i0: No such file or directory Oct 26 09:26:24 vrt14 kernel: [60614151.785915] device tap150i0 entered promiscuous mode Oct 26 09:26:24 vrt14 systemd-udevd[33711]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33711]: Could not generate persistent MAC address for fwbr150i0: No such file or directory Oct 26 09:26:24 vrt14 systemd-udevd[33715]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33715]: Using default interface naming scheme 'v240'. Oct 26 09:26:24 vrt14 systemd-udevd[33714]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33715]: Could not generate persistent MAC address for fwpr150p0: No such file or directory Oct 26 09:26:24 vrt14 systemd-udevd[33714]: Using default interface naming scheme 'v240'. Oct 26 09:26:24 vrt14 systemd-udevd[33714]: Could not generate persistent MAC address for fwln150i0: No such file or directory Oct 26 09:26:24 vrt14 kernel: [60614151.835721] fwbr150i0: port 1(fwln150i0) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614151.835723] fwbr150i0: port 1(fwln150i0) entered disabled state Oct 26 09:26:24 vrt14 kernel: [60614151.835883] device fwln150i0 entered promiscuous mode Oct 26 09:26:24 vrt14 kernel: [60614151.835949] fwbr150i0: port 1(fwln150i0) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614151.835951] fwbr150i0: port 1(fwln150i0) entered forwarding state Oct 26 09:26:24 vrt14 kernel: [60614151.841872] vmbr1: port 3(fwpr150p0) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614151.841876] vmbr1: port 3(fwpr150p0) entered disabled state Oct 26 09:26:24 vrt14 kernel: [60614151.842008] device fwpr150p0 entered promiscuous mode Oct 26 09:26:24 vrt14 kernel: [60614151.842060] vmbr1: port 3(fwpr150p0) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614151.842062] vmbr1: port 3(fwpr150p0) entered forwarding state Oct 26 09:26:24 vrt14 kernel: [60614151.846860] fwbr150i0: port 2(tap150i0) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614151.846862] fwbr150i0: port 2(tap150i0) entered disabled state Oct 26 09:26:24 vrt14 kernel: [60614151.847035] fwbr150i0: port 2(tap150i0) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614151.847037] fwbr150i0: port 2(tap150i0) entered forwarding state Oct 26 09:26:24 vrt14 systemd-udevd[33711]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33711]: Could not generate persistent MAC address for tap150i1: No such file or directory Oct 26 09:26:24 vrt14 kernel: [60614152.417563] device tap150i1 entered promiscuous mode Oct 26 09:26:24 vrt14 systemd-udevd[33711]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33711]: Could not generate persistent MAC address for fwbr150i1: No such file or directory Oct 26 09:26:24 vrt14 systemd-udevd[33715]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33714]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable. Oct 26 09:26:24 vrt14 systemd-udevd[33714]: Could not generate persistent MAC address for fwln150i1: No such file or directory Oct 26 09:26:24 vrt14 systemd-udevd[33715]: Could not generate persistent MAC address for fwpr150p1: No such file or directory Oct 26 09:26:24 vrt14 kernel: [60614152.472309] fwbr150i1: port 1(fwln150i1) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614152.472312] fwbr150i1: port 1(fwln150i1) entered disabled state Oct 26 09:26:24 vrt14 kernel: [60614152.472458] device fwln150i1 entered promiscuous mode Oct 26 09:26:24 vrt14 kernel: [60614152.472546] fwbr150i1: port 1(fwln150i1) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614152.472549] fwbr150i1: port 1(fwln150i1) entered forwarding state Oct 26 09:26:24 vrt14 kernel: [60614152.481244] vmbr0: port 7(fwpr150p1) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614152.481247] vmbr0: port 7(fwpr150p1) entered disabled state Oct 26 09:26:24 vrt14 kernel: [60614152.481408] device fwpr150p1 entered promiscuous mode Oct 26 09:26:24 vrt14 kernel: [60614152.481475] vmbr0: port 7(fwpr150p1) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614152.481478] vmbr0: port 7(fwpr150p1) entered forwarding state Oct 26 09:26:24 vrt14 kernel: [60614152.489538] fwbr150i1: port 2(tap150i1) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614152.489542] fwbr150i1: port 2(tap150i1) entered disabled state Oct 26 09:26:24 vrt14 kernel: [60614152.489743] fwbr150i1: port 2(tap150i1) entered blocking state Oct 26 09:26:24 vrt14 kernel: [60614152.489746] fwbr150i1: port 2(tap150i1) entered forwarding state Oct 26 09:26:25 vrt14 pvedaemon[47689]: <username@pam> end task UPID:vrt14:000083A9:1694AF0AD:6177AD9F:qmstart:150:username@pam: OK Oct 26 09:26:25 vrt14 systemd[1]: Stopping User Manager for UID 0... Oct 26 09:26:25 vrt14 systemd[33629]: Stopped target Default. Oct 26 09:26:25 vrt14 systemd[33629]: Stopped target Basic System. Oct 26 09:26:25 vrt14 systemd[33629]: Stopped target Timers. Oct 26 09:26:25 vrt14 systemd[33629]: Stopped target Paths. Oct 26 09:26:25 vrt14 systemd[33629]: Stopped target Sockets. Oct 26 09:26:25 vrt14 systemd[33629]: dirmngr.socket: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Closed GnuPG network certificate management daemon. Oct 26 09:26:25 vrt14 systemd[33629]: gpg-agent-extra.socket: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Closed GnuPG cryptographic agent and passphrase cache (restricted). Oct 26 09:26:25 vrt14 systemd[33629]: gpg-agent-ssh.socket: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Closed GnuPG cryptographic agent (ssh-agent emulation). Oct 26 09:26:25 vrt14 systemd[33629]: gpg-agent-browser.socket: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 26 09:26:25 vrt14 systemd[33629]: gpg-agent.socket: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Closed GnuPG cryptographic agent and passphrase cache. Oct 26 09:26:25 vrt14 systemd[33629]: dbus.socket: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Closed D-Bus User Message Bus Socket. Oct 26 09:26:25 vrt14 systemd[33629]: Reached target Shutdown. Oct 26 09:26:25 vrt14 systemd[33629]: systemd-exit.service: Succeeded. Oct 26 09:26:25 vrt14 systemd[33629]: Started Exit the Session. Oct 26 09:26:25 vrt14 systemd[33629]: Reached target Exit the Session. Oct 26 09:26:25 vrt14 systemd[1]: user@0.service: Succeeded. Oct 26 09:26:25 vrt14 systemd[1]: Stopped User Manager for UID 0. Oct 26 09:26:25 vrt14 systemd[1]: Stopping User Runtime Directory /run/user/0... Oct 26 09:26:25 vrt14 systemd[1]: run-user-0.mount: Succeeded. Oct 26 09:26:25 vrt14 systemd[1]: user-runtime-dir@0.service: Succeeded. Oct 26 09:26:25 vrt14 systemd[1]: Stopped User Runtime Directory /run/user/0. Oct 26 09:26:25 vrt14 systemd[32665]: run-user-0.mount: Succeeded. Oct 26 09:26:25 vrt14 systemd[1]: Removed slice User Slice of UID 0. Oct 26 09:26:36 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:26:37 vrt14 systemd[1]: Created slice User Slice of UID 0. Oct 26 09:26:37 vrt14 systemd[1]: Starting User Runtime Directory /run/user/0... Oct 26 09:26:37 vrt14 systemd[1]: Started User Runtime Directory /run/user/0. Oct 26 09:26:37 vrt14 systemd[1]: Starting User Manager for UID 0... Oct 26 09:26:37 vrt14 systemd[33927]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 26 09:26:37 vrt14 systemd[33927]: Listening on GnuPG network certificate management daemon. Oct 26 09:26:37 vrt14 systemd[33927]: Reached target Timers. Oct 26 09:26:37 vrt14 systemd[33927]: Listening on GnuPG cryptographic agent and passphrase cache. Oct 26 09:26:37 vrt14 systemd[33927]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Oct 26 09:26:37 vrt14 systemd[33927]: Starting D-Bus User Message Bus Socket. Oct 26 09:26:37 vrt14 systemd[33927]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Oct 26 09:26:37 vrt14 systemd[33927]: Reached target Paths. Oct 26 09:26:37 vrt14 systemd[33927]: Listening on D-Bus User Message Bus Socket. Oct 26 09:26:37 vrt14 systemd[33927]: Reached target Sockets. Oct 26 09:26:37 vrt14 systemd[33927]: Reached target Basic System. Oct 26 09:26:37 vrt14 systemd[33927]: Reached target Default. Oct 26 09:26:37 vrt14 systemd[33927]: Startup finished in 103ms. Oct 26 09:26:37 vrt14 systemd[1]: Started User Manager for UID 0. Oct 26 09:26:37 vrt14 systemd[1]: Started Session 19949 of user root. Oct 26 09:27:00 vrt14 systemd[1]: Starting Proxmox VE replication runner... Oct 26 09:27:01 vrt14 systemd[1]: pvesr.service: Succeeded. Oct 26 09:27:01 vrt14 systemd[1]: Started Proxmox VE replication runner. Oct 26 09:27:22 vrt14 systemd[1]: session-19949.scope: Succeeded. Oct 26 09:27:22 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:27:24 vrt14 pvedaemon[47689]: <username@pam> starting task UPID:vrt14:00008570:1694B08A3:6177ADDC:qmshutdown:150:username@pam: Oct 26 09:27:24 vrt14 pvedaemon[34160]: shutdown VM 150: UPID:vrt14:00008570:1694B08A3:6177ADDC:qmshutdown:150:username@pam: Oct 26 09:27:32 vrt14 systemd[1]: Stopping User Manager for UID 0... Oct 26 09:27:32 vrt14 systemd[33927]: Stopped target Default. Oct 26 09:27:32 vrt14 systemd[33927]: Stopped target Basic System. Oct 26 09:27:32 vrt14 systemd[33927]: Stopped target Sockets. Oct 26 09:27:32 vrt14 systemd[33927]: dbus.socket: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Closed D-Bus User Message Bus Socket. Oct 26 09:27:32 vrt14 systemd[33927]: gpg-agent-extra.socket: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Closed GnuPG cryptographic agent and passphrase cache (restricted). Oct 26 09:27:32 vrt14 systemd[33927]: gpg-agent.socket: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Closed GnuPG cryptographic agent and passphrase cache. Oct 26 09:27:32 vrt14 systemd[33927]: dirmngr.socket: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Closed GnuPG network certificate management daemon. Oct 26 09:27:32 vrt14 systemd[33927]: gpg-agent-ssh.socket: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Closed GnuPG cryptographic agent (ssh-agent emulation). Oct 26 09:27:32 vrt14 systemd[33927]: Stopped target Timers. Oct 26 09:27:32 vrt14 systemd[33927]: Stopped target Paths. Oct 26 09:27:32 vrt14 systemd[33927]: gpg-agent-browser.socket: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Closed GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 26 09:27:32 vrt14 systemd[33927]: Reached target Shutdown. Oct 26 09:27:32 vrt14 systemd[33927]: systemd-exit.service: Succeeded. Oct 26 09:27:32 vrt14 systemd[33927]: Started Exit the Session. Oct 26 09:27:32 vrt14 systemd[33927]: Reached target Exit the Session. Oct 26 09:27:32 vrt14 systemd[1]: user@0.service: Succeeded. Oct 26 09:27:32 vrt14 systemd[1]: Stopped User Manager for UID 0. Oct 26 09:27:32 vrt14 systemd[1]: Stopping User Runtime Directory /run/user/0... Oct 26 09:27:32 vrt14 systemd[1]: run-user-0.mount: Succeeded. Oct 26 09:27:32 vrt14 systemd[32665]: run-user-0.mount: Succeeded. Oct 26 09:27:32 vrt14 systemd[1]: user-runtime-dir@0.service: Succeeded. Oct 26 09:27:32 vrt14 systemd[1]: Stopped User Runtime Directory /run/user/0. Oct 26 09:27:32 vrt14 systemd[1]: Removed slice User Slice of UID 0. Oct 26 09:27:37 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:27:37 vrt14 systemd[1]: Created slice User Slice of UID 0. Oct 26 09:27:37 vrt14 systemd[1]: Starting User Runtime Directory /run/user/0... Oct 26 09:27:37 vrt14 systemd[1]: Started User Runtime Directory /run/user/0. Oct 26 09:27:37 vrt14 systemd[1]: Starting User Manager for UID 0... Oct 26 09:27:37 vrt14 systemd[34267]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Oct 26 09:27:37 vrt14 systemd[34267]: Listening on GnuPG network certificate management daemon. Oct 26 09:27:37 vrt14 systemd[34267]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Oct 26 09:27:37 vrt14 systemd[34267]: Listening on GnuPG cryptographic agent and passphrase cache. Oct 26 09:27:37 vrt14 systemd[34267]: Starting D-Bus User Message Bus Socket. Oct 26 09:27:37 vrt14 systemd[34267]: Reached target Paths. Oct 26 09:27:37 vrt14 systemd[34267]: Reached target Timers. Oct 26 09:27:37 vrt14 systemd[34267]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Oct 26 09:27:37 vrt14 systemd[34267]: Listening on D-Bus User Message Bus Socket. Oct 26 09:27:37 vrt14 systemd[34267]: Reached target Sockets. Oct 26 09:27:37 vrt14 systemd[34267]: Reached target Basic System. Oct 26 09:27:37 vrt14 systemd[34267]: Reached target Default. Oct 26 09:27:37 vrt14 systemd[34267]: Startup finished in 83ms. Oct 26 09:27:37 vrt14 systemd[1]: Started User Manager for UID 0. Oct 26 09:27:37 vrt14 systemd[1]: Started Session 19951 of user root. Oct 26 09:27:41 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:27:42 vrt14 systemd[1]: Started Session 19953 of user root. Oct 26 09:27:45 vrt14 systemd[1]: session-19953.scope: Succeeded. Oct 26 09:27:45 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:28:00 vrt14 systemd[1]: Starting Proxmox VE replication runner... Oct 26 09:28:00 vrt14 systemd[1]: pvesr.service: Succeeded. Oct 26 09:28:00 vrt14 systemd[1]: Started Proxmox VE replication runner. Oct 26 09:28:24 vrt14 pvedaemon[34160]: VM quit/powerdown failed - got timeout Oct 26 09:28:24 vrt14 pvedaemon[47689]: <username@pam> end task UPID:vrt14:00008570:1694B08A3:6177ADDC:qmshutdown:150:username@pam: VM quit/powerdown failed - got timeout Oct 26 09:28:34 vrt14 kernel: [60614281.913565] EXT4-fs error (device dm-0): ext4_validate_block_bitmap:376: comm kvm: bg 13924: bad block bitmap checksum Oct 26 09:28:34 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:28:58 vrt14 systemd[1]: Started Session 19954 of user username. Oct 26 09:29:00 vrt14 systemd[1]: Starting Proxmox VE replication runner... Oct 26 09:29:01 vrt14 systemd[1]: pvesr.service: Succeeded. Oct 26 09:29:01 vrt14 systemd[1]: Started Proxmox VE replication runner. Oct 26 09:29:03 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:29:15 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:29:21 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:29:22 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:29:23 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:29:40 vrt14 pmxcfs[11901]: [status] notice: received log Oct 26 09:29:40 vrt14 systemd[1]: Started Session 19955 of user root. Oct 26 09:29:44 vrt14 pvedaemon[40343]: Can't locate object method "#000#000#000#000#000" via package "URI::_generic" at /usr/share/perl5/URI.pm line 64. Oct 26 09:29:54 vrt14 pmxcfs[11901]: [status] notice: received log ... paar min later ... Oct 26 09:32:56 vrt14 kernel: [60614544.424452] EXT4-fs error (device dm-0): ext4_validate_block_bitmap:376: comm kvm: bg 9043: bad block bitmap checksum Oct 26 09:32:56 vrt14 kernel: [60614544.424530] EXT4-fs error (device dm-0): ext4_discard_preallocations:4073: comm kvm: Error -74 reading block bitmap for 9043 Oct 26 09:32:56 vrt14 kernel: [60614544.430178] EXT4-fs error (device dm-0): ext4_validate_block_bitmap:376: comm kvm: bg 13310: bad block bitmap checksum Oct 26 09:32:56 vrt14 kernel: [60614544.430239] EXT4-fs error (device dm-0): ext4_discard_preallocations:4065: comm kvm: Error -74 loading buddy information for 13310 Oct 26 09:32:56 vrt14 kernel: [60614544.435025] EXT4-fs error (device dm-0): ext4_validate_block_bitmap:376: comm kvm: bg 9047: bad block bitmap checksum Oct 26 09:32:56 vrt14 kernel: [60614544.435090] EXT4-fs error (device dm-0): ext4_discard_preallocations:4065: comm kvm: Error -74 loading buddy information for 9047 Oct 26 09:32:56 vrt14 kernel: [60614544.435335] EXT4-fs error (device dm-0): ext4_validate_block_bitmap:376: comm kvm: bg 9048: bad block bitmap checksum Oct 26 09:32:56 vrt14 kernel: [60614544.435390] EXT4-fs error (device dm-0): ext4_discard_preallocations:4065: comm kvm: Error -74 loading buddy information for 9048 Oct 26 09:32:56 vrt14 kernel: [60614544.438149] EXT4-fs error (device dm-0): ext4_validate_block_bitmap:376: comm kvm: bg 13299: bad block bitmap checksum Oct 26 09:32:56 vrt14 kernel: [60614544.438206] EXT4-fs error (device dm-0): ext4_discard_preallocations:4073: comm kvm: Error -74 reading block bitmap for 13299 ... reboot ... Oct 26 09:56:51 vrt14 kernel: [ 176.072902] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.073883] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.074518] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.074829] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.074962] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.087147] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.087520] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.103127] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.103537] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) Oct 26 09:56:51 vrt14 kernel: [ 176.107169] EXT4-fs error (device dm-0): ext4_find_extent:913: inode #44957706: comm kvm: pblk 234161639 bad header/extent: invalid magic - magic 0, entries 0, max 0(0), depth 0(0) |
Relevante software en hardware die ik gebruik
HP DL380 Gen10 met RAID
HP Smart Array P408i-a SR Gen10 (BBU / alles ok-status)
Linux vrt14 5.0.21-5-pve #1 SMP PVE 5.0.21-10 (Wed, 13 Nov 2019 08:27:10 +0100) x86_64 GNU/Linux
Wat ik al gevonden of geprobeerd heb
fsck gedaan, vele errors laten repareren, niks opgelost, qemu-img check gedaan op de virtuele images, ook fouten, helaas starten ook virtuele servers niet meer en klagen ze (logischerwijs) ook over corrupties en/of root-disks die niet willen starten.
Corrupte VM's dus, je snapt mijn schrik & frustratie...