2022-05-18T10:57:31.508+0000 7fc78327f700 1 osd.25 pg_epoch: 18356 pg[2.282( v 17528'2529901 lc 16523'2529900 (11747'2526900,17528'2529901] local-lis/les=18350/18351 n=502 ec=11802/98 lis/c=18353/18353 les/c/f=18354/18354/0 sis=18356 pruub=13.029947281s) [29,25] r=1 lpr=18356 pi=[16606,18356)/2 crt=17528'2529901 lcod 0'0 mlcod 0'0 unknown NOTIFY pruub 159.213790894s@ m=1 mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:31.508+0000 7fc78227d700 1 osd.25 pg_epoch: 18356 pg[2.63( v 11780'3043998 (11775'3038582,11780'3043998] lb 2:c613e9c8:::rbd_data.4f8634c44a746b.0000000000000c48:head local-lis/les=13630/13631 n=302 ec=98/98 lis/c=17610/17610 les/c/f=17611/17611/0 sis=18356) [10,25]/[10] r=-1 lpr=18356 pi=[13630,18356)/1 crt=11780'3043998 mlcod 0'0 remapped NOTIFY mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:31.508+0000 7fc78327f700 1 osd.25 pg_epoch: 18356 pg[2.ac( v 12976'2359645 (11780'2357129,12976'2359645] local-lis/les=16557/16558 n=501 ec=2244/98 lis/c=16557/16557 les/c/f=16558/16558/0 sis=18356) [25,5]/[25] r=0 lpr=18356 pi=[16557,18356)/2 crt=12976'2359645 lcod 0'0 mlcod 0'0 remapped mbc={}] start_peering_interval up [25,5] -> [25,5], acting [25,5] -> [25], acting_primary 25 -> 25, up_primary 25 -> 25, role 0 -> 0, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:31.508+0000 7fc78327f700 1 osd.25 pg_epoch: 18356 pg[2.ac( v 12976'2359645 (11780'2357129,12976'2359645] local-lis/les=16557/16558 n=501 ec=2244/98 lis/c=16557/16557 les/c/f=16558/16558/0 sis=18356) [25,5]/[25] r=0 lpr=18356 pi=[16557,18356)/2 crt=12976'2359645 lcod 0'0 mlcod 0'0 remapped mbc={}] state<Start>: transitioning to Primary
2022-05-18T10:57:32.664+0000 7fc78327f700 0 log_channel(cluster) log [INF] : 2.ac continuing backfill to osd.5 from (11780'2357129,12976'2359645] 2:35011190:::rbd_data.5a67fff34445bb.0000000000000c57:head to 12976'2359645
2022-05-18T10:57:32.664+0000 7fc782a7e700 0 log_channel(cluster) log [INF] : 2.12a continuing backfill to osd.19 from (11780'2916530,11780'2922079] MIN to 11780'2922079
2022-05-18T10:57:32.664+0000 7fc783a80700 0 log_channel(cluster) log [INF] : 2.4ac continuing backfill to osd.5 from (11780'2357129,11780'2359638] MIN to 11780'2359638
2022-05-18T10:57:32.664+0000 7fc78227d700 0 log_channel(cluster) log [INF] : 2.2ac continuing backfill to osd.5 from (11780'2357129,11780'2359638] 2:35461315:::rbd_data.5a67fff34445bb.000000000001329d:head to 11780'2359638
2022-05-18T10:57:32.664+0000 7fc78327f700 0 log_channel(cluster) log [INF] : 2.21e continuing backfill to osd.3 from (11780'3969559,11780'3972047] 2:784662d6:::rbd_data.4dba77a5b8f793.0000000000002d00:head to 11780'3972047
2022-05-18T10:57:32.664+0000 7fc782a7e700 0 log_channel(cluster) log [INF] : 2.6ac continuing backfill to osd.5 from (11780'2357129,11780'2359638] 2:356fce3c:::rbd_data.52befd43cf3520.00000000000081eb:head to 11780'2359638
2022-05-18T10:57:32.664+0000 7fc78327f700 0 log_channel(cluster) log [INF] : 2.21e continuing backfill to osd.8 from (11780'3969559,11780'3972047] 2:784662d6:::rbd_data.4dba77a5b8f793.0000000000002d00:head to 11780'3972047
2022-05-18T10:57:32.664+0000 7fc784281700 0 log_channel(cluster) log [INF] : 2.32a continuing backfill to osd.19 from (11780'2916530,11780'2922079] MIN to 11780'2922079
2022-05-18T10:57:32.664+0000 7fc783a80700 0 log_channel(cluster) log [INF] : 2.61e continuing backfill to osd.3 from (11780'3969559,12978'3972057] 2:7863171a:::rbd_data.668c986b195cf.0000000000000e9d:head to 12978'3972057
2022-05-18T10:57:32.664+0000 7fc783a80700 0 log_channel(cluster) log [INF] : 2.61e continuing backfill to osd.8 from (11780'3969559,12978'3972057] 2:7863171a:::rbd_data.668c986b195cf.0000000000000e9d:head to 12978'3972057
2022-05-18T10:57:32.664+0000 7fc78227d700 0 log_channel(cluster) log [INF] : 2.72a continuing backfill to osd.19 from (11780'2916530,11780'2922079] 2:54e93c03:::rbd_data.a3160d630815e4.0000000000006486:head to 11780'2922079
2022-05-18T10:57:32.664+0000 7fc783a80700 0 log_channel(cluster) log [INF] : 2.6e1 continuing backfill to osd.20 from (11780'2528655,11780'2531061] 2:87623ed2:::rbd_data.b508a2bbb4b6cd.0000000000000ab8:head to 11780'2531061
2022-05-18T10:57:32.664+0000 7fc78327f700 0 log_channel(cluster) log [INF] : 2.52a continuing backfill to osd.19 from (11780'2916530,11885'2922080] MIN to 11885'2922080
2022-05-18T10:57:32.664+0000 7fc784281700 0 log_channel(cluster) log [INF] : 2.66d continuing backfill to osd.20 from (11750'4215211,11780'4217579] MIN to 11780'4217579
2022-05-18T10:57:32.664+0000 7fc78227d700 0 log_channel(cluster) log [INF] : 2.41e continuing backfill to osd.15 from (11780'3969559,11780'3972047] MIN to 11780'3972047
2022-05-18T10:57:32.664+0000 7fc78227d700 0 log_channel(cluster) log [INF] : 2.4e1 continuing backfill to osd.20 from (11780'2528655,11780'2531061] MIN to 11780'2531061
2022-05-18T10:57:32.664+0000 7fc783a80700 0 log_channel(cluster) log [INF] : 2.37b continuing backfill to osd.31 from (11780'2777237,11780'2779687] MIN to 11780'2779687
2022-05-18T10:57:32.664+0000 7fc78327f700 0 log_channel(cluster) log [INF] : 2.2e1 continuing backfill to osd.20 from (11780'2528655,13099'2531150] 2:875ab6d3:::rbd_data.52befd43cf3520.00000000000133bc:head to 13099'2531150
2022-05-18T10:57:32.664+0000 7fc784281700 0 log_channel(cluster) log [INF] : 2.1e continuing backfill to osd.15 from (11780'3969559,12584'3972048] 2:780256ab:::rbd_data.a3160d630815e4.0000000000007859:head to 12584'3972048
2022-05-18T10:57:32.664+0000 7fc78227d700 0 log_channel(cluster) log [INF] : 2.6d continuing backfill to osd.20 from (11750'4215211,13067'4217584] 2:b60108dd:::rbd_data.5a67fff34445bb.00000000000079ed:head to 13067'4217584
2022-05-18T10:57:32.664+0000 7fc783a80700 0 log_channel(cluster) log [INF] : 2.26d continuing backfill to osd.20 from (11750'4215211,11780'4217579] 2:b64364e9:::rbd_data.5a67fff34445bb.0000000000000e3c:head to 11780'4217579
2022-05-18T10:57:32.664+0000 7fc782a7e700 0 log_channel(cluster) log [INF] : 2.46d continuing backfill to osd.20 from (11750'4215211,11780'4217579] 2:b6208f9e:::rbd_data.5a67fff34445bb.00000000000038df:head to 11780'4217579
2022-05-18T10:57:32.664+0000 7fc784281700 0 log_channel(cluster) log [INF] : 2.77b continuing backfill to osd.31 from (11780'2778322,13096'2779689] MIN to 13096'2779689
2022-05-18T10:57:32.664+0000 7fc782a7e700 0 log_channel(cluster) log [INF] : 2.57b continuing backfill to osd.31 from (11780'2777237,11780'2779687] MIN to 11780'2779687
2022-05-18T10:57:32.664+0000 7fc784281700 0 log_channel(cluster) log [INF] : 2.e1 continuing backfill to osd.20 from (11780'2528655,11780'2531061] MIN to 11780'2531061
2022-05-18T10:57:32.664+0000 7fc78227d700 0 log_channel(cluster) log [INF] : 2.17b continuing backfill to osd.31 from (11780'2777237,11780'2779687] MIN to 11780'2779687
2022-05-18T10:57:57.904+0000 7fc78ea96700 0 log_channel(cluster) log [WRN] : Monitor daemon marked osd.25 down, but it is still running
2022-05-18T10:57:57.904+0000 7fc78ea96700 0 log_channel(cluster) log [DBG] : map e18360 wrongly marked me down at e18360
2022-05-18T10:57:57.904+0000 7fc78ea96700 -1 osd.25 18360 _committed_osd_maps marked down 6 > osd_max_markdown_count 5 in last 600.000000 seconds, shutting down
2022-05-18T10:57:57.904+0000 7fc78ea96700 1 osd.25 18360 start_waiting_for_healthy
2022-05-18T10:57:57.904+0000 7fc784281700 1 osd.25 pg_epoch: 18360 pg[2.63b( v 11780'2414361 (11780'2408831,11780'2414361] lb MIN local-lis/les=18322/18323 n=0 ec=11860/98 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [13]/[13,4] r=-1 lpr=18360 pi=[17606,18360)/1 luod=0'0 crt=11780'2414361 lcod 0'0 mlcod 0'0 active+remapped mbc={}] start_peering_interval up [13,25] -> [13], acting [13,4] -> [13,4], acting_primary 13 -> 13, up_primary 13 -> 13, role -1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc783a80700 1 osd.25 pg_epoch: 18360 pg[2.e2( v 12978'3038142 (11747'3032397,12978'3038142] lb MIN local-lis/les=18323/18324 n=0 ec=2244/98 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [20]/[20,10] r=-1 lpr=18360 pi=[17709,18360)/1 luod=0'0 crt=12978'3038142 lcod 0'0 mlcod 0'0 active+remapped mbc={}] start_peering_interval up [20,25] -> [20], acting [20,10] -> [20,10], acting_primary 20 -> 20, up_primary 20 -> 20, role -1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc784281700 1 osd.25 pg_epoch: 18360 pg[2.63b( v 11780'2414361 (11780'2408831,11780'2414361] lb MIN local-lis/les=18322/18323 n=0 ec=11860/98 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [13]/[13,4] r=-1 lpr=18360 pi=[17606,18360)/1 crt=11780'2414361 lcod 0'0 mlcod 0'0 remapped NOTIFY mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:57.904+0000 7fc783a80700 1 osd.25 pg_epoch: 18360 pg[2.e2( v 12978'3038142 (11747'3032397,12978'3038142] lb MIN local-lis/les=18323/18324 n=0 ec=2244/98 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [20]/[20,10] r=-1 lpr=18360 pi=[17709,18360)/1 crt=12978'3038142 lcod 0'0 mlcod 0'0 remapped NOTIFY mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:57.904+0000 7fc78327f700 1 osd.25 pg_epoch: 18360 pg[1.66( v 17517'235 (169'1,17517'235] lb MIN local-lis/les=18323/18324 n=0 ec=15/11 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [22]/[22,4] r=-1 lpr=18360 pi=[17918,18360)/1 luod=0'0 crt=17517'235 lcod 0'0 mlcod 0'0 active+remapped mbc={}] start_peering_interval up [22,25] -> [22], acting [22,4] -> [22,4], acting_primary 22 -> 22, up_primary 22 -> 22, role -1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc782a7e700 1 osd.25 pg_epoch: 18360 pg[4.b7( empty local-lis/les=18355/18356 n=0 ec=179/173 lis/c=18355/18355 les/c/f=18356/18356/0 sis=18360 pruub=13.691542625s) [23] r=-1 lpr=18360 pi=[18355,18360)/1 crt=0'0 mlcod 0'0 active pruub 186.271499634s@ mbc={}] start_peering_interval up [23,25] -> [23], acting [23,25] -> [23], acting_primary 23 -> 23, up_primary 23 -> 23, role 1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc78227d700 1 osd.25 pg_epoch: 18360 pg[3.27( v 11801'75 lc 1824'2 (0'0,11801'75] local-lis/les=18356/18357 n=26 ec=170/170 lis/c=18356/18353 les/c/f=18357/18354/0 sis=18360 pruub=14.793540001s) [4] r=-1 lpr=18360 pi=[17663,18360)/2 luod=0'0 crt=11801'75 lcod 0'0 mlcod 0'0 active pruub 187.373565674s@ m=30 mbc={}] start_peering_interval up [4,25] -> [4], acting [4,25] -> [4], acting_primary 4 -> 4, up_primary 4 -> 4, role 1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc782a7e700 1 osd.25 pg_epoch: 18360 pg[4.b7( empty local-lis/les=18355/18356 n=0 ec=179/173 lis/c=18355/18355 les/c/f=18356/18356/0 sis=18360 pruub=13.691492081s) [23] r=-1 lpr=18360 pi=[18355,18360)/1 crt=0'0 mlcod 0'0 unknown NOTIFY pruub 186.271499634s@ mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:57.904+0000 7fc78327f700 1 osd.25 pg_epoch: 18360 pg[1.66( v 17517'235 (169'1,17517'235] lb MIN local-lis/les=18323/18324 n=0 ec=15/11 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [22]/[22,4] r=-1 lpr=18360 pi=[17918,18360)/1 crt=17517'235 lcod 0'0 mlcod 0'0 remapped NOTIFY mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:57.904+0000 7fc78ea96700 0 osd.25 18360 _committed_osd_maps shutdown OSD via async signal
2022-05-18T10:57:57.904+0000 7fc78227d700 1 osd.25 pg_epoch: 18360 pg[3.27( v 11801'75 lc 1824'2 (0'0,11801'75] local-lis/les=18356/18357 n=26 ec=170/170 lis/c=18356/18353 les/c/f=18357/18354/0 sis=18360 pruub=14.793498993s) [4] r=-1 lpr=18360 pi=[17663,18360)/2 crt=11801'75 lcod 0'0 mlcod 0'0 unknown NOTIFY pruub 187.373565674s@ m=30 mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:57.904+0000 7fc79b558700 -1 received signal: Interrupt from Kernel ( Could be generated by pthread_kill(), raise(), abort(), alarm() ) UID: 0
2022-05-18T10:57:57.904+0000 7fc79b558700 -1 osd.25 18360 *** Got signal Interrupt ***
2022-05-18T10:57:57.904+0000 7fc79b558700 -1 osd.25 18360 *** Immediate shutdown (osd_fast_shutdown=true) ***
2022-05-18T10:57:57.904+0000 7fc783a80700 1 osd.25 pg_epoch: 18360 pg[2.23b( v 12993'2414382 (11780'2409763,12993'2414382] lb MIN local-lis/les=18322/18323 n=0 ec=11802/98 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [13]/[13,4] r=-1 lpr=18360 pi=[17606,18360)/1 luod=0'0 crt=12993'2414382 lcod 0'0 mlcod 0'0 active+remapped mbc={}] start_peering_interval up [13,25] -> [13], acting [13,4] -> [13,4], acting_primary 13 -> 13, up_primary 13 -> 13, role -1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc784281700 1 osd.25 pg_epoch: 18360 pg[2.5eb( v 17523'2669643 (11780'2667288,17523'2669643] lb MIN local-lis/les=17851/17852 n=0 ec=11802/98 lis/c=17851/17851 les/c/f=17852/17852/0 sis=18360) [2] r=-1 lpr=18360 pi=[17851,18360)/1 luod=0'0 crt=17523'2669643 lcod 0'0 mlcod 0'0 peered mbc={}] start_peering_interval up [2,25] -> [2], acting [2] -> [2], acting_primary 2 -> 2, up_primary 2 -> 2, role -1 -> -1, features acting 4540138297136906239 upacting 4540138297136906239
2022-05-18T10:57:57.904+0000 7fc784281700 1 osd.25 pg_epoch: 18360 pg[2.5eb( v 17523'2669643 (11780'2667288,17523'2669643] lb MIN local-lis/les=17851/17852 n=0 ec=11802/98 lis/c=17851/17851 les/c/f=17852/17852/0 sis=18360) [2] r=-1 lpr=18360 pi=[17851,18360)/1 crt=17523'2669643 lcod 0'0 mlcod 0'0 unknown NOTIFY mbc={}] state<Start>: transitioning to Stray
2022-05-18T10:57:57.904+0000 7fc783a80700 1 osd.25 pg_epoch: 18360 pg[2.23b( v 12993'2414382 (11780'2409763,12993'2414382] lb MIN local-lis/les=18322/18323 n=0 ec=11802/98 lis/c=18355/18352 les/c/f=18356/18353/0 sis=18360) [13]/[13,4] r=-1 lpr=18360 pi=[17606,18360)/1 crt=12993'2414382 lcod 0'0 mlcod 0'0 remapped NOTIFY mbc={}] state<Start>: transitioning to Stray