Die Festplatten müssen konsoldiert werden. -> Zugriff nic

chris1234 · Beitragvon **chris1234** » 05.04.2016, 18:06

hallo zusammen,

ich habe folgendes Problem.
Mir ist heute aufgefallen, das ein Backup (Arcserv ) fehlgeschlagen ist.
per Vcenter drauf und siehe da " Die Festplatten der virtuellen Maschine müssen konsoldiert werden.

Ich habe erstmal den Snapshot gelöscht über den snapshotmanager. hat funktioniert.
Danach Snapshot -> Konsolidieren und bekomme eine Fehlermeldung
Zugriff auf eine Datei <unspecified
filename> nicht möglich, weil sie
gesperrt ist.

Die VM läuft noch.
Gibt es eine Möglichkeit im laufenden betrieb es zu bereinigen ?

https://picload.org/image/rggocpad/vm.jpg

LUN hat 1TB und es sind noch 207 GB frei
Die VM hat 2 festplatten:
1 x 40GB
1 x 180 GB

Falls noch Logs benötigt werden kann ich diese nachreichen.

JustMe · Beitragvon **JustMe** » 05.04.2016, 18:22

Der verunstaltete Screenshot zeigt, dass da noch drei bzw. vier Snapshots bestehen, die wegen des tagesaktuellen Zeitstempels auch vmtl. in Benutzung sind.

Schau doch mal, ob da noch irgendwas von der betroffenen VM per HotAdd an der Backup-Appliance gemountet ist. Dann diese Appliance herunterfahren, und die ueberzaehlige/n vmdk aus DEREN Konfiguration entfernen. Danach sollte die Konsolidierung der betroffenen VM durchlaufen. Ansonsten noch 'nen Snapshot erzeugen, und "Alle löschen" auswählen, statt nur "einen bestimmten".

Wenn's das auch nicht ist, braucht's die vmware.log, sowie die KLEINEN .vmdk-Dateien aus dem Verzeichnis der VM. Aber nicht aus dem Datastore-Browser, sondern von der Kommandozeile bzw. WinSCP oder so. Und vmtl. ein Herunterfahren der VM...

chris1234 · Beitragvon **chris1234** » 06.04.2016, 09:52

Da bei uns erst Freitag Abend Wartungsarbeiten anstehen, kann ich erst dann die VM herunterfahren/neustarten.

Könnte was passieren, (VM fällt aus und fährt nicht mehr hoch ? )
wenn ich jetzt einpaar Sachen probiere ? Snapshot erzeugen und alle löschen z.B. ?

JustMe · Beitragvon **JustMe** » 06.04.2016, 10:18

"Koennen" kann immer...
...aber zu erwarten ist's eigentlich nicht.

Die Arbeiten an der Backup-Appliance koennen sowieso ohne Beeintraechtigung der produktiven VM durchgefuehrt werden. Genauso wie die Snapshot-Operationen. Das "Schlimmste" was passieren sollte ist, dass ein weiterer Snapshot angelegt wird, der sich nicht aus dem GUI heraus loeschen laesst.

Und die Log-Infos sowie die kleinen vmdk-Dateien lassen sich auf jeden Fall im laufenden Betrieb einsammeln und herunterladen.

chris1234 · Beitragvon **chris1234** » 06.04.2016, 10:47

ok danke für die Antwort, werde es heute abend mal kurz versuchen.
Was mir auf gefallen ist, ich habe versucht übers Vcenter die vmware.log herunterzuladen und bekomme folgende Fehelrmeldung.
Fehler: Expected put message. Got: Error

wenn ich direkt auf den Esxi Host gehe, klappt es ohne Probleme.

chris1234 · Beitragvon **chris1234** » 06.04.2016, 10:53

[code]
2016-04-02T15:36:16.206Z| vcpu-0| I120: DumpDiskInfo: scsi0:1 createType=11, capacity = 377487360, numLinks = 1, allocationType = 1
2016-04-02T15:36:16.206Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-02T15:36:16.206Z| vcpu-0| I120: DISKUTIL: scsi0:1 : geometry=23497/255/63
2016-04-02T15:36:16.207Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 6 uid 0
2016-04-02T15:36:16.207Z| vcpu-0| I120: Vix: [11834 mainDispatch.c:3870]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1881, success=1 additionalError=0
2016-04-02T15:36:16.221Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: Destroying thread 8
2016-04-02T15:36:16.221Z| vcpu-0| I120: Turning off snapshot info cache.
2016-04-02T15:36:16.222Z| vcpu-0| I120: Turning off snapshot disk cache.
2016-04-02T15:36:16.222Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: Done with consolidate
2016-04-02T15:36:16.227Z| vcpu-1| I120: HBACommon: First write on scsi0:1.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1.vmdk'
2016-04-02T15:36:16.228Z| vcpu-1| I120: DDB: "longContentID" = "c7ccbde94fffebd03f48ae18f4cf39e1" (was "1b6b414083b8d3d7cd4cb7cb2100c05b")
2016-04-02T15:36:16.243Z| vcpu-1| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0x2100c05b, new=0xf4cf39e1 (c7ccbde94fffebd03f48ae18f4cf39e1)
2016-04-02T15:36:45.587Z| vcpu-1| I120: HBACommon: First write on scsi0:0.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk'
2016-04-02T15:36:45.588Z| vcpu-1| I120: DDB: "longContentID" = "c367b7c0745d35f9e018c538adf9524f" (was "00ee25809de6cccf0cd7290fa3461fc5")
2016-04-02T15:36:45.607Z| vcpu-1| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0xa3461fc5, new=0xadf9524f (c367b7c0745d35f9e018c538adf9524f)
2016-04-02T15:37:10.596Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-02T15:37:14.686Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-02T15:37:16.225Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-02T18:24:07.196Z| vcpu-0| I120: ide1:0: Command *UNKNOWN (0x4a)* took 4.255 seconds (ok)
2016-04-04T23:06:00.552Z| vmx| I120: Vix: [11011 vigorCommands.c:481]: VigorSnapshotManager_Take: takeOptions=8, clientFlags=0, displayName=_ARCSERVE-BACKUP_J5916_S39662_05.04.2016 01:06:00
2016-04-04T23:06:00.556Z| vmx| I120: SnapshotVMX_TakeSnapshot start: '_ARCSERVE-BACKUP_J5916_S39662_05.04.2016 01:06:00', deviceState=0, logging=0, quiesced=1, forceNative=0, tryNative=0, sibling=0 saveAllocMaps=0 cb=1DDCFB90, cbData=1EC36E40
2016-04-04T23:06:00.595Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (65557) size = 42949672960, hd = 0. Type 3
2016-04-04T23:06:00.596Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:00.598Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (65557) size = 193273528320, hd = 0. Type 3
2016-04-04T23:06:00.598Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:01.399Z| vcpu-0| I120: ToolsBackup: changing quiesce state: IDLE -> STARTED
2016-04-04T23:06:14.057Z| vcpu-0| I120: ToolsBackup: changing quiesce state: STARTED -> COMMITTED
2016-04-04T23:06:14.057Z| vcpu-0| I120: Destroying virtual dev for scsi0:0 vscsi=10369
2016-04-04T23:06:14.057Z| vcpu-0| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-04T23:06:14.060Z| vcpu-0| I120: Destroying virtual dev for scsi0:1 vscsi=10370
2016-04-04T23:06:14.060Z| vcpu-0| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-04T23:06:14.072Z| vcpu-0| I120: SnapshotVMXTakeSnapshotCB: Enter checkpoint status 1, mode 0.
2016-04-04T23:06:14.072Z| vcpu-0| I120: Closing all the disks of the VM.
2016-04-04T23:06:14.072Z| vcpu-0| I120: Closing disk scsi0:0
2016-04-04T23:06:14.074Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 135334631.
2016-04-04T23:06:14.074Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:14.152Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:14.152Z| vcpu-0| I120: Closing disk scsi0:1
2016-04-04T23:06:14.154Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 49482474.
2016-04-04T23:06:14.154Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:14.229Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:14.230Z| vcpu-0| I120: SNAPSHOT: SnapshotConfigInfoReadEx: Creating new snapshot dictionary, '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmsd.usd'.
2016-04-04T23:06:14.244Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (65557) size = 42949672960, hd = 0. Type 3
2016-04-04T23:06:14.244Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:14.245Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (65557) size = 193273528320, hd = 0. Type 3
2016-04-04T23:06:14.245Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:14.259Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (65557) size = 42949672960, hd = 0. Type 3
2016-04-04T23:06:14.259Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:14.260Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (65557) size = 193273528320, hd = 0. Type 3
2016-04-04T23:06:14.260Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:14.310Z| vcpu-0| I120: SNAPSHOT: SnapshotDumperOpenFromInfo: Creating checkpoint file /vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-Snapshot487.vmsn
2016-04-04T23:06:14.339Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (29) size = 42949672960, hd = 0. Type 3
2016-04-04T23:06:14.341Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 1
2016-04-04T23:06:14.341Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk" -- vmfsSparse cowGran=1 allocType=0
2016-04-04T23:06:14.341Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:14.344Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-04T23:06:14.371Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : success
2016-04-04T23:06:14.382Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk" : creation successful.
2016-04-04T23:06:14.432Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (17) size = 86016, hd = 0. Type 8
2016-04-04T23:06:14.788Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-04T23:06:14.793Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (16) size = 86016, hd = 81136365. Type 8
2016-04-04T23:06:14.793Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000001-delta.vmdk" (0x10)
2016-04-04T23:06:14.793Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' (0x10): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-04T23:06:14.793Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-04T23:06:14.793Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 81136365, extentType = 0
2016-04-04T23:06:14.793Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:14.797Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 81136365.
2016-04-04T23:06:14.797Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 33e0aee-cbt.
2016-04-04T23:06:14.797Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/33e0aee-cbt
2016-04-04T23:06:14.797Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk" (flags 0x10, type vmfsSparse).
2016-04-04T23:06:14.798Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 81136365.
2016-04-04T23:06:14.798Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:14.806Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-04T23:06:14.809Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:14.812Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (29) size = 193273528320, hd = 0. Type 3
2016-04-04T23:06:14.813Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 1
2016-04-04T23:06:14.814Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk" -- vmfsSparse cowGran=1 allocType=0
2016-04-04T23:06:14.814Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:14.824Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-04T23:06:14.871Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : success
2016-04-04T23:06:14.891Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk" : creation successful.
2016-04-04T23:06:14.936Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (17) size = 372736, hd = 0. Type 8
2016-04-04T23:06:15.585Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-04T23:06:15.588Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (16) size = 372736, hd = 82119405. Type 8
2016-04-04T23:06:15.588Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000001-delta.vmdk" (0x10)
2016-04-04T23:06:15.588Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' (0x10): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-04T23:06:15.588Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-04T23:06:15.588Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 82119405, extentType = 0
2016-04-04T23:06:15.589Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:15.592Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 82119405.
2016-04-04T23:06:15.592Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 3490aee-cbt.
2016-04-04T23:06:15.592Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/3490aee-cbt
2016-04-04T23:06:15.592Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk" (flags 0x10, type vmfsSparse).
2016-04-04T23:06:15.594Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 82119405.
2016-04-04T23:06:15.594Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:15.616Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-04T23:06:15.619Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:15.624Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (29) size = 42949672960, hd = 0. Type 3
2016-04-04T23:06:15.625Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 1
2016-04-04T23:06:15.625Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk" -- vmfsSparse cowGran=1 allocType=0
2016-04-04T23:06:15.625Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:15.628Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-04T23:06:15.681Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : success
2016-04-04T23:06:15.703Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk" : creation successful.
2016-04-04T23:06:15.750Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (17) size = 86016, hd = 0. Type 8
2016-04-04T23:06:16.090Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.092Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:16.097Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (29) size = 193273528320, hd = 0. Type 3
2016-04-04T23:06:16.098Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 1
2016-04-04T23:06:16.098Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" -- vmfsSparse cowGran=1 allocType=0
2016-04-04T23:06:16.098Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.101Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-04T23:06:16.141Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : success
2016-04-04T23:06:16.157Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" : creation successful.
2016-04-04T23:06:16.197Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (17) size = 372736, hd = 0. Type 8
2016-04-04T23:06:16.591Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.593Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:16.650Z| vcpu-0| I120: Checkpoint_Unstun: vm stopped for 2593438 us
2016-04-04T23:06:16.650Z| vcpu-0| I120: SCSI: switching scsi0 to push completion mode
2016-04-04T23:06:16.651Z| vcpu-0| I120: DISK: OPEN scsi0:0 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' persistent R[]
2016-04-04T23:06:16.655Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (10) size = 86016, hd = 49744618. Type 8
2016-04-04T23:06:16.655Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000001-delta.vmdk" (0xa)
2016-04-04T23:06:16.655Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' (0xa): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-04T23:06:16.667Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (14) size = 42949672960, hd = 163646187. Type 3
2016-04-04T23:06:16.667Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-flat.vmdk" (0xe)
2016-04-04T23:06:16.667Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk' (0xe): vmfs, 83886080 sectors / 40 GB.
2016-04-04T23:06:16.667Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 2, numSubChains = 1
2016-04-04T23:06:16.667Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 163646187, extentType = 2
2016-04-04T23:06:16.667Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 49744618, extentType = 0
2016-04-04T23:06:16.668Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 49744618.
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 5ee0aec-cbt.
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/5ee0aec-cbt
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk" (flags 0xa, type vmfs).
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' has UUID '60 00 c2 90 85 75 e6 c5-c6 fd c5 00 7d 15 27 00'
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' Geo (5221/255/63) BIOS Geo (0/0/0)
2016-04-04T23:06:16.670Z| vcpu-0| I120: Creating virtual dev for scsi0:0
2016-04-04T23:06:16.670Z| vcpu-0| I120: DumpDiskInfo: scsi0:0 createType=11, capacity = 83886080, numLinks = 2, allocationType = 0
2016-04-04T23:06:16.670Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-04T23:06:16.670Z| vcpu-0| I120: DISKUTIL: scsi0:0 : geometry=5221/255/63
2016-04-04T23:06:16.671Z| vcpu-0| I120: DISK: OPEN scsi0:1 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' persistent R[]
2016-04-04T23:06:16.674Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (10) size = 372736, hd = 86575855. Type 8
2016-04-04T23:06:16.674Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000001-delta.vmdk" (0xa)
2016-04-04T23:06:16.674Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' (0xa): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-04T23:06:16.678Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (14) size = 193273528320, hd = 73337584. Type 3
2016-04-04T23:06:16.678Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-flat.vmdk" (0xe)
2016-04-04T23:06:16.678Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1.vmdk' (0xe): vmfs, 377487360 sectors / 180 GB.
2016-04-04T23:06:16.678Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 2, numSubChains = 1
2016-04-04T23:06:16.678Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 73337584, extentType = 2
2016-04-04T23:06:16.678Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 86575855, extentType = 0
2016-04-04T23:06:16.679Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.681Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 86575855.
2016-04-04T23:06:16.681Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 6420af1-cbt.
2016-04-04T23:06:16.681Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/6420af1-cbt
2016-04-04T23:06:16.682Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk" (flags 0xa, type vmfs).
2016-04-04T23:06:16.682Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' has UUID '60 00 c2 9f f9 9f 61 cb-96 e8 96 d8 29 03 6a 7f'
2016-04-04T23:06:16.682Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' Geo (23497/255/63) BIOS Geo (0/0/0)
2016-04-04T23:06:16.682Z| vcpu-0| I120: Creating virtual dev for scsi0:1
2016-04-04T23:06:16.682Z| vcpu-0| I120: DumpDiskInfo: scsi0:1 createType=11, capacity = 377487360, numLinks = 2, allocationType = 0
2016-04-04T23:06:16.682Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-04T23:06:16.682Z| vcpu-0| I120: DISKUTIL: scsi0:1 : geometry=23497/255/63
2016-04-04T23:06:16.685Z| vcpu-0| I120: SnapshotVMXTakeSnapshotCB: Enter checkpoint status 1, mode 2.
2016-04-04T23:06:16.688Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 86016, hd = 0. Type 8
2016-04-04T23:06:16.688Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-04T23:06:16.688Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 372736, hd = 0. Type 8
2016-04-04T23:06:16.688Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-04T23:06:16.689Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (65557) size = 86016, hd = 0. Type 8
2016-04-04T23:06:16.689Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.690Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 372736, hd = 0. Type 8
2016-04-04T23:06:16.690Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.693Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 86016, hd = 0. Type 8
2016-04-04T23:06:16.693Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-04T23:06:16.693Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 372736, hd = 0. Type 8
2016-04-04T23:06:16.693Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-04T23:06:16.694Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (65557) size = 86016, hd = 0. Type 8
2016-04-04T23:06:16.694Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.695Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 372736, hd = 0. Type 8
2016-04-04T23:06:16.695Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.695Z| vcpu-0| I120: ToolsBackup: hot adding disk VM_1-000002.vmdk to node scsi0:2 (oldnode scsi0:1).
2016-04-04T23:06:16.698Z| vcpu-0| I120: DISKLIB-VMFS : "./VM_1-000002-delta.vmdk" : open successful (0) size = 372736, hd = 73140980. Type 8
2016-04-04T23:06:16.698Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000002-delta.vmdk" (0)
2016-04-04T23:06:16.698Z| vcpu-0| I120: DISKLIB-LINK : Opened 'VM_1-000002.vmdk' (0): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-04T23:06:16.698Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-04T23:06:16.698Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 73140980, extentType = 0
2016-04-04T23:06:16.699Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.702Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 73140980.
2016-04-04T23:06:16.702Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 49b0af8-cbt.
2016-04-04T23:06:16.702Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/49b0af8-cbt
2016-04-04T23:06:16.702Z| vcpu-0| I120: DISKLIB-LIB : Opened "VM_1-000002.vmdk" (flags 0, type vmfsSparse).
2016-04-04T23:06:16.704Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 73140980.
2016-04-04T23:06:16.704Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:16.722Z| vcpu-0| I120: DISKLIB-VMFS : "./VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.722Z| vcpu-0| I120: DISKLIB-LIB : DiskLib_DigestDisable: no digest disk associated.
2016-04-04T23:06:16.722Z| vcpu-0| I120: HotAdd: Adding scsi-hardDisk with mode 'persistent' to scsi0:2
2016-04-04T23:06:16.722Z| vcpu-0| I120: DISK: OPEN scsi0:2 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' persistent R[]
2016-04-04T23:06:16.726Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (10) size = 372736, hd = 73272052. Type 8
2016-04-04T23:06:16.726Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000002-delta.vmdk" (0xa)
2016-04-04T23:06:16.726Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' (0xa): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-04T23:06:16.728Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (14) size = 193273528320, hd = 77466360. Type 3
2016-04-04T23:06:16.728Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-flat.vmdk" (0xe)
2016-04-04T23:06:16.728Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1.vmdk' (0xe): vmfs, 377487360 sectors / 180 GB.
2016-04-04T23:06:16.728Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 2, numSubChains = 1
2016-04-04T23:06:16.728Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 77466360, extentType = 2
2016-04-04T23:06:16.728Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 73272052, extentType = 0
2016-04-04T23:06:16.729Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.732Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 73272052.
2016-04-04T23:06:16.732Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 3b40af9-cbt.
2016-04-04T23:06:16.732Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/3b40af9-cbt
2016-04-04T23:06:16.732Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" (flags 0xa, type vmfs).
2016-04-04T23:06:16.732Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' has UUID '60 00 c2 95 c6 a2 e1 e7-03 71 5b 15 ea c8 81 04'
2016-04-04T23:06:16.732Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' Geo (23497/255/63) BIOS Geo (0/0/0)
2016-04-04T23:06:16.746Z| vcpu-0| I120: SCSI DEVICE (scsi0:2): Computed value of scsi0:2.useBounceBuffers: default
2016-04-04T23:06:16.746Z| vcpu-0| I120: Creating virtual dev for scsi0:2
2016-04-04T23:06:16.746Z| vcpu-0| I120: DumpDiskInfo: scsi0:2 createType=11, capacity = 377487360, numLinks = 2, allocationType = 0
2016-04-04T23:06:16.746Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-04T23:06:16.746Z| vcpu-0| I120: DISKUTIL: scsi0:2 : geometry=23497/255/63
2016-04-04T23:06:16.755Z| vcpu-0| I120: ToolsBackup: hot adding disk VM-000002.vmdk to node scsi0:3 (oldnode scsi0:0).
2016-04-04T23:06:16.757Z| vcpu-0| I120: DISKLIB-VMFS : "./VM-000002-delta.vmdk" : open successful (0) size = 86016, hd = 86313724. Type 8
2016-04-04T23:06:16.757Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000002-delta.vmdk" (0)
2016-04-04T23:06:16.757Z| vcpu-0| I120: DISKLIB-LINK : Opened 'VM-000002.vmdk' (0): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-04T23:06:16.757Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-04T23:06:16.757Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 86313724, extentType = 0
2016-04-04T23:06:16.758Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.760Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 86313724.
2016-04-04T23:06:16.760Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 5fe0afd-cbt.
2016-04-04T23:06:16.760Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/5fe0afd-cbt
2016-04-04T23:06:16.760Z| vcpu-0| I120: DISKLIB-LIB : Opened "VM-000002.vmdk" (flags 0, type vmfsSparse).
2016-04-04T23:06:16.761Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 86313724.
2016-04-04T23:06:16.761Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:16.768Z| vcpu-0| I120: DISKLIB-VMFS : "./VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:16.768Z| vcpu-0| I120: DISKLIB-LIB : DiskLib_DigestDisable: no digest disk associated.
2016-04-04T23:06:16.768Z| vcpu-0| I120: HotAdd: Adding scsi-hardDisk with mode 'persistent' to scsi0:3
2016-04-04T23:06:16.768Z| vcpu-0| I120: DISK: OPEN scsi0:3 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk' persistent R[]
2016-04-04T23:06:16.771Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (10) size = 86016, hd = 86444796. Type 8
2016-04-04T23:06:16.771Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000002-delta.vmdk" (0xa)
2016-04-04T23:06:16.771Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk' (0xa): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (14) size = 42949672960, hd = 100731645. Type 3
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-flat.vmdk" (0xe)
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk' (0xe): vmfs, 83886080 sectors / 40 GB.
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 2, numSubChains = 1
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 100731645, extentType = 2
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 86444796, extentType = 0
2016-04-04T23:06:16.774Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:16.776Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 86444796.
2016-04-04T23:06:16.776Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 6330afe-cbt.
2016-04-04T23:06:16.776Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/6330afe-cbt
2016-04-04T23:06:16.776Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk" (flags 0xa, type vmfs).
2016-04-04T23:06:16.776Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk' has UUID '60 00 c2 90 d0 2a 2e d6-ff dd bf 5f 49 19 c1 7a'
2016-04-04T23:06:16.776Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk' Geo (5221/255/63) BIOS Geo (0/0/0)
2016-04-04T23:06:16.780Z| vcpu-0| I120: SCSI DEVICE (scsi0:3): Computed value of scsi0:3.useBounceBuffers: default
2016-04-04T23:06:16.780Z| vcpu-0| I120: Creating virtual dev for scsi0:3
2016-04-04T23:06:16.780Z| vcpu-0| I120: DumpDiskInfo: scsi0:3 createType=11, capacity = 83886080, numLinks = 2, allocationType = 0
2016-04-04T23:06:16.780Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-04T23:06:16.780Z| vcpu-0| I120: DISKUTIL: scsi0:3 : geometry=5221/255/63
2016-04-04T23:06:16.790Z| vcpu-0| I120: ToolsBackup: notification message is "vmbackup.snapshotDone 6000c295-c6a2-e1e7-0371-5b15eac88104 6000c290-d02a-2ed6-ffdd-bf5f4919c17a".
2016-04-04T23:06:16.790Z| vcpu-0| I120: ToolsBackup: successfully mounted writable snapshot in guest.
2016-04-04T23:06:16.790Z| vcpu-0| I120: LSI:Event notification sent for SAS device scsi0:2...
2016-04-04T23:06:16.790Z| vcpu-0| I120: LSI:Event notification sent for SAS device scsi0:3...
2016-04-04T23:06:16.802Z| vcpu-0| I120: ToolsBackup: changing quiesce state: COMMITTED -> FINISHING
2016-04-04T23:06:16.815Z| vcpu-0| I120: HBACommon: First write on scsi0:1.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk'
2016-04-04T23:06:16.815Z| vcpu-0| I120: DDB: "longContentID" = "3a8cbf617d4a1e242f13f19516aef924" (was "c7ccbde94fffebd03f48ae18f4cf39e1")
2016-04-04T23:06:16.847Z| vcpu-0| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0xf4cf39e1, new=0x16aef924 (3a8cbf617d4a1e242f13f19516aef924)
2016-04-04T23:06:16.862Z| vcpu-1| I120: HBACommon: First write on scsi0:0.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk'
2016-04-04T23:06:16.862Z| vcpu-1| I120: DDB: "longContentID" = "bc4e782b1bcec09cb8ce15021d2854e8" (was "c367b7c0745d35f9e018c538adf9524f")
2016-04-04T23:06:16.894Z| vcpu-1| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0xadf9524f, new=0x1d2854e8 (bc4e782b1bcec09cb8ce15021d2854e8)
2016-04-04T23:06:17.061Z| vcpu-0| I120: HBACommon: First write on scsi0:3.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk'
2016-04-04T23:06:17.061Z| vcpu-0| I120: DDB: "longContentID" = "7ddd06e3614ef66052597a913818738e" (was "c367b7c0745d35f9e018c538adf9524f")
2016-04-04T23:06:17.086Z| vcpu-0| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0xadf9524f, new=0x3818738e (7ddd06e3614ef66052597a913818738e)
2016-04-04T23:06:17.109Z| vcpu-0| I120: HBACommon: First write on scsi0:2.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk'
2016-04-04T23:06:17.109Z| vcpu-0| I120: DDB: "longContentID" = "efc43e5d1e58861b8b5909b63f44310c" (was "c7ccbde94fffebd03f48ae18f4cf39e1")
2016-04-04T23:06:17.135Z| vcpu-0| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0xf4cf39e1, new=0x3f44310c (efc43e5d1e58861b8b5909b63f44310c)
2016-04-04T23:06:46.672Z| vcpu-1| I120: ToolsBackup: changing quiesce state: FINISHING -> DONE_WAIT
2016-04-04T23:06:47.675Z| vcpu-0| I120: ToolsBackup: changing quiesce state: DONE_WAIT -> GET_MANIFEST
2016-04-04T23:06:47.787Z| vcpu-0| I120: HGFileCopyCreateSessionCB: Successfully created the session.
2016-04-04T23:06:48.006Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 134303744, hd = 0. Type 8
2016-04-04T23:06:48.006Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-04T23:06:48.028Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 17149952, hd = 0. Type 8
2016-04-04T23:06:48.028Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-04T23:06:48.036Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 17149952, hd = 0. Type 8
2016-04-04T23:06:48.036Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.037Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (65557) size = 16863232, hd = 0. Type 8
2016-04-04T23:06:48.037Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.038Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (65557) size = 16863232, hd = 0. Type 8
2016-04-04T23:06:48.038Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.038Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 17149952, hd = 0. Type 8
2016-04-04T23:06:48.039Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.069Z| vcpu-1| I120: ToolsBackup: changing quiesce state: GET_MANIFEST -> IDLE
2016-04-04T23:06:48.069Z| vcpu-1| I120: ToolsBackup: hot removing disk VM-000002.vmdk from node scsi0:3.
2016-04-04T23:06:48.069Z| vcpu-1| I120: LSI:Event notification sent for SAS device scsi0:3...
2016-04-04T23:06:48.069Z| vcpu-1| I120: Destroying virtual dev for scsi0:3 vscsi=10438
2016-04-04T23:06:48.069Z| vcpu-1| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-04T23:06:48.077Z| vcpu-1| I120: scsi0:3: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)
2016-04-04T23:06:48.077Z| vcpu-1| I120: Closing disk scsi0:3
2016-04-04T23:06:48.078Z| vcpu-1| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 86444796.
2016-04-04T23:06:48.079Z| vcpu-1| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:48.131Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.131Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:48.140Z| vcpu-1| I120: ToolsBackup: Post-processing writable snapshot disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk'.
2016-04-04T23:06:48.144Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (0) size = 16863232, hd = 100862717. Type 8
2016-04-04T23:06:48.144Z| vcpu-1| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000002-delta.vmdk" (0)
2016-04-04T23:06:48.144Z| vcpu-1| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk' (0): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-04T23:06:48.144Z| vcpu-1| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-04T23:06:48.144Z| vcpu-1| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 100862717, extentType = 0
2016-04-04T23:06:48.144Z| vcpu-1| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:48.148Z| vcpu-1| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 100862717.
2016-04-04T23:06:48.149Z| vcpu-1| I120: DISKLIB-CBT : Successfuly created cbt node 6350afe-cbt.
2016-04-04T23:06:48.149Z| vcpu-1| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/6350afe-cbt
2016-04-04T23:06:48.149Z| vcpu-1| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk" (flags 0, type vmfsSparse).
2016-04-04T23:06:48.157Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (19) size = 42949672960, hd = 0. Type 3
2016-04-04T23:06:48.167Z| vcpu-1| I120: ToolsBackup: Fixing MBR partitioned writable disk 'VM-000002.vmdk'.
2016-04-04T23:06:48.167Z| vcpu-1| I120: DDB: "longContentID" = "952e0b4691d33a2bb3a37e4fe0ab4948" (was "7ddd06e3614ef66052597a913818738e")
2016-04-04T23:06:48.216Z| vcpu-1| I120: ToolsBackup: No epoch on base disk, merging since 1.DISKLIB-CTK : ChangeTracker_Merge: Merging 333787 changes.
2016-04-04T23:06:48.288Z| vcpu-1| I120: ToolsBackup: Merged change tracking information from writable snapshot disk 'VM-000002.vmdk' since epoch 1.
2016-04-04T23:06:48.289Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-04T23:06:48.290Z| vcpu-1| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 100862717.
2016-04-04T23:06:48.290Z| vcpu-1| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:48.300Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.300Z| vcpu-1| I120: ToolsBackup: hot removing disk VM_1-000002.vmdk from node scsi0:2.
2016-04-04T23:06:48.300Z| vcpu-1| I120: LSI:Event notification sent for SAS device scsi0:2...
2016-04-04T23:06:48.300Z| vcpu-1| I120: Destroying virtual dev for scsi0:2 vscsi=10437
2016-04-04T23:06:48.301Z| vcpu-1| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-04T23:06:48.309Z| vcpu-1| I120: scsi0:2: numIOs = 0 numMergedIOs = 0 numSplitIOs = 0 ( 0.0%)
2016-04-04T23:06:48.309Z| vcpu-1| I120: Closing disk scsi0:2
2016-04-04T23:06:48.311Z| vcpu-1| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 73272052.
2016-04-04T23:06:48.311Z| vcpu-1| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:48.343Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.343Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:48.352Z| vcpu-1| I120: ToolsBackup: Post-processing writable snapshot disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk'.
2016-04-04T23:06:48.354Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (0) size = 17149952, hd = 77597432. Type 8
2016-04-04T23:06:48.354Z| vcpu-1| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000002-delta.vmdk" (0)
2016-04-04T23:06:48.354Z| vcpu-1| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' (0): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-04T23:06:48.354Z| vcpu-1| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-04T23:06:48.354Z| vcpu-1| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 77597432, extentType = 0
2016-04-04T23:06:48.355Z| vcpu-1| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-04T23:06:48.357Z| vcpu-1| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 77597432.
2016-04-04T23:06:48.357Z| vcpu-1| I120: DISKLIB-CBT : Successfuly created cbt node 3b60af9-cbt.
2016-04-04T23:06:48.357Z| vcpu-1| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/3b60af9-cbt
2016-04-04T23:06:48.358Z| vcpu-1| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" (flags 0, type vmfsSparse).
2016-04-04T23:06:48.365Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (19) size = 193273528320, hd = 0. Type 3
2016-04-04T23:06:48.373Z| vcpu-1| I120: ToolsBackup: Fixing MBR partitioned writable disk 'VM_1-000002.vmdk'.
2016-04-04T23:06:48.373Z| vcpu-1| I120: DDB: "longContentID" = "883aef7347bd446bbbf41174fd70a4c7" (was "efc43e5d1e58861b8b5909b63f44310c")
2016-04-04T23:06:48.416Z| vcpu-1| I120: ToolsBackup: No epoch on base disk, merging since 1.DISKLIB-CTK : ChangeTracker_Merge: Merging 1327897 changes.
2016-04-04T23:06:48.557Z| vcpu-1| I120: ToolsBackup: Merged change tracking information from writable snapshot disk 'VM_1-000002.vmdk' since epoch 1.
2016-04-04T23:06:48.557Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-04T23:06:48.559Z| vcpu-1| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 77597432.
2016-04-04T23:06:48.559Z| vcpu-1| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-04T23:06:48.581Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.581Z| vcpu-1| I120: ToolsBackup: changing quiesce state: IDLE -> DONE
2016-04-04T23:06:48.586Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 134303744, hd = 0. Type 8
2016-04-04T23:06:48.586Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-04T23:06:48.587Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 17149952, hd = 0. Type 8
2016-04-04T23:06:48.587Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-04T23:06:48.588Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (65557) size = 16863232, hd = 0. Type 8
2016-04-04T23:06:48.588Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.589Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 17149952, hd = 0. Type 8
2016-04-04T23:06:48.589Z| vcpu-1| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-04T23:06:48.653Z| vcpu-1| I120: SnapshotVMXTakeSnapshotComplete: done with snapshot '_ARCSERVE-BACKUP_J5916_S39662_05.04.2016 01:06:00': 487
2016-04-04T23:07:16.792Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-04T23:07:48.659Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-05T07:17:50.442Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.454Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.455Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:50.455Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.456Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (65557) size = 16863232, hd = 0. Type 8
2016-04-05T07:17:50.457Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-05T07:17:50.457Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 17149952, hd = 0. Type 8
2016-04-05T07:17:50.458Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T07:17:50.458Z| vmx| I120: SNAPSHOT: SnapshotDelete '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmx' : 487
2016-04-05T07:17:50.473Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.473Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.474Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T07:17:50.474Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T07:17:50.475Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:50.475Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.477Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T07:17:50.477Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T07:17:50.478Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (21) size = 16863232, hd = 0. Type 8
2016-04-05T07:17:50.478Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-05T07:17:50.479Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (21) size = 17149952, hd = 0. Type 8
2016-04-05T07:17:50.479Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T07:17:50.498Z| vmx| I120: SNAPSHOT: SnapshotDeleteNode: Deleting '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk'.
2016-04-05T07:17:50.499Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (1041) size = 17149952, hd = 0. Type 8
2016-04-05T07:17:50.499Z| vmx| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:50.531Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T07:17:50.543Z| vmx| I120: SNAPSHOT: SnapshotDeleteNode: Deleting '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk'.
2016-04-05T07:17:50.544Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : open successful (1041) size = 16863232, hd = 0. Type 8
2016-04-05T07:17:50.544Z| vmx| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:50.567Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk" : closed.
2016-04-05T07:17:50.568Z| vmx| I120: OBJLIB-FILEBE :FileBEUnlink : Failed to unlink the file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk' : 1048579
2016-04-05T07:17:50.568Z| vmx| I120: DISKLIB-LIB : Cannot remove extent `/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002-delta.vmdk': Device or resource busy
2016-04-05T07:17:50.568Z| vmx| I120: DISKLIB-LIB : Failed to delete disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000002.vmdk' or one of its components: Device or resource busy
2016-04-05T07:17:50.597Z| vmx| I120: SnapshotVMX_Consolidate: starting
2016-04-05T07:17:50.599Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.599Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.600Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:50.600Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.601Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.601Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.602Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T07:17:50.602Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T07:17:50.603Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:50.603Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.604Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T07:17:50.604Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T07:17:50.604Z| vmx| I120: SnapshotVMXConsolidateOnlineCB: nextState = 0 uid 0
2016-04-05T07:17:50.604Z| vmx| I120: Turning on snapshot info cache. VM=VM.vmx.
2016-04-05T07:17:50.606Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.606Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.607Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open su

chris1234 · Beitragvon **chris1234** » 06.04.2016, 11:02

[code]
2016-04-05T07:17:50.606Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.606Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.607Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:50.607Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.607Z| vmx| I120: SNAPSHOT: Turning on snapshot disk cache.
2016-04-05T07:17:50.607Z| vmx| I120: Vix: [11011 mainDispatch.c:3870]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1880, success=1 additionalError=0
2016-04-05T07:17:50.607Z| vcpu-0| I120: Destroying virtual dev for scsi0:0 vscsi=10435
2016-04-05T07:17:50.607Z| vcpu-0| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-05T07:17:50.608Z| vcpu-0| I120: Destroying virtual dev for scsi0:1 vscsi=10436
2016-04-05T07:17:50.608Z| vcpu-0| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-05T07:17:50.612Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 1 uid 0
2016-04-05T07:17:50.613Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.613Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.613Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T07:17:50.613Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T07:17:50.614Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:50.614Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.615Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T07:17:50.615Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T07:17:50.615Z| vcpu-0| I120: Closing all the disks of the VM.
2016-04-05T07:17:50.615Z| vcpu-0| I120: Closing disk scsi0:0
2016-04-05T07:17:50.616Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 49744618.
2016-04-05T07:17:50.616Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T07:17:50.679Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.679Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T07:17:50.679Z| vcpu-0| I120: Closing disk scsi0:1
2016-04-05T07:17:50.681Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 86575855.
2016-04-05T07:17:50.682Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T07:17:50.782Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:50.783Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T07:17:50.783Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: taking intermediate snapshot.
2016-04-05T07:17:50.829Z| vcpu-0| I120: SNAPSHOT: SnapshotDumperOpenFromInfo: Creating checkpoint file /vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-Snapshot488.vmsn
2016-04-05T07:17:50.845Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (29) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:50.846Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 0
2016-04-05T07:17:50.846Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk" -- vmfsSparse cowGran=0 allocType=0
2016-04-05T07:17:50.847Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (23) size = 42949672960, hd = 0. Type 3
2016-04-05T07:17:50.847Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T07:17:50.847Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:50.848Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-05T07:17:50.864Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : success
2016-04-05T07:17:50.870Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk" : creation successful.
2016-04-05T07:17:50.886Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (17) size = 86016, hd = 0. Type 8
2016-04-05T07:17:51.056Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T07:17:51.057Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:51.059Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (29) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:51.060Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 0
2016-04-05T07:17:51.060Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" -- vmfsSparse cowGran=0 allocType=0
2016-04-05T07:17:51.061Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (23) size = 193273528320, hd = 0. Type 3
2016-04-05T07:17:51.061Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T07:17:51.061Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:51.062Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-05T07:17:51.078Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : success
2016-04-05T07:17:51.084Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" : creation successful.
2016-04-05T07:17:51.098Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (17) size = 372736, hd = 0. Type 8
2016-04-05T07:17:51.313Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T07:17:51.314Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:51.347Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 1 uid 488
2016-04-05T07:17:51.349Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (21) size = 86016, hd = 0. Type 8
2016-04-05T07:17:51.349Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T07:17:51.349Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T07:17:51.350Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:51.350Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T07:17:51.350Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T07:17:51.351Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (21) size = 372736, hd = 0. Type 8
2016-04-05T07:17:51.351Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T07:17:51.352Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T07:17:51.352Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T07:17:51.353Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T07:17:51.353Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T07:17:51.353Z| vcpu-0| I120: Checkpoint_Unstun: vm stopped for 745632 us
2016-04-05T07:17:51.353Z| vcpu-0| I120: SCSI: switching scsi0 to push completion mode
2016-04-05T07:17:51.353Z| vcpu-0| I120: DISK: OPEN scsi0:0 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' persistent R[]
2016-04-05T07:17:51.356Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (8) size = 86016, hd = 75434736. Type 8
2016-04-05T07:17:51.356Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000003-delta.vmdk" (0x8)
2016-04-05T07:17:51.356Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' (0x8): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T07:17:51.356Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-05T07:17:51.356Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 75434736, extentType = 0
2016-04-05T07:17:51.356Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:51.358Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 75434736.
2016-04-05T07:17:51.358Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 6610af1-cbt.
2016-04-05T07:17:51.358Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/6610af1-cbt
2016-04-05T07:17:51.358Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk" (flags 0x8, type vmfsSparse).
2016-04-05T07:17:51.367Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (8) size = 469848064, hd = 90573556. Type 8
2016-04-05T07:17:51.367Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000001-delta.vmdk" (0x8)
2016-04-05T07:17:51.367Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' (0x8): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T07:17:51.367Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-05T07:17:51.367Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 90573556, extentType = 0
2016-04-05T07:17:51.368Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:51.369Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 90573556.
2016-04-05T07:17:51.369Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 4f90af8-cbt.
2016-04-05T07:17:51.369Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/4f90af8-cbt
2016-04-05T07:17:51.369Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk" (flags 0x8, type vmfsSparse).
2016-04-05T07:17:51.370Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 75434736.
2016-04-05T07:17:51.371Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T07:17:51.372Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 90573556.
2016-04-05T07:17:51.372Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T07:17:51.376Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 2, numSubChains = 1
2016-04-05T07:17:51.376Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 90573556, extentType = 0
2016-04-05T07:17:51.376Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 75434736, extentType = 0
2016-04-05T07:17:51.377Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 75434736.
2016-04-05T07:17:51.377Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 4fb0af8-cbt.
2016-04-05T07:17:51.377Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/4fb0af8-cbt
2016-04-05T07:17:51.379Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T07:17:51.379Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 0)
2016-04-05T07:17:51.681Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T07:17:51.681Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 1)
2016-04-05T07:17:51.983Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T07:17:51.983Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 2)
2016-04-05T07:17:52.285Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T07:17:52.285Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 3)
2016-04-05T07:17:52.588Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T07:17:52.588Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 4)
2016-04-05T07:17:52.888Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T07:17:52.888Z| vcpu-0| I120: OBJLIB-FILEBE : FileBEOpen: can't open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (262146).
2016-04-05T07:17:52.888Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : failed to open (Failed to lock the file): ObjLib_Open failed. Type 3
2016-04-05T07:17:52.888Z| vcpu-0| I120: DISKLIB-LINK : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk" : failed to open (Failed to lock the file).
2016-04-05T07:17:52.888Z| vcpu-0| I120: DISKLIB-CHAIN : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk" : failed to open (Failed to lock the file).
2016-04-05T07:17:52.888Z| vcpu-0| I120: DISKLIB-LIB : Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk' with flags 0x20a Failed to lock the file (16392).
2016-04-05T07:17:52.888Z| vcpu-0| I120: SNAPSHOT:Failed to open disk /vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk : Failed to lock the file (16392)
2016-04-05T07:17:52.889Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 75434736.
2016-04-05T07:17:52.890Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T07:17:52.895Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T07:17:52.896Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T07:17:52.896Z| vcpu-0| I120: DISK: Failed to open disk for consolidate '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' : Failed to lock the file (16392) 6873
2016-04-05T07:17:52.899Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (10) size = 86016, hd = 90704628. Type 8
2016-04-05T07:17:52.899Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000003-delta.vmdk" (0xa)
2016-04-05T07:17:52.899Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' (0xa): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T07:17:52.902Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (14) size = 469848064, hd = 83757816. Type 8
2016-04-05T07:17:52.902Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000001-delta.vmdk" (0xe)
2016-04-05T07:17:52.902Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' (0xe): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (14) size = 42949672960, hd = 63638265. Type 3
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-flat.vmdk" (0xe)
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk' (0xe): vmfs, 83886080 sectors / 40 GB.
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 3, numSubChains = 1
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 63638265, extentType = 2
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 83757816, extentType = 0
2016-04-05T07:17:52.904Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(2) fid = 90704628, extentType = 0
2016-04-05T07:17:52.905Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:52.907Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 90704628.
2016-04-05T07:17:52.907Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 30f0afa-cbt.
2016-04-05T07:17:52.907Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/30f0afa-cbt
2016-04-05T07:17:52.907Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk" (flags 0xa, type vmfs).
2016-04-05T07:17:52.907Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' has UUID '60 00 c2 90 85 75 e6 c5-c6 fd c5 00 7d 15 27 00'
2016-04-05T07:17:52.907Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' Geo (5221/255/63) BIOS Geo (0/0/0)
2016-04-05T07:17:52.907Z| vcpu-0| I120: Creating virtual dev for scsi0:0
2016-04-05T07:17:52.907Z| vcpu-0| I120: DumpDiskInfo: scsi0:0 createType=11, capacity = 83886080, numLinks = 3, allocationType = 0
2016-04-05T07:17:52.908Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-05T07:17:52.908Z| vcpu-0| I120: DISKUTIL: scsi0:0 : geometry=5221/255/63
2016-04-05T07:17:52.908Z| vcpu-0| I120: DISK: OPEN scsi0:1 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' persistent R[]
2016-04-05T07:17:52.911Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (10) size = 372736, hd = 101452541. Type 8
2016-04-05T07:17:52.911Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000002-delta.vmdk" (0xa)
2016-04-05T07:17:52.911Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' (0xa): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-05T07:17:52.915Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (14) size = 84258816, hd = 104663806. Type 8
2016-04-05T07:17:52.915Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000001-delta.vmdk" (0xe)
2016-04-05T07:17:52.915Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' (0xe): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (14) size = 193273528320, hd = 70781695. Type 3
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-flat.vmdk" (0xe)
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1.vmdk' (0xe): vmfs, 377487360 sectors / 180 GB.
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 3, numSubChains = 1
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 70781695, extentType = 2
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 104663806, extentType = 0
2016-04-05T07:17:52.925Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(2) fid = 101452541, extentType = 0
2016-04-05T07:17:52.926Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T07:17:52.928Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 101452541.
2016-04-05T07:17:52.928Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 2b50b00-cbt.
2016-04-05T07:17:52.928Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/2b50b00-cbt
2016-04-05T07:17:52.928Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk" (flags 0xa, type vmfs).
2016-04-05T07:17:52.928Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' has UUID '60 00 c2 9f f9 9f 61 cb-96 e8 96 d8 29 03 6a 7f'
2016-04-05T07:17:52.928Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' Geo (23497/255/63) BIOS Geo (0/0/0)
2016-04-05T07:17:52.929Z| vcpu-0| I120: Creating virtual dev for scsi0:1
2016-04-05T07:17:52.929Z| vcpu-0| I120: DumpDiskInfo: scsi0:1 createType=11, capacity = 377487360, numLinks = 3, allocationType = 0
2016-04-05T07:17:52.929Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-05T07:17:52.929Z| vcpu-0| I120: DISKUTIL: scsi0:1 : geometry=23497/255/63
2016-04-05T07:17:52.930Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 2 uid 488
2016-04-05T07:17:52.930Z| vcpu-0| I120: Vix: [11834 mainDispatch.c:3870]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1881, success=1 additionalError=0
2016-04-05T07:17:52.930Z| vcpu-0| I120: Vix: [11834 vigorCommands.c:548]: VigorSnapshotManagerConsolidateCallback: snapshotErr = Failed to lock the file (5:4008)
2016-04-05T07:17:52.930Z| vcpu-0| I120: Turning off snapshot info cache.
2016-04-05T07:17:52.931Z| vcpu-0| I120: Turning off snapshot disk cache.
2016-04-05T07:17:52.931Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: Done with consolidate
2016-04-05T07:17:52.951Z| vcpu-0| I120: HBACommon: First write on scsi0:1.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk'
2016-04-05T07:17:52.951Z| vcpu-0| I120: DDB: "longContentID" = "9414de50927e10965b9d833668208bd9" (was "3a8cbf617d4a1e242f13f19516aef924")
2016-04-05T07:17:52.970Z| vcpu-0| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0x16aef924, new=0x68208bd9 (9414de50927e10965b9d833668208bd9)
2016-04-05T07:17:53.008Z| vcpu-1| I120: HBACommon: First write on scsi0:0.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk'
2016-04-05T07:17:53.008Z| vcpu-1| I120: DDB: "longContentID" = "7c0ec449ebc3e3ab080622b37047c3be" (was "bc4e782b1bcec09cb8ce15021d2854e8")
2016-04-05T07:17:53.027Z| vcpu-1| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0x1d2854e8, new=0x7047c3be (7c0ec449ebc3e3ab080622b37047c3be)
2016-04-05T07:18:52.938Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-05T12:06:54.472Z| mks| I120: SOCKET 2 (139) Creating VNC remote connection.
2016-04-05T12:39:53.240Z| mks| I120: SOCKET 2 (139) recv error 104: Connection reset by peer
2016-04-05T12:39:53.240Z| mks| I120: SOCKET 2 (139) VNC Remote Disconnect.
2016-04-05T14:41:07.394Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (65557) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:07.400Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.402Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:07.402Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:07.414Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (65557) size = 469848064, hd = 0. Type 8
2016-04-05T14:41:07.414Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.416Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (65557) size = 84258816, hd = 0. Type 8
2016-04-05T14:41:07.416Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.416Z| vmx| I120: SNAPSHOT: SnapshotDelete '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmx' : 488
2016-04-05T14:41:07.476Z| vmx| I120: SnapshotVMX_Consolidate: starting
2016-04-05T14:41:07.480Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (65557) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:07.480Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.481Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:07.481Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:07.482Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (21) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:07.482Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.483Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T14:41:07.483Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.484Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T14:41:07.484Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T14:41:07.486Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (21) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:07.486Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:07.487Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T14:41:07.487Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.488Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T14:41:07.488Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T14:41:07.488Z| vmx| I120: SnapshotVMXConsolidateOnlineCB: nextState = 0 uid 0
2016-04-05T14:41:07.488Z| vmx| I120: Turning on snapshot info cache. VM=VM.vmx.
2016-04-05T14:41:07.492Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (65557) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:07.492Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.493Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (65557) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:07.493Z| vmx| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:07.494Z| vmx| I120: SNAPSHOT: Turning on snapshot disk cache.
2016-04-05T14:41:07.494Z| vmx| I120: Vix: [11011 mainDispatch.c:3870]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1880, success=1 additionalError=0
2016-04-05T14:41:07.494Z| vcpu-0| I120: Destroying virtual dev for scsi0:0 vscsi=10441
2016-04-05T14:41:07.494Z| vcpu-0| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-05T14:41:07.494Z| vcpu-0| I120: Destroying virtual dev for scsi0:1 vscsi=10442
2016-04-05T14:41:07.495Z| vcpu-0| I120: VMMon_VSCSIStopVports: No such target on adapter
2016-04-05T14:41:07.504Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 1 uid 0
2016-04-05T14:41:07.505Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (21) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:07.505Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.505Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T14:41:07.505Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.506Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T14:41:07.506Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T14:41:07.507Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (21) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:07.507Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:07.508Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T14:41:07.508Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.508Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T14:41:07.508Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T14:41:07.508Z| vcpu-0| I120: Closing all the disks of the VM.
2016-04-05T14:41:07.508Z| vcpu-0| I120: Closing disk scsi0:0
2016-04-05T14:41:07.510Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 90704628.
2016-04-05T14:41:07.510Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:07.566Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.567Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.567Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T14:41:07.567Z| vcpu-0| I120: Closing disk scsi0:1
2016-04-05T14:41:07.570Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 101452541.
2016-04-05T14:41:07.570Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:07.601Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:07.602Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.602Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T14:41:07.602Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: taking intermediate snapshot.
2016-04-05T14:41:07.649Z| vcpu-0| I120: SNAPSHOT: SnapshotDumperOpenFromInfo: Creating checkpoint file /vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-Snapshot489.vmsn
2016-04-05T14:41:07.664Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (29) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:07.665Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 0
2016-04-05T14:41:07.665Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk" -- vmfsSparse cowGran=0 allocType=0
2016-04-05T14:41:07.666Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (23) size = 469848064, hd = 0. Type 8
2016-04-05T14:41:07.666Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (23) size = 42949672960, hd = 0. Type 3
2016-04-05T14:41:07.667Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.667Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T14:41:07.667Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T14:41:07.668Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-05T14:41:07.687Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : success
2016-04-05T14:41:07.693Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk" : creation successful.
2016-04-05T14:41:07.708Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : open successful (17) size = 86016, hd = 0. Type 8
2016-04-05T14:41:07.893Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : closed.
2016-04-05T14:41:07.894Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:07.897Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (29) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:07.898Z| vcpu-0| I120: DISKLIB-LIB : DiskLibCreateCreateParam: vmfssparse grain size set to : 0
2016-04-05T14:41:07.898Z| vcpu-0| I120: DISKLIB-LIB : CREATE CHILD: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk" -- vmfsSparse cowGran=0 allocType=0
2016-04-05T14:41:07.899Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (23) size = 84258816, hd = 0. Type 8
2016-04-05T14:41:07.900Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (23) size = 193273528320, hd = 0. Type 3
2016-04-05T14:41:07.900Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T14:41:07.900Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T14:41:07.900Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T14:41:07.902Z| vcpu-0| I120: CREATE-CHILD: Creating disk backed by 'default'
2016-04-05T14:41:07.919Z| vcpu-0| I120: DISKLIB-VMFS_SPARSE : VmfsSparseExtentCreate: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003-delta.vmdk" : success
2016-04-05T14:41:07.925Z| vcpu-0| I120: DISKLIB-DSCPTR: "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk" : creation successful.
2016-04-05T14:41:07.941Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003-delta.vmdk" : open successful (17) size = 372736, hd = 0. Type 8
2016-04-05T14:41:08.216Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003-delta.vmdk" : closed.
2016-04-05T14:41:08.217Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:08.248Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 1 uid 489
2016-04-05T14:41:08.249Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : open successful (21) size = 86016, hd = 0. Type 8
2016-04-05T14:41:08.249Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : closed.
2016-04-05T14:41:08.250Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (21) size = 251744256, hd = 0. Type 8
2016-04-05T14:41:08.250Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:08.250Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (21) size = 469848064, hd = 0. Type 8
2016-04-05T14:41:08.250Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:08.251Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (21) size = 42949672960, hd = 0. Type 3
2016-04-05T14:41:08.251Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : closed.
2016-04-05T14:41:08.252Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003-delta.vmdk" : open successful (21) size = 372736, hd = 0. Type 8
2016-04-05T14:41:08.252Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003-delta.vmdk" : closed.
2016-04-05T14:41:08.253Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (21) size = 134590464, hd = 0. Type 8
2016-04-05T14:41:08.253Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : closed.
2016-04-05T14:41:08.254Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (21) size = 84258816, hd = 0. Type 8
2016-04-05T14:41:08.254Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : closed.
2016-04-05T14:41:08.255Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (21) size = 193273528320, hd = 0. Type 3
2016-04-05T14:41:08.255Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : closed.
2016-04-05T14:41:08.255Z| vcpu-0| I120: Checkpoint_Unstun: vm stopped for 761545 us
2016-04-05T14:41:08.255Z| vcpu-0| I120: SCSI: switching scsi0 to push completion mode
2016-04-05T14:41:08.255Z| vcpu-0| I120: DISK: OPEN scsi0:0 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk' persistent R[]
2016-04-05T14:41:08.258Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : open successful (8) size = 86016, hd = 73403135. Type 8
2016-04-05T14:41:08.259Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000004-delta.vmdk" (0x8)
2016-04-05T14:41:08.259Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk' (0x8): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T14:41:08.259Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-05T14:41:08.259Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 73403135, extentType = 0
2016-04-05T14:41:08.259Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T14:41:08.262Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 73403135.
2016-04-05T14:41:08.262Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 2d20b00-cbt.
2016-04-05T14:41:08.262Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/2d20b00-cbt
2016-04-05T14:41:08.262Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk" (flags 0x8, type vmfsSparse).
2016-04-05T14:41:08.265Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (8) size = 251744256, hd = 62130947. Type 8
2016-04-05T14:41:08.265Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000003-delta.vmdk" (0x8)
2016-04-05T14:41:08.265Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' (0x8): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T14:41:08.265Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-05T14:41:08.265Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 62130947, extentType = 0
2016-04-05T14:41:08.266Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T14:41:08.267Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 62130947.
2016-04-05T14:41:08.267Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 4910b04-cbt.
2016-04-05T14:41:08.267Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/4910b04-cbt
2016-04-05T14:41:08.267Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk" (flags 0x8, type vmfsSparse).
2016-04-05T14:41:08.268Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 73403135.
2016-04-05T14:41:08.268Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:08.269Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 62130947.
2016-04-05T14:41:08.269Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:08.274Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 2, numSubChains = 1
2016-04-05T14:41:08.274Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 62130947, extentType = 0
2016-04-05T14:41:08.274Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 73403135, extentType = 0
2016-04-05T14:41:08.275Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 73403135.
2016-04-05T14:41:08.275Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 4930b04-cbt.
2016-04-05T14:41:08.275Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/4930b04-cbt
2016-04-05T14:41:08.288Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (8) size = 469848064, hd = 65800966. Type 8
2016-04-05T14:41:08.288Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000001-delta.vmdk" (0x8)
2016-04-05T14:41:08.288Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' (0x8): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T14:41:08.288Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 1, numSubChains = 1
2016-04-05T14:41:08.288Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 65800966, extentType = 0
2016-04-05T14:41:08.288Z| vcpu-0| I120: DISKLIB-LIB : Resuming change tracking.
2016-04-05T14:41:08.290Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 65800966.
2016-04-05T14:41:08.291Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 3830b07-cbt.
2016-04-05T14:41:08.291Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/3830b07-cbt
2016-04-05T14:41:08.291Z| vcpu-0| I120: DISKLIB-LIB : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk" (flags 0x8, type vmfsSparse).
2016-04-05T14:41:08.291Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 73403135.
2016-04-05T14:41:08.292Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:08.292Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 65800966.
2016-04-05T14:41:08.293Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:08.297Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 3, numSubChains = 1
2016-04-05T14:41:08.297Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 65800966, extentType = 0
2016-04-05T14:41:08.297Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 62130947, extentType = 0
2016-04-05T14:41:08.297Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(2) fid = 73403135, extentType = 0
2016-04-05T14:41:08.298Z| vcpu-0| I120: DISKLIB-CBT : Initializing ESX kernel change tracking for fid 73403135.
2016-04-05T14:41:08.298Z| vcpu-0| I120: DISKLIB-CBT : Successfuly created cbt node 3850b07-cbt.
2016-04-05T14:41:08.298Z| vcpu-0| I120: DISKLIB-CBT : Opening cbt node /vmfs/devices/cbt/3850b07-cbt
2016-04-05T14:41:08.300Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T14:41:08.300Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 0)
2016-04-05T14:41:08.603Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T14:41:08.603Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 1)
2016-04-05T14:41:08.904Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T14:41:08.904Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 2)
2016-04-05T14:41:09.205Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T14:41:09.205Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 3)
2016-04-05T14:41:09.507Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T14:41:09.507Z| vcpu-0| I120: AIOMGR: AIOMgr_OpenWithRetry: Descriptor file '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' locked (try 4)
2016-04-05T14:41:09.810Z| vcpu-0| I120: AIOGNRC: Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (40003) (0x2013).
2016-04-05T14:41:09.811Z| vcpu-0| I120: OBJLIB-FILEBE : FileBEOpen: can't open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk' : Failed to lock the file (262146).
2016-04-05T14:41:09.811Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : failed to open (Failed to lock the file): ObjLib_Open failed. Type 3
2016-04-05T14:41:09.811Z| vcpu-0| I120: DISKLIB-LINK : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk" : failed to open (Failed to lock the file).
2016-04-05T14:41:09.811Z| vcpu-0| I120: DISKLIB-CHAIN : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk" : failed to open (Failed to lock the file).
2016-04-05T14:41:09.811Z| vcpu-0| I120: DISKLIB-LIB : Failed to open '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk' with flags 0x20a Failed to lock the file (16392).
2016-04-05T14:41:09.811Z| vcpu-0| I120: SNAPSHOT:Failed to open disk /vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk : Failed to lock the file (16392)
2016-04-05T14:41:09.812Z| vcpu-0| I120: DISKLIB-CBT : Shutting down change tracking for untracked fid 73403135.
2016-04-05T14:41:09.812Z| vcpu-0| I120: DISKLIB-CBT : Successfully disconnected CBT node.
2016-04-05T14:41:09.819Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : closed.
2016-04-05T14:41:09.820Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : closed.
2016-04-05T14:41:09.821Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : closed.
2016-04-05T14:41:09.821Z| vcpu-0| I120: DISK: Failed to open disk for consolidate '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk' : Failed to lock the file (16392) 6873
2016-04-05T14:41:09.826Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004-delta.vmdk" : open successful (10) size = 86016, hd = 65932038. Type 8
2016-04-05T14:41:09.826Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000004-delta.vmdk" (0xa)
2016-04-05T14:41:09.826Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk' (0xa): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T14:41:09.830Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003-delta.vmdk" : open successful (14) size = 251744256, hd = 59247367. Type 8
2016-04-05T14:41:09.830Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000003-delta.vmdk" (0xe)
2016-04-05T14:41:09.830Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000003.vmdk' (0xe): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T14:41:09.834Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001-delta.vmdk" : open successful (14) size = 469848064, hd = 69208843. Type 8
2016-04-05T14:41:09.834Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-000001-delta.vmdk" (0xe)
2016-04-05T14:41:09.834Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000001.vmdk' (0xe): vmfsSparse, 83886080 sectors / 40 GB.
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-VMFS : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-flat.vmdk" : open successful (14) size = 42949672960, hd = 50531084. Type 3
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM-flat.vmdk" (0xe)
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-LINK : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk' (0xe): vmfs, 83886080 sectors / 40 GB.
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 4, numSubChains = 1
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 50531084, extentType = 2
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 69208843, extentType = 0
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(2) fid = 59247367, extentType = 0
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubC

chris1234 · Beitragvon **chris1234** » 06.04.2016, 11:03

Code: Alles auswählen

016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 4, numSubChains = 1
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 50531084, extentType = 2
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 69208843, extentType = 0
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(2) fid = 59247367, extentType = 0
2016-04-05T14:41:09.837Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(3) fid = 65932038, extentType = 0
2016-04-05T14:41:09.839Z| vcpu-0| I120: DISKLIB-LIB   : Resuming change tracking.
2016-04-05T14:41:09.841Z| vcpu-0| I120: DISKLIB-CBT   : Initializing ESX kernel change tracking for fid 65932038.
2016-04-05T14:41:09.841Z| vcpu-0| I120: DISKLIB-CBT   : Successfuly created cbt node 57b0b0d-cbt.
2016-04-05T14:41:09.841Z| vcpu-0| I120: DISKLIB-CBT   : Opening cbt node /vmfs/devices/cbt/57b0b0d-cbt
2016-04-05T14:41:09.841Z| vcpu-0| I120: DISKLIB-LIB   : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk" (flags 0xa, type vmfs).
2016-04-05T14:41:09.841Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk' has UUID '60 00 c2 90 85 75 e6 c5-c6 fd c5 00 7d 15 27 00'
2016-04-05T14:41:09.841Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk' Geo (5221/255/63) BIOS Geo (0/0/0)
2016-04-05T14:41:09.841Z| vcpu-0| I120: Creating virtual dev for scsi0:0
2016-04-05T14:41:09.842Z| vcpu-0| I120: DumpDiskInfo: scsi0:0 createType=11, capacity = 83886080, numLinks = 4, allocationType = 0
2016-04-05T14:41:09.842Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-05T14:41:09.842Z| vcpu-0| I120: DISKUTIL: scsi0:0 : geometry=5221/255/63
2016-04-05T14:41:09.842Z| vcpu-0| I120: DISK: OPEN scsi0:1 '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk' persistent R[]
2016-04-05T14:41:09.847Z| vcpu-0| I120: DISKLIB-VMFS  : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003-delta.vmdk" : open successful (10) size = 372736, hd = 82709264. Type 8
2016-04-05T14:41:09.847Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000003-delta.vmdk" (0xa)
2016-04-05T14:41:09.847Z| vcpu-0| I120: DISKLIB-LINK  : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk' (0xa): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-05T14:41:09.851Z| vcpu-0| I120: DISKLIB-VMFS  : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002-delta.vmdk" : open successful (14) size = 134590464, hd = 131730193. Type 8
2016-04-05T14:41:09.851Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000002-delta.vmdk" (0xe)
2016-04-05T14:41:09.851Z| vcpu-0| I120: DISKLIB-LINK  : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000002.vmdk' (0xe): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-05T14:41:09.862Z| vcpu-0| I120: DISKLIB-VMFS  : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001-delta.vmdk" : open successful (14) size = 84258816, hd = 67963666. Type 8
2016-04-05T14:41:09.863Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-000001-delta.vmdk" (0xe)
2016-04-05T14:41:09.863Z| vcpu-0| I120: DISKLIB-LINK  : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000001.vmdk' (0xe): vmfsSparse, 377487360 sectors / 180 GB.
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-VMFS  : "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-flat.vmdk" : open successful (14) size = 193273528320, hd = 73599763. Type 3
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-DSCPTR: Opened [0]: "VM_1-flat.vmdk" (0xe)
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-LINK  : Opened '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1.vmdk' (0xe): vmfs, 377487360 sectors / 180 GB.
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain: numLinks = 4, numSubChains = 1
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(0) fid = 73599763, extentType = 2
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(1) fid = 67963666, extentType = 0
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(2) fid = 131730193, extentType = 0
2016-04-05T14:41:09.866Z| vcpu-0| I120: DISKLIB-CHAINESX : ChainESXOpenSubChain:(3) fid = 82709264, extentType = 0
2016-04-05T14:41:09.868Z| vcpu-0| I120: DISKLIB-LIB   : Resuming change tracking.
2016-04-05T14:41:09.871Z| vcpu-0| I120: DISKLIB-CBT   : Initializing ESX kernel change tracking for fid 82709264.
2016-04-05T14:41:09.871Z| vcpu-0| I120: DISKLIB-CBT   : Successfuly created cbt node 52f0b14-cbt.
2016-04-05T14:41:09.871Z| vcpu-0| I120: DISKLIB-CBT   : Opening cbt node /vmfs/devices/cbt/52f0b14-cbt
2016-04-05T14:41:09.871Z| vcpu-0| I120: DISKLIB-LIB   : Opened "/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk" (flags 0xa, type vmfs).
2016-04-05T14:41:09.871Z| vcpu-0| I120: DISK: Disk '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk' has UUID '60 00 c2 9f f9 9f 61 cb-96 e8 96 d8 29 03 6a 7f'
2016-04-05T14:41:09.871Z| vcpu-0| I120: DISK: OPEN '/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk' Geo (23497/255/63) BIOS Geo (0/0/0)
2016-04-05T14:41:09.871Z| vcpu-0| I120: Creating virtual dev for scsi0:1
2016-04-05T14:41:09.872Z| vcpu-0| I120: DumpDiskInfo: scsi0:1 createType=11, capacity = 377487360, numLinks = 4, allocationType = 0
2016-04-05T14:41:09.872Z| vcpu-0| I120: SCSIDiskESXPopulateVDevDesc: Using FS backend
2016-04-05T14:41:09.872Z| vcpu-0| I120: DISKUTIL: scsi0:1 : geometry=23497/255/63
2016-04-05T14:41:09.873Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: nextState = 2 uid 489
2016-04-05T14:41:09.873Z| vcpu-0| I120: Vix: [11834 mainDispatch.c:3870]: VMAutomation_ReportPowerOpFinished: statevar=3, newAppState=1881, success=1 additionalError=0
2016-04-05T14:41:09.873Z| vcpu-0| I120: Vix: [11834 vigorCommands.c:548]: VigorSnapshotManagerConsolidateCallback: snapshotErr = Failed to lock the file (5:4008)
2016-04-05T14:41:09.873Z| vcpu-0| I120: Turning off snapshot info cache.
2016-04-05T14:41:09.875Z| vcpu-0| I120: Turning off snapshot disk cache.
2016-04-05T14:41:09.875Z| vcpu-0| I120: SnapshotVMXConsolidateOnlineCB: Done with consolidate
2016-04-05T14:41:09.894Z| vcpu-0| I120: HBACommon: First write on scsi0:1.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM_1-000003.vmdk'
2016-04-05T14:41:09.894Z| vcpu-0| I120: DDB: "longContentID" = "77b4d88ad90ad50dcf6c39d831617cd2" (was "9414de50927e10965b9d833668208bd9")
2016-04-05T14:41:09.918Z| vcpu-0| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0x68208bd9, new=0x31617cd2 (77b4d88ad90ad50dcf6c39d831617cd2)
2016-04-05T14:41:27.540Z| vcpu-1| I120: <<< Log Throttled >>>
2016-04-05T14:41:27.540Z| vcpu-1| I120: HBACommon: First write on scsi0:0.fileName='/vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM-000004.vmdk'
2016-04-05T14:41:27.541Z| vcpu-1| I120: DDB: "longContentID" = "706b5fa5096487a030745eb2a451e852" (was "7c0ec449ebc3e3ab080622b37047c3be")
2016-04-05T14:41:27.570Z| vcpu-1| I120: DISKLIB-CHAIN : DiskChainUpdateContentID: old=0x7047c3be, new=0xa451e852 (706b5fa5096487a030745eb2a451e852)
2016-04-05T14:42:09.882Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox-dnd timed out.
2016-04-05T19:53:12.078Z| vcpu-1| I120: ide1:0: Command *UNKNOWN (0x4a)* took 30.259 seconds (ok)
2016-04-06T02:01:21.580Z| vmx| I120: GuestRpcSendTimedOut: message to toolbox timed out.
2016-04-06T07:55:24.529Z| vcpu-0| I120: ide1:0: Command *UNKNOWN (0x4a)* took 2.374 seconds (ok)

JustMe · Beitragvon **JustMe** » 06.04.2016, 11:13

Aeh, nee. Bitte nicht versuchen, Logs von zig hundert KB hier im Forum als Text (oder auch als "Code") zu posten.

Besser irgendwo hochladen, und dann hier nur den Link posten. Dann hat man die Datei einerseits komplett (wenn auch "sanitized" ;-)

), und zum anderen ohne die misinterpretierten Bruchstellen.

Aber auch so kann man schon in den Schnipseln dieses erkennen:

Code: Alles auswählen

2016-04-05T07:17:52.888Z| vcpu-0| I120: SNAPSHOT:Failed to open disk /vmfs/volumes/544a1df2-2e2e8115-c8d7-001999ed4aa0/VM/VM.vmdk : [b]Failed to lock the file[/b] (16392)

Also hat da vmtl. noch "jemand" die Finger drauf.

chris1234 · Beitragvon **chris1234** » 06.04.2016, 11:53

eine wischenfrage.

Gibt es eine Möglichkeit das rauszufinden ? wer das noch blockiert?

Die SIcherungen werden über einen AD-BackupUser (adminrechte) gemacht. Kann es sein, dass er das ist ?
Das konsoldieren habe ich mit meinen Account gemacht.
Kann das sein ?

JustMe · Beitragvon **JustMe** » 06.04.2016, 12:12

Als wischenantwort:
Investigating virtual machine file locks on ESXi/ESX (10051)
bzw. auch
Finding the lock owners of a VMDK or file on a VMFS datastore in VMware ESXi 5.5 P05 (2110152)

Aber wie schon viele Zeile weiter oben erwaehnt:
Schau' doch erstmal bei der Backup-Appliance nach, ob die noch "zusaetzliche" Disks angehaengt hat.

Die vmdk File Locks stammen nicht von einem "Benutzer/Account", sondern von Prozessen, meistens VMs.

chris1234 · Beitragvon **chris1234** » 06.04.2016, 15:32

Code: Alles auswählen


VM-000001-ctk.vmdk        VM.vmxf
VM-000001-delta.vmdk      VM.vmx~
VM-000001.vmdk            VM_1-000001-ctk.vmdk
VM-000002-delta.vmdk      VM_1-000001-delta.vmdk
VM-000002.vmdk            VM_1-000001.vmdk
VM-000003-ctk.vmdk        VM_1-000002-ctk.vmdk
VM-000003-delta.vmdk      VM_1-000002-delta.vmdk
VM-000003.vmdk            VM_1-000002.vmdk
VM-000004-ctk.vmdk        VM_1-000003-ctk.vmdk
VM-000004-delta.vmdk      VM_1-000003-delta.vmdk
VM-000004.vmdk            VM_1-000003.vmdk
VM-Snapshot489.vmsn       VM_1-ctk.vmdk
VM-aux.xml                VM_1-flat.vmdk
VM-cf462e6a.hlog          VM_1.vmdk


VM-000001-delta.vmdk
Lock [type 10c00001 offset 241883136 v 79227, hb offset 3555328
gen 531, mode 2, owner 00000000-00000000-0000-000000000000 mtime 998786
num 1 gblnum 0 gblgen 0 gblbrk 0]
RO Owner[0] HB Offset 3555328 56be222a-7ebde35c-87ec-001999ed4aa0
Addr <4, 560, 155>, gen 79212, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 469848064, nb 449 tbz 0, cow 0, newSinceEpoch 449, zla 3, bs 1048576



VM-000002-delta.vmdk
Lock [type 10c00001 offset 241922048 v 79258, hb offset 3833856
gen 6749, mode 0, owner 00000000-00000000-0000-000000000000 mtime 639817
num 0 gblnum 0 gblgen 0 gblbrk 0]
Addr <4, 560, 174>, gen 79228, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 16863232, nb 17 tbz 0, cow 0, newSinceEpoch 17, zla 1, bs 1048576


VM-000003-delta.vmdk
Lock [type 10c00001 offset 241647616 v 79314, hb offset 3555328
gen 531, mode 2, owner 00000000-00000000-0000-000000000000 mtime 998781
num 1 gblnum 0 gblgen 0 gblbrk 0]
RO Owner[0] HB Offset 3555328 56be222a-7ebde35c-87ec-001999ed4aa0
Addr <4, 560, 40>, gen 79303, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 251744256, nb 241 tbz 0, cow 0, newSinceEpoch 241, zla 1, bs 1048576


VM-000004-delta.vmdk
Lock [type 10c00001 offset 241905664 v 79532, hb offset 3555328
gen 531, mode 1, owner 56be222a-7ebde35c-87ec-001999ed4aa0 mtime 998776
num 0 gblnum 0 gblgen 0 gblbrk 0]
Addr <4, 560, 166>, gen 79525, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 520179712, nb 497 tbz 0, cow 0, newSinceEpoch 497, zla 3, bs 1048576


zweite Platte

VM_1-000001.vmdk
Lock [type 10c00001 offset 241911808 v 79243, hb offset 3555328
gen 531, mode 0, owner 00000000-00000000-0000-000000000000 mtime 998805
num 0 gblnum 0 gblgen 0 gblbrk 0]
Addr <4, 560, 169>, gen 79221, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 396, nb 0 tbz 0, cow 0, newSinceEpoch 0, zla 4305, bs 8192


VM_1-000002.vmdk
Lock [type 10c00001 offset 241666048 v 79332, hb offset 3555328
gen 531, mode 0, owner 00000000-00000000-0000-000000000000 mtime 998800
num 0 gblnum 0 gblgen 0 gblbrk 0]
Addr <4, 560, 49>, gen 79312, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 403, nb 0 tbz 0, cow 0, newSinceEpoch 0, zla 4305, bs 8192


VM_1-000003.vmdk
Lock [type 10c00001 offset 241958912 v 79550, hb offset 3555328
gen 531, mode 0, owner 00000000-00000000-0000-000000000000 mtime 998845
num 0 gblnum 0 gblgen 0 gblbrk 0]
Addr <4, 560, 192>, gen 79534, links 1, type reg, flags 0, uid 0, gid 0, mode 600
len 403, nb 0 tbz 0, cow 0, newSinceEpoch 0, zla 4305, bs 8192

Die Mac adresse 001999ed4aa0 gehört dem esxi auf dem die VM läuft.

habe jetzt in einem anderen Beitrag gelesen das man hostd dienst neustarten kann um das Problem zu lösen.

Meine frage, kann ich das im laufenden Betrieb machen ? Laufen ja auch andere VM´s auf dem ESX

JustMe · Beitragvon **JustMe** » 06.04.2016, 16:01

Ja, kann man.
Und wenn's nicht nur der hostd sein sollte:

Code: Alles auswählen

~ # /bin/services.sh restart

Restarting the Management agents on an ESXi or ESX host (1003490)

Ausserdem fehlen noch die Lock-Ausgaben fuer die Base-vmdks auf Eurem FTS-Server.

Und natuerlich die Antworten auf all' die anderen Fragen ;-)

chris1234 · Beitragvon **chris1234** » 06.04.2016, 16:16

Erstmal vielen Dank, das du so aktiv mithilfst :-)

die beiden vmdk datein haben beide bei owner 00000000

Das backup ist, denke ich nicht das Problem, weil wir nicht per Hotadd sichern sondern LAN, jeden Tag vollbackup. Dazu habe ich ich den Backupserver neugestartet aber das konsolidieren noch nicht durchgeführt.

was mir noch aufgefallen ist, die eine platte hat 4 deltas und die andere 3.

weiß nur nicht, was ich zuerst machen soll
:shock:

JustMe · Beitragvon **JustMe** » 06.04.2016, 16:28

Schau mal weiter oben, wo ich schrieb

dass da noch drei bzw. vier Snapshots bestehen

.

Moeglicherweise ist da mal beim Aufloesen eines Snapshots der VM der Prozess nach der ersten der beiden vmdk abgebrochen oder so. Deswegen ist auch die Snapshot-Info in sich nicht mehr konsistent, und im Gesamtergebnis schlaegt das "Konsolidieren" fehl.

Wenn Du magst, kannst Du ja zuerst mal die Dienste restarten. Das sollte die laufenden VMs nicht beeinflussen. Ich persoenlich bezweifle aber, dass das beim aktuellen Problem hilft.

Danach gehst Du einfach die Reihenfolge der Vorschlaege durch wie sie von verschiedenen Quellen hier im Thread geaeussert wurden. ;-)

Beitragvon **Dayworker** » 06.04.2016, 18:14

Owner 0000000 sieht für mich nach einem verwaisten Eintrag aus und vermutlich muß der ESXi mal rebootet werden, damit dort wieder sinnvolle Anzeigen möglich sind.

Beitragvon **irix** » 06.04.2016, 22:51

Bei uns hilft da nur immer ein ESXi Reboot.

Gruss
Joerg

chris1234 · Beitragvon **chris1234** » 07.04.2016, 10:11

okay,

ich verschiebe alle VM´s auf einen anderen Knoten ( auch die betroffenen ) und starte den esxi neu. Verschiebe alles wieder zurück, und versuche dann die Snapshots zu löschen ? bzw zu konsolidieren ?

JustMe · Beitragvon **JustMe** » 07.04.2016, 10:23

Jou.
Probier's.
Damit ueberhaupt mal was ausprobiert wird :-)

(Das soll aber nicht heissen, dass es sinnlos waere. Abhaengig von der tatsaechlichen Ursache und den erzielten Ergebnissen koennen aber noch weitere Massnahmen noetig sein.)

chris1234 · Beitragvon **chris1234** » 11.04.2016, 15:16

soooo

ich habe folgendes gemacht, alle VM´s auf einen anderen Knoten geschubst. Knoten neugestartet. Alle vm´s wieder zurück.
Die betroffene VM genommen. -> konsolidieren. Lief druch.

Was aufgefallen ist, das eine delta "über" ist VM-000002.vmdk

Wenn ich mir die einstellungen der VM anschaue, ist die VM-00002.vmdk nicht eingebunden.

ist das einfach über ? kann es gelöscht werden ?

Ansonsten bis jetzt danke an alle die mir geholfen haben :-)

JustMe · Beitragvon **JustMe** » 11.04.2016, 15:30

"Ist das Kunst, oder kann das weg?"

Nee, kann vmtl. einfach geloescht werden.

Die Anzeige im vSphere (Web) Client ist nicht wirklich hilfreich. Auch von Snapshot-Ketten wird ja immer nur das "Ende" angezeigt, und weder der Anfang, noch die ganzen Zwischenstuecke.

Deshalb einfach mal zur Sicherheit die uebriggebliebene Datei *auf der Kommandozeile* in ein anderes Verzeichnis verschieben. Wenn das geht, dann arbeitet da (zumindest momentan) keiner mehr dran. Um ganz sicher zu gehen, kann man die Datei dann noch 1-2 Jahre in ihrem Ablageverzeichnis abhaengen lassen (oder kuerzer :-)

), bevor man sie endgueltig loescht.

VMware-Forum

Die Festplatten müssen konsoldiert werden. -> Zugriff nic

Die Festplatten müssen konsoldiert werden. -> Zugriff nic

Wer ist online?