ESXi 4.1 et ghettoVCB.sh

[user007]

Bonjour à toutes et à tous,

Dans notre environnement, nous avons 3 serveurs ESXi :

• 2 serveurs ESXi 4.0.0 228255
• 1 serveur ESXi 4.1.0 348481

Nous utilisons le script ghettoVCB.sh pour sauvegarder les VMs qui se trouvent sur ces ESXi. Voici le lien de cet outil : http://communities.vmware.com/docs/DOC-8760

Nous en sommes très contents, cela fonctionne bien. Nous l'utilisions déjà lorsque nous ESXi était en version 3.5
L'ESXi 4.1 est en service depuis peu, avant, tous les ESXi était en 4.0.0
Lorsque nous sauvegardons les VMs qui sont sur l'ESXi 4.1, sur 6 VMs, seules 2 sont sauvegardées correctement.
En effet, le sauvegarde commence et au bout d'un certain pourcentage, ça plante.
Nous avons édité les fichiers VMX pour voir s'il y avait une différence entre les 2 VMs qui se sauvegardent correctement et les 4 autres. Nous n'avons rien remarqué.
Nous avons tenté de cloné le disque et de l'ajouter à une nouvelle VM, le problème persiste.

Si on remet ces VMs sur un ESXi 4.0, il n'y a aucun problème. Est-ce que quelqu'un est confronté au même problème ?
Pourriez-vous nous aider s'il vous plaît.

Merci beaucoup pour votre aide et belle journée.

[lavazavio]

Bonjour,

Est-ce qu'il existe des différences entre les 2 VM qui se backup bien et les 4 autres ?
Par exemple, les 2 VM ok ont été créées sous une version 4.0 et importées sur la 4.1, alors que les 4 autres ont été créées à partir de l'ESXi 4.1 ?
Y a t il une différence de taille de disques significative entre les VM qui se backup et les autres ?
etc...

[user007]

Bonjour,

Merci pour votre message.

Alors les 6 VMs était sur du VMware Server et on toutes été converties avec VMware Converter. Non aucune différence de taille.
Voici la liste des VMs :

Nom - Taille - OS
VM1 - 15 Go - Debian 5.0 Lenny x64
VM2 - 20 Go - Windows 2003 Server SP2 x32
VM3 - 8 Go - Linux web 2.6.32-24 server
VM4 - 8 Go - Ubuntu 10.04
VM5 - 20 Go - Windows 2003 Server SP2 x32
VM6 - 10 Go - Windows XP SP3

Les VM1 et VM6 se backup correctement.

Cordialement

[Mygale1978]

Salut,

Code :

1
2
echo "Usage: $0 -f [VM_BACKUP_UP_LIST] -c [VM_CONFIG_DIR] -l [LOG_FILE] -d [DEBUG_LEVEL] -g [GLOBAL_CONF] -e [VM_EXCLUSION_LIST]"

As-tu spécifié un fichier log lors du lancement de ce script? Si oui, Est-ce qu'il y a qqch dans ce log?

Eventuellement activé le mode DEBUG avec l'option -d pour essayer de voir ce qu'il se passe.

[user007]

Bonjour,

Voici le résultat du log :

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
2011-06-27 07:18:16 -- info: ============================== ghettoVCB LOG START ==============================

2011-06-27 07:18:16 -- debug: Succesfully acquired lock directory - /tmp/ghettoVCB.lock

2011-06-27 07:18:16 -- debug: HOST VERSION: VMware ESXi 4.1.0 build-348481
2011-06-27 07:18:16 -- debug: HOST LEVEL: VMware ESXi 4.1.0 Update 1
2011-06-27 07:18:16 -- debug: HOSTNAME: niesen.intra.ceff.ch

2011-06-27 07:18:16 -- info: CONFIG - VERSION = 2011_05_22_1
2011-06-27 07:18:16 -- info: CONFIG - GHETTOVCB_PID = 17152
2011-06-27 07:18:16 -- info: CONFIG - VM_BACKUP_VOLUME = /vmfs/volumes/BackupVMs
2011-06-27 07:18:16 -- info: CONFIG - VM_BACKUP_ROTATION_COUNT = 3
2011-06-27 07:18:16 -- info: CONFIG - VM_BACKUP_DIR_NAMING_CONVENTION = 2011-06-27_07-18-16
2011-06-27 07:18:16 -- info: CONFIG - DISK_BACKUP_FORMAT = thin
2011-06-27 07:18:16 -- info: CONFIG - ADAPTER_FORMAT = buslogic
2011-06-27 07:18:16 -- info: CONFIG - POWER_VM_DOWN_BEFORE_BACKUP = 0
2011-06-27 07:18:16 -- info: CONFIG - ENABLE_HARD_POWER_OFF = 0
2011-06-27 07:18:16 -- info: CONFIG - ITER_TO_WAIT_SHUTDOWN = 3
2011-06-27 07:18:16 -- info: CONFIG - POWER_DOWN_TIMEOUT = 5
2011-06-27 07:18:16 -- info: CONFIG - SNAPSHOT_TIMEOUT = 15
2011-06-27 07:18:16 -- info: CONFIG - LOG_LEVEL = debug
2011-06-27 07:18:16 -- info: CONFIG - BACKUP_LOG_OUTPUT = resultNiesen.txt
2011-06-27 07:18:16 -- info: CONFIG - VM_SNAPSHOT_MEMORY = 0
2011-06-27 07:18:16 -- info: CONFIG - VM_SNAPSHOT_QUIESCE = 0
2011-06-27 07:18:16 -- info: CONFIG - VMDK_FILES_TO_BACKUP = all
2011-06-27 07:18:16 -- info: CONFIG - EMAIL_LOG = 0
2011-06-27 07:18:16 -- info: 
2011-06-27 07:18:20 -- debug: Storage Information before backup: 
2011-06-27 07:18:20 -- debug: SRC_DATASTORE: datastore1
2011-06-27 07:18:20 -- debug: SRC_DATASTORE_CAPACITY: 130.5 GB
2011-06-27 07:18:20 -- debug: SRC_DATASTORE_FREE: 44.5 GB
2011-06-27 07:18:20 -- debug: SRC_DATASTORE_BLOCKSIZE: 1
2011-06-27 07:18:20 -- debug: SRC_DATASTORE_MAX_FILE_SIZE: 256 GB
2011-06-27 07:18:20 -- debug: 
2011-06-27 07:18:20 -- debug: DST_DATASTORE: BackupVMs
2011-06-27 07:18:20 -- debug: DST_DATASTORE_CAPACITY: 1862.5 GB
2011-06-27 07:18:20 -- debug: DST_DATASTORE_FREE: 0.0 GB
2011-06-27 07:18:20 -- debug: DST_DATASTORE_BLOCKSIZE: NA
2011-06-27 07:18:20 -- debug: DST_DATASTORE_MAX_FILE_SIZE: NA
2011-06-27 07:18:20 -- debug: 
2011-06-27 07:18:20 -- debug: getVMDKs() - CTM.vmdk###8:
2011-06-27 07:18:21 -- info: Initiate backup for CTM
2011-06-27 07:18:21 -- info: Creating Snapshot "ghettoVCB-snapshot-2011-06-27" for CTM
2011-06-27 07:18:23 -- debug: Waiting for snapshot "ghettoVCB-snapshot-2011-06-27" to be created
2011-06-27 07:18:23 -- debug: Snapshot timeout set to: 900 seconds
2011-06-27 07:18:23 -- debug: findVMDK() - Searching for VMDK: "CTM.vmdk" to backup
2011-06-27 07:18:23 -- debug: /sbin/vmkfstools -i "/vmfs/volumes/datastore1/CTM/CTM.vmdk" -a "buslogic" -d "thin" "/vmfs/volumes/BackupVMs/CTM/CTM-2011-06-27_07-18-16/CTM.vmdk"
Destination disk format: VMFS thin-provisioned
Cloning disk '/vmfs/volumes/datastore1/CTM/CTM.vmdk'...

Clone: 0% done.
Clone: 1% done.
Clone: 2% done.
Clone: 3% done.
Clone: 4% done.
Clone: 5% done.
Clone: 6% done.
Clone: 7% done.
Clone: 8% done.
Clone: 9% done.
Clone: 10% done.
Clone: 11% done.
Clone: 12% done.
Clone: 13% done.
Clone: 14% done.
Clone: 15% done.
Clone: 16% done.
Clone: 17% done.
Clone: 18% done.
Clone: 19% done.
Clone: 20% done.
Clone: 21% done.
Clone: 22% done.
Clone: 23% done.
Clone: 24% done.
Clone: 25% done.
Clone: 26% done.
Clone: 27% done.Failed to clone disk : Input/output error (327689).

2011-06-27 07:21:41 -- info: ERROR: error in backing up of "/vmfs/volumes/datastore1/CTM/CTM.vmdk" for CTM
2011-06-27 07:21:43 -- info: Removing snapshot from CTM ...
2011-06-27 07:21:43 -- info: Backup Duration: 3.37 Minutes
2011-06-27 07:21:43 -- info: ERROR: Unable to backup CTM due to error in VMDK backup!

2011-06-27 07:21:43 -- info: ###### Final status: ERROR: No VMs backed up! ######

2011-06-27 07:21:43 -- debug: Succesfully removed lock directory - /tmp/ghettoVCB.lock

2011-06-27 07:21:43 -- info: ============================== ghettoVCB LOG END ================================

De plus, ce week-end, le serveur a planté. Perte de connexion, les VMs ne répondaient plus. Pas moyen d'éteindre ou de redémarrer le serveur en ligne de commande, il a fallu faire un hard reset.

En regardant dans les logs, j'ai vu ceci :

Code :

1
2
3
4
5
6
7
8
9
10
11
12
13
14
Jun 25 11:55:22 Hostd: [2011-06-25 11:55:22.233 415C3B90 info 'Vmomi'] Throw vmodl.fault.RequestCanceled
Jun 25 11:55:22 Hostd: [2011-06-25 11:55:22.233 415C3B90 info 'Vmomi'] Result:
Jun 25 11:55:22 Hostd: (vmodl.fault.RequestCanceled) {
Jun 25 11:55:22 Hostd:    dynamicType = <unset>, 
Jun 25 11:55:22 Hostd:    faultCause = (vmodl.MethodFault) null, 
Jun 25 11:55:22 Hostd:    msg = "", 
Jun 25 11:55:22 Hostd: }
Jun 25 11:55:22 Hostd: [2011-06-25 11:55:22.234 40CEFB90 error 'App'] Failed to read header on stream TCP(local=127.0.0.1:53972, peer=127.0.0.1:0): N7Vmacore15SystemExceptionE(Connection reset by peer)
Jun 25 11:55:55 Hostd: [2011-06-25 11:55:55.614 40E81B90 verbose 'Cimsvc'] Ticket issued for CIMOM version 1.0, user root
Jun 25 11:57:26 Hostd: [2011-06-25 11:57:26.116 417CDB90 verbose 'Cimsvc'] Ticket issued for CIMOM version 1.0, user root
Jun 25 11:57:27 Hostd: [2011-06-25 11:57:27.087 41740B90 verbose 'vm:/vmfs/volumes/4d395453-fe818802-42b3-0019b9f1df7d/ServeurICH/ServeurICH.vmx'] Actual VM overhead: 162324480 bytes
Jun 25 11:57:27 Hostd: [2011-06-25 11:57:27.087 41740B90 verbose 'Vmsvc'] RefreshVms updated overhead for 1 VM
Jun 25 11:58:24 Hostd: [2011-06-25 11:58:24.870 41C81B90 verbose 'DvsManager'] PersistAllDvsInfo called

Sur ce post, j'ai vu que d'autres personnes avaient le même problème avec la version 4.1 de ESXi. Je ne sais pas si c'est lié, mais bon.
http://communities.vmware.com/message/1617408

Merci pour votre aide et belle journée.

[user007]

Est-ce que quelqu'un peut m'aider s'il vous plaît ?

Je viens juste de mettre à jour mon ESXi 4.1 de la release 348481 à 381591 mais le problème est toujours le même.

Merci pour votre aide et belle journée.

[vpourchet]

DST_DATASTORE: BackupVMs
2011-06-27 07:18:20 -- debug: DST_DATASTORE_CAPACITY: 1862.5 GB
2011-06-27 07:18:20 -- debug: DST_DATASTORE_FREE: 0.0 GB
2011-06-27 07:18:20 -- debug: DST_DATASTORE_BLOCKSIZE: NA
2011-06-27 07:18:20 -- debug: DST_DATASTORE_MAX_FILE_SIZE: NA

-> -> -> ->

non ?

[user007]

Bonjour,

Cette ligne est totalement fausse. Même si je backup les deux VMs qui fonctionnent, il met aussi que l'espace disponible est de 0 alors qu'il y a 1.6 To de libre.

Le problème ne vient donc pas de là

Merci pour votre aide.