Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.531 3A681B90 verbose 'Partitionsvc' opID=7C06D05E-000000AE] InvokePartedUtil /sbin/partedUtil "get" "/vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397"
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.531 3A681B90 verbose 'SysCommandPosix' opID=7C06D05E-000000AE] ForkExec '/sbin/partedUtil', pid 11624, rc 0
Jul 14 19:40:50 vmkernel: 0:00:34:10.402 cpu0:11624)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:40:50 vmkernel: 0:00:34:10.403 cpu0:11624)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x5
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.580 3A681B90 verbose 'Partitionsvc' opID=7C06D05E-000000AE] Output Stream from partedUtil while getting partitions for /vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397:
Jul 14 19:40:50 Hostd: 486267 255 63 7811891200
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.601 3A28AB90 verbose 'Partitionsvc' opID=7C06D05E-000000AF] InvokePartedUtil /sbin/partedUtil "get" "/vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397"
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.602 3A28AB90 verbose 'SysCommandPosix' opID=7C06D05E-000000AF] ForkExec '/sbin/partedUtil', pid 11625, rc 0
Jul 14 19:40:50 vmkernel: 0:00:34:10.473 cpu6:11625)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:40:50 vmkernel: 0:00:34:10.474 cpu6:11625)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x5
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.683 3A28AB90 verbose 'Partitionsvc' opID=7C06D05E-000000AF] Output Stream from partedUtil while getting partitions for /vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397:
Jul 14 19:40:50 Hostd: 486267 255 63 7811891200
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.683 3A28AB90 verbose 'App' opID=7C06D05E-000000AF] Available primary : [1, 2, 3, 4, ]
Jul 14 19:40:50 Hostd: [2011-07-14 19:40:50.683 3A28AB90 verbose 'App' opID=7C06D05E-000000AF] Setting start sector to 128 for 64K alignment
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.645 3A772B90 verbose 'Partitionsvc' opID=7C06D05E-000000B1] InvokePartedUtil /sbin/partedUtil "get" "/vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397"
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.645 3A772B90 verbose 'SysCommandPosix' opID=7C06D05E-000000B1] ForkExec '/sbin/partedUtil', pid 11626, rc 0
Jul 14 19:41:00 vmkernel: 0:00:34:20.516 cpu0:11626)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:41:00 vmkernel: 0:00:34:20.517 cpu2:11626)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x5
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.709 3A772B90 verbose 'Partitionsvc' opID=7C06D05E-000000B1] Output Stream from partedUtil while getting partitions for /vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397:
Jul 14 19:41:00 Hostd: 486267 255 63 7811891200
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.709 3A772B90 verbose 'App' opID=7C06D05E-000000B1] Available primary : [1, 2, 3, 4, ]
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.709 3A772B90 verbose 'App' opID=7C06D05E-000000B1] Setting start sector to 128 for 64K alignment
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.739 3A440B90 info 'TaskManager' opID=7C06D05E-000000B2] Task Created : haTask-ha-host-vim.host.DatastoreSystem.createVmfsDatastore-66
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.740 3A681B90 verbose 'FSVolumeProvider' opID=7C06D05E-000000B2] RescanVmfs called
Jul 14 19:41:00 vmkernel: 0:00:34:20.618 cpu0:5403)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:41:00 vmkernel: 0:00:34:20.656 cpu7:5403)Vol3: 1604: Could not open device 'mpx.vmhba32:C0:T0:L0:8' for probing: Permission denied
Jul 14 19:41:00 vmkernel: 0:00:34:20.666 cpu7:5403)Vol3: 644: Could not open device 'mpx.vmhba32:C0:T0:L0:8' for volume open: Permission denied
Jul 14 19:41:00 vmkernel: 0:00:34:20.689 cpu7:5403)Vol3: 1604: Could not open device 'mpx.vmhba32:C0:T0:L0:6' for probing: Permission denied
Jul 14 19:41:00 vmkernel: 0:00:34:20.698 cpu7:5403)Vol3: 644: Could not open device 'mpx.vmhba32:C0:T0:L0:6' for volume open: Permission denied
Jul 14 19:41:00 vmkernel: 0:00:34:20.730 cpu7:5403)Vol3: 1604: Could not open device 'mpx.vmhba32:C0:T0:L0:5' for probing: Permission denied
Jul 14 19:41:00 vmkernel: 0:00:34:20.739 cpu7:5403)Vol3: 644: Could not open device 'mpx.vmhba32:C0:T0:L0:5' for volume open: Permission denied
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.905 3A440B90 verbose 'Hostsvc::DatastoreSystem'] VmfsUpdate: got VMFS message [N11HostdCommon18VmkernelUpdateVmfsE:0xd246d10] timestamp=2060784993 specific=0 name= label=
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.906 3A681B90 verbose 'Partitionsvc' opID=7C06D05E-000000B2] InvokePartedUtil /sbin/partedUtil "set" "/vmfs/devices/disks/naa.60024e8055da830015b1fab4653de397" "1 128 7811879354 251 0"
Jul 14 19:41:00 Hostd: [2011-07-14 19:41:00.906 3A681B90 verbose 'SysCommandPosix' opID=7C06D05E-000000B2] ForkExec '/sbin/partedUtil', pid 11627, rc 0
Jul 14 19:41:00 vmkernel: 0:00:34:20.777 cpu2:11627)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:41:00 vmkernel: 0:00:34:20.778 cpu2:11627)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x5
Jul 14 19:41:00 vmkernel: 0:00:34:20.817 cpu5:11627)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:41:00 vmkernel: 0:00:34:20.855 cpu5:11627)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.013 3A681B90 verbose 'FSVolumeProvider' opID=7C06D05E-000000B2] RescanVmfs called
Jul 14 19:41:01 vmkernel: 0:00:34:20.890 cpu2:5403)WARNING: ScsiCore: 1400: Invalid sense buffer: error=0x0, valid=0x0, segment=0x0, key=0x0
Jul 14 19:41:01 vmkernel: 0:00:34:20.928 cpu2:5403)Vol3: 1604: Could not open device 'mpx.vmhba32:C0:T0:L0:5' for probing: Permission denied
Jul 14 19:41:01 vmkernel: 0:00:34:20.937 cpu2:5403)Vol3: 644: Could not open device 'mpx.vmhba32:C0:T0:L0:5' for volume open: Permission denied
Jul 14 19:41:01 vmkernel: 0:00:34:20.978 cpu2:5403)Vol3: 1604: Could not open device 'mpx.vmhba32:C0:T0:L0:6' for probing: Permission denied
Jul 14 19:41:01 vmkernel: 0:00:34:20.987 cpu2:5403)Vol3: 644: Could not open device 'mpx.vmhba32:C0:T0:L0:6' for volume open: Permission denied
Jul 14 19:41:01 vmkernel: 0:00:34:21.019 cpu2:5403)Vol3: 1604: Could not open device 'mpx.vmhba32:C0:T0:L0:8' for probing: Permission denied
Jul 14 19:41:01 vmkernel: 0:00:34:21.028 cpu2:5403)Vol3: 644: Could not open device 'mpx.vmhba32:C0:T0:L0:8' for volume open: Permission denied
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 info 'Hostsvc::DatastoreSystem' opID=7C06D05E-000000B2] Formatting vmfs partition
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 verbose 'FSVolumeProvider' opID=7C06D05E-000000B2] FormatVmfs called
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 verbose 'FSVolumeProvider' opID=7C06D05E-000000B2] LookupVmfs: Cannot find VMFS volume with disk name naa.60024e8055da830015b1fab4653de397 and number 1
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 verbose 'FSVolumeProvider' opID=7C06D05E-000000B2] LookupVmfs: Cannot find VMFS volume with id <unset>, path, <unset>, or name DatenFestplatte
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 verbose 'FSVolumeProvider' opID=7C06D05E-000000B2] LookupNasByName: Cannot find NasVolume with volume name DatenFestplatte
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 info 'App' opID=7C06D05E-000000B2] AdapterServer caught exception: 3a51d1d0
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A440B90 verbose 'Hostsvc::DatastoreSystem'] VmfsUpdate: got VMFS message [N11HostdCommon18VmkernelUpdateVmfsE:0xd894ff0] timestamp=2061054244 specific=0 name= label=
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 info 'TaskManager' opID=7C06D05E-000000B2] Task Completed : haTask-ha-host-vim.host.DatastoreSystem.createVmfsDatastore-66 Status error
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 info 'Vmomi' opID=7C06D05E-000000B2] Activation [N5Vmomi10ActivationE:0x3a332ea8] : Invoke done [createVmfsDatastore] on [vim.host.DatastoreSystem:ha-datastoresystem]
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.175 3A681B90 verbose 'Vmomi' opID=7C06D05E-000000B2] Arg spec:
Jul 14 19:41:01 Hostd: (vim.host.VmfsDatastoreCreateSpec) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: diskUuid = "020000000060024e8055da830015b1fab4653de397504552432035",
Jul 14 19:41:01 Hostd: partition = (vim.host.DiskPartitionInfo.Specification) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: partitionFormat = <unset>,
Jul 14 19:41:01 Hostd: chs = (vim.host.DiskDimensions.Chs) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: cylinder = 486267,
Jul 14 19:41:01 Hostd: head = 255,
Jul 14 19:41:01 Hostd: sector = 63,
Jul 14 19:41:01 Hostd: },
Jul 14 19:41:01 Hostd: totalSectors = 7811891200,
Jul 14 19:41:01 Hostd: partition = (vim.host.DiskPartitionInfo.Partition) [
Jul 14 19:41:01 Hostd: (vim.host.DiskPartitionInfo.Partition) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: partition = 1,
Jul 14 19:41:01 Hostd: startSector = 128,
Jul 14 19:41:01 Hostd: endSector = 7811879354,
Jul 14 19:41:01 Hostd: type = "0xfb",
Jul 14 19:41:01 Hostd: guid = <unset>,
Jul 14 19:41:01 Hostd: logical = false,
Jul 14 19:41:01 Hostd: attributes = 0,
Jul 14 19:41:01 Hostd: }
Jul 14 19:41:01 Hostd: ],
Jul 14 19:41:01 Hostd: },
Jul 14 19:41:01 Hostd: vmfs = (vim.host.VmfsVolume.Specification) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: extent = (vim.host.ScsiDisk.Partition) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: diskName = "naa.60024e8055da830015b1fab4653de397",
Jul 14 19:41:01 Hostd: partition = 1,
Jul 14 19:41:01 Hostd: },
Jul 14 19:41:01 Hostd: blockSizeMb = 1,
Jul 14 19:41:01 Hostd: majorVersion = 3,
Jul 14 19:41:01 Hostd: volumeName = "DatenFestplatte",
Jul 14 19:41:01 Hostd: },
Jul 14 19:41:01 Hostd: extent = (vim.host.ScsiDisk.Partition) [
Jul 14 19:41:01 Hostd: (vim.host.ScsiDisk.Partition) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: diskName = "naa.60024e8055da830015b1fab4653de397",
Jul 14 19:41:01 Hostd: partition = 1,
Jul 14 19:41:01 Hostd: }
Jul 14 19:41:01 Hostd: ],
Jul 14 19:41:01 Hostd: }
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.177 3A681B90 info 'Vmomi' opID=7C06D05E-000000B2] Throw vim.fault.PlatformConfigFault
Jul 14 19:41:01 Hostd: [2011-07-14 19:41:01.177 3A681B90 info 'Vmomi' opID=7C06D05E-000000B2] Result:
Jul 14 19:41:01 Hostd: (vim.fault.PlatformConfigFault) {
Jul 14 19:41:01 Hostd: dynamicType = <unset>,
Jul 14 19:41:01 Hostd: faultCause = (vmodl.MethodFault) null,
Jul 14 19:41:01 Hostd: text = "Unable to Find Head Extent Device Path",
Jul 14 19:41:01 Hostd: msg = "",
Jul 14 19:41:01 Hostd: }
Jul 14 19:41:06 Hostd: [2011-07-14 19:41:06.219 3A28AB90 verbose 'Cimsvc'] Ticket issued for CIMOM version 1.0, user root