2025-10-26 18:50:26,157 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 18:50:26,157 - INFO - ya.test - pytest_runtest_setup: test_when_write_and_change_tablet_channel_then_can_read_from_tablet
2025-10-26 18:50:26,158 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-26 18:50:26,158 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-26 18:50:26,158 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: All test params = {}
2025-10-26 18:50:26,159 - INFO - ydb.tests.library.harness.kikimr_cluster - kikimr_cluster_factory: Starting standalone YDB cluster
2025-10-26 18:50:26,228 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/3241
2025-10-26 18:50:26,229 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/70hy/000abf/r3tmp/kikimr__hx5ycwyp
2025-10-26 18:50:26,260 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/19340
2025-10-26 18:50:26,261 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/7191
2025-10-26 18:50:26,261 - DEBUG - library.python.filelock - acquire: Acquiring filelock (blocking=False): /home/runner/.ya/build/port_sync_dir/27878
2025-10-26 18:50:26,262 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd
2025-10-26 18:50:26,263 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/70hy/000abf/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk0/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_and_change_tablet_channel_then_can_read_from_tablet/kikimr_configs"
2025-10-26 18:50:26,263 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd server --suppress-version-check --node=1 --log-file-name=/home/runner/.ya/build/build_root/70hy/000abf/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk0/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_and_change_tablet_channel_then_can_read_from_tablet/node_1/logfile_yqfz76km.log --yaml-config=$CFG_DIR_PATH/config.yaml --grpc-port=19340 --mon-port=7191 --ic-port=3241
2025-10-26 18:50:26,263 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:19340/1, disk_size 68719476736
2025-10-26 18:50:26,264 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/70hy/000abf/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk0/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_and_change_tablet_channel_then_can_read_from_tablet/node_1/logfile_yqfz76km.log', '--yaml-config=/home/runner/.ya/build/build_root/70hy/000abf/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk0/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_and_change_tablet_channel_then_can_read_from_tablet/kikimr_configs/config.yaml', '--grpc-port=19340', '--mon-port=7191', '--ic-port=3241')' with input '/home/runner/.ya/build/build_root/70hy/000abf/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk0/stdin' in '/home/runner/.ya/build/build_root/70hy/000abf/ydb/tests/functional/blobstorage/test-results/py3test/testing_out_stuff/test_tablet_channel_migration/chunk0/testing_out_stuff/test_tablet_channel_migration.py__TestChannelsOps__test_when_write_and_change_tablet_channel_then_can_read_from_tablet/node_1' (no wait)
2025-10-26 18:50:26,266 - DEBUG - ya.test - execute: Command pid: 1644088
2025-10-26 18:50:26,267 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:19340/1
2025-10-26 18:50:28,415 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd
2025-10-26 18:50:28,416 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:19340', '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: 3241\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-26 18:50:28,417 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-26 18:50:28,418 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-26 18:50:28,418 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:19340', '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: 3241\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-26 18:50:28,420 - DEBUG - ya.test - execute: Command pid: 1644318
2025-10-26 18:50:29,106 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) rc: 0
2025-10-26 18:50:29,106 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) elapsed time (sec): 0.6852240562438965
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) idrss: 0
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) inblock: 0
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) isrss: 0
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) ixrss: 0
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) majflt: 0
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) maxrss: 582852
2025-10-26 18:50:29,107 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) minflt: 46560
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) msgrcv: 0
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) msgsnd: 0
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) nivcsw: 4
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) nsignals: 0
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) nswap: 0
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) nvcsw: 747
2025-10-26 18:50:29,108 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) oublock: 8
2025-10-26 18:50:29,109 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) stime: 0.254774
2025-10-26 18:50:29,109 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) utime: 0.41208799999999995
2025-10-26 18:50:29,109 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) wtime: 0.687
2025-10-26 18:50:29,109 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-26 18:50:29,110 - DEBUG - ya.test - _save_outputs: Command (pid 1644318) errors:

2025-10-26 18:50:29,111 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd
2025-10-26 18:50:29,111 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:19340', '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:50:29,112 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-26 18:50:29,113 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-26 18:50:29,113 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/70hy/000abf/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:19340', '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:50:29,114 - DEBUG - ya.test - execute: Command pid: 1644400
2025-10-26 18:50:29,796 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) rc: 0
2025-10-26 18:50:29,797 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) elapsed time (sec): 0.6812729835510254
2025-10-26 18:50:29,797 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) idrss: 0
2025-10-26 18:50:29,797 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) inblock: 0
2025-10-26 18:50:29,798 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) isrss: 0
2025-10-26 18:50:29,798 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) ixrss: 0
2025-10-26 18:50:29,798 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) majflt: 0
2025-10-26 18:50:29,798 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) maxrss: 582664
2025-10-26 18:50:29,798 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) minflt: 46524
2025-10-26 18:50:29,799 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) msgrcv: 0
2025-10-26 18:50:29,799 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) msgsnd: 0
2025-10-26 18:50:29,799 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) nivcsw: 1
2025-10-26 18:50:29,799 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) nsignals: 0
2025-10-26 18:50:29,799 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) nswap: 0
2025-10-26 18:50:29,799 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) nvcsw: 747
2025-10-26 18:50:29,800 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) oublock: 8
2025-10-26 18:50:29,800 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) stime: 0.19950299999999999
2025-10-26 18:50:29,800 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) utime: 0.45952299999999996
2025-10-26 18:50:29,800 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) wtime: 0.683
2025-10-26 18:50:29,801 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-10-26 18:50:29,801 - DEBUG - ya.test - _save_outputs: Command (pid 1644400) errors:

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

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

2025-10-26 18:50:31,890 - INFO - root - predicate: Result from callable = 
================================================================================
Status: 1
TabletStateInfo {
  TabletId: 72075186224037892
  ChangeTime: 1761504629923
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037896
  ChangeTime: 1761504629924
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037889
  ChangeTime: 1761504629918
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037893
  ChangeTime: 1761504629924
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037897
  ChangeTime: 1761504629925
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037890
  ChangeTime: 1761504629924
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037894
  ChangeTime: 1761504629920
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037888
  ChangeTime: 1761504629919
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037895
  ChangeTime: 1761504629922
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}
TabletStateInfo {
  TabletId: 72075186224037891
  ChangeTime: 1761504629920
  State: Active
  Generation: 1
  Type: KeyValue
  Host: "localhost"
  Leader: true
  FollowerId: 0
  TenantId {
    SchemeShard: 72075186232723360
    PathId: 1
  }
  HiveId: 72057594037968897
}

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

2025-10-26 19:00:32,907 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:19340/1
2025-10-26 19:00:32,909 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/27878
2025-10-26 19:00:32,910 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/7191
2025-10-26 19:00:32,915 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/19340
2025-10-26 19:00:32,915 - DEBUG - library.python.filelock - release: Ensuring filelock released: /home/runner/.ya/build/port_sync_dir/3241
