2025-10-26 18:34:15,665 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 18:34:15,665 - INFO - ya.test - pytest_runtest_setup: test_when_write_in_new_channel_then_can_read_from_tablet
2025-10-26 18:34:15,665 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 18:34:15,666 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 18:34:15,667 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: All test params = {}
2025-10-26 18:34:15,667 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: Starting standalone YDB cluster
2025-10-26 18:34:15,753 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/20520
2025-10-26 18:34:15,755 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/70hy/000af0/r3tmp/kikimr__nkb___dk
2025-10-26 18:34:15,784 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/32758
2025-10-26 18:34:15,786 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/17650
2025-10-26 18:34:15,787 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/29393
2025-10-26 18:34:15,789 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd
2025-10-26 18:34:15,790 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/70hy/000af0/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk1/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_in_new_channel_then_can_read_from_tablet/kikimr_configs"
2025-10-26 18:34:15,790 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd server --suppress-version-check --node=1 --log-file-name=/home/runner/.ya/build/build_root/70hy/000af0/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk1/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_in_new_channel_then_can_read_from_tablet/node_1/logfile_cjf92mqx.log --yaml-config=$CFG_DIR_PATH/config.yaml --grpc-port=32758 --mon-port=17650 --ic-port=20520
2025-10-26 18:34:15,790 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:32758/1, disk_size 68719476736
2025-10-26 18:34:15,792 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/70hy/000af0/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk1/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_in_new_channel_then_can_read_from_tablet/node_1/logfile_cjf92mqx.log', '--yaml-config=/home/runner/.ya/build/build_root/70hy/000af0/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk1/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_in_new_channel_then_can_read_from_tablet/kikimr_configs/config.yaml', '--grpc-port=32758', '--mon-port=17650', '--ic-port=20520')' with input '/home/runner/.ya/build/build_root/70hy/000af0/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk1/stdin' in '/home/runner/.ya/build/build_root/70hy/000af0/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk1/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_in_new_channel_then_can_read_from_tablet/node_1' (no wait)
2025-10-26 18:34:15,793 - DEBUG - ya.test - execute: Command pid: 1478328
2025-10-26 18:34:15,794 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:32758/1
2025-10-26 18:34:17,930 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd
2025-10-26 18:34:17,930 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:32758', '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: 20520\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 18:34:17,931 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 18:34:17,932 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 18:34:17,932 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:32758', '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: 20520\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 18:34:17,933 - DEBUG - ya.test - execute: Command pid: 1479014
2025-10-26 18:34:18,652 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) rc: 0
2025-10-26 18:34:18,653 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) elapsed time (sec): 0.7181921005249023
2025-10-26 18:34:18,653 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) idrss: 0
2025-10-26 18:34:18,653 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) inblock: 0
2025-10-26 18:34:18,654 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) isrss: 0
2025-10-26 18:34:18,654 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) ixrss: 0
2025-10-26 18:34:18,654 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) majflt: 0
2025-10-26 18:34:18,654 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) maxrss: 582624
2025-10-26 18:34:18,654 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) minflt: 46556
2025-10-26 18:34:18,655 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) msgrcv: 0
2025-10-26 18:34:18,655 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) msgsnd: 0
2025-10-26 18:34:18,655 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) nivcsw: 2
2025-10-26 18:34:18,655 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) nsignals: 0
2025-10-26 18:34:18,655 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) nswap: 0
2025-10-26 18:34:18,656 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) nvcsw: 720
2025-10-26 18:34:18,656 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) oublock: 8
2025-10-26 18:34:18,656 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) stime: 0.252566
2025-10-26 18:34:18,656 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) utime: 0.444036
2025-10-26 18:34:18,657 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) wtime: 0.72
2025-10-26 18:34:18,657 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 18:34:18,657 - DEBUG - ya.test - _save_outputs: Command (pid 1479014) errors:

2025-10-26 18:34:18,659 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd
2025-10-26 18:34:18,659 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:32758', '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 18:34:18,660 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 18:34:18,661 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 18:34:18,661 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/000af0/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:32758', '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 18:34:18,663 - DEBUG - ya.test - execute: Command pid: 1479194
2025-10-26 18:34:19,393 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) rc: 0
2025-10-26 18:34:19,394 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) elapsed time (sec): 0.7297523021697998
2025-10-26 18:34:19,394 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) idrss: 0
2025-10-26 18:34:19,394 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) inblock: 0
2025-10-26 18:34:19,395 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) isrss: 0
2025-10-26 18:34:19,395 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) ixrss: 0
2025-10-26 18:34:19,396 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) majflt: 0
2025-10-26 18:34:19,396 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) maxrss: 582816
2025-10-26 18:34:19,397 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) minflt: 46620
2025-10-26 18:34:19,397 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) msgrcv: 0
2025-10-26 18:34:19,398 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) msgsnd: 0
2025-10-26 18:34:19,398 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) nivcsw: 5
2025-10-26 18:34:19,398 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) nsignals: 0
2025-10-26 18:34:19,399 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) nswap: 0
2025-10-26 18:34:19,399 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) nvcsw: 699
2025-10-26 18:34:19,399 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) oublock: 8
2025-10-26 18:34:19,399 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) stime: 0.264717
2025-10-26 18:34:19,399 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) utime: 0.44195799999999996
2025-10-26 18:34:19,400 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) wtime: 0.731
2025-10-26 18:34:19,400 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-26 18:34:19,400 - DEBUG - ya.test - _save_outputs: Command (pid 1479194) errors:

2025-10-26 18:34:19,459 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-26 18:34:19,542 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_tablet_channel_migration.py::TestChannelsOps, test_name: test_when_write_in_new_channel_then_can_read_from_tablet)
2025-10-26 18:34:19,565 - INFO - root - predicate: Result from callable = 
================================================================================
Status: 1
TabletStateInfo {
  TabletId: 72075186224037892
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037896
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037889
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037893
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037897
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037890
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037894
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037888
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037895
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037891
  ChangeTime: 1761503659557
  State: Discover
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}

================================================================================

2025-10-26 18:34:21,569 - INFO - root - predicate: Result from callable = 
================================================================================
Status: 1
TabletStateInfo {
  TabletId: 72075186224037892
  ChangeTime: 1761503659605
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037896
  ChangeTime: 1761503659600
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037889
  ChangeTime: 1761503659600
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037893
  ChangeTime: 1761503659597
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037897
  ChangeTime: 1761503659600
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037890
  ChangeTime: 1761503659600
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037894
  ChangeTime: 1761503659597
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037888
  ChangeTime: 1761503659602
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037895
  ChangeTime: 1761503659603
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037891
  ChangeTime: 1761503659603
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}

================================================================================

2025-10-26 18:44:21,724 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:32758/1
2025-10-26 18:44:21,725 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/29393
2025-10-26 18:44:21,725 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/17650
2025-10-26 18:44:21,726 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/32758
2025-10-26 18:44:21,726 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/20520
