force_promote_hang

gistfile1.txt

```
===   Force promote cepheast ===
2022-03-08T19:11:57.504+0000 7f6e80fa5200 20 librbd::asio::ContextWQ: 0x5620afd6f0d0 ContextWQ:
2022-03-08T19:11:57.504+0000 7f6e80fa5200 20 librbd::AsioEngine: 0x5620afd87c60 AsioEngine:
2022-03-08T19:11:57.504+0000 7f6e80fa5200 10 librbd::ImageCtx: 0x5620afd23e40 ImageCtx: image_name=test-demote-sb, image_id=
2022-03-08T19:11:57.504+0000 7f6e80fa5200  5 librbd::io::Dispatcher: 0x5620afd8b1c0 register_dispatch: dispatch_layer=10
2022-03-08T19:11:57.505+0000 7f6e80fa5200  5 librbd::io::QueueImageDispatch: 0x5620afd8b280 QueueImageDispatch: ictx=0x5620afd23e40
2022-03-08T19:11:57.505+0000 7f6e80fa5200  5 librbd::io::Dispatcher: 0x5620afd8b1c0 register_dispatch: dispatch_layer=1
2022-03-08T19:11:57.505+0000 7f6e80fa5200  5 librbd::io::QosImageDispatch: 0x5620afd8b320 QosImageDispatch: ictx=0x5620afd23e40
2022-03-08T19:11:57.506+0000 7f6e80fa5200  5 librbd::io::Dispatcher: 0x5620afd8b1c0 register_dispatch: dispatch_layer=2
2022-03-08T19:11:57.506+0000 7f6e80fa5200  5 librbd::io::RefreshImageDispatch: 0x5620afd8b840 RefreshImageDispatch: ictx=0x5620afd23e40
2022-03-08T19:11:57.507+0000 7f6e80fa5200  5 librbd::io::Dispatcher: 0x5620afd8b1c0 register_dispatch: dispatch_layer=4
2022-03-08T19:11:57.507+0000 7f6e80fa5200  5 librbd::io::WriteBlockImageDispatch: 0x5620afb8cef0 WriteBlockImageDispatch: ictx=0x5620afd23e40
2022-03-08T19:11:57.507+0000 7f6e80fa5200  5 librbd::io::Dispatcher: 0x5620afd8b1c0 register_dispatch: dispatch_layer=7
2022-03-08T19:11:57.507+0000 7f6e80fa5200  5 librbd::io::Dispatcher: 0x5620afd88530 register_dispatch: dispatch_layer=6
2022-03-08T19:11:57.507+0000 7f6e80fa5200 20 librbd::ImageState: 0x5620afd884b0 open
2022-03-08T19:11:57.507+0000 7f6e80fa5200 10 librbd::ImageState: 0x5620afd884b0 0x5620afd884b0 send_open_unlock
2022-03-08T19:11:57.507+0000 7f6e80fa5200 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_v2_detect_header
2022-03-08T19:11:57.509+0000 7f6e6ede9700 10 librbd::image::OpenRequest: handle_v2_detect_header: r=0
2022-03-08T19:11:57.509+0000 7f6e6ede9700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_v2_get_id
2022-03-08T19:11:57.510+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: handle_v2_get_id: r=0
2022-03-08T19:11:57.510+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_v2_get_initial_metadata
2022-03-08T19:11:57.516+0000 7f6e6ede9700 10 librbd::image::OpenRequest: handle_v2_get_initial_metadata: r=0
2022-03-08T19:11:57.516+0000 7f6e6ede9700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_v2_get_create_timestamp
2022-03-08T19:11:57.522+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 handle_v2_get_create_timestamp: r=0
2022-03-08T19:11:57.522+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_v2_get_access_modify_timestamp
2022-03-08T19:11:57.526+0000 7f6e6ede9700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 handle_v2_get_access_modify_timestamp: r=0
2022-03-08T19:11:57.526+0000 7f6e6ede9700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_v2_get_data_pool
2022-03-08T19:11:57.528+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 handle_v2_get_data_pool: r=0
2022-03-08T19:11:57.528+0000 7f6e6e5e8700 10 librbd::ImageCtx: init_layout stripe_unit 4194304 stripe_count 1 object_size 4194304 prefix rbd_data.10f754fbbc65 format rbd_data.10f754fbbc65.%016llx
2022-03-08T19:11:57.528+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_refresh
2022-03-08T19:11:57.528+0000 7f6e6e5e8700 10 librbd::ConfigWatcher: init:
2022-03-08T19:11:57.528+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_get_mutable_metadata
2022-03-08T19:11:57.536+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_get_mutable_metadata: r=0
2022-03-08T19:11:57.536+0000 7f6e6ede9700  5 librbd::image::RefreshRequest: adding non-primary read-only image flag
2022-03-08T19:11:57.536+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_get_parent: legacy=0
2022-03-08T19:11:57.539+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_get_parent: r=0
2022-03-08T19:11:57.539+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_get_metadata
2022-03-08T19:11:57.539+0000 7f6e6e5e8700 15 librbd::image::GetMetadataRequest: 0x7f6e54017d60 metadata_list: start_key=conf_
2022-03-08T19:11:57.541+0000 7f6e6ede9700 15 librbd::image::GetMetadataRequest: 0x7f6e54017d60 handle_metadata_list: r=0
2022-03-08T19:11:57.541+0000 7f6e6ede9700 15 librbd::image::GetMetadataRequest: 0x7f6e54017d60 finish: r=0
2022-03-08T19:11:57.541+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_get_metadata: r=0
2022-03-08T19:11:57.541+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_get_pool_metadata
2022-03-08T19:11:57.541+0000 7f6e6ede9700 15 librbd::image::GetMetadataRequest: 0x7f6e4c003340 metadata_list: start_key=conf_
2022-03-08T19:11:57.544+0000 7f6e6e5e8700 15 librbd::image::GetMetadataRequest: 0x7f6e4c003340 handle_metadata_list: r=0
2022-03-08T19:11:57.544+0000 7f6e6e5e8700 15 librbd::image::GetMetadataRequest: 0x7f6e4c003340 finish: r=0
2022-03-08T19:11:57.545+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_get_pool_metadata: r=0
2022-03-08T19:11:57.545+0000 7f6e6e5e8700 20 librbd::ImageCtx: apply_metadata
2022-03-08T19:11:57.545+0000 7f6e6e5e8700  5 librbd::ImageCtx: 0x5620afd23e40: disabling zero-copy writes
2022-03-08T19:11:57.545+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_get_group
2022-03-08T19:11:57.546+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_get_group: r=0
2022-03-08T19:11:57.546+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_get_snapshots
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_get_snapshots: r=0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_v2_apply
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_v2_apply
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::image::RefreshRequest: 0x7f6e5400dd40 apply
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::image::RefreshRequest: new snapshot id=853 name=.mirror.non_primary.c11dd83b-ee7c-4f0d-933c-61c97bb66894.9057869e-4da6-4cbd-b0fe-0f2ab4dbf467 size=1073741824
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 send_flush_aio
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::AsyncOperation: 0x7f6e54014190 start_op
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::Dispatcher: 0x5620afd8b1c0 send: dispatch_spec=0x7f6e540141f0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::WriteBlockImageDispatch: 0x5620afb8cef0 flush: tid=1
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::ImageDispatch: 0x5620afd8b260 flush:
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::ImageRequest: 0x7f6e6e5e2c60 send: aio_flush: ictx=0x5620afd23e40, completion=0x7f6e54014080
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::AioCompletion: 0x7f6e54014080 set_request_count: pending=1
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::Dispatcher: 0x5620afd88530 send: dispatch_spec=0x7f6e540142e0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::AioCompletion: 0x7f6e54014080 complete_request: cb=1, pending=0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::AioCompletion: 0x7f6e54014080 finalize: r=0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x7f6e5400dd40 handle_flush_aio: r=0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 20 librbd::io::AsyncOperation: 0x7f6e54014190 finish_op
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: handle_refresh: r=0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: send_init_plugin_registry: plugins=
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: handle_init_plugin_registry: r=0
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_init_cache
2022-03-08T19:11:57.547+0000 7f6e6e5e8700  5 librbd::cache::WriteAroundObjectDispatch: 0x7f6e54016c90 init:
2022-03-08T19:11:57.547+0000 7f6e6e5e8700  5 librbd::io::Dispatcher: 0x5620afd88530 register_dispatch: dispatch_layer=1
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 send_register_watch
2022-03-08T19:11:57.547+0000 7f6e6e5e8700 10 librbd::Watcher: 0x7f6e54008a60 register_watch:
2022-03-08T19:11:57.556+0000 7f6e6e5e8700 10 librbd::Watcher: 0x7f6e54008a60 handle_register_watch: r=0
2022-03-08T19:11:57.556+0000 7f6e6e5e8700 10 librbd::image::OpenRequest: 0x5620afd8c3a0 handle_register_watch: r=0
2022-03-08T19:11:57.556+0000 7f6e6e5e8700 10 librbd::ImageState: 0x5620afd884b0 0x5620afd884b0 handle_open: r=0
2022-03-08T19:11:57.556+0000 7f6e80fa5200 20 librbd::api::Mirror: image_get_info: ictx=0x5620afd23e40
2022-03-08T19:11:57.556+0000 7f6e80fa5200 20 librbd::mirror::GetInfoRequest: 0x5620afc5df60 get_mirror_image:
2022-03-08T19:11:57.557+0000 7f6e6e5e8700 20 librbd::mirror::GetInfoRequest: 0x5620afc5df60 handle_get_mirror_image: r=0
2022-03-08T19:11:57.558+0000 7f6e6e5e8700 10 librbd::mirror::GetInfoRequest: 0x5620afc5df60 calc_promotion_state: promotion_state=2, primary_mirror_uuid=9a7de952-fed5-43e2-9d0c-d067556d224b
2022-03-08T19:11:57.558+0000 7f6e6e5e8700 20 librbd::mirror::GetInfoRequest: 0x5620afc5df60 finish: r=0
2022-03-08T19:11:57.558+0000 7f6e80fa5200 20 librbd::api::Mirror: image_promote: ictx=0x5620afd23e40, force=1
2022-03-08T19:11:57.558+0000 7f6e80fa5200 20 librbd::ImageState: 0x5620afd884b0 refresh
2022-03-08T19:11:57.558+0000 7f6e80fa5200 10 librbd::ImageState: 0x5620afd884b0 0x5620afd884b0 send_refresh_unlock
2022-03-08T19:11:57.558+0000 7f6e80fa5200 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_get_mutable_metadata
2022-03-08T19:11:57.559+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_get_mutable_metadata: r=0
2022-03-08T19:11:57.559+0000 7f6e6ede9700  5 librbd::image::RefreshRequest: removing non-primary read-only image flag
2022-03-08T19:11:57.559+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_get_parent: legacy=0
2022-03-08T19:11:57.560+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_get_parent: r=0
2022-03-08T19:11:57.561+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_get_metadata
2022-03-08T19:11:57.561+0000 7f6e6e5e8700 15 librbd::image::GetMetadataRequest: 0x7f6e4c003340 metadata_list: start_key=conf_
2022-03-08T19:11:57.563+0000 7f6e6ede9700 15 librbd::image::GetMetadataRequest: 0x7f6e4c003340 handle_metadata_list: r=0
2022-03-08T19:11:57.563+0000 7f6e6ede9700 15 librbd::image::GetMetadataRequest: 0x7f6e4c003340 finish: r=0
2022-03-08T19:11:57.563+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_get_metadata: r=0
2022-03-08T19:11:57.563+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_get_pool_metadata
2022-03-08T19:11:57.563+0000 7f6e6ede9700 15 librbd::image::GetMetadataRequest: 0x7f6e54017d60 metadata_list: start_key=conf_
2022-03-08T19:11:57.564+0000 7f6e6e5e8700 15 librbd::image::GetMetadataRequest: 0x7f6e54017d60 handle_metadata_list: r=0
2022-03-08T19:11:57.564+0000 7f6e6e5e8700 15 librbd::image::GetMetadataRequest: 0x7f6e54017d60 finish: r=0
2022-03-08T19:11:57.564+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_get_pool_metadata: r=0
2022-03-08T19:11:57.564+0000 7f6e6e5e8700 20 librbd::ImageCtx: apply_metadata
2022-03-08T19:11:57.564+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_get_group
2022-03-08T19:11:57.565+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_get_group: r=0
2022-03-08T19:11:57.565+0000 7f6e6ede9700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_get_snapshots
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_get_snapshots: r=0
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_init_exclusive_lock
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::ExclusiveLock: 0x7f6e540179c0 init: features=1053
2022-03-08T19:11:57.566+0000 7f6e6e5e8700  5 librbd::io::Dispatcher: 0x5620afd8b1c0 register_dispatch: dispatch_layer=3
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::exclusive_lock::ImageDispatch: 0x7f6e540022f0 set_require_lock: direction=1, enabled=1
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::AsyncOperation: 0x7f6e54014190 start_op
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::Dispatcher: 0x5620afd8b1c0 send: dispatch_spec=0x7f6e540141f0
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::RefreshImageDispatch: 0x5620afd8b840 flush: tid=2
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::WriteBlockImageDispatch: 0x5620afb8cef0 flush: tid=2
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::ImageDispatch: 0x5620afd8b260 flush:
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::ImageRequest: 0x7f6e6e5e29f0 send: aio_flush: ictx=0x5620afd23e40, completion=0x7f6e54014080
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::AioCompletion: 0x7f6e54014080 set_request_count: pending=1
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::Dispatcher: 0x5620afd88530 send: dispatch_spec=0x7f6e4c003450
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::cache::WriteAroundObjectDispatch: 0x7f6e54016c90 flush:
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::AioCompletion: 0x7f6e54014080 complete_request: cb=1, pending=0
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::AioCompletion: 0x7f6e54014080 finalize: r=0
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_init_exclusive_lock: r=0
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 send_v2_apply
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::io::AsyncOperation: 0x7f6e54014190 finish_op
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::image::RefreshRequest: 0x5620afd8c940 handle_v2_apply
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::image::RefreshRequest: 0x5620afd8c940 apply
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 10 librbd::ImageState: 0x5620afd884b0 0x5620afd884b0 handle_refresh: r=0
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::mirror::PromoteRequest: 0x5620afd8c7b0 get_info:
2022-03-08T19:11:57.566+0000 7f6e6e5e8700 20 librbd::mirror::GetInfoRequest: 0x5620afc5df60 get_mirror_image:
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 20 librbd::mirror::GetInfoRequest: 0x5620afc5df60 handle_get_mirror_image: r=0
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 10 librbd::mirror::GetInfoRequest: 0x5620afc5df60 calc_promotion_state: promotion_state=2, primary_mirror_uuid=9a7de952-fed5-43e2-9d0c-d067556d224b
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 20 librbd::mirror::GetInfoRequest: 0x5620afc5df60 finish: r=0
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 20 librbd::mirror::PromoteRequest: 0x5620afd8c7b0 handle_get_info: r=0
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 20 librbd::mirror::PromoteRequest: 0x5620afd8c7b0 promote:
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 20 librbd::mirror::snapshot::util:  can_create_primary_snapshot: previous snapshot snap_id=853 [mirror state=non-primary, complete=1, mirror_peer_uuids=, primary_mirror_uuid=9a7de952-fed5-43e2-9d0c-d067556d224b, primary_snap_id=225, last_copied_object_number=0, snap_seqs={549=18446744073709551614}]
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 send: requires_orphan=1, rollback_snap_id=18446744073709551614
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 create_orphan_snapshot:
2022-03-08T19:11:57.568+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::CreateNonPrimaryRequest: 0x7f6e54017300 get_mirror_image:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 15 librbd::mirror::snapshot::CreateNonPrimaryRequest: 0x7f6e54017300 handle_get_mirror_image: r=0
2022-03-08T19:11:57.569+0000 7f6e6ede9700 15 librbd::mirror::snapshot::CreateNonPrimaryRequest: 0x7f6e54017300 create_snapshot: ns=[mirror state=non-primary, complete=1, mirror_peer_uuids=, primary_mirror_uuid=, primary_snap_id=head, last_copied_object_number=0, snap_seqs={}]
2022-03-08T19:11:57.569+0000 7f6e6ede9700  5 librbd::Operations: 0x5620afd88040 snap_create: snap_name=.mirror.non_primary.c11dd83b-ee7c-4f0d-933c-61c97bb66894.e00b2646-558a-422a-a365-56e56bb345e7
2022-03-08T19:11:57.569+0000 7f6e6ede9700 20 librbd::ManagedLock: 0x7f6e540179d8 is_lock_owner: =0
2022-03-08T19:11:57.569+0000 7f6e6ede9700 20 librbd::Operations: send_acquire_exclusive_lock
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::ManagedLock: 0x7f6e540179d8 try_acquire_lock:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::ManagedLock: 0x7f6e540179d8 send_acquire_lock:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::ExclusiveLock: 0x7f6e540179c0 pre_acquire_lock_handler
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::exclusive_lock::PreAcquireRequest: 0x7f6e4c003270 send_prepare_lock:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::ImageState: 0x5620afd884b0 prepare_lock
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::ImageState: 0x5620afd884b0 0x5620afd884b0 send_prepare_lock_unlock
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::exclusive_lock::PreAcquireRequest: 0x7f6e4c003270 handle_prepare_lock: r=0
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::exclusive_lock::PreAcquireRequest: 0x7f6e4c003270 send_flush_notifies:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::exclusive_lock::PreAcquireRequest: 0x7f6e4c003270 handle_flush_notifies:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::ManagedLock: 0x7f6e540179d8 handle_pre_acquire_lock: r=0
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 send_get_locker:
2022-03-08T19:11:57.569+0000 7f6e6ede9700 10 librbd::managed_lock::GetLockerRequest: 0x7f6e4c002060 send_get_lockers:
2022-03-08T19:11:57.570+0000 7f6e6ede9700 10 librbd::managed_lock::GetLockerRequest: 0x7f6e4c002060 handle_get_lockers: r=0
2022-03-08T19:11:57.570+0000 7f6e6ede9700 10 librbd::managed_lock::GetLockerRequest: 0x7f6e4c002060 handle_get_lockers: retrieved exclusive locker: client.4343@192.168.122.239:0/3545043649
2022-03-08T19:11:57.570+0000 7f6e6ede9700 10 librbd::managed_lock::GetLockerRequest: 0x7f6e4c002060 finish: r=0
2022-03-08T19:11:57.570+0000 7f6e6ede9700 10 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 handle_get_locker: r=0
2022-03-08T19:11:57.570+0000 7f6e6ede9700 10 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 send_lock: entity=client.12127, cookie=auto 140111832510128
2022-03-08T19:11:57.578+0000 7f6e6e5e8700 10 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 handle_lock: r=-16
2022-03-08T19:11:57.578+0000 7f6e6e5e8700 10 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 send_break_lock:
2022-03-08T19:11:57.578+0000 7f6e6e5e8700 10 librbd::managed_lock::BreakRequest: 0x7f6e54017490 send_get_watchers:
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::managed_lock::BreakRequest: 0x7f6e54017490 handle_get_watchers: r=0
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::managed_lock::BreakRequest: 0x7f6e54017490 handle_get_watchers: watcher=[addr=192.168.122.239:0/3545043649, entity=client.4343]
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::managed_lock::BreakRequest: 0x7f6e54017490 handle_get_watchers: lock owner is still alive
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::managed_lock::BreakRequest: 0x7f6e54017490 handle_get_watchers: watcher=[addr=172.17.0.4:0/707225874, entity=client.12127]
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::managed_lock::BreakRequest: 0x7f6e54017490 handle_get_watchers: watcher=[addr=172.17.0.4:0/3830636822, entity=client.12115]
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::managed_lock::BreakRequest: 0x7f6e54017490 finish: r=-11
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 handle_break_lock: r=-11
2022-03-08T19:11:57.580+0000 7f6e6ede9700  5 librbd::managed_lock::AcquireRequest: 0x7f6e4c0028a0 handle_break_lock: lock owner is still alive
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::ManagedLock: 0x7f6e540179d8 handle_acquire_lock: r=-11
2022-03-08T19:11:57.580+0000 7f6e6ede9700  5 librbd::ManagedLock: 0x7f6e540179d8 handle_acquire_lock: unable to acquire exclusive lock
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::ExclusiveLock: 0x7f6e540179c0 post_acquire_lock_handler: r=-11
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::ImageState: 0x5620afd884b0 handle_prepare_lock_complete
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::ManagedLock: 0x7f6e540179d8 handle_post_acquire_lock: r=0
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::Operations: handle_acquire_exclusive_lock: r=0
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::ManagedLock: 0x7f6e540179d8 is_lock_owner: =0
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::Operations: send_remote_request
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::ManagedLock: 0x7f6e540179d8 is_lock_owner: =0
2022-03-08T19:11:57.580+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e54008a60 async request: [12127,140111832510128,1]
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::ImageWatcher: scheduling async request time out: [12127,140111832510128,1]
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::image_watcher::NotifyLockOwner: 0x7f6e4c00bcd0 send_notify
2022-03-08T19:11:57.580+0000 7f6e6ede9700 20 librbd::watcher::Notifier: 0x7f6e54008ae0 notify: pending=1
2022-03-08T19:11:57.582+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:11:57.582+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e4c009940 C_NotifyAck: id=5553392728221, handle=140111832510128
2022-03-08T19:11:57.582+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e54008a60 remote snap_create request: [12127,140111832510128,1] [mirror state=non-primary, complete=1, mirror_peer_uuids=, primary_mirror_uuid=, primary_snap_id=head, last_copied_object_number=0, snap_seqs={}] .mirror.non_primary.c11dd83b-ee7c-4f0d-933c-61c97bb66894.e00b2646-558a-422a-a365-56e56bb345e7 0
2022-03-08T19:11:57.582+0000 7f6e6ede9700 20 librbd::ExclusiveLock: 0x7f6e540179c0 accept_request=0 (request_type=2)
2022-03-08T19:11:57.582+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e4c009940 finish: r=0
2022-03-08T19:11:57.583+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:11:57.583+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e54018340 C_NotifyAck: id=5553392728222, handle=140111832510128
2022-03-08T19:11:57.583+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e54008a60 quiesce request: [4343,93937420734848,20]
2022-03-08T19:11:57.583+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afd884b0 notify_quiesce
2022-03-08T19:11:57.583+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e4c00ccb0 C_ResponseMessage: r=0
2022-03-08T19:11:57.583+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e54018340 finish: r=0
2022-03-08T19:12:02.581+0000 7f6e6ede9700 20 librbd::watcher::Notifier: 0x7f6e54008ae0 handle_notify: r=-110
2022-03-08T19:12:02.581+0000 7f6e6ede9700 20 librbd::watcher::Notifier: 0x7f6e54008ae0 handle_notify: pending=0
2022-03-08T19:12:02.581+0000 7f6e6ede9700 20 librbd::image_watcher::NotifyLockOwner: 0x7f6e4c00bcd0 handle_notify: r=-110
2022-03-08T19:12:02.585+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:02.585+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e540026b0 C_NotifyAck: id=5561982662827, handle=140111832510128
2022-03-08T19:12:02.585+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e54008a60 duplicate quiesce request: [4343,93937420734848,20]
2022-03-08T19:12:02.585+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:02.585+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e64000be0 C_NotifyAck: id=5561982662828, handle=140111832510128
2022-03-08T19:12:02.585+0000 7f6e6ede9700 20 librbd::ImageWatcher: 0x7f6e54008a60 request progress: [12127,140111832510128,1] @ 1/10
2022-03-08T19:12:02.585+0000 7f6e6ede9700 20 librbd::ImageWatcher: scheduling async request time out: [12127,140111832510128,1]
2022-03-08T19:12:02.585+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e64000be0 finish: r=0
2022-03-08T19:12:02.585+0000 7f6e5dffb700 10 librbd::ImageWatcher: 0x7f6e54016780 C_ResponseMessage: r=0
2022-03-08T19:12:02.586+0000 7f6e5dffb700 10 librbd::Watcher::C_NotifyAck 0x7f6e540026b0 finish: r=0
2022-03-08T19:12:07.588+0000 7f6e6e5e8700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:07.588+0000 7f6e6e5e8700 10 librbd::Watcher::C_NotifyAck 0x7f6e480010c0 C_NotifyAck: id=5561982662832, handle=140111832510128
2022-03-08T19:12:07.588+0000 7f6e6e5e8700 10 librbd::ImageWatcher: 0x7f6e54008a60 duplicate quiesce request: [4343,93937420734848,20]
2022-03-08T19:12:07.588+0000 7f6e5dffb700 10 librbd::ImageWatcher: 0x7f6e540183b0 C_ResponseMessage: r=0
2022-03-08T19:12:07.588+0000 7f6e5dffb700 10 librbd::Watcher::C_NotifyAck 0x7f6e480010c0 finish: r=0
2022-03-08T19:12:07.593+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:07.593+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e4c003b00 C_NotifyAck: id=5561982662833, handle=140111832510128
2022-03-08T19:12:07.593+0000 7f6e6ede9700 20 librbd::ImageWatcher: 0x7f6e54008a60 request progress: [12127,140111832510128,1] @ 2/10
2022-03-08T19:12:07.593+0000 7f6e6ede9700 20 librbd::ImageWatcher: scheduling async request time out: [12127,140111832510128,1]
2022-03-08T19:12:07.593+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e4c003b00 finish: r=0
2022-03-08T19:12:08.614+0000 7f6e6e5e8700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:08.614+0000 7f6e6e5e8700 10 librbd::Watcher::C_NotifyAck 0x5620afc63350 C_NotifyAck: id=5566277630131, handle=140111832510128
2022-03-08T19:12:08.614+0000 7f6e6e5e8700 20 librbd::ImageWatcher: 0x7f6e54008a60 request progress: [12127,140111832510128,1] @ 3/10
2022-03-08T19:12:08.614+0000 7f6e6e5e8700 20 librbd::ImageWatcher: scheduling async request time out: [12127,140111832510128,1]
2022-03-08T19:12:08.614+0000 7f6e6e5e8700 10 librbd::Watcher::C_NotifyAck 0x5620afc63350 finish: r=0
2022-03-08T19:12:09.218+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:09.218+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e540026b0 C_NotifyAck: id=5570572597429, handle=140111832510128
2022-03-08T19:12:09.218+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e54008a60 unquiesce request: [4343,93937420734848,20]
2022-03-08T19:12:09.218+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afd884b0 notify_unquiesce
2022-03-08T19:12:09.218+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e540026b0 finish: r=0
2022-03-08T19:12:09.220+0000 7f6e6ede9700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:09.220+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e64000be0 C_NotifyAck: id=5570572597430, handle=140111832510128
2022-03-08T19:12:09.220+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e54008a60 image header updated
2022-03-08T19:12:09.220+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afd884b0 handle_update_notification: refresh_seq = 1, last_refresh = 0
2022-03-08T19:12:09.220+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::notify
2022-03-08T19:12:09.220+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afd884b0 flush_update_watchers
2022-03-08T19:12:09.220+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::flush
2022-03-08T19:12:09.221+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::flush: completing flush
2022-03-08T19:12:09.221+0000 7f6e6ede9700 10 librbd::ImageWatcher: 0x7f6e64004100 C_ResponseMessage: r=0
2022-03-08T19:12:09.221+0000 7f6e6ede9700 10 librbd::Watcher::C_NotifyAck 0x7f6e64000be0 finish: r=0
2022-03-08T19:12:09.223+0000 7f6e6e5e8700  5 librbd::Watcher: 0x7f6e54008a60 notifications_blocked: blocked=0
2022-03-08T19:12:09.223+0000 7f6e6e5e8700 10 librbd::Watcher::C_NotifyAck 0x7f6e54013cc0 C_NotifyAck: id=5570572597431, handle=140111832510128
2022-03-08T19:12:09.223+0000 7f6e6e5e8700 10 librbd::ImageWatcher: 0x7f6e54008a60 request finished: [12127,140111832510128,1]=0
2022-03-08T19:12:09.223+0000 7f6e6e5e8700 10 librbd::Watcher::C_NotifyAck 0x7f6e54013cc0 finish: r=0
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 20 librbd::Operations: handle_remote_request: r=0
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 20 librbd::ImageState: 0x5620afd884b0 handle_update_notification: refresh_seq = 2, last_refresh = 0
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::notify
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::CreateNonPrimaryRequest: 0x7f6e54017300 handle_create_snapshot: r=0
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::CreateNonPrimaryRequest: 0x7f6e54017300 finish: r=0
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 handle_create_orphan_snapshot: r=0
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 list_watchers:
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 send:
2022-03-08T19:12:09.224+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 list_image_watchers:
2022-03-08T19:12:09.225+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 handle_list_image_watchers: r=0
2022-03-08T19:12:09.225+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 handle_list_image_watchers: object_watchers={addr=192.168.122.239:0/3545043649, watcher_id=4343, cookie=93937420734848},{addr=172.17.0.4:0/707225874, watcher_id=12127, cookie=140111832510128}
2022-03-08T19:12:09.225+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 list_mirror_watchers:
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 handle_list_mirror_watchers: r=0
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 handle_list_mirror_watchers: mirror_watchers={addr=192.168.122.239:0/3545043649, watcher_id=4343, cookie=93937373959680},{addr=192.168.122.239:0/3545043649, watcher_id=4343, cookie=93937414050304},{addr=192.168.122.239:0/2736823241, watcher_id=4171, cookie=94101508039808},{addr=192.168.122.241:0/4281505517, watcher_id=4361, cookie=94391331767424},{addr=192.168.122.241:0/4281505517, watcher_id=4361, cookie=94391331773184}
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 finish: r=0
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e540146d0 finish: filtering out my instance: {addr=172.17.0.4:0/707225874, watcher_id=12127, cookie=140111832510128}
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 handle_list_watchers: r=0
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 wait_update_notify:
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::ImageState: 0x5620afd884b0 register_update_watcher
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::register_watcher: watcher=0x7f6e54013538
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 20 librbd::ImageState: 0x5620afd884b0 register_update_watcher: handle=0
2022-03-08T19:12:09.226+0000 7f6e6e5e8700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 scheduler_unregister_update_watcher: scheduler_ticks=5
2022-03-08T19:12:10.226+0000 7f6e5effd700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 scheduler_unregister_update_watcher: scheduler_ticks=4
2022-03-08T19:12:11.227+0000 7f6e5effd700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 scheduler_unregister_update_watcher: scheduler_ticks=3
2022-03-08T19:12:12.228+0000 7f6e5effd700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 scheduler_unregister_update_watcher: scheduler_ticks=2
2022-03-08T19:12:13.228+0000 7f6e5effd700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 scheduler_unregister_update_watcher: scheduler_ticks=1
2022-03-08T19:12:14.228+0000 7f6e5effd700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 scheduler_unregister_update_watcher: scheduler_ticks=0
2022-03-08T19:12:14.228+0000 7f6e6ede9700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 unregister_update_watcher:
2022-03-08T19:12:14.228+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afd884b0 unregister_update_watcher: handle=0
2022-03-08T19:12:14.228+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::unregister_watcher: handle=0
2022-03-08T19:12:14.228+0000 7f6e6ede9700 20 librbd::ImageState: 0x5620afbda160 ImageUpdateWatchers::unregister_watcher: completing unregister
2022-03-08T19:12:14.228+0000 7f6e6ede9700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 handle_unregister_update_watcher: r=0
2022-03-08T19:12:14.228+0000 7f6e6ede9700 15 librbd::mirror::snapshot::PromoteRequest: 0x7f6e540134f0 list_watchers:
2022-03-08T19:12:14.228+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 send:
2022-03-08T19:12:14.228+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 list_image_watchers:
2022-03-08T19:12:14.228+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 handle_list_image_watchers: r=0
2022-03-08T19:12:14.229+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 handle_list_image_watchers: object_watchers={addr=192.168.122.239:0/3545043649, watcher_id=4343, cookie=93937420734848},{addr=172.17.0.4:0/707225874, watcher_id=12127, cookie=140111832510128}
2022-03-08T19:12:14.229+0000 7f6e6e5e8700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 list_mirror_watchers:
2022-03-08T19:12:14.229+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 handle_list_mirror_watchers: r=0
2022-03-08T19:12:14.229+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 handle_list_mirror_watchers: mirror_watchers={addr=192.168.122.239:0/3545043649, watcher_id=4343, cookie=93937373959680},{addr=192.168.122.239:0/3545043649, watcher_id=4343, cookie=93937414050304},{addr=192.168.122.239:0/2736823241, watcher_id=4171, cookie=94101508039808},{addr=192.168.122.241:0/4281505517, watcher_id=4361, cookie=94391331767424},{addr=192.168.122.241:0/4281505517, watcher_id=4361, cookie=94391331773184}
2022-03-08T19:12:14.229+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 finish: r=0
2022-03-08T19:12:14.229+0000 7f6e6ede9700 20 librbd::image::ListWatchersRequest: 0x7f6e4c00bcd0 finish: filtering out my instance: {addr=172.17.0.4:0/707225874, watcher_id=12127, cookie=140111832510128}
```