[LU-6814] conf-sanity test 23b hangs on unmount

• Type: Bug
• Resolution: Duplicate
• Priority: Minor
• Affects Version/s: Lustre 2.8.0
• Labels: zfs
• Environment: review-zfs-part-2
• Severity: 3
• Assignee: WC Triage
• Reporter: James Nunez (Inactive)

Description

conf-sanity test 23b hangs on unmount. Logs for this failure are at https://testing.hpdd.intel.com/test_sets/94b549e8-24be-11e5-8427-5254006e85c2

From the MDS1 console:

11:42:59:Lustre: DEBUG MARKER: == conf-sanity test 23b: Simulate -EINTR during mount == 11:42:03 (1436269323)
11:42:59:Lustre: DEBUG MARKER: mkdir -p /mnt/mds1
11:42:59:Lustre: DEBUG MARKER: zpool list -H lustre-mdt1 >/dev/null 2>&1 ||
11:42:59:			zpool import -f -o cachefile=none -d /dev/lvm-Role_MDS lustre-mdt1
11:42:59:Lustre: DEBUG MARKER: mkdir -p /mnt/mds1; mount -t lustre   		                   lustre-mdt1/mdt1 /mnt/mds1
11:42:59:Lustre: DEBUG MARKER: PATH=/usr/lib64/lustre/tests:/usr/lib/lustre/tests:/usr/lib64/lustre/tests:/opt/iozone/bin:/usr/lib64/lustre/tests//usr/lib64/lustre/tests:/usr/lib64/lustre/tests:/usr/lib64/lustre/tests/../utils:/opt/iozone/bin:/usr/lib64/lustre/tests/mpi:/usr/lib64/lust
11:42:59:Lustre: DEBUG MARKER: lctl set_param -n mdt.lustre*.enable_remote_dir=1
11:42:59:Lustre: DEBUG MARKER: zfs get -H -o value lustre:svname 		                           lustre-mdt1/mdt1 2>/dev/null
11:42:59:Lustre: DEBUG MARKER: lctl set_param -n mdt.lustre*.enable_remote_dir=1
11:42:59:Lustre: DEBUG MARKER: grep -c /mnt/mds1' ' /proc/mounts
11:42:59:Lustre: DEBUG MARKER: umount -d -f /mnt/mds1
11:42:59:general protection fault: 0000 [#1] SMP 
11:42:59:last sysfs file: /sys/devices/system/cpu/online
11:42:59:CPU 0 
11:42:59:Modules linked in: osp(U) mdd(U) lod(U) mdt(U) lfsck(U) mgs(U) mgc(U) osd_zfs(U) lquota(U) lustre(U) lov(U) mdc(U) fid(U) lmv(U) fld(U) ksocklnd(U) ptlrpc(U) obdclass(U) lnet(U) sha512_generic libcfs(U) nfsd exportfs nfs lockd fscache auth_rpcgss nfs_acl sunrpc ib_ipoib rdma_ucm ib_ucm ib_uverbs ib_umad rdma_cm ib_cm iw_cm ib_sa ib_mad ib_core ib_addr ipv6 zfs(P)(U) zcommon(P)(U) znvpair(P)(U) spl(U) zlib_deflate zavl(P)(U) zunicode(P)(U) microcode virtio_balloon i2c_piix4 i2c_core 8139too 8139cp mii ext3 jbd mbcache virtio_blk virtio_pci virtio_ring virtio pata_acpi ata_generic ata_piix dm_mirror dm_region_hash dm_log dm_mod [last unloaded: speedstep_lib]
11:42:59:
11:42:59:Pid: 1210, comm: tx_commit_cb/0 Tainted: P           ---------------    2.6.32-504.23.4.el6_lustre.g2382eb0.x86_64 #1 Red Hat KVM
11:42:59:RIP: 0010:[<ffffffffa086bff0>]  [<ffffffffa086bff0>] dt_txn_hook_commit+0x40/0x60 [obdclass]
11:42:59:RSP: 0018:ffff8800736efd80  EFLAGS: 00010206
11:42:59:RAX: 5a5a5a5a5a5a5a5a RBX: ffff88007b82b3f8 RCX: ffff88007b1ac000
11:42:59:RDX: ffff88007b1ac048 RSI: 5a5a5a5a5a5a5a5a RDI: ffff88006dd21200
11:42:59:RBP: ffff8800736efd90 R08: 20737365636f7250 R09: 0a64657265746e65
11:42:59:R10: 20737365636f7250 R11: 0a64657265746e65 R12: ffff88006dd21200
11:42:59:R13: ffff88007b1ac000 R14: 0000000000000000 R15: ffff88006dd21250
11:42:59:FS:  0000000000000000(0000) GS:ffff880002200000(0000) knlGS:0000000000000000
11:42:59:CS:  0010 DS: 0018 ES: 0018 CR0: 000000008005003b
11:42:59:CR2: 00007f6e5658d000 CR3: 0000000001a85000 CR4: 00000000000006f0
11:42:59:DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
11:42:59:DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
11:42:59:Process tx_commit_cb/0 (pid: 1210, threadinfo ffff8800736ee000, task ffff88006db8cab0)
11:42:59:Stack:
11:42:59: ffff88006dd21200 0000000000000000 ffff8800736efdd0 ffffffffa0f94e3c
11:42:59:<d> ffff88006db8d068 ffff88006f59ca40 ffff880079bbc8e0 ffff880079bbc8f0
11:42:59:<d> 0000000000000000 ffff88006a39d208 ffff8800736efe00 ffffffffa021386d
11:42:59:Call Trace:
11:42:59: [<ffffffffa0f94e3c>] osd_trans_commit_cb+0x17c/0x4c0 [osd_zfs]
11:42:59: [<ffffffffa021386d>] dmu_tx_do_callbacks+0x3d/0x60 [zfs]
11:42:59: [<ffffffffa0255ab8>] txg_do_callbacks+0x18/0x40 [zfs]
11:42:59: [<ffffffffa019a727>] taskq_thread+0x1e7/0x3f0 [spl]
11:42:59: [<ffffffff81064be0>] ? default_wake_function+0x0/0x20
11:42:59: [<ffffffffa019a540>] ? taskq_thread+0x0/0x3f0 [spl]
11:42:59: [<ffffffff8109e78e>] kthread+0x9e/0xc0
11:42:59: [<ffffffff8100c28a>] child_rip+0xa/0x20
11:42:59: [<ffffffff8109e6f0>] ? kthread+0x0/0xc0
11:42:59: [<ffffffff8100c280>] ? child_rip+0x0/0x20
11:42:59:Code: 48 8b 0f 48 8b 41 48 48 8d 51 48 48 39 d0 48 8d 58 d8 74 2e 0f 1f 80 00 00 00 00 48 8b 43 10 48 85 c0 74 0d 48 8b 73 18 4c 89 e7 <ff> d0 49 8b 0c 24 48 8b 43 28 48 8d 51 48 48 39 d0 48 8d 58 d8 
11:42:59:RIP  [<ffffffffa086bff0>] dt_txn_hook_commit+0x40/0x60 [obdclass]
11:42:59: RSP <ffff8800736efd80>
11:42:59:Initializing cgroup subsys cpuset
11:42:59:Initializing cgroup subsys cpu

Issue Links

• duplicates: LU-6845 conf-sanity test_30b: kernel panic in dt_txn_hook_commit+0x30 during umount
• is duplicated by: LU-6845 conf-sanity test_30b: kernel panic in dt_txn_hook_commit+0x30 during umount
• is duplicated by: LU-9706 conf-sanity test_53a: MDS soft lockup - CPU#0 stuck for 22s in osd_trans_commit_cb()