/a/kchai-2020-08-22_03:33:19-crimson-rados:thrash-wip-crimson-more-ops-kefu-distro-basic-smithi/5365998
2020-08-22T03:49:33.852 INFO:tasks.rados.rados.0.smithi183.stdout:118: writing smithi18327214-118 from 766419 to 1315847 tid 1
2020-08-22T03:49:33.858 INFO:tasks.rados.rados.0.smithi183.stdout:118: writing smithi18327214-118 from 2013452 to 2588147 tid 2
2020-08-22T03:49:33.865 INFO:tasks.rados.rados.0.smithi183.stdout:118: writing smithi18327214-118 from 3346843 to 3774492 tid 3
//// header = 5
//// read = 6
2020-08-22T03:49:34.613 INFO:tasks.rados.rados.0.smithi183.stdout:118: finishing write tid 1 to smithi18327214-118
2020-08-22T03:49:34.619 INFO:tasks.rados.rados.0.smithi183.stdout:118: finishing write tid 2 to smithi18327214-118
2020-08-22T03:49:34.623 INFO:tasks.rados.rados.0.smithi183.stdout:118: finishing write tid 3 to smithi18327214-118
2020-08-22T03:49:34.624 INFO:tasks.rados.rados.0.smithi183.stdout:118: finishing write tid 6 to smithi18327214-118
2020-08-22T03:49:35.820 INFO:tasks.rados.rados.0.smithi183.stdout:118: finishing write tid 5 to smithi18327214-118
$ zgrep 'smithi18327214-118:head sending reply' remote/*/log/ceph-osd.*.log.gz
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:33,953 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:528 3.9 3:9240fc16:::smithi18327214-118:head {write 766419~549428 in=549428b, stat out=16b} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:33,971 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:529 3.9 3:9240fc16:::smithi18327214-118:head {write 2013452~574695 in=574695b} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,014 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:530 3.9 3:9240fc16:::smithi18327214-118:head {write 3346843~427649 in=427649b} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,023 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:532 3.9 3:9240fc16:::smithi18327214-118:head {read 0~1 out=1b} snapc 0={} ondisk+read+rwordered+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
remote/smithi183/log/ceph-osd.1.log.gz:DEBUG 2020-08-22 03:49:35,064 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} RETRY=1 ondisk+retry+write+known_if_redirected e18) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
$ zgrep 'do_osd_ops' remote/smithi183/log/ceph-osd.*.log.gz | grep smithi18327214-118
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:33,972 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:530 3.9 3:9240fc16:::smithi18327214-118:head {write 3346843~427649 in=427649b} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head all operations successful
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:33,972 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:530 3.9 3:9240fc16:::smithi18327214-118:head {write 3346843~427649 in=427649b} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head submitting txn
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,014 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:530 3.9 3:9240fc16:::smithi18327214-118:head {write 3346843~427649 in=427649b} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,014 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr _header (57) in=64b, truncate 3966419} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head - handling op setxattr
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,014 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head - handling op truncate
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,014 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head all operations successful
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,014 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} ondisk+write+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head submitting txn
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,023 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:532 3.9 3:9240fc16:::smithi18327214-118:head {read 0~1} snapc 0={} ondisk+read+rwordered+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head - handling op read
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,023 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:532 3.9 3:9240fc16:::smithi18327214-118:head {read 0~1 out=1b} snapc 0={} ondisk+read+rwordered+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head all operations successful
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,023 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:532 3.9 3:9240fc16:::smithi18327214-118:head {read 0~1 out=1b} snapc 0={} ondisk+read+rwordered+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head txn is empty, bypassing mutate
remote/smithi183/log/ceph-osd.0.log.gz:DEBUG 2020-08-22 03:49:34,023 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:532 3.9 3:9240fc16:::smithi18327214-118:head {read 0~1 out=1b} snapc 0={} ondisk+read+rwordered+known_if_redirected e16) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply
remote/smithi183/log/ceph-osd.1.log.gz:DEBUG 2020-08-22 03:49:35,015 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr _header (57) in=64b, truncate 3966419} snapc 0={} RETRY=1 ondisk+retry+write+known_if_redirected e18) v8 - object 3:9240fc16:::smithi18327214-118:head - handling op setxattr
remote/smithi183/log/ceph-osd.1.log.gz:DEBUG 2020-08-22 03:49:35,015 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} RETRY=1 ondisk+retry+write+known_if_redirected e18) v8 - object 3:9240fc16:::smithi18327214-118:head - handling op truncate
remote/smithi183/log/ceph-osd.1.log.gz:DEBUG 2020-08-22 03:49:35,015 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} RETRY=1 ondisk+retry+write+known_if_redirected e18) v8 - object 3:9240fc16:::smithi18327214-118:head all operations successful
remote/smithi183/log/ceph-osd.1.log.gz:DEBUG 2020-08-22 03:49:35,015 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} RETRY=1 ondisk+retry+write+known_if_redirected e18) v8 - object 3:9240fc16:::smithi18327214-118:head submitting txn
remote/smithi183/log/ceph-osd.1.log.gz:DEBUG 2020-08-22 03:49:35,064 [shard 0] osd - do_osd_ops: osd_op(client.4228.0:531 3.9 3:9240fc16:::smithi18327214-118:head {setxattr (57), truncate 3966419} snapc 0={} RETRY=1 ondisk+retry+write+known_if_redirected e18) v8 - object 3:9240fc16:::smithi18327214-118:head sending reply