search

lvmteam / lvm2

Mirror of upstream LVM2 repository
https://gitlab.com/lvmteam/lvm2
GNU General Public License v2.0
133 stars 73 forks source link

lvcreate not found: device not cleared #50

Closed ncist2011 closed 3 years ago

ncist2011 commented 3 years ago

platform:


1. 

uname -a
Linux controller7325 3.10.0-957.10.4.el7.x86_64 #1 SMP Wed Oct 21 09:27:12 CST 2020 x86_64 x86_64 x86_64 GNU/Linux

2. 

cat /etc/redhat-release
CentOS Linux release 7.6.1810 (Core)

3.
lvm version
  LVM version:     2.02.180(2)-RHEL7 (2018-07-20)
  Library version: 1.02.149-RHEL7 (2018-07-20)
  Driver version:  4.37.1
  Configuration:   ./configure --build=x86_64-redhat-linux-gnu --host=x86_64-redhat-linux-gnu --program-prefix= --disable-dependency-tracking --prefix=/usr --exec-prefix=/usr --bindir=/usr/bin --sbindir=/usr/sbin --sysconfdir=/etc --datadir=/usr/share --includedir=/usr/include --libdir=/usr/lib64 --libexecdir=/usr/libexec --localstatedir=/var --sharedstatedir=/var/lib --mandir=/usr/share/man --infodir=/usr/share/info --with-default-dm-run-dir=/run --with-default-run-dir=/run/lvm --with-default-pid-dir=/run --with-default-locking-dir=/run/lock/lvm --with-usrlibdir=/usr/lib64 --enable-lvm1_fallback --enable-fsadm --with-pool=internal --enable-write_install --with-user= --with-group= --with-device-uid=0 --with-device-gid=6 --with-device-mode=0660 --enable-pkgconfig --enable-applib --enable-cmdlib --enable-dmeventd --enable-blkid_wiping --enable-python2-bindings --with-cluster=internal --with-clvmd=corosync --enable-cmirrord --with-udevdir=/usr/lib/udev/rules.d --enable-udev_sync --with-thin=internal --enable-lvmetad --with-cache=internal --enable-lvmpolld --enable-lvmlockd-dlm --enable-lvmlockd-sanlock --enable-dmfilemapd

4.
create an shared sanlock vg:
vgcreate global_lock  /dev/mapper/mpatha --shared --metadatasize 10M

5.
[root@controller7325 ~]# pvs
  PV                 VG                Fmt  Attr PSize    PFree
  /dev/mapper/mpatha global_lock       lvm2 a--    14.98g   14.73g
  /dev/sdb           controller7325SSD lvm2 a--  <447.13g <447.13g
  /dev/sdg           controller7325HDD lvm2 a--    <5.46t       0
  /dev/sdh4          data              lvm2 a--   148.47g       0

6.
create lv:
lvcreate --name zhx --size 1g global_lock -v
    Loading table for global_lock-lvmlock (253:8).
    Suppressed global_lock-lvmlock (253:8) identical table reload.
    Suspending global_lock-lvmlock (253:8) with device flush
    Loading table for global_lock-lvmlock (253:8).
    Suppressed global_lock-lvmlock (253:8) identical table reload.
    Resuming global_lock-lvmlock (253:8).
    Archiving volume group "global_lock" metadata (seqno 15).
    Creating logical volume zhx
    Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 16).
    Activating logical volume global_lock/zhx.
    activation/volume_list configuration setting not defined: Checking only host tags for global_lock/zhx.
    Creating global_lock-zhx
    Loading table for global_lock-zhx (253:9).
    Resuming global_lock-zhx (253:9).
  /dev/global_lock/zhx: not found: device not cleared
  Aborting. Failed to wipe start of new LV.
    Removing global_lock-zhx (253:9)
    Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 17).
  semid 1376258: semop failed for cookie 0xd4d3570: incorrect semaphore state
  Failed to set a proper state for notification semaphore identified by cookie value 223163760 (0xd4d3570) to initialize waiting for incoming notifications.

Am I missing anything ?

teigland commented 3 years ago

create an shared sanlock vg: vgcreate testvg /dev/mapper/mpatha --shared --metadatasize 10M

create lv: lvcreate --name zhx --size 1g global_lock -v Loading table for global_lock-lvmlock (253:8). Suppressed global_lock-lvmlock (253:8) identical table reload. Suspending global_lock-lvmlock (253:8) with device flush Loading table for global_lock-lvmlock (253:8). Suppressed global_lock-lvmlock (253:8) identical table reload. Resuming global_lock-lvmlock (253:8). Archiving volume group "global_lock" metadata (seqno 15). Creating logical volume zhx Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 16). Activating logical volume global_lock/zhx. activation/volume_list configuration setting not defined: Checking only host tags for global_lock/zhx. Creating global_lock-zhx Loading table for global_lock-zhx (253:9). Resuming global_lock-zhx (253:9). /dev/global_lock/zhx: not found: device not cleared Aborting. Failed to wipe start of new LV. Removing global_lock-zhx (253:9) Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 17). semid 1376258: semop failed for cookie 0xd4d3570: incorrect semaphore state Failed to set a proper state for notification semaphore identified by cookie value 223163760 (0xd4d3570) to initialize waiting for incoming notifications.

This seems like it could be a problem synchronizing with udev. You might try adding -Wn -Zn to the lvcreate command to see if that works around the problem.

Dave

prajnoha commented 3 years ago

Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 17). semid 1376258: semop failed for cookie 0xd4d3570: incorrect semaphore state Failed to set a proper state for notification semaphore identified by cookie value 223163760 (0xd4d3570) to initialize waiting for incoming notifications.

This usually happens if the number of actual notifications (dmsetup udevcomplete calls from udev rule) do not match number of expected notifications - one of the reasons might be the udev rule is executed more than once with the same udev cookie. I'll try to check (if this is reproducible).

prajnoha commented 3 years ago

If you can reproduce, please, also try switching systemd-udevd into debug mode with:

udevadm control -l debug

Then start collecting the journal:

journalctl -f -u systemd-udevd

Then try running the lvm commands that fail (with -vvvv for most verbose logs). After that, please, send us the lvm command's log and journal output for analysis - feel free to open a report on LVM's bugzilla. Thanks.

ncist2011 commented 3 years ago

If you can reproduce, please, also try switching systemd-udevd into debug mode with:

udevadm control -l debug

Then start collecting the journal:

journalctl -f -u systemd-udevd

Then try running the lvm commands that fail (with -vvvv for most verbose logs). After that, please, send us the lvm command's log and journal output for analysis - feel free to open a report on LVM's bugzilla. Thanks.

Thank you for your answering my questions.

[root@controller7327 ~]#  lvcreate --name test --size 1g global_lock

systemd-udevd debug outputs:

6月 03 21:33:41 controller7327 systemd-udevd[8336]: Validate module index
6月 03 21:33:41 controller7327 systemd-udevd[8336]: Check if link configuration needs reloading.
6月 03 21:33:41 controller7327 systemd-udevd[8336]: seq 14717 queued, 'change' 'block'
6月 03 21:33:41 controller7327 systemd-udevd[8336]: seq 14717 forked new worker [54030]
6月 03 21:33:41 controller7327 systemd-udevd[54030]: seq 14717 running
6月 03 21:33:41 controller7327 systemd-udevd[54030]: IMPORT '/usr/sbin/dmsetup udevflags 7225821' /usr/lib/udev/rules.d/10-dm.rules:53
6月 03 21:33:41 controller7327 systemd-udevd[54033]: starting '/usr/sbin/dmsetup udevflags 7225821'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 7225821'(out) 'DM_UDEV_DISABLE_SUBSYSTEM_RULES_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 7225821'(out) 'DM_UDEV_DISABLE_DISK_RULES_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 7225821'(out) 'DM_UDEV_DISABLE_OTHER_RULES_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 7225821'(out) 'DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 7225821'(out) 'DM_UDEV_PRIMARY_SOURCE_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 7225821' [54033] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: LINK 'mapper/global_lock-lvmlock' /usr/lib/udev/rules.d/10-dm.rules:135
6月 03 21:33:41 controller7327 systemd-udevd[54030]: IMPORT '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-lvmlock' /usr/lib/udev/rules.d/11-dm-lvm.rules:21
6月 03 21:33:41 controller7327 systemd-udevd[54035]: starting '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-lvmlock'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-lvmlock'(out) 'DM_VG_NAME='global_lock''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-lvmlock'(out) 'DM_LV_NAME='lvmlock''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-lvmlock'(out) 'DM_LV_LAYER='''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-lvmlock' [54035] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: PROGRAM '/sbin/multipath -T 1622706989: -c /dev/dm-9' /usr/lib/udev/rules.d/62-multipath.rules:29
6月 03 21:33:41 controller7327 systemd-udevd[54036]: starting '/sbin/multipath -T 1622706989: -c /dev/dm-9'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/sbin/multipath -T 1622706989: -c /dev/dm-9' [54036] exit with return code 1
6月 03 21:33:41 controller7327 systemd-udevd[54030]: RUN '/usr/sbin/dmsetup udevcomplete $env{DM_COOKIE}' /usr/lib/udev/rules.d/95-dm-notify.rules:12
6月 03 21:33:41 controller7327 systemd-udevd[54030]: handling device node '/dev/dm-9', devnum=b253:9, mode=0600, uid=0, gid=0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/block/253:9' to '../dm-9'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: found 'b253:9' claiming '/run/udev/links/\x2fmapper\x2fglobal_lock-lvmlock'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: creating link '/dev/mapper/global_lock-lvmlock' to '/dev/dm-9'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/mapper/global_lock-lvmlock' to '../dm-9'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: created db file '/run/udev/data/b253:9' for '/devices/virtual/block/dm-9'
6月 03 21:33:41 controller7327 systemd-udevd[54037]: starting '/usr/sbin/dmsetup udevcomplete 7225821'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 7225821' [54037] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: passed unknown number of bytes to netlink monitor 0x56004b1beac0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: seq 14717 processed with 0
6月 03 21:33:41 controller7327 systemd-udevd[8336]: seq 14718 queued, 'add' 'bdi'
6月 03 21:33:41 controller7327 systemd-udevd[8336]: passed 143 bytes to netlink monitor 0x56004b1ba0d0
6月 03 21:33:41 controller7327 systemd-udevd[8336]: seq 14719 queued, 'add' 'block'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: seq 14718 running
6月 03 21:33:41 controller7327 systemd-udevd[54030]: no db file to read /run/udev/data/+bdi:253:12: No such file or directory
6月 03 21:33:41 controller7327 systemd-udevd[54030]: PROGRAM '/bin/uname -p' /usr/lib/udev/rules.d/40-redhat.rules:8
6月 03 21:33:41 controller7327 systemd-udevd[8336]: seq 14719 forked new worker [54038]
6月 03 21:33:41 controller7327 systemd-udevd[54038]: seq 14719 running
6月 03 21:33:41 controller7327 systemd-udevd[54038]: no db file to read /run/udev/data/b253:12: No such file or directory
6月 03 21:33:41 controller7327 systemd-udevd[54038]: PROGRAM '/bin/uname -p' /usr/lib/udev/rules.d/40-redhat.rules:8
6月 03 21:33:41 controller7327 systemd-udevd[8336]: seq 14720 queued, 'change' 'block'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/bin/uname -p'(out) 'x86_64'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/bin/uname -p' [54041] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: PROGRAM '/bin/systemd-detect-virt' /usr/lib/udev/rules.d/40-redhat.rules:11
6月 03 21:33:41 controller7327 systemd-udevd[54045]: starting '/bin/systemd-detect-virt'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: '/bin/uname -p'(out) 'x86_64'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: '/bin/uname -p' [54043] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54038]: PROGRAM '/bin/systemd-detect-virt' /usr/lib/udev/rules.d/40-redhat.rules:11
6月 03 21:33:41 controller7327 systemd-udevd[54046]: starting '/bin/systemd-detect-virt'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/bin/systemd-detect-virt'(out) 'none'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/bin/systemd-detect-virt' [54045] exit with return code 1
6月 03 21:33:41 controller7327 systemd-udevd[54030]: passed unknown number of bytes to netlink monitor 0x56004b1beac0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: seq 14718 processed with 0
6月 03 21:33:41 controller7327 systemd-udevd[54038]: '/bin/systemd-detect-virt'(out) 'none'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: '/bin/systemd-detect-virt' [54046] exit with return code 1
6月 03 21:33:41 controller7327 systemd-udevd[54038]: GROUP 6 /usr/lib/udev/rules.d/50-udev-default.rules:52
6月 03 21:33:41 controller7327 systemd-udevd[54038]: PROGRAM '/sbin/multipath -c /dev/dm-12' /usr/lib/udev/rules.d/62-multipath.rules:15
6月 03 21:33:41 controller7327 systemd-udevd[54047]: starting '/sbin/multipath -c /dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: '/sbin/multipath -c /dev/dm-12'(out) 'Jun 03 21:33:41 | the -c option requires a path to check'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: '/sbin/multipath -c /dev/dm-12' [54047] exit with return code 1
6月 03 21:33:41 controller7327 systemd-udevd[54038]: handling device node '/dev/dm-12', devnum=b253:12, mode=0660, uid=0, gid=6
6月 03 21:33:41 controller7327 systemd-udevd[54038]: preserve permissions /dev/dm-12, 060660, uid=0, gid=6
6月 03 21:33:41 controller7327 systemd-udevd[54038]: preserve already existing symlink '/dev/block/253:12' to '../dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: created db file '/run/udev/data/b253:12' for '/devices/virtual/block/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54038]: passed unknown number of bytes to netlink monitor 0x56004b1cb120
6月 03 21:33:41 controller7327 systemd-udevd[54038]: seq 14719 processed with 0
6月 03 21:33:41 controller7327 systemd-udevd[8336]: passed 219 bytes to netlink monitor 0x56004b1ba0d0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: seq 14720 running
6月 03 21:33:41 controller7327 systemd-udevd[54030]: IMPORT '/usr/sbin/dmsetup udevflags 23085533' /usr/lib/udev/rules.d/10-dm.rules:53
6月 03 21:33:41 controller7327 systemd-udevd[54048]: starting '/usr/sbin/dmsetup udevflags 23085533'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 23085533'(out) 'DM_UDEV_DISABLE_LIBRARY_FALLBACK_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 23085533'(out) 'DM_UDEV_PRIMARY_SOURCE_FLAG='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 23085533'(out) 'DM_SUBSYSTEM_UDEV_FLAG0='1''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevflags 23085533' [54048] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: LINK 'mapper/global_lock-test' /usr/lib/udev/rules.d/10-dm.rules:135
6月 03 21:33:41 controller7327 systemd-udevd[54030]: IMPORT '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-test' /usr/lib/udev/rules.d/11-dm-lvm.rules:21
6月 03 21:33:41 controller7327 systemd-udevd[54050]: starting '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-test'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-test'(out) 'DM_VG_NAME='global_lock''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-test'(out) 'DM_LV_NAME='test''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-test'(out) 'DM_LV_LAYER='''
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup splitname --nameprefixes --noheadings --rows global_lock-test' [54050] exit with return code 0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: LINK 'global_lock/test' /usr/lib/udev/rules.d/11-dm-lvm.rules:47
6月 03 21:33:41 controller7327 systemd-udevd[54030]: LINK 'disk/by-id/dm-name-global_lock-test' /usr/lib/udev/rules.d/13-dm-disk.rules:17
6月 03 21:33:41 controller7327 systemd-udevd[54030]: LINK 'disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIYcXiXnJ23saRYbxqWj0qYGYxR21iRSR3' /usr/lib/udev/rules.d/13-dm-disk.rules:18
6月 03 21:33:41 controller7327 systemd-udevd[54030]: PROGRAM '/sbin/multipath -T 1622706989: -c /dev/dm-12' /usr/lib/udev/rules.d/62-multipath.rules:29
6月 03 21:33:41 controller7327 systemd-udevd[54051]: starting '/sbin/multipath -T 1622706989: -c /dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/sbin/multipath -T 1622706989: -c /dev/dm-12' [54051] exit with return code 1
6月 03 21:33:41 controller7327 systemd-udevd[54030]: RUN '/usr/sbin/dmsetup udevcomplete $env{DM_COOKIE}' /usr/lib/udev/rules.d/95-dm-notify.rules:12
6月 03 21:33:41 controller7327 systemd-udevd[54030]: handling device node '/dev/dm-12', devnum=b253:12, mode=0600, uid=0, gid=0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/block/253:12' to '../dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: creating link '/dev/disk/by-id/dm-name-global_lock-test' to '/dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/disk/by-id/dm-name-global_lock-test' to '../../dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: creating link '/dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIYcXiXnJ23saRYbxqWj0qYGYxR21iRSR3' to '/dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIYcXiXnJ23saRYbxqWj0qYGYxR21iRSR3' to '../../dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: creating link '/dev/global_lock/test' to '/dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: creating symlink '/dev/global_lock/test' to '../dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: creating link '/dev/mapper/global_lock-test' to '/dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/mapper/global_lock-test' to '../dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: created db file '/run/udev/data/b253:12' for '/devices/virtual/block/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54052]: starting '/usr/sbin/dmsetup udevcomplete 23085533'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533'(err) 'Could not find notification semaphore identified by cookie value 223166941 (0xd4d41dd)'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533'(err) 'Command failed.'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533' [54052] exit with return code 1
6月 03 21:33:41 controller7327 systemd-udevd[54030]: adding watch on '/dev/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: created db file '/run/udev/data/b253:12' for '/devices/virtual/block/dm-12'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: passed unknown number of bytes to netlink monitor 0x56004b1beac0
6月 03 21:33:41 controller7327 systemd-udevd[54030]: seq 14720 processed with 0
6月 03 21:33:42 controller7327 systemd-udevd[8336]: seq 14721 queued, 'remove' 'block'
6月 03 21:33:42 controller7327 systemd-udevd[8336]: passed 218 bytes to netlink monitor 0x56004b1ba0d0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: seq 14721 running
6月 03 21:33:42 controller7327 systemd-udevd[54030]: removing watch on '/dev/dm-12'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: RUN '/sbin/mdadm -If $name' /usr/lib/udev/rules.d/65-md-incremental.rules:44
6月 03 21:33:42 controller7327 systemd-udevd[54030]: RUN '/usr/sbin/dmsetup udevcomplete $env{DM_COOKIE}' /usr/lib/udev/rules.d/95-dm-notify.rules:12
6月 03 21:33:42 controller7327 systemd-udevd[54030]: no reference left, remove '/dev/disk/by-id/dm-name-global_lock-test'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: no reference left, remove '/dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIYcXiXnJ23saRYbxqWj0qYGYxR21iRSR3'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: no reference left, remove '/dev/global_lock/test'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: no reference left, remove '/dev/mapper/global_lock-test'
6月 03 21:33:42 controller7327 systemd-udevd[8336]: seq 14722 queued, 'remove' 'bdi'
6月 03 21:33:42 controller7327 systemd-udevd[8336]: passed 146 bytes to netlink monitor 0x56004b1ba0d0
6月 03 21:33:42 controller7327 systemd-udevd[54054]: starting '/sbin/mdadm -If dm-12'
6月 03 21:33:42 controller7327 systemd-udevd[54038]: seq 14722 running
6月 03 21:33:42 controller7327 systemd-udevd[8336]: seq 14723 queued, 'remove' 'block'
6月 03 21:33:42 controller7327 systemd-udevd[54038]: no db file to read /run/udev/data/+bdi:253:12: No such file or directory
6月 03 21:33:42 controller7327 systemd-udevd[54038]: passed unknown number of bytes to netlink monitor 0x56004b1cb120
6月 03 21:33:42 controller7327 systemd-udevd[54038]: seq 14722 processed with 0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: '/sbin/mdadm -If dm-12'(err) 'mdadm: dm-12 does not appear to be a component of any array'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: '/sbin/mdadm -If dm-12' [54054] exit with return code 1
6月 03 21:33:42 controller7327 systemd-udevd[54055]: starting '/usr/sbin/dmsetup udevcomplete 6328756'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 6328756' [54055] exit with return code 0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: passed unknown number of bytes to netlink monitor 0x56004b1beac0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: seq 14721 processed with 0
6月 03 21:33:42 controller7327 systemd-udevd[8336]: passed 200 bytes to netlink monitor 0x56004b1ba0d0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: seq 14723 running
6月 03 21:33:42 controller7327 systemd-udevd[54030]: no db file to read /run/udev/data/b253:12: No such file or directory
6月 03 21:33:42 controller7327 systemd-udevd[54030]: RUN '/sbin/mdadm -If $name' /usr/lib/udev/rules.d/65-md-incremental.rules:44
6月 03 21:33:42 controller7327 systemd-udevd[54056]: starting '/sbin/mdadm -If dm-12'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: '/sbin/mdadm -If dm-12'(err) 'mdadm: dm-12 does not appear to be a component of any array'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: '/sbin/mdadm -If dm-12' [54056] exit with return code 1
6月 03 21:33:42 controller7327 systemd-udevd[54030]: passed unknown number of bytes to netlink monitor 0x56004b1beac0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: seq 14723 processed with 0
6月 03 21:33:42 controller7327 systemd-udevd[8336]: inotify event: 8 for /dev/dm-7
6月 03 21:33:42 controller7327 systemd-udevd[8336]: device /dev/dm-7 closed, synthesising 'change'
6月 03 21:33:42 controller7327 systemd-udevd[8336]: seq 14724 queued, 'change' 'block'
6月 03 21:33:42 controller7327 systemd-udevd[8336]: passed 197 bytes to netlink monitor 0x56004b1ba0d0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: seq 14724 running
6月 03 21:33:42 controller7327 systemd-udevd[54030]: removing watch on '/dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: LINK 'mapper/mpatha' /usr/lib/udev/rules.d/10-dm.rules:135
6月 03 21:33:42 controller7327 systemd-udevd[54030]: LINK 'disk/by-id/dm-name-mpatha' /usr/lib/udev/rules.d/13-dm-disk.rules:17
6月 03 21:33:42 controller7327 systemd-udevd[54030]: LINK 'disk/by-id/dm-uuid-mpath-36001405ab294643ad8c48e0ad84b6764' /usr/lib/udev/rules.d/13-dm-disk.rules:18
6月 03 21:33:42 controller7327 systemd-udevd[54030]: IMPORT builtin 'blkid' /usr/lib/udev/rules.d/13-dm-disk.rules:23
6月 03 21:33:42 controller7327 systemd-udevd[54030]: probe /dev/dm-7 raid offset=0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: PROGRAM '/sbin/multipath -T 1622706989: -c /dev/dm-7' /usr/lib/udev/rules.d/62-multipath.rules:29
6月 03 21:33:42 controller7327 systemd-udevd[54067]: starting '/sbin/multipath -T 1622706989: -c /dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: '/sbin/multipath -T 1622706989: -c /dev/dm-7' [54067] exit with return code 1
6月 03 21:33:42 controller7327 systemd-udevd[54030]: LINK 'disk/by-id/lvm-pv-uuid-FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV' /usr/lib/udev/rules.d/69-dm-lvm-metad.rules:38
6月 03 21:33:42 controller7327 systemd-udevd[54030]: handling device node '/dev/dm-7', devnum=b253:7, mode=0600, uid=0, gid=0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/block/253:7' to '../dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: found 'b253:7' claiming '/run/udev/links/\x2fdisk\x2fby-id\x2fdm-name-mpatha'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: creating link '/dev/disk/by-id/dm-name-mpatha' to '/dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/disk/by-id/dm-name-mpatha' to '../../dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: found 'b253:7' claiming '/run/udev/links/\x2fdisk\x2fby-id\x2fdm-uuid-mpath-36001405ab294643ad8c48e0ad84b6764'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: creating link '/dev/disk/by-id/dm-uuid-mpath-36001405ab294643ad8c48e0ad84b6764' to '/dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/disk/by-id/dm-uuid-mpath-36001405ab294643ad8c48e0ad84b6764' to '../../dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: found 'b253:7' claiming '/run/udev/links/\x2fdisk\x2fby-id\x2flvm-pv-uuid-FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: creating link '/dev/disk/by-id/lvm-pv-uuid-FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV' to '/dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/disk/by-id/lvm-pv-uuid-FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV' to '../../dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: found 'b253:7' claiming '/run/udev/links/\x2fmapper\x2fmpatha'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: creating link '/dev/mapper/mpatha' to '/dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: preserve already existing symlink '/dev/mapper/mpatha' to '../dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: created db file '/run/udev/data/b253:7' for '/devices/virtual/block/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: adding watch on '/dev/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: created db file '/run/udev/data/b253:7' for '/devices/virtual/block/dm-7'
6月 03 21:33:42 controller7327 systemd-udevd[54030]: passed unknown number of bytes to netlink monitor 0x56004b1beac0
6月 03 21:33:42 controller7327 systemd-udevd[54030]: seq 14724 processed with 0
6月 03 21:33:45 controller7327 systemd-udevd[8336]: cleanup idle workers
6月 03 21:33:45 controller7327 systemd-udevd[8336]: Validate module index
6月 03 21:33:45 controller7327 systemd-udevd[8336]: Check if link configuration needs reloading.
6月 03 21:33:45 controller7327 systemd-udevd[8336]: worker [54030] exit
6月 03 21:33:45 controller7327 systemd-udevd[8336]: worker [54030] cleaned up
6月 03 21:33:45 controller7327 systemd-udevd[8336]: worker [54038] exit
6月 03 21:33:45 controller7327 systemd-udevd[8336]: worker [54038] cleaned up

But, if i set verify_udev_operations = 1 in /etc/lvm/lvm.conf, lv can be created, and there are some warnings.

[root@controller7327 ~]#  lvcreate --name test --size 1g global_lock
  /dev/mapper/global_lock-test not set up by udev: Falling back to direct node creation.
  The link /dev/global_lock/test should have been created by udev but it was not found. Falling back to direct link creation.
  Logical volume "test" created.

I also try excute cmd strace lvcreate --name test --size 1g global_lock, lv can be created successfully, and there are no warnings.

In addition, a container is running on my host, if i stop this container, lv can be created successfully, and there are no warnings.

[root@controller7327 ~]# docker ps -a
CONTAINER ID        IMAGE                     COMMAND             CREATED             STATUS              PORTS               NAMES
610e2d5ab28e        maxta/mxsp:3.9.0.1-beta   "/usr/sbin/init"    4 days ago          Up 6 hours                              mxsp
ncist2011 commented 3 years ago

@prajnoha

cmd lvcreate --name test --size 1g global_lock -vvvv outputs:

#lvmcmdline.c:2829          Parsing: lvcreate --name test --size 1g global_lock -vvvv
#lvmcmdline.c:1881          Recognised command lvcreate_linear (id 45 / enum 44).
#config/config.c:1480        devices/global_filter not found in config: defaulting to global_filter = [ "a|.*/|" ]
#libdm-config.c:1002        global/lvmetad_update_wait_time not found in config: defaulting to 10
#daemon-client.c:33            /run/lvm/lvmetad.socket: Opening daemon socket to lvmetad for protocol lvmetad version 1.
#daemon-client.c:52            Sending daemon lvmetad: hello
#cache/lvmetad.c:143           Successfully connected to lvmetad on fd 3.
#filters/filter-sysfs.c:327           Sysfs filter initialised.
#filters/filter-internal.c:77            Internal filter initialised.
#filters/filter-type.c:56            LVM type filter initialised.
#filters/filter-usable.c:183           Usable device filter initialised.
#filters/filter-mpath.c:291           mpath filter initialised.
#filters/filter-partitioned.c:69            Partitioned filter initialised.
#filters/filter-md.c:150           MD filter initialised.
#filters/filter-composite.c:109           Composite filter initialised.
#config/config.c:1480        devices/filter not found in config: defaulting to filter = [ "a|.*/|" ]
#filters/filter-regex.c:216           Regex filter initialised.
#filters/filter-usable.c:183           Usable device filter initialised.
#filters/filter-composite.c:109           Composite filter initialised.
#libdm-config.c:975         devices/cache not found in config: defaulting to /etc/lvm/cache/.cache
#filters/filter-persistent.c:415           Persistent filter initialised.
#filters/filter-composite.c:109           Composite filter initialised.
#libdm-config.c:1074        metadata/record_lvs_history not found in config: defaulting to 0
#lvmcmdline.c:2897          DEGRADED MODE. Incomplete RAID LVs will be processed.
#lvmcmdline.c:2903          Processing command: lvcreate --name test --size 1g global_lock -vvvv
#lvmcmdline.c:2904          Command pid: 238330
#lvmcmdline.c:2905          System ID:
#lvmcmdline.c:2908          O_DIRECT will be used
#locking/locking.c:129         File-based locking selected.
#daemon-client.c:33            /run/lvm/lvmlockd.socket: Opening daemon socket to lvmlockd for protocol lvmlockd version 1.
#daemon-client.c:52            Sending daemon lvmlockd: hello
#locking/lvmlockd.c:91            Successfully connected to lvmlockd on fd 4.
#cache/lvmetad.c:256           Sending lvmetad get_global_info
#cache/lvmetad.c:335           lvmetad initialized previously.
#activate/activate.c:535         Getting target version for linear
#ioctl/libdm-iface.c:1857          dm version   [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm versions   [ opencount flush ]   [16384] (*1)
#activate/activate.c:572         Found linear target v1.3.0.
#activate/activate.c:535         Getting target version for striped
#ioctl/libdm-iface.c:1857          dm versions   [ opencount flush ]   [16384] (*1)
#activate/activate.c:572         Found striped target v1.6.0.
#libdm-config.c:1002        activation/mirror_region_size not found in config: defaulting to 2048
#libdm-config.c:975         report/output_format not found in config: defaulting to basic
#libdm-config.c:1074        log/report_command_log not found in config: defaulting to 0
#toollib.c:2246          Processing each VG
#toollib.c:2294        Obtaining the complete list of VGs to process
#cache/lvmetad.c:1454          Asking lvmetad for complete list of known VG ids/names
#toollib.c:2008        Processing VG global_lock q6gcmH-e3b1-uCK1-O5pX-BjuK-yL6n-xY4EEI
#locking/lvmlockd.c:1819          lockd VG global_lock mode ex
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#locking/lvmlockd.c:284           lvmlockd lock_vg ex vg global_lock result 0 0
#locking/locking.c:367           Dropping cache for global_lock.
#misc/lvm-flock.c:202         Locking /run/lock/lvm/V_global_lock WB
#misc/lvm-flock.c:100           _do_flock /run/lock/lvm/V_global_lock:aux WB
#misc/lvm-flock.c:100           _do_flock /run/lock/lvm/V_global_lock WB
#misc/lvm-flock.c:47            _undo_flock /run/lock/lvm/V_global_lock:aux
#cache/lvmcache.c:755           lvmcache has no info for vgname "global_lock".
#metadata/metadata.c:3780        Reading VG global_lock q6gcmH-e3b1-uCK1-O5pX-BjuK-yL6n-xY4EEI
#cache/lvmetad.c:992           Asking lvmetad for VG q6gcmH-e3b1-uCK1-O5pX-BjuK-yL6n-xY4EEI global_lock
#cache/lvmcache.c:755           lvmcache has no info for vgname "global_lock" with VGID q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEI.
#format_text/format-text.c:2059          <backtrace>
#device/dev-cache.c:1212          Creating list of system devices.
#device/dev-cache.c:723           Found dev 8:80 /dev/sdf - new.
#device/dev-cache.c:763           Found dev 8:80 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J - new alias.
#device/dev-cache.c:763           Found dev 8:80 /dev/disk/by-id/wwn-0x55cd2e414eef4781 - new alias.
#device/dev-cache.c:763           Found dev 8:80 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0 - new alias.
#device/dev-cache.c:723           Found dev 8:81 /dev/sdf1 - new.
#device/dev-cache.c:763           Found dev 8:81 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:81 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:81 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:81 /dev/disk/by-uuid/09ecd057-6e58-478a-b2fd-67f07de840ba - new alias.
#device/dev-cache.c:723           Found dev 8:82 /dev/sdf2 - new.
#device/dev-cache.c:763           Found dev 8:82 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:82 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:82 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:82 /dev/disk/by-uuid/4473f19b-1b50-44e2-a392-ffbf663496c2 - new alias.
#device/dev-cache.c:723           Found dev 8:83 /dev/sdf3 - new.
#device/dev-cache.c:763           Found dev 8:83 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:83 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:83 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:83 /dev/disk/by-uuid/5a8f61b5-0abe-4383-a56f-ca589ae97264 - new alias.
#device/dev-cache.c:723           Found dev 8:84 /dev/sdf4 - new.
#device/dev-cache.c:763           Found dev 8:84 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part4 - new alias.
#device/dev-cache.c:763           Found dev 8:84 /dev/disk/by-id/lvm-pv-uuid-FVB0r4-2UhB-4ExV-xJpj-8zwV-8dp2-FPdrfO - new alias.
#device/dev-cache.c:763           Found dev 8:84 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part4 - new alias.
#device/dev-cache.c:763           Found dev 8:84 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part4 - new alias.
#device/dev-cache.c:723           Found dev 8:0 /dev/sda - new.
#device/dev-cache.c:763           Found dev 8:0 /dev/disk/by-id/ata-INTEL_SSDSC2KG480G7_BTYM7406017Y480BGN - new alias.
#device/dev-cache.c:763           Found dev 8:0 /dev/disk/by-id/lvm-pv-uuid-XflkxS-jQ0b-AxF7-d5WY-WuTT-icUL-9TXNW3 - new alias.
#device/dev-cache.c:763           Found dev 8:0 /dev/disk/by-id/wwn-0x55cd2e414ec103a2 - new alias.
#device/dev-cache.c:763           Found dev 8:0 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6874-lun-0 - new alias.
#device/dev-cache.c:763           Found dev 8:0 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy4-lun-0 - new alias.
#device/dev-cache.c:723           Found dev 8:16 /dev/sdb - new.
#device/dev-cache.c:763           Found dev 8:16 /dev/disk/by-id/scsi-350000398c88383d9 - new alias.
#device/dev-cache.c:763           Found dev 8:16 /dev/disk/by-id/wwn-0x50000398c88383d9 - new alias.
#device/dev-cache.c:763           Found dev 8:16 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c88383da-lun-0 - new alias.
#device/dev-cache.c:763           Found dev 8:16 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy6-lun-0 - new alias.
#device/dev-cache.c:723           Found dev 8:17 /dev/sdb1 - new.
#device/dev-cache.c:763           Found dev 8:17 /dev/disk/by-id/scsi-350000398c88383d9-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:17 /dev/disk/by-id/wwn-0x50000398c88383d9-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:17 /dev/disk/by-partuuid/95282417-6039-40bf-a22e-4676b0fa73c7 - new alias.
#device/dev-cache.c:763           Found dev 8:17 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c88383da-lun-0-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:17 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy6-lun-0-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:17 /dev/disk/by-uuid/bf5f2488-7889-49f1-af24-4966a86f283c - new alias.
#device/dev-cache.c:723           Found dev 8:18 /dev/sdb2 - new.
#device/dev-cache.c:763           Found dev 8:18 /dev/disk/by-id/scsi-350000398c88383d9-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:18 /dev/disk/by-id/wwn-0x50000398c88383d9-part2 - new alias.
#device/dev-cache.c:723           Found dev 8:36 /dev/disk/by-label/MaxtaPool-1 - new.
#device/dev-cache.c:763           Found dev 8:18 /dev/disk/by-partuuid/76d20f27-d755-4b3b-9f71-9a5c03549b6a - new alias.
#device/dev-cache.c:763           Found dev 8:18 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c88383da-lun-0-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:18 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy6-lun-0-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:36 /dev/disk/by-uuid/8116647707660763715 - new alias.
#device/dev-cache.c:723           Found dev 8:32 /dev/sdc - new.
#device/dev-cache.c:763           Found dev 8:32 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN - new alias.
#device/dev-cache.c:763           Found dev 8:32 /dev/disk/by-id/wwn-0x55cd2e4150dccba0 - new alias.
#device/dev-cache.c:763           Found dev 8:32 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0 - new alias.
#device/dev-cache.c:763           Found dev 8:32 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0 - new alias.
#device/dev-cache.c:723           Found dev 8:33 /dev/sdc1 - new.
#device/dev-cache.c:763           Found dev 8:33 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:33 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:33 /dev/disk/by-partuuid/7c56fd01-7f36-4529-867a-520e4f01a943 - new alias.
#device/dev-cache.c:763           Found dev 8:33 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:33 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part1 - new alias.
#device/dev-cache.c:763           Found dev 8:33 /dev/disk/by-uuid/8a8cedd5-2ecf-4d53-afcc-8075fe6c2c67 - new alias.
#device/dev-cache.c:723           Found dev 8:34 /dev/sdc2 - new.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-label/ResourcePool - new alias.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-partuuid/a84f6375-0e17-42af-9ab2-e95d9ea82af9 - new alias.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part2 - new alias.
#device/dev-cache.c:763           Found dev 8:34 /dev/disk/by-uuid/5880381756353009591 - new alias.
#device/dev-cache.c:723           Found dev 8:35 /dev/sdc3 - new.
#device/dev-cache.c:763           Found dev 8:35 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:35 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:35 /dev/disk/by-partuuid/4fcfb395-568b-403e-b9ce-5de1e388b0f5 - new alias.
#device/dev-cache.c:763           Found dev 8:35 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:35 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part3 - new alias.
#device/dev-cache.c:763           Found dev 8:36 /dev/sdc4 - new alias.
#device/dev-cache.c:763           Found dev 8:36 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part4 - new alias.
#device/dev-cache.c:763           Found dev 8:36 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part4 - new alias.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-label/MaxtaPool-1 - exists.
#device/dev-cache.c:763           Found dev 8:36 /dev/disk/by-partuuid/6805acd5-74e2-47f4-b2f7-0a56b0ce87a3 - new alias.
#device/dev-cache.c:763           Found dev 8:36 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part4 - new alias.
#device/dev-cache.c:763           Found dev 8:36 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part4 - new alias.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-uuid/8116647707660763715 - exists.
#device/dev-cache.c:723           Found dev 8:37 /dev/sdc5 - new.
#device/dev-cache.c:763           Found dev 8:37 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part5 - new alias.
#device/dev-cache.c:763           Found dev 8:37 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part5 - new alias.
#device/dev-cache.c:763           Found dev 8:37 /dev/disk/by-partuuid/76dfcd81-d676-4ebe-ac74-85ee1e56958b - new alias.
#device/dev-cache.c:763           Found dev 8:37 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part5 - new alias.
#device/dev-cache.c:763           Found dev 8:37 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part5 - new alias.
#device/dev-cache.c:723           Found dev 8:48 /dev/sdd - new.
#device/dev-cache.c:763           Found dev 8:48 /dev/disk/by-id/lvm-pv-uuid-g1sv0r-feqn-rBBY-cRH7-H1fc-DdF0-43hAYm - new alias.
#device/dev-cache.c:763           Found dev 8:48 /dev/disk/by-id/scsi-350000398c8838e79 - new alias.
#device/dev-cache.c:763           Found dev 8:48 /dev/disk/by-id/wwn-0x50000398c8838e79 - new alias.
#device/dev-cache.c:763           Found dev 8:48 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c8838e7a-lun-0 - new alias.
#device/dev-cache.c:763           Found dev 8:48 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy8-lun-0 - new alias.
#device/dev-cache.c:723           Found dev 8:64 /dev/sde - new.
#device/dev-cache.c:763           Found dev 8:64 /dev/disk/by-id/scsi-350000398c8838d8d - new alias.
#device/dev-cache.c:763           Found dev 8:64 /dev/disk/by-id/wwn-0x50000398c8838d8d - new alias.
#device/dev-cache.c:763           Found dev 8:64 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c8838d8e-lun-0 - new alias.
#device/dev-cache.c:763           Found dev 8:64 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy9-lun-0 - new alias.
#device/dev-cache.c:723           Found dev 8:112 /dev/sdh - new.
#device/dev-cache.c:763           Found dev 8:112 /dev/disk/by-id/scsi-36001405ab294643ad8c48e0ad84b6764 - new alias.
#device/dev-cache.c:763           Found dev 8:112 /dev/disk/by-id/wwn-0x6001405ab294643ad8c48e0ad84b6764 - new alias.
#device/dev-cache.c:763           Found dev 8:112 /dev/disk/by-path/ip-10.10.1.20:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-0 - new alias.
#device/dev-cache.c:723           Found dev 8:144 /dev/sdj - new.
#device/dev-cache.c:723           Found dev 8:128 /dev/disk/by-id/scsi-36001405b064c1b59a35487f805012807 - new.
#device/dev-cache.c:763           Found dev 8:128 /dev/disk/by-id/wwn-0x6001405b064c1b59a35487f805012807 - new alias.
#device/dev-cache.c:763           Found dev 8:144 /dev/disk/by-path/ip-10.10.1.20:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-1 - new alias.
#device/dev-cache.c:723           Found dev 253:8 /dev/disk/by-uuid/6a5c7194-c7bf-4a62-8f30-193dab500dd9 - new.
#device/dev-cache.c:723           Found dev 8:96 /dev/sdg - new.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-id/scsi-36001405ab294643ad8c48e0ad84b6764 - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-id/wwn-0x6001405ab294643ad8c48e0ad84b6764 - exists.
#device/dev-cache.c:763           Found dev 8:96 /dev/disk/by-path/ip-10.10.1.21:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-0 - new alias.
#device/dev-cache.c:763           Found dev 8:128 /dev/sdi - new alias.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-id/scsi-36001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-id/wwn-0x6001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:763           Found dev 8:128 /dev/disk/by-path/ip-10.10.1.21:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-1 - new alias.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-uuid/6a5c7194-c7bf-4a62-8f30-193dab500dd9 - exists.
#device/dev-cache.c:723           Found dev 253:0 /dev/dm-0 - new.
#device/dev-cache.c:763           Found dev 253:0 /dev/controller7327SSD/controller7327SSD - new alias.
#device/dev-cache.c:763           Found dev 253:0 /dev/disk/by-id/dm-name-controller7327SSD-controller7327SSD - new alias.
#device/dev-cache.c:763           Found dev 253:0 /dev/disk/by-id/dm-uuid-LVM-G5V44lTN6cQRhGRbr8isoFHtC1P6XTy1joICKgH7pn1iUfeKGn4SoVMVkf7fYaeq - new alias.
#device/dev-cache.c:763           Found dev 253:0 /dev/disk/by-uuid/c1953979-49a0-4369-8872-9aada27f0a2f - new alias.
#device/dev-cache.c:763           Found dev 253:0 /dev/mapper/controller7327SSD-controller7327SSD - new alias.
#device/dev-cache.c:723           Found dev 253:1 /dev/dm-1 - new.
#device/dev-cache.c:763           Found dev 253:1 /dev/controller7327HDD/controller7327HDD - new alias.
#device/dev-cache.c:763           Found dev 253:1 /dev/disk/by-id/dm-name-controller7327HDD-controller7327HDD - new alias.
#device/dev-cache.c:763           Found dev 253:1 /dev/disk/by-id/dm-uuid-LVM-1bTHwygy4bA32M4nug0EwH9sSJ1QfTuwtfSCgU323BhCCk2gidr304wA1TStMuiF - new alias.
#device/dev-cache.c:763           Found dev 253:1 /dev/disk/by-uuid/9520a7a9-8052-4c2b-9377-adf2126297b1 - new alias.
#device/dev-cache.c:763           Found dev 253:1 /dev/mapper/controller7327HDD-controller7327HDD - new alias.
#device/dev-cache.c:723           Found dev 253:10 /dev/dm-10 - new.
#device/dev-cache.c:763           Found dev 253:10 /dev/disk/by-id/dm-name-global_lock-lvol0 - new alias.
#device/dev-cache.c:763           Found dev 253:10 /dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIiacIrc0zdJxFeYVinn27ndV3CeBoEi16 - new alias.
#device/dev-cache.c:763           Found dev 253:10 /dev/global_lock/lvol0 - new alias.
#device/dev-cache.c:763           Found dev 253:10 /dev/mapper/global_lock-lvol0 - new alias.
#device/dev-cache.c:723           Found dev 253:11 /dev/dm-11 - new.
#device/dev-cache.c:763           Found dev 253:11 /dev/disk/by-id/dm-name-global_lock-lvol1 - new alias.
#device/dev-cache.c:763           Found dev 253:11 /dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEI6iPd9KyS6swCkaL8Il6qif8qdHiMQ3Bb - new alias.
#device/dev-cache.c:763           Found dev 253:11 /dev/global_lock/lvol1 - new alias.
#device/dev-cache.c:763           Found dev 253:11 /dev/mapper/global_lock-lvol1 - new alias.
#device/dev-cache.c:723           Found dev 253:2 /dev/dm-2 - new.
#device/dev-cache.c:763           Found dev 253:2 /dev/data/datastore1 - new alias.
#device/dev-cache.c:763           Found dev 253:2 /dev/disk/by-id/dm-name-data-datastore1 - new alias.
#device/dev-cache.c:763           Found dev 253:2 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvbMl3q8RBEm9vAs87jPhqf3kkmMV6x7Hw - new alias.
#device/dev-cache.c:763           Found dev 253:2 /dev/disk/by-uuid/d57cea48-80c2-4837-bec2-3bb974360375 - new alias.
#device/dev-cache.c:763           Found dev 253:2 /dev/mapper/data-datastore1 - new alias.
#device/dev-cache.c:723           Found dev 253:3 /dev/dm-3 - new.
#device/dev-cache.c:763           Found dev 253:3 /dev/data/datastore2 - new alias.
#device/dev-cache.c:763           Found dev 253:3 /dev/disk/by-id/dm-name-data-datastore2 - new alias.
#device/dev-cache.c:763           Found dev 253:3 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvarj9VZi2K7gz9OKF2W3yLFOdEgbjdoYe - new alias.
#device/dev-cache.c:763           Found dev 253:3 /dev/disk/by-uuid/fafe234b-1942-4b49-918f-32eb82f296b8 - new alias.
#device/dev-cache.c:763           Found dev 253:3 /dev/mapper/data-datastore2 - new alias.
#device/dev-cache.c:723           Found dev 253:4 /dev/dm-4 - new.
#device/dev-cache.c:763           Found dev 253:4 /dev/data/backup - new alias.
#device/dev-cache.c:763           Found dev 253:4 /dev/disk/by-id/dm-name-data-backup - new alias.
#device/dev-cache.c:763           Found dev 253:4 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvBa4TXU9QTFauK4subGzCbd9tSwRIiB9f - new alias.
#device/dev-cache.c:763           Found dev 253:4 /dev/disk/by-uuid/9454ff20-1e1a-4724-ac84-9460c3590dd1 - new alias.
#device/dev-cache.c:763           Found dev 253:4 /dev/mapper/data-backup - new alias.
#device/dev-cache.c:723           Found dev 253:5 /dev/dm-5 - new.
#device/dev-cache.c:763           Found dev 253:5 /dev/data/arstore - new alias.
#device/dev-cache.c:763           Found dev 253:5 /dev/disk/by-id/dm-name-data-arstore - new alias.
#device/dev-cache.c:763           Found dev 253:5 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvhn7B0UUuIv3k7WWiGh3ajokkiu8fpqWx - new alias.
#device/dev-cache.c:763           Found dev 253:5 /dev/disk/by-uuid/0673f76d-9811-42c2-9418-b37fb993d93d - new alias.
#device/dev-cache.c:763           Found dev 253:5 /dev/mapper/data-arstore - new alias.
#device/dev-cache.c:723           Found dev 253:6 /dev/dm-6 - new.
#device/dev-cache.c:763           Found dev 253:6 /dev/data/log - new alias.
#device/dev-cache.c:763           Found dev 253:6 /dev/disk/by-id/dm-name-data-log - new alias.
#device/dev-cache.c:763           Found dev 253:6 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvuwl3wSsdIYhKnKtnsQaNVJPJYHdRC3by - new alias.
#device/dev-cache.c:763           Found dev 253:6 /dev/disk/by-uuid/31ee50e4-e6e7-4a76-9c6e-d59044580376 - new alias.
#device/dev-cache.c:763           Found dev 253:6 /dev/mapper/data-log - new alias.
#device/dev-cache.c:723           Found dev 253:7 /dev/dm-7 - new.
#device/dev-cache.c:763           Found dev 253:7 /dev/disk/by-id/dm-name-mpatha - new alias.
#device/dev-cache.c:763           Found dev 253:7 /dev/disk/by-id/dm-uuid-mpath-36001405ab294643ad8c48e0ad84b6764 - new alias.
#device/dev-cache.c:763           Found dev 253:7 /dev/disk/by-id/lvm-pv-uuid-FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV - new alias.
#device/dev-cache.c:763           Found dev 253:7 /dev/mapper/mpatha - new alias.
#device/dev-cache.c:763           Found dev 253:8 /dev/dm-8 - new alias.
#device/dev-cache.c:763           Found dev 253:8 /dev/disk/by-id/dm-name-mpathb - new alias.
#device/dev-cache.c:763           Found dev 253:8 /dev/disk/by-id/dm-uuid-mpath-36001405b064c1b59a35487f805012807 - new alias.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-uuid/6a5c7194-c7bf-4a62-8f30-193dab500dd9 - exists.
#device/dev-cache.c:763           Found dev 253:8 /dev/mapper/mpathb - new alias.
#device/dev-cache.c:723           Found dev 253:9 /dev/dm-9 - new.
#device/dev-cache.c:763           Found dev 253:9 /dev/mapper/global_lock-lvmlock - new alias.
#ioctl/libdm-iface.c:1857          dm status   (253:7) [ noopencount noflush ]   [16384] (*1)
#filters/filter-persistent.c:346           filter caching good /dev/mapper/mpatha
#cache/lvmcache.c:2084          lvmcache /dev/mapper/mpatha: now in VG #orphans_lvm2 (#orphans_lvm2) with 0 mda(s).
#metadata/vg.c:74            Allocated VG global_lock at 0x5593c1042710.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol0.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol1.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvmlock.
#format_text/import_vsn1.c:716           Logical volume global_lock/lvmlock is sanlock lv.
#cache/lvmcache.c:755           lvmcache has no info for vgname "global_lock" with VGID q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEI.
#cache/lvmcache.c:755           lvmcache has no info for vgname "global_lock".
#cache/lvmcache.c:2084          lvmcache /dev/mapper/mpatha: now in VG global_lock with 1 mda(s).
#cache/lvmcache.c:1910          lvmcache /dev/mapper/mpatha: VG global_lock: set VGID to q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEI.
#cache/lvmetad.c:2482          Sending lvmetad vg_clear_outdated_pvs
#libdm-config.c:1002        metadata/lvs_history_retention_time not found in config: defaulting to 0
#device/dev-io.c:359         /dev/mapper/mpatha: size is 31457280 sectors
#metadata/pv_manip.c:417           /dev/mapper/mpatha 0:      0     64: lvmlock(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 1:     64      3: lvol0(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 2:     67      3: lvol1(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 3:     70   3766: NULL(0:0)
#metadata/vg.c:74            Allocated VG global_lock at 0x5593c1046720.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol0.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol1.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvmlock.
#format_text/import_vsn1.c:716           Logical volume global_lock/lvmlock is sanlock lv.
#toollib.c:2034        Running command for VG global_lock q6gcmH-e3b1-uCK1-O5pX-BjuK-yL6n-xY4EEI
#libdm-config.c:1002        global/sanlock_lv_extend not found in config: defaulting to 256
#locking/file_locking.c:109         Locking LV q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo (W)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo [ noopencount flush ]   [16384] (*1)
#activate/dev_manager.c:3225          Creating PRELOAD tree for global_lock/lvmlock.
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo [ opencount flush ]   [16384] (*1)
#libdm-config.c:1074        activation/verify_udev_operations not found in config: defaulting to 0
#activate/activate.c:523         Getting driver version
#ioctl/libdm-iface.c:1857          dm version   [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:9) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:761           Skipping checks for old devices without LVM- dm uuid prefix (kernel vsn 3 >= 3).
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:2869          Adding new LV global_lock/lvmlock to dtree
#libdm-deptree.c:573           Matched uuid LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo in deptree.
#libdm-deptree.c:573           Matched uuid LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo in deptree.
#activate/dev_manager.c:2791          Checking kernel supports striped segment type for global_lock/lvmlock
#libdm-deptree.c:2701      Loading table for global_lock-lvmlock (253:9).
#libdm-deptree.c:2646          Adding target to (253:9): 0 524288 linear 253:7 32760
#ioctl/libdm-iface.c:1857          dm table   (253:9) [ opencount flush ]   [16384] (*1)
#libdm-deptree.c:2734      Suppressed global_lock-lvmlock (253:9) identical table reload.
#activate/activate.c:2350          Requiring flush for LV global_lock/lvmlock.
#mm/memlock.c:623           Entering critical section (suspending).
#mm/memlock.c:583           Lock:   Memlock counters: prioritized:0 locked:0 critical:1 daemon:0 suspended:0
#mm/memlock.c:516         Locking memory
#mm/memlock.c:296           mlock       1904KiB 5593be823000 - 5593be9ff000 r-xp 00000000 08:53 1654727                    /usr/sbin/lvm
#mm/memlock.c:296           mlock         40KiB 5593bebfe000 - 5593bec08000 r--p 001db000 08:53 1654727                    /usr/sbin/lvm
#mm/memlock.c:296           mlock        212KiB 5593bec08000 - 5593bec3d000 rw-p 001e5000 08:53 1654727                    /usr/sbin/lvm
#mm/memlock.c:296           mlock       2272KiB 5593bec3d000 - 5593bee75000 rw-p 00000000 00:00 0
#mm/memlock.c:296           mlock      18952KiB 5593c07d1000 - 5593c1a53000 rw-p 00000000 00:00 0                          [heap]
#mm/memlock.c:268           mlock default filter 'locale/locale-archive' matches '7f5b2213e000-7f5b28668000 r--p 00000000 08:53 33572115                   /usr/lib/locale/locale-archive': Skipping.
#mm/memlock.c:268           mlock default filter '/libpcre.so.' matches '7f5b28668000-7f5b286c8000 r-xp 00000000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b286c8000-7f5b288c8000 ---p 00060000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0 : Skipping.
#mm/memlock.c:268           mlock default filter '/libpcre.so.' matches '7f5b288c8000-7f5b288c9000 r--p 00060000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0': Skipping.
#mm/memlock.c:268           mlock default filter '/libpcre.so.' matches '7f5b288c9000-7f5b288ca000 rw-p 00061000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0': Skipping.
#mm/memlock.c:268           mlock default filter '/libbz2.so.' matches '7f5b288ca000-7f5b288d9000 r-xp 00000000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b288d9000-7f5b28ad8000 ---p 0000f000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6 : Skipping.
#mm/memlock.c:268           mlock default filter '/libbz2.so.' matches '7f5b28ad8000-7f5b28ad9000 r--p 0000e000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6': Skipping.
#mm/memlock.c:268           mlock default filter '/libbz2.so.' matches '7f5b28ad9000-7f5b28ada000 rw-p 0000f000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6': Skipping.
#mm/memlock.c:268           mlock default filter '/liblzma.so.' matches '7f5b28ada000-7f5b28aff000 r-xp 00000000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b28aff000-7f5b28cfe000 ---p 00025000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2 : Skipping.
#mm/memlock.c:268           mlock default filter '/liblzma.so.' matches '7f5b28cfe000-7f5b28cff000 r--p 00024000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2': Skipping.
#mm/memlock.c:268           mlock default filter '/liblzma.so.' matches '7f5b28cff000-7f5b28d00000 rw-p 00025000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2': Skipping.
#mm/memlock.c:268           mlock default filter '/libz.so.' matches '7f5b28d00000-7f5b28d15000 r-xp 00000000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b28d15000-7f5b28f14000 ---p 00015000 08:53 40139                      /usr/lib64/libz.so.1.2.7 : Skipping.
#mm/memlock.c:268           mlock default filter '/libz.so.' matches '7f5b28f14000-7f5b28f15000 r--p 00014000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:268           mlock default filter '/libz.so.' matches '7f5b28f15000-7f5b28f16000 rw-p 00015000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:268           mlock default filter '/libelf-' matches '7f5b28f16000-7f5b28f2d000 r-xp 00000000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b28f2d000-7f5b2912c000 ---p 00017000 08:53 40391                      /usr/lib64/libelf-0.172.so : Skipping.
#mm/memlock.c:268           mlock default filter '/libelf-' matches '7f5b2912c000-7f5b2912d000 r--p 00016000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:268           mlock default filter '/libz.so.' matches '7f5b28f15000-7f5b28f16000 rw-p 00015000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:268           mlock default filter '/libelf-' matches '7f5b28f16000-7f5b28f2d000 r-xp 00000000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b28f2d000-7f5b2912c000 ---p 00017000 08:53 40391                      /usr/lib64/libelf-0.172.so : Skipping.
#mm/memlock.c:268           mlock default filter '/libelf-' matches '7f5b2912c000-7f5b2912d000 r--p 00016000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:268           mlock default filter '/libelf-' matches '7f5b2912d000-7f5b2912e000 rw-p 00017000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:268           mlock default filter '/libattr.so.' matches '7f5b2912e000-7f5b29132000 r-xp 00000000 08:53 40231                      /usr/lib64/libattr.so.1.1.0': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b29132000-7f5b29331000 ---p 00004000 08:53 40231                      /usr/lib64/libattr.so.1.1.0 : Skipping.
#mm/memlock.c:268           mlock default filter '/libattr.so.' matches '7f5b29331000-7f5b29332000 r--p 00003000 08:53 40231                      /usr/lib64/libattr.so.1.1.0': Skipping.
#mm/memlock.c:268           mlock default filter '/libattr.so.' matches '7f5b29332000-7f5b29333000 rw-p 00004000 08:53 40231                      /usr/lib64/libattr.so.1.1.0': Skipping.
#mm/memlock.c:268           mlock default filter '/libtinfo.so.' matches '7f5b29333000-7f5b29358000 r-xp 00000000 08:53 40216                      /usr/lib64/libtinfo.so.5.9': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b29358000-7f5b29558000 ---p 00025000 08:53 40216                      /usr/lib64/libtinfo.so.5.9 : Skipping.
#mm/memlock.c:268           mlock default filter '/libtinfo.so.' matches '7f5b29558000-7f5b2955c000 r--p 00025000 08:53 40216                      /usr/lib64/libtinfo.so.5.9': Skipping.
#mm/memlock.c:268           mlock default filter '/libtinfo.so.' matches '7f5b2955c000-7f5b2955d000 rw-p 00029000 08:53 40216                      /usr/lib64/libtinfo.so.5.9': Skipping.
#mm/memlock.c:268           mlock default filter '/libsepol.so.' matches '7f5b2955d000-7f5b295f9000 r-xp 00000000 08:53 40227                      /usr/lib64/libsepol.so.1': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b295f9000-7f5b297f8000 ---p 0009c000 08:53 40227                      /usr/lib64/libsepol.so.1 : Skipping.
#mm/memlock.c:268           mlock default filter '/libsepol.so.' matches '7f5b297f8000-7f5b297f9000 r--p 0009b000 08:53 40227                      /usr/lib64/libsepol.so.1': Skipping.
#mm/memlock.c:268           mlock default filter '/libsepol.so.' matches '7f5b297f9000-7f5b297fa000 rw-p 0009c000 08:53 40227                      /usr/lib64/libsepol.so.1': Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b297fa000 - 7f5b297fb000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/libselinux.so.' matches '7f5b297fb000-7f5b2981f000 r-xp 00000000 08:53 40257                      /usr/lib64/libselinux.so.1': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2981f000-7f5b29a1e000 ---p 00024000 08:53 40257                      /usr/lib64/libselinux.so.1 : Skipping.
#mm/memlock.c:268           mlock default filter '/libselinux.so.' matches '7f5b29a1e000-7f5b29a1f000 r--p 00023000 08:53 40257                      /usr/lib64/libselinux.so.1': Skipping.
#mm/memlock.c:268           mlock default filter '/libselinux.so.' matches '7f5b29a1f000-7f5b29a20000 rw-p 00024000 08:53 40257                      /usr/lib64/libselinux.so.1': Skipping.
#mm/memlock.c:296           mlock          8KiB 7f5b29a20000 - 7f5b29a22000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/libuuid.so.' matches '7f5b29a22000-7f5b29a26000 r-xp 00000000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b29a26000-7f5b29c25000 ---p 00004000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0 : Skipping.
#mm/memlock.c:268           mlock default filter '/libuuid.so.' matches '7f5b29c25000-7f5b29c26000 r--p 00003000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0': Skipping.
#mm/memlock.c:268           mlock default filter '/libuuid.so.' matches '7f5b29c26000-7f5b29c27000 rw-p 00004000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0': Skipping.
#mm/memlock.c:296           mlock         84KiB 7f5b29c27000 - 7f5b29c3c000 r-xp 00000000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1
#mm/memlock.c:250           mlock area unreadable 7f5b29c3c000-7f5b29e3b000 ---p 00015000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1 : Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b29e3b000 - 7f5b29e3c000 r--p 00014000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1
#mm/memlock.c:296           mlock          4KiB 7f5b29e3c000 - 7f5b29e3d000 rw-p 00015000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1
#mm/memlock.c:268           mlock default filter '/libdw-' matches '7f5b29e3d000-7f5b29e89000 r-xp 00000000 08:53 205424                     /usr/lib64/libdw-0.172.so': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b29e89000-7f5b2a089000 ---p 0004c000 08:53 205424                     /usr/lib64/libdw-0.172.so : Skipping.
#mm/memlock.c:268           mlock default filter '/libdw-' matches '7f5b2a089000-7f5b2a08b000 r--p 0004c000 08:53 205424                     /usr/lib64/libdw-0.172.so': Skipping.
#mm/memlock.c:268           mlock default filter '/libdw-' matches '7f5b2a08b000-7f5b2a08c000 rw-p 0004e000 08:53 205424                     /usr/lib64/libdw-0.172.so': Skipping.
#mm/memlock.c:296           mlock       1028KiB 7f5b2a08c000 - 7f5b2a18d000 r-xp 00000000 08:53 40099                      /usr/lib64/libm-2.17.so
#mm/memlock.c:250           mlock area unreadable 7f5b2a18d000-7f5b2a38c000 ---p 00101000 08:53 40099                      /usr/lib64/libm-2.17.so : Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2a38c000 - 7f5b2a38d000 r--p 00100000 08:53 40099                      /usr/lib64/libm-2.17.so
#mm/memlock.c:296           mlock          4KiB 7f5b2a38d000 - 7f5b2a38e000 rw-p 00101000 08:53 40099                      /usr/lib64/libm-2.17.so
#mm/memlock.c:268           mlock default filter '/libcap.so.' matches '7f5b2a38e000-7f5b2a392000 r-xp 00000000 08:53 40235                      /usr/lib64/libcap.so.2.22': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2a392000-7f5b2a591000 ---p 00004000 08:53 40235                      /usr/lib64/libcap.so.2.22 : Skipping.
#mm/memlock.c:268           mlock default filter '/libcap.so.' matches '7f5b2a591000-7f5b2a592000 r--p 00003000 08:53 40235                      /usr/lib64/libcap.so.2.22': Skipping.
#mm/memlock.c:268           mlock default filter '/libcap.so.' matches '7f5b2a592000-7f5b2a593000 rw-p 00004000 08:53 40235                      /usr/lib64/libcap.so.2.22': Skipping.
#mm/memlock.c:296           mlock         28KiB 7f5b2a593000 - 7f5b2a59a000 r-xp 00000000 08:53 435548                     /usr/lib64/librt-2.17.so
#mm/memlock.c:250           mlock area unreadable 7f5b2a59a000-7f5b2a799000 ---p 00007000 08:53 435548                     /usr/lib64/librt-2.17.so : Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2a799000 - 7f5b2a79a000 r--p 00006000 08:53 435548                     /usr/lib64/librt-2.17.so
#mm/memlock.c:296           mlock          4KiB 7f5b2a79a000 - 7f5b2a79b000 rw-p 00007000 08:53 435548                     /usr/lib64/librt-2.17.so
#mm/memlock.c:296           mlock         92KiB 7f5b2a79b000 - 7f5b2a7b2000 r-xp 00000000 08:53 435544                     /usr/lib64/libpthread-2.17.so
#mm/memlock.c:250           mlock area unreadable 7f5b2a7b2000-7f5b2a9b1000 ---p 00017000 08:53 435544                     /usr/lib64/libpthread-2.17.so : Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2a9b1000 - 7f5b2a9b2000 r--p 00016000 08:53 435544                     /usr/lib64/libpthread-2.17.so
#mm/memlock.c:296           mlock          4KiB 7f5b2a9b2000 - 7f5b2a9b3000 rw-p 00017000 08:53 435544                     /usr/lib64/libpthread-2.17.so
#mm/memlock.c:296           mlock         16KiB 7f5b2a9b3000 - 7f5b2a9b7000 rw-p 00000000 00:00 0
#mm/memlock.c:296           mlock       1800KiB 7f5b2a9b7000 - 7f5b2ab79000 r-xp 00000000 08:53 40088                      /usr/lib64/libc-2.17.so
#mm/memlock.c:250           mlock area unreadable 7f5b2ab79000-7f5b2ad79000 ---p 001c2000 08:53 40088                      /usr/lib64/libc-2.17.so : Skipping.
#mm/memlock.c:296           mlock         16KiB 7f5b2ad79000 - 7f5b2ad7d000 r--p 001c2000 08:53 40088                      /usr/lib64/libc-2.17.so
#mm/memlock.c:296           mlock          8KiB 7f5b2ad7d000 - 7f5b2ad7f000 rw-p 001c6000 08:53 40088                      /usr/lib64/libc-2.17.so
#mm/memlock.c:296           mlock         20KiB 7f5b2ad7f000 - 7f5b2ad84000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/libreadline.so.' matches '7f5b2ad84000-7f5b2adc0000 r-xp 00000000 08:53 40390                      /usr/lib64/libreadline.so.6.2': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2adc0000-7f5b2afc0000 ---p 0003c000 08:53 40390                      /usr/lib64/libreadline.so.6.2 : Skipping.
#mm/memlock.c:268           mlock default filter '/libreadline.so.' matches '7f5b2afc0000-7f5b2afc2000 r--p 0003c000 08:53 40390                      /usr/lib64/libreadline.so.6.2': Skipping.
#mm/memlock.c:268           mlock default filter '/libreadline.so.' matches '7f5b2afc2000-7f5b2afc8000 rw-p 0003e000 08:53 40390                      /usr/lib64/libreadline.so.6.2': Skipping.
#mm/memlock.c:296           mlock          8KiB 7f5b2afc8000 - 7f5b2afca000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/libaio.so.' matches '7f5b2afca000-7f5b2afcb000 r-xp 00000000 08:53 40826                      /usr/lib64/libaio.so.1.0.1': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2afcb000-7f5b2b1ca000 ---p 00001000 08:53 40826                      /usr/lib64/libaio.so.1.0.1 : Skipping.
#mm/memlock.c:268           mlock default filter '/libaio.so.' matches '7f5b2b1ca000-7f5b2b1cb000 r--p 00000000 08:53 40826                      /usr/lib64/libaio.so.1.0.1': Skipping.
#mm/memlock.c:268           mlock default filter '/libaio.so.' matches '7f5b2b1cb000-7f5b2b1cc000 rw-p 00001000 08:53 40826                      /usr/lib64/libaio.so.1.0.1': Skipping.
#mm/memlock.c:296           mlock        328KiB 7f5b2b1cc000 - 7f5b2b21e000 r-xp 00000000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02
#mm/memlock.c:250           mlock area unreadable 7f5b2b21e000-7f5b2b41d000 ---p 00052000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02 : Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2b41d000 - 7f5b2b41e000 r--p 00051000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02
#mm/memlock.c:296           mlock         16KiB 7f5b2b41e000 - 7f5b2b422000 rw-p 00052000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02
#mm/memlock.c:296           mlock          4KiB 7f5b2b422000 - 7f5b2b423000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/libblkid.so.' matches '7f5b2b423000-7f5b2b45f000 r-xp 00000000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2b45f000-7f5b2b65e000 ---p 0003c000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0 : Skipping.
#mm/memlock.c:268           mlock default filter '/libblkid.so.' matches '7f5b2b65e000-7f5b2b661000 r--p 0003b000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0': Skipping.
#mm/memlock.c:268           mlock default filter '/libblkid.so.' matches '7f5b2b661000-7f5b2b662000 rw-p 0003e000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0': Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2b662000 - 7f5b2b663000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/libdl-' matches '7f5b2b663000-7f5b2b665000 r-xp 00000000 08:53 40095                      /usr/lib64/libdl-2.17.so': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2b665000-7f5b2b865000 ---p 00002000 08:53 40095                      /usr/lib64/libdl-2.17.so : Skipping.
#mm/memlock.c:268           mlock default filter '/libdl-' matches '7f5b2b865000-7f5b2b866000 r--p 00002000 08:53 40095                      /usr/lib64/libdl-2.17.so': Skipping.
#mm/memlock.c:268           mlock default filter '/libdl-' matches '7f5b2b866000-7f5b2b867000 rw-p 00003000 08:53 40095                      /usr/lib64/libdl-2.17.so': Skipping.
#mm/memlock.c:268           mlock default filter '/libudev.so.' matches '7f5b2b867000-7f5b2b87c000 r-xp 00000000 08:53 205438                     /usr/lib64/libudev.so.1.6.2': Skipping.
#mm/memlock.c:250           mlock area unreadable 7f5b2b87c000-7f5b2ba7b000 ---p 00015000 08:53 205438                     /usr/lib64/libudev.so.1.6.2 : Skipping.
#mm/memlock.c:268           mlock default filter '/libudev.so.' matches '7f5b2ba7b000-7f5b2ba7c000 r--p 00014000 08:53 205438                     /usr/lib64/libudev.so.1.6.2': Skipping.
#mm/memlock.c:268           mlock default filter '/libudev.so.' matches '7f5b2ba7c000-7f5b2ba7d000 rw-p 00015000 08:53 205438                     /usr/lib64/libudev.so.1.6.2': Skipping.
#mm/memlock.c:296           mlock         20KiB 7f5b2ba7d000 - 7f5b2ba82000 r-xp 00000000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02
#mm/memlock.c:250           mlock area unreadable 7f5b2ba82000-7f5b2bc81000 ---p 00005000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02 : Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2bc81000 - 7f5b2bc82000 r--p 00004000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02
#mm/memlock.c:296           mlock          4KiB 7f5b2bc82000 - 7f5b2bc83000 rw-p 00005000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02
#mm/memlock.c:268           mlock default filter '/ld-2.' matches '7f5b2bc83000-7f5b2bca5000 r-xp 00000000 08:53 435526                     /usr/lib64/ld-2.17.so': Skipping.
#mm/memlock.c:268           mlock default filter '/LC_MESSAGES/' matches '7f5b2be72000-7f5b2be86000 r--p 00000000 08:53 100682798                  /usr/share/locale/zh_CN/LC_MESSAGES/libc.mo': Skipping.
#mm/memlock.c:296           mlock         52KiB 7f5b2be86000 - 7f5b2be93000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter 'gconv/gconv-modules.cache' matches '7f5b2be99000-7f5b2bea0000 r--s 00000000 08:53 34279825                   /usr/lib64/gconv/gconv-modules.cache': Skipping.
#mm/memlock.c:296           mlock         12KiB 7f5b2bea0000 - 7f5b2bea3000 rw-s 00000000 00:0b 10723186                   /[aio] (deleted)
#mm/memlock.c:296           mlock          4KiB 7f5b2bea3000 - 7f5b2bea4000 rw-p 00000000 00:00 0
#mm/memlock.c:268           mlock default filter '/ld-2.' matches '7f5b2bea4000-7f5b2bea5000 r--p 00021000 08:53 435526                     /usr/lib64/ld-2.17.so': Skipping.
#mm/memlock.c:268           mlock default filter '/ld-2.' matches '7f5b2bea5000-7f5b2bea6000 rw-p 00022000 08:53 435526                     /usr/lib64/ld-2.17.so': Skipping.
#mm/memlock.c:296           mlock          4KiB 7f5b2bea6000 - 7f5b2bea7000 rw-p 00000000 00:00 0
#mm/memlock.c:296           mlock        132KiB 7ffed2282000 - 7ffed22a3000 rw-p 00000000 00:00 0                          [stack]
#mm/memlock.c:258           mlock ignore filter '[vdso]' matches '7ffed22ac000-7ffed22ae000 r-xp 00000000 00:00 0                          [vdso]': Skipping.
#mm/memlock.c:258           mlock ignore filter '[vsyscall]' matches 'ffffffffff600000-ffffffffff601000 r-xp 00000000 00:00 0                  [vsyscall]': Skipping.
#mm/memlock.c:382           Locked 27762688 bytes
#mm/memlock.c:489           Raised task priority 0 -> -18.
#activate/dev_manager.c:3225          Creating SUSPEND tree for global_lock/lvmlock.
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:9) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm info   (253:9) [ noopencount flush ]   [16384] (*1)
#libdm-deptree.c:1354      Suspending global_lock-lvmlock (253:9) with device flush
#ioctl/libdm-iface.c:1857          dm suspend   (253:9) [ noopencount flush skiplockfs ]   [16384] (*1)
#libdm-common.c:277           Suspended device counter increased to 1
#locking/file_locking.c:90          Unlocking LV q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo
#activate/activate.c:2539          Resuming LV global_lock/lvmlock if active.
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo [ noopencount flush ]   [16384] (*1)
#activate/dev_manager.c:3225          Creating ACTIVATE tree for global_lock/lvmlock.
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:9) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:2869          Adding new LV global_lock/lvmlock to dtree
#libdm-deptree.c:573           Matched uuid LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo in deptree.
#libdm-deptree.c:573           Matched uuid LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo in deptree.
#activate/dev_manager.c:2791          Checking kernel supports striped segment type for global_lock/lvmlock
#libdm-deptree.c:2701      Loading table for global_lock-lvmlock (253:9).
#libdm-deptree.c:2646          Adding target to (253:9): 0 524288 linear 253:7 32760
#ioctl/libdm-iface.c:1857          dm table   (253:9) [ opencount flush ]   [16384] (*1)
#libdm-deptree.c:2734      Suppressed global_lock-lvmlock (253:9) identical table reload.
#libdm-deptree.c:1303      Resuming global_lock-lvmlock (253:9).
#libdm-common.c:2433          Udev cookie 0xd4d0c89 (semid 884738) created
#libdm-common.c:2453          Udev cookie 0xd4d0c89 (semid 884738) incremented to 1
#libdm-common.c:2325          Udev cookie 0xd4d0c89 (semid 884738) incremented to 2
#libdm-common.c:2575          Udev cookie 0xd4d0c89 (semid 884738) assigned to RESUME task(5) with flags DISABLE_SUBSYSTEM_RULES DISABLE_DISK_RULES DISABLE_OTHER_RULES DISABLE_LIBRARY_FALLBACK         (0x2e)
#ioctl/libdm-iface.c:1857          dm resume   (253:9) [ noopencount flush ]   [16384] (*1)
#libdm-common.c:1484          global_lock-lvmlock: Stacking NODE_ADD (253,9) 0:6 0660 [trust_udev]
#libdm-common.c:1494          global_lock-lvmlock: Stacking NODE_READ_AHEAD 0 (flags=0)
#libdm-common.c:288           Suspended device counter reduced to 0
#activate/dev_manager.c:3225          Creating CLEAN tree for global_lock/lvmlock.
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:9) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-lvmlock-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIOLRASmxW9qu9DhZd6Ps55QP7AV6W5pRo-cow [ opencount flush ]   [16384] (*1)
#mm/memlock.c:636           Leaving critical section (resumed).
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#format_text/archiver.c:142       Archiving volume group "global_lock" metadata (seqno 93).
#metadata/lv_manip.c:5816      Creating logical volume test
#metadata/lv_manip.c:4148        Adding segment of type striped to LV test.
#metadata/lv_manip.c:3449          Adjusted allocation request to 256 logical extents. Existing size 0. New size 256.
#metadata/pv_map.c:54            Allowing allocation on /dev/mapper/mpatha start PE 70 length 3766
#metadata/lv_manip.c:3195          Trying allocation using contiguous policy.
#metadata/lv_manip.c:2793          Areas to be sorted and filled sequentially.
#metadata/lv_manip.c:2708          Still need 256 total extents from 3766 remaining (0 positional slots):
#metadata/lv_manip.c:2711            1 (1 data/0 parity) parallel areas of 256 extents each
#metadata/lv_manip.c:2715            0 mirror logs of 0 extents each
#metadata/lv_manip.c:2370          Considering allocation area 0 as /dev/mapper/mpatha start PE 70 length 256 leaving 3510.
#metadata/lv_manip.c:1950          Allocating parallel area 0 on /dev/mapper/mpatha start PE 70 length 256.
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:1 locked:1 critical:0 daemon:0 suspended:0
#mm/memlock.c:552         Unlocking memory
#mm/memlock.c:296           munlock       1904KiB 5593be823000 - 5593be9ff000 r-xp 00000000 08:53 1654727                    /usr/sbin/lvm
#mm/memlock.c:296           munlock         40KiB 5593bebfe000 - 5593bec08000 r--p 001db000 08:53 1654727                    /usr/sbin/lvm
#mm/memlock.c:296           munlock        212KiB 5593bec08000 - 5593bec3d000 rw-p 001e5000 08:53 1654727                    /usr/sbin/lvm
#mm/memlock.c:296           munlock       2272KiB 5593bec3d000 - 5593bee75000 rw-p 00000000 00:00 0
#mm/memlock.c:296           munlock      18952KiB 5593c07d1000 - 5593c1a53000 rw-p 00000000 00:00 0                          [heap]
#mm/memlock.c:268           munlock default filter 'locale/locale-archive' matches '7f5b2213e000-7f5b28668000 r--p 00000000 08:53 33572115                   /usr/lib/locale/locale-archive': Skipping.
#mm/memlock.c:268           munlock default filter '/libpcre.so.' matches '7f5b28668000-7f5b286c8000 r-xp 00000000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b286c8000-7f5b288c8000 ---p 00060000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0 : Skipping.
#mm/memlock.c:268           munlock default filter '/libpcre.so.' matches '7f5b288c8000-7f5b288c9000 r--p 00060000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0': Skipping.
#mm/memlock.c:268           munlock default filter '/libpcre.so.' matches '7f5b288c9000-7f5b288ca000 rw-p 00061000 08:53 40247                      /usr/lib64/libpcre.so.1.2.0': Skipping.
#mm/memlock.c:268           munlock default filter '/libbz2.so.' matches '7f5b288ca000-7f5b288d9000 r-xp 00000000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b288d9000-7f5b28ad8000 ---p 0000f000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6 : Skipping.
#mm/memlock.c:268           munlock default filter '/libbz2.so.' matches '7f5b28ad8000-7f5b28ad9000 r--p 0000e000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6': Skipping.
#mm/memlock.c:268           munlock default filter '/libbz2.so.' matches '7f5b28ad9000-7f5b28ada000 rw-p 0000f000 08:53 40383                      /usr/lib64/libbz2.so.1.0.6': Skipping.
#mm/memlock.c:268           munlock default filter '/liblzma.so.' matches '7f5b28ada000-7f5b28aff000 r-xp 00000000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b28aff000-7f5b28cfe000 ---p 00025000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2 : Skipping.
#mm/memlock.c:268           munlock default filter '/liblzma.so.' matches '7f5b28cfe000-7f5b28cff000 r--p 00024000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2': Skipping.
#mm/memlock.c:268           munlock default filter '/liblzma.so.' matches '7f5b28cff000-7f5b28d00000 rw-p 00025000 08:53 40374                      /usr/lib64/liblzma.so.5.2.2': Skipping.
#mm/memlock.c:268           munlock default filter '/libz.so.' matches '7f5b28d00000-7f5b28d15000 r-xp 00000000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b28d15000-7f5b28f14000 ---p 00015000 08:53 40139                      /usr/lib64/libz.so.1.2.7 : Skipping.
#mm/memlock.c:268           munlock default filter '/libz.so.' matches '7f5b28f14000-7f5b28f15000 r--p 00014000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:268           munlock default filter '/libz.so.' matches '7f5b28f15000-7f5b28f16000 rw-p 00015000 08:53 40139                      /usr/lib64/libz.so.1.2.7': Skipping.
#mm/memlock.c:268           munlock default filter '/libelf-' matches '7f5b28f16000-7f5b28f2d000 r-xp 00000000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b28f2d000-7f5b2912c000 ---p 00017000 08:53 40391                      /usr/lib64/libelf-0.172.so : Skipping.
#mm/memlock.c:268           munlock default filter '/libelf-' matches '7f5b2912c000-7f5b2912d000 r--p 00016000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:268           munlock default filter '/libelf-' matches '7f5b2912d000-7f5b2912e000 rw-p 00017000 08:53 40391                      /usr/lib64/libelf-0.172.so': Skipping.
#mm/memlock.c:268           munlock default filter '/libattr.so.' matches '7f5b2912e000-7f5b29132000 r-xp 00000000 08:53 40231                      /usr/lib64/libattr.so.1.1.0': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b29132000-7f5b29331000 ---p 00004000 08:53 40231                      /usr/lib64/libattr.so.1.1.0 : Skipping.
#mm/memlock.c:268           munlock default filter '/libattr.so.' matches '7f5b29331000-7f5b29332000 r--p 00003000 08:53 40231                      /usr/lib64/libattr.so.1.1.0': Skipping.
#mm/memlock.c:268           munlock default filter '/libattr.so.' matches '7f5b29332000-7f5b29333000 rw-p 00004000 08:53 40231                      /usr/lib64/libattr.so.1.1.0': Skipping.
#mm/memlock.c:268           munlock default filter '/libtinfo.so.' matches '7f5b29333000-7f5b29358000 r-xp 00000000 08:53 40216                      /usr/lib64/libtinfo.so.5.9': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b29358000-7f5b29558000 ---p 00025000 08:53 40216                      /usr/lib64/libtinfo.so.5.9 : Skipping.
#mm/memlock.c:268           munlock default filter '/libtinfo.so.' matches '7f5b29558000-7f5b2955c000 r--p 00025000 08:53 40216                      /usr/lib64/libtinfo.so.5.9': Skipping.
#mm/memlock.c:268           munlock default filter '/libtinfo.so.' matches '7f5b2955c000-7f5b2955d000 rw-p 00029000 08:53 40216                      /usr/lib64/libtinfo.so.5.9': Skipping.
#mm/memlock.c:268           munlock default filter '/libsepol.so.' matches '7f5b2955d000-7f5b295f9000 r-xp 00000000 08:53 40227                      /usr/lib64/libsepol.so.1': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b295f9000-7f5b297f8000 ---p 0009c000 08:53 40227                      /usr/lib64/libsepol.so.1 : Skipping.
#mm/memlock.c:268           munlock default filter '/libsepol.so.' matches '7f5b297f8000-7f5b297f9000 r--p 0009b000 08:53 40227                      /usr/lib64/libsepol.so.1': Skipping.
#mm/memlock.c:268           munlock default filter '/libsepol.so.' matches '7f5b297f9000-7f5b297fa000 rw-p 0009c000 08:53 40227                      /usr/lib64/libsepol.so.1': Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b297fa000 - 7f5b297fb000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/libselinux.so.' matches '7f5b297fb000-7f5b2981f000 r-xp 00000000 08:53 40257                      /usr/lib64/libselinux.so.1': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2981f000-7f5b29a1e000 ---p 00024000 08:53 40257                      /usr/lib64/libselinux.so.1 : Skipping.
#mm/memlock.c:268           munlock default filter '/libselinux.so.' matches '7f5b29a1e000-7f5b29a1f000 r--p 00023000 08:53 40257                      /usr/lib64/libselinux.so.1': Skipping.
#mm/memlock.c:268           munlock default filter '/libselinux.so.' matches '7f5b29a1f000-7f5b29a20000 rw-p 00024000 08:53 40257                      /usr/lib64/libselinux.so.1': Skipping.
#mm/memlock.c:296           munlock          8KiB 7f5b29a20000 - 7f5b29a22000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/libuuid.so.' matches '7f5b29a22000-7f5b29a26000 r-xp 00000000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b29a26000-7f5b29c25000 ---p 00004000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0 : Skipping.
#mm/memlock.c:268           munlock default filter '/libuuid.so.' matches '7f5b29c25000-7f5b29c26000 r--p 00003000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0': Skipping.
#mm/memlock.c:268           munlock default filter '/libuuid.so.' matches '7f5b29c26000-7f5b29c27000 rw-p 00004000 08:53 40381                      /usr/lib64/libuuid.so.1.3.0': Skipping.
#mm/memlock.c:296           munlock         84KiB 7f5b29c27000 - 7f5b29c3c000 r-xp 00000000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1
#mm/memlock.c:250           munlock area unreadable 7f5b29c3c000-7f5b29e3b000 ---p 00015000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1 : Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b29e3b000 - 7f5b29e3c000 r--p 00014000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1
#mm/memlock.c:296           munlock          4KiB 7f5b29e3c000 - 7f5b29e3d000 rw-p 00015000 08:53 435521                     /usr/lib64/libgcc_s-4.8.5-20150702.so.1
#mm/memlock.c:268           munlock default filter '/libdw-' matches '7f5b29e3d000-7f5b29e89000 r-xp 00000000 08:53 205424                     /usr/lib64/libdw-0.172.so': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b29e89000-7f5b2a089000 ---p 0004c000 08:53 205424                     /usr/lib64/libdw-0.172.so : Skipping.
#mm/memlock.c:268           munlock default filter '/libdw-' matches '7f5b2a089000-7f5b2a08b000 r--p 0004c000 08:53 205424                     /usr/lib64/libdw-0.172.so': Skipping.
#mm/memlock.c:268           munlock default filter '/libdw-' matches '7f5b2a08b000-7f5b2a08c000 rw-p 0004e000 08:53 205424                     /usr/lib64/libdw-0.172.so': Skipping.
#mm/memlock.c:296           munlock       1028KiB 7f5b2a08c000 - 7f5b2a18d000 r-xp 00000000 08:53 40099                      /usr/lib64/libm-2.17.so
#mm/memlock.c:250           munlock area unreadable 7f5b2a18d000-7f5b2a38c000 ---p 00101000 08:53 40099                      /usr/lib64/libm-2.17.so : Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2a38c000 - 7f5b2a38d000 r--p 00100000 08:53 40099                      /usr/lib64/libm-2.17.so
#mm/memlock.c:296           munlock          4KiB 7f5b2a38d000 - 7f5b2a38e000 rw-p 00101000 08:53 40099                      /usr/lib64/libm-2.17.so
#mm/memlock.c:268           munlock default filter '/libcap.so.' matches '7f5b2a38e000-7f5b2a392000 r-xp 00000000 08:53 40235                      /usr/lib64/libcap.so.2.22': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2a392000-7f5b2a591000 ---p 00004000 08:53 40235                      /usr/lib64/libcap.so.2.22 : Skipping.
#mm/memlock.c:268           munlock default filter '/libcap.so.' matches '7f5b2a591000-7f5b2a592000 r--p 00003000 08:53 40235                      /usr/lib64/libcap.so.2.22': Skipping.
#mm/memlock.c:268           munlock default filter '/libcap.so.' matches '7f5b2a592000-7f5b2a593000 rw-p 00004000 08:53 40235                      /usr/lib64/libcap.so.2.22': Skipping.
#mm/memlock.c:296           munlock         28KiB 7f5b2a593000 - 7f5b2a59a000 r-xp 00000000 08:53 435548                     /usr/lib64/librt-2.17.so
#mm/memlock.c:250           munlock area unreadable 7f5b2a59a000-7f5b2a799000 ---p 00007000 08:53 435548                     /usr/lib64/librt-2.17.so : Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2a799000 - 7f5b2a79a000 r--p 00006000 08:53 435548                     /usr/lib64/librt-2.17.so
#mm/memlock.c:296           munlock          4KiB 7f5b2a79a000 - 7f5b2a79b000 rw-p 00007000 08:53 435548                     /usr/lib64/librt-2.17.so
#mm/memlock.c:296           munlock         92KiB 7f5b2a79b000 - 7f5b2a7b2000 r-xp 00000000 08:53 435544                     /usr/lib64/libpthread-2.17.so
#mm/memlock.c:250           munlock area unreadable 7f5b2a7b2000-7f5b2a9b1000 ---p 00017000 08:53 435544                     /usr/lib64/libpthread-2.17.so : Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2a9b1000 - 7f5b2a9b2000 r--p 00016000 08:53 435544                     /usr/lib64/libpthread-2.17.so
#mm/memlock.c:296           munlock          4KiB 7f5b2a9b2000 - 7f5b2a9b3000 rw-p 00017000 08:53 435544                     /usr/lib64/libpthread-2.17.so
#mm/memlock.c:296           munlock         16KiB 7f5b2a9b3000 - 7f5b2a9b7000 rw-p 00000000 00:00 0
#mm/memlock.c:296           munlock       1800KiB 7f5b2a9b7000 - 7f5b2ab79000 r-xp 00000000 08:53 40088                      /usr/lib64/libc-2.17.so
#mm/memlock.c:250           munlock area unreadable 7f5b2ab79000-7f5b2ad79000 ---p 001c2000 08:53 40088                      /usr/lib64/libc-2.17.so : Skipping.
#mm/memlock.c:296           munlock         16KiB 7f5b2ad79000 - 7f5b2ad7d000 r--p 001c2000 08:53 40088                      /usr/lib64/libc-2.17.so
#mm/memlock.c:296           munlock          8KiB 7f5b2ad7d000 - 7f5b2ad7f000 rw-p 001c6000 08:53 40088                      /usr/lib64/libc-2.17.so
#mm/memlock.c:296           munlock         20KiB 7f5b2ad7f000 - 7f5b2ad84000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/libreadline.so.' matches '7f5b2ad84000-7f5b2adc0000 r-xp 00000000 08:53 40390                      /usr/lib64/libreadline.so.6.2': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2adc0000-7f5b2afc0000 ---p 0003c000 08:53 40390                      /usr/lib64/libreadline.so.6.2 : Skipping.
#mm/memlock.c:268           munlock default filter '/libreadline.so.' matches '7f5b2afc0000-7f5b2afc2000 r--p 0003c000 08:53 40390                      /usr/lib64/libreadline.so.6.2': Skipping.
#mm/memlock.c:268           munlock default filter '/libreadline.so.' matches '7f5b2afc2000-7f5b2afc8000 rw-p 0003e000 08:53 40390                      /usr/lib64/libreadline.so.6.2': Skipping.
#mm/memlock.c:296           munlock          8KiB 7f5b2afc8000 - 7f5b2afca000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/libaio.so.' matches '7f5b2afca000-7f5b2afcb000 r-xp 00000000 08:53 40826                      /usr/lib64/libaio.so.1.0.1': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2afcb000-7f5b2b1ca000 ---p 00001000 08:53 40826                      /usr/lib64/libaio.so.1.0.1 : Skipping.
#mm/memlock.c:268           munlock default filter '/libaio.so.' matches '7f5b2b1ca000-7f5b2b1cb000 r--p 00000000 08:53 40826                      /usr/lib64/libaio.so.1.0.1': Skipping.
#mm/memlock.c:268           munlock default filter '/libaio.so.' matches '7f5b2b1cb000-7f5b2b1cc000 rw-p 00001000 08:53 40826                      /usr/lib64/libaio.so.1.0.1': Skipping.
#mm/memlock.c:296           munlock        328KiB 7f5b2b1cc000 - 7f5b2b21e000 r-xp 00000000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02
#mm/memlock.c:250           munlock area unreadable 7f5b2b21e000-7f5b2b41d000 ---p 00052000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02 : Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2b41d000 - 7f5b2b41e000 r--p 00051000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02
#mm/memlock.c:296           munlock         16KiB 7f5b2b41e000 - 7f5b2b422000 rw-p 00052000 08:53 92791                      /usr/lib64/libdevmapper.so.1.02
#mm/memlock.c:296           munlock          4KiB 7f5b2b422000 - 7f5b2b423000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/libblkid.so.' matches '7f5b2b423000-7f5b2b45f000 r-xp 00000000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2b45f000-7f5b2b65e000 ---p 0003c000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0 : Skipping.
#mm/memlock.c:268           munlock default filter '/libblkid.so.' matches '7f5b2b65e000-7f5b2b661000 r--p 0003b000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0': Skipping.
#mm/memlock.c:268           munlock default filter '/libblkid.so.' matches '7f5b2b661000-7f5b2b662000 rw-p 0003e000 08:53 40387                      /usr/lib64/libblkid.so.1.1.0': Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2b662000 - 7f5b2b663000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/libdl-' matches '7f5b2b663000-7f5b2b665000 r-xp 00000000 08:53 40095                      /usr/lib64/libdl-2.17.so': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2b665000-7f5b2b865000 ---p 00002000 08:53 40095                      /usr/lib64/libdl-2.17.so : Skipping.
#mm/memlock.c:268           munlock default filter '/libdl-' matches '7f5b2b865000-7f5b2b866000 r--p 00002000 08:53 40095                      /usr/lib64/libdl-2.17.so': Skipping.
#mm/memlock.c:268           munlock default filter '/libdl-' matches '7f5b2b866000-7f5b2b867000 rw-p 00003000 08:53 40095                      /usr/lib64/libdl-2.17.so': Skipping.
#mm/memlock.c:268           munlock default filter '/libudev.so.' matches '7f5b2b867000-7f5b2b87c000 r-xp 00000000 08:53 205438                     /usr/lib64/libudev.so.1.6.2': Skipping.
#mm/memlock.c:250           munlock area unreadable 7f5b2b87c000-7f5b2ba7b000 ---p 00015000 08:53 205438                     /usr/lib64/libudev.so.1.6.2 : Skipping.
#mm/memlock.c:268           munlock default filter '/libudev.so.' matches '7f5b2ba7b000-7f5b2ba7c000 r--p 00014000 08:53 205438                     /usr/lib64/libudev.so.1.6.2': Skipping.
#mm/memlock.c:268           munlock default filter '/libudev.so.' matches '7f5b2ba7c000-7f5b2ba7d000 rw-p 00015000 08:53 205438                     /usr/lib64/libudev.so.1.6.2': Skipping.
#mm/memlock.c:296           munlock         20KiB 7f5b2ba7d000 - 7f5b2ba82000 r-xp 00000000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02
#mm/memlock.c:250           munlock area unreadable 7f5b2ba82000-7f5b2bc81000 ---p 00005000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02 : Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2bc81000 - 7f5b2bc82000 r--p 00004000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02
#mm/memlock.c:296           munlock          4KiB 7f5b2bc82000 - 7f5b2bc83000 rw-p 00005000 08:53 40680                      /usr/lib64/libdevmapper-event.so.1.02
#mm/memlock.c:268           munlock default filter '/ld-2.' matches '7f5b2bc83000-7f5b2bca5000 r-xp 00000000 08:53 435526                     /usr/lib64/ld-2.17.so': Skipping.
#mm/memlock.c:268           munlock default filter '/LC_MESSAGES/' matches '7f5b2be72000-7f5b2be86000 r--p 00000000 08:53 100682798                  /usr/share/locale/zh_CN/LC_MESSAGES/libc.mo': Skipping.
#mm/memlock.c:296           munlock         52KiB 7f5b2be86000 - 7f5b2be93000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter 'gconv/gconv-modules.cache' matches '7f5b2be99000-7f5b2bea0000 r--s 00000000 08:53 34279825                   /usr/lib64/gconv/gconv-modules.cache': Skipping.
#mm/memlock.c:296           munlock         12KiB 7f5b2bea0000 - 7f5b2bea3000 rw-s 00000000 00:0b 10723186                   /[aio] (deleted)
#mm/memlock.c:296           munlock          4KiB 7f5b2bea3000 - 7f5b2bea4000 rw-p 00000000 00:00 0
#mm/memlock.c:268           munlock default filter '/ld-2.' matches '7f5b2bea4000-7f5b2bea5000 r--p 00021000 08:53 435526                     /usr/lib64/ld-2.17.so': Skipping.
#mm/memlock.c:268           munlock default filter '/ld-2.' matches '7f5b2bea5000-7f5b2bea6000 rw-p 00022000 08:53 435526                     /usr/lib64/ld-2.17.so': Skipping.
#mm/memlock.c:296           munlock          4KiB 7f5b2bea6000 - 7f5b2bea7000 rw-p 00000000 00:00 0
#mm/memlock.c:296           munlock        132KiB 7ffed2282000 - 7ffed22a3000 rw-p 00000000 00:00 0                          [stack]
#mm/memlock.c:258           munlock ignore filter '[vdso]' matches '7ffed22ac000-7ffed22ae000 r-xp 00000000 00:00 0                          [vdso]': Skipping.
#mm/memlock.c:258           munlock ignore filter '[vsyscall]' matches 'ffffffffff600000-ffffffffff601000 r-xp 00000000 00:00 0                  [vsyscall]': Skipping.
#mm/memlock.c:382           Unlocked 27762688 bytes
#mm/memlock.c:502           Restoring original task priority 0.
#libdm-config.c:975         lock_type not found in config: defaulting to none
#locking/lvmlockd.c:173           lockd_result 0 flags none lm none
#metadata/pv_manip.c:417           /dev/mapper/mpatha 0:      0     64: lvmlock(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 1:     64      3: lvol0(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 2:     67      3: lvol1(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 3:     70    256: test(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 4:    326   3510: NULL(0:0)
#locking/locking.c:367           Dropping cache for global_lock.
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:0 locked:0 critical:0 daemon:0 suspended:0
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#format_text/format-text.c:682           Writing metadata for VG global_lock to /dev/mapper/mpatha at 170496 len 2096 (wrap 0)
#device/dev-io.c:609           Opened /dev/mapper/mpatha RO O_DIRECT
#device/dev-io.c:166           /dev/mapper/mpatha: Block size is 4096 bytes
#device/dev-io.c:177           /dev/mapper/mpatha: Physical block size is 512 bytes
#device/dev-io.c:658           Closed /dev/mapper/mpatha
#label/label.c:1277          Close and reopen to write /dev/mapper/mpatha
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#format_text/format-text.c:800           Pre-Committing global_lock metadata (94) to /dev/mapper/mpatha header at 4096
#device/dev-io.c:609           Opened /dev/mapper/mpatha RO O_DIRECT
#device/dev-io.c:166           /dev/mapper/mpatha: Block size is 4096 bytes
#device/dev-io.c:177           /dev/mapper/mpatha: Physical block size is 512 bytes
#device/dev-io.c:658           Closed /dev/mapper/mpatha
#device/bcache.c:211           Limit write at 0 len 131072 to len 4608
#metadata/vg.c:74            Allocated VG global_lock at 0x5593c105a740.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol0.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol1.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/test.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvmlock.
#format_text/import_vsn1.c:716           Logical volume global_lock/lvmlock is sanlock lv.
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#cache/lvmetad.c:1191          Sending lvmetad pending VG global_lock (seqno 94)
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#format_text/format-text.c:800           Committing global_lock metadata (94) to /dev/mapper/mpatha header at 4096
#device/dev-io.c:609           Opened /dev/mapper/mpatha RO O_DIRECT
#device/dev-io.c:166           /dev/mapper/mpatha: Block size is 4096 bytes
#device/dev-io.c:177           /dev/mapper/mpatha: Physical block size is 512 bytes
#device/dev-io.c:658           Closed /dev/mapper/mpatha
#device/bcache.c:211           Limit write at 0 len 131072 to len 4608
#locking/locking.c:367           Dropping cache for global_lock.
#metadata/vg.c:89            Freeing VG global_lock at 0x5593c1046720.
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:0 locked:0 critical:0 daemon:0 suspended:0
#format_text/archiver.c:576       Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 94).
#format_text/format-text.c:1009          Writing global_lock metadata to /etc/lvm/backup/.lvm_controller7327_238330_1874986752
#format_text/format-text.c:1028          Renaming /etc/lvm/backup/.lvm_controller7327_238330_1874986752 to /etc/lvm/backup/global_lock.tmp
#format_text/format-text.c:1053          Committing global_lock metadata (94)
#format_text/format-text.c:1054          Renaming /etc/lvm/backup/global_lock.tmp to /etc/lvm/backup/global_lock
#locking/lvmlockd.c:2089          lockd LV global_lock/test mode ex uuid Rz0Gld-2LnD-Z23e-3uVu-wksh-wvur-4KhuxB
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#locking/lvmlockd.c:267           lvmlockd lock_lv ex vg global_lock lv test result 0 0
#metadata/lv.c:1528      Activating logical volume global_lock/test.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ noopencount flush ]   [16384] (*1)
#activate/activate.c:1591        global_lock/test is not active
#locking/file_locking.c:100         Locking LV q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB (R)
#activate/activate.c:479       activation/volume_list configuration setting not defined: Checking only host tags for global_lock/test.
#activate/activate.c:2822          Activating global_lock/test noscan.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ noopencount flush ]   [16384] (*1)
#device/dev-io.c:396         /dev/mapper/mpatha: read_ahead is 256 sectors
#mm/memlock.c:626           Entering prioritized section (activating).
#mm/memlock.c:489           Raised task priority 0 -> -18.
#activate/dev_manager.c:3225          Creating ACTIVATE tree for global_lock/test.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-cow [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:2869          Adding new LV global_lock/test to dtree
#libdm-deptree.c:605           Not matched uuid LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB in deptree.
#libdm-deptree.c:605           Not matched uuid LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB in deptree.
#activate/dev_manager.c:2791          Checking kernel supports striped segment type for global_lock/test
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#metadata/metadata.c:2133          Calculated readahead of LV test is 256
#libdm-deptree.c:1945      Creating global_lock-test
#ioctl/libdm-iface.c:1857          dm create global_lock-test LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ noopencount flush ]   [16384] (*1)
#libdm-deptree.c:2701      Loading table for global_lock-test (253:12).
#libdm-deptree.c:2646          Adding target to (253:12): 0 2097152 linear 253:7 606200
#ioctl/libdm-iface.c:1857          dm table   (253:12) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm reload   (253:12) [ noopencount flush ]   [16384] (*1)
#libdm-deptree.c:2751          Table size changed from 0 to 2097152 for global_lock-test (253:12).
#libdm-deptree.c:1303      Resuming global_lock-test (253:12).
#libdm-common.c:2325          Udev cookie 0xd4d0c89 (semid 884738) incremented to 1
#libdm-common.c:2575          Udev cookie 0xd4d0c89 (semid 884738) assigned to RESUME task(5) with flags DISABLE_LIBRARY_FALLBACK SUBSYSTEM_0        (0x120)
#ioctl/libdm-iface.c:1857          dm resume   (253:12) [ noopencount flush ]   [16384] (*1)
#libdm-common.c:1484          global_lock-test: Stacking NODE_ADD (253,12) 0:6 0660 [trust_udev]
#libdm-common.c:1494          global_lock-test: Stacking NODE_READ_AHEAD 256 (flags=1)
#activate/dev_manager.c:3225          Creating CLEAN tree for global_lock/test.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:12) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-cow [ opencount flush ]   [16384] (*1)
#mm/memlock.c:638           Leaving section (activated).
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ noopencount flush ]   [16384] (*1)
#activate/activate.c:1591        global_lock/test is active locally
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:1 locked:0 critical:0 daemon:0 suspended:0
#mm/memlock.c:502           Restoring original task priority 0.
#activate/fs.c:491           Syncing device names
#libdm-common.c:2360          Udev cookie 0xd4d0c89 (semid 884738) decremented to 0
#libdm-common.c:2646          Udev cookie 0xd4d0c89 (semid 884738) waiting for zero
#libdm-common.c:2375          Udev cookie 0xd4d0c89 (semid 884738) destroyed
#libdm-common.c:1484          global_lock-lvmlock: Skipping NODE_ADD (253,9) 0:6 0660 [trust_udev]
#libdm-common.c:1494          global_lock-lvmlock: Processing NODE_READ_AHEAD 0 (flags=0)
#libdm-common.c:1298          global_lock-lvmlock (253:9): Setting read ahead to 0
#libdm-common.c:1484          global_lock-test: Skipping NODE_ADD (253,12) 0:6 0660 [trust_udev]
#libdm-common.c:1494          global_lock-test: Processing NODE_READ_AHEAD 256 (flags=1)
#libdm-common.c:1248          global_lock-test (253:12): read ahead is 256
#libdm-common.c:1373          global_lock-test: retaining kernel read ahead of 256 (requested 256)
#device/dev-cache.c:1520        /dev/global_lock/test: stat failed: 没有那个文件或目录
#device/dev-cache.c:1172        /dev/global_lock/test: stat failed: 没有那个文件或目录
#device/dev-cache.c:1212          Creating list of system devices.
#device/dev-cache.c:714           Found dev 8:80 /dev/sdf - exists.
#device/dev-cache.c:714           Found dev 8:80 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J - exists.
#device/dev-cache.c:714           Found dev 8:80 /dev/disk/by-id/wwn-0x55cd2e414eef4781 - exists.
#device/dev-cache.c:714           Found dev 8:80 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0 - exists.
#device/dev-cache.c:714           Found dev 8:81 /dev/sdf1 - exists.
#device/dev-cache.c:714           Found dev 8:81 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part1 - exists.
#device/dev-cache.c:714           Found dev 8:81 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part1 - exists.
#device/dev-cache.c:714           Found dev 8:81 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part1 - exists.
#device/dev-cache.c:714           Found dev 8:81 /dev/disk/by-uuid/09ecd057-6e58-478a-b2fd-67f07de840ba - exists.
#device/dev-cache.c:714           Found dev 8:82 /dev/sdf2 - exists.
#device/dev-cache.c:714           Found dev 8:82 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part2 - exists.
#device/dev-cache.c:714           Found dev 8:82 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part2 - exists.
#device/dev-cache.c:714           Found dev 8:82 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part2 - exists.
#device/dev-cache.c:714           Found dev 8:82 /dev/disk/by-uuid/4473f19b-1b50-44e2-a392-ffbf663496c2 - exists.
#device/dev-cache.c:714           Found dev 8:83 /dev/sdf3 - exists.
#device/dev-cache.c:714           Found dev 8:83 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part3 - exists.
#device/dev-cache.c:714           Found dev 8:83 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part3 - exists.
#device/dev-cache.c:714           Found dev 8:83 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part3 - exists.
#device/dev-cache.c:714           Found dev 8:83 /dev/disk/by-uuid/5a8f61b5-0abe-4383-a56f-ca589ae97264 - exists.
#device/dev-cache.c:714           Found dev 8:84 /dev/sdf4 - exists.
#device/dev-cache.c:714           Found dev 8:84 /dev/disk/by-id/ata-INTEL_SSDSCKKI256G8_BTLA75221P58256J-part4 - exists.
#device/dev-cache.c:714           Found dev 8:84 /dev/disk/by-id/lvm-pv-uuid-FVB0r4-2UhB-4ExV-xJpj-8zwV-8dp2-FPdrfO - exists.
#device/dev-cache.c:714           Found dev 8:84 /dev/disk/by-id/wwn-0x55cd2e414eef4781-part4 - exists.
#device/dev-cache.c:714           Found dev 8:84 /dev/disk/by-path/pci-0000:00:11.5-ata-1.0-part4 - exists.
#device/dev-cache.c:714           Found dev 8:0 /dev/sda - exists.
#device/dev-cache.c:714           Found dev 8:0 /dev/disk/by-id/ata-INTEL_SSDSC2KG480G7_BTYM7406017Y480BGN - exists.
#device/dev-cache.c:714           Found dev 8:0 /dev/disk/by-id/lvm-pv-uuid-XflkxS-jQ0b-AxF7-d5WY-WuTT-icUL-9TXNW3 - exists.
#device/dev-cache.c:714           Found dev 8:0 /dev/disk/by-id/wwn-0x55cd2e414ec103a2 - exists.
#device/dev-cache.c:714           Found dev 8:0 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6874-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:0 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy4-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:16 /dev/sdb - exists.
#device/dev-cache.c:714           Found dev 8:16 /dev/disk/by-id/scsi-350000398c88383d9 - exists.
#device/dev-cache.c:714           Found dev 8:16 /dev/disk/by-id/wwn-0x50000398c88383d9 - exists.
#device/dev-cache.c:714           Found dev 8:16 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c88383da-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:16 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy6-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/sdb1 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/disk/by-id/scsi-350000398c88383d9-part1 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/disk/by-id/wwn-0x50000398c88383d9-part1 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/disk/by-partuuid/95282417-6039-40bf-a22e-4676b0fa73c7 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c88383da-lun-0-part1 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy6-lun-0-part1 - exists.
#device/dev-cache.c:714           Found dev 8:17 /dev/disk/by-uuid/bf5f2488-7889-49f1-af24-4966a86f283c - exists.
#device/dev-cache.c:714           Found dev 8:18 /dev/sdb2 - exists.
#device/dev-cache.c:714           Found dev 8:18 /dev/disk/by-id/scsi-350000398c88383d9-part2 - exists.
#device/dev-cache.c:714           Found dev 8:18 /dev/disk/by-id/wwn-0x50000398c88383d9-part2 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-label/MaxtaPool-1 - exists.
#device/dev-cache.c:714           Found dev 8:18 /dev/disk/by-partuuid/76d20f27-d755-4b3b-9f71-9a5c03549b6a - exists.
#device/dev-cache.c:714           Found dev 8:18 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c88383da-lun-0-part2 - exists.
#device/dev-cache.c:714           Found dev 8:18 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy6-lun-0-part2 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-uuid/8116647707660763715 - exists.
#device/dev-cache.c:714           Found dev 8:32 /dev/sdc - exists.
#device/dev-cache.c:714           Found dev 8:32 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN - exists.
#device/dev-cache.c:714           Found dev 8:32 /dev/disk/by-id/wwn-0x55cd2e4150dccba0 - exists.
#device/dev-cache.c:714           Found dev 8:32 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:32 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/sdc1 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part1 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part1 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/disk/by-partuuid/7c56fd01-7f36-4529-867a-520e4f01a943 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part1 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part1 - exists.
#device/dev-cache.c:714           Found dev 8:33 /dev/disk/by-uuid/8a8cedd5-2ecf-4d53-afcc-8075fe6c2c67 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/sdc2 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part2 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part2 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-label/ResourcePool - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-partuuid/a84f6375-0e17-42af-9ab2-e95d9ea82af9 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part2 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part2 - exists.
#device/dev-cache.c:714           Found dev 8:34 /dev/disk/by-uuid/5880381756353009591 - exists.
#device/dev-cache.c:714           Found dev 8:35 /dev/sdc3 - exists.
#device/dev-cache.c:714           Found dev 8:35 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part3 - exists.
#device/dev-cache.c:714           Found dev 8:35 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part3 - exists.
#device/dev-cache.c:714           Found dev 8:35 /dev/disk/by-partuuid/4fcfb395-568b-403e-b9ce-5de1e388b0f5 - exists.
#device/dev-cache.c:714           Found dev 8:35 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part3 - exists.
#device/dev-cache.c:714           Found dev 8:35 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part3 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/sdc4 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part4 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part4 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-label/MaxtaPool-1 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-partuuid/6805acd5-74e2-47f4-b2f7-0a56b0ce87a3 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part4 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part4 - exists.
#device/dev-cache.c:714           Found dev 8:36 /dev/disk/by-uuid/8116647707660763715 - exists.
#device/dev-cache.c:714           Found dev 8:37 /dev/sdc5 - exists.
#device/dev-cache.c:714           Found dev 8:37 /dev/disk/by-id/ata-INTEL_SSDSC2KB480G8_PHYF918200CD480BGN-part5 - exists.
#device/dev-cache.c:714           Found dev 8:37 /dev/disk/by-id/wwn-0x55cd2e4150dccba0-part5 - exists.
#device/dev-cache.c:714           Found dev 8:37 /dev/disk/by-partuuid/76dfcd81-d676-4ebe-ac74-85ee1e56958b - exists.
#device/dev-cache.c:714           Found dev 8:37 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x30016360029a6877-lun-0-part5 - exists.
#device/dev-cache.c:714           Found dev 8:37 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy7-lun-0-part5 - exists.
#device/dev-cache.c:714           Found dev 8:48 /dev/sdd - exists.
#device/dev-cache.c:714           Found dev 8:48 /dev/disk/by-id/lvm-pv-uuid-g1sv0r-feqn-rBBY-cRH7-H1fc-DdF0-43hAYm - exists.
#device/dev-cache.c:714           Found dev 8:48 /dev/disk/by-id/scsi-350000398c8838e79 - exists.
#device/dev-cache.c:714           Found dev 8:48 /dev/disk/by-id/wwn-0x50000398c8838e79 - exists.
#device/dev-cache.c:714           Found dev 8:48 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c8838e7a-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:48 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy8-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:64 /dev/sde - exists.
#device/dev-cache.c:714           Found dev 8:64 /dev/disk/by-id/scsi-350000398c8838d8d - exists.
#device/dev-cache.c:714           Found dev 8:64 /dev/disk/by-id/wwn-0x50000398c8838d8d - exists.
#device/dev-cache.c:714           Found dev 8:64 /dev/disk/by-path/pci-0000:5e:00.0-sas-0x50000398c8838d8e-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:64 /dev/disk/by-path/pci-0000:5e:00.0-sas-phy9-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/sdh - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-id/scsi-36001405ab294643ad8c48e0ad84b6764 - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-id/wwn-0x6001405ab294643ad8c48e0ad84b6764 - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-path/ip-10.10.1.20:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:144 /dev/sdj - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-id/scsi-36001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-id/wwn-0x6001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:714           Found dev 8:144 /dev/disk/by-path/ip-10.10.1.20:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-1 - exists.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-uuid/6a5c7194-c7bf-4a62-8f30-193dab500dd9 - exists.
#device/dev-cache.c:714           Found dev 8:96 /dev/sdg - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-id/scsi-36001405ab294643ad8c48e0ad84b6764 - exists.
#device/dev-cache.c:714           Found dev 8:112 /dev/disk/by-id/wwn-0x6001405ab294643ad8c48e0ad84b6764 - exists.
#device/dev-cache.c:714           Found dev 8:96 /dev/disk/by-path/ip-10.10.1.21:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-0 - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/sdi - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-id/scsi-36001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-id/wwn-0x6001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:714           Found dev 8:128 /dev/disk/by-path/ip-10.10.1.21:3260-iscsi-iqn.2021-05.com.archeros518:iscsi-lun-1 - exists.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-uuid/6a5c7194-c7bf-4a62-8f30-193dab500dd9 - exists.
#device/dev-cache.c:714           Found dev 253:0 /dev/dm-0 - exists.
#device/dev-cache.c:714           Found dev 253:0 /dev/controller7327SSD/controller7327SSD - exists.
#device/dev-cache.c:714           Found dev 253:0 /dev/disk/by-id/dm-name-controller7327SSD-controller7327SSD - exists.
#device/dev-cache.c:714           Found dev 253:0 /dev/disk/by-id/dm-uuid-LVM-G5V44lTN6cQRhGRbr8isoFHtC1P6XTy1joICKgH7pn1iUfeKGn4SoVMVkf7fYaeq - exists.
#device/dev-cache.c:714           Found dev 253:0 /dev/disk/by-uuid/c1953979-49a0-4369-8872-9aada27f0a2f - exists.
#device/dev-cache.c:714           Found dev 253:0 /dev/mapper/controller7327SSD-controller7327SSD - exists.
#device/dev-cache.c:714           Found dev 253:1 /dev/dm-1 - exists.
#device/dev-cache.c:714           Found dev 253:1 /dev/controller7327HDD/controller7327HDD - exists.
#device/dev-cache.c:714           Found dev 253:1 /dev/disk/by-id/dm-name-controller7327HDD-controller7327HDD - exists.
#device/dev-cache.c:714           Found dev 253:1 /dev/disk/by-id/dm-uuid-LVM-1bTHwygy4bA32M4nug0EwH9sSJ1QfTuwtfSCgU323BhCCk2gidr304wA1TStMuiF - exists.
#device/dev-cache.c:714           Found dev 253:1 /dev/disk/by-uuid/9520a7a9-8052-4c2b-9377-adf2126297b1 - exists.
#device/dev-cache.c:714           Found dev 253:1 /dev/mapper/controller7327HDD-controller7327HDD - exists.
#device/dev-cache.c:714           Found dev 253:10 /dev/dm-10 - exists.
#device/dev-cache.c:714           Found dev 253:10 /dev/disk/by-id/dm-name-global_lock-lvol0 - exists.
#device/dev-cache.c:714           Found dev 253:10 /dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIiacIrc0zdJxFeYVinn27ndV3CeBoEi16 - exists.
#device/dev-cache.c:714           Found dev 253:10 /dev/global_lock/lvol0 - exists.
#device/dev-cache.c:714           Found dev 253:10 /dev/mapper/global_lock-lvol0 - exists.
#device/dev-cache.c:714           Found dev 253:11 /dev/dm-11 - exists.
#device/dev-cache.c:714           Found dev 253:11 /dev/disk/by-id/dm-name-global_lock-lvol1 - exists.
#device/dev-cache.c:714           Found dev 253:11 /dev/disk/by-id/dm-uuid-LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEI6iPd9KyS6swCkaL8Il6qif8qdHiMQ3Bb - exists.
#device/dev-cache.c:714           Found dev 253:11 /dev/global_lock/lvol1 - exists.
#device/dev-cache.c:714           Found dev 253:11 /dev/mapper/global_lock-lvol1 - exists.
#device/dev-cache.c:723           Found dev 253:12 /dev/dm-12 - new.
#device/dev-cache.c:714           Found dev 253:2 /dev/dm-2 - exists.
#device/dev-cache.c:714           Found dev 253:2 /dev/data/datastore1 - exists.
#device/dev-cache.c:714           Found dev 253:2 /dev/disk/by-id/dm-name-data-datastore1 - exists.
#device/dev-cache.c:714           Found dev 253:2 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvbMl3q8RBEm9vAs87jPhqf3kkmMV6x7Hw - exists.
#device/dev-cache.c:714           Found dev 253:2 /dev/disk/by-uuid/d57cea48-80c2-4837-bec2-3bb974360375 - exists.
#device/dev-cache.c:714           Found dev 253:2 /dev/mapper/data-datastore1 - exists.
#device/dev-cache.c:714           Found dev 253:3 /dev/dm-3 - exists.
#device/dev-cache.c:714           Found dev 253:3 /dev/data/datastore2 - exists.
#device/dev-cache.c:714           Found dev 253:3 /dev/disk/by-id/dm-name-data-datastore2 - exists.
#device/dev-cache.c:714           Found dev 253:3 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvarj9VZi2K7gz9OKF2W3yLFOdEgbjdoYe - exists.
#device/dev-cache.c:714           Found dev 253:3 /dev/disk/by-uuid/fafe234b-1942-4b49-918f-32eb82f296b8 - exists.
#device/dev-cache.c:714           Found dev 253:3 /dev/mapper/data-datastore2 - exists.
#device/dev-cache.c:714           Found dev 253:4 /dev/dm-4 - exists.
#device/dev-cache.c:714           Found dev 253:4 /dev/data/backup - exists.
#device/dev-cache.c:714           Found dev 253:4 /dev/disk/by-id/dm-name-data-backup - exists.
#device/dev-cache.c:714           Found dev 253:4 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvBa4TXU9QTFauK4subGzCbd9tSwRIiB9f - exists.
#device/dev-cache.c:714           Found dev 253:4 /dev/disk/by-uuid/9454ff20-1e1a-4724-ac84-9460c3590dd1 - exists.
#device/dev-cache.c:714           Found dev 253:4 /dev/mapper/data-backup - exists.
#device/dev-cache.c:714           Found dev 253:5 /dev/dm-5 - exists.
#device/dev-cache.c:714           Found dev 253:5 /dev/data/arstore - exists.
#device/dev-cache.c:714           Found dev 253:5 /dev/disk/by-id/dm-name-data-arstore - exists.
#device/dev-cache.c:714           Found dev 253:5 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvhn7B0UUuIv3k7WWiGh3ajokkiu8fpqWx - exists.
#device/dev-cache.c:714           Found dev 253:5 /dev/disk/by-uuid/0673f76d-9811-42c2-9418-b37fb993d93d - exists.
#device/dev-cache.c:714           Found dev 253:5 /dev/mapper/data-arstore - exists.
#device/dev-cache.c:714           Found dev 253:6 /dev/dm-6 - exists.
#device/dev-cache.c:714           Found dev 253:6 /dev/data/log - exists.
#device/dev-cache.c:714           Found dev 253:6 /dev/disk/by-id/dm-name-data-log - exists.
#device/dev-cache.c:714           Found dev 253:6 /dev/disk/by-id/dm-uuid-LVM-xkPE62uYh7QWjLzMv3fJ2P4G2pbYU8xvuwl3wSsdIYhKnKtnsQaNVJPJYHdRC3by - exists.
#device/dev-cache.c:714           Found dev 253:6 /dev/disk/by-uuid/31ee50e4-e6e7-4a76-9c6e-d59044580376 - exists.
#device/dev-cache.c:714           Found dev 253:6 /dev/mapper/data-log - exists.
#device/dev-cache.c:714           Found dev 253:7 /dev/dm-7 - exists. FW5S4kGi
#device/dev-cache.c:714           Found dev 253:7 /dev/disk/by-id/dm-name-mpatha - exists. FW5S4kGi
#device/dev-cache.c:714           Found dev 253:7 /dev/disk/by-id/dm-uuid-mpath-36001405ab294643ad8c48e0ad84b6764 - exists. FW5S4kGi
#device/dev-cache.c:714           Found dev 253:7 /dev/disk/by-id/lvm-pv-uuid-FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV - exists. FW5S4kGi
#device/dev-cache.c:714           Found dev 253:7 /dev/mapper/mpatha - exists. FW5S4kGi
#device/dev-cache.c:714           Found dev 253:8 /dev/dm-8 - exists.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-id/dm-name-mpathb - exists.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-id/dm-uuid-mpath-36001405b064c1b59a35487f805012807 - exists.
#device/dev-cache.c:714           Found dev 253:8 /dev/disk/by-uuid/6a5c7194-c7bf-4a62-8f30-193dab500dd9 - exists.
#device/dev-cache.c:714           Found dev 253:8 /dev/mapper/mpathb - exists.
#device/dev-cache.c:714           Found dev 253:9 /dev/dm-9 - exists.
#device/dev-cache.c:714           Found dev 253:9 /dev/mapper/global_lock-lvmlock - exists.
#metadata/lv_manip.c:7185    /dev/global_lock/test: not found: device not cleared
#metadata/lv_manip.c:7933    Aborting. Failed to wipe start of new LV.
#locking/file_locking.c:95          Locking LV q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB (NL)
#activate/activate.c:2652          Deactivating global_lock/test.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ noopencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ opencount flush ]   [16384] (*1)
#activate/activate.c:901           Retrying open_count check for global_lock/test.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ opencount flush ]   [16384] (*1)
#mm/memlock.c:626           Entering prioritized section (deactivating).
#mm/memlock.c:489           Raised task priority 0 -> -18.
#activate/dev_manager.c:3225          Creating DEACTIVATE tree for global_lock/test.
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:12) [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm deps   (253:7) [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test-real [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-real].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-real [ opencount flush ]   [16384] (*1)
#activate/dev_manager.c:779           Getting device info for global_lock-test-cow [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-cow].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB-cow [ opencount flush ]   [16384] (*1)
#ioctl/libdm-iface.c:1857          dm info   (253:12) [ opencount flush ]   [16384] (*1)
#libdm-deptree.c:994       Removing global_lock-test (253:12)
#libdm-common.c:2433          Udev cookie 0xd4d77c0 (semid 917506) created
#libdm-common.c:2453          Udev cookie 0xd4d77c0 (semid 917506) incremented to 1
#libdm-common.c:2325          Udev cookie 0xd4d77c0 (semid 917506) incremented to 2
#libdm-common.c:2575          Udev cookie 0xd4d77c0 (semid 917506) assigned to REMOVE task(2) with flags DISABLE_LIBRARY_FALLBACK         (0x20)
#ioctl/libdm-iface.c:1857          dm remove   (253:12) [ noopencount flush retryremove ]   [16384] (*1)
#libdm-common.c:1487          global_lock-test: Stacking NODE_DEL [trust_udev]
#mm/memlock.c:638           Leaving section (deactivated).
#activate/dev_manager.c:779           Getting device info for global_lock-test [LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB].
#ioctl/libdm-iface.c:1857          dm info  LVM-q6gcmHe3b1uCK1O5pXBjuKyL6nxY4EEIRz0Gld2LnDZ23e3uVuwkshwvur4KhuxB [ noopencount flush ]   [16384] (*1)
#locking/lvmlockd.c:2089          lockd LV global_lock/test mode un uuid Rz0Gld-2LnD-Z23e-3uVu-wksh-wvur-4KhuxB
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#locking/lvmlockd.c:267           lvmlockd lock_lv un vg global_lock lv test result 0 0
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#metadata/pv_manip.c:417           /dev/mapper/mpatha 0:      0     64: lvmlock(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 1:     64      3: lvol0(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 2:     67      3: lvol1(0:0)
#metadata/pv_manip.c:417           /dev/mapper/mpatha 3:     70   3766: NULL(0:0)
#locking/locking.c:367           Dropping cache for global_lock.
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:1 locked:0 critical:0 daemon:0 suspended:0
#mm/memlock.c:502           Restoring original task priority 0.
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#format_text/format-text.c:682           Writing metadata for VG global_lock to /dev/mapper/mpatha at 173056 len 1769 (wrap 0)
#device/dev-io.c:609           Opened /dev/mapper/mpatha RO O_DIRECT
#device/dev-io.c:166           /dev/mapper/mpatha: Block size is 4096 bytes
#device/dev-io.c:177           /dev/mapper/mpatha: Physical block size is 512 bytes
#device/dev-io.c:658           Closed /dev/mapper/mpatha
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#format_text/format-text.c:800           Pre-Committing global_lock metadata (95) to /dev/mapper/mpatha header at 4096
#device/dev-io.c:609           Opened /dev/mapper/mpatha RO O_DIRECT
#device/dev-io.c:166           /dev/mapper/mpatha: Block size is 4096 bytes
#device/dev-io.c:177           /dev/mapper/mpatha: Physical block size is 512 bytes
#device/dev-io.c:658           Closed /dev/mapper/mpatha
#device/bcache.c:211           Limit write at 0 len 131072 to len 4608
#metadata/vg.c:74            Allocated VG global_lock at 0x5593c105e750.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol0.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvol1.
#format_text/import_vsn1.c:591           Importing logical volume global_lock/lvmlock.
#format_text/import_vsn1.c:716           Logical volume global_lock/lvmlock is sanlock lv.
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#cache/lvmetad.c:1191          Sending lvmetad pending VG global_lock (seqno 95)
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#format_text/format-text.c:800           Committing global_lock metadata (95) to /dev/mapper/mpatha header at 4096
#device/dev-io.c:609           Opened /dev/mapper/mpatha RO O_DIRECT
#device/dev-io.c:166           /dev/mapper/mpatha: Block size is 4096 bytes
#device/dev-io.c:177           /dev/mapper/mpatha: Physical block size is 512 bytes
#device/dev-io.c:658           Closed /dev/mapper/mpatha
#device/bcache.c:211           Limit write at 0 len 131072 to len 4608
#locking/locking.c:367           Dropping cache for global_lock.
#metadata/vg.c:89            Freeing VG global_lock at 0x5593c105a740.
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:0 locked:0 critical:0 daemon:0 suspended:0
#format_text/archiver.c:576       Creating volume group backup "/etc/lvm/backup/global_lock" (seqno 95).
#format_text/format-text.c:1009          Writing global_lock metadata to /etc/lvm/backup/.lvm_controller7327_238330_1823450570
#format_text/format-text.c:1028          Renaming /etc/lvm/backup/.lvm_controller7327_238330_1823450570 to /etc/lvm/backup/global_lock.tmp
#format_text/format-text.c:1053          Committing global_lock metadata (95)
#format_text/format-text.c:1054          Renaming /etc/lvm/backup/global_lock.tmp to /etc/lvm/backup/global_lock
#metadata/lv_manip.c:8109          <backtrace>
#lvcreate.c:1658          <backtrace>
#toollib.c:2039          <backtrace>
#cache/lvmetad.c:1253          Sending lvmetad updated VG global_lock (seqno 95)
#format_text/format-text.c:331           Reading mda header sector from /dev/mapper/mpatha at 4096
#cache/lvmetad.c:1680          Telling lvmetad to store PV /dev/mapper/mpatha (FW5S4k-GiVY-XCFQ-iNjG-iIt7-xOp4-TBYBkV)
#mm/memlock.c:594           Unlock: Memlock counters: prioritized:0 locked:0 critical:0 daemon:0 suspended:0
#activate/fs.c:491           Syncing device names
#libdm-common.c:2348    semid 917506: semop failed for cookie 0xd4d77c0: incorrect semaphore state
#libdm-common.c:2640    Failed to set a proper state for notification semaphore identified by cookie value 223180736 (0xd4d77c0) to initialize waiting for incoming notifications.
#libdm-common.c:2375          Udev cookie 0xd4d77c0 (semid 917506) destroyed
#libdm-common.c:1487          global_lock-test: Skipping NODE_DEL [trust_udev]
#activate/fs.c:494           <backtrace>
#locking/locking.c:367           Dropping cache for global_lock.
#misc/lvm-flock.c:70          Unlocking /run/lock/lvm/V_global_lock
#misc/lvm-flock.c:47            _undo_flock /run/lock/lvm/V_global_lock
#metadata/vg.c:89            Freeing VG global_lock at 0x5593c105e750.
#metadata/vg.c:89            Freeing VG global_lock at 0x5593c1042710.
#locking/lvmlockd.c:1819          lockd VG global_lock mode un
#locking/lvmlockd.c:173           lockd_result 0 flags none lm sanlock
#locking/lvmlockd.c:284           lvmlockd lock_vg un vg global_lock result 0 0
#daemon-client.c:179           Closing daemon socket (fd 4).
#cache/lvmcache.c:2539          Dropping VG info
#cache/lvmcache.c:755           lvmcache has no info for vgname "#orphans_lvm1" with VGID #orphans_lvm1.
#cache/lvmcache.c:755           lvmcache has no info for vgname "#orphans_lvm1".
#cache/lvmcache.c:2086          lvmcache: Initialised VG #orphans_lvm1.
#cache/lvmcache.c:755           lvmcache has no info for vgname "#orphans_pool" with VGID #orphans_pool.
#cache/lvmcache.c:755           lvmcache has no info for vgname "#orphans_pool".
#cache/lvmcache.c:2086          lvmcache: Initialised VG #orphans_pool.
#cache/lvmcache.c:755           lvmcache has no info for vgname "#orphans_lvm2" with VGID #orphans_lvm2.
#cache/lvmcache.c:755           lvmcache has no info for vgname "#orphans_lvm2".
#cache/lvmcache.c:2086          lvmcache: Initialised VG #orphans_lvm2.
#lvmcmdline.c:3050          Completed: lvcreate --name test --size 1g global_lock -vvvv
prajnoha commented 3 years ago

Thanks for the logs! This sequence looks wrong:

#libdm-deptree.c:1303      Resuming global_lock-lvmlock (253:9).
#libdm-common.c:2433          Udev cookie 0xd4d0c89 (semid 884738) created                                                                                                                                                                                                                                                     
#libdm-common.c:2453          Udev cookie 0xd4d0c89 (semid 884738) incremented to 1
#libdm-common.c:2325          Udev cookie 0xd4d0c89 (semid 884738) incremented to 2
#libdm-common.c:2575          Udev cookie 0xd4d0c89 (semid 884738) assigned to RESUME task(5) with flags DISABLE_SUBSYSTEM_RULES DISABLE_DISK_RULES DISABLE_OTHER_RULES DISABLE_LIBRARY_FALLBACK         (0x2e)
...
#libdm-deptree.c:1303      Resuming global_lock-test (253:12). 
#libdm-common.c:2325          Udev cookie 0xd4d0c89 (semid 884738) incremented to 1                                                                                                                                                                                                                                            
#libdm-common.c:2575          Udev cookie 0xd4d0c89 (semid 884738) assigned to RESUME task(5) with flags DISABLE_LIBRARY_FALLBACK SUBSYSTEM_0        (0x120)
...
#activate/fs.c:491           Syncing device names                                
#libdm-common.c:2360          Udev cookie 0xd4d0c89 (semid 884738) decremented to 0
#libdm-common.c:2646          Udev cookie 0xd4d0c89 (semid 884738) waiting for zero
#libdm-common.c:2375          Udev cookie 0xd4d0c89 (semid 884738) destroyed

We're reusing the same cookie for synchronizing with udev (that's OK), but the counters are wrong and this sequence must have happened:

This is also confirmed by udev logs where we can see:

6月 03 21:33:41 controller7327 systemd-udevd[54052]: starting '/usr/sbin/dmsetup udevcomplete 23085533'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533'(err) 'Could not find notification semaphore identified by cookie value 223166941 (0xd4d41dd)'                                                                                                                                   
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533'(err) 'Command failed.'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533' [54052] exit with return code 1

So at the time the udev on host tries to notify about this uevent, the synchronization cookie is already gone (because of the incorrect counting as noted above).

In summary, there must have been the /usr/lib/udev/rules.d/95-dm-notify.rules processed twice for the same uevent. You mentioned the container and that switching it off made the lvcreate working again. So I think this is the usual case where the container tries to incorrectly react to uevents and so we end up processing uevents/udev rules in both the host and the container for a single uevent - that should be processed only on host - uevents are global, not namespaced. The container is interfering.

ncist2011 commented 3 years ago

Thanks for the logs! This sequence looks wrong:

#libdm-deptree.c:1303      Resuming global_lock-lvmlock (253:9).
#libdm-common.c:2433          Udev cookie 0xd4d0c89 (semid 884738) created                                                                                                                                                                                                                                                     
#libdm-common.c:2453          Udev cookie 0xd4d0c89 (semid 884738) incremented to 1
#libdm-common.c:2325          Udev cookie 0xd4d0c89 (semid 884738) incremented to 2
#libdm-common.c:2575          Udev cookie 0xd4d0c89 (semid 884738) assigned to RESUME task(5) with flags DISABLE_SUBSYSTEM_RULES DISABLE_DISK_RULES DISABLE_OTHER_RULES DISABLE_LIBRARY_FALLBACK         (0x2e)
...
#libdm-deptree.c:1303      Resuming global_lock-test (253:12). 
#libdm-common.c:2325          Udev cookie 0xd4d0c89 (semid 884738) incremented to 1                                                                                                                                                                                                                                            
#libdm-common.c:2575          Udev cookie 0xd4d0c89 (semid 884738) assigned to RESUME task(5) with flags DISABLE_LIBRARY_FALLBACK SUBSYSTEM_0        (0x120)
...
#activate/fs.c:491           Syncing device names                                
#libdm-common.c:2360          Udev cookie 0xd4d0c89 (semid 884738) decremented to 0
#libdm-common.c:2646          Udev cookie 0xd4d0c89 (semid 884738) waiting for zero
#libdm-common.c:2375          Udev cookie 0xd4d0c89 (semid 884738) destroyed

We're reusing the same cookie for synchronizing with udev (that's OK), but the counters are wrong and this sequence must have happened:

  • inc to 1 (for cookie initialization) - OK
  • inc to 2 (expecting one event for RESUME of global_lock-lvmlock internal LV - OK
  • dec to 1 (notified about RESUME processed in udev) - OK
  • dec to 0 (notified again about the same RESUME processed in udev) - !!!WRONG!!!
  • inc to 1 (expecting one event for RESUME of global_lock-test LV (should have been 2 here)
  • dec to 0 (for preparing the cookie for waiting for notification) (should have been 2 or 1 here, depending on whether the notification from udev already came or not)
  • waiting for 0 BUT we're already at 0 so we immediately continue with processing, even though the udev rules processing is not fully finished and hence the /dev/global_lock/test device symlink is missing (with verify_udev_operations = 1 LVM will create the missing symlink, but this is not 100% correct approach because in that case we can get into problem with udev database readers where the info about the symlink might be still missing right after we finish the lvcreate - so the verify_udev_operations=1 is more of a debug/last resort/rescue option; the udev machinery should be working fully instead).

This is also confirmed by udev logs where we can see:

6月 03 21:33:41 controller7327 systemd-udevd[54052]: starting '/usr/sbin/dmsetup udevcomplete 23085533'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533'(err) 'Could not find notification semaphore identified by cookie value 223166941 (0xd4d41dd)'                                                                                                                                   
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533'(err) 'Command failed.'
6月 03 21:33:41 controller7327 systemd-udevd[54030]: '/usr/sbin/dmsetup udevcomplete 23085533' [54052] exit with return code 1

So at the time the udev on host tries to notify about this uevent, the synchronization cookie is already gone (because of the incorrect counting as noted above).

In summary, there must have been the /usr/lib/udev/rules.d/95-dm-notify.rules processed twice for the same uevent. You mentioned the container and that switching it off made the lvcreate working again. So I think this is the usual case where the container tries to incorrectly react to uevents and so we end up processing uevents/udev rules in both the host and the container for a single uevent - that should be processed only on host - uevents are global, not namespaced. The container is interfering.

The container is interfering. Service systemd-udevd is running in container, lvcreate works well if i stop this service.

Thank you.

zkabelac commented 3 years ago

lvm2 does NOT support usage witin containers WITH udev - this is not going to fly.

Usage of lvm2 within container requirers serious deep level knowledge about how things works together.

Sorry - closing this issue - as there is no good fix - user can play with things like disabling 'udev' for such lvm2 - but this still leave a lot of troubles ahead of such user.