[LU-7021] osd_trans_exec_check()) LBUG for ofd_write_attr_set

• Type: Bug
• Resolution: Fixed
• Priority: Minor
• Fix Version/s: Lustre 2.17.0
• Severity: 3
• Assignee: Alex Zhuravlev
• Reporter: Oleg Drokin

Description

Running a current master snapshot +;

pick 496b566 LU-6903 lov: call lov_object_find_cbdata() inside lock
pick fd5b2da LU-6727 osd: auto locate BH_DXLock bit
pick 174ca9c LU-6119 test: Add testing for Lustre exported via Samba
pick 7ccf098 LU-6356 ptlrpc: do not sleep if encpool reached max capacity
pick db3981e LU-6215 llite: handle backing_dev_info removal
pick c0aafaa LU-6846 llog: combine cancel rec and destroy

I just hit this LBUG:

<4>[ 5532.419038] Lustre: 5319:0:(osd_internal.h:1087:osd_trans_exec_check()) op 0: used 8, used now 8, reserved 1
<4>[ 5532.419630] Lustre: 5319:0:(osd_handler.c:902:osd_trans_dump_creds())   create: 0/0/0, destroy: 0/0/0
<4>[ 5532.420063] Lustre: 5319:0:(osd_handler.c:909:osd_trans_dump_creds())   attr_set: 1/1/8, xattr_set: 1/216/0
<4>[ 5532.420419] Lustre: 5319:0:(osd_handler.c:919:osd_trans_dump_creds())   write: 0/0/0, punch: 0/0/0, quota 2/2/0
<4>[ 5532.420804] Lustre: 5319:0:(osd_handler.c:926:osd_trans_dump_creds())   insert: 0/0/0, delete: 0/0/0
<4>[ 5532.421728] Lustre: 5319:0:(osd_handler.c:933:osd_trans_dump_creds())   ref_add: 0/0/0, ref_del: 0/0/0
<0>[ 5532.422069] LustreError: 5319:0:(osd_internal.h:1090:osd_trans_exec_check()) LBUG
<4>[ 5532.436922] Pid: 5319, comm: ll_ost_io01_004
<4>[ 5532.437212] 
<4>[ 5532.437213] Call Trace:
<4>[ 5532.437656]  [<ffffffffa12d9885>] libcfs_debug_dumpstack+0x55/0x80 [libcfs]
<4>[ 5532.442062]  [<ffffffffa12d9e87>] lbug_with_loc+0x47/0xb0 [libcfs]
<4>[ 5532.442360]  [<ffffffffa078b6c4>] osd_attr_set+0x284/0x620 [osd_ldiskfs]
<4>[ 5532.442653]  [<ffffffffa0adad4d>] dt_attr_set+0x8d/0x1a0 [ofd]
<4>[ 5532.442938]  [<ffffffffa0adb379>] ofd_write_attr_set+0x519/0x8b0 [ofd]
<4>[ 5532.446791]  [<ffffffffa0adb966>] ofd_commitrw_write+0x256/0xfc0 [ofd]
<4>[ 5532.447128]  [<ffffffffa0ae0f3d>] ? ofd_fmd_find_nolock+0xad/0xd0 [ofd]
<4>[ 5532.447427]  [<ffffffffa0adcc82>] ofd_commitrw+0x5b2/0xba0 [ofd]
<4>[ 5532.447736]  [<ffffffffa13cfac9>] ? lprocfs_counter_add+0x119/0x1c0 [obdclass]
<4>[ 5532.448233]  [<ffffffffa1676504>] obd_commitrw+0x114/0x380 [ptlrpc]
<4>[ 5532.448553]  [<ffffffffa167f8b0>] tgt_brw_write+0xc80/0x1550 [ptlrpc]
<4>[ 5532.448842]  [<ffffffff812918f0>] ? string+0x40/0x100
<4>[ 5532.449151]  [<ffffffffa15d2ce0>] ? target_bulk_timeout+0x0/0xc0 [ptlrpc]
<4>[ 5532.449627]  [<ffffffffa167e442>] tgt_request_handle+0xa42/0x1230 [ptlrpc]
<4>[ 5532.450133]  [<ffffffffa1629ab4>] ptlrpc_main+0xd74/0x1850 [ptlrpc]
<4>[ 5532.450687]  [<ffffffffa1628d40>] ? ptlrpc_main+0x0/0x1850 [ptlrpc]
<4>[ 5532.453814]  [<ffffffff8109ce4e>] kthread+0x9e/0xc0
<4>[ 5532.454167]  [<ffffffff8100c24a>] child_rip+0xa/0x20
<4>[ 5532.454431]  [<ffffffff8109cdb0>] ? kthread+0x0/0xc0
<4>[ 5532.454711]  [<ffffffff8100c240>] ? child_rip+0x0/0x20
<4>[ 5532.454901] 
<0>[ 5532.687417] Kernel panic - not syncing: LBUG
<4>[ 5532.687691] Pid: 5319, comm: ll_ost_io01_004 Tainted: P           ---------------    2.6.32-rhe6.6-debug #1
<4>[ 5532.688234] Call Trace:
<4>[ 5532.688461]  [<ffffffff8151dcd9>] ? panic+0xa7/0x16f
<4>[ 5532.688757]  [<ffffffffa12d9edb>] ? lbug_with_loc+0x9b/0xb0 [libcfs]
<4>[ 5532.689072]  [<ffffffffa078b6c4>] ? osd_attr_set+0x284/0x620 [osd_ldiskfs]
<4>[ 5532.689376]  [<ffffffffa0adad4d>] ? dt_attr_set+0x8d/0x1a0 [ofd]
<4>[ 5532.689686]  [<ffffffffa0adb379>] ? ofd_write_attr_set+0x519/0x8b0 [ofd]
<4>[ 5532.690040]  [<ffffffffa0adb966>] ? ofd_commitrw_write+0x256/0xfc0 [ofd]
<4>[ 5532.690365]  [<ffffffffa0ae0f3d>] ? ofd_fmd_find_nolock+0xad/0xd0 [ofd]
<4>[ 5532.691261]  [<ffffffffa0adcc82>] ? ofd_commitrw+0x5b2/0xba0 [ofd]
<4>[ 5532.691261]  [<ffffffffa13cfac9>] ? lprocfs_counter_add+0x119/0x1c0 [obdclass]
<4>[ 5532.691261]  [<ffffffffa1676504>] ? obd_commitrw+0x114/0x380 [ptlrpc]
<4>[ 5532.700994]  [<ffffffffa167f8b0>] ? tgt_brw_write+0xc80/0x1550 [ptlrpc]
<4>[ 5532.700994]  [<ffffffff812918f0>] ? string+0x40/0x100
<4>[ 5532.700994]  [<ffffffffa15d2ce0>] ? target_bulk_timeout+0x0/0xc0 [ptlrpc]
<4>[ 5532.700994]  [<ffffffffa167e442>] ? tgt_request_handle+0xa42/0x1230 [ptlrpc]
<4>[ 5532.700994]  [<ffffffffa1629ab4>] ? ptlrpc_main+0xd74/0x1850 [ptlrpc]
<4>[ 5532.700994]  [<ffffffffa1628d40>] ? ptlrpc_main+0x0/0x1850 [ptlrpc]
<4>[ 5532.700994]  [<ffffffff8109ce4e>] ? kthread+0x9e/0xc0
<4>[ 5532.700994]  [<ffffffff8100c24a>] ? child_rip+0xa/0x20
<4>[ 5532.700994]  [<ffffffff8109cdb0>] ? kthread+0x0/0xc0
<4>[ 5532.700994]  [<ffffffff8100c240>] ? child_rip+0x0/0x20

Issue Links

• is related to: LU-13093 osd_trans_exec_check()) lustre-OST0001: opcode 0: used 8, used now 8, reserved 1 LBUG
• is related to: LU-6969 osd_internal.h:1090:osd_trans_exec_check()) LBUG for osd_index_ea_delete()