Note: This bug is displayed in read-only format because the product is no longer active in Red Hat Bugzilla.
RHEL Engineering is moving the tracking of its product development work on RHEL 6 through RHEL 9 to Red Hat Jira (issues.redhat.com). If you're a Red Hat customer, please continue to file support cases via the Red Hat customer portal. If you're not, please head to the "RHEL project" in Red Hat Jira and file new tickets here. Individual Bugzilla bugs in the statuses "NEW", "ASSIGNED", and "POST" are being migrated throughout September 2023. Bugs of Red Hat partners with an assigned Engineering Partner Manager (EPM) are migrated in late September as per pre-agreed dates. Bugs against components "kernel", "kernel-rt", and "kpatch" are only migrated if still in "NEW" or "ASSIGNED". If you cannot log in to RH Jira, please consult article #7032570. That failing, please send an e-mail to the RH Jira admins at rh-issues@redhat.com to troubleshoot your issue as a user management inquiry. The email creates a ServiceNow ticket with Red Hat. Individual Bugzilla bugs that are migrated will be moved to status "CLOSED", resolution "MIGRATED", and set with "MigratedToJIRA" in "Keywords". The link to the successor Jira issue will be found under "Links", have a little "two-footprint" icon next to it, and direct you to the "RHEL project" in Red Hat Jira (issue links are of type "https://issues.redhat.com/browse/RHEL-XXXX", where "X" is a digit). This same link will be available in a blue banner at the top of the page informing you that that bug has been migrated.

Bug 1919077

Summary: [IBM power10] multipathd didn't report error when verbosity is greater than 6
Product: Red Hat Enterprise Linux 8 Reporter: Lin Li <lilin>
Component: device-mapper-multipathAssignee: Ben Marzinski <bmarzins>
Status: CLOSED DUPLICATE QA Contact: Lin Li <lilin>
Severity: high Docs Contact:
Priority: unspecified    
Version: 8.4CC: agk, bmarzins, heinzm, msnitzer, prajnoha, zkabelac
Target Milestone: rcFlags: pm-rhel: mirror+
Target Release: 8.0   
Hardware: ppc64le   
OS: Linux   
Whiteboard:
Fixed In Version: Doc Type: If docs needed, set a value
Doc Text:
Story Points: ---
Clone Of: Environment:
Last Closed: 2021-01-25 21:18:00 UTC Type: Bug
Regression: --- Mount Type: ---
Documentation: --- CRM:
Verified Versions: Category: ---
oVirt Team: --- RHEL 7.3 requirements from Atomic Host:
Cloudforms Team: --- Target Upstream Version:
Embargoed:

Description Lin Li 2021-01-22 04:14:26 UTC
Description of problem:
[IBM power10] multipathd didn't report error when verbosity is greater than 6

Version-Release number of selected component (if applicable):
device-mapper-multipath-0.8.4-7.el8.ppc64le
device-mapper-multipath-libs-0.8.4-7.el8.ppc64le

How reproducible:
always

Steps to Reproduce:
1.[root@rhyzden1-lp6 ~]# rpm -qa | grep multipath
device-mapper-multipath-0.8.4-7.el8.ppc64le
device-mapper-multipath-libs-0.8.4-7.el8.ppc64le

2.[root@rhyzden1-lp6 ~]# man multipath.conf
defaults section
       verbosity        Default  verbosity.  Higher  values  increase  the verbosity
                        level. Valid levels are between 0 and 6.

                        The default is: 2

3.Edit /etc/multipath.conf
defaults {
	verbosity 100
}

4.[root@rhyzden1-lp6 ~]# service multipathd reload
Redirecting to /bin/systemctl reload multipathd.service

5.[root@rhyzden1-lp6 ~]# multipathd show config local
defaults {
	verbosity 100
	polling_interval 5
	max_polling_interval 20
	reassign_maps "no"
	multipath_dir "/lib64/multipath"
	path_selector "service-time 0"
	path_grouping_policy "failover"
	uid_attribute "ID_SERIAL"
	prio "const"
	prio_args ""
	features "0"
	path_checker "tur"
	alias_prefix "mpath"
	failback "manual"
	rr_min_io 1000
	rr_min_io_rq 1
	max_fds "max"
	rr_weight "uniform"
	queue_without_daemon "no"
	flush_on_last_del "no"
	user_friendly_names "yes"
	fast_io_fail_tmo 5
	bindings_file "/etc/multipath/bindings"
	wwids_file "/etc/multipath/wwids"
	prkeys_file "/etc/multipath/prkeys"
	log_checker_err always
	all_tg_pt "no"
	retain_attached_hw_handler "yes"
	detect_prio "yes"
	detect_checker "yes"
	force_sync "no"
	strict_timing "no"
	deferred_remove "no"
	config_dir "/etc/multipath/conf.d"
	delay_watch_checks "no"
	delay_wait_checks "no"
	san_path_err_threshold "no"
	san_path_err_forget_rate "no"
	san_path_err_recovery_time "no"
	marginal_path_err_sample_time "no"
	marginal_path_err_rate_threshold "no"
	marginal_path_err_recheck_gap_time "no"
	marginal_path_double_failed_time "no"
	find_multipaths "on"
	uxsock_timeout 4000
	retrigger_tries 3
	retrigger_delay 10
	missing_uev_wait_timeout 30
	skip_kpartx "no"
	disable_changed_wwids ignored
	remove_retries 0
	ghost_delay "no"
	find_multipaths_timeout -10
	enable_foreign "^$"
	marginal_pathgroups "no"
}
blacklist {
	devnode "!^(sd[a-z]|dasd[a-z]|nvme[0-9])"
	device {
		vendor "SGI"
		product "Universal Xport"
	}
	device {
		vendor "^DGC"
		product "LUNZ"
	}
	device {
		vendor "EMC"
		product "LUNZ"
	}
	device {
		vendor "DELL"
		product "Universal Xport"
	}
	device {
		vendor "FUJITSU"
		product "Universal Xport"
	}
	device {
		vendor "IBM"
		product "Universal Xport"
	}
	device {
		vendor "IBM"
		product "S/390"
	}
	device {
		vendor "LENOVO"
		product "Universal Xport"
	}
	device {
		vendor "(NETAPP|LSI|ENGENIO)"
		product "Universal Xport"
	}
	device {
		vendor "STK"
		product "Universal Xport"
	}
	device {
		vendor "SUN"
		product "Universal Xport"
	}
	device {
		vendor "(Intel|INTEL)"
		product "VTrak V-LUN"
	}
	device {
		vendor "Promise"
		product "VTrak V-LUN"
	}
	device {
		vendor "Promise"
		product "Vess V-LUN"
	}
}
blacklist_exceptions {
	property "(SCSI_IDENT_|ID_WWN)"
}
devices {
	device {
		vendor "Linux"
		product "scsi_debug"
		path_grouping_policy "failover"
		no_path_retry 60
	}
	device {
		vendor "AIX"
		product "VDASD"
		path_grouping_policy "multibus"
		no_path_retry 60
	}
}
overrides {
	path_grouping_policy "multibus"
}
multipaths {
	multipath {
		wwid "333333330000007d1"
		alias "redhat"
		path_grouping_policy "multibus"
		path_selector "round-robin 0"
		# alias "redhat"
	}
}


6.[root@rhyzden1-lp6 ~]# multipath -ll
Jan 21 23:03:08 | set open fds limit to 1048576/1048576
Jan 21 23:03:08 | loading /lib64/multipath/libchecktur.so checker
Jan 21 23:03:08 | checker tur: message table size = 3
Jan 21 23:03:08 | loading /lib64/multipath/libprioconst.so prioritizer
Jan 21 23:03:08 | _init_foreign: found libforeign-nvme.so
Jan 21 23:03:08 | _init_foreign: foreign library "nvme" is not enabled
Jan 21 23:03:08 | released_to_systemd: DM_MULTIPATH_DEVICE_PATH=(null) -> 0
Jan 21 23:03:08 | Discover device /sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/block/sdb
Jan 21 23:03:08 | sdb: dev not found in pathvec
Jan 21 23:03:08 | 8:16: dev_t not found in pathvec
Jan 21 23:03:08 | sdb: udev property ID_WWN whitelisted
Jan 21 23:03:08 | sdb: mask = 0x27
Jan 21 23:03:08 | sdb: dev_t = 8:16
Jan 21 23:03:08 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/block/sdb/size'
Jan 21 23:03:08 | sdb: size = 2097152
Jan 21 23:03:08 | sdb: vendor = Linux
Jan 21 23:03:08 | sdb: product = scsi_debug
Jan 21 23:03:08 | sdb: rev = 0190
Jan 21 23:03:08 | find_hwe: found match /Linux:scsi_debug:(null)/ for 'Linux:scsi_debug:0190'
Jan 21 23:03:08 | find_hwe: found 1 hwtable matches for Linux:scsi_debug:0190
Jan 21 23:03:08 | sdb: h:b:t:l = 1:0:0:1
Jan 21 23:03:08 | sdb: tgt_node_name = 
Jan 21 23:03:08 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/state'
Jan 21 23:03:08 | sdb: path state = running
Jan 21 23:03:08 | sdb: 1011 cyl, 34 heads, 61 sectors/track, start at 0
Jan 21 23:03:08 | sdb: vpd_vendor_id = 0 "undef" (setting: multipath internal)
Jan 21 23:03:08 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/vpd_pg80'
Jan 21 23:03:08 | sdb: serial = 2001
Jan 21 23:03:08 | sdb: detect_checker = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:08 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/inquiry'
Jan 21 23:03:08 | overflow while reading from /sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/inquiry
Jan 21 23:03:08 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/vpd_pg83'
Jan 21 23:03:08 | pref=1
Jan 21 23:03:08 | sdb: path_checker = tur (setting: storage device autodetected)
Jan 21 23:03:08 | sdb: checker timeout = 30 s (setting: kernel sysfs)
Jan 21 23:03:09 | sdb: tur state = up
Jan 21 23:03:09 | Discover device /sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/block/sdc
Jan 21 23:03:09 | sdc: dev not found in pathvec
Jan 21 23:03:09 | 8:32: dev_t not found in pathvec
Jan 21 23:03:09 | sdc: udev property ID_WWN whitelisted
Jan 21 23:03:09 | sdc: mask = 0x27
Jan 21 23:03:09 | sdc: dev_t = 8:32
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/block/sdc/size'
Jan 21 23:03:09 | sdc: size = 2097152
Jan 21 23:03:09 | sdc: vendor = Linux
Jan 21 23:03:09 | sdc: product = scsi_debug
Jan 21 23:03:09 | sdc: rev = 0190
Jan 21 23:03:09 | find_hwe: found match /Linux:scsi_debug:(null)/ for 'Linux:scsi_debug:0190'
Jan 21 23:03:09 | find_hwe: found 1 hwtable matches for Linux:scsi_debug:0190
Jan 21 23:03:09 | sdc: h:b:t:l = 2:0:0:1
Jan 21 23:03:09 | sdc: tgt_node_name = 
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/state'
Jan 21 23:03:09 | sdc: path state = running
Jan 21 23:03:09 | sdc: 1011 cyl, 34 heads, 61 sectors/track, start at 0
Jan 21 23:03:09 | sdc: vpd_vendor_id = 0 "undef" (setting: multipath internal)
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/vpd_pg80'
Jan 21 23:03:09 | sdc: serial = 2001
Jan 21 23:03:09 | sdc: detect_checker = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/inquiry'
Jan 21 23:03:09 | overflow while reading from /sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/inquiry
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/vpd_pg83'
Jan 21 23:03:09 | pref=2
Jan 21 23:03:09 | sdc: path_checker = tur (setting: storage device autodetected)
Jan 21 23:03:09 | sdc: checker timeout = 30 s (setting: kernel sysfs)
Jan 21 23:03:09 | sdc: tur state = up
Jan 21 23:03:09 | Discover device /sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/block/sdd
Jan 21 23:03:09 | sdd: dev not found in pathvec
Jan 21 23:03:09 | 8:48: dev_t not found in pathvec
Jan 21 23:03:09 | sdd: udev property ID_WWN whitelisted
Jan 21 23:03:09 | sdd: mask = 0x27
Jan 21 23:03:09 | sdd: dev_t = 8:48
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/block/sdd/size'
Jan 21 23:03:09 | sdd: size = 2097152
Jan 21 23:03:09 | sdd: vendor = Linux
Jan 21 23:03:09 | sdd: product = scsi_debug
Jan 21 23:03:09 | sdd: rev = 0190
Jan 21 23:03:09 | find_hwe: found match /Linux:scsi_debug:(null)/ for 'Linux:scsi_debug:0190'
Jan 21 23:03:09 | find_hwe: found 1 hwtable matches for Linux:scsi_debug:0190
Jan 21 23:03:09 | sdd: h:b:t:l = 3:0:0:1
Jan 21 23:03:09 | sdd: tgt_node_name = 
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/state'
Jan 21 23:03:09 | sdd: path state = running
Jan 21 23:03:09 | sdd: 1011 cyl, 34 heads, 61 sectors/track, start at 0
Jan 21 23:03:09 | sdd: vpd_vendor_id = 0 "undef" (setting: multipath internal)
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/vpd_pg80'
Jan 21 23:03:09 | sdd: serial = 2001
Jan 21 23:03:09 | sdd: detect_checker = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/inquiry'
Jan 21 23:03:09 | overflow while reading from /sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/inquiry
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/vpd_pg83'
Jan 21 23:03:09 | pref=0
Jan 21 23:03:09 | sdd: path_checker = tur (setting: storage device autodetected)
Jan 21 23:03:09 | sdd: checker timeout = 30 s (setting: kernel sysfs)
Jan 21 23:03:09 | sdd: tur state = up
Jan 21 23:03:09 | Discover device /sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/block/sde
Jan 21 23:03:09 | sde: dev not found in pathvec
Jan 21 23:03:09 | 8:64: dev_t not found in pathvec
Jan 21 23:03:09 | sde: udev property ID_WWN whitelisted
Jan 21 23:03:09 | sde: mask = 0x27
Jan 21 23:03:09 | sde: dev_t = 8:64
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/block/sde/size'
Jan 21 23:03:09 | sde: size = 2097152
Jan 21 23:03:09 | sde: vendor = Linux
Jan 21 23:03:09 | sde: product = scsi_debug
Jan 21 23:03:09 | sde: rev = 0190
Jan 21 23:03:09 | find_hwe: found match /Linux:scsi_debug:(null)/ for 'Linux:scsi_debug:0190'
Jan 21 23:03:09 | find_hwe: found 1 hwtable matches for Linux:scsi_debug:0190
Jan 21 23:03:09 | sde: h:b:t:l = 4:0:0:1
Jan 21 23:03:09 | sde: tgt_node_name = 
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/state'
Jan 21 23:03:09 | sde: path state = running
Jan 21 23:03:09 | sde: 1011 cyl, 34 heads, 61 sectors/track, start at 0
Jan 21 23:03:09 | sde: vpd_vendor_id = 0 "undef" (setting: multipath internal)
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/vpd_pg80'
Jan 21 23:03:09 | sde: serial = 2001
Jan 21 23:03:09 | sde: detect_checker = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/inquiry'
Jan 21 23:03:09 | overflow while reading from /sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/inquiry
Jan 21 23:03:09 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/vpd_pg83'
Jan 21 23:03:10 | pref=1
Jan 21 23:03:10 | sde: path_checker = tur (setting: storage device autodetected)
Jan 21 23:03:10 | sde: checker timeout = 30 s (setting: kernel sysfs)
Jan 21 23:03:10 | sde: tur state = up
Jan 21 23:03:10 | Discover device /sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/block/sda
Jan 21 23:03:10 | sda: dev not found in pathvec
Jan 21 23:03:10 | 8:0: dev_t not found in pathvec
Jan 21 23:03:10 | sda: udev property SCSI_IDENT_SERIAL whitelisted
Jan 21 23:03:10 | sda: mask = 0x27
Jan 21 23:03:10 | sda: dev_t = 8:0
Jan 21 23:03:10 | open '/sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/block/sda/size'
Jan 21 23:03:10 | sda: size = 230686720
Jan 21 23:03:10 | sda: vendor = AIX
Jan 21 23:03:10 | sda: product = VDASD
Jan 21 23:03:10 | sda: rev = 0001
Jan 21 23:03:10 | find_hwe: found match /AIX:VDASD:(null)/ for 'AIX:VDASD:0001'
Jan 21 23:03:10 | find_hwe: found 1 hwtable matches for AIX:VDASD:0001
Jan 21 23:03:10 | sda: h:b:t:l = 0:0:1:0
Jan 21 23:03:10 | sda: tgt_node_name = 
Jan 21 23:03:10 | open '/sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/state'
Jan 21 23:03:10 | sda: path state = running
Jan 21 23:03:10 | sda: 14359 cyl, 255 heads, 63 sectors/track, start at 0
Jan 21 23:03:10 | sda: vpd_vendor_id = 0 "undef" (setting: multipath internal)
Jan 21 23:03:10 | open '/sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/vpd_pg80'
Jan 21 23:03:10 | sda: serial = 00c4c89800004c0000000175b727cf96.6
Jan 21 23:03:10 | sda: detect_checker = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:10 | open '/sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/inquiry'
Jan 21 23:03:10 | overflow while reading from /sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/inquiry
Jan 21 23:03:10 | sda: path_checker = tur (setting: multipath.conf defaults/devices section)
Jan 21 23:03:10 | sda: checker timeout = 120 s (setting: kernel sysfs)
Jan 21 23:03:10 | sda: tur state = up
Jan 21 23:03:10 | Discover device /sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/block/sda/sda1
Jan 21 23:03:10 | Discover device /sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/block/sda/sda2
Jan 21 23:03:10 | Discover device /sys/devices/vio/3000006a/host0/target0:0:1/0:0:1:0/block/sda/sda3
Jan 21 23:03:10 | Discover device /sys/devices/virtual/block/dm-0
Jan 21 23:03:10 | dm-0: dev not found in pathvec
Jan 21 23:03:10 | 253:0: dev_t not found in pathvec
Jan 21 23:03:10 | dm-0: device node name blacklisted
Jan 21 23:03:10 | Discover device /sys/devices/virtual/block/dm-1
Jan 21 23:03:10 | dm-1: dev not found in pathvec
Jan 21 23:03:10 | 253:1: dev_t not found in pathvec
Jan 21 23:03:10 | dm-1: device node name blacklisted
Jan 21 23:03:10 | Discover device /sys/devices/virtual/block/dm-2
Jan 21 23:03:10 | dm-2: dev not found in pathvec
Jan 21 23:03:10 | 253:2: dev_t not found in pathvec
Jan 21 23:03:10 | dm-2: device node name blacklisted
Jan 21 23:03:10 | Discover device /sys/devices/virtual/block/dm-3
Jan 21 23:03:10 | dm-3: dev not found in pathvec
Jan 21 23:03:10 | 253:3: dev_t not found in pathvec
Jan 21 23:03:10 | dm-3: device node name blacklisted
Jan 21 23:03:10 | Discovered 5/9 paths
===== paths list =====
uuid hcil    dev dev_t pri dm_st chk_st vend/prod/rev    dev_st 
     1:0:0:1 sdb 8:16  -1  undef undef  Linux,scsi_debug unknown
     2:0:0:1 sdc 8:32  -1  undef undef  Linux,scsi_debug unknown
     3:0:0:1 sdd 8:48  -1  undef undef  Linux,scsi_debug unknown
     4:0:0:1 sde 8:64  -1  undef undef  Linux,scsi_debug unknown
     0:0:1:0 sda 8:0   -1  undef undef  AIX,VDASD        unknown
Jan 21 23:03:10 | libdevmapper version 1.02.175-git (2020-12-22)
Jan 21 23:03:10 | DM multipath kernel driver v1.14.0
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(2155): Hold of control device is now set.
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm names   [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm table rhel_rhyzden1--lp6-home  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm table rhel_rhyzden1--lp6-swap  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm table rhel_rhyzden1--lp6-root  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm table redhat  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm table redhat  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm info redhat  [ opencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm info redhat  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm table redhat  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | params = 1 queue_if_no_path 1 alua 1 1 round-robin 0 4 1 8:16 1 8:32 1 8:48 1 8:64 1 
Jan 21 23:03:10 | libdevmapper: ioctl/libdm-iface.c(1898): dm status redhat  [ noopencount flush ]   [16384] (*1)
Jan 21 23:03:10 | status = 2 0 1 0 1 1 A 0 4 0 8:16 A 0 8:32 F 8 8:48 A 0 8:64 A 0 
Jan 21 23:03:10 | redhat: disassemble map [1 queue_if_no_path 1 alua 1 1 round-robin 0 4 1 8:16 1 8:32 1 8:48 1 8:64 1 ]
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = queue_if_no_path, len = 16
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = alua, len = 4
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = round-robin, len = 11
Jan 21 23:03:10 | *word = 0, len = 1
Jan 21 23:03:10 | *word = 4, len = 1
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = 8:16, len = 4
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = 8:32, len = 4
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = 8:48, len = 4
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = 8:64, len = 4
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | sdb: udev property ID_WWN whitelisted
Jan 21 23:03:10 | sdb: mask = 0x8
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/state'
Jan 21 23:03:10 | sdb: path state = running
Jan 21 23:03:10 | sdb: detect_prio = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/preferred_path'
Jan 21 23:03:10 | loading /lib64/multipath/libpriosysfs.so prioritizer
Jan 21 23:03:10 | sdb: prio = sysfs (setting: storage device autodetected)
Jan 21 23:03:10 | sdb: prio args = "" (setting: storage device autodetected)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter0/host1/target1:0:0/1:0:0:1/preferred_path'
Jan 21 23:03:10 | sdb: sysfs prio = 10
Jan 21 23:03:10 | sdc: udev property ID_WWN whitelisted
Jan 21 23:03:10 | sdc: mask = 0x8
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/state'
Jan 21 23:03:10 | sdc: path state = running
Jan 21 23:03:10 | sdc: detect_prio = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/preferred_path'
Jan 21 23:03:10 | sdc: prio = sysfs (setting: storage device autodetected)
Jan 21 23:03:10 | sdc: prio args = "" (setting: storage device autodetected)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter1/host2/target2:0:0/2:0:0:1/preferred_path'
Jan 21 23:03:10 | sdc: sysfs prio = 1
Jan 21 23:03:10 | sdd: udev property ID_WWN whitelisted
Jan 21 23:03:10 | sdd: mask = 0x8
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/state'
Jan 21 23:03:10 | sdd: path state = running
Jan 21 23:03:10 | sdd: detect_prio = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/preferred_path'
Jan 21 23:03:10 | sdd: prio = sysfs (setting: storage device autodetected)
Jan 21 23:03:10 | sdd: prio args = "" (setting: storage device autodetected)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter2/host3/target3:0:0/3:0:0:1/preferred_path'
Jan 21 23:03:10 | sdd: sysfs prio = 50
Jan 21 23:03:10 | sde: udev property ID_WWN whitelisted
Jan 21 23:03:10 | sde: mask = 0x8
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/state'
Jan 21 23:03:10 | sde: path state = running
Jan 21 23:03:10 | sde: detect_prio = yes (setting: multipath.conf defaults/devices section)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/preferred_path'
Jan 21 23:03:10 | sde: prio = sysfs (setting: storage device autodetected)
Jan 21 23:03:10 | sde: prio args = "" (setting: storage device autodetected)
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/access_state'
Jan 21 23:03:10 | open '/sys/devices/pseudo_0/adapter3/host4/target4:0:0/4:0:0:1/preferred_path'
Jan 21 23:03:10 | sde: sysfs prio = 10
Jan 21 23:03:10 | redhat: disassemble status [2 0 1 0 1 1 A 0 4 0 8:16 A 0 8:32 F 8 8:48 A 0 8:64 A 0 ]
Jan 21 23:03:10 | *word = 2, len = 1
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = 0, len = 1
Jan 21 23:03:10 | *word = 1, len = 1
Jan 21 23:03:10 | *word = A, len = 1
Jan 21 23:03:10 | *word = 4, len = 1
Jan 21 23:03:10 | *word = 0, len = 1
Jan 21 23:03:10 | *word = A, len = 1
Jan 21 23:03:10 | *word = 0, len = 1
Jan 21 23:03:10 | *word = F, len = 1
Jan 21 23:03:10 | *word = 8, len = 1
Jan 21 23:03:10 | *word = A, len = 1
Jan 21 23:03:10 | *word = 0, len = 1
Jan 21 23:03:10 | *word = A, len = 1
Jan 21 23:03:10 | *word = 0, len = 1
redhat (333333330000007d1) dm-3 Linux,scsi_debug
size=1.0G features='1 queue_if_no_path' hwhandler='1 alua' wp=rw
`-+- policy='round-robin 0' prio=17 status=active
  |- 1:0:0:1 sdb 8:16 active ready running
  |- 2:0:0:1 sdc 8:32 failed ready running
  |- 3:0:0:1 sdd 8:48 active ready running
  `- 4:0:0:1 sde 8:64 active ready running
Jan 21 23:03:10 | tur checker refcount 5
Jan 21 23:03:10 | sysfs prioritizer refcount 4
Jan 21 23:03:10 | tur checker refcount 4
Jan 21 23:03:10 | sysfs prioritizer refcount 3
Jan 21 23:03:10 | tur checker refcount 3
Jan 21 23:03:10 | sysfs prioritizer refcount 2
Jan 21 23:03:10 | tur checker refcount 2
Jan 21 23:03:10 | sysfs prioritizer refcount 1
Jan 21 23:03:10 | tur checker refcount 1
Jan 21 23:03:10 | unloading sysfs prioritizer
Jan 21 23:03:10 | unloading const prioritizer
Jan 21 23:03:10 | unloading tur checker



Actual results:
verbosity 100 is reloaded successfully. Multipath and multipathd didn't report error. The output of "multipath -ll" is not normal.

Expected results:
Multipath and multipathd should report error when verbosity is greater than 6. The output of "multipath -ll" is normal.

Additional info:

Comment 1 Ben Marzinski 2021-01-25 21:18:00 UTC
I agree that multipath should print warnings when it encounters invalid config values, instead of silently dealing with them. Currently, multipath issues almost no warnings for invalid values.  Bug #1900595 is for going through the config code and adding these warnings. This is bug is just another instance where that needs to happen.  What multipath actually does when it encounters a verbosity that's too high (assume that you entered the max valid verbosity) seems like the correct response, so I don't see any need to keep this as a separate bug.

*** This bug has been marked as a duplicate of bug 1900595 ***