gistfile1.txt

2011-06-01 11:11:21.650239 7f2eb8984700 osd0 26 ping from client1721501
2011-06-01 11:11:21.745931 7f2ebd18d700 filestore(/data/osd0) sync_entry woke after 5.000141
2011-06-01 11:11:21.745953 7f2ebd18d700 journal commit_start op_seq 555711, applied_seq 555711, committed_seq 555711
2011-06-01 11:11:21.745964 7f2ebd18d700 journal commit_start nothing to do
2011-06-01 11:11:21.745972 7f2ebd18d700 journal commit_start
2011-06-01 11:11:21.745980 7f2ebd18d700 filestore(/data/osd0) sync_entry waiting for max_interval 5.000000
2011-06-01 11:11:22.355158 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:22.355213 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:22.355226 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:22.355234 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:22.355241 7f2ebf191700 osd0 26 do_mon_report
2011-06-01 11:11:22.355247 7f2ebf191700 osd0 26 send_alive up_thru currently 0 want 0
2011-06-01 11:11:22.355254 7f2ebf191700 osd0 26 send_pg_stats
2011-06-01 11:11:22.582874 7f2eb8984700 -- 192.168.100.7:6801/13315 <== mds0 192.168.100.7:6800/3403 134 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a29180 con 0x1a04280
2011-06-01 11:11:22.582895 7f2eb8984700 osd0 26 _dispatch 0x1a29180 ping v1
2011-06-01 11:11:22.582906 7f2eb8984700 osd0 26 ping from mds0
2011-06-01 11:11:22.874570 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:22.874602 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:22.874522 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:22.874611 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:23.355397 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:23.355452 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:23.355465 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:23.355472 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:24.074828 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:24.074876 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:24.074737 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:24.074882 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:24.355601 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:24.355662 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:24.513035 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721306 192.168.100.7:0/1011731 130 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2ed80 con 0x1a04500
2011-06-01 11:11:24.513057 7f2eb8984700 osd0 26 _dispatch 0x1a2ed80 ping v1
2011-06-01 11:11:24.513069 7f2eb8984700 osd0 26 ping from client1721306
--
2011-06-01 11:11:26.650353 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721501 192.168.100.7:0/1013621 11 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2e480 con 0x1a0b640
2011-06-01 11:11:26.650374 7f2eb8984700 osd0 26 _dispatch 0x1a2e480 ping v1
2011-06-01 11:11:26.650386 7f2eb8984700 osd0 26 ping from client1721501
2011-06-01 11:11:26.746108 7f2ebd18d700 filestore(/data/osd0) sync_entry woke after 5.000125
2011-06-01 11:11:26.746131 7f2ebd18d700 journal commit_start op_seq 555711, applied_seq 555711, committed_seq 555711
2011-06-01 11:11:26.746142 7f2ebd18d700 journal commit_start nothing to do
2011-06-01 11:11:26.746151 7f2ebd18d700 journal commit_start
2011-06-01 11:11:26.746159 7f2ebd18d700 filestore(/data/osd0) sync_entry waiting for max_interval 5.000000
2011-06-01 11:11:27.275760 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:27.275792 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:27.275713 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:27.275801 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:27.356218 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:27.356273 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:27.356286 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:27.356294 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:27.356301 7f2ebf191700 osd0 26 do_mon_report
2011-06-01 11:11:27.356308 7f2ebf191700 osd0 26 send_alive up_thru currently 0 want 0
2011-06-01 11:11:27.356315 7f2ebf191700 osd0 26 send_pg_stats
2011-06-01 11:11:27.582995 7f2eb8984700 -- 192.168.100.7:6801/13315 <== mds0 192.168.100.7:6800/3403 135 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2fd80 con 0x1a04280
2011-06-01 11:11:27.583024 7f2eb8984700 osd0 26 _dispatch 0x1a2fd80 ping v1
2011-06-01 11:11:27.583036 7f2eb8984700 osd0 26 ping from mds0
2011-06-01 11:11:27.975989 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:27.976021 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:27.975941 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:27.976029 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:28.356459 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:28.356514 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:28.356527 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:28.356535 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:28.776213 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:28.776246 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:28.776166 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:28.776254 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:29.356678 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:29.356733 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
--
2011-06-01 11:11:31.650506 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721501 192.168.100.7:0/1013621 12 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a30600 con 0x1a0b640
2011-06-01 11:11:31.650538 7f2eb8984700 osd0 26 _dispatch 0x1a30600 ping v1
2011-06-01 11:11:31.650550 7f2eb8984700 osd0 26 ping from client1721501
2011-06-01 11:11:31.746304 7f2ebd18d700 filestore(/data/osd0) sync_entry woke after 5.000142
2011-06-01 11:11:31.746326 7f2ebd18d700 journal commit_start op_seq 555711, applied_seq 555711, committed_seq 555711
2011-06-01 11:11:31.746337 7f2ebd18d700 journal commit_start nothing to do
2011-06-01 11:11:31.746345 7f2ebd18d700 journal commit_start
2011-06-01 11:11:31.746353 7f2ebd18d700 filestore(/data/osd0) sync_entry waiting for max_interval 5.000000
2011-06-01 11:11:31.876883 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:31.876915 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:31.876835 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:31.876923 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:32.357286 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:32.357340 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:32.357355 7f2ebf191700 osd0 26 do_mon_report
2011-06-01 11:11:32.357363 7f2ebf191700 osd0 26 send_alive up_thru currently 0 want 0
2011-06-01 11:11:32.357369 7f2ebf191700 osd0 26 send_pg_stats
2011-06-01 11:11:32.577110 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:32.577142 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:32.577062 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:32.577151 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:32.583121 7f2eb8984700 -- 192.168.100.7:6801/13315 <== mds0 192.168.100.7:6800/3403 136 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2fc00 con 0x1a04280
2011-06-01 11:11:32.583142 7f2eb8984700 osd0 26 _dispatch 0x1a2fc00 ping v1
2011-06-01 11:11:32.583154 7f2eb8984700 osd0 26 ping from mds0
2011-06-01 11:11:33.357504 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:33.357559 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:33.977337 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:33.977371 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:33.977288 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:33.977380 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:34.357712 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:34.357767 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:34.513345 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721306 192.168.100.7:0/1011731 132 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2ea80 con 0x1a04500
2011-06-01 11:11:34.513366 7f2eb8984700 osd0 26 _dispatch 0x1a2ea80 ping v1
2011-06-01 11:11:34.513378 7f2eb8984700 osd0 26 ping from client1721306
2011-06-01 11:11:35.172325 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1720602 192.168.100.2:0/1018565 132 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a30d80 con 0x19ffc80
--
2011-06-01 11:11:36.650649 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721501 192.168.100.7:0/1013621 13 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a30480 con 0x1a0b640
2011-06-01 11:11:36.650670 7f2eb8984700 osd0 26 _dispatch 0x1a30480 ping v1
2011-06-01 11:11:36.650682 7f2eb8984700 osd0 26 ping from client1721501
2011-06-01 11:11:36.746480 7f2ebd18d700 filestore(/data/osd0) sync_entry woke after 5.000124
2011-06-01 11:11:36.746502 7f2ebd18d700 journal commit_start op_seq 555711, applied_seq 555711, committed_seq 555711
2011-06-01 11:11:36.746513 7f2ebd18d700 journal commit_start nothing to do
2011-06-01 11:11:36.746522 7f2ebd18d700 journal commit_start
2011-06-01 11:11:36.746530 7f2ebd18d700 filestore(/data/osd0) sync_entry waiting for max_interval 5.000000
2011-06-01 11:11:37.178019 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:37.178051 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:37.177972 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:37.178060 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:37.358343 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:37.358398 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:37.358411 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:37.358419 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:37.358426 7f2ebf191700 osd0 26 do_mon_report
2011-06-01 11:11:37.358433 7f2ebf191700 osd0 26 send_alive up_thru currently 0 want 0
2011-06-01 11:11:37.358440 7f2ebf191700 osd0 26 send_pg_stats
2011-06-01 11:11:37.583260 7f2eb8984700 -- 192.168.100.7:6801/13315 <== mds0 192.168.100.7:6800/3403 137 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2fa80 con 0x1a04280
2011-06-01 11:11:37.583281 7f2eb8984700 osd0 26 _dispatch 0x1a2fa80 ping v1
2011-06-01 11:11:37.583293 7f2eb8984700 osd0 26 ping from mds0
2011-06-01 11:11:38.278247 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:38.278279 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:38.278199 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:38.278288 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:38.358587 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:38.358644 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:38.358657 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:38.358665 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:39.358809 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:39.358864 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:39.513490 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721306 192.168.100.7:0/1011731 133 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a33d80 con 0x1a04500
2011-06-01 11:11:39.513511 7f2eb8984700 osd0 26 _dispatch 0x1a33d80 ping v1
2011-06-01 11:11:39.513522 7f2eb8984700 osd0 26 ping from client1721306
--
2011-06-01 11:11:41.650795 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721501 192.168.100.7:0/1013621 14 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a30300 con 0x1a0b640
2011-06-01 11:11:41.650816 7f2eb8984700 osd0 26 _dispatch 0x1a30300 ping v1
2011-06-01 11:11:41.650828 7f2eb8984700 osd0 26 ping from client1721501
2011-06-01 11:11:41.746673 7f2ebd18d700 filestore(/data/osd0) sync_entry woke after 5.000141
2011-06-01 11:11:41.746695 7f2ebd18d700 journal commit_start op_seq 555711, applied_seq 555711, committed_seq 555711
2011-06-01 11:11:41.746706 7f2ebd18d700 journal commit_start nothing to do
2011-06-01 11:11:41.746715 7f2ebd18d700 journal commit_start
2011-06-01 11:11:41.746723 7f2ebd18d700 filestore(/data/osd0) sync_entry waiting for max_interval 5.000000
2011-06-01 11:11:42.079148 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:42.079180 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:42.079100 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:42.079189 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:42.359425 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:42.359480 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:42.359493 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:42.359501 7f2ebf191700 osd0 26 sched_scrub done
2011-06-01 11:11:42.359508 7f2ebf191700 osd0 26 do_mon_report
2011-06-01 11:11:42.359514 7f2ebf191700 osd0 26 send_alive up_thru currently 0 want 0
2011-06-01 11:11:42.359521 7f2ebf191700 osd0 26 send_pg_stats
2011-06-01 11:11:42.583439 7f2eb8984700 -- 192.168.100.7:6801/13315 <== mds0 192.168.100.7:6800/3403 138 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2f900 con 0x1a04280
2011-06-01 11:11:42.583460 7f2eb8984700 osd0 26 _dispatch 0x1a2f900 ping v1
2011-06-01 11:11:42.583472 7f2eb8984700 osd0 26 ping from mds0
2011-06-01 11:11:43.079378 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:43.079411 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:43.079331 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:43.079420 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:43.359665 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:43.359720 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:44.079633 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:44.079664 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:44.079559 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:44.079672 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:44.359853 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:44.359908 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = yes
2011-06-01 11:11:44.359921 7f2ebf191700 osd0 26 sched_scrub
2011-06-01 11:11:44.359929 7f2ebf191700 osd0 26 sched_scrub done
--
2011-06-01 11:11:46.650925 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721501 192.168.100.7:0/1013621 15 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a30180 con 0x1a0b640
2011-06-01 11:11:46.650946 7f2eb8984700 osd0 26 _dispatch 0x1a30180 ping v1
2011-06-01 11:11:46.650958 7f2eb8984700 osd0 26 ping from client1721501
2011-06-01 11:11:46.746857 7f2ebd18d700 filestore(/data/osd0) sync_entry woke after 5.000132
2011-06-01 11:11:46.746879 7f2ebd18d700 journal commit_start op_seq 555711, applied_seq 555711, committed_seq 555711
2011-06-01 11:11:46.746890 7f2ebd18d700 journal commit_start nothing to do
2011-06-01 11:11:46.746898 7f2ebd18d700 journal commit_start
2011-06-01 11:11:46.746906 7f2ebd18d700 filestore(/data/osd0) sync_entry waiting for max_interval 5.000000
2011-06-01 11:11:47.360480 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:47.360535 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:47.360550 7f2ebf191700 osd0 26 do_mon_report
2011-06-01 11:11:47.360557 7f2ebf191700 osd0 26 send_alive up_thru currently 0 want 0
2011-06-01 11:11:47.360564 7f2ebf191700 osd0 26 send_pg_stats
2011-06-01 11:11:47.580320 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:47.580352 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:47.580273 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:47.580361 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:47.583578 7f2eb8984700 -- 192.168.100.7:6801/13315 <== mds0 192.168.100.7:6800/3403 139 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a2f780 con 0x1a04280
2011-06-01 11:11:47.583599 7f2eb8984700 osd0 26 _dispatch 0x1a2f780 ping v1
2011-06-01 11:11:47.583611 7f2eb8984700 osd0 26 ping from mds0
2011-06-01 11:11:48.360707 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:48.360762 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:48.780526 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:48.780558 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:48.780478 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:48.780567 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:49.360911 7f2ebf191700 osd0 26 tick
2011-06-01 11:11:49.360965 7f2ebf191700 osd0 26 scrub_should_schedule loadavg 0 < max 0.5 = no, randomly backing off
2011-06-01 11:11:49.380755 7f2eb487b700 osd0 26 update_osd_stat osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:49.380787 7f2eb487b700 osd0 26 heartbeat: stat(2011-06-01 11:11:49.380708 oprate=0 qlen=0 recent_qlen=0 rdlat=0 / 0 fshedin=0)
2011-06-01 11:11:49.380795 7f2eb487b700 osd0 26 heartbeat: osd_stat(15209 MB used, 131 GB avail, 146 GB total, peers []/[])
2011-06-01 11:11:49.513802 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1721306 192.168.100.7:0/1011731 135 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a33a80 con 0x1a04500
2011-06-01 11:11:49.513823 7f2eb8984700 osd0 26 _dispatch 0x1a33a80 ping v1
2011-06-01 11:11:49.513841 7f2eb8984700 osd0 26 ping from client1721306
2011-06-01 11:11:50.172773 7f2eb8984700 -- 192.168.100.7:6801/13315 <== client1720602 192.168.100.2:0/1018565 135 ==== ping v1 ==== 0+0+0 (0 0 0) 0x1a30900 con 0x19ffc80