All of lore.kernel.org
 help / color / mirror / Atom feed
* multipath-tools and queue-length/service-time path selectors oops
@ 2009-09-11 21:34 Andy
  2009-09-14  2:15 ` Kiyoshi Ueda
  0 siblings, 1 reply; 7+ messages in thread
From: Andy @ 2009-09-11 21:34 UTC (permalink / raw)
  To: dm-devel

When I try to change the path selector in multipath.conf to queue-length or
service-time I get a kernel oops.

Sep 11 15:33:32 linuxdev1 kernel: Modules linked in: kvm_intel kvm autofs4 cpufreq_powersave cpufreq_userspace cpufreq_ondemand cpufreq_conservative fuse qla2xxx dcdbas
Sep 11 15:33:32 linuxdev1 kernel: Pid: 6611, comm: multipath Not tainted 2.6.31 #34 PowerEdge 1950
Sep 11 15:33:32 linuxdev1 kernel: RIP: 0010:[<ffffffff8134207d>]  [<ffffffff8134207d>] multipath_ctr+0x7dd/0x980
Sep 11 15:33:32 linuxdev1 kernel: RSP: 0018:ffff880227d41c88  EFLAGS: 00010207
Sep 11 15:33:32 linuxdev1 kernel: RAX: 0000000000000002 RBX: 0000000000000000 RCX: ffff880226d41e40
Sep 11 15:33:32 linuxdev1 kernel: RDX: ffff88022de41980 RSI: 0000000000000286 RDI: 0000000000000286
Sep 11 15:33:32 linuxdev1 kernel: RBP: ffff880227d41d48 R08: 000000000000000a R09: 000000000000000a
Sep 11 15:33:32 linuxdev1 kernel: R10: 000000000000003c R11: 0000000000000000 R12: 0000000000000000
Sep 11 15:33:32 linuxdev1 kernel: R13: 0000000000000003 R14: 0000000000000003 R15: 0000000000000000
Sep 11 15:33:32 linuxdev1 kernel: FS:  00007f8d06dff790(0000) GS:ffff8800280ca000(0000) knlGS:0000000000000000
Sep 11 15:33:32 linuxdev1 kernel: CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
Sep 11 15:33:32 linuxdev1 kernel: CR2: 0000000000000030 CR3: 0000000227d37000 CR4: 00000000000026e0
Sep 11 15:33:32 linuxdev1 kernel: DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
Sep 11 15:33:32 linuxdev1 kernel: DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
Sep 11 15:33:32 linuxdev1 kernel: Process multipath (pid: 6611, threadinfo ffff880227d40000, task ffff88022ddb22d0)
Sep 11 15:33:32 linuxdev1 kernel: 00000000ffffffff 8000000000000163 ffffc90004f2a040 000000001cc2f800
Sep 11 15:33:32 linuxdev1 kernel: <0> ffff88022de41980 0000000000000040 ffff88022de419b0 ffff880227d41d70
Sep 11 15:33:32 linuxdev1 kernel: <0> ffff880226d41e78 ffffc90004f2a040 ffffc90004f24160 ffff880226d41e58
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff8133b4d2>] dm_table_add_target+0x172/0x220
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff8133d549>] table_load+0xe9/0x290
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff8133d460>] ? table_load+0x0/0x290
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff8133e4e1>] ctl_ioctl+0x1e1/0x260
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff810aad15>] ? cache_alloc_refill+0x85/0x270
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff8133e56e>] dm_ctl_ioctl+0xe/0x20
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff810bf811>] vfs_ioctl+0x31/0xa0
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff810bfd03>] do_vfs_ioctl+0x3f3/0x580
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff810bfeda>] sys_ioctl+0x4a/0x80
Sep 11 15:33:32 linuxdev1 kernel: [<ffffffff8100b4c2>] system_call_fastpath+0x16/0x1b
Sep 11 15:33:32 linuxdev1 kernel: RSP <ffff880227d41c88>
Sep 11 15:33:32 linuxdev1 kernel: ---[ end trace a1499fdf6de0e5c0 ]---

Any ideas,
	Andy

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: multipath-tools and queue-length/service-time path selectors oops
  2009-09-11 21:34 multipath-tools and queue-length/service-time path selectors oops Andy
@ 2009-09-14  2:15 ` Kiyoshi Ueda
  2009-09-14 15:12   ` Andy
  0 siblings, 1 reply; 7+ messages in thread
From: Kiyoshi Ueda @ 2009-09-14  2:15 UTC (permalink / raw)
  To: device-mapper development

Hi Andy,

Thank you for reporting this.

On 2009/09/12 6:34 +0900, Andy wrote:
> When I try to change the path selector in multipath.conf to queue-length or
> service-time I get a kernel oops.

I'd like to see the information of your environment, so could you
give me the followings?
  - multipath.conf which causes the oops.
  - The output of "multipath -v3" when the oops occurs.
  - Your distribution and its version.
  - The version of multipath-tools package (e.g. device-mapper-multipath in RHEL).
  - You don't hit the oops when you use round-robin, right?
    If so, can you give me the result of the following commands after you
    configure your multipath device using round-robin?
      * "multipath -ll"
      * "dmsetup table"

Thanks,
Kiyoshi Ueda

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: multipath-tools and queue-length/service-time path selectors oops
  2009-09-14  2:15 ` Kiyoshi Ueda
@ 2009-09-14 15:12   ` Andy
  2009-09-15  2:10     ` Kiyoshi Ueda
  0 siblings, 1 reply; 7+ messages in thread
From: Andy @ 2009-09-14 15:12 UTC (permalink / raw)
  To: device-mapper development

On Mon, Sep 14, 2009 at 11:15:47AM +0900, Kiyoshi Ueda wrote:
> Hi Andy,
> 
> Thank you for reporting this.
> 
> On 2009/09/12 6:34 +0900, Andy wrote:
> > When I try to change the path selector in multipath.conf to queue-length or
> > service-time I get a kernel oops.
> 
> I'd like to see the information of your environment, so could you
> give me the followings?


This is a test system, so there is no problem try things out on it.

version information:

Distribution : Debian squeeze/sid
kernel: 2.6.31

multipath-tools v0.4.9 (04/04, 2009)

dmsetup --version
Library version:   1.02.36 (2009-08-06)
Driver version:    4.15.0


multipath.conf part:

multipath {
	wwid 			350002ac000020246
	path_grouping_policy	multibus
	# path_selector		"round-robin 0"
	path_selector		"queue-length"
	rr_min_io		8	# u02 io count
	alias 			u02 
}

Round-robin dmsetup table:

u02: 0 209715200 multipath 0 0 1 1 round-robin 0 4 1 8:224 8 8:64 8 8:144 8 65:48 8 
u01: 0 73400304 linear 254:0 0
u01: 73400304 73400304 linear 254:4 0
u01: 146800608 52428784 linear 254:2 0
u01: 199229392 41943024 linear 254:3 0
u01_vm4: 0 41943040 multipath 0 0 1 1 round-robin 0 4 1 8:240 1 8:80 1 8:160 1 65:64 1 
u01_vm3: 0 52428800 multipath 0 0 1 1 round-robin 0 4 1 8:208 1 8:48 1 8:128 1 65:32 1 
u01_vm2: 0 73400320 multipath 0 0 1 1 round-robin 0 4 1 8:192 1 8:32 1 8:112 1 65:16 1 
u01_vm1: 0 73400320 multipath 0 0 1 1 round-robin 0 4 1 8:176 1 8:16 1 8:96 1 65:0 1 

Round-robin multipath -v3 :

Sep 14 09:45:31 | loop0: device node name blacklisted
Sep 14 09:45:31 | loop1: device node name blacklisted
Sep 14 09:45:31 | loop2: device node name blacklisted
Sep 14 09:45:31 | loop3: device node name blacklisted
Sep 14 09:45:31 | loop4: device node name blacklisted
Sep 14 09:45:31 | loop5: device node name blacklisted
Sep 14 09:45:31 | loop6: device node name blacklisted
Sep 14 09:45:31 | loop7: device node name blacklisted
Sep 14 09:45:31 | hda: device node name blacklisted
Sep 14 09:45:31 | sda: not found in pathvec
Sep 14 09:45:31 | sda: mask = 0x1f
Sep 14 09:45:31 | sda: dev_t = 8:0
Sep 14 09:45:31 | sda: size = 142082048
Sep 14 09:45:31 | sda: subsystem = scsi
Sep 14 09:45:31 | sda: vendor = DELL
Sep 14 09:45:31 | sda: product = PERC 5/i
Sep 14 09:45:31 | sda: rev = 1.03
Sep 14 09:45:31 | sda: h:b:t:l = 0:2:0:0
Sep 14 09:45:31 | sda: serial = 009534df7894e2720f00fe5320f0e401
Sep 14 09:45:31 | sda: get_state
Sep 14 09:45:31 | loading /lib64/multipath/libcheckreadsector0.so checker
Sep 14 09:45:31 | sda: path checker = readsector0 (config file default)
Sep 14 09:45:31 | sda: state = running
Sep 14 09:45:31 | sda: state = 3
Sep 14 09:45:31 | sda: prio = const (config file default)
Sep 14 09:45:31 | sda: const prio = 1
Sep 14 09:45:31 | sda: getuid = /sbin/scsi_id -g -u -s /block/%n (config file default)
Sep 14 09:45:31 | sda: uid = 36001e4f02053fe000f72e29478df3495 (callout)
Sep 14 09:45:31 | sdb: not found in pathvec
Sep 14 09:45:31 | sdb: mask = 0x1f
Sep 14 09:45:31 | sdb: dev_t = 8:16
Sep 14 09:45:31 | sdb: size = 73400320
Sep 14 09:45:31 | sdb: subsystem = scsi
Sep 14 09:45:31 | sdb: vendor = 3PARdata
Sep 14 09:45:31 | sdb: product = VV
Sep 14 09:45:31 | sdb: rev = 0000
Sep 14 09:45:31 | sdb: h:b:t:l = 1:0:0:0
Sep 14 09:45:31 | sdb: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdb: serial = 00ED0246
Sep 14 09:45:31 | sdb: get_state
Sep 14 09:45:31 | sdb: path checker = directio (controller setting)
Sep 14 09:45:31 | sdb: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdb: state = 3
Sep 14 09:45:31 | sdb: prio = const (controller setting)
Sep 14 09:45:31 | sdb: const prio = 1
Sep 14 09:45:31 | sdb: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdb: uid = 350002ac000ed0246 (callout)
Sep 14 09:45:31 | sdc: not found in pathvec
Sep 14 09:45:31 | sdc: mask = 0x1f
Sep 14 09:45:31 | sdc: dev_t = 8:32
Sep 14 09:45:31 | sdc: size = 73400320
Sep 14 09:45:31 | sdc: subsystem = scsi
Sep 14 09:45:31 | sdc: vendor = 3PARdata
Sep 14 09:45:31 | sdc: product = VV
Sep 14 09:45:31 | sdc: rev = 0000
Sep 14 09:45:31 | sdc: h:b:t:l = 1:0:0:1
Sep 14 09:45:31 | sdc: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdc: serial = 00EE0246
Sep 14 09:45:31 | sdc: get_state
Sep 14 09:45:31 | sdc: path checker = directio (controller setting)
Sep 14 09:45:31 | sdc: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdc: state = 3
Sep 14 09:45:31 | sdc: prio = const (controller setting)
Sep 14 09:45:31 | sdc: const prio = 1
Sep 14 09:45:31 | sdc: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdc: uid = 350002ac000ee0246 (callout)
Sep 14 09:45:31 | sdd: not found in pathvec
Sep 14 09:45:31 | sdd: mask = 0x1f
Sep 14 09:45:31 | sdd: dev_t = 8:48
Sep 14 09:45:31 | sdd: size = 52428800
Sep 14 09:45:31 | sdd: subsystem = scsi
Sep 14 09:45:31 | sdd: vendor = 3PARdata
Sep 14 09:45:31 | sdd: product = VV
Sep 14 09:45:31 | sdd: rev = 0000
Sep 14 09:45:31 | sdd: h:b:t:l = 1:0:0:2
Sep 14 09:45:31 | sdd: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdd: serial = 01260246
Sep 14 09:45:31 | sdd: get_state
Sep 14 09:45:31 | sdd: path checker = directio (controller setting)
Sep 14 09:45:31 | sdd: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdd: state = 3
Sep 14 09:45:31 | sdd: prio = const (controller setting)
Sep 14 09:45:31 | sdd: const prio = 1
Sep 14 09:45:31 | sdd: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdd: uid = 350002ac001260246 (callout)
Sep 14 09:45:31 | sde: not found in pathvec
Sep 14 09:45:31 | sde: mask = 0x1f
Sep 14 09:45:31 | sde: dev_t = 8:64
Sep 14 09:45:31 | sde: size = 209715200
Sep 14 09:45:31 | sde: subsystem = scsi
Sep 14 09:45:31 | sde: vendor = 3PARdata
Sep 14 09:45:31 | sde: product = VV
Sep 14 09:45:31 | sde: rev = 0000
Sep 14 09:45:31 | sde: h:b:t:l = 1:0:0:3
Sep 14 09:45:31 | sde: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sde: serial = 00020246
Sep 14 09:45:31 | sde: get_state
Sep 14 09:45:31 | sde: path checker = directio (controller setting)
Sep 14 09:45:31 | sde: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sde: state = 3
Sep 14 09:45:31 | sde: prio = const (controller setting)
Sep 14 09:45:31 | sde: const prio = 1
Sep 14 09:45:31 | sde: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sde: uid = 350002ac000020246 (callout)
Sep 14 09:45:31 | sdf: not found in pathvec
Sep 14 09:45:31 | sdf: mask = 0x1f
Sep 14 09:45:31 | sdf: dev_t = 8:80
Sep 14 09:45:31 | sdf: size = 41943040
Sep 14 09:45:31 | sdf: subsystem = scsi
Sep 14 09:45:31 | sdf: vendor = 3PARdata
Sep 14 09:45:31 | sdf: product = VV
Sep 14 09:45:31 | sdf: rev = 0000
Sep 14 09:45:31 | sdf: h:b:t:l = 1:0:0:4
Sep 14 09:45:31 | sdf: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdf: serial = 01670246
Sep 14 09:45:31 | sdf: get_state
Sep 14 09:45:31 | sdf: path checker = directio (controller setting)
Sep 14 09:45:31 | sdf: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdf: state = 3
Sep 14 09:45:31 | sdf: prio = const (controller setting)
Sep 14 09:45:31 | sdf: const prio = 1
Sep 14 09:45:31 | sdf: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdf: uid = 350002ac001670246 (callout)
Sep 14 09:45:31 | sdg: not found in pathvec
Sep 14 09:45:31 | sdg: mask = 0x1f
Sep 14 09:45:31 | sdg: dev_t = 8:96
Sep 14 09:45:31 | sdg: size = 73400320
Sep 14 09:45:31 | sdg: subsystem = scsi
Sep 14 09:45:31 | sdg: vendor = 3PARdata
Sep 14 09:45:31 | sdg: product = VV
Sep 14 09:45:31 | sdg: rev = 0000
Sep 14 09:45:31 | sdg: h:b:t:l = 1:0:1:0
Sep 14 09:45:31 | sdg: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdg: serial = 00ED0246
Sep 14 09:45:31 | sdg: get_state
Sep 14 09:45:31 | sdg: path checker = directio (controller setting)
Sep 14 09:45:31 | sdg: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdg: state = 3
Sep 14 09:45:31 | sdg: prio = const (controller setting)
Sep 14 09:45:31 | sdg: const prio = 1
Sep 14 09:45:31 | sdg: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdg: uid = 350002ac000ed0246 (callout)
Sep 14 09:45:31 | sdh: not found in pathvec
Sep 14 09:45:31 | sdh: mask = 0x1f
Sep 14 09:45:31 | sdh: dev_t = 8:112
Sep 14 09:45:31 | sdh: size = 73400320
Sep 14 09:45:31 | sdh: subsystem = scsi
Sep 14 09:45:31 | sdh: vendor = 3PARdata
Sep 14 09:45:31 | sdh: product = VV
Sep 14 09:45:31 | sdh: rev = 0000
Sep 14 09:45:31 | sdh: h:b:t:l = 1:0:1:1
Sep 14 09:45:31 | sdh: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdh: serial = 00EE0246
Sep 14 09:45:31 | sdh: get_state
Sep 14 09:45:31 | sdh: path checker = directio (controller setting)
Sep 14 09:45:31 | sdh: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdh: state = 3
Sep 14 09:45:31 | sdh: prio = const (controller setting)
Sep 14 09:45:31 | sdh: const prio = 1
Sep 14 09:45:31 | sdh: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdh: uid = 350002ac000ee0246 (callout)
Sep 14 09:45:31 | sdi: not found in pathvec
Sep 14 09:45:31 | sdi: mask = 0x1f
Sep 14 09:45:31 | sdi: dev_t = 8:128
Sep 14 09:45:31 | sdi: size = 52428800
Sep 14 09:45:31 | sdi: subsystem = scsi
Sep 14 09:45:31 | sdi: vendor = 3PARdata
Sep 14 09:45:31 | sdi: product = VV
Sep 14 09:45:31 | sdi: rev = 0000
Sep 14 09:45:31 | sdi: h:b:t:l = 1:0:1:2
Sep 14 09:45:31 | sdi: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdi: serial = 01260246
Sep 14 09:45:31 | sdi: get_state
Sep 14 09:45:31 | sdi: path checker = directio (controller setting)
Sep 14 09:45:31 | sdi: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdi: state = 3
Sep 14 09:45:31 | sdi: prio = const (controller setting)
Sep 14 09:45:31 | sdi: const prio = 1
Sep 14 09:45:31 | sdi: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdi: uid = 350002ac001260246 (callout)
Sep 14 09:45:31 | sdj: not found in pathvec
Sep 14 09:45:31 | sdj: mask = 0x1f
Sep 14 09:45:31 | sdj: dev_t = 8:144
Sep 14 09:45:31 | sdj: size = 209715200
Sep 14 09:45:31 | sdj: subsystem = scsi
Sep 14 09:45:31 | sdj: vendor = 3PARdata
Sep 14 09:45:31 | sdj: product = VV
Sep 14 09:45:31 | sdj: rev = 0000
Sep 14 09:45:31 | sdj: h:b:t:l = 1:0:1:3
Sep 14 09:45:31 | sdj: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdj: serial = 00020246
Sep 14 09:45:31 | sdj: get_state
Sep 14 09:45:31 | sdj: path checker = directio (controller setting)
Sep 14 09:45:31 | sdj: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdj: state = 3
Sep 14 09:45:31 | sdj: prio = const (controller setting)
Sep 14 09:45:31 | sdj: const prio = 1
Sep 14 09:45:31 | sdj: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdj: uid = 350002ac000020246 (callout)
Sep 14 09:45:31 | sdk: not found in pathvec
Sep 14 09:45:31 | sdk: mask = 0x1f
Sep 14 09:45:31 | sdk: dev_t = 8:160
Sep 14 09:45:31 | sdk: size = 41943040
Sep 14 09:45:31 | sdk: subsystem = scsi
Sep 14 09:45:31 | sdk: vendor = 3PARdata
Sep 14 09:45:31 | sdk: product = VV
Sep 14 09:45:31 | sdk: rev = 0000
Sep 14 09:45:31 | sdk: h:b:t:l = 1:0:1:4
Sep 14 09:45:31 | sdk: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdk: serial = 01670246
Sep 14 09:45:31 | sdk: get_state
Sep 14 09:45:31 | sdk: path checker = directio (controller setting)
Sep 14 09:45:31 | sdk: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdk: state = 3
Sep 14 09:45:31 | sdk: prio = const (controller setting)
Sep 14 09:45:31 | sdk: const prio = 1
Sep 14 09:45:31 | sdk: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdk: uid = 350002ac001670246 (callout)
Sep 14 09:45:31 | dm-0: device node name blacklisted
Sep 14 09:45:31 | dm-1: device node name blacklisted
Sep 14 09:45:31 | dm-2: device node name blacklisted
Sep 14 09:45:31 | dm-3: device node name blacklisted
Sep 14 09:45:31 | dm-4: device node name blacklisted
Sep 14 09:45:31 | sdl: not found in pathvec
Sep 14 09:45:31 | sdl: mask = 0x1f
Sep 14 09:45:31 | sdl: dev_t = 8:176
Sep 14 09:45:31 | sdl: size = 73400320
Sep 14 09:45:31 | sdl: subsystem = scsi
Sep 14 09:45:31 | sdl: vendor = 3PARdata
Sep 14 09:45:31 | sdl: product = VV
Sep 14 09:45:31 | sdl: rev = 0000
Sep 14 09:45:31 | sdl: h:b:t:l = 2:0:0:0
Sep 14 09:45:31 | sdl: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdl: serial = 00ED0246
Sep 14 09:45:31 | sdl: get_state
Sep 14 09:45:31 | sdl: path checker = directio (controller setting)
Sep 14 09:45:31 | sdl: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdl: state = 3
Sep 14 09:45:31 | sdl: prio = const (controller setting)
Sep 14 09:45:31 | sdl: const prio = 1
Sep 14 09:45:31 | sdl: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdl: uid = 350002ac000ed0246 (callout)
Sep 14 09:45:31 | sdm: not found in pathvec
Sep 14 09:45:31 | sdm: mask = 0x1f
Sep 14 09:45:31 | sdm: dev_t = 8:192
Sep 14 09:45:31 | sdm: size = 73400320
Sep 14 09:45:31 | sdm: subsystem = scsi
Sep 14 09:45:31 | sdm: vendor = 3PARdata
Sep 14 09:45:31 | sdm: product = VV
Sep 14 09:45:31 | sdm: rev = 0000
Sep 14 09:45:31 | sdm: h:b:t:l = 2:0:0:1
Sep 14 09:45:31 | sdm: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdm: serial = 00EE0246
Sep 14 09:45:31 | sdm: get_state
Sep 14 09:45:31 | sdm: path checker = directio (controller setting)
Sep 14 09:45:31 | sdm: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdm: state = 3
Sep 14 09:45:31 | sdm: prio = const (controller setting)
Sep 14 09:45:31 | sdm: const prio = 1
Sep 14 09:45:31 | sdm: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdm: uid = 350002ac000ee0246 (callout)
Sep 14 09:45:31 | sdn: not found in pathvec
Sep 14 09:45:31 | sdn: mask = 0x1f
Sep 14 09:45:31 | sdn: dev_t = 8:208
Sep 14 09:45:31 | sdn: size = 52428800
Sep 14 09:45:31 | sdn: subsystem = scsi
Sep 14 09:45:31 | sdn: vendor = 3PARdata
Sep 14 09:45:31 | sdn: product = VV
Sep 14 09:45:31 | sdn: rev = 0000
Sep 14 09:45:31 | sdn: h:b:t:l = 2:0:0:2
Sep 14 09:45:31 | sdn: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdn: serial = 01260246
Sep 14 09:45:31 | sdn: get_state
Sep 14 09:45:31 | sdn: path checker = directio (controller setting)
Sep 14 09:45:31 | sdn: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdn: state = 3
Sep 14 09:45:31 | sdn: prio = const (controller setting)
Sep 14 09:45:31 | sdn: const prio = 1
Sep 14 09:45:31 | sdn: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdn: uid = 350002ac001260246 (callout)
Sep 14 09:45:31 | sdo: not found in pathvec
Sep 14 09:45:31 | sdo: mask = 0x1f
Sep 14 09:45:31 | sdo: dev_t = 8:224
Sep 14 09:45:31 | sdo: size = 209715200
Sep 14 09:45:31 | sdo: subsystem = scsi
Sep 14 09:45:31 | sdo: vendor = 3PARdata
Sep 14 09:45:31 | sdo: product = VV
Sep 14 09:45:31 | sdo: rev = 0000
Sep 14 09:45:31 | sdo: h:b:t:l = 2:0:0:3
Sep 14 09:45:31 | sdo: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdo: serial = 00020246
Sep 14 09:45:31 | sdo: get_state
Sep 14 09:45:31 | sdo: path checker = directio (controller setting)
Sep 14 09:45:31 | sdo: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdo: state = 3
Sep 14 09:45:31 | sdo: prio = const (controller setting)
Sep 14 09:45:31 | sdo: const prio = 1
Sep 14 09:45:31 | sdo: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdo: uid = 350002ac000020246 (callout)
Sep 14 09:45:31 | sdq: not found in pathvec
Sep 14 09:45:31 | sdq: mask = 0x1f
Sep 14 09:45:31 | sdq: dev_t = 65:0
Sep 14 09:45:31 | sdq: size = 73400320
Sep 14 09:45:31 | sdq: subsystem = scsi
Sep 14 09:45:31 | sdq: vendor = 3PARdata
Sep 14 09:45:31 | sdq: product = VV
Sep 14 09:45:31 | sdq: rev = 0000
Sep 14 09:45:31 | sdq: h:b:t:l = 2:0:1:0
Sep 14 09:45:31 | sdq: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdq: serial = 00ED0246
Sep 14 09:45:31 | sdq: get_state
Sep 14 09:45:31 | sdq: path checker = directio (controller setting)
Sep 14 09:45:31 | sdq: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdq: state = 3
Sep 14 09:45:31 | sdq: prio = const (controller setting)
Sep 14 09:45:31 | sdq: const prio = 1
Sep 14 09:45:31 | sdq: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdq: uid = 350002ac000ed0246 (callout)
Sep 14 09:45:31 | sdp: not found in pathvec
Sep 14 09:45:31 | sdp: mask = 0x1f
Sep 14 09:45:31 | sdp: dev_t = 8:240
Sep 14 09:45:31 | sdp: size = 41943040
Sep 14 09:45:31 | sdp: subsystem = scsi
Sep 14 09:45:31 | sdp: vendor = 3PARdata
Sep 14 09:45:31 | sdp: product = VV
Sep 14 09:45:31 | sdp: rev = 0000
Sep 14 09:45:31 | sdp: h:b:t:l = 2:0:0:4
Sep 14 09:45:31 | sdp: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdp: serial = 01670246
Sep 14 09:45:31 | sdp: get_state
Sep 14 09:45:31 | sdp: path checker = directio (controller setting)
Sep 14 09:45:31 | sdp: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdp: state = 3
Sep 14 09:45:31 | sdp: prio = const (controller setting)
Sep 14 09:45:31 | sdp: const prio = 1
Sep 14 09:45:31 | sdp: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdp: uid = 350002ac001670246 (callout)
Sep 14 09:45:31 | sdr: not found in pathvec
Sep 14 09:45:31 | sdr: mask = 0x1f
Sep 14 09:45:31 | sdr: dev_t = 65:16
Sep 14 09:45:31 | sdr: size = 73400320
Sep 14 09:45:31 | sdr: subsystem = scsi
Sep 14 09:45:31 | sdr: vendor = 3PARdata
Sep 14 09:45:31 | sdr: product = VV
Sep 14 09:45:31 | sdr: rev = 0000
Sep 14 09:45:31 | sdr: h:b:t:l = 2:0:1:1
Sep 14 09:45:31 | sdr: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdr: serial = 00EE0246
Sep 14 09:45:31 | sdr: get_state
Sep 14 09:45:31 | sdr: path checker = directio (controller setting)
Sep 14 09:45:31 | sdr: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdr: state = 3
Sep 14 09:45:31 | sdr: prio = const (controller setting)
Sep 14 09:45:31 | sdr: const prio = 1
Sep 14 09:45:31 | sdr: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdr: uid = 350002ac000ee0246 (callout)
Sep 14 09:45:31 | sds: not found in pathvec
Sep 14 09:45:31 | sds: mask = 0x1f
Sep 14 09:45:31 | sds: dev_t = 65:32
Sep 14 09:45:31 | sds: size = 52428800
Sep 14 09:45:31 | sds: subsystem = scsi
Sep 14 09:45:31 | sds: vendor = 3PARdata
Sep 14 09:45:31 | sds: product = VV
Sep 14 09:45:31 | sds: rev = 0000
Sep 14 09:45:31 | sds: h:b:t:l = 2:0:1:2
Sep 14 09:45:31 | sds: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sds: serial = 01260246
Sep 14 09:45:31 | sds: get_state
Sep 14 09:45:31 | sds: path checker = directio (controller setting)
Sep 14 09:45:31 | sds: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sds: state = 3
Sep 14 09:45:31 | sds: prio = const (controller setting)
Sep 14 09:45:31 | sds: const prio = 1
Sep 14 09:45:31 | sds: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sds: uid = 350002ac001260246 (callout)
Sep 14 09:45:31 | sdt: not found in pathvec
Sep 14 09:45:31 | sdt: mask = 0x1f
Sep 14 09:45:31 | sdt: dev_t = 65:48
Sep 14 09:45:31 | sdt: size = 209715200
Sep 14 09:45:31 | sdt: subsystem = scsi
Sep 14 09:45:31 | sdt: vendor = 3PARdata
Sep 14 09:45:31 | sdt: product = VV
Sep 14 09:45:31 | sdt: rev = 0000
Sep 14 09:45:31 | sdt: h:b:t:l = 2:0:1:3
Sep 14 09:45:31 | sdt: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdt: serial = 00020246
Sep 14 09:45:31 | sdt: get_state
Sep 14 09:45:31 | sdt: path checker = directio (controller setting)
Sep 14 09:45:31 | sdt: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdt: state = 3
Sep 14 09:45:31 | sdt: prio = const (controller setting)
Sep 14 09:45:31 | sdt: const prio = 1
Sep 14 09:45:31 | sdt: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdt: uid = 350002ac000020246 (callout)
Sep 14 09:45:31 | sdu: not found in pathvec
Sep 14 09:45:31 | sdu: mask = 0x1f
Sep 14 09:45:31 | sdu: dev_t = 65:64
Sep 14 09:45:31 | sdu: size = 41943040
Sep 14 09:45:31 | sdu: subsystem = scsi
Sep 14 09:45:31 | sdu: vendor = 3PARdata
Sep 14 09:45:31 | sdu: product = VV
Sep 14 09:45:31 | sdu: rev = 0000
Sep 14 09:45:31 | sdu: h:b:t:l = 2:0:1:4
Sep 14 09:45:31 | sdu: tgt_node_name = 0x2ff70002ac00024
Sep 14 09:45:31 | sdu: serial = 01670246
Sep 14 09:45:31 | sdu: get_state
Sep 14 09:45:31 | sdu: path checker = directio (controller setting)
Sep 14 09:45:31 | sdu: state = running
Sep 14 09:45:31 | directio: starting new request
Sep 14 09:45:31 | directio: io finished 4096/0
Sep 14 09:45:31 | sdu: state = 3
Sep 14 09:45:31 | sdu: prio = const (controller setting)
Sep 14 09:45:31 | sdu: const prio = 1
Sep 14 09:45:31 | sdu: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 09:45:31 | sdu: uid = 350002ac001670246 (callout)
Sep 14 09:45:31 | dm-5: device node name blacklisted
===== paths list =====
uuid                              hcil    dev dev_t pri dm_st chk_st vend/prod
36001e4f02053fe000f72e29478df3495 0:2:0:0 sda 8:0   1   undef ready  DELL,PERC
350002ac000ed0246                 1:0:0:0 sdb 8:16  1   undef ready  3PARdata,
350002ac000ee0246                 1:0:0:1 sdc 8:32  1   undef ready  3PARdata,
350002ac001260246                 1:0:0:2 sdd 8:48  1   undef ready  3PARdata,
350002ac000020246                 1:0:0:3 sde 8:64  1   undef ready  3PARdata,
350002ac001670246                 1:0:0:4 sdf 8:80  1   undef ready  3PARdata,
350002ac000ed0246                 1:0:1:0 sdg 8:96  1   undef ready  3PARdata,
350002ac000ee0246                 1:0:1:1 sdh 8:112 1   undef ready  3PARdata,
350002ac001260246                 1:0:1:2 sdi 8:128 1   undef ready  3PARdata,
350002ac000020246                 1:0:1:3 sdj 8:144 1   undef ready  3PARdata,
350002ac001670246                 1:0:1:4 sdk 8:160 1   undef ready  3PARdata,
350002ac000ed0246                 2:0:0:0 sdl 8:176 1   undef ready  3PARdata,
350002ac000ee0246                 2:0:0:1 sdm 8:192 1   undef ready  3PARdata,
350002ac001260246                 2:0:0:2 sdn 8:208 1   undef ready  3PARdata,
350002ac000020246                 2:0:0:3 sdo 8:224 1   undef ready  3PARdata,
350002ac000ed0246                 2:0:1:0 sdq 65:0  1   undef ready  3PARdata,
350002ac001670246                 2:0:0:4 sdp 8:240 1   undef ready  3PARdata,
350002ac000ee0246                 2:0:1:1 sdr 65:16 1   undef ready  3PARdata,
350002ac001260246                 2:0:1:2 sds 65:32 1   undef ready  3PARdata,
350002ac000020246                 2:0:1:3 sdt 65:48 1   undef ready  3PARdata,
350002ac001670246                 2:0:1:4 sdu 65:64 1   undef ready  3PARdata,
Sep 14 09:45:31 | params = 0 0 1 1 round-robin 0 4 1 8:224 8 8:64 8 8:144 8 65:48 8 
Sep 14 09:45:31 | status = 2 0 0 0 1 1 A 0 4 0 8:224 A 0 8:64 A 0 8:144 A 0 65:48 A 0 
Sep 14 09:45:31 | params = 0 0 1 1 round-robin 0 4 1 8:240 1 8:80 1 8:160 1 65:64 1 
Sep 14 09:45:31 | status = 2 0 0 0 1 1 A 0 4 0 8:240 A 0 8:80 A 0 8:160 A 0 65:64 A 0 
Sep 14 09:45:31 | params = 0 0 1 1 round-robin 0 4 1 8:208 1 8:48 1 8:128 1 65:32 1 
Sep 14 09:45:31 | status = 2 0 0 0 1 1 A 0 4 0 8:208 A 0 8:48 A 0 8:128 A 0 65:32 A 0 
Sep 14 09:45:31 | params = 0 0 1 1 round-robin 0 4 1 8:192 1 8:32 1 8:112 1 65:16 1 
Sep 14 09:45:31 | status = 2 0 0 0 1 1 A 0 4 0 8:192 A 0 8:32 A 0 8:112 A 0 65:16 A 0 
Sep 14 09:45:31 | params = 0 0 1 1 round-robin 0 4 1 8:176 1 8:16 1 8:96 1 65:0 1 
Sep 14 09:45:31 | status = 2 0 0 0 1 1 A 0 4 0 8:176 A 0 8:16 A 0 8:96 A 0 65:0 A 0 
Sep 14 09:45:31 | sda: ownership set to 36001e4f02053fe000f72e29478df3495
Sep 14 09:45:31 | sda: not found in pathvec
Sep 14 09:45:31 | sda: mask = 0xc
Sep 14 09:45:31 | sda: get_state
Sep 14 09:45:31 | sda: state = running
Sep 14 09:45:31 | sda: state = 3
Sep 14 09:45:31 | sda: const prio = 1
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: pgfailover = -1 (internal default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: pgpolicy = multibus (config file default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: selector = round-robin 0 (internal default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: features = 0 (internal default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: hwhandler = 0 (internal default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: rr_weight = 1 (internal default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: minio = 8 (config file default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: no_path_retry = NONE (internal default)
Sep 14 09:45:31 | pg_timeout = NONE (internal default)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: set ACT_CREATE (map does not exist)
Sep 14 09:45:31 | 36001e4f02053fe000f72e29478df3495: domap (0) failure for create/reload map

Round-robin multipath -ll

u02 (350002ac000020246) dm-1 3PARdata,VV
size=100G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:3 sdo 8:224 active ready running
  |- 1:0:0:3 sde 8:64  active ready running
  |- 1:0:1:3 sdj 8:144 active ready running
  `- 2:0:1:3 sdt 65:48 active ready running
u01_vm4 (350002ac001670246) dm-3 3PARdata,VV
size=20G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:4 sdp 8:240 active ready running
  |- 1:0:0:4 sdf 8:80  active ready running
  |- 1:0:1:4 sdk 8:160 active ready running
  `- 2:0:1:4 sdu 65:64 active ready running
u01_vm3 (350002ac001260246) dm-2 3PARdata,VV
size=25G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:2 sdn 8:208 active ready running
  |- 1:0:0:2 sdd 8:48  active ready running
  |- 1:0:1:2 sdi 8:128 active ready running
  `- 2:0:1:2 sds 65:32 active ready running
u01_vm2 (350002ac000ee0246) dm-4 3PARdata,VV
size=35G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:1 sdm 8:192 active ready running
  |- 1:0:0:1 sdc 8:32  active ready running
  |- 1:0:1:1 sdh 8:112 active ready running
  `- 2:0:1:1 sdr 65:16 active ready running
u01_vm1 (350002ac000ed0246) dm-0 3PARdata,VV
size=35G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:0 sdl 8:176 active ready running
  |- 1:0:0:0 sdb 8:16  active ready running
  |- 1:0:1:0 sdg 8:96  active ready running
  `- 2:0:1:0 sdq 65:0  active ready running


queue-length multipath -v3 (after multipathd causes a segfault):

Sep 14 10:04:27 | loop0: device node name blacklisted
Sep 14 10:04:27 | loop1: device node name blacklisted
Sep 14 10:04:27 | loop2: device node name blacklisted
Sep 14 10:04:27 | loop3: device node name blacklisted
Sep 14 10:04:27 | loop4: device node name blacklisted
Sep 14 10:04:27 | loop5: device node name blacklisted
Sep 14 10:04:27 | loop6: device node name blacklisted
Sep 14 10:04:27 | loop7: device node name blacklisted
Sep 14 10:04:27 | hda: device node name blacklisted
Sep 14 10:04:27 | sda: not found in pathvec
Sep 14 10:04:27 | sda: mask = 0x1f
Sep 14 10:04:27 | sda: dev_t = 8:0
Sep 14 10:04:27 | sda: size = 142082048
Sep 14 10:04:27 | sda: subsystem = scsi
Sep 14 10:04:27 | sda: vendor = DELL
Sep 14 10:04:27 | sda: product = PERC 5/i
Sep 14 10:04:27 | sda: rev = 1.03
Sep 14 10:04:27 | sda: h:b:t:l = 0:2:0:0
Sep 14 10:04:27 | sda: serial = 009534df7894e2720f00fe5320f0e401
Sep 14 10:04:27 | sda: get_state
Sep 14 10:04:27 | loading /lib64/multipath/libcheckreadsector0.so checker
Sep 14 10:04:27 | sda: path checker = readsector0 (config file default)
Sep 14 10:04:27 | sda: state = running
Sep 14 10:04:27 | sda: state = 3
Sep 14 10:04:27 | sda: prio = const (config file default)
Sep 14 10:04:27 | sda: const prio = 1
Sep 14 10:04:27 | sda: getuid = /sbin/scsi_id -g -u -s /block/%n (config file default)
Sep 14 10:04:27 | sda: uid = 36001e4f02053fe000f72e29478df3495 (callout)
Sep 14 10:04:27 | sdb: not found in pathvec
Sep 14 10:04:27 | sdb: mask = 0x1f
Sep 14 10:04:27 | sdb: dev_t = 8:16
Sep 14 10:04:27 | sdb: size = 73400320
Sep 14 10:04:27 | sdb: subsystem = scsi
Sep 14 10:04:27 | sdb: vendor = 3PARdata
Sep 14 10:04:27 | sdb: product = VV
Sep 14 10:04:27 | sdb: rev = 0000
Sep 14 10:04:27 | sdb: h:b:t:l = 1:0:0:0
Sep 14 10:04:27 | sdb: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdb: serial = 00ED0246
Sep 14 10:04:27 | sdb: get_state
Sep 14 10:04:27 | sdb: path checker = directio (controller setting)
Sep 14 10:04:27 | sdb: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdb: state = 3
Sep 14 10:04:27 | sdb: prio = const (controller setting)
Sep 14 10:04:27 | sdb: const prio = 1
Sep 14 10:04:27 | sdb: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdb: uid = 350002ac000ed0246 (callout)
Sep 14 10:04:27 | sdc: not found in pathvec
Sep 14 10:04:27 | sdc: mask = 0x1f
Sep 14 10:04:27 | sdc: dev_t = 8:32
Sep 14 10:04:27 | sdc: size = 73400320
Sep 14 10:04:27 | sdc: subsystem = scsi
Sep 14 10:04:27 | sdc: vendor = 3PARdata
Sep 14 10:04:27 | sdc: product = VV
Sep 14 10:04:27 | sdc: rev = 0000
Sep 14 10:04:27 | sdc: h:b:t:l = 1:0:0:1
Sep 14 10:04:27 | sdc: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdc: serial = 00EE0246
Sep 14 10:04:27 | sdc: get_state
Sep 14 10:04:27 | sdc: path checker = directio (controller setting)
Sep 14 10:04:27 | sdc: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdc: state = 3
Sep 14 10:04:27 | sdc: prio = const (controller setting)
Sep 14 10:04:27 | sdc: const prio = 1
Sep 14 10:04:27 | sdc: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdc: uid = 350002ac000ee0246 (callout)
Sep 14 10:04:27 | sdd: not found in pathvec
Sep 14 10:04:27 | sdd: mask = 0x1f
Sep 14 10:04:27 | sdd: dev_t = 8:48
Sep 14 10:04:27 | sdd: size = 52428800
Sep 14 10:04:27 | sdd: subsystem = scsi
Sep 14 10:04:27 | sdd: vendor = 3PARdata
Sep 14 10:04:27 | sdd: product = VV
Sep 14 10:04:27 | sdd: rev = 0000
Sep 14 10:04:27 | sdd: h:b:t:l = 1:0:0:2
Sep 14 10:04:27 | sdd: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdd: serial = 01260246
Sep 14 10:04:27 | sdd: get_state
Sep 14 10:04:27 | sdd: path checker = directio (controller setting)
Sep 14 10:04:27 | sdd: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdd: state = 3
Sep 14 10:04:27 | sdd: prio = const (controller setting)
Sep 14 10:04:27 | sdd: const prio = 1
Sep 14 10:04:27 | sdd: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdd: uid = 350002ac001260246 (callout)
Sep 14 10:04:27 | sde: not found in pathvec
Sep 14 10:04:27 | sde: mask = 0x1f
Sep 14 10:04:27 | sde: dev_t = 8:64
Sep 14 10:04:27 | sde: size = 209715200
Sep 14 10:04:27 | sde: subsystem = scsi
Sep 14 10:04:27 | sde: vendor = 3PARdata
Sep 14 10:04:27 | sde: product = VV
Sep 14 10:04:27 | sde: rev = 0000
Sep 14 10:04:27 | sde: h:b:t:l = 1:0:0:3
Sep 14 10:04:27 | sde: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sde: serial = 00020246
Sep 14 10:04:27 | sde: get_state
Sep 14 10:04:27 | sde: path checker = directio (controller setting)
Sep 14 10:04:27 | sde: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sde: state = 3
Sep 14 10:04:27 | sde: prio = const (controller setting)
Sep 14 10:04:27 | sde: const prio = 1
Sep 14 10:04:27 | sde: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sde: uid = 350002ac000020246 (callout)
Sep 14 10:04:27 | sdf: not found in pathvec
Sep 14 10:04:27 | sdf: mask = 0x1f
Sep 14 10:04:27 | sdf: dev_t = 8:80
Sep 14 10:04:27 | sdf: size = 41943040
Sep 14 10:04:27 | sdf: subsystem = scsi
Sep 14 10:04:27 | sdf: vendor = 3PARdata
Sep 14 10:04:27 | sdf: product = VV
Sep 14 10:04:27 | sdf: rev = 0000
Sep 14 10:04:27 | sdf: h:b:t:l = 1:0:0:4
Sep 14 10:04:27 | sdf: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdf: serial = 01670246
Sep 14 10:04:27 | sdf: get_state
Sep 14 10:04:27 | sdf: path checker = directio (controller setting)
Sep 14 10:04:27 | sdf: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdf: state = 3
Sep 14 10:04:27 | sdf: prio = const (controller setting)
Sep 14 10:04:27 | sdf: const prio = 1
Sep 14 10:04:27 | sdf: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdf: uid = 350002ac001670246 (callout)
Sep 14 10:04:27 | sdg: not found in pathvec
Sep 14 10:04:27 | sdg: mask = 0x1f
Sep 14 10:04:27 | sdg: dev_t = 8:96
Sep 14 10:04:27 | sdg: size = 73400320
Sep 14 10:04:27 | sdg: subsystem = scsi
Sep 14 10:04:27 | sdg: vendor = 3PARdata
Sep 14 10:04:27 | sdg: product = VV
Sep 14 10:04:27 | sdg: rev = 0000
Sep 14 10:04:27 | sdg: h:b:t:l = 1:0:1:0
Sep 14 10:04:27 | sdg: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdg: serial = 00ED0246
Sep 14 10:04:27 | sdg: get_state
Sep 14 10:04:27 | sdg: path checker = directio (controller setting)
Sep 14 10:04:27 | sdg: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdg: state = 3
Sep 14 10:04:27 | sdg: prio = const (controller setting)
Sep 14 10:04:27 | sdg: const prio = 1
Sep 14 10:04:27 | sdg: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdg: uid = 350002ac000ed0246 (callout)
Sep 14 10:04:27 | sdh: not found in pathvec
Sep 14 10:04:27 | sdh: mask = 0x1f
Sep 14 10:04:27 | sdh: dev_t = 8:112
Sep 14 10:04:27 | sdh: size = 73400320
Sep 14 10:04:27 | sdh: subsystem = scsi
Sep 14 10:04:27 | sdh: vendor = 3PARdata
Sep 14 10:04:27 | sdh: product = VV
Sep 14 10:04:27 | sdh: rev = 0000
Sep 14 10:04:27 | sdh: h:b:t:l = 1:0:1:1
Sep 14 10:04:27 | sdh: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdh: serial = 00EE0246
Sep 14 10:04:27 | sdh: get_state
Sep 14 10:04:27 | sdh: path checker = directio (controller setting)
Sep 14 10:04:27 | sdh: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdh: state = 3
Sep 14 10:04:27 | sdh: prio = const (controller setting)
Sep 14 10:04:27 | sdh: const prio = 1
Sep 14 10:04:27 | sdh: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdh: uid = 350002ac000ee0246 (callout)
Sep 14 10:04:27 | sdi: not found in pathvec
Sep 14 10:04:27 | sdi: mask = 0x1f
Sep 14 10:04:27 | sdi: dev_t = 8:128
Sep 14 10:04:27 | sdi: size = 52428800
Sep 14 10:04:27 | sdi: subsystem = scsi
Sep 14 10:04:27 | sdi: vendor = 3PARdata
Sep 14 10:04:27 | sdi: product = VV
Sep 14 10:04:27 | sdi: rev = 0000
Sep 14 10:04:27 | sdi: h:b:t:l = 1:0:1:2
Sep 14 10:04:27 | sdi: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdi: serial = 01260246
Sep 14 10:04:27 | sdi: get_state
Sep 14 10:04:27 | sdi: path checker = directio (controller setting)
Sep 14 10:04:27 | sdi: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdi: state = 3
Sep 14 10:04:27 | sdi: prio = const (controller setting)
Sep 14 10:04:27 | sdi: const prio = 1
Sep 14 10:04:27 | sdi: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdi: uid = 350002ac001260246 (callout)
Sep 14 10:04:27 | sdj: not found in pathvec
Sep 14 10:04:27 | sdj: mask = 0x1f
Sep 14 10:04:27 | sdj: dev_t = 8:144
Sep 14 10:04:27 | sdj: size = 209715200
Sep 14 10:04:27 | sdj: subsystem = scsi
Sep 14 10:04:27 | sdj: vendor = 3PARdata
Sep 14 10:04:27 | sdj: product = VV
Sep 14 10:04:27 | sdj: rev = 0000
Sep 14 10:04:27 | sdj: h:b:t:l = 1:0:1:3
Sep 14 10:04:27 | sdj: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdj: serial = 00020246
Sep 14 10:04:27 | sdj: get_state
Sep 14 10:04:27 | sdj: path checker = directio (controller setting)
Sep 14 10:04:27 | sdj: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdj: state = 3
Sep 14 10:04:27 | sdj: prio = const (controller setting)
Sep 14 10:04:27 | sdj: const prio = 1
Sep 14 10:04:27 | sdj: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdj: uid = 350002ac000020246 (callout)
Sep 14 10:04:27 | sdk: not found in pathvec
Sep 14 10:04:27 | sdk: mask = 0x1f
Sep 14 10:04:27 | sdk: dev_t = 8:160
Sep 14 10:04:27 | sdk: size = 41943040
Sep 14 10:04:27 | sdk: subsystem = scsi
Sep 14 10:04:27 | sdk: vendor = 3PARdata
Sep 14 10:04:27 | sdk: product = VV
Sep 14 10:04:27 | sdk: rev = 0000
Sep 14 10:04:27 | sdk: h:b:t:l = 1:0:1:4
Sep 14 10:04:27 | sdk: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdk: serial = 01670246
Sep 14 10:04:27 | sdk: get_state
Sep 14 10:04:27 | sdk: path checker = directio (controller setting)
Sep 14 10:04:27 | sdk: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdk: state = 3
Sep 14 10:04:27 | sdk: prio = const (controller setting)
Sep 14 10:04:27 | sdk: const prio = 1
Sep 14 10:04:27 | sdk: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdk: uid = 350002ac001670246 (callout)
Sep 14 10:04:27 | dm-0: device node name blacklisted
Sep 14 10:04:27 | dm-1: device node name blacklisted
Sep 14 10:04:27 | dm-2: device node name blacklisted
Sep 14 10:04:27 | dm-3: device node name blacklisted
Sep 14 10:04:27 | dm-4: device node name blacklisted
Sep 14 10:04:27 | sdl: not found in pathvec
Sep 14 10:04:27 | sdl: mask = 0x1f
Sep 14 10:04:27 | sdl: dev_t = 8:176
Sep 14 10:04:27 | sdl: size = 73400320
Sep 14 10:04:27 | sdl: subsystem = scsi
Sep 14 10:04:27 | sdl: vendor = 3PARdata
Sep 14 10:04:27 | sdl: product = VV
Sep 14 10:04:27 | sdl: rev = 0000
Sep 14 10:04:27 | sdl: h:b:t:l = 2:0:0:0
Sep 14 10:04:27 | sdl: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdl: serial = 00ED0246
Sep 14 10:04:27 | sdl: get_state
Sep 14 10:04:27 | sdl: path checker = directio (controller setting)
Sep 14 10:04:27 | sdl: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdl: state = 3
Sep 14 10:04:27 | sdl: prio = const (controller setting)
Sep 14 10:04:27 | sdl: const prio = 1
Sep 14 10:04:27 | sdl: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdl: uid = 350002ac000ed0246 (callout)
Sep 14 10:04:27 | sdm: not found in pathvec
Sep 14 10:04:27 | sdm: mask = 0x1f
Sep 14 10:04:27 | sdm: dev_t = 8:192
Sep 14 10:04:27 | sdm: size = 73400320
Sep 14 10:04:27 | sdm: subsystem = scsi
Sep 14 10:04:27 | sdm: vendor = 3PARdata
Sep 14 10:04:27 | sdm: product = VV
Sep 14 10:04:27 | sdm: rev = 0000
Sep 14 10:04:27 | sdm: h:b:t:l = 2:0:0:1
Sep 14 10:04:27 | sdm: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdm: serial = 00EE0246
Sep 14 10:04:27 | sdm: get_state
Sep 14 10:04:27 | sdm: path checker = directio (controller setting)
Sep 14 10:04:27 | sdm: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdm: state = 3
Sep 14 10:04:27 | sdm: prio = const (controller setting)
Sep 14 10:04:27 | sdm: const prio = 1
Sep 14 10:04:27 | sdm: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdm: uid = 350002ac000ee0246 (callout)
Sep 14 10:04:27 | sdn: not found in pathvec
Sep 14 10:04:27 | sdn: mask = 0x1f
Sep 14 10:04:27 | sdn: dev_t = 8:208
Sep 14 10:04:27 | sdn: size = 52428800
Sep 14 10:04:27 | sdn: subsystem = scsi
Sep 14 10:04:27 | sdn: vendor = 3PARdata
Sep 14 10:04:27 | sdn: product = VV
Sep 14 10:04:27 | sdn: rev = 0000
Sep 14 10:04:27 | sdn: h:b:t:l = 2:0:0:2
Sep 14 10:04:27 | sdn: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdn: serial = 01260246
Sep 14 10:04:27 | sdn: get_state
Sep 14 10:04:27 | sdn: path checker = directio (controller setting)
Sep 14 10:04:27 | sdn: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdn: state = 3
Sep 14 10:04:27 | sdn: prio = const (controller setting)
Sep 14 10:04:27 | sdn: const prio = 1
Sep 14 10:04:27 | sdn: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdn: uid = 350002ac001260246 (callout)
Sep 14 10:04:27 | sdo: not found in pathvec
Sep 14 10:04:27 | sdo: mask = 0x1f
Sep 14 10:04:27 | sdo: dev_t = 8:224
Sep 14 10:04:27 | sdo: size = 209715200
Sep 14 10:04:27 | sdo: subsystem = scsi
Sep 14 10:04:27 | sdo: vendor = 3PARdata
Sep 14 10:04:27 | sdo: product = VV
Sep 14 10:04:27 | sdo: rev = 0000
Sep 14 10:04:27 | sdo: h:b:t:l = 2:0:0:3
Sep 14 10:04:27 | sdo: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdo: serial = 00020246
Sep 14 10:04:27 | sdo: get_state
Sep 14 10:04:27 | sdo: path checker = directio (controller setting)
Sep 14 10:04:27 | sdo: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdo: state = 3
Sep 14 10:04:27 | sdo: prio = const (controller setting)
Sep 14 10:04:27 | sdo: const prio = 1
Sep 14 10:04:27 | sdo: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdo: uid = 350002ac000020246 (callout)
Sep 14 10:04:27 | sdq: not found in pathvec
Sep 14 10:04:27 | sdq: mask = 0x1f
Sep 14 10:04:27 | sdq: dev_t = 65:0
Sep 14 10:04:27 | sdq: size = 73400320
Sep 14 10:04:27 | sdq: subsystem = scsi
Sep 14 10:04:27 | sdq: vendor = 3PARdata
Sep 14 10:04:27 | sdq: product = VV
Sep 14 10:04:27 | sdq: rev = 0000
Sep 14 10:04:27 | sdq: h:b:t:l = 2:0:1:0
Sep 14 10:04:27 | sdq: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdq: serial = 00ED0246
Sep 14 10:04:27 | sdq: get_state
Sep 14 10:04:27 | sdq: path checker = directio (controller setting)
Sep 14 10:04:27 | sdq: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdq: state = 3
Sep 14 10:04:27 | sdq: prio = const (controller setting)
Sep 14 10:04:27 | sdq: const prio = 1
Sep 14 10:04:27 | sdq: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdq: uid = 350002ac000ed0246 (callout)
Sep 14 10:04:27 | sdp: not found in pathvec
Sep 14 10:04:27 | sdp: mask = 0x1f
Sep 14 10:04:27 | sdp: dev_t = 8:240
Sep 14 10:04:27 | sdp: size = 41943040
Sep 14 10:04:27 | sdp: subsystem = scsi
Sep 14 10:04:27 | sdp: vendor = 3PARdata
Sep 14 10:04:27 | sdp: product = VV
Sep 14 10:04:27 | sdp: rev = 0000
Sep 14 10:04:27 | sdp: h:b:t:l = 2:0:0:4
Sep 14 10:04:27 | sdp: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdp: serial = 01670246
Sep 14 10:04:27 | sdp: get_state
Sep 14 10:04:27 | sdp: path checker = directio (controller setting)
Sep 14 10:04:27 | sdp: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdp: state = 3
Sep 14 10:04:27 | sdp: prio = const (controller setting)
Sep 14 10:04:27 | sdp: const prio = 1
Sep 14 10:04:27 | sdp: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdp: uid = 350002ac001670246 (callout)
Sep 14 10:04:27 | sdr: not found in pathvec
Sep 14 10:04:27 | sdr: mask = 0x1f
Sep 14 10:04:27 | sdr: dev_t = 65:16
Sep 14 10:04:27 | sdr: size = 73400320
Sep 14 10:04:27 | sdr: subsystem = scsi
Sep 14 10:04:27 | sdr: vendor = 3PARdata
Sep 14 10:04:27 | sdr: product = VV
Sep 14 10:04:27 | sdr: rev = 0000
Sep 14 10:04:27 | sdr: h:b:t:l = 2:0:1:1
Sep 14 10:04:27 | sdr: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdr: serial = 00EE0246
Sep 14 10:04:27 | sdr: get_state
Sep 14 10:04:27 | sdr: path checker = directio (controller setting)
Sep 14 10:04:27 | sdr: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdr: state = 3
Sep 14 10:04:27 | sdr: prio = const (controller setting)
Sep 14 10:04:27 | sdr: const prio = 1
Sep 14 10:04:27 | sdr: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdr: uid = 350002ac000ee0246 (callout)
Sep 14 10:04:27 | sds: not found in pathvec
Sep 14 10:04:27 | sds: mask = 0x1f
Sep 14 10:04:27 | sds: dev_t = 65:32
Sep 14 10:04:27 | sds: size = 52428800
Sep 14 10:04:27 | sds: subsystem = scsi
Sep 14 10:04:27 | sds: vendor = 3PARdata
Sep 14 10:04:27 | sds: product = VV
Sep 14 10:04:27 | sds: rev = 0000
Sep 14 10:04:27 | sds: h:b:t:l = 2:0:1:2
Sep 14 10:04:27 | sds: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sds: serial = 01260246
Sep 14 10:04:27 | sds: get_state
Sep 14 10:04:27 | sds: path checker = directio (controller setting)
Sep 14 10:04:27 | sds: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sds: state = 3
Sep 14 10:04:27 | sds: prio = const (controller setting)
Sep 14 10:04:27 | sds: const prio = 1
Sep 14 10:04:27 | sds: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sds: uid = 350002ac001260246 (callout)
Sep 14 10:04:27 | sdt: not found in pathvec
Sep 14 10:04:27 | sdt: mask = 0x1f
Sep 14 10:04:27 | sdt: dev_t = 65:48
Sep 14 10:04:27 | sdt: size = 209715200
Sep 14 10:04:27 | sdt: subsystem = scsi
Sep 14 10:04:27 | sdt: vendor = 3PARdata
Sep 14 10:04:27 | sdt: product = VV
Sep 14 10:04:27 | sdt: rev = 0000
Sep 14 10:04:27 | sdt: h:b:t:l = 2:0:1:3
Sep 14 10:04:27 | sdt: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdt: serial = 00020246
Sep 14 10:04:27 | sdt: get_state
Sep 14 10:04:27 | sdt: path checker = directio (controller setting)
Sep 14 10:04:27 | sdt: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdt: state = 3
Sep 14 10:04:27 | sdt: prio = const (controller setting)
Sep 14 10:04:27 | sdt: const prio = 1
Sep 14 10:04:27 | sdt: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdt: uid = 350002ac000020246 (callout)
Sep 14 10:04:27 | sdu: not found in pathvec
Sep 14 10:04:27 | sdu: mask = 0x1f
Sep 14 10:04:27 | sdu: dev_t = 65:64
Sep 14 10:04:27 | sdu: size = 41943040
Sep 14 10:04:27 | sdu: subsystem = scsi
Sep 14 10:04:27 | sdu: vendor = 3PARdata
Sep 14 10:04:27 | sdu: product = VV
Sep 14 10:04:27 | sdu: rev = 0000
Sep 14 10:04:27 | sdu: h:b:t:l = 2:0:1:4
Sep 14 10:04:27 | sdu: tgt_node_name = 0x2ff70002ac00024
Sep 14 10:04:27 | sdu: serial = 01670246
Sep 14 10:04:27 | sdu: get_state
Sep 14 10:04:27 | sdu: path checker = directio (controller setting)
Sep 14 10:04:27 | sdu: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdu: state = 3
Sep 14 10:04:27 | sdu: prio = const (controller setting)
Sep 14 10:04:27 | sdu: const prio = 1
Sep 14 10:04:27 | sdu: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 14 10:04:27 | sdu: uid = 350002ac001670246 (callout)
Sep 14 10:04:27 | dm-5: device node name blacklisted
Sep 14 10:04:27 | dm-6: device node name blacklisted
===== paths list =====
uuid                              hcil    dev dev_t pri dm_st chk_st vend/prod
36001e4f02053fe000f72e29478df3495 0:2:0:0 sda 8:0   1   undef ready  DELL,PERC
350002ac000ed0246                 1:0:0:0 sdb 8:16  1   undef ready  3PARdata,
350002ac000ee0246                 1:0:0:1 sdc 8:32  1   undef ready  3PARdata,
350002ac001260246                 1:0:0:2 sdd 8:48  1   undef ready  3PARdata,
350002ac000020246                 1:0:0:3 sde 8:64  1   undef ready  3PARdata,
350002ac001670246                 1:0:0:4 sdf 8:80  1   undef ready  3PARdata,
350002ac000ed0246                 1:0:1:0 sdg 8:96  1   undef ready  3PARdata,
350002ac000ee0246                 1:0:1:1 sdh 8:112 1   undef ready  3PARdata,
350002ac001260246                 1:0:1:2 sdi 8:128 1   undef ready  3PARdata,
350002ac000020246                 1:0:1:3 sdj 8:144 1   undef ready  3PARdata,
350002ac001670246                 1:0:1:4 sdk 8:160 1   undef ready  3PARdata,
350002ac000ed0246                 2:0:0:0 sdl 8:176 1   undef ready  3PARdata,
350002ac000ee0246                 2:0:0:1 sdm 8:192 1   undef ready  3PARdata,
350002ac001260246                 2:0:0:2 sdn 8:208 1   undef ready  3PARdata,
350002ac000020246                 2:0:0:3 sdo 8:224 1   undef ready  3PARdata,
350002ac000ed0246                 2:0:1:0 sdq 65:0  1   undef ready  3PARdata,
350002ac001670246                 2:0:0:4 sdp 8:240 1   undef ready  3PARdata,
350002ac000ee0246                 2:0:1:1 sdr 65:16 1   undef ready  3PARdata,
350002ac001260246                 2:0:1:2 sds 65:32 1   undef ready  3PARdata,
350002ac000020246                 2:0:1:3 sdt 65:48 1   undef ready  3PARdata,
350002ac001670246                 2:0:1:4 sdu 65:64 1   undef ready  3PARdata,
Sep 14 10:04:27 | params = 0 0 1 1 round-robin 0 4 1 8:240 1 8:80 1 8:160 1 65:64 1 
Sep 14 10:04:27 | status = 2 0 0 0 1 1 A 0 4 0 8:240 A 0 8:80 A 0 8:160 A 0 65:64 A 0 
Sep 14 10:04:27 | params = 0 0 1 1 round-robin 0 4 1 8:208 1 8:48 1 8:128 1 65:32 1 
Sep 14 10:04:27 | status = 2 0 0 0 1 1 A 0 4 0 8:208 A 0 8:48 A 0 8:128 A 0 65:32 A 0 
Sep 14 10:04:27 | params = 0 0 1 1 round-robin 0 4 1 8:192 1 8:32 1 8:112 1 65:16 1 
Sep 14 10:04:27 | status = 2 0 0 0 1 1 A 0 4 0 8:192 A 0 8:32 A 0 8:112 A 0 65:16 A 0 
Sep 14 10:04:27 | params = 0 0 1 1 round-robin 0 4 1 8:176 1 8:16 1 8:96 1 65:0 1 
Sep 14 10:04:27 | status = 2 0 0 0 1 1 A 0 4 0 8:176 A 0 8:16 A 0 8:96 A 0 65:0 A 0 
Sep 14 10:04:27 | sda: ownership set to 36001e4f02053fe000f72e29478df3495
Sep 14 10:04:27 | sda: not found in pathvec
Sep 14 10:04:27 | sda: mask = 0xc
Sep 14 10:04:27 | sda: get_state
Sep 14 10:04:27 | sda: state = running
Sep 14 10:04:27 | sda: state = 3
Sep 14 10:04:27 | sda: const prio = 1
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: pgfailover = -1 (internal default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: pgpolicy = multibus (config file default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: selector = round-robin 0 (internal default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: features = 0 (internal default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: hwhandler = 0 (internal default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: rr_weight = 1 (internal default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: minio = 8 (config file default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: no_path_retry = NONE (internal default)
Sep 14 10:04:27 | pg_timeout = NONE (internal default)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: set ACT_CREATE (map does not exist)
Sep 14 10:04:27 | 36001e4f02053fe000f72e29478df3495: domap (0) failure for create/reload map
Sep 14 10:04:27 | sde: ownership set to u02
Sep 14 10:04:27 | sde: not found in pathvec
Sep 14 10:04:27 | sde: mask = 0xc
Sep 14 10:04:27 | sde: get_state
Sep 14 10:04:27 | sde: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sde: state = 3
Sep 14 10:04:27 | sde: const prio = 1
Sep 14 10:04:27 | sdj: ownership set to u02
Sep 14 10:04:27 | sdj: not found in pathvec
Sep 14 10:04:27 | sdj: mask = 0xc
Sep 14 10:04:27 | sdj: get_state
Sep 14 10:04:27 | sdj: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdj: state = 3
Sep 14 10:04:27 | sdj: const prio = 1
Sep 14 10:04:27 | sdo: ownership set to u02
Sep 14 10:04:27 | sdo: not found in pathvec
Sep 14 10:04:27 | sdo: mask = 0xc
Sep 14 10:04:27 | sdo: get_state
Sep 14 10:04:27 | sdo: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdo: state = 3
Sep 14 10:04:27 | sdo: const prio = 1
Sep 14 10:04:27 | sdt: ownership set to u02
Sep 14 10:04:27 | sdt: not found in pathvec
Sep 14 10:04:27 | sdt: mask = 0xc
Sep 14 10:04:27 | sdt: get_state
Sep 14 10:04:27 | sdt: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdt: state = 3
Sep 14 10:04:27 | sdt: const prio = 1
Sep 14 10:04:27 | u02: pgfailover = -1 (internal default)
Sep 14 10:04:27 | u02: pgpolicy = multibus (LUN setting)
Sep 14 10:04:27 | u02: selector = queue-length (LUN setting)
Sep 14 10:04:27 | u02: features = 0 (controller setting)
Sep 14 10:04:27 | u02: hwhandler = 0 (controller setting)
Sep 14 10:04:27 | u02: rr_weight = 1 (controller setting)
Sep 14 10:04:27 | u02: minio = 8 (LUN setting)
Sep 14 10:04:27 | u02: no_path_retry = NONE (internal default)
Sep 14 10:04:27 | pg_timeout = NONE (internal default)
Sep 14 10:04:27 | u02: set ACT_CREATE (map does not exist)
Sep 14 10:04:27 | u02: map already present
Sep 14 10:04:27 | u02: domap (0) failure for create/reload map
Sep 14 10:04:27 | sde: ownership set to u02
Sep 14 10:04:27 | sde: not found in pathvec
Sep 14 10:04:27 | sde: mask = 0xc
Sep 14 10:04:27 | sde: get_state
Sep 14 10:04:27 | sde: path checker = directio (controller setting)
Sep 14 10:04:27 | sde: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sde: state = 3
Sep 14 10:04:27 | sde: prio = const (controller setting)
Sep 14 10:04:27 | sde: const prio = 1
Sep 14 10:04:27 | sdj: ownership set to u02
Sep 14 10:04:27 | sdj: not found in pathvec
Sep 14 10:04:27 | sdj: mask = 0xc
Sep 14 10:04:27 | sdj: get_state
Sep 14 10:04:27 | sdj: path checker = directio (controller setting)
Sep 14 10:04:27 | sdj: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdj: state = 3
Sep 14 10:04:27 | sdj: prio = const (controller setting)
Sep 14 10:04:27 | sdj: const prio = 1
Sep 14 10:04:27 | sdo: ownership set to u02
Sep 14 10:04:27 | sdo: not found in pathvec
Sep 14 10:04:27 | sdo: mask = 0xc
Sep 14 10:04:27 | sdo: get_state
Sep 14 10:04:27 | sdo: path checker = directio (controller setting)
Sep 14 10:04:27 | sdo: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdo: state = 3
Sep 14 10:04:27 | sdo: prio = const (controller setting)
Sep 14 10:04:27 | sdo: const prio = 1
Sep 14 10:04:27 | sdt: ownership set to u02
Sep 14 10:04:27 | sdt: not found in pathvec
Sep 14 10:04:27 | sdt: mask = 0xc
Sep 14 10:04:27 | sdt: get_state
Sep 14 10:04:27 | sdt: path checker = directio (controller setting)
Sep 14 10:04:27 | sdt: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdt: state = 3
Sep 14 10:04:27 | sdt: prio = const (controller setting)
Sep 14 10:04:27 | sdt: const prio = 1
Sep 14 10:04:27 | u02: pgfailover = -1 (internal default)
Sep 14 10:04:27 | u02: pgpolicy = multibus (LUN setting)
Sep 14 10:04:27 | u02: selector = queue-length (LUN setting)
Sep 14 10:04:27 | u02: features = 0 (controller setting)
Sep 14 10:04:27 | u02: hwhandler = 0 (controller setting)
Sep 14 10:04:27 | u02: rr_weight = 1 (controller setting)
Sep 14 10:04:27 | u02: minio = 8 (LUN setting)
Sep 14 10:04:27 | u02: no_path_retry = NONE (internal default)
Sep 14 10:04:27 | pg_timeout = NONE (internal default)
Sep 14 10:04:27 | u02: set ACT_CREATE (map does not exist)
Sep 14 10:04:27 | u02: map already present
Sep 14 10:04:27 | u02: domap (0) failure for create/reload map
Sep 14 10:04:27 | sde: ownership set to u02
Sep 14 10:04:27 | sde: not found in pathvec
Sep 14 10:04:27 | sde: mask = 0xc
Sep 14 10:04:27 | sde: get_state
Sep 14 10:04:27 | sde: path checker = directio (controller setting)
Sep 14 10:04:27 | sde: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sde: state = 3
Sep 14 10:04:27 | sde: prio = const (controller setting)
Sep 14 10:04:27 | sde: const prio = 1
Sep 14 10:04:27 | sdj: ownership set to u02
Sep 14 10:04:27 | sdj: not found in pathvec
Sep 14 10:04:27 | sdj: mask = 0xc
Sep 14 10:04:27 | sdj: get_state
Sep 14 10:04:27 | sdj: path checker = directio (controller setting)
Sep 14 10:04:27 | sdj: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdj: state = 3
Sep 14 10:04:27 | sdj: prio = const (controller setting)
Sep 14 10:04:27 | sdj: const prio = 1
Sep 14 10:04:27 | sdo: ownership set to u02
Sep 14 10:04:27 | sdo: not found in pathvec
Sep 14 10:04:27 | sdo: mask = 0xc
Sep 14 10:04:27 | sdo: get_state
Sep 14 10:04:27 | sdo: path checker = directio (controller setting)
Sep 14 10:04:27 | sdo: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdo: state = 3
Sep 14 10:04:27 | sdo: prio = const (controller setting)
Sep 14 10:04:27 | sdo: const prio = 1
Sep 14 10:04:27 | sdt: ownership set to u02
Sep 14 10:04:27 | sdt: not found in pathvec
Sep 14 10:04:27 | sdt: mask = 0xc
Sep 14 10:04:27 | sdt: get_state
Sep 14 10:04:27 | sdt: path checker = directio (controller setting)
Sep 14 10:04:27 | sdt: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdt: state = 3
Sep 14 10:04:27 | sdt: prio = const (controller setting)
Sep 14 10:04:27 | sdt: const prio = 1
Sep 14 10:04:27 | u02: pgfailover = -1 (internal default)
Sep 14 10:04:27 | u02: pgpolicy = multibus (LUN setting)
Sep 14 10:04:27 | u02: selector = queue-length (LUN setting)
Sep 14 10:04:27 | u02: features = 0 (controller setting)
Sep 14 10:04:27 | u02: hwhandler = 0 (controller setting)
Sep 14 10:04:27 | u02: rr_weight = 1 (controller setting)
Sep 14 10:04:27 | u02: minio = 8 (LUN setting)
Sep 14 10:04:27 | u02: no_path_retry = NONE (internal default)
Sep 14 10:04:27 | pg_timeout = NONE (internal default)
Sep 14 10:04:27 | u02: set ACT_CREATE (map does not exist)
Sep 14 10:04:27 | u02: map already present
Sep 14 10:04:27 | u02: domap (0) failure for create/reload map
Sep 14 10:04:27 | sde: ownership set to u02
Sep 14 10:04:27 | sde: not found in pathvec
Sep 14 10:04:27 | sde: mask = 0xc
Sep 14 10:04:27 | sde: get_state
Sep 14 10:04:27 | sde: path checker = directio (controller setting)
Sep 14 10:04:27 | sde: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sde: state = 3
Sep 14 10:04:27 | sde: prio = const (controller setting)
Sep 14 10:04:27 | sde: const prio = 1
Sep 14 10:04:27 | sdj: ownership set to u02
Sep 14 10:04:27 | sdj: not found in pathvec
Sep 14 10:04:27 | sdj: mask = 0xc
Sep 14 10:04:27 | sdj: get_state
Sep 14 10:04:27 | sdj: path checker = directio (controller setting)
Sep 14 10:04:27 | sdj: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdj: state = 3
Sep 14 10:04:27 | sdj: prio = const (controller setting)
Sep 14 10:04:27 | sdj: const prio = 1
Sep 14 10:04:27 | sdo: ownership set to u02
Sep 14 10:04:27 | sdo: not found in pathvec
Sep 14 10:04:27 | sdo: mask = 0xc
Sep 14 10:04:27 | sdo: get_state
Sep 14 10:04:27 | sdo: path checker = directio (controller setting)
Sep 14 10:04:27 | sdo: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdo: state = 3
Sep 14 10:04:27 | sdo: prio = const (controller setting)
Sep 14 10:04:27 | sdo: const prio = 1
Sep 14 10:04:27 | sdt: ownership set to u02
Sep 14 10:04:27 | sdt: not found in pathvec
Sep 14 10:04:27 | sdt: mask = 0xc
Sep 14 10:04:27 | sdt: get_state
Sep 14 10:04:27 | sdt: path checker = directio (controller setting)
Sep 14 10:04:27 | sdt: state = running
Sep 14 10:04:27 | directio: starting new request
Sep 14 10:04:27 | directio: io finished 4096/0
Sep 14 10:04:27 | sdt: state = 3
Sep 14 10:04:27 | sdt: prio = const (controller setting)
Sep 14 10:04:27 | sdt: const prio = 1
Sep 14 10:04:27 | u02: pgfailover = -1 (internal default)
Sep 14 10:04:27 | u02: pgpolicy = multibus (LUN setting)
Sep 14 10:04:27 | u02: selector = queue-length (LUN setting)
Sep 14 10:04:27 | u02: features = 0 (controller setting)
Sep 14 10:04:27 | u02: hwhandler = 0 (controller setting)
Sep 14 10:04:27 | u02: rr_weight = 1 (controller setting)
Sep 14 10:04:27 | u02: minio = 8 (LUN setting)
Sep 14 10:04:27 | u02: no_path_retry = NONE (internal default)
Sep 14 10:04:27 | pg_timeout = NONE (internal default)
Sep 14 10:04:27 | u02: set ACT_CREATE (map does not exist)
Sep 14 10:04:27 | u02: map already present
Sep 14 10:04:27 | u02: domap (0) failure for create/reload map

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: multipath-tools and queue-length/service-time path selectors oops
  2009-09-14 15:12   ` Andy
@ 2009-09-15  2:10     ` Kiyoshi Ueda
  2009-09-15 14:35       ` Andy
  0 siblings, 1 reply; 7+ messages in thread
From: Kiyoshi Ueda @ 2009-09-15  2:10 UTC (permalink / raw)
  To: device-mapper development

Hi Andy,

On 09/15/2009 12:12 AM +0900, Andy wrote:
> On Mon, Sep 14, 2009 at 11:15:47AM +0900, Kiyoshi Ueda wrote:
>> Hi Andy,
>>
>> Thank you for reporting this.
>>
>> On 2009/09/12 6:34 +0900, Andy wrote:
>>> When I try to change the path selector in multipath.conf to queue-length or
>>> service-time I get a kernel oops.
>> I'd like to see the information of your environment, so could you
>> give me the followings?
> 
> This is a test system, so there is no problem try things out on it.
> 
> version information:
> 
> Distribution : Debian squeeze/sid
> kernel: 2.6.31
> 
> multipath-tools v0.4.9 (04/04, 2009)
> 
> dmsetup --version
> Library version:   1.02.36 (2009-08-06)
> Driver version:    4.15.0
> 
> 
> multipath.conf part:
> 
> multipath {
> 	wwid 			350002ac000020246
> 	path_grouping_policy	multibus
> 	# path_selector		"round-robin 0"
> 	path_selector		"queue-length"
> 	rr_min_io		8	# u02 io count
> 	alias 			u02 
> }

OK, thanks.
Please specify the path_selector part in the same way as
round-robin like below:

	path_selector	"queue-length 0"

Note that '0' is the required argument which specifies the number
of path_selector parameters.

I think this is a bug in the parameter parsing of multipath target
driver, not queue-length/service-time specific.

Thanks,
Kiyoshi Ueda

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: multipath-tools and queue-length/service-time path selectors oops
  2009-09-15  2:10     ` Kiyoshi Ueda
@ 2009-09-15 14:35       ` Andy
  2009-09-18  1:37         ` Kiyoshi Ueda
  0 siblings, 1 reply; 7+ messages in thread
From: Andy @ 2009-09-15 14:35 UTC (permalink / raw)
  To: device-mapper development

On Tue, Sep 15, 2009 at 11:10:29AM +0900, Kiyoshi Ueda wrote:
> Hi Andy,
> 
> On 09/15/2009 12:12 AM +0900, Andy wrote:
> 
> OK, thanks.
> Please specify the path_selector part in the same way as
> round-robin like below:
> 
> 	path_selector	"queue-length 0"
> 
> Note that '0' is the required argument which specifies the number
> of path_selector parameters.
> 
> I think this is a bug in the parameter parsing of multipath target
> driver, not queue-length/service-time specific.
> 
I thought I had tried that. But, an informative error message would be nice. 
Now, I have another question. Why does the queue-length selector not use all
my paths?

Sep 15 09:25:44 | loop0: device node name blacklisted
Sep 15 09:25:44 | loop1: device node name blacklisted
Sep 15 09:25:44 | loop2: device node name blacklisted
Sep 15 09:25:44 | loop3: device node name blacklisted
Sep 15 09:25:44 | loop4: device node name blacklisted
Sep 15 09:25:44 | loop5: device node name blacklisted
Sep 15 09:25:44 | loop6: device node name blacklisted
Sep 15 09:25:44 | loop7: device node name blacklisted
Sep 15 09:25:44 | hda: device node name blacklisted
Sep 15 09:25:44 | sda: not found in pathvec
Sep 15 09:25:44 | sda: mask = 0x1f
Sep 15 09:25:44 | sda: dev_t = 8:0
Sep 15 09:25:44 | sda: size = 142082048
Sep 15 09:25:44 | sda: subsystem = scsi
Sep 15 09:25:44 | sda: vendor = DELL
Sep 15 09:25:44 | sda: product = PERC 5/i
Sep 15 09:25:44 | sda: rev = 1.03
Sep 15 09:25:44 | sda: h:b:t:l = 0:2:0:0
Sep 15 09:25:44 | sda: serial = 009534df7894e2720f00fe5320f0e401
Sep 15 09:25:44 | sda: get_state
Sep 15 09:25:44 | loading /lib64/multipath/libcheckreadsector0.so checker
Sep 15 09:25:44 | sda: path checker = readsector0 (config file default)
Sep 15 09:25:44 | sda: state = running
Sep 15 09:25:44 | sda: state = 3
Sep 15 09:25:44 | sda: prio = const (config file default)
Sep 15 09:25:44 | sda: const prio = 1
Sep 15 09:25:44 | sda: getuid = /sbin/scsi_id -g -u -s /block/%n (config file default)
Sep 15 09:25:44 | sda: uid = 36001e4f02053fe000f72e29478df3495 (callout)
Sep 15 09:25:44 | sdb: not found in pathvec
Sep 15 09:25:44 | sdb: mask = 0x1f
Sep 15 09:25:44 | sdb: dev_t = 8:16
Sep 15 09:25:44 | sdb: size = 73400320
Sep 15 09:25:44 | sdb: subsystem = scsi
Sep 15 09:25:44 | sdb: vendor = 3PARdata
Sep 15 09:25:44 | sdb: product = VV
Sep 15 09:25:44 | sdb: rev = 0000
Sep 15 09:25:44 | sdb: h:b:t:l = 1:0:0:0
Sep 15 09:25:44 | sdb: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdb: serial = 00ED0246
Sep 15 09:25:44 | sdb: get_state
Sep 15 09:25:44 | sdb: path checker = directio (controller setting)
Sep 15 09:25:44 | sdb: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdb: state = 3
Sep 15 09:25:44 | sdb: prio = const (controller setting)
Sep 15 09:25:44 | sdb: const prio = 1
Sep 15 09:25:44 | sdb: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdb: uid = 350002ac000ed0246 (callout)
Sep 15 09:25:44 | sdc: not found in pathvec
Sep 15 09:25:44 | sdc: mask = 0x1f
Sep 15 09:25:44 | sdc: dev_t = 8:32
Sep 15 09:25:44 | sdc: size = 73400320
Sep 15 09:25:44 | sdc: subsystem = scsi
Sep 15 09:25:44 | sdc: vendor = 3PARdata
Sep 15 09:25:44 | sdc: product = VV
Sep 15 09:25:44 | sdc: rev = 0000
Sep 15 09:25:44 | sdc: h:b:t:l = 1:0:0:1
Sep 15 09:25:44 | sdc: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdc: serial = 00EE0246
Sep 15 09:25:44 | sdc: get_state
Sep 15 09:25:44 | sdc: path checker = directio (controller setting)
Sep 15 09:25:44 | sdc: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdc: state = 3
Sep 15 09:25:44 | sdc: prio = const (controller setting)
Sep 15 09:25:44 | sdc: const prio = 1
Sep 15 09:25:44 | sdc: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdc: uid = 350002ac000ee0246 (callout)
Sep 15 09:25:44 | sdd: not found in pathvec
Sep 15 09:25:44 | sdd: mask = 0x1f
Sep 15 09:25:44 | sdd: dev_t = 8:48
Sep 15 09:25:44 | sdd: size = 52428800
Sep 15 09:25:44 | sdd: subsystem = scsi
Sep 15 09:25:44 | sdd: vendor = 3PARdata
Sep 15 09:25:44 | sdd: product = VV
Sep 15 09:25:44 | sdd: rev = 0000
Sep 15 09:25:44 | sdd: h:b:t:l = 1:0:0:2
Sep 15 09:25:44 | sdd: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdd: serial = 01260246
Sep 15 09:25:44 | sdd: get_state
Sep 15 09:25:44 | sdd: path checker = directio (controller setting)
Sep 15 09:25:44 | sdd: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdd: state = 3
Sep 15 09:25:44 | sdd: prio = const (controller setting)
Sep 15 09:25:44 | sdd: const prio = 1
Sep 15 09:25:44 | sdd: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdd: uid = 350002ac001260246 (callout)
Sep 15 09:25:44 | sde: not found in pathvec
Sep 15 09:25:44 | sde: mask = 0x1f
Sep 15 09:25:44 | sde: dev_t = 8:64
Sep 15 09:25:44 | sde: size = 209715200
Sep 15 09:25:44 | sde: subsystem = scsi
Sep 15 09:25:44 | sde: vendor = 3PARdata
Sep 15 09:25:44 | sde: product = VV
Sep 15 09:25:44 | sde: rev = 0000
Sep 15 09:25:44 | sde: h:b:t:l = 1:0:0:3
Sep 15 09:25:44 | sde: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sde: serial = 00020246
Sep 15 09:25:44 | sde: get_state
Sep 15 09:25:44 | sde: path checker = directio (controller setting)
Sep 15 09:25:44 | sde: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sde: state = 3
Sep 15 09:25:44 | sde: prio = const (controller setting)
Sep 15 09:25:44 | sde: const prio = 1
Sep 15 09:25:44 | sde: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sde: uid = 350002ac000020246 (callout)
Sep 15 09:25:44 | sdg: not found in pathvec
Sep 15 09:25:44 | sdg: mask = 0x1f
Sep 15 09:25:44 | sdg: dev_t = 8:96
Sep 15 09:25:44 | sdg: size = 73400320
Sep 15 09:25:44 | sdg: subsystem = scsi
Sep 15 09:25:44 | sdg: vendor = 3PARdata
Sep 15 09:25:44 | sdg: product = VV
Sep 15 09:25:44 | sdg: rev = 0000
Sep 15 09:25:44 | sdg: h:b:t:l = 1:0:1:0
Sep 15 09:25:44 | sdg: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdg: serial = 00ED0246
Sep 15 09:25:44 | sdg: get_state
Sep 15 09:25:44 | sdg: path checker = directio (controller setting)
Sep 15 09:25:44 | sdg: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdg: state = 3
Sep 15 09:25:44 | sdg: prio = const (controller setting)
Sep 15 09:25:44 | sdg: const prio = 1
Sep 15 09:25:44 | sdg: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdg: uid = 350002ac000ed0246 (callout)
Sep 15 09:25:44 | sdf: not found in pathvec
Sep 15 09:25:44 | sdf: mask = 0x1f
Sep 15 09:25:44 | sdf: dev_t = 8:80
Sep 15 09:25:44 | sdf: size = 41943040
Sep 15 09:25:44 | sdf: subsystem = scsi
Sep 15 09:25:44 | sdf: vendor = 3PARdata
Sep 15 09:25:44 | sdf: product = VV
Sep 15 09:25:44 | sdf: rev = 0000
Sep 15 09:25:44 | sdf: h:b:t:l = 1:0:0:4
Sep 15 09:25:44 | sdf: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdf: serial = 01670246
Sep 15 09:25:44 | sdf: get_state
Sep 15 09:25:44 | sdf: path checker = directio (controller setting)
Sep 15 09:25:44 | sdf: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdf: state = 3
Sep 15 09:25:44 | sdf: prio = const (controller setting)
Sep 15 09:25:44 | sdf: const prio = 1
Sep 15 09:25:44 | sdf: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdf: uid = 350002ac001670246 (callout)
Sep 15 09:25:44 | sdh: not found in pathvec
Sep 15 09:25:44 | sdh: mask = 0x1f
Sep 15 09:25:44 | sdh: dev_t = 8:112
Sep 15 09:25:44 | sdh: size = 73400320
Sep 15 09:25:44 | sdh: subsystem = scsi
Sep 15 09:25:44 | sdh: vendor = 3PARdata
Sep 15 09:25:44 | sdh: product = VV
Sep 15 09:25:44 | sdh: rev = 0000
Sep 15 09:25:44 | sdh: h:b:t:l = 1:0:1:1
Sep 15 09:25:44 | sdh: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdh: serial = 00EE0246
Sep 15 09:25:44 | sdh: get_state
Sep 15 09:25:44 | sdh: path checker = directio (controller setting)
Sep 15 09:25:44 | sdh: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdh: state = 3
Sep 15 09:25:44 | sdh: prio = const (controller setting)
Sep 15 09:25:44 | sdh: const prio = 1
Sep 15 09:25:44 | sdh: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdh: uid = 350002ac000ee0246 (callout)
Sep 15 09:25:44 | sdi: not found in pathvec
Sep 15 09:25:44 | sdi: mask = 0x1f
Sep 15 09:25:44 | sdi: dev_t = 8:128
Sep 15 09:25:44 | sdi: size = 52428800
Sep 15 09:25:44 | sdi: subsystem = scsi
Sep 15 09:25:44 | sdi: vendor = 3PARdata
Sep 15 09:25:44 | sdi: product = VV
Sep 15 09:25:44 | sdi: rev = 0000
Sep 15 09:25:44 | sdi: h:b:t:l = 1:0:1:2
Sep 15 09:25:44 | sdi: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdi: serial = 01260246
Sep 15 09:25:44 | sdi: get_state
Sep 15 09:25:44 | sdi: path checker = directio (controller setting)
Sep 15 09:25:44 | sdi: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdi: state = 3
Sep 15 09:25:44 | sdi: prio = const (controller setting)
Sep 15 09:25:44 | sdi: const prio = 1
Sep 15 09:25:44 | sdi: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdi: uid = 350002ac001260246 (callout)
Sep 15 09:25:44 | sdj: not found in pathvec
Sep 15 09:25:44 | sdj: mask = 0x1f
Sep 15 09:25:44 | sdj: dev_t = 8:144
Sep 15 09:25:44 | sdj: size = 209715200
Sep 15 09:25:44 | sdj: subsystem = scsi
Sep 15 09:25:44 | sdj: vendor = 3PARdata
Sep 15 09:25:44 | sdj: product = VV
Sep 15 09:25:44 | sdj: rev = 0000
Sep 15 09:25:44 | sdj: h:b:t:l = 1:0:1:3
Sep 15 09:25:44 | sdj: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdj: serial = 00020246
Sep 15 09:25:44 | sdj: get_state
Sep 15 09:25:44 | sdj: path checker = directio (controller setting)
Sep 15 09:25:44 | sdj: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdj: state = 3
Sep 15 09:25:44 | sdj: prio = const (controller setting)
Sep 15 09:25:44 | sdj: const prio = 1
Sep 15 09:25:44 | sdj: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdj: uid = 350002ac000020246 (callout)
Sep 15 09:25:44 | sdk: not found in pathvec
Sep 15 09:25:44 | sdk: mask = 0x1f
Sep 15 09:25:44 | sdk: dev_t = 8:160
Sep 15 09:25:44 | sdk: size = 41943040
Sep 15 09:25:44 | sdk: subsystem = scsi
Sep 15 09:25:44 | sdk: vendor = 3PARdata
Sep 15 09:25:44 | sdk: product = VV
Sep 15 09:25:44 | sdk: rev = 0000
Sep 15 09:25:44 | sdk: h:b:t:l = 1:0:1:4
Sep 15 09:25:44 | sdk: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdk: serial = 01670246
Sep 15 09:25:44 | sdk: get_state
Sep 15 09:25:44 | sdk: path checker = directio (controller setting)
Sep 15 09:25:44 | sdk: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdk: state = 3
Sep 15 09:25:44 | sdk: prio = const (controller setting)
Sep 15 09:25:44 | sdk: const prio = 1
Sep 15 09:25:44 | sdk: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdk: uid = 350002ac001670246 (callout)
Sep 15 09:25:44 | dm-0: device node name blacklisted
Sep 15 09:25:44 | dm-1: device node name blacklisted
Sep 15 09:25:44 | dm-2: device node name blacklisted
Sep 15 09:25:44 | dm-3: device node name blacklisted
Sep 15 09:25:44 | dm-4: device node name blacklisted
Sep 15 09:25:44 | sdl: not found in pathvec
Sep 15 09:25:44 | sdl: mask = 0x1f
Sep 15 09:25:44 | sdl: dev_t = 8:176
Sep 15 09:25:44 | sdl: size = 73400320
Sep 15 09:25:44 | sdl: subsystem = scsi
Sep 15 09:25:44 | sdl: vendor = 3PARdata
Sep 15 09:25:44 | sdl: product = VV
Sep 15 09:25:44 | sdl: rev = 0000
Sep 15 09:25:44 | sdl: h:b:t:l = 2:0:0:0
Sep 15 09:25:44 | sdl: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdl: serial = 00ED0246
Sep 15 09:25:44 | sdl: get_state
Sep 15 09:25:44 | sdl: path checker = directio (controller setting)
Sep 15 09:25:44 | sdl: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdl: state = 3
Sep 15 09:25:44 | sdl: prio = const (controller setting)
Sep 15 09:25:44 | sdl: const prio = 1
Sep 15 09:25:44 | sdl: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdl: uid = 350002ac000ed0246 (callout)
Sep 15 09:25:44 | sdm: not found in pathvec
Sep 15 09:25:44 | sdm: mask = 0x1f
Sep 15 09:25:44 | sdm: dev_t = 8:192
Sep 15 09:25:44 | sdm: size = 73400320
Sep 15 09:25:44 | sdm: subsystem = scsi
Sep 15 09:25:44 | sdm: vendor = 3PARdata
Sep 15 09:25:44 | sdm: product = VV
Sep 15 09:25:44 | sdm: rev = 0000
Sep 15 09:25:44 | sdm: h:b:t:l = 2:0:0:1
Sep 15 09:25:44 | sdm: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdm: serial = 00EE0246
Sep 15 09:25:44 | sdm: get_state
Sep 15 09:25:44 | sdm: path checker = directio (controller setting)
Sep 15 09:25:44 | sdm: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdm: state = 3
Sep 15 09:25:44 | sdm: prio = const (controller setting)
Sep 15 09:25:44 | sdm: const prio = 1
Sep 15 09:25:44 | sdm: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdm: uid = 350002ac000ee0246 (callout)
Sep 15 09:25:44 | sdn: not found in pathvec
Sep 15 09:25:44 | sdn: mask = 0x1f
Sep 15 09:25:44 | sdn: dev_t = 8:208
Sep 15 09:25:44 | sdn: size = 52428800
Sep 15 09:25:44 | sdn: subsystem = scsi
Sep 15 09:25:44 | sdn: vendor = 3PARdata
Sep 15 09:25:44 | sdn: product = VV
Sep 15 09:25:44 | sdn: rev = 0000
Sep 15 09:25:44 | sdn: h:b:t:l = 2:0:0:2
Sep 15 09:25:44 | sdn: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdn: serial = 01260246
Sep 15 09:25:44 | sdn: get_state
Sep 15 09:25:44 | sdn: path checker = directio (controller setting)
Sep 15 09:25:44 | sdn: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdn: state = 3
Sep 15 09:25:44 | sdn: prio = const (controller setting)
Sep 15 09:25:44 | sdn: const prio = 1
Sep 15 09:25:44 | sdn: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdn: uid = 350002ac001260246 (callout)
Sep 15 09:25:44 | sdq: not found in pathvec
Sep 15 09:25:44 | sdq: mask = 0x1f
Sep 15 09:25:44 | sdq: dev_t = 65:0
Sep 15 09:25:44 | sdq: size = 73400320
Sep 15 09:25:44 | sdq: subsystem = scsi
Sep 15 09:25:44 | sdq: vendor = 3PARdata
Sep 15 09:25:44 | sdq: product = VV
Sep 15 09:25:44 | sdq: rev = 0000
Sep 15 09:25:44 | sdq: h:b:t:l = 2:0:1:0
Sep 15 09:25:44 | sdq: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdq: serial = 00ED0246
Sep 15 09:25:44 | sdq: get_state
Sep 15 09:25:44 | sdq: path checker = directio (controller setting)
Sep 15 09:25:44 | sdq: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdq: state = 3
Sep 15 09:25:44 | sdq: prio = const (controller setting)
Sep 15 09:25:44 | sdq: const prio = 1
Sep 15 09:25:44 | sdq: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdq: uid = 350002ac000ed0246 (callout)
Sep 15 09:25:44 | sdp: not found in pathvec
Sep 15 09:25:44 | sdp: mask = 0x1f
Sep 15 09:25:44 | sdp: dev_t = 8:240
Sep 15 09:25:44 | sdp: size = 41943040
Sep 15 09:25:44 | sdp: subsystem = scsi
Sep 15 09:25:44 | sdp: vendor = 3PARdata
Sep 15 09:25:44 | sdp: product = VV
Sep 15 09:25:44 | sdp: rev = 0000
Sep 15 09:25:44 | sdp: h:b:t:l = 2:0:0:4
Sep 15 09:25:44 | sdp: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdp: serial = 01670246
Sep 15 09:25:44 | sdp: get_state
Sep 15 09:25:44 | sdp: path checker = directio (controller setting)
Sep 15 09:25:44 | sdp: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdp: state = 3
Sep 15 09:25:44 | sdp: prio = const (controller setting)
Sep 15 09:25:44 | sdp: const prio = 1
Sep 15 09:25:44 | sdp: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdp: uid = 350002ac001670246 (callout)
Sep 15 09:25:44 | sdo: not found in pathvec
Sep 15 09:25:44 | sdo: mask = 0x1f
Sep 15 09:25:44 | sdo: dev_t = 8:224
Sep 15 09:25:44 | sdo: size = 209715200
Sep 15 09:25:44 | sdo: subsystem = scsi
Sep 15 09:25:44 | sdo: vendor = 3PARdata
Sep 15 09:25:44 | sdo: product = VV
Sep 15 09:25:44 | sdo: rev = 0000
Sep 15 09:25:44 | sdo: h:b:t:l = 2:0:0:3
Sep 15 09:25:44 | sdo: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdo: serial = 00020246
Sep 15 09:25:44 | sdo: get_state
Sep 15 09:25:44 | sdo: path checker = directio (controller setting)
Sep 15 09:25:44 | sdo: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdo: state = 3
Sep 15 09:25:44 | sdo: prio = const (controller setting)
Sep 15 09:25:44 | sdo: const prio = 1
Sep 15 09:25:44 | sdo: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdo: uid = 350002ac000020246 (callout)
Sep 15 09:25:44 | sdr: not found in pathvec
Sep 15 09:25:44 | sdr: mask = 0x1f
Sep 15 09:25:44 | sdr: dev_t = 65:16
Sep 15 09:25:44 | sdr: size = 73400320
Sep 15 09:25:44 | sdr: subsystem = scsi
Sep 15 09:25:44 | sdr: vendor = 3PARdata
Sep 15 09:25:44 | sdr: product = VV
Sep 15 09:25:44 | sdr: rev = 0000
Sep 15 09:25:44 | sdr: h:b:t:l = 2:0:1:1
Sep 15 09:25:44 | sdr: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdr: serial = 00EE0246
Sep 15 09:25:44 | sdr: get_state
Sep 15 09:25:44 | sdr: path checker = directio (controller setting)
Sep 15 09:25:44 | sdr: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdr: state = 3
Sep 15 09:25:44 | sdr: prio = const (controller setting)
Sep 15 09:25:44 | sdr: const prio = 1
Sep 15 09:25:44 | sdr: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdr: uid = 350002ac000ee0246 (callout)
Sep 15 09:25:44 | sds: not found in pathvec
Sep 15 09:25:44 | sds: mask = 0x1f
Sep 15 09:25:44 | sds: dev_t = 65:32
Sep 15 09:25:44 | sds: size = 52428800
Sep 15 09:25:44 | sds: subsystem = scsi
Sep 15 09:25:44 | sds: vendor = 3PARdata
Sep 15 09:25:44 | sds: product = VV
Sep 15 09:25:44 | sds: rev = 0000
Sep 15 09:25:44 | sds: h:b:t:l = 2:0:1:2
Sep 15 09:25:44 | sds: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sds: serial = 01260246
Sep 15 09:25:44 | sds: get_state
Sep 15 09:25:44 | sds: path checker = directio (controller setting)
Sep 15 09:25:44 | sds: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sds: state = 3
Sep 15 09:25:44 | sds: prio = const (controller setting)
Sep 15 09:25:44 | sds: const prio = 1
Sep 15 09:25:44 | sds: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sds: uid = 350002ac001260246 (callout)
Sep 15 09:25:44 | sdt: not found in pathvec
Sep 15 09:25:44 | sdt: mask = 0x1f
Sep 15 09:25:44 | sdt: dev_t = 65:48
Sep 15 09:25:44 | sdt: size = 209715200
Sep 15 09:25:44 | sdt: subsystem = scsi
Sep 15 09:25:44 | sdt: vendor = 3PARdata
Sep 15 09:25:44 | sdt: product = VV
Sep 15 09:25:44 | sdt: rev = 0000
Sep 15 09:25:44 | sdt: h:b:t:l = 2:0:1:3
Sep 15 09:25:44 | sdt: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdt: serial = 00020246
Sep 15 09:25:44 | sdt: get_state
Sep 15 09:25:44 | sdt: path checker = directio (controller setting)
Sep 15 09:25:44 | sdt: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdt: state = 3
Sep 15 09:25:44 | sdt: prio = const (controller setting)
Sep 15 09:25:44 | sdt: const prio = 1
Sep 15 09:25:44 | sdt: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdt: uid = 350002ac000020246 (callout)
Sep 15 09:25:44 | sdu: not found in pathvec
Sep 15 09:25:44 | sdu: mask = 0x1f
Sep 15 09:25:44 | sdu: dev_t = 65:64
Sep 15 09:25:44 | sdu: size = 41943040
Sep 15 09:25:44 | sdu: subsystem = scsi
Sep 15 09:25:44 | sdu: vendor = 3PARdata
Sep 15 09:25:44 | sdu: product = VV
Sep 15 09:25:44 | sdu: rev = 0000
Sep 15 09:25:44 | sdu: h:b:t:l = 2:0:1:4
Sep 15 09:25:44 | sdu: tgt_node_name = 0x2ff70002ac00024
Sep 15 09:25:44 | sdu: serial = 01670246
Sep 15 09:25:44 | sdu: get_state
Sep 15 09:25:44 | sdu: path checker = directio (controller setting)
Sep 15 09:25:44 | sdu: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdu: state = 3
Sep 15 09:25:44 | sdu: prio = const (controller setting)
Sep 15 09:25:44 | sdu: const prio = 1
Sep 15 09:25:44 | sdu: getuid = /lib/udev/scsi_id --whitelisted --device=/dev/%n (controller setting)
Sep 15 09:25:44 | sdu: uid = 350002ac001670246 (callout)
Sep 15 09:25:44 | dm-5: device node name blacklisted
===== paths list =====
uuid                              hcil    dev dev_t pri dm_st chk_st vend/prod
36001e4f02053fe000f72e29478df3495 0:2:0:0 sda 8:0   1   undef ready  DELL,PERC
350002ac000ed0246                 1:0:0:0 sdb 8:16  1   undef ready  3PARdata,
350002ac000ee0246                 1:0:0:1 sdc 8:32  1   undef ready  3PARdata,
350002ac001260246                 1:0:0:2 sdd 8:48  1   undef ready  3PARdata,
350002ac000020246                 1:0:0:3 sde 8:64  1   undef ready  3PARdata,
350002ac000ed0246                 1:0:1:0 sdg 8:96  1   undef ready  3PARdata,
350002ac001670246                 1:0:0:4 sdf 8:80  1   undef ready  3PARdata,
350002ac000ee0246                 1:0:1:1 sdh 8:112 1   undef ready  3PARdata,
350002ac001260246                 1:0:1:2 sdi 8:128 1   undef ready  3PARdata,
350002ac000020246                 1:0:1:3 sdj 8:144 1   undef ready  3PARdata,
350002ac001670246                 1:0:1:4 sdk 8:160 1   undef ready  3PARdata,
350002ac000ed0246                 2:0:0:0 sdl 8:176 1   undef ready  3PARdata,
350002ac000ee0246                 2:0:0:1 sdm 8:192 1   undef ready  3PARdata,
350002ac001260246                 2:0:0:2 sdn 8:208 1   undef ready  3PARdata,
350002ac000ed0246                 2:0:1:0 sdq 65:0  1   undef ready  3PARdata,
350002ac001670246                 2:0:0:4 sdp 8:240 1   undef ready  3PARdata,
350002ac000020246                 2:0:0:3 sdo 8:224 1   undef ready  3PARdata,
350002ac000ee0246                 2:0:1:1 sdr 65:16 1   undef ready  3PARdata,
350002ac001260246                 2:0:1:2 sds 65:32 1   undef ready  3PARdata,
350002ac000020246                 2:0:1:3 sdt 65:48 1   undef ready  3PARdata,
350002ac001670246                 2:0:1:4 sdu 65:64 1   undef ready  3PARdata,
Sep 15 09:25:44 | params = 0 0 1 1 queue-length 0 4 1 8:64 8 8:144 8 8:224 8 65:48 8 
Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 1 8:64 A 0 0 8:144 A 0 0 8:224 A 0 0 65:48 A 0 0 
Sep 15 09:25:44 | 8: not found in pathvec
Sep 15 09:25:44 | Invalid device number 8
Sep 15 09:25:44 | Invalid device number 8
Sep 15 09:25:44 | params = 0 0 1 1 round-robin 0 4 1 8:240 1 8:80 1 8:160 1 65:64 1 
Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 0 8:240 A 0 8:80 A 0 8:160 A 0 65:64 A 0 
Sep 15 09:25:44 | params = 0 0 1 1 round-robin 0 4 1 65:32 1 8:48 1 8:128 1 8:208 1 
Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 0 65:32 A 0 8:48 A 0 8:128 A 0 8:208 A 0 
Sep 15 09:25:44 | params = 0 0 1 1 round-robin 0 4 1 8:192 1 8:32 1 8:112 1 65:16 1 
Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 0 8:192 A 0 8:32 A 0 8:112 A 0 65:16 A 0 
Sep 15 09:25:44 | params = 0 0 1 1 round-robin 0 4 1 8:176 1 8:16 1 8:96 1 65:0 1 
Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 0 8:176 A 0 8:16 A 0 8:96 A 0 65:0 A 0 
Sep 15 09:25:44 | sda: ownership set to 36001e4f02053fe000f72e29478df3495
Sep 15 09:25:44 | sda: not found in pathvec
Sep 15 09:25:44 | sda: mask = 0xc
Sep 15 09:25:44 | sda: get_state
Sep 15 09:25:44 | sda: state = running
Sep 15 09:25:44 | sda: state = 3
Sep 15 09:25:44 | sda: const prio = 1
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: pgfailover = -1 (internal default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: pgpolicy = multibus (config file default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: selector = round-robin 0 (internal default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: features = 0 (internal default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: hwhandler = 0 (internal default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: rr_weight = 1 (internal default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: minio = 8 (config file default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: no_path_retry = NONE (internal default)
Sep 15 09:25:44 | pg_timeout = NONE (internal default)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: set ACT_CREATE (map does not exist)
Sep 15 09:25:44 | 36001e4f02053fe000f72e29478df3495: domap (0) failure for create/reload map
Sep 15 09:25:44 | sde: ownership set to u02
Sep 15 09:25:44 | sde: not found in pathvec
Sep 15 09:25:44 | sde: mask = 0xc
Sep 15 09:25:44 | sde: get_state
Sep 15 09:25:44 | sde: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sde: state = 3
Sep 15 09:25:44 | sde: const prio = 1
Sep 15 09:25:44 | sdj: ownership set to u02
Sep 15 09:25:44 | sdj: not found in pathvec
Sep 15 09:25:44 | sdj: mask = 0xc
Sep 15 09:25:44 | sdj: get_state
Sep 15 09:25:44 | sdj: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdj: state = 3
Sep 15 09:25:44 | sdj: const prio = 1
Sep 15 09:25:44 | sdo: ownership set to u02
Sep 15 09:25:44 | sdo: not found in pathvec
Sep 15 09:25:44 | sdo: mask = 0xc
Sep 15 09:25:44 | sdo: get_state
Sep 15 09:25:44 | sdo: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdo: state = 3
Sep 15 09:25:44 | sdo: const prio = 1
Sep 15 09:25:44 | sdt: ownership set to u02
Sep 15 09:25:44 | sdt: not found in pathvec
Sep 15 09:25:44 | sdt: mask = 0xc
Sep 15 09:25:44 | sdt: get_state
Sep 15 09:25:44 | sdt: state = running
Sep 15 09:25:44 | directio: starting new request
Sep 15 09:25:44 | directio: io finished 4096/0
Sep 15 09:25:44 | sdt: state = 3
Sep 15 09:25:44 | sdt: const prio = 1
Sep 15 09:25:44 | : ownership set to u02
Sep 15 09:25:44 | : not found in pathvec
Sep 15 09:25:44 | : mask = 0xc
Sep 15 09:25:44 | : get_state
Sep 15 09:25:44 | : path checker = readsector0 (config file default)
Sep 15 09:25:44 | : failed to get parent
Sep 15 09:25:44 | : path offline
Sep 15 09:25:44 | : prio = const (config file default)
Sep 15 09:25:44 | : const prio = 1
Sep 15 09:25:44 | block: no 'dev' attribute in sysfs
Sep 15 09:25:44 | u02: failed to access path /block
Sep 15 09:25:44 | u02: pgfailover = -1 (internal default)
Sep 15 09:25:44 | u02: pgpolicy = multibus (LUN setting)
Sep 15 09:25:44 | u02: selector = queue-length 0 (LUN setting)
Sep 15 09:25:44 | u02: features = 0 (controller setting)
Sep 15 09:25:44 | u02: hwhandler = 0 (controller setting)
Sep 15 09:25:44 | u02: rr_weight = 1 (controller setting)
Sep 15 09:25:44 | u02: minio = 8 (LUN setting)
Sep 15 09:25:44 | u02: no_path_retry = NONE (internal default)
Sep 15 09:25:44 | pg_timeout = NONE (internal default)
Sep 15 09:25:44 | u02: set ACT_RELOAD (minio change, 0->8)
reload: u02 (350002ac000020246) undef 3PARdata,VV
size=100G features='0' hwhandler='0' wp=undef
`-+- policy='queue-length 0' prio=4 status=undef
  |- 1:0:0:3 sde 8:64  active ready running
  |- 1:0:1:3 sdj 8:144 active ready running
  |- 2:0:0:3 sdo 8:224 undef ready running
  `- 2:0:1:3 sdt 65:48 undef ready running
Sep 15 09:25:49 | Invalid device number 8
Sep 15 09:25:49 | Invalid device number 8


u02 (350002ac000020246) dm-3 3PARdata,VV
size=100G features='0' hwhandler='0' wp=rw
`-+- policy='queue-length 0' prio=2 status=active
  |- 1:0:0:3 sde 8:64  active ready running
  |- #:#:#:# -   #:#   active faulty running
  |- 1:0:1:3 sdj 8:144 active ready running
  `- #:#:#:# -   #:#   active faulty running
u01_vm4 (350002ac001670246) dm-0 3PARdata,VV
size=20G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:4 sdp 8:240 active ready running
  |- 1:0:0:4 sdf 8:80  active ready running
  |- 1:0:1:4 sdk 8:160 active ready running
  `- 2:0:1:4 sdu 65:64 active ready running
u01_vm3 (350002ac001260246) dm-4 3PARdata,VV
size=25G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:1:2 sds 65:32 active ready running
  |- 1:0:0:2 sdd 8:48  active ready running
  |- 1:0:1:2 sdi 8:128 active ready running
  `- 2:0:0:2 sdn 8:208 active ready running
u01_vm2 (350002ac000ee0246) dm-2 3PARdata,VV
size=35G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:1 sdm 8:192 active ready running
  |- 1:0:0:1 sdc 8:32  active ready running
  |- 1:0:1:1 sdh 8:112 active ready running
  `- 2:0:1:1 sdr 65:16 active ready running
u01_vm1 (350002ac000ed0246) dm-1 3PARdata,VV
size=35G features='0' hwhandler='0' wp=rw
`-+- policy='round-robin 0' prio=4 status=active
  |- 2:0:0:0 sdl 8:176 active ready running
  |- 1:0:0:0 sdb 8:16  active ready running
  |- 1:0:1:0 sdg 8:96  active ready running
  `- 2:0:1:0 sdq 65:0  active ready running

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: multipath-tools and queue-length/service-time path selectors oops
  2009-09-15 14:35       ` Andy
@ 2009-09-18  1:37         ` Kiyoshi Ueda
       [not found]           ` <20090924192859.GA14887@thumper2>
  0 siblings, 1 reply; 7+ messages in thread
From: Kiyoshi Ueda @ 2009-09-18  1:37 UTC (permalink / raw)
  To: genanr; +Cc: device-mapper development

Hi Andy,

Sorry for the late reply.

On 09/15/2009 11:35 PM +0900, Andy wrote:
> Now, I have another question. Why does the queue-length selector not use all
> my paths?
> 
> Sep 15 09:25:44 | loop0: device node name blacklisted
> Sep 15 09:25:44 | loop1: device node name blacklisted
<snip>
> Sep 15 09:25:44 | params = 0 0 1 1 queue-length 0 4 1 8:64 8 8:144 8 8:224 8 65:48 8 
> Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 1 8:64 A 0 0 8:144 A 0 0 8:224 A 0 0 65:48 A 0 0 
> Sep 15 09:25:44 | 8: not found in pathvec
> Sep 15 09:25:44 | Invalid device number 8
> Sep 15 09:25:44 | Invalid device number 8
<snip>
> reload: u02 (350002ac000020246) undef 3PARdata,VV
> size=100G features='0' hwhandler='0' wp=undef
> `-+- policy='queue-length 0' prio=4 status=undef
>   |- 1:0:0:3 sde 8:64  active ready running
>   |- 1:0:1:3 sdj 8:144 active ready running
>   |- 2:0:0:3 sdo 8:224 undef ready running
>   `- 2:0:1:3 sdt 65:48 undef ready running
> Sep 15 09:25:49 | Invalid device number 8
> Sep 15 09:25:49 | Invalid device number 8
> 
> 
> u02 (350002ac000020246) dm-3 3PARdata,VV
> size=100G features='0' hwhandler='0' wp=rw
> `-+- policy='queue-length 0' prio=2 status=active
>   |- 1:0:0:3 sde 8:64  active ready running
>   |- #:#:#:# -   #:#   active faulty running
>   |- 1:0:1:3 sdj 8:144 active ready running
>   `- #:#:#:# -   #:#   active faulty running

Actual device configuration seems to be working fine, but the getting
information from the configured device seems to be failing due to
table parsing problem in disassemble_map().
(The RHEL5's device-mapper-multipath package works fine.
 So the problem seems to be introduced during upstream development.)

I guess the attached patch works around the problem. Please try it.
Please note that this patch may *NOT* be a complete fix.
Some more codes for new dynamic load balancers may be needed.

By the way, unfortunatelly, I can't work on this next week.
I'll look at this more after that.  Sorry for the inconvenience.

Thanks,
Kiyoshi Ueda

---
 libmultipath/dmparser.c |    4 +++-
 1 file changed, 3 insertions(+), 1 deletion(-)

Index: multipath-tools/libmultipath/dmparser.c
===================================================================
--- multipath-tools.orig/libmultipath/dmparser.c
+++ multipath-tools/libmultipath/dmparser.c
@@ -323,8 +323,10 @@ disassemble_map (vector pathvec, char * 
 							def_minio /= pp->priority;
 
 						FREE(word);
-					} else
+					} else {
+						p += get_word(p, NULL);
 						def_minio = 0;
+					}
 
 					if (def_minio != mpp->minio)
 						mpp->minio = def_minio;

^ permalink raw reply	[flat|nested] 7+ messages in thread

* Re: multipath-tools and queue-length/service-time path selectors oops
       [not found]           ` <20090924192859.GA14887@thumper2>
@ 2009-09-28  7:41             ` Kiyoshi Ueda
  0 siblings, 0 replies; 7+ messages in thread
From: Kiyoshi Ueda @ 2009-09-28  7:41 UTC (permalink / raw)
  To: Andy, Christophe Varoqui; +Cc: device-mapper development

Hi Andy and Christophe,

On 09/25/2009 04:29 AM +0900, Andy wrote:
> On Fri, Sep 18, 2009 at 10:37:53AM +0900, Kiyoshi Ueda wrote:
>> Hi Andy,
>>
>> Sorry for the late reply.
>>
>> On 09/15/2009 11:35 PM +0900, Andy wrote:
>>> Now, I have another question. Why does the queue-length selector not use all
>>> my paths?
>>>
>>> Sep 15 09:25:44 | loop0: device node name blacklisted
>>> Sep 15 09:25:44 | loop1: device node name blacklisted
>> <snip>
>>> Sep 15 09:25:44 | params = 0 0 1 1 queue-length 0 4 1 8:64 8 8:144 8 8:224 8 65:48 8 
>>> Sep 15 09:25:44 | status = 2 0 0 0 1 1 A 0 4 1 8:64 A 0 0 8:144 A 0 0 8:224 A 0 0 65:48 A 0 0 
>>> Sep 15 09:25:44 | 8: not found in pathvec
>>> Sep 15 09:25:44 | Invalid device number 8
>>> Sep 15 09:25:44 | Invalid device number 8
>> <snip>
>>> reload: u02 (350002ac000020246) undef 3PARdata,VV
>>> size=100G features='0' hwhandler='0' wp=undef
>>> `-+- policy='queue-length 0' prio=4 status=undef
>>>   |- 1:0:0:3 sde 8:64  active ready running
>>>   |- 1:0:1:3 sdj 8:144 active ready running
>>>   |- 2:0:0:3 sdo 8:224 undef ready running
>>>   `- 2:0:1:3 sdt 65:48 undef ready running
>>> Sep 15 09:25:49 | Invalid device number 8
>>> Sep 15 09:25:49 | Invalid device number 8
>>>
>>>
>>> u02 (350002ac000020246) dm-3 3PARdata,VV
>>> size=100G features='0' hwhandler='0' wp=rw
>>> `-+- policy='queue-length 0' prio=2 status=active
>>>   |- 1:0:0:3 sde 8:64  active ready running
>>>   |- #:#:#:# -   #:#   active faulty running
>>>   |- 1:0:1:3 sdj 8:144 active ready running
>>>   `- #:#:#:# -   #:#   active faulty running
>> Actual device configuration seems to be working fine, but the getting
>> information from the configured device seems to be failing due to
>> table parsing problem in disassemble_map().
>> (The RHEL5's device-mapper-multipath package works fine.
>>  So the problem seems to be introduced during upstream development.)
>>
>> I guess the attached patch works around the problem. Please try it.
>> Please note that this patch may *NOT* be a complete fix.
>> Some more codes for new dynamic load balancers may be needed.
>>
>> By the way, unfortunatelly, I can't work on this next week.
>> I'll look at this more after that.  Sorry for the inconvenience.
>>
> 
> I've been busy myself.  But, I did want to let you know that your patches
> worked.

Thank you for your testing, Andy.


Christophe,
I found that you have already applied the patch:
    http://git.kernel.org/?p=linux/storage/multipath-tools/.git;a=commit;h=6a3b111e5e1fb6661a6fe4ff5a44397128279a10

Although the patch is not related to the new dynamic load balancers
directly, it definitely fixes a bug of the table parser.
Thank you very much.

As for the actual parsers of the new load balancers, I'll investigate
the needs and post as separate patches.

Thanks,
Kiyoshi Ueda

^ permalink raw reply	[flat|nested] 7+ messages in thread

end of thread, other threads:[~2009-09-28  7:41 UTC | newest]

Thread overview: 7+ messages (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
2009-09-11 21:34 multipath-tools and queue-length/service-time path selectors oops Andy
2009-09-14  2:15 ` Kiyoshi Ueda
2009-09-14 15:12   ` Andy
2009-09-15  2:10     ` Kiyoshi Ueda
2009-09-15 14:35       ` Andy
2009-09-18  1:37         ` Kiyoshi Ueda
     [not found]           ` <20090924192859.GA14887@thumper2>
2009-09-28  7:41             ` Kiyoshi Ueda

This is an external index of several public inboxes,
see mirroring instructions on how to clone and mirror
all data and code used by this external index.