2025-10-26 19:04:01,378 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 19:04:01,379 - INFO - ya.test - pytest_runtest_setup: test_replication
2025-10-26 19:04:01,379 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 19:04:01,379 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 19:04:01,381 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: All test params = {}
2025-10-26 19:04:01,381 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: Starting standalone YDB cluster
2025-10-26 19:04:01,528 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/28960
2025-10-26 19:04:01,530 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/28961
2025-10-26 19:04:01,531 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/70hy/000aa8/r3tmp/kikimr__8vyn_3l5
2025-10-26 19:04:01,582 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/15728
2025-10-26 19:04:01,582 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/29034
2025-10-26 19:04:01,583 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/6165
2025-10-26 19:04:01,585 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd
2025-10-26 19:04:01,586 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/kikimr_configs"
2025-10-26 19:04:01,586 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd server --suppress-version-check --node=1 --log-file-name=/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1/logfile_wz4tod52.log --yaml-config=$CFG_DIR_PATH/config.yaml --grpc-port=15728 --mon-port=29034 --ic-port=28961
2025-10-26 19:04:01,587 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:15728/1, disk_size 68719476736
2025-10-26 19:04:01,588 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1/logfile_wz4tod52.log', '--yaml-config=/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/kikimr_configs/config.yaml', '--grpc-port=15728', '--mon-port=29034', '--ic-port=28961')' with input '/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/stdin' in '/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1' (no wait)
2025-10-26 19:04:01,602 - DEBUG - ya.test - execute: Command pid: 1724377
2025-10-26 19:04:01,603 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:15728/1
2025-10-26 19:04:05,740 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd
2025-10-26 19:04:05,741 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:15728', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 28961\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 19:04:05,748 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 19:04:05,749 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 19:04:05,751 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:15728', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineHostConfig {\n    HostConfigId: 1\n    Drive {\n      Path: "SectorMap:1:64"\n    }\n  }\n}\nCommand {\n  DefineBox {\n    BoxId: 1\n    Host {\n      Key {\n        Fqdn: "localhost"\n        IcPort: 28961\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 19:04:05,752 - DEBUG - ya.test - execute: Command pid: 1724652
2025-10-26 19:04:06,966 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) rc: 0
2025-10-26 19:04:06,966 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) elapsed time (sec): 1.2121946811676025
2025-10-26 19:04:06,967 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) idrss: 0
2025-10-26 19:04:06,967 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) inblock: 0
2025-10-26 19:04:06,967 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) isrss: 0
2025-10-26 19:04:06,968 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) ixrss: 0
2025-10-26 19:04:06,970 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) majflt: 0
2025-10-26 19:04:06,970 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) maxrss: 582624
2025-10-26 19:04:06,971 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) minflt: 46600
2025-10-26 19:04:06,972 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) msgrcv: 0
2025-10-26 19:04:06,973 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) msgsnd: 0
2025-10-26 19:04:06,973 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) nivcsw: 217
2025-10-26 19:04:06,973 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) nsignals: 0
2025-10-26 19:04:06,974 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) nswap: 0
2025-10-26 19:04:06,974 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) nvcsw: 828
2025-10-26 19:04:06,974 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) oublock: 8
2025-10-26 19:04:06,974 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) stime: 0.333377
2025-10-26 19:04:06,975 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) utime: 0.5746669999999999
2025-10-26 19:04:06,975 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) wtime: 1.214
2025-10-26 19:04:06,975 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 19:04:06,976 - DEBUG - ya.test - _save_outputs: Command (pid 1724652) errors:

2025-10-26 19:04:06,978 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd
2025-10-26 19:04:06,984 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:15728', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-10-26 19:04:06,985 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 19:04:06,986 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 19:04:06,987 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:15728', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 19:04:06,990 - DEBUG - ya.test - execute: Command pid: 1724740
2025-10-26 19:04:08,059 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) rc: 0
2025-10-26 19:04:08,060 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) elapsed time (sec): 1.0649182796478271
2025-10-26 19:04:08,060 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) idrss: 0
2025-10-26 19:04:08,061 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) inblock: 0
2025-10-26 19:04:08,061 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) isrss: 0
2025-10-26 19:04:08,062 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) ixrss: 0
2025-10-26 19:04:08,074 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) majflt: 0
2025-10-26 19:04:08,074 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) maxrss: 582984
2025-10-26 19:04:08,074 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) minflt: 46677
2025-10-26 19:04:08,075 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) msgrcv: 0
2025-10-26 19:04:08,081 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) msgsnd: 0
2025-10-26 19:04:08,082 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) nivcsw: 164
2025-10-26 19:04:08,082 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) nsignals: 0
2025-10-26 19:04:08,082 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) nswap: 0
2025-10-26 19:04:08,082 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) nvcsw: 854
2025-10-26 19:04:08,083 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) oublock: 8
2025-10-26 19:04:08,083 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) stime: 0.24606599999999998
2025-10-26 19:04:08,083 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) utime: 0.63235
2025-10-26 19:04:08,084 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) wtime: 1.068
2025-10-26 19:04:08,093 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-26 19:04:08,102 - DEBUG - ya.test - _save_outputs: Command (pid 1724740) errors:

2025-10-26 19:04:08,228 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 19:04:08,303 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_self_heal.py::TestEnableSelfHeal, test_name: test_replication)
2025-10-26 19:04:20,306 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:15728/1
2025-10-26 19:04:20,307 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/70hy/000aa8/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1/logfile_wz4tod52.log', '--yaml-config=/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/kikimr_configs/config.yaml', '--grpc-port=15728', '--mon-port=29034', '--ic-port=28961')' with input '/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/stdin' in '/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1' (no wait)
2025-10-26 19:04:20,313 - DEBUG - ya.test - execute: Command pid: 1725178
2025-10-26 19:04:20,314 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:15728/1
2025-10-26 19:04:20,328 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-10-26 19:04:21,329 - DEBUG - library.python.cores - recover_core_dump_file: hostname = 'ghrun-pqq4nwlsgu'
2025-10-26 19:04:21,330 - DEBUG - library.python.cores - recover_core_dump_file: rlimit_core = '(0, -1)'
2025-10-26 19:04:21,331 - DEBUG - library.python.cores - recover_core_dump_file: core_pattern = '|/usr/share/apport/apport -p%p -s%s -c%c -d%d -P%P -u%u -g%g -F%F -- %E'
2025-10-26 19:04:21,331 - DEBUG - library.python.cores - recover_core_dump_file: core_uses_pid = '1'
2025-10-26 19:04:21,332 - DEBUG - library.python.cores - recover_core_dump_file: Core dump dir (/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1) permission mask: 0o40755 (expected: 0o41777 (0o40000-dir, 0o1000-sticky bit))
2025-10-26 19:04:21,332 - DEBUG - library.python.cores - recover_core_dump_file: Search for core dump files match pattern 'core.1725178' in '/home/runner/.ya/build/build_root/70hy/000aa8/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_self_heal/chunk0/testing_out_stuff/test_self_heal.py__TestEnableSelfHeal__test_replication/node_1'
2025-10-26 19:04:21,333 - DEBUG - library.python.cores - recover_core_dump_file: Matched core dump files (0/1): [] (mismatched samples: logfile_wz4tod52.log)
2025-10-26 19:04:21,347 - WARNING - library.python.cores - recover_core_dump_file: Core dump dir doesn't exist: /coredumps
2025-10-26 19:04:21,349 - WARNING - library.python.cores - recover_core_dump_file: Core dump dir doesn't exist: /var/tmp/cores
2025-10-26 19:04:21,352 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:15728/1
2025-10-26 19:04:21,353 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/6165
2025-10-26 19:04:21,354 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/29034
2025-10-26 19:04:21,354 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/15728
2025-10-26 19:04:21,354 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/28961
