Hi,Since we upgraded ceph to 0.67.4, the radosgw-admin doesn't list all the users anymore:
root@ineri:~# radosgw-admin user info could not fetch user info: no user info saved But it still work for single user: root@ineri:~# radosgw-admin user info --uid=valery { "user_id": "valery", "display_name": "Valery Tschopp", "email": "valery.tschopp@xxxxxxxxx", ... The debug log file is attached, any idea? Cheers, Valery -- SWITCH -------------------------- Valery Tschopp, Software Engineer, Peta Solutions Werdstrasse 2, P.O. Box, 8021 Zurich, Switzerland email: valery.tschopp@xxxxxxxxx phone: +41 44 268 1544
root@ineri:~# radosgw-admin user info --debug-objecter=10 --debug-rgw=10 --debug-ms=10 --log-to-stderr 2>&1 2013-10-11 13:54:38.528157 7f43d9779780 10 -- :/0 ready :/0 2013-10-11 13:54:38.528181 7f43d9779780 1 -- :/0 messenger.start 2013-10-11 13:54:38.528322 7f43d00ba700 10 -- :/1028435 reaper_entry start 2013-10-11 13:54:38.528963 7f43d00ba700 10 -- :/1028435 reaper 2013-10-11 13:54:38.528972 7f43d00ba700 10 -- :/1028435 reaper done 2013-10-11 13:54:38.529353 7f43d9779780 10 -- :/1028435 connect_rank to [2001:620:0:6::106]:6789/0, creating pipe and registering 2013-10-11 13:54:38.529418 7f43d9779780 10 -- :/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d87ad0).register_pipe 2013-10-11 13:54:38.529446 7f43d9779780 10 -- :/1028435 get_connection mon.0 [2001:620:0:6::106]:6789/0 new 0x1d87870 2013-10-11 13:54:38.529486 7f43d9779780 1 -- :/1028435 --> [2001:620:0:6::106]:6789/0 -- auth(proto 0 30 bytes epoch 0) v1 -- ?+0 0x1d85120 con 0x1d87ad0 2013-10-11 13:54:38.529460 7f43d9771700 10 -- :/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d87ad0).writer: state = connecting policy.server=0 2013-10-11 13:54:38.529504 7f43d9771700 10 -- :/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d87ad0).connect 0 2013-10-11 13:54:38.529531 7f43d9771700 10 -- :/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :0 s=1 pgs=0 cs=0 l=1 c=0x1d87ad0).connecting to [2001:620:0:6::106]:6789/0 2013-10-11 13:54:38.530126 7f43d9771700 1 -- [2001:620:0:6::d0]:0/1028435 learned my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.530227 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=1 pgs=0 cs=0 l=1 c=0x1d87ad0).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.530254 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=1 pgs=0 cs=0 l=1 c=0x1d87ad0).connect sending gseq=1 cseq=0 proto=15 2013-10-11 13:54:38.530421 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.530636 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.530645 7f43d08bb700 10 client.?.objecter ms_handle_connect 0x1d87ad0 2013-10-11 13:54:38.530676 7f43d08bb700 10 client.?.objecter resend_mon_ops 2013-10-11 13:54:38.530782 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.531353 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 760 from dispatch throttler 0/104857600 2013-10-11 13:54:38.531454 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.531485 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.531500 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 1 0x7f43bc000f10 mon_map v1 2013-10-11 13:54:38.531557 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.531579 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 33 from dispatch throttler 760/104857600 2013-10-11 13:54:38.531587 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 1 2013-10-11 13:54:38.531596 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.531605 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.531611 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.531604 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 1 ==== mon_map v1 ==== 760+0+0 (2090067598 0 0) 0x7f43bc000f10 con 0x1d87ad0 2013-10-11 13:54:38.531624 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 2 0x7f43bc001920 auth_reply(proto 2 0 Success) v1 2013-10-11 13:54:38.531686 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.531710 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 2 2013-10-11 13:54:38.531717 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 760 to dispatch throttler 793/104857600 2013-10-11 13:54:38.531727 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.531732 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 2 ==== auth_reply(proto 2 0 Success) v1 ==== 33+0+0 (2140891321 0 0) 0x7f43bc001920 con 0x1d87ad0 2013-10-11 13:54:38.531952 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::106]:6789/0 -- auth(proto 2 32 bytes epoch 0) v1 -- ?+0 0x7f43b8001e00 con 0x1d87ad0 2013-10-11 13:54:38.531967 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 33 to dispatch throttler 33/104857600 2013-10-11 13:54:38.532076 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.532147 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.532757 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 206 from dispatch throttler 0/104857600 2013-10-11 13:54:38.532791 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.532835 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.532849 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 3 0x7f43bc000b10 auth_reply(proto 2 0 Success) v1 2013-10-11 13:54:38.532904 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.532929 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 3 2013-10-11 13:54:38.532946 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.532946 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 3 ==== auth_reply(proto 2 0 Success) v1 ==== 206+0+0 (290785253 0 0) 0x7f43bc000b10 con 0x1d87ad0 2013-10-11 13:54:38.533134 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::106]:6789/0 -- auth(proto 2 165 bytes epoch 0) v1 -- ?+0 0x7f43b8001e00 con 0x1d87ad0 2013-10-11 13:54:38.533150 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 206 to dispatch throttler 206/104857600 2013-10-11 13:54:38.533209 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.533277 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534050 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 393 from dispatch throttler 0/104857600 2013-10-11 13:54:38.534085 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.534130 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.534143 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 4 0x7f43bc002350 auth_reply(proto 2 0 Success) v1 2013-10-11 13:54:38.534206 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534235 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 4 2013-10-11 13:54:38.534234 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 4 ==== auth_reply(proto 2 0 Success) v1 ==== 393+0+0 (12451388 0 0) 0x7f43bc002350 con 0x1d87ad0 2013-10-11 13:54:38.534253 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534350 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::106]:6789/0 -- mon_subscribe({monmap=0+}) v2 -- ?+0 0x1d81840 con 0x1d87ad0 2013-10-11 13:54:38.534381 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 393 to dispatch throttler 393/104857600 2013-10-11 13:54:38.534448 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534478 7f43d9779780 10 client.211130.objecter maybe_request_map subscribing (onetime) to next osd map 2013-10-11 13:54:38.534498 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::106]:6789/0 -- mon_subscribe({monmap=21+,osdmap=0}) v2 -- ?+0 0x1d858d0 con 0x1d87ad0 2013-10-11 13:54:38.534558 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534596 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534606 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::106]:6789/0 -- mon_subscribe({monmap=21+,osdmap=0}) v2 -- ?+0 0x1d85d40 con 0x1d87ad0 2013-10-11 13:54:38.534626 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534657 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.534840 7f43cd7b4700 2 RGWDataChangesLog::ChangesRenewThread: start 2013-10-11 13:54:38.535061 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 760 from dispatch throttler 0/104857600 2013-10-11 13:54:38.535093 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.535135 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.535147 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 5 0x7f43bc002c90 mon_map v1 2013-10-11 13:54:38.535192 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.535211 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 5 2013-10-11 13:54:38.535227 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.535264 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 20 from dispatch throttler 760/104857600 2013-10-11 13:54:38.535280 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.535296 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.535284 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 5 ==== mon_map v1 ==== 760+0+0 (2090067598 0 0) 0x7f43bc002c90 con 0x1d87ad0 2013-10-11 13:54:38.535308 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 6 0x7f43bc0034e0 mon_subscribe_ack(300s) v1 2013-10-11 13:54:38.535359 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 760 to dispatch throttler 780/104857600 2013-10-11 13:54:38.535371 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 6 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (1089595926 0 0) 0x7f43bc0034e0 con 0x1d87ad0 2013-10-11 13:54:38.535369 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.535391 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 20 to dispatch throttler 20/104857600 2013-10-11 13:54:38.535388 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 6 2013-10-11 13:54:38.535402 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.535468 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 51140 from dispatch throttler 0/104857600 2013-10-11 13:54:38.535866 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.536020 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.536052 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 7 0x7f43bc0028c0 osd_map(90036..90036 src has 89375..90036) v3 2013-10-11 13:54:38.536095 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.536116 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 7 2013-10-11 13:54:38.536131 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.536149 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 20 from dispatch throttler 51140/104857600 2013-10-11 13:54:38.536166 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 7 ==== osd_map(90036..90036 src has 89375..90036) v3 ==== 51140+0+0 (940560370 0 0) 0x7f43bc0028c0 con 0x1d87ad0 2013-10-11 13:54:38.536169 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.536204 7f43d08bb700 3 client.211130.objecter handle_osd_map got epochs [90036,90036] > 0 2013-10-11 13:54:38.536208 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.536215 7f43d08bb700 3 client.211130.objecter handle_osd_map decoding full epoch 90036 2013-10-11 13:54:38.536221 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 8 0x7f43bc010540 mon_subscribe_ack(300s) v1 2013-10-11 13:54:38.536244 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 51140 from dispatch throttler 51160/104857600 2013-10-11 13:54:38.536288 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.536312 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 8 2013-10-11 13:54:38.536329 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.536519 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.536626 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 51140 to dispatch throttler 102300/104857600 2013-10-11 13:54:38.536644 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 8 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (1089595926 0 0) 0x7f43bc010540 con 0x1d87ad0 2013-10-11 13:54:38.536652 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.536659 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 20 to dispatch throttler 51160/104857600 2013-10-11 13:54:38.536668 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 9 0x7f43bc0028c0 osd_map(90036..90036 src has 89375..90036) v3 2013-10-11 13:54:38.536692 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader wants 20 from dispatch throttler 51140/104857600 2013-10-11 13:54:38.536707 7f43d9779780 10 cache get: name=.rgw.root+default.region : miss 2013-10-11 13:54:38.536710 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).aborted = 0 2013-10-11 13:54:38.536701 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 9 ==== osd_map(90036..90036 src has 89375..90036) v3 ==== 51140+0+0 (940560370 0 0) 0x7f43bc0028c0 con 0x1d87ad0 2013-10-11 13:54:38.536722 7f43d08bb700 3 client.211130.objecter handle_osd_map ignoring epochs [90036,90036] <= 90036 2013-10-11 13:54:38.536722 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).No session security set 2013-10-11 13:54:38.536727 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 51140 to dispatch throttler 51160/104857600 2013-10-11 13:54:38.536731 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader got message 10 0x7f43bc003d90 mon_subscribe_ack(300s) v1 2013-10-11 13:54:38.536757 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== mon.0 [2001:620:0:6::106]:6789/0 10 ==== mon_subscribe_ack(300s) v1 ==== 20+0+0 (1089595926 0 0) 0x7f43bc003d90 con 0x1d87ad0 2013-10-11 13:54:38.536771 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 20 to dispatch throttler 20/104857600 2013-10-11 13:54:38.536779 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.536803 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).write_ack 10 2013-10-11 13:54:38.536820 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer: state = open policy.server=0 2013-10-11 13:54:38.536823 7f43d9779780 10 client.211130.objecter recalc_op_target tid 1 pgid 19.9a566808 acting [9,49] 2013-10-11 13:54:38.536845 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::108]:6816/18863, creating pipe and registering 2013-10-11 13:54:38.536892 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).register_pipe 2013-10-11 13:54:38.536906 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.9 [2001:620:0:6::108]:6816/18863 new 0x1d83cc0 2013-10-11 13:54:38.536924 7f43d9779780 10 client.211130.objecter op_submit oid default.region @19 [getxattrs,stat] tid 1 osd.9 2013-10-11 13:54:38.536943 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:1 default.region [getxattrs,stat] 19.9a566808 e90036) v4 -- ?+0 0x1d846d0 con 0x1d83f20 2013-10-11 13:54:38.536958 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.536963 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).writer: state = connecting policy.server=0 2013-10-11 13:54:38.537035 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).connect 0 2013-10-11 13:54:38.537052 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :0 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).connecting to [2001:620:0:6::108]:6816/18863 2013-10-11 13:54:38.537902 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.538023 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.538045 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).connect sending gseq=2 cseq=0 proto=24 2013-10-11 13:54:38.538743 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=1 pgs=0 cs=0 l=1 c=0x1d83f20).reply.authorizer_len=36 2013-10-11 13:54:38.538841 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.538968 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d83f20 2013-10-11 13:54:38.538976 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.539094 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.540479 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 175 from dispatch throttler 0/104857600 2013-10-11 13:54:38.540539 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.540658 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 1 0x7f43a8000d70 osd_op_reply(1 default.region [getxattrs,stat] ondisk = 0) v4 2013-10-11 13:54:38.540711 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.540736 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 1 2013-10-11 13:54:38.540753 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.540761 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 1 ==== osd_op_reply(1 default.region [getxattrs,stat] ondisk = 0) v4 ==== 155+0+20 (1285254566 0 3018233598) 0x7f43a8000d70 con 0x1d83f20 2013-10-11 13:54:38.540790 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.540795 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 1 ondisk v 79940'2 in 19.9a566808 attempt 0 2013-10-11 13:54:38.540803 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 4 2013-10-11 13:54:38.540807 7f43d08bb700 10 client.211130.objecter op 0 handler 0x1d835c0 2013-10-11 13:54:38.540818 7f43d08bb700 10 client.211130.objecter op 1 rval 0 len 16 2013-10-11 13:54:38.540821 7f43d08bb700 10 client.211130.objecter op 1 handler 0x1d83490 2013-10-11 13:54:38.540836 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.540845 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 175 to dispatch throttler 175/104857600 2013-10-11 13:54:38.540907 7f43d9779780 10 cache put: name=.rgw.root+default.region 2013-10-11 13:54:38.540918 7f43d9779780 10 adding .rgw.root+default.region to cache LRU end 2013-10-11 13:54:38.540934 7f43d9779780 10 moving .rgw.root+default.region to cache LRU end 2013-10-11 13:54:38.540939 7f43d9779780 10 cache get: name=.rgw.root+default.region : type miss (requested=1, cached=6) 2013-10-11 13:54:38.540951 7f43d9779780 10 moving .rgw.root+default.region to cache LRU end 2013-10-11 13:54:38.540953 7f43d9779780 10 cache get: name=.rgw.root+default.region : hit 2013-10-11 13:54:38.540982 7f43d9779780 10 client.211130.objecter recalc_op_target tid 2 pgid 19.9a566808 acting [9,49] 2013-10-11 13:54:38.540989 7f43d9779780 10 client.211130.objecter op_submit oid default.region @19 [read 0~524288] tid 2 osd.9 2013-10-11 13:54:38.540997 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:2 default.region [read 0~524288] 19.9a566808 e90036) v4 -- ?+0 0x1d8b0e0 con 0x1d83f20 2013-10-11 13:54:38.541190 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.541211 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.541316 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.542595 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 130 from dispatch throttler 0/104857600 2013-10-11 13:54:38.542634 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.542735 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 2 0x7f43a8001670 osd_op_reply(2 default.region [read 0~17] ondisk = 0) v4 2013-10-11 13:54:38.542775 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.542811 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 2 2013-10-11 13:54:38.542827 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.542835 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 2 ==== osd_op_reply(2 default.region [read 0~17] ondisk = 0) v4 ==== 113+0+17 (3751067599 0 2082767461) 0x7f43a8001670 con 0x1d83f20 2013-10-11 13:54:38.542862 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.542865 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 2 ondisk v 79940'2 in 19.9a566808 attempt 0 2013-10-11 13:54:38.542870 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 17 2013-10-11 13:54:38.542878 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.542887 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 130 to dispatch throttler 130/104857600 2013-10-11 13:54:38.542971 7f43d9779780 10 cache put: name=.rgw.root+default.region 2013-10-11 13:54:38.542977 7f43d9779780 10 moving .rgw.root+default.region to cache LRU end 2013-10-11 13:54:38.543006 7f43d9779780 10 cache get: name=.rgw.root+region_info.default : miss 2013-10-11 13:54:38.543033 7f43d9779780 10 client.211130.objecter recalc_op_target tid 3 pgid 19.43611588 acting [9,49] 2013-10-11 13:54:38.543040 7f43d9779780 10 client.211130.objecter op_submit oid region_info.default @19 [getxattrs,stat] tid 3 osd.9 2013-10-11 13:54:38.543048 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:3 region_info.default [getxattrs,stat] 19.43611588 e90036) v4 -- ?+0 0x1d8bcb0 con 0x1d83f20 2013-10-11 13:54:38.543068 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.543105 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.543201 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.544607 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 180 from dispatch throttler 0/104857600 2013-10-11 13:54:38.544647 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.544717 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 3 0x7f43a80053b0 osd_op_reply(3 region_info.default [getxattrs,stat] ondisk = 0) v4 2013-10-11 13:54:38.544763 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.544791 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 3 2013-10-11 13:54:38.544808 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.544813 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 3 ==== osd_op_reply(3 region_info.default [getxattrs,stat] ondisk = 0) v4 ==== 160+0+20 (1065564842 0 47698694) 0x7f43a80053b0 con 0x1d83f20 2013-10-11 13:54:38.544839 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.544843 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 3 ondisk v 79940'1 in 19.43611588 attempt 0 2013-10-11 13:54:38.544847 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 4 2013-10-11 13:54:38.544850 7f43d08bb700 10 client.211130.objecter op 0 handler 0x1d84bb0 2013-10-11 13:54:38.544854 7f43d08bb700 10 client.211130.objecter op 1 rval 0 len 16 2013-10-11 13:54:38.544856 7f43d08bb700 10 client.211130.objecter op 1 handler 0x1d8b290 2013-10-11 13:54:38.544863 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.544872 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 180 to dispatch throttler 180/104857600 2013-10-11 13:54:38.544943 7f43d9779780 10 cache put: name=.rgw.root+region_info.default 2013-10-11 13:54:38.544952 7f43d9779780 10 adding .rgw.root+region_info.default to cache LRU end 2013-10-11 13:54:38.544964 7f43d9779780 10 moving .rgw.root+region_info.default to cache LRU end 2013-10-11 13:54:38.544967 7f43d9779780 10 cache get: name=.rgw.root+region_info.default : type miss (requested=1, cached=6) 2013-10-11 13:54:38.544976 7f43d9779780 10 moving .rgw.root+region_info.default to cache LRU end 2013-10-11 13:54:38.544979 7f43d9779780 10 cache get: name=.rgw.root+region_info.default : hit 2013-10-11 13:54:38.545014 7f43d9779780 10 client.211130.objecter recalc_op_target tid 4 pgid 19.43611588 acting [9,49] 2013-10-11 13:54:38.545022 7f43d9779780 10 client.211130.objecter op_submit oid region_info.default @19 [read 0~524288] tid 4 osd.9 2013-10-11 13:54:38.545030 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:4 region_info.default [read 0~524288] 19.43611588 e90036) v4 -- ?+0 0x1d8d510 con 0x1d83f20 2013-10-11 13:54:38.545050 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.545064 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.545158 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.546337 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 263 from dispatch throttler 0/104857600 2013-10-11 13:54:38.546374 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.546467 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 4 0x7f43a8005a10 osd_op_reply(4 region_info.default [read 0~145] ondisk = 0) v4 2013-10-11 13:54:38.546563 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.546610 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 4 2013-10-11 13:54:38.546562 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 4 ==== osd_op_reply(4 region_info.default [read 0~145] ondisk = 0) v4 ==== 118+0+145 (963281292 0 4143625220) 0x7f43a8005a10 con 0x1d83f20 2013-10-11 13:54:38.546628 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.546634 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.546640 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 4 ondisk v 79940'1 in 19.43611588 attempt 0 2013-10-11 13:54:38.546646 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 145 2013-10-11 13:54:38.546654 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.546664 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 263 to dispatch throttler 263/104857600 2013-10-11 13:54:38.546744 7f43d9779780 10 cache put: name=.rgw.root+region_info.default 2013-10-11 13:54:38.546750 7f43d9779780 10 moving .rgw.root+region_info.default to cache LRU end 2013-10-11 13:54:38.546790 7f43d9779780 10 cache get: name=.rgw.root+zone_info.default : miss 2013-10-11 13:54:38.546875 7f43d9779780 10 client.211130.objecter recalc_op_target tid 5 pgid 19.e01f9ae acting [64,10] 2013-10-11 13:54:38.546882 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::10c]:6832/32676, creating pipe and registering 2013-10-11 13:54:38.546937 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).register_pipe 2013-10-11 13:54:38.546961 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.64 [2001:620:0:6::10c]:6832/32676 new 0x1d8f1a0 2013-10-11 13:54:38.546972 7f43d9779780 10 client.211130.objecter op_submit oid zone_info.default @19 [getxattrs,stat] tid 5 osd.64 2013-10-11 13:54:38.546979 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6832/32676 -- osd_op(client.211130.0:5 zone_info.default [getxattrs,stat] 19.e01f9ae e90036) v4 -- ?+0 0x1d8fac0 con 0x1d8f400 2013-10-11 13:54:38.546972 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).writer: state = connecting policy.server=0 2013-10-11 13:54:38.547019 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).connect 0 2013-10-11 13:54:38.547040 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :0 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).connecting to [2001:620:0:6::10c]:6832/32676 2013-10-11 13:54:38.547099 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.547732 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.547860 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.547890 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).connect sending gseq=3 cseq=0 proto=24 2013-10-11 13:54:38.548337 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=1 pgs=0 cs=0 l=1 c=0x1d8f400).reply.authorizer_len=36 2013-10-11 13:54:38.548458 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.548553 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d8f400 2013-10-11 13:54:38.548569 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.548674 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.549589 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).reader wants 178 from dispatch throttler 0/104857600 2013-10-11 13:54:38.549650 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).aborted = 0 2013-10-11 13:54:38.549759 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).reader got message 1 0x7f43a0000d70 osd_op_reply(5 zone_info.default [getxattrs,stat] ondisk = 0) v4 2013-10-11 13:54:38.549828 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.549857 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).write_ack 1 2013-10-11 13:54:38.549853 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.64 [2001:620:0:6::10c]:6832/32676 1 ==== osd_op_reply(5 zone_info.default [getxattrs,stat] ondisk = 0) v4 ==== 158+0+20 (4185879531 0 3123008434) 0x7f43a0000d70 con 0x1d8f400 2013-10-11 13:54:38.549879 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.549882 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 5 ondisk v 79940'1 in 19.e01f9ae attempt 0 2013-10-11 13:54:38.549876 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.549887 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 4 2013-10-11 13:54:38.549891 7f43d08bb700 10 client.211130.objecter op 0 handler 0x1d8ddb0 2013-10-11 13:54:38.549894 7f43d08bb700 10 client.211130.objecter op 1 rval 0 len 16 2013-10-11 13:54:38.549896 7f43d08bb700 10 client.211130.objecter op 1 handler 0x1d84bb0 2013-10-11 13:54:38.549904 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.549913 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 178 to dispatch throttler 178/104857600 2013-10-11 13:54:38.549982 7f43d9779780 10 cache put: name=.rgw.root+zone_info.default 2013-10-11 13:54:38.549991 7f43d9779780 10 adding .rgw.root+zone_info.default to cache LRU end 2013-10-11 13:54:38.550002 7f43d9779780 10 moving .rgw.root+zone_info.default to cache LRU end 2013-10-11 13:54:38.550005 7f43d9779780 10 cache get: name=.rgw.root+zone_info.default : type miss (requested=1, cached=6) 2013-10-11 13:54:38.550014 7f43d9779780 10 moving .rgw.root+zone_info.default to cache LRU end 2013-10-11 13:54:38.550016 7f43d9779780 10 cache get: name=.rgw.root+zone_info.default : hit 2013-10-11 13:54:38.550095 7f43d9779780 10 client.211130.objecter recalc_op_target tid 6 pgid 19.e01f9ae acting [64,10] 2013-10-11 13:54:38.550103 7f43d9779780 10 client.211130.objecter op_submit oid zone_info.default @19 [read 0~524288] tid 6 osd.64 2013-10-11 13:54:38.550111 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6832/32676 -- osd_op(client.211130.0:6 zone_info.default [read 0~524288] 19.e01f9ae e90036) v4 -- ?+0 0x1d904f0 con 0x1d8f400 2013-10-11 13:54:38.550131 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.550243 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.550352 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.551243 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).reader wants 667 from dispatch throttler 0/104857600 2013-10-11 13:54:38.551291 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).aborted = 0 2013-10-11 13:54:38.551391 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).reader got message 2 0x7f43a0000d70 osd_op_reply(6 zone_info.default [read 0~551] ondisk = 0) v4 2013-10-11 13:54:38.551471 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.551500 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).write_ack 2 2013-10-11 13:54:38.551489 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.64 [2001:620:0:6::10c]:6832/32676 2 ==== osd_op_reply(6 zone_info.default [read 0~551] ondisk = 0) v4 ==== 116+0+551 (3280821328 0 4237757719) 0x7f43a0000d70 con 0x1d8f400 2013-10-11 13:54:38.551516 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.551519 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 6 ondisk v 79940'1 in 19.e01f9ae attempt 0 2013-10-11 13:54:38.551524 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 551 2013-10-11 13:54:38.551518 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).writer: state = open policy.server=0 2013-10-11 13:54:38.551533 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.551545 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 667 to dispatch throttler 667/104857600 2013-10-11 13:54:38.551635 7f43d9779780 10 cache put: name=.rgw.root+zone_info.default 2013-10-11 13:54:38.551641 7f43d9779780 10 moving .rgw.root+zone_info.default to cache LRU end 2013-10-11 13:54:38.551673 7f43d9779780 10 cache get: name=.rgw.root+region_map : miss 2013-10-11 13:54:38.551699 7f43d9779780 10 client.211130.objecter recalc_op_target tid 7 pgid 19.bd31b503 acting [52,62] 2013-10-11 13:54:38.551707 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::10e]:6820/7836, creating pipe and registering 2013-10-11 13:54:38.551762 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).register_pipe 2013-10-11 13:54:38.551777 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.52 [2001:620:0:6::10e]:6820/7836 new 0x1d92270 2013-10-11 13:54:38.551787 7f43d9779780 10 client.211130.objecter op_submit oid region_map @19 [getxattrs,stat] tid 7 osd.52 2013-10-11 13:54:38.551797 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10e]:6820/7836 -- osd_op(client.211130.0:7 region_map [getxattrs,stat] 19.bd31b503 e90036) v4 -- ?+0 0x1d92c80 con 0x1d924d0 2013-10-11 13:54:38.551810 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.551842 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).writer: state = connecting policy.server=0 2013-10-11 13:54:38.551886 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).connect 0 2013-10-11 13:54:38.551911 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :0 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).connecting to [2001:620:0:6::10e]:6820/7836 2013-10-11 13:54:38.552594 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.552743 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.552763 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).connect sending gseq=4 cseq=0 proto=24 2013-10-11 13:54:38.553188 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=1 pgs=0 cs=0 l=1 c=0x1d924d0).reply.authorizer_len=36 2013-10-11 13:54:38.553313 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.553408 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d924d0 2013-10-11 13:54:38.553416 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.553520 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.554458 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).reader wants 171 from dispatch throttler 0/104857600 2013-10-11 13:54:38.554514 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).aborted = 0 2013-10-11 13:54:38.554620 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).reader got message 1 0x7f4398000d60 osd_op_reply(7 region_map [getxattrs,stat] ondisk = 0) v4 2013-10-11 13:54:38.554656 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.554684 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).write_ack 1 2013-10-11 13:54:38.554702 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.554714 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.52 [2001:620:0:6::10e]:6820/7836 1 ==== osd_op_reply(7 region_map [getxattrs,stat] ondisk = 0) v4 ==== 151+0+20 (510368520 0 827797142) 0x7f4398000d60 con 0x1d924d0 2013-10-11 13:54:38.554740 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.554744 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 7 ondisk v 90036'1 in 19.bd31b503 attempt 0 2013-10-11 13:54:38.554748 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 4 2013-10-11 13:54:38.554751 7f43d08bb700 10 client.211130.objecter op 0 handler 0x1d90d30 2013-10-11 13:54:38.554755 7f43d08bb700 10 client.211130.objecter op 1 rval 0 len 16 2013-10-11 13:54:38.554757 7f43d08bb700 10 client.211130.objecter op 1 handler 0x1d90f70 2013-10-11 13:54:38.554764 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.554779 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 171 to dispatch throttler 171/104857600 2013-10-11 13:54:38.554862 7f43d9779780 10 cache put: name=.rgw.root+region_map 2013-10-11 13:54:38.554872 7f43d9779780 10 adding .rgw.root+region_map to cache LRU end 2013-10-11 13:54:38.554883 7f43d9779780 10 moving .rgw.root+region_map to cache LRU end 2013-10-11 13:54:38.554886 7f43d9779780 10 cache get: name=.rgw.root+region_map : type miss (requested=1, cached=6) 2013-10-11 13:54:38.554895 7f43d9779780 10 moving .rgw.root+region_map to cache LRU end 2013-10-11 13:54:38.554897 7f43d9779780 10 cache get: name=.rgw.root+region_map : hit 2013-10-11 13:54:38.554921 7f43d9779780 10 client.211130.objecter recalc_op_target tid 8 pgid 19.bd31b503 acting [52,62] 2013-10-11 13:54:38.554929 7f43d9779780 10 client.211130.objecter op_submit oid region_map @19 [read 0~524288] tid 8 osd.52 2013-10-11 13:54:38.554935 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10e]:6820/7836 -- osd_op(client.211130.0:8 region_map [read 0~524288] 19.bd31b503 e90036) v4 -- ?+0 0x1d936f0 con 0x1d924d0 2013-10-11 13:54:38.554959 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.555019 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.555135 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.555791 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).reader wants 286 from dispatch throttler 0/104857600 2013-10-11 13:54:38.555828 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).aborted = 0 2013-10-11 13:54:38.555928 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).reader got message 2 0x7f4398001660 osd_op_reply(8 region_map [read 0~177] ondisk = 0) v4 2013-10-11 13:54:38.556010 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.556038 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).write_ack 2 2013-10-11 13:54:38.556057 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).writer: state = open policy.server=0 2013-10-11 13:54:38.556067 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.52 [2001:620:0:6::10e]:6820/7836 2 ==== osd_op_reply(8 region_map [read 0~177] ondisk = 0) v4 ==== 109+0+177 (2731374125 0 3101274191) 0x7f4398001660 con 0x1d924d0 2013-10-11 13:54:38.556095 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.556098 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 8 ondisk v 90036'1 in 19.bd31b503 attempt 0 2013-10-11 13:54:38.556103 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 177 2013-10-11 13:54:38.556110 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.556119 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 286 to dispatch throttler 286/104857600 2013-10-11 13:54:38.556189 7f43d9779780 10 cache put: name=.rgw.root+region_map 2013-10-11 13:54:38.556196 7f43d9779780 10 moving .rgw.root+region_map to cache LRU end 2013-10-11 13:54:38.556272 7f43d9779780 10 client.211130.objecter recalc_op_target tid 9 pgid 5.4322fa9f acting [63,48] 2013-10-11 13:54:38.556282 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::10c]:6828/32590, creating pipe and registering 2013-10-11 13:54:38.556335 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d95270).register_pipe 2013-10-11 13:54:38.556350 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.63 [2001:620:0:6::10c]:6828/32590 new 0x1d95010 2013-10-11 13:54:38.556361 7f43d9779780 10 client.211130.objecter op_submit oid notify.0 @5 [create 0~0] tid 9 osd.63 2013-10-11 13:54:38.556367 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6828/32590 -- osd_op(client.211130.0:9 notify.0 [create 0~0] 5.4322fa9f e90036) v4 -- ?+0 0x1d957e0 con 0x1d95270 2013-10-11 13:54:38.556364 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d95270).writer: state = connecting policy.server=0 2013-10-11 13:54:38.556406 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d95270).connect 0 2013-10-11 13:54:38.556426 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :0 s=1 pgs=0 cs=0 l=1 c=0x1d95270).connecting to [2001:620:0:6::10c]:6828/32590 2013-10-11 13:54:38.556436 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.557089 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=1 pgs=0 cs=0 l=1 c=0x1d95270).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.557173 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=1 pgs=0 cs=0 l=1 c=0x1d95270).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.557204 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=1 pgs=0 cs=0 l=1 c=0x1d95270).connect sending gseq=5 cseq=0 proto=24 2013-10-11 13:54:38.557577 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=1 pgs=0 cs=0 l=1 c=0x1d95270).reply.authorizer_len=36 2013-10-11 13:54:38.557658 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.557724 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.557764 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d95270 2013-10-11 13:54:38.557823 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.558710 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.558774 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).aborted = 0 2013-10-11 13:54:38.558853 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).reader got message 1 0x7f4390000c90 osd_op_reply(9 notify.0 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.558915 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.63 [2001:620:0:6::10c]:6828/32590 1 ==== osd_op_reply(9 notify.0 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (1707069942 0 0) 0x7f4390000c90 con 0x1d95270 2013-10-11 13:54:38.558955 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.558961 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 9 ondisk v 31'1 in 5.4322fa9f attempt 0 2013-10-11 13:54:38.558967 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.558976 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.558988 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.558989 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.559012 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).write_ack 1 2013-10-11 13:54:38.559033 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.559081 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 1 pgid 5.4322fa9f acting [63,48] 2013-10-11 13:54:38.559108 7f43d9779780 10 client.211130.objecter recalc_op_target tid 10 pgid 5.4322fa9f acting [63,48] 2013-10-11 13:54:38.559113 7f43d9779780 10 client.211130.objecter op_submit oid notify.0 @5 [watch add cookie 1 ver 0] tid 10 osd.63 2013-10-11 13:54:38.559120 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6828/32590 -- osd_op(client.211130.0:10 notify.0 [watch add cookie 1 ver 0] 5.4322fa9f e90036) v4 -- ?+0 0x1d962e0 con 0x1d95270 2013-10-11 13:54:38.559140 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.559199 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.559303 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.563455 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.563487 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).aborted = 0 2013-10-11 13:54:38.563558 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).reader got message 2 0x7f4390002520 osd_op_reply(10 notify.0 [watch add cookie 1 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.563651 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.563656 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.63 [2001:620:0:6::10c]:6828/32590 2 ==== osd_op_reply(10 notify.0 [watch add cookie 1 ver 0] ondisk = 0) v4 ==== 107+0+0 (2310388763 0 0) 0x7f4390002520 con 0x1d95270 2013-10-11 13:54:38.563690 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.563695 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 10 ondisk v 31'1 in 5.4322fa9f attempt 0 2013-10-11 13:54:38.563686 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).write_ack 2 2013-10-11 13:54:38.563702 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.563711 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.563718 7f43d08bb700 10 client.211130.objecter _linger_commit 1 2013-10-11 13:54:38.563710 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.563730 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.563822 7f43d9779780 10 client.211130.objecter recalc_op_target tid 11 pgid 5.16dafda0 acting [11,47] 2013-10-11 13:54:38.563834 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::108]:6807/17758, creating pipe and registering 2013-10-11 13:54:38.563890 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d96410).register_pipe 2013-10-11 13:54:38.563907 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.11 [2001:620:0:6::108]:6807/17758 new 0x1d96900 2013-10-11 13:54:38.563917 7f43d9779780 10 client.211130.objecter op_submit oid notify.1 @5 [create 0~0] tid 11 osd.11 2013-10-11 13:54:38.563931 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6807/17758 -- osd_op(client.211130.0:11 notify.1 [create 0~0] 5.16dafda0 e90036) v4 -- ?+0 0x1d97040 con 0x1d96410 2013-10-11 13:54:38.563930 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d96410).writer: state = connecting policy.server=0 2013-10-11 13:54:38.563974 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d96410).connect 0 2013-10-11 13:54:38.563996 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :0 s=1 pgs=0 cs=0 l=1 c=0x1d96410).connecting to [2001:620:0:6::108]:6807/17758 2013-10-11 13:54:38.564047 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.564885 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=1 pgs=0 cs=0 l=1 c=0x1d96410).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.565029 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=1 pgs=0 cs=0 l=1 c=0x1d96410).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.565049 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=1 pgs=0 cs=0 l=1 c=0x1d96410).connect sending gseq=6 cseq=0 proto=24 2013-10-11 13:54:38.565560 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=1 pgs=0 cs=0 l=1 c=0x1d96410).reply.authorizer_len=36 2013-10-11 13:54:38.565651 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.565753 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d96410 2013-10-11 13:54:38.565766 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.565856 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.567064 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.567118 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).aborted = 0 2013-10-11 13:54:38.567199 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).reader got message 1 0x7f4388000c90 osd_op_reply(11 notify.1 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.567247 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.567276 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).write_ack 1 2013-10-11 13:54:38.567293 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.567297 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.11 [2001:620:0:6::108]:6807/17758 1 ==== osd_op_reply(11 notify.1 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (3977607205 0 0) 0x7f4388000c90 con 0x1d96410 2013-10-11 13:54:38.567324 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.567327 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 11 ondisk v 31'1 in 5.16dafda0 attempt 0 2013-10-11 13:54:38.567331 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.567338 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.567347 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.567435 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 2 pgid 5.16dafda0 acting [11,47] 2013-10-11 13:54:38.567457 7f43d9779780 10 client.211130.objecter recalc_op_target tid 12 pgid 5.16dafda0 acting [11,47] 2013-10-11 13:54:38.567463 7f43d9779780 10 client.211130.objecter op_submit oid notify.1 @5 [watch add cookie 2 ver 0] tid 12 osd.11 2013-10-11 13:54:38.567471 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6807/17758 -- osd_op(client.211130.0:12 notify.1 [watch add cookie 2 ver 0] 5.16dafda0 e90036) v4 -- ?+0 0x1d97b60 con 0x1d96410 2013-10-11 13:54:38.567498 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.567525 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.567645 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.583519 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.583560 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).aborted = 0 2013-10-11 13:54:38.583679 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).reader got message 2 0x7f4388002520 osd_op_reply(12 notify.1 [watch add cookie 2 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.583714 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.583736 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).write_ack 2 2013-10-11 13:54:38.583752 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.583785 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.11 [2001:620:0:6::108]:6807/17758 2 ==== osd_op_reply(12 notify.1 [watch add cookie 2 ver 0] ondisk = 0) v4 ==== 107+0+0 (1655921732 0 0) 0x7f4388002520 con 0x1d96410 2013-10-11 13:54:38.583825 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.583829 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 12 ondisk v 31'1 in 5.16dafda0 attempt 0 2013-10-11 13:54:38.583833 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.583839 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.583841 7f43d08bb700 10 client.211130.objecter _linger_commit 2 2013-10-11 13:54:38.583849 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.583936 7f43d9779780 10 client.211130.objecter recalc_op_target tid 13 pgid 5.88aa5c95 acting [62,33] 2013-10-11 13:54:38.583948 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::10c]:6824/32504, creating pipe and registering 2013-10-11 13:54:38.584009 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).register_pipe 2013-10-11 13:54:38.584026 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.62 [2001:620:0:6::10c]:6824/32504 new 0x1d98180 2013-10-11 13:54:38.584036 7f43d9779780 10 client.211130.objecter op_submit oid notify.2 @5 [create 0~0] tid 13 osd.62 2013-10-11 13:54:38.584043 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6824/32504 -- osd_op(client.211130.0:13 notify.2 [create 0~0] 5.88aa5c95 e90036) v4 -- ?+0 0x1d98870 con 0x1d97c90 2013-10-11 13:54:38.584046 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).writer: state = connecting policy.server=0 2013-10-11 13:54:38.584088 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).connect 0 2013-10-11 13:54:38.584109 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :0 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).connecting to [2001:620:0:6::10c]:6824/32504 2013-10-11 13:54:38.584160 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.584892 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.584992 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.585025 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).connect sending gseq=7 cseq=0 proto=24 2013-10-11 13:54:38.585446 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=1 pgs=0 cs=0 l=1 c=0x1d97c90).reply.authorizer_len=36 2013-10-11 13:54:38.585532 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.585595 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.585628 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d97c90 2013-10-11 13:54:38.585688 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.586597 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.586650 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).aborted = 0 2013-10-11 13:54:38.586725 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader got message 1 0x7f4380000c90 osd_op_reply(13 notify.2 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.586795 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.586824 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).write_ack 1 2013-10-11 13:54:38.586843 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.586833 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.62 [2001:620:0:6::10c]:6824/32504 1 ==== osd_op_reply(13 notify.2 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (205894020 0 0) 0x7f4380000c90 con 0x1d97c90 2013-10-11 13:54:38.586859 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.586862 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 13 ondisk v 31'1 in 5.88aa5c95 attempt 0 2013-10-11 13:54:38.586867 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.586874 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.586884 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.586958 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 3 pgid 5.88aa5c95 acting [62,33] 2013-10-11 13:54:38.586979 7f43d9779780 10 client.211130.objecter recalc_op_target tid 14 pgid 5.88aa5c95 acting [62,33] 2013-10-11 13:54:38.586986 7f43d9779780 10 client.211130.objecter op_submit oid notify.2 @5 [watch add cookie 3 ver 0] tid 14 osd.62 2013-10-11 13:54:38.586993 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6824/32504 -- osd_op(client.211130.0:14 notify.2 [watch add cookie 3 ver 0] 5.88aa5c95 e90036) v4 -- ?+0 0x1d98dc0 con 0x1d97c90 2013-10-11 13:54:38.587016 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.587080 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.587188 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.591682 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.591715 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).aborted = 0 2013-10-11 13:54:38.591788 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader got message 2 0x7f4380002520 osd_op_reply(14 notify.2 [watch add cookie 3 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.591873 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.591874 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.62 [2001:620:0:6::10c]:6824/32504 2 ==== osd_op_reply(14 notify.2 [watch add cookie 3 ver 0] ondisk = 0) v4 ==== 107+0+0 (1579385038 0 0) 0x7f4380002520 con 0x1d97c90 2013-10-11 13:54:38.591913 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.591904 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).write_ack 2 2013-10-11 13:54:38.591917 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 14 ondisk v 31'1 in 5.88aa5c95 attempt 0 2013-10-11 13:54:38.591921 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.591927 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.591930 7f43d08bb700 10 client.211130.objecter _linger_commit 3 2013-10-11 13:54:38.591924 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.591938 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.592035 7f43d9779780 10 client.211130.objecter recalc_op_target tid 15 pgid 5.f8c99aee acting [49,10] 2013-10-11 13:54:38.592047 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::10e]:6801/28914, creating pipe and registering 2013-10-11 13:54:38.592101 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).register_pipe 2013-10-11 13:54:38.592115 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.49 [2001:620:0:6::10e]:6801/28914 new 0x1d81040 2013-10-11 13:54:38.592126 7f43d9779780 10 client.211130.objecter op_submit oid notify.3 @5 [create 0~0] tid 15 osd.49 2013-10-11 13:54:38.592136 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10e]:6801/28914 -- osd_op(client.211130.0:15 notify.3 [create 0~0] 5.f8c99aee e90036) v4 -- ?+0 0x1d98f10 con 0x1d876d0 2013-10-11 13:54:38.592149 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.592164 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).writer: state = connecting policy.server=0 2013-10-11 13:54:38.592207 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).connect 0 2013-10-11 13:54:38.592224 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :0 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).connecting to [2001:620:0:6::10e]:6801/28914 2013-10-11 13:54:38.592764 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.592907 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.592929 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).connect sending gseq=8 cseq=0 proto=24 2013-10-11 13:54:38.593357 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=1 pgs=0 cs=0 l=1 c=0x1d876d0).reply.authorizer_len=36 2013-10-11 13:54:38.593470 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.593583 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d876d0 2013-10-11 13:54:38.593593 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.593681 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.594505 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.594559 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).aborted = 0 2013-10-11 13:54:38.594660 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).reader got message 1 0x7f4378000c90 osd_op_reply(15 notify.3 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.594719 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.594748 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).write_ack 1 2013-10-11 13:54:38.594749 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.49 [2001:620:0:6::10e]:6801/28914 1 ==== osd_op_reply(15 notify.3 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (4007618063 0 0) 0x7f4378000c90 con 0x1d876d0 2013-10-11 13:54:38.594766 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.594776 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.594780 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 15 ondisk v 31'1 in 5.f8c99aee attempt 0 2013-10-11 13:54:38.594785 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.594791 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.594800 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.594908 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 4 pgid 5.f8c99aee acting [49,10] 2013-10-11 13:54:38.594946 7f43d9779780 10 client.211130.objecter recalc_op_target tid 16 pgid 5.f8c99aee acting [49,10] 2013-10-11 13:54:38.594951 7f43d9779780 10 client.211130.objecter op_submit oid notify.3 @5 [watch add cookie 4 ver 0] tid 16 osd.49 2013-10-11 13:54:38.594958 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10e]:6801/28914 -- osd_op(client.211130.0:16 notify.3 [watch add cookie 4 ver 0] 5.f8c99aee e90036) v4 -- ?+0 0x1d99280 con 0x1d876d0 2013-10-11 13:54:38.594979 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.595042 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.595162 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.600126 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.600172 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).aborted = 0 2013-10-11 13:54:38.600282 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).reader got message 2 0x7f4378002520 osd_op_reply(16 notify.3 [watch add cookie 4 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.600353 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.600381 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).write_ack 2 2013-10-11 13:54:38.600373 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.49 [2001:620:0:6::10e]:6801/28914 2 ==== osd_op_reply(16 notify.3 [watch add cookie 4 ver 0] ondisk = 0) v4 ==== 107+0+0 (2787234166 0 0) 0x7f4378002520 con 0x1d876d0 2013-10-11 13:54:38.600400 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.600404 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 16 ondisk v 31'1 in 5.f8c99aee attempt 0 2013-10-11 13:54:38.600408 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.600400 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.600415 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.600419 7f43d08bb700 10 client.211130.objecter _linger_commit 4 2013-10-11 13:54:38.600426 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.600517 7f43d9779780 10 client.211130.objecter recalc_op_target tid 17 pgid 5.a204812d acting [62,33] 2013-10-11 13:54:38.600528 7f43d9779780 10 client.211130.objecter op_submit oid notify.4 @5 [create 0~0] tid 17 osd.62 2013-10-11 13:54:38.600536 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6824/32504 -- osd_op(client.211130.0:17 notify.4 [create 0~0] 5.a204812d e90036) v4 -- ?+0 0x1d99360 con 0x1d97c90 2013-10-11 13:54:38.600559 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.600623 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.600724 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.601467 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.601500 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).aborted = 0 2013-10-11 13:54:38.601572 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader got message 3 0x7f4380002a90 osd_op_reply(17 notify.4 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.601639 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.601663 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).write_ack 3 2013-10-11 13:54:38.601680 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.601677 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.62 [2001:620:0:6::10c]:6824/32504 3 ==== osd_op_reply(17 notify.4 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (1571993625 0 0) 0x7f4380002a90 con 0x1d97c90 2013-10-11 13:54:38.601704 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.601707 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 17 ondisk v 31'3 in 5.a204812d attempt 0 2013-10-11 13:54:38.601712 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.601718 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.601728 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.601806 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 5 pgid 5.a204812d acting [62,33] 2013-10-11 13:54:38.601827 7f43d9779780 10 client.211130.objecter recalc_op_target tid 18 pgid 5.a204812d acting [62,33] 2013-10-11 13:54:38.601834 7f43d9779780 10 client.211130.objecter op_submit oid notify.4 @5 [watch add cookie 5 ver 0] tid 18 osd.62 2013-10-11 13:54:38.601841 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6824/32504 -- osd_op(client.211130.0:18 notify.4 [watch add cookie 5 ver 0] 5.a204812d e90036) v4 -- ?+0 0x1d99360 con 0x1d97c90 2013-10-11 13:54:38.601863 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.601925 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.602033 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.605879 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.605912 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).aborted = 0 2013-10-11 13:54:38.605977 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader got message 4 0x7f43800014d0 osd_op_reply(18 notify.4 [watch add cookie 5 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.606062 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.606064 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.62 [2001:620:0:6::10c]:6824/32504 4 ==== osd_op_reply(18 notify.4 [watch add cookie 5 ver 0] ondisk = 0) v4 ==== 107+0+0 (3364624971 0 0) 0x7f43800014d0 con 0x1d97c90 2013-10-11 13:54:38.606110 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.606104 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).write_ack 4 2013-10-11 13:54:38.606114 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 18 ondisk v 31'3 in 5.a204812d attempt 0 2013-10-11 13:54:38.606119 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.606125 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.606127 7f43d08bb700 10 client.211130.objecter _linger_commit 5 2013-10-11 13:54:38.606121 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.606135 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.606225 7f43d9779780 10 client.211130.objecter recalc_op_target tid 19 pgid 5.31099063 acting [17,51] 2013-10-11 13:54:38.606236 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::110]:6804/4397, creating pipe and registering 2013-10-11 13:54:38.606296 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d99430).register_pipe 2013-10-11 13:54:38.606310 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.17 [2001:620:0:6::110]:6804/4397 new 0x1d99d30 2013-10-11 13:54:38.606320 7f43d9779780 10 client.211130.objecter op_submit oid notify.5 @5 [create 0~0] tid 19 osd.17 2013-10-11 13:54:38.606327 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::110]:6804/4397 -- osd_op(client.211130.0:19 notify.5 [create 0~0] 5.31099063 e90036) v4 -- ?+0 0x1d9a4a0 con 0x1d99430 2013-10-11 13:54:38.606331 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d99430).writer: state = connecting policy.server=0 2013-10-11 13:54:38.606373 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d99430).connect 0 2013-10-11 13:54:38.606394 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :0 s=1 pgs=0 cs=0 l=1 c=0x1d99430).connecting to [2001:620:0:6::110]:6804/4397 2013-10-11 13:54:38.606433 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.607144 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=1 pgs=0 cs=0 l=1 c=0x1d99430).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.607331 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=1 pgs=0 cs=0 l=1 c=0x1d99430).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.607353 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=1 pgs=0 cs=0 l=1 c=0x1d99430).connect sending gseq=9 cseq=0 proto=24 2013-10-11 13:54:38.607881 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=1 pgs=0 cs=0 l=1 c=0x1d99430).reply.authorizer_len=36 2013-10-11 13:54:38.608060 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.608158 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d99430 2013-10-11 13:54:38.608168 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.608320 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.609357 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.609417 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).aborted = 0 2013-10-11 13:54:38.609520 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).reader got message 1 0x7f4370000c90 osd_op_reply(19 notify.5 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.609552 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.609581 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).write_ack 1 2013-10-11 13:54:38.609599 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.609612 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.17 [2001:620:0:6::110]:6804/4397 1 ==== osd_op_reply(19 notify.5 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (2007658913 0 0) 0x7f4370000c90 con 0x1d99430 2013-10-11 13:54:38.609638 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.609642 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 19 ondisk v 31'1 in 5.31099063 attempt 0 2013-10-11 13:54:38.609646 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.609653 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.609662 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.609766 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 6 pgid 5.31099063 acting [17,51] 2013-10-11 13:54:38.609802 7f43d9779780 10 client.211130.objecter recalc_op_target tid 20 pgid 5.31099063 acting [17,51] 2013-10-11 13:54:38.609808 7f43d9779780 10 client.211130.objecter op_submit oid notify.5 @5 [watch add cookie 6 ver 0] tid 20 osd.17 2013-10-11 13:54:38.609821 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::110]:6804/4397 -- osd_op(client.211130.0:20 notify.5 [watch add cookie 6 ver 0] 5.31099063 e90036) v4 -- ?+0 0x1d9af20 con 0x1d99430 2013-10-11 13:54:38.609842 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.609850 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.609959 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.627027 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.627061 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).aborted = 0 2013-10-11 13:54:38.627162 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).reader got message 2 0x7f4370002520 osd_op_reply(20 notify.5 [watch add cookie 6 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.627211 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.627237 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).write_ack 2 2013-10-11 13:54:38.627256 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.627254 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.17 [2001:620:0:6::110]:6804/4397 2 ==== osd_op_reply(20 notify.5 [watch add cookie 6 ver 0] ondisk = 0) v4 ==== 107+0+0 (2167970431 0 0) 0x7f4370002520 con 0x1d99430 2013-10-11 13:54:38.627282 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.627285 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 20 ondisk v 31'1 in 5.31099063 attempt 0 2013-10-11 13:54:38.627289 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.627296 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.627299 7f43d08bb700 10 client.211130.objecter _linger_commit 6 2013-10-11 13:54:38.627307 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.627412 7f43d9779780 10 client.211130.objecter recalc_op_target tid 21 pgid 5.97c520d4 acting [9,60] 2013-10-11 13:54:38.627424 7f43d9779780 10 client.211130.objecter op_submit oid notify.6 @5 [create 0~0] tid 21 osd.9 2013-10-11 13:54:38.627431 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:21 notify.6 [create 0~0] 5.97c520d4 e90036) v4 -- ?+0 0x1d9af20 con 0x1d83f20 2013-10-11 13:54:38.627451 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.627495 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.627599 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.628783 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.628816 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.628911 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 5 0x7f43a8005a10 osd_op_reply(21 notify.6 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.628942 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.628965 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 5 2013-10-11 13:54:38.628981 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.629030 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 5 ==== osd_op_reply(21 notify.6 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (390432425 0 0) 0x7f43a8005a10 con 0x1d83f20 2013-10-11 13:54:38.629057 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.629060 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 21 ondisk v 31'1 in 5.97c520d4 attempt 0 2013-10-11 13:54:38.629064 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.629073 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.629082 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.629216 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 7 pgid 5.97c520d4 acting [9,60] 2013-10-11 13:54:38.629260 7f43d9779780 10 client.211130.objecter recalc_op_target tid 22 pgid 5.97c520d4 acting [9,60] 2013-10-11 13:54:38.629266 7f43d9779780 10 client.211130.objecter op_submit oid notify.6 @5 [watch add cookie 7 ver 0] tid 22 osd.9 2013-10-11 13:54:38.629273 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:22 notify.6 [watch add cookie 7 ver 0] 5.97c520d4 e90036) v4 -- ?+0 0x1d9b610 con 0x1d83f20 2013-10-11 13:54:38.629293 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.629300 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.629395 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.636091 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.636127 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.636196 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 6 0x7f43a8005f10 osd_op_reply(22 notify.6 [watch add cookie 7 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.636233 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.636263 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 6 2013-10-11 13:54:38.636282 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.636296 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 6 ==== osd_op_reply(22 notify.6 [watch add cookie 7 ver 0] ondisk = 0) v4 ==== 107+0+0 (1008171100 0 0) 0x7f43a8005f10 con 0x1d83f20 2013-10-11 13:54:38.636324 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.636327 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 22 ondisk v 31'1 in 5.97c520d4 attempt 0 2013-10-11 13:54:38.636331 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.636338 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.636340 7f43d08bb700 10 client.211130.objecter _linger_commit 7 2013-10-11 13:54:38.636348 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.636462 7f43d9779780 10 client.211130.objecter recalc_op_target tid 23 pgid 5.84ada7c9 acting [10,55] 2013-10-11 13:54:38.636473 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 connect_rank to [2001:620:0:6::108]:6800/17670, creating pipe and registering 2013-10-11 13:54:38.636524 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).register_pipe 2013-10-11 13:54:38.636539 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 get_connection osd.10 [2001:620:0:6::108]:6800/17670 new 0x1d8b410 2013-10-11 13:54:38.636549 7f43d9779780 10 client.211130.objecter op_submit oid notify.7 @5 [create 0~0] tid 23 osd.10 2013-10-11 13:54:38.636556 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6800/17670 -- osd_op(client.211130.0:23 notify.7 [create 0~0] 5.84ada7c9 e90036) v4 -- ?+0 0x1d9bae0 con 0x1d9b610 2013-10-11 13:54:38.636557 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).writer: state = connecting policy.server=0 2013-10-11 13:54:38.636604 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=-1 :0 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).connect 0 2013-10-11 13:54:38.636625 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :0 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).connecting to [2001:620:0:6::108]:6800/17670 2013-10-11 13:54:38.636676 7f43d9779780 5 client.211130.objecter 1 unacked, 0 uncommitted 2013-10-11 13:54:38.637383 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).connect sent my addr [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.637527 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).connect.authorizer_len=174 protocol=2 2013-10-11 13:54:38.637552 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).connect sending gseq=10 cseq=0 proto=24 2013-10-11 13:54:38.638040 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=1 pgs=0 cs=0 l=1 c=0x1d9b610).reply.authorizer_len=36 2013-10-11 13:54:38.638143 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).connect success 1, lossy = 1, features 34359738367 2013-10-11 13:54:38.638239 7f43d08bb700 10 client.211130.objecter ms_handle_connect 0x1d9b610 2013-10-11 13:54:38.638254 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.638350 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.639625 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.639683 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).aborted = 0 2013-10-11 13:54:38.639788 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).reader got message 1 0x7f436c000c90 osd_op_reply(23 notify.7 [create 0~0] ondisk = 0) v4 2013-10-11 13:54:38.639843 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.639876 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).write_ack 1 2013-10-11 13:54:38.639892 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.639883 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.10 [2001:620:0:6::108]:6800/17670 1 ==== osd_op_reply(23 notify.7 [create 0~0] ondisk = 0) v4 ==== 107+0+0 (2950480587 0 0) 0x7f436c000c90 con 0x1d9b610 2013-10-11 13:54:38.639910 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.639914 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 23 ondisk v 31'1 in 5.84ada7c9 attempt 0 2013-10-11 13:54:38.639919 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.639925 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.639934 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.640049 7f43d9779780 10 client.211130.objecter recalc_linger_op_target tid 8 pgid 5.84ada7c9 acting [10,55] 2013-10-11 13:54:38.640092 7f43d9779780 10 client.211130.objecter recalc_op_target tid 24 pgid 5.84ada7c9 acting [10,55] 2013-10-11 13:54:38.640097 7f43d9779780 10 client.211130.objecter op_submit oid notify.7 @5 [watch add cookie 8 ver 0] tid 24 osd.10 2013-10-11 13:54:38.640112 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6800/17670 -- osd_op(client.211130.0:24 notify.7 [watch add cookie 8 ver 0] 5.84ada7c9 e90036) v4 -- ?+0 0x1d9bfb0 con 0x1d9b610 2013-10-11 13:54:38.640133 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.640170 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.640291 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.648110 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.648146 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).aborted = 0 2013-10-11 13:54:38.648264 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).reader got message 2 0x7f436c002520 osd_op_reply(24 notify.7 [watch add cookie 8 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.648329 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.648353 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).write_ack 2 2013-10-11 13:54:38.648371 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.648370 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.10 [2001:620:0:6::108]:6800/17670 2 ==== osd_op_reply(24 notify.7 [watch add cookie 8 ver 0] ondisk = 0) v4 ==== 107+0+0 (1820271987 0 0) 0x7f436c002520 con 0x1d9b610 2013-10-11 13:54:38.648397 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.648401 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 24 ondisk v 31'1 in 5.84ada7c9 attempt 0 2013-10-11 13:54:38.648405 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 could not fetch user info: no user info saved2013-10-11 13:54:38.648412 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.648414 7f43d08bb700 10 client.211130.objecter _linger_commit 8 2013-10-11 13:54:38.648422 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.648753 7f43d9779780 10 client.211130.objecter recalc_op_target tid 25 pgid 5.4322fa9f acting [63,48] 2013-10-11 13:54:38.648768 7f43d9779780 10 client.211130.objecter op_submit oid notify.0 @5 [watch remove cookie 1 ver 0] tid 25 osd.63 2013-10-11 13:54:38.648777 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6828/32590 -- osd_op(client.211130.0:25 notify.0 [watch remove cookie 1 ver 0] 5.4322fa9f e90036) v4 -- ?+0 0x1d9c2c0 con 0x1d95270 2013-10-11 13:54:38.648796 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.648882 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.648989 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.652871 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.652903 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).aborted = 0 2013-10-11 13:54:38.652974 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).reader got message 3 0x7f4390002a90 osd_op_reply(25 notify.0 [watch remove cookie 1 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.653047 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.653052 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.63 [2001:620:0:6::10c]:6828/32590 3 ==== osd_op_reply(25 notify.0 [watch remove cookie 1 ver 0] ondisk = 0) v4 ==== 107+0+0 (945751809 0 0) 0x7f4390002a90 con 0x1d95270 2013-10-11 13:54:38.653080 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.653085 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 25 ondisk v 31'1 in 5.4322fa9f attempt 0 2013-10-11 13:54:38.653076 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).write_ack 3 2013-10-11 13:54:38.653092 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.653103 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.653101 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).writer: state = open policy.server=0 2013-10-11 13:54:38.653116 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.653154 7f43d9779780 10 client.211130.objecter recalc_op_target tid 26 pgid 5.16dafda0 acting [11,47] 2013-10-11 13:54:38.653165 7f43d9779780 10 client.211130.objecter op_submit oid notify.1 @5 [watch remove cookie 2 ver 0] tid 26 osd.11 2013-10-11 13:54:38.653174 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6807/17758 -- osd_op(client.211130.0:26 notify.1 [watch remove cookie 2 ver 0] 5.16dafda0 e90036) v4 -- ?+0 0x1d9c2c0 con 0x1d96410 2013-10-11 13:54:38.653196 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.653267 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.653370 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.658355 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.658398 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).aborted = 0 2013-10-11 13:54:38.658484 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).reader got message 3 0x7f4388002a90 osd_op_reply(26 notify.1 [watch remove cookie 2 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.658523 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.658542 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).write_ack 3 2013-10-11 13:54:38.658558 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).writer: state = open policy.server=0 2013-10-11 13:54:38.658584 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.11 [2001:620:0:6::108]:6807/17758 3 ==== osd_op_reply(26 notify.1 [watch remove cookie 2 ver 0] ondisk = 0) v4 ==== 107+0+0 (3545884510 0 0) 0x7f4388002a90 con 0x1d96410 2013-10-11 13:54:38.658610 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.658614 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 26 ondisk v 31'1 in 5.16dafda0 attempt 0 2013-10-11 13:54:38.658618 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.658625 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.658633 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.658719 7f43d9779780 10 client.211130.objecter recalc_op_target tid 27 pgid 5.88aa5c95 acting [62,33] 2013-10-11 13:54:38.658730 7f43d9779780 10 client.211130.objecter op_submit oid notify.2 @5 [watch remove cookie 3 ver 0] tid 27 osd.62 2013-10-11 13:54:38.658739 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6824/32504 -- osd_op(client.211130.0:27 notify.2 [watch remove cookie 3 ver 0] 5.88aa5c95 e90036) v4 -- ?+0 0x1d976a0 con 0x1d97c90 2013-10-11 13:54:38.658764 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.658827 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.658928 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.663148 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.663181 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).aborted = 0 2013-10-11 13:54:38.663252 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader got message 5 0x7f43800019c0 osd_op_reply(27 notify.2 [watch remove cookie 3 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.663339 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.663344 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.62 [2001:620:0:6::10c]:6824/32504 5 ==== osd_op_reply(27 notify.2 [watch remove cookie 3 ver 0] ondisk = 0) v4 ==== 107+0+0 (4022942676 0 0) 0x7f43800019c0 con 0x1d97c90 2013-10-11 13:54:38.663393 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.663397 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 27 ondisk v 31'1 in 5.88aa5c95 attempt 0 2013-10-11 13:54:38.663388 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).write_ack 5 2013-10-11 13:54:38.663404 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.663413 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.663413 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.663424 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.663538 7f43d9779780 10 client.211130.objecter recalc_op_target tid 28 pgid 5.f8c99aee acting [49,10] 2013-10-11 13:54:38.663549 7f43d9779780 10 client.211130.objecter op_submit oid notify.3 @5 [watch remove cookie 4 ver 0] tid 28 osd.49 2013-10-11 13:54:38.663557 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10e]:6801/28914 -- osd_op(client.211130.0:28 notify.3 [watch remove cookie 4 ver 0] 5.f8c99aee e90036) v4 -- ?+0 0x1d976a0 con 0x1d876d0 2013-10-11 13:54:38.663577 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.663673 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.663772 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.668966 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.668999 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).aborted = 0 2013-10-11 13:54:38.669210 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).reader got message 3 0x7f4378002a90 osd_op_reply(28 notify.3 [watch remove cookie 4 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.669332 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.669367 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).write_ack 3 2013-10-11 13:54:38.669385 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).writer: state = open policy.server=0 2013-10-11 13:54:38.669421 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.49 [2001:620:0:6::10e]:6801/28914 3 ==== osd_op_reply(28 notify.3 [watch remove cookie 4 ver 0] ondisk = 0) v4 ==== 107+0+0 (399207020 0 0) 0x7f4378002a90 con 0x1d876d0 2013-10-11 13:54:38.669448 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.669452 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 28 ondisk v 31'1 in 5.f8c99aee attempt 0 2013-10-11 13:54:38.669456 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.669462 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.669471 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.669560 7f43d9779780 10 client.211130.objecter recalc_op_target tid 29 pgid 5.a204812d acting [62,33] 2013-10-11 13:54:38.669572 7f43d9779780 10 client.211130.objecter op_submit oid notify.4 @5 [watch remove cookie 5 ver 0] tid 29 osd.62 2013-10-11 13:54:38.669581 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::10c]:6824/32504 -- osd_op(client.211130.0:29 notify.4 [watch remove cookie 5 ver 0] 5.a204812d e90036) v4 -- ?+0 0x1d976a0 con 0x1d97c90 2013-10-11 13:54:38.669605 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.669667 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.669768 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.673869 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.673903 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).aborted = 0 2013-10-11 13:54:38.673968 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).reader got message 6 0x7f43800019d0 osd_op_reply(29 notify.4 [watch remove cookie 5 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.674046 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.674050 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.62 [2001:620:0:6::10c]:6824/32504 6 ==== osd_op_reply(29 notify.4 [watch remove cookie 5 ver 0] ondisk = 0) v4 ==== 107+0+0 (2036769105 0 0) 0x7f43800019d0 con 0x1d97c90 2013-10-11 13:54:38.674101 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.674106 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 29 ondisk v 31'3 in 5.a204812d attempt 0 2013-10-11 13:54:38.674094 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).write_ack 6 2013-10-11 13:54:38.674112 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.674121 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.674119 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).writer: state = open policy.server=0 2013-10-11 13:54:38.674132 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.674238 7f43d9779780 10 client.211130.objecter recalc_op_target tid 30 pgid 5.31099063 acting [17,51] 2013-10-11 13:54:38.674249 7f43d9779780 10 client.211130.objecter op_submit oid notify.5 @5 [watch remove cookie 6 ver 0] tid 30 osd.17 2013-10-11 13:54:38.674257 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::110]:6804/4397 -- osd_op(client.211130.0:30 notify.5 [watch remove cookie 6 ver 0] 5.31099063 e90036) v4 -- ?+0 0x1d97040 con 0x1d99430 2013-10-11 13:54:38.674278 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.674352 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.674454 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.679082 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.679114 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).aborted = 0 2013-10-11 13:54:38.679216 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).reader got message 3 0x7f4370002a90 osd_op_reply(30 notify.5 [watch remove cookie 6 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.679284 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.679313 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).write_ack 3 2013-10-11 13:54:38.679311 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.17 [2001:620:0:6::110]:6804/4397 3 ==== osd_op_reply(30 notify.5 [watch remove cookie 6 ver 0] ondisk = 0) v4 ==== 107+0+0 (819077477 0 0) 0x7f4370002a90 con 0x1d99430 2013-10-11 13:54:38.679338 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.679332 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).writer: state = open policy.server=0 2013-10-11 13:54:38.679342 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 30 ondisk v 31'1 in 5.31099063 attempt 0 2013-10-11 13:54:38.679346 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.679353 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.679362 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.679466 7f43d9779780 10 client.211130.objecter recalc_op_target tid 31 pgid 5.97c520d4 acting [9,60] 2013-10-11 13:54:38.679477 7f43d9779780 10 client.211130.objecter op_submit oid notify.6 @5 [watch remove cookie 7 ver 0] tid 31 osd.9 2013-10-11 13:54:38.679485 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6816/18863 -- osd_op(client.211130.0:31 notify.6 [watch remove cookie 7 ver 0] 5.97c520d4 e90036) v4 -- ?+0 0x1d976a0 con 0x1d83f20 2013-10-11 13:54:38.679505 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.679514 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.679609 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.684582 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.684614 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).aborted = 0 2013-10-11 13:54:38.684709 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).reader got message 7 0x7f43a8005090 osd_op_reply(31 notify.6 [watch remove cookie 7 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.684778 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.684806 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).write_ack 7 2013-10-11 13:54:38.684804 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.9 [2001:620:0:6::108]:6816/18863 7 ==== osd_op_reply(31 notify.6 [watch remove cookie 7 ver 0] ondisk = 0) v4 ==== 107+0+0 (2382218054 0 0) 0x7f43a8005090 con 0x1d83f20 2013-10-11 13:54:38.684831 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.684825 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).writer: state = open policy.server=0 2013-10-11 13:54:38.684834 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 31 ondisk v 31'1 in 5.97c520d4 attempt 0 2013-10-11 13:54:38.684839 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.684846 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.684855 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.684970 7f43d9779780 10 client.211130.objecter recalc_op_target tid 32 pgid 5.84ada7c9 acting [10,55] 2013-10-11 13:54:38.684981 7f43d9779780 10 client.211130.objecter op_submit oid notify.7 @5 [watch remove cookie 8 ver 0] tid 32 osd.10 2013-10-11 13:54:38.684989 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 --> [2001:620:0:6::108]:6800/17670 -- osd_op(client.211130.0:32 notify.7 [watch remove cookie 8 ver 0] 5.84ada7c9 e90036) v4 -- ?+0 0x1d9a4a0 con 0x1d9b610 2013-10-11 13:54:38.685113 7f43d9779780 5 client.211130.objecter 0 unacked, 1 uncommitted 2013-10-11 13:54:38.685196 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.685304 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.689955 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).reader wants 107 from dispatch throttler 0/104857600 2013-10-11 13:54:38.689988 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).aborted = 0 2013-10-11 13:54:38.690079 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).reader got message 3 0x7f436c002a90 osd_op_reply(32 notify.7 [watch remove cookie 8 ver 0] ondisk = 0) v4 2013-10-11 13:54:38.690116 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.690140 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).write_ack 3 2013-10-11 13:54:38.690156 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).writer: state = open policy.server=0 2013-10-11 13:54:38.690185 7f43d08bb700 1 -- [2001:620:0:6::d0]:0/1028435 <== osd.10 [2001:620:0:6::108]:6800/17670 3 ==== osd_op_reply(32 notify.7 [watch remove cookie 8 ver 0] ondisk = 0) v4 ==== 107+0+0 (3717570153 0 0) 0x7f436c002a90 con 0x1d9b610 2013-10-11 13:54:38.690212 7f43d08bb700 10 client.211130.objecter in handle_osd_op_reply 2013-10-11 13:54:38.690215 7f43d08bb700 7 client.211130.objecter handle_osd_op_reply 32 ondisk v 31'1 in 5.84ada7c9 attempt 0 2013-10-11 13:54:38.690219 7f43d08bb700 10 client.211130.objecter op 0 rval 0 len 0 2013-10-11 13:54:38.690226 7f43d08bb700 5 client.211130.objecter 0 unacked, 0 uncommitted 2013-10-11 13:54:38.690235 7f43d08bb700 10 -- [2001:620:0:6::d0]:0/1028435 dispatch_throttle_release 107 to dispatch throttler 107/104857600 2013-10-11 13:54:38.690574 7f43d9779780 10 client.211130.objecter close_session for osd.9 2013-10-11 13:54:38.690589 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d83f20 -- 0x1d83cc0 2013-10-11 13:54:38.690602 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).unregister_pipe 2013-10-11 13:54:38.690618 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=2 pgs=1704 cs=1 l=1 c=0x1d83f20).stop 2013-10-11 13:54:38.690732 7f43d9779780 10 client.211130.objecter close_session for osd.10 2013-10-11 13:54:38.690736 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d9b610 -- 0x1d8b410 2013-10-11 13:54:38.690743 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).unregister_pipe 2013-10-11 13:54:38.690738 7f43ccfb3700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).writer done 2013-10-11 13:54:38.690753 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=2 pgs=1411 cs=1 l=1 c=0x1d9b610).stop 2013-10-11 13:54:38.690741 7f43cceb2700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).reader couldn't read tag, Success 2013-10-11 13:54:38.690769 7f43cceb2700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).fault 0: Success 2013-10-11 13:54:38.690783 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).fault already closed|closing 2013-10-11 13:54:38.690796 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d83cc0 2013-10-11 13:54:38.690828 7f43d9779780 10 client.211130.objecter close_session for osd.11 2013-10-11 13:54:38.690832 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d96410 -- 0x1d96900 2013-10-11 13:54:38.690837 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).unregister_pipe 2013-10-11 13:54:38.690846 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=2 pgs=1503 cs=1 l=1 c=0x1d96410).stop 2013-10-11 13:54:38.690837 7f4377efe700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).writer done 2013-10-11 13:54:38.690838 7f4377dfd700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).reader couldn't read tag, Success 2013-10-11 13:54:38.690865 7f4377dfd700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).fault 0: Success 2013-10-11 13:54:38.690869 7f43d9779780 10 client.211130.objecter close_session for osd.17 2013-10-11 13:54:38.690875 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).fault already closed|closing 2013-10-11 13:54:38.690885 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d8b410 2013-10-11 13:54:38.690875 7f43cc7ab700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).writer done 2013-10-11 13:54:38.690900 7f4377dfd700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).reader done 2013-10-11 13:54:38.690885 7f43cc6aa700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).reader couldn't read tag, Success 2013-10-11 13:54:38.690900 7f43cceb2700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).reader done 2013-10-11 13:54:38.690901 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.690914 7f43cc6aa700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).fault 0: Success 2013-10-11 13:54:38.690920 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d83cc0 [2001:620:0:6::108]:6816/18863 2013-10-11 13:54:38.690928 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).fault already closed|closing 2013-10-11 13:54:38.690933 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).discard_queue 2013-10-11 13:54:38.690939 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d96900 2013-10-11 13:54:38.690944 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6816/18863 pipe(0x1d83cc0 sd=4 :50521 s=4 pgs=1704 cs=1 l=1 c=0x1d83f20).unregister_pipe - not registered 2013-10-11 13:54:38.690971 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d83cc0 [2001:620:0:6::108]:6816/18863 2013-10-11 13:54:38.690985 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d83cc0 2013-10-11 13:54:38.690990 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d8b410 [2001:620:0:6::108]:6800/17670 2013-10-11 13:54:38.691000 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).discard_queue 2013-10-11 13:54:38.691008 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6800/17670 pipe(0x1d8b410 sd=12 :60578 s=4 pgs=1411 cs=1 l=1 c=0x1d9b610).unregister_pipe - not registered 2013-10-11 13:54:38.691022 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d8b410 [2001:620:0:6::108]:6800/17670 2013-10-11 13:54:38.691030 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d8b410 2013-10-11 13:54:38.691034 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.691107 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d99430 -- 0x1d99d30 2013-10-11 13:54:38.691124 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).unregister_pipe 2013-10-11 13:54:38.691138 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=2 pgs=739 cs=1 l=1 c=0x1d99430).stop 2013-10-11 13:54:38.691185 7f43d9779780 10 client.211130.objecter close_session for osd.49 2013-10-11 13:54:38.691190 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d876d0 -- 0x1d81040 2013-10-11 13:54:38.691181 7f4377fff700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).reader couldn't read tag, Success 2013-10-11 13:54:38.691197 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).unregister_pipe 2013-10-11 13:54:38.691202 7f4377fff700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).fault 0: Success 2013-10-11 13:54:38.691207 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=2 pgs=210 cs=1 l=1 c=0x1d876d0).stop 2013-10-11 13:54:38.691212 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).fault already closed|closing 2013-10-11 13:54:38.691224 7f4377fff700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).reader done 2013-10-11 13:54:38.691232 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d99d30 2013-10-11 13:54:38.691241 7f43cc3a7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).writer done 2013-10-11 13:54:38.691283 7f43d9779780 10 client.211130.objecter close_session for osd.52 2013-10-11 13:54:38.691287 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d924d0 -- 0x1d92270 2013-10-11 13:54:38.691285 7f43cc1a5700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).writer done 2013-10-11 13:54:38.691293 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).unregister_pipe 2013-10-11 13:54:38.691301 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=2 pgs=240 cs=1 l=1 c=0x1d924d0).stop 2013-10-11 13:54:38.691297 7f43cc2a6700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).reader couldn't read tag, Success 2013-10-11 13:54:38.691329 7f43d9779780 10 client.211130.objecter close_session for osd.62 2013-10-11 13:54:38.691325 7f43cc2a6700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).fault 0: Success 2013-10-11 13:54:38.691326 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.691338 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).fault already closed|closing 2013-10-11 13:54:38.691331 7f43ccaae700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).reader couldn't read tag, Success 2013-10-11 13:54:38.691340 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d99d30 [2001:620:0:6::110]:6804/4397 2013-10-11 13:54:38.691349 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d81040 2013-10-11 13:54:38.691349 7f43ccaae700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).fault 0: Success 2013-10-11 13:54:38.691350 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).discard_queue 2013-10-11 13:54:38.691358 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).fault already closed|closing 2013-10-11 13:54:38.691362 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::110]:6804/4397 pipe(0x1d99d30 sd=11 :34978 s=4 pgs=739 cs=1 l=1 c=0x1d99430).unregister_pipe - not registered 2013-10-11 13:54:38.691366 7f43ccaae700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).reader done 2013-10-11 13:54:38.691381 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d99d30 [2001:620:0:6::110]:6804/4397 2013-10-11 13:54:38.691382 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d92270 2013-10-11 13:54:38.691393 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d99d30 2013-10-11 13:54:38.691397 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.691473 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d97c90 -- 0x1d98180 2013-10-11 13:54:38.691489 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).unregister_pipe 2013-10-11 13:54:38.691503 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=2 pgs=1420 cs=1 l=1 c=0x1d97c90).stop 2013-10-11 13:54:38.691548 7f43d9779780 10 client.211130.objecter close_session for osd.63 2013-10-11 13:54:38.691555 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d95270 -- 0x1d95010 2013-10-11 13:54:38.691562 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).unregister_pipe 2013-10-11 13:54:38.691554 7f43cc5a9700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).writer done 2013-10-11 13:54:38.691557 7f43cc6aa700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).reader done 2013-10-11 13:54:38.691571 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=2 pgs=1477 cs=1 l=1 c=0x1d95270).stop 2013-10-11 13:54:38.691603 7f43d9779780 10 client.211130.objecter close_session for osd.64 2013-10-11 13:54:38.691609 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d8f400 -- 0x1d8f1a0 2013-10-11 13:54:38.691615 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).unregister_pipe 2013-10-11 13:54:38.691609 7f43cc2a6700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).reader done 2013-10-11 13:54:38.691624 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=2 pgs=1517 cs=1 l=1 c=0x1d8f400).stop 2013-10-11 13:54:38.691610 7f43ccbaf700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).writer done 2013-10-11 13:54:38.691608 7f43cc4a8700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).reader couldn't read tag, Success 2013-10-11 13:54:38.691636 7f43cc4a8700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).fault 0: Success 2013-10-11 13:54:38.691656 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.691654 7f43ccdb1700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).writer done 2013-10-11 13:54:38.691657 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).fault already closed|closing 2013-10-11 13:54:38.691654 7f43cccb0700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).reader couldn't read tag, Success 2013-10-11 13:54:38.691669 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d96900 [2001:620:0:6::108]:6807/17758 2013-10-11 13:54:38.691660 7f43cc9ad700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).writer done 2013-10-11 13:54:38.691659 7f43cc8ac700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).reader couldn't read tag, Success 2013-10-11 13:54:38.691677 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d98180 2013-10-11 13:54:38.691677 7f43cccb0700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).fault 0: Success 2013-10-11 13:54:38.691683 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).discard_queue 2013-10-11 13:54:38.691687 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).fault already closed|closing 2013-10-11 13:54:38.691692 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::108]:6807/17758 pipe(0x1d96900 sd=8 :42856 s=4 pgs=1503 cs=1 l=1 c=0x1d96410).unregister_pipe - not registered 2013-10-11 13:54:38.691697 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d8f1a0 2013-10-11 13:54:38.691686 7f43cc8ac700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).fault 0: Success 2013-10-11 13:54:38.691710 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d96900 [2001:620:0:6::108]:6807/17758 2013-10-11 13:54:38.691721 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d96900 2013-10-11 13:54:38.691709 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).fault already closed|closing 2013-10-11 13:54:38.691725 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d81040 [2001:620:0:6::10e]:6801/28914 2013-10-11 13:54:38.691729 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d95010 2013-10-11 13:54:38.691731 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).discard_queue 2013-10-11 13:54:38.691739 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6801/28914 pipe(0x1d81040 sd=10 :51628 s=4 pgs=210 cs=1 l=1 c=0x1d876d0).unregister_pipe - not registered 2013-10-11 13:54:38.691753 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d81040 [2001:620:0:6::10e]:6801/28914 2013-10-11 13:54:38.691788 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d81040 2013-10-11 13:54:38.691793 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d92270 [2001:620:0:6::10e]:6820/7836 2013-10-11 13:54:38.691799 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).discard_queue 2013-10-11 13:54:38.691808 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10e]:6820/7836 pipe(0x1d92270 sd=6 :37217 s=4 pgs=240 cs=1 l=1 c=0x1d924d0).unregister_pipe - not registered 2013-10-11 13:54:38.691850 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d92270 [2001:620:0:6::10e]:6820/7836 2013-10-11 13:54:38.691868 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d92270 2013-10-11 13:54:38.691872 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.691960 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.691967 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d98180 [2001:620:0:6::10c]:6824/32504 2013-10-11 13:54:38.691957 7f43cc4a8700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).reader done 2013-10-11 13:54:38.691974 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).discard_queue 2013-10-11 13:54:38.691983 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6824/32504 pipe(0x1d98180 sd=9 :46771 s=4 pgs=1420 cs=1 l=1 c=0x1d97c90).unregister_pipe - not registered 2013-10-11 13:54:38.691998 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d98180 [2001:620:0:6::10c]:6824/32504 2013-10-11 13:54:38.692007 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d98180 2013-10-11 13:54:38.692010 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.692098 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.692095 7f43cc8ac700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).reader done 2013-10-11 13:54:38.692112 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d95010 [2001:620:0:6::10c]:6828/32590 2013-10-11 13:54:38.692120 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).discard_queue 2013-10-11 13:54:38.692129 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6828/32590 pipe(0x1d95010 sd=7 :48995 s=4 pgs=1477 cs=1 l=1 c=0x1d95270).unregister_pipe - not registered 2013-10-11 13:54:38.692168 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d95010 [2001:620:0:6::10c]:6828/32590 2013-10-11 13:54:38.692186 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d95010 2013-10-11 13:54:38.692190 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.692268 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.692210 7f43cccb0700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).reader done 2013-10-11 13:54:38.692277 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d8f1a0 [2001:620:0:6::10c]:6832/32676 2013-10-11 13:54:38.692288 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).discard_queue 2013-10-11 13:54:38.692303 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::10c]:6832/32676 pipe(0x1d8f1a0 sd=5 :58352 s=4 pgs=1517 cs=1 l=1 c=0x1d8f400).unregister_pipe - not registered 2013-10-11 13:54:38.692346 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d8f1a0 [2001:620:0:6::10c]:6832/32676 2013-10-11 13:54:38.692359 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d8f1a0 2013-10-11 13:54:38.692363 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.692440 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down 0x1d87ad0 -- 0x1d87870 2013-10-11 13:54:38.692456 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).unregister_pipe 2013-10-11 13:54:38.692470 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=2 pgs=19827 cs=1 l=1 c=0x1d87ad0).stop 2013-10-11 13:54:38.692514 7f43d9771700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).writer done 2013-10-11 13:54:38.692543 7f43ce8b7700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader couldn't read tag, Success 2013-10-11 13:54:38.692565 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 shutdown [2001:620:0:6::d0]:0/1028435 2013-10-11 13:54:38.692591 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 mark_down_all 2013-10-11 13:54:38.692575 7f43ce8b7700 2 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).fault 0: Success 2013-10-11 13:54:38.692602 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 wait: waiting for dispatch queue 2013-10-11 13:54:38.692601 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).fault already closed|closing 2013-10-11 13:54:38.692620 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 queue_reap 0x1d87870 2013-10-11 13:54:38.692662 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.692663 7f43ce8b7700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).reader done 2013-10-11 13:54:38.692670 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaping pipe 0x1d87870 [2001:620:0:6::106]:6789/0 2013-10-11 13:54:38.692677 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).discard_queue 2013-10-11 13:54:38.692685 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 >> [2001:620:0:6::106]:6789/0 pipe(0x1d87870 sd=3 :57368 s=4 pgs=19827 cs=1 l=1 c=0x1d87ad0).unregister_pipe - not registered 2013-10-11 13:54:38.692755 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 wait: dispatch queue is stopped 2013-10-11 13:54:38.692767 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper reaped pipe 0x1d87870 [2001:620:0:6::106]:6789/0 2013-10-11 13:54:38.692781 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper deleted pipe 0x1d87870 2013-10-11 13:54:38.692789 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.692841 7f43d00ba700 10 -- [2001:620:0:6::d0]:0/1028435 reaper_entry done 2013-10-11 13:54:38.692900 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 wait: closing pipes 2013-10-11 13:54:38.692914 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 reaper 2013-10-11 13:54:38.692920 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 reaper done 2013-10-11 13:54:38.692924 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 wait: waiting for pipes to close 2013-10-11 13:54:38.692931 7f43d9779780 10 -- [2001:620:0:6::d0]:0/1028435 wait: done. 2013-10-11 13:54:38.692935 7f43d9779780 1 -- [2001:620:0:6::d0]:0/1028435 shutdown complete. root@ineri:~#
Attachment:
smime.p7s
Description: S/MIME Cryptographic Signature
_______________________________________________ ceph-users mailing list ceph-users@xxxxxxxxxxxxxx http://lists.ceph.com/listinfo.cgi/ceph-users-ceph.com