[LU-6967] racer test_1: (osd_internal.h:1036:osd_trans_exec_op()) LBUG

• Type: Bug
• Resolution: Cannot Reproduce
• Priority: Minor
• Affects Version/s: Lustre 2.8.0
• Environment: <lustre-server>; Version : 2.7.56; Release : 2.6.32_431.29.2.el6_lustremaster_master__49_g87a28e4; ; <lustre-client>; Version : 2.7.56; Release : 2.6.32_431.29.2.el6.x86_64_g87a28e4
• Severity: 3
• Assignee: WC Triage
• Reporter: Ashish Purkar (Inactive)

Description

<cmd>
SLOW=YES NAME=ncli NETTYPE=tcp
mds1_HOST=fre0101 MDSDEV1=/dev/vdb mds_HOST=fre0101 MDSDEV=/dev/vdb MDSCOUNT=1
ost1_HOST=fre0102 OSTDEV1=/dev/vdb ost2_HOST=fre0102 OSTDEV2=/dev/vdc OSTCOUNT=2
CLIENTS=fre0103 RCLIENTS="fre0104" DIR=/mnt/lustre
ONLY=1
MDS_MOUNT_OPTS="-o rw,user_xattr"
OST_MOUNT_OPTS="-o user_xattr"
ENABLE_QUOTA="yes" MAXFREE="1400000" MDSJOURNALSIZE="22" /usr/lib64/lustre/tests/racer.sh

<stdout>
== racer test 1: racer on clients: fre0103,fre0104 DURATION=900 == 19:01:31 (1438282891)
racers pids: 5604 5605
fre0103: ./file_exec.sh: line 12: 11096 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0104: ./file_exec.sh: line 12: 6621 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0104: ./file_exec.sh: line 12: 8187 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0103: ./file_exec.sh: line 12: 22080 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0103: ./file_exec.sh: line 12: 22082 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0104: ./file_exec.sh: line 12: 22389 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0104: ./file_exec.sh: line 12: 29217 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0104: ./file_exec.sh: line 12: 31092 Segmentation fault $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null
fre0103: ./file_exec.sh: line 12: 11679 Bus error $DIR/$file 0.$((RANDOM % 5 + 1)) 2> /dev/null

Lustre: DEBUG MARKER: == racer test 1: racer on clients: fre0103,fre0104 DURATION=900 == 19:01:31 (1438282891)
Lustre: 7205:0:(osd_handler.c:902:osd_trans_dump_creds()) create: 0/0/0, destroy: 0/0/0
Lustre: 7205:0:(osd_handler.c:909:osd_trans_dump_creds()) attr_set: 1/1/0, xattr_set: 1/1/0
Lustre: 7205:0:(osd_handler.c:919:osd_trans_dump_creds()) write: 2/12/0, punch: 1/4/0, quota 2/2/0
Lustre: 7205:0:(osd_handler.c:926:osd_trans_dump_creds()) insert: 0/0/0, delete: 0/0/0
Lustre: 7205:0:(osd_handler.c:933:osd_trans_dump_creds()) ref_add: 0/0/0, ref_del: 0/0/0
LustreError: 7205:0:(osd_internal.h:1028:osd_trans_exec_op()) lustre-OST0001-osd: op = 7, rb = 7
LustreError: 7205:0:(osd_internal.h:1036:osd_trans_exec_op()) LBUG
Pid: 7205, comm: ll_ost_io00_005

Call Trace:
[<ffffffffa032a875>] libcfs_debug_dumpstack+0x55/0x80 [libcfs]
[<ffffffffa032ae77>] lbug_with_loc+0x47/0xb0 [libcfs]
[<ffffffffa0b8557e>] osd_write+0x41e/0x5b0 [osd_ldiskfs]
[<ffffffffa047d8ed>] dt_record_write+0x3d/0x130 [obdclass]
[<ffffffffa06fe9e5>] tgt_client_data_write+0x165/0x1b0 [ptlrpc]
[<ffffffffa06ff98d>] tgt_txn_stop_cb+0x8bd/0x1340 [ptlrpc]
[<ffffffffa047d7be>] dt_txn_hook_stop+0x5e/0x90 [obdclass]
[<ffffffffa0b625de>] osd_trans_stop+0x18e/0x5c0 [osd_ldiskfs]
[<ffffffffa0cefa2f>] ofd_trans_stop+0x1f/0x60 [ofd]
[<ffffffffa0cf145a>] ofd_object_punch+0x35a/0xa30 [ofd]
[<ffffffffa0cdd6fe>] ofd_punch_hdl+0x36e/0xb20 [ofd]
[<ffffffffa070e872>] tgt_request_handle+0xa42/0x1230 [ptlrpc]
[<ffffffffa06b64c1>] ptlrpc_main+0xe41/0x1920 [ptlrpc]
[<ffffffffa06b5680>] ? ptlrpc_main+0x0/0x1920 [ptlrpc]
[<ffffffff8109abf6>] kthread+0x96/0xa0
[<ffffffff8100c20a>] child_rip+0xa/0x20
[<ffffffff8109ab60>] ? kthread+0x0/0xa0
[<ffffffff8100c200>] ? child_rip+0x0/0x20