ich habe mal eine Frage oder besser gesagt Problem mit dem wunderbaren ghettoVCBg2 Skript.
Zuerst ein kleiner Überblick
vSphere 4.1 Essential
1 Cisco UCS C200 M2 Server
1 QNAP TS459ProII (als NFS Storage)
1 QNAP TS219ProII+ (als NFS Backup)
Ich habe mir das ghettoVCBg2 Skript auf dem vMA eingerichtet und lasse das ganze per plink von einem Windows Server aus starten. Dies funktioniert auch wunderbar. Allerdings habe ich folgendes PRoblem : Gesichert werden sollen 4 VMs, dazu habe ich eine Backupliste erstellt auf die ghettoVCBg2 zugreifen soll. Er fängt auch mit dem ersten Server in der Liste an und sichert diesen wie gewünscht, die anderen zeigt er auch an das er sie sichern will, tut es aber leider nicht. Ich habe mal einfach den ersten Server in meiner Liste gegen einen anderen getauscht (Srv1 gegen Srv3) und daraufhin wird Srv3 auch gesichert.
Hier erstmal das LOG
09-08-2011 08:21:51 -- info: ============================== ghettoVCBg2 LOG START ==============================
09-08-2011 08:21:51 -- info: CONFIG - BACKUP_LOG_OUTPUT = /tmp/ghettoVCBg2.log
09-08-2011 08:21:51 -- info: CONFIG - VM_BACKUP_DATASTORE = QNAP-Backupstore (NAS)
09-08-2011 08:21:51 -- info: CONFIG - VM_BACKUP_DIRECTORY = BACKUP
09-08-2011 08:21:51 -- info: CONFIG - DISK_BACKUP_FORMAT = zeroedthick
09-08-2011 08:21:51 -- info: CONFIG - ADAPTER_FORMAT = buslogic
09-08-2011 08:21:51 -- info: CONFIG - POWER_VM_DOWN_BEFORE_BACKUP = NO
09-08-2011 08:21:51 -- info: CONFIG - VM_SNAPSHOT_MEMORY = NO
09-08-2011 08:21:51 -- info: CONFIG - VM_SNAPSHOT_QUIESCE = NO
09-08-2011 08:21:51 -- info: CONFIG - VM_BACKUP_DIR_NAMING_CONVENTION = 2011-09-08
09-08-2011 08:21:51 -- info: CONFIG - VM_VMDK_FILES = all
09-08-2011 08:21:51 -- debug: Main: Login by vi-fastpass to: esxi-01.verwaltung.local
09-08-2011 08:21:51 -- debug: copyTask: Task START
09-08-2011 08:21:51 -- debug: copyTask: waiting for next job and sleep ...
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO ES211i01.verwaltung.local ----------
09-08-2011 08:21:54 -- info: DEBUG - Host Build: VMware ESXi 4.1.0 build-381591
09-08-2011 08:21:54 -- info: DEBUG - License: esxExpress
09-08-2011 08:21:54 -- info: DEBUG - Host: esxi-01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - Virtual Machine: ES211i01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - VM ConfigPath: [QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - VMX File: ES211i01.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupConfigPath: [QNAP-Backupstore (NAS)] BACKUP/ES211i01.verwaltung.local/ES211i01.verwaltung.local-2011-09-08/ES211i01.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupPath: [QNAP-Backupstore (NAS)] BACKUP/ES211i01.verwaltung.local/ES211i01.verwaltung.local-2011-09-08
09-08-2011 08:21:54 -- info: DEBUG - VM Datastore: QNAP-Datastore02 (SAN)
09-08-2011 08:21:54 -- info: DEBUG - VMDK(s):
09-08-2011 08:21:54 -- info: DEBUG - [QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local.vmdk
09-08-2011 08:21:54 -- info: DEBUG - [QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local_1.vmdk
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO ES211i01.verwaltung.local ----------
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO DB211i01.verwaltung.local ----------
09-08-2011 08:21:54 -- info: DEBUG - Host Build: VMware ESXi 4.1.0 build-381591
09-08-2011 08:21:54 -- info: DEBUG - License: esxExpress
09-08-2011 08:21:54 -- info: DEBUG - Host: esxi-01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - Virtual Machine: DB211i01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - VM ConfigPath: [QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - VMX File: DB211i01.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupConfigPath: [QNAP-Backupstore (NAS)] BACKUP/DB211i01.verwaltung.local/DB211i01.verwaltung.local-2011-09-08/DB211i01.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupPath: [QNAP-Backupstore (NAS)] BACKUP/DB211i01.verwaltung.local/DB211i01.verwaltung.local-2011-09-08
09-08-2011 08:21:54 -- info: DEBUG - VM Datastore: QNAP-Datastore02 (SAN)
09-08-2011 08:21:54 -- info: DEBUG - VMDK(s):
09-08-2011 08:21:54 -- info: DEBUG - [QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local.vmdk
09-08-2011 08:21:54 -- info: DEBUG - [QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local_1.vmdk
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO DB211i01.verwaltung.local ----------
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO NT_SERVER.verwaltung.local ----------
09-08-2011 08:21:54 -- info: DEBUG - Host Build: VMware ESXi 4.1.0 build-381591
09-08-2011 08:21:54 -- info: DEBUG - License: esxExpress
09-08-2011 08:21:54 -- info: DEBUG - Host: esxi-01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - Virtual Machine: NT_SERVER.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - VM ConfigPath: [QNAP-Datastore02 (SAN)] NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - VMX File: NT_SERVER.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupConfigPath: [QNAP-Backupstore (NAS)] BACKUP/NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local-2011-09-08/NT_SERVER.verwaltung.local.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupPath: [QNAP-Backupstore (NAS)] BACKUP/NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local-2011-09-08
09-08-2011 08:21:54 -- info: DEBUG - VM Datastore: QNAP-Datastore02 (SAN)
09-08-2011 08:21:54 -- info: DEBUG - VMDK(s):
09-08-2011 08:21:54 -- info: DEBUG - [QNAP-Datastore02 (SAN)] NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local.vmdk
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO NT_SERVER.verwaltung.local ----------
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO TS211i01.verwaltung.local ----------
09-08-2011 08:21:54 -- info: DEBUG - Host Build: VMware ESXi 4.1.0 build-381591
09-08-2011 08:21:54 -- info: DEBUG - License: esxExpress
09-08-2011 08:21:54 -- info: DEBUG - Host: esxi-01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - Virtual Machine: TS211i01.verwaltung.local
09-08-2011 08:21:54 -- info: DEBUG - VM ConfigPath: [QNAP-Datastore02 (SAN)] TS211i01/TS211i01.vmx
09-08-2011 08:21:54 -- info: DEBUG - VMX File: TS211i01.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupConfigPath: [QNAP-Backupstore (NAS)] BACKUP/TS211i01.verwaltung.local/TS211i01.verwaltung.local-2011-09-08/TS211i01.vmx
09-08-2011 08:21:54 -- info: DEBUG - BackupPath: [QNAP-Backupstore (NAS)] BACKUP/TS211i01.verwaltung.local/TS211i01.verwaltung.local-2011-09-08
09-08-2011 08:21:54 -- info: DEBUG - VM Datastore: QNAP-Datastore02 (SAN)
09-08-2011 08:21:54 -- info: DEBUG - VMDK(s):
09-08-2011 08:21:54 -- info: DEBUG - [QNAP-Datastore02 (SAN)] TS211i01/TS211i01-1.vmdk
09-08-2011 08:21:54 -- info: ---------- DRYRUN DEBUG INFO TS211i01.verwaltung.local ----------
09-08-2011 08:21:54 -- debug: Main: Disconnect from: esxi-01.verwaltung.local
09-08-2011 08:21:54 -- debug: Main: Calling final clean up
09-08-2011 08:21:54 -- debug: cleanUP: Thread clean up starting ...
09-08-2011 08:21:54 -- debug: cleanUp: CopyTask was never started, send copyTaskStart
09-08-2011 08:21:54 -- debug: cleanUp: Send exit to copyThread
09-08-2011 08:21:54 -- debug: copyTask: Wake up and follow the white rabbit, with status: exit
09-08-2011 08:21:54 -- debug: copyTask: die ...
09-08-2011 08:21:54 -- debug: cleanUp: Join passed
09-08-2011 08:21:54 -- info: ============================== ghettoVCBg2 LOG END ==============================
Hier dann der Inhalt der virtual_machine_backup_list
ES211i01.verwaltung.local
DB211i01.verwaltung.local
NT_Server.verwaltung.local
TS211i01.verwaltung.local
Habe ich evtl. was falsch eingerichtet? Ich hoffe ihr könnt mir auf die Sprünge helfen
Dies ist übringes ein Log wo alle VMs erfolgreich gesichert wurden
09-02-2011 20:58:26 -- info: ============================== ghettoVCBg2 LOG START ==============================
09-02-2011 20:58:26 -- debug: copyTask: Task START
09-02-2011 20:58:26 -- debug: copyTask: waiting for next job and sleep ...
09-02-2011 20:58:26 -- info: CONFIG - BACKUP_LOG_OUTPUT = /tmp/ghettoVCBg2.log
09-02-2011 20:58:26 -- info: CONFIG - VM_BACKUP_DATASTORE = QNAP-Backupstore (NAS)
09-02-2011 20:58:26 -- info: CONFIG - VM_BACKUP_DIRECTORY = BACKUP
09-02-2011 20:58:26 -- info: CONFIG - DISK_BACKUP_FORMAT = zeroedthick
09-02-2011 20:58:26 -- info: CONFIG - ADAPTER_FORMAT = buslogic
09-02-2011 20:58:26 -- info: CONFIG - POWER_VM_DOWN_BEFORE_BACKUP = NO
09-02-2011 20:58:26 -- info: CONFIG - VM_SNAPSHOT_MEMORY = NO
09-02-2011 20:58:26 -- info: CONFIG - VM_SNAPSHOT_QUIESCE = NO
09-02-2011 20:58:26 -- info: CONFIG - VM_BACKUP_DIR_NAMING_CONVENTION = 2011-09-02
09-02-2011 20:58:26 -- info: CONFIG - VM_VMDK_FILES = all
09-02-2011 20:58:26 -- debug: Main: Login by vi-fastpass to: esxi-01.verwaltung.local
09-02-2011 20:58:29 -- info: Initiate backup for DB211i01.verwaltung.local found on esxi-01.verwaltung.local
09-02-2011 20:58:32 -- debug: DB211i01.verwaltung.local original powerState: poweredOn
09-02-2011 20:58:32 -- debug: Creating Snapshot "ghettoVCBg2-snapshot-2011-09-02" for DB211i01.verwaltung.local
09-02-2011 20:58:42 -- info: DB211i01.verwaltung.local has 2 VMDK(s)
09-02-2011 20:58:42 -- debug: backupVMDK: Backing up "[QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local.vmdk" to "[QNAP-Backupstore (NAS)] BACKUP/DB211i01.verwaltung.local/DB211i01.verwaltung.local-2011-09-02/DB211i01.verwaltung.local.vmdk"
09-02-2011 20:58:42 -- debug: backupVMDK: Signal copyThread to start
09-02-2011 20:58:42 -- debug: backupVMDK: Backup progress: Elapsed time 0 min
09-02-2011 20:58:42 -- debug: copyTask: Wake up and follow the white rabbit, with status: doCopy
09-02-2011 20:58:42 -- debug: CopyThread: Start backing up VMDK(s) ...
09-02-2011 21:13:43 -- debug: backupVMDK: Backup progress: Elapsed time 15 min
09-02-2011 21:28:45 -- debug: backupVMDK: Backup progress: Elapsed time 30 min
09-02-2011 21:41:29 -- debug: copyTask: send copySuccess message ...
09-02-2011 21:41:29 -- debug: copyTask: waiting for next job and sleep ...
09-02-2011 21:41:46 -- debug: backupVMDK: Successfully completed backup for [QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local.vmdk Elapsed time: 43 min
09-02-2011 21:41:46 -- debug: backupVMDK: Backing up "[QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local_1.vmdk" to "[QNAP-Backupstore (NAS)] BACKUP/DB211i01.verwaltung.local/DB211i01.verwaltung.local-2011-09-02/DB211i01.verwaltung.local_1.vmdk"
09-02-2011 21:41:46 -- debug: backupVMDK: Signal copyThread to start
09-02-2011 21:41:46 -- debug: backupVMDK: Backup progress: Elapsed time 0 min
09-02-2011 21:41:46 -- debug: copyTask: Wake up and follow the white rabbit, with status: doCopy
09-02-2011 21:41:46 -- debug: CopyThread: Start backing up VMDK(s) ...
09-02-2011 21:56:47 -- debug: backupVMDK: Backup progress: Elapsed time 15 min
09-02-2011 22:11:48 -- debug: backupVMDK: Backup progress: Elapsed time 30 min
09-02-2011 22:26:49 -- debug: backupVMDK: Backup progress: Elapsed time 45 min
09-02-2011 22:41:50 -- debug: backupVMDK: Backup progress: Elapsed time 60 min
09-02-2011 22:56:52 -- debug: backupVMDK: Backup progress: Elapsed time 75 min
09-02-2011 23:11:53 -- debug: backupVMDK: Backup progress: Elapsed time 90 min
09-02-2011 23:26:54 -- debug: backupVMDK: Backup progress: Elapsed time 105 min
09-02-2011 23:41:42 -- debug: copyTask: send copySuccess message ...
09-02-2011 23:41:42 -- debug: copyTask: waiting for next job and sleep ...
09-02-2011 23:41:55 -- debug: backupVMDK: Successfully completed backup for [QNAP-Datastore02 (SAN)] DB211i01.verwaltung.local/DB211i01.verwaltung.local_1.vmdk Elapsed time: 120 min
09-02-2011 23:42:21 -- debug: Removing Snapshot "ghettoVCBg2-snapshot-2011-09-02" for DB211i01.verwaltung.local
09-02-2011 23:42:22 -- debug: checkVMBackupRotation: Starting ...
09-02-2011 23:42:32 -- debug: Purging [QNAP-Backupstore (NAS)] BACKUP/DB211i01.verwaltung.local/DB211i01.verwaltung.local-2011-09-01--2 due to rotation max
09-02-2011 23:42:35 -- info: Backup completed for DB211i01.verwaltung.local!
09-02-2011 23:42:35 -- info: Initiate backup for ES211i01.verwaltung.local found on esxi-01.verwaltung.local
09-02-2011 23:42:38 -- debug: ES211i01.verwaltung.local original powerState: poweredOn
09-02-2011 23:42:38 -- debug: Creating Snapshot "ghettoVCBg2-snapshot-2011-09-02" for ES211i01.verwaltung.local
09-02-2011 23:42:48 -- info: ES211i01.verwaltung.local has 2 VMDK(s)
09-02-2011 23:42:48 -- debug: backupVMDK: Backing up "[QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local.vmdk" to "[QNAP-Backupstore (NAS)] BACKUP/ES211i01.verwaltung.local/ES211i01.verwaltung.local-2011-09-02/ES211i01.verwaltung.local.vmdk"
09-02-2011 23:42:48 -- debug: backupVMDK: Signal copyThread to start
09-02-2011 23:42:48 -- debug: backupVMDK: Backup progress: Elapsed time 0 min
09-02-2011 23:42:48 -- debug: copyTask: Wake up and follow the white rabbit, with status: doCopy
09-02-2011 23:42:48 -- debug: CopyThread: Start backing up VMDK(s) ...
09-02-2011 23:57:49 -- debug: backupVMDK: Backup progress: Elapsed time 15 min
09-03-2011 00:12:50 -- debug: backupVMDK: Backup progress: Elapsed time 30 min
09-03-2011 00:18:54 -- debug: copyTask: send copySuccess message ...
09-03-2011 00:18:54 -- debug: copyTask: waiting for next job and sleep ...
09-03-2011 00:19:51 -- debug: backupVMDK: Successfully completed backup for [QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local.vmdk Elapsed time: 37 min
09-03-2011 00:19:51 -- debug: backupVMDK: Backing up "[QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local_1.vmdk" to "[QNAP-Backupstore (NAS)] BACKUP/ES211i01.verwaltung.local/ES211i01.verwaltung.local-2011-09-02/ES211i01.verwaltung.local_1.vmdk"
09-03-2011 00:19:51 -- debug: backupVMDK: Signal copyThread to start
09-03-2011 00:19:51 -- debug: backupVMDK: Backup progress: Elapsed time 0 min
09-03-2011 00:19:51 -- debug: copyTask: Wake up and follow the white rabbit, with status: doCopy
09-03-2011 00:19:51 -- debug: CopyThread: Start backing up VMDK(s) ...
09-03-2011 00:34:52 -- debug: backupVMDK: Backup progress: Elapsed time 15 min
09-03-2011 00:49:53 -- debug: backupVMDK: Backup progress: Elapsed time 30 min
09-03-2011 01:04:55 -- debug: backupVMDK: Backup progress: Elapsed time 45 min
09-03-2011 01:19:56 -- debug: backupVMDK: Backup progress: Elapsed time 60 min
09-03-2011 01:34:57 -- debug: backupVMDK: Backup progress: Elapsed time 75 min
09-03-2011 01:49:58 -- debug: backupVMDK: Backup progress: Elapsed time 90 min
09-03-2011 02:04:59 -- debug: backupVMDK: Backup progress: Elapsed time 105 min
09-03-2011 02:11:37 -- debug: copyTask: send copySuccess message ...
09-03-2011 02:11:37 -- debug: copyTask: waiting for next job and sleep ...
09-03-2011 02:12:00 -- debug: backupVMDK: Successfully completed backup for [QNAP-Datastore02 (SAN)] ES211i01.verwaltung.local/ES211i01.verwaltung.local_1.vmdk Elapsed time: 112 min
09-03-2011 02:15:28 -- debug: Removing Snapshot "ghettoVCBg2-snapshot-2011-09-02" for ES211i01.verwaltung.local
09-03-2011 02:15:29 -- debug: checkVMBackupRotation: Starting ...
09-03-2011 02:15:34 -- info: Backup completed for ES211i01.verwaltung.local!
09-03-2011 02:15:34 -- info: Initiate backup for NT_SERVER.verwaltung.local found on esxi-01.verwaltung.local
09-03-2011 02:15:37 -- debug: NT_SERVER.verwaltung.local original powerState: poweredOn
09-03-2011 02:15:37 -- debug: Creating Snapshot "ghettoVCBg2-snapshot-2011-09-03" for NT_SERVER.verwaltung.local
09-03-2011 02:15:47 -- info: NT_SERVER.verwaltung.local has 1 VMDK(s)
09-03-2011 02:15:47 -- debug: backupVMDK: Backing up "[QNAP-Datastore02 (SAN)] NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local.vmdk" to "[QNAP-Backupstore (NAS)] BACKUP/NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local-2011-09-02/NT_SERVER.verwaltung.local.vmdk"
09-03-2011 02:15:47 -- debug: backupVMDK: Signal copyThread to start
09-03-2011 02:15:47 -- debug: backupVMDK: Backup progress: Elapsed time 0 min
09-03-2011 02:15:47 -- debug: copyTask: Wake up and follow the white rabbit, with status: doCopy
09-03-2011 02:15:47 -- debug: CopyThread: Start backing up VMDK(s) ...
09-03-2011 02:30:48 -- debug: backupVMDK: Backup progress: Elapsed time 15 min
09-03-2011 02:45:49 -- debug: backupVMDK: Backup progress: Elapsed time 30 min
09-03-2011 03:00:51 -- debug: backupVMDK: Backup progress: Elapsed time 45 min
09-03-2011 03:15:52 -- debug: backupVMDK: Backup progress: Elapsed time 60 min
09-03-2011 03:30:53 -- debug: backupVMDK: Backup progress: Elapsed time 75 min
09-03-2011 03:45:54 -- debug: backupVMDK: Backup progress: Elapsed time 90 min
09-03-2011 04:00:55 -- debug: backupVMDK: Backup progress: Elapsed time 105 min
09-03-2011 04:15:56 -- debug: backupVMDK: Backup progress: Elapsed time 120 min
09-03-2011 04:30:57 -- debug: backupVMDK: Backup progress: Elapsed time 135 min
09-03-2011 04:45:59 -- debug: backupVMDK: Backup progress: Elapsed time 150 min
09-03-2011 05:01:00 -- debug: backupVMDK: Backup progress: Elapsed time 165 min
09-03-2011 05:16:01 -- debug: backupVMDK: Backup progress: Elapsed time 180 min
09-03-2011 05:31:02 -- debug: backupVMDK: Backup progress: Elapsed time 195 min
09-03-2011 05:46:03 -- debug: backupVMDK: Backup progress: Elapsed time 210 min
09-03-2011 06:01:04 -- debug: backupVMDK: Backup progress: Elapsed time 225 min
09-03-2011 06:16:06 -- debug: backupVMDK: Backup progress: Elapsed time 240 min
09-03-2011 06:31:07 -- debug: backupVMDK: Backup progress: Elapsed time 255 min
09-03-2011 06:46:08 -- debug: backupVMDK: Backup progress: Elapsed time 270 min
09-03-2011 07:01:09 -- debug: backupVMDK: Backup progress: Elapsed time 285 min
09-03-2011 07:16:10 -- debug: backupVMDK: Backup progress: Elapsed time 300 min
09-03-2011 07:31:12 -- debug: backupVMDK: Backup progress: Elapsed time 315 min
09-03-2011 07:46:13 -- debug: backupVMDK: Backup progress: Elapsed time 330 min
09-03-2011 08:01:14 -- debug: backupVMDK: Backup progress: Elapsed time 345 min
09-03-2011 08:16:15 -- debug: backupVMDK: Backup progress: Elapsed time 360 min
09-03-2011 08:31:16 -- debug: backupVMDK: Backup progress: Elapsed time 375 min
09-03-2011 08:46:17 -- debug: backupVMDK: Backup progress: Elapsed time 390 min
09-03-2011 09:01:19 -- debug: backupVMDK: Backup progress: Elapsed time 405 min
09-03-2011 09:10:21 -- debug: copyTask: send copySuccess message ...
09-03-2011 09:10:21 -- debug: copyTask: waiting for next job and sleep ...
09-03-2011 09:11:19 -- debug: backupVMDK: Successfully completed backup for [QNAP-Datastore02 (SAN)] NT_SERVER.verwaltung.local/NT_SERVER.verwaltung.local.vmdk Elapsed time: 415 min
09-03-2011 09:12:41 -- debug: Removing Snapshot "ghettoVCBg2-snapshot-2011-09-03" for NT_SERVER.verwaltung.local
09-03-2011 09:12:41 -- debug: checkVMBackupRotation: Starting ...
09-03-2011 09:12:46 -- info: Backup completed for NT_SERVER.verwaltung.local!
09-03-2011 09:12:46 -- info: Initiate backup for TS211i01.verwaltung.local found on esxi-01.verwaltung.local
09-03-2011 09:12:49 -- debug: TS211i01.verwaltung.local original powerState: poweredOn
09-03-2011 09:12:49 -- debug: Creating Snapshot "ghettoVCBg2-snapshot-2011-09-03" for TS211i01.verwaltung.local
09-03-2011 09:12:59 -- info: TS211i01.verwaltung.local has 1 VMDK(s)
09-03-2011 09:12:59 -- debug: backupVMDK: Backing up "[QNAP-Datastore02 (SAN)] TS211i01/TS211i01-1.vmdk" to "[QNAP-Backupstore (NAS)] BACKUP/TS211i01.verwaltung.local/TS211i01.verwaltung.local-2011-09-02/TS211i01-1.vmdk"
09-03-2011 09:12:59 -- debug: backupVMDK: Signal copyThread to start
09-03-2011 09:12:59 -- debug: backupVMDK: Backup progress: Elapsed time 0 min
09-03-2011 09:12:59 -- debug: copyTask: Wake up and follow the white rabbit, with status: doCopy
09-03-2011 09:12:59 -- debug: CopyThread: Start backing up VMDK(s) ...
09-03-2011 09:28:00 -- debug: backupVMDK: Backup progress: Elapsed time 15 min
09-03-2011 09:43:01 -- debug: backupVMDK: Backup progress: Elapsed time 30 min
09-03-2011 09:58:03 -- debug: backupVMDK: Backup progress: Elapsed time 45 min
09-03-2011 10:13:04 -- debug: backupVMDK: Backup progress: Elapsed time 60 min
09-03-2011 10:28:05 -- debug: backupVMDK: Backup progress: Elapsed time 75 min
09-03-2011 10:43:06 -- debug: backupVMDK: Backup progress: Elapsed time 90 min
09-03-2011 10:58:08 -- debug: backupVMDK: Backup progress: Elapsed time 105 min
09-03-2011 11:10:33 -- debug: copyTask: send copySuccess message ...
09-03-2011 11:10:33 -- debug: copyTask: waiting for next job and sleep ...
09-03-2011 11:11:09 -- debug: backupVMDK: Successfully completed backup for [QNAP-Datastore02 (SAN)] TS211i01/TS211i01-1.vmdk Elapsed time: 118 min
09-03-2011 11:12:34 -- debug: Removing Snapshot "ghettoVCBg2-snapshot-2011-09-03" for TS211i01.verwaltung.local
09-03-2011 11:12:34 -- debug: checkVMBackupRotation: Starting ...
09-03-2011 11:12:39 -- info: Backup completed for TS211i01.verwaltung.local!
09-03-2011 11:12:39 -- debug: Main: Disconnect from: esxi-01.verwaltung.local
09-03-2011 11:12:39 -- debug: Main: Calling final clean up
09-03-2011 11:12:39 -- debug: cleanUP: Thread clean up starting ...
09-03-2011 11:12:39 -- debug: cleanUp: Send exit to copyThread
09-03-2011 11:12:39 -- debug: copyTask: Wake up and follow the white rabbit, with status: exit
09-03-2011 11:12:39 -- debug: copyTask: die ...
09-03-2011 11:12:39 -- debug: cleanUp: Join passed
09-03-2011 11:12:39 -- info: ============================== ghettoVCBg2 LOG END ==============================