2025-11-14 06:54:04,014 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-14 06:54:04,014 - INFO - ya.test - pytest_runtest_setup: test_create_user
2025-11-14 06:54:04,014 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-14 06:54:04,014 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-14 06:54:04,062 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd
2025-11-14 06:54:04,063 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18138
2025-11-14 06:54:04,063 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster for __tests__.test_create_users
2025-11-14 06:54:04,064 - INFO - ydb.tests.library.fixtures - ydb_cluster: setup ydb_cluster as local
2025-11-14 06:54:04,064 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/rl7h/0030d5/r3tmp/kikimr_cluster_jtrqri5s
2025-11-14 06:54:04,094 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd
2025-11-14 06:54:04,094 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28485
2025-11-14 06:54:04,095 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/1111
2025-11-14 06:54:04,095 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28471
2025-11-14 06:54:04,095 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5663
2025-11-14 06:54:04,096 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/kikimr_configs"
2025-11-14 06:54:04,096 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node=1 --log-file-name=/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/node_1/logfile_frpugiuy.log --grpc-port=28485 --mon-port=1111 --ic-port=18138
2025-11-14 06:54:04,096 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:28485/1, disk_size 68719476736
2025-11-14 06:54:04,097 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/node_1/logfile_frpugiuy.log', '--grpc-port=28485', '--mon-port=1111', '--ic-port=18138')' in '/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/node_1' (no wait)
2025-11-14 06:54:04,098 - DEBUG - ya.test - execute: Command pid: 1459823
2025-11-14 06:54:04,098 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28485/1
2025-11-14 06:54:05,844 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd
2025-11-14 06:54:05,844 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28485', '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: 18138\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-14 06:54:05,845 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-14 06:54:05,845 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-14 06:54:05,845 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28485', '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: 18138\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-14 06:54:05,846 - DEBUG - ya.test - execute: Command pid: 1461068
2025-11-14 06:54:06,773 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) rc: 0
2025-11-14 06:54:06,773 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) elapsed time (sec): 0.9254229068756104
2025-11-14 06:54:06,773 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) idrss: 0
2025-11-14 06:54:06,773 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) inblock: 0
2025-11-14 06:54:06,773 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) isrss: 0
2025-11-14 06:54:06,773 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) ixrss: 0
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) majflt: 2
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) maxrss: 525804
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) minflt: 19703
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) msgrcv: 0
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) msgsnd: 0
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) nivcsw: 4
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) nsignals: 0
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) nswap: 0
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) nvcsw: 182
2025-11-14 06:54:06,774 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) oublock: 8
2025-11-14 06:54:06,775 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) stime: 0.789141
2025-11-14 06:54:06,775 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) utime: 0.091667
2025-11-14 06:54:06,775 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) wtime: 0.927
2025-11-14 06:54:06,775 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-14 06:54:06,775 - DEBUG - ya.test - _save_outputs: Command (pid 1461068) errors:

2025-11-14 06:54:06,776 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd
2025-11-14 06:54:06,776 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28485', '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-11-14 06:54:06,777 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-14 06:54:06,777 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-14 06:54:06,777 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:28485', '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-11-14 06:54:06,778 - DEBUG - ya.test - execute: Command pid: 1461369
2025-11-14 06:54:07,356 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) rc: 0
2025-11-14 06:54:07,357 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) elapsed time (sec): 0.5779728889465332
2025-11-14 06:54:07,357 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) idrss: 0
2025-11-14 06:54:07,357 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) inblock: 0
2025-11-14 06:54:07,357 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) isrss: 0
2025-11-14 06:54:07,357 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) ixrss: 0
2025-11-14 06:54:07,357 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) majflt: 2
2025-11-14 06:54:07,358 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) maxrss: 525636
2025-11-14 06:54:07,358 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) minflt: 23577
2025-11-14 06:54:07,358 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) msgrcv: 0
2025-11-14 06:54:07,358 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) msgsnd: 0
2025-11-14 06:54:07,358 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) nivcsw: 2
2025-11-14 06:54:07,358 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) nsignals: 0
2025-11-14 06:54:07,359 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) nswap: 0
2025-11-14 06:54:07,359 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) nvcsw: 145
2025-11-14 06:54:07,359 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) oublock: 8
2025-11-14 06:54:07,359 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) stime: 0.454615
2025-11-14 06:54:07,359 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) utime: 0.08046199999999999
2025-11-14 06:54:07,360 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) wtime: 0.579
2025-11-14 06:54:07,360 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-14 06:54:07,360 - DEBUG - ya.test - _save_outputs: Command (pid 1461369) errors:

2025-11-14 06:54:07,360 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain Root: {'dynamic_storage_pool:1': 'hdd'}
2025-11-14 06:54:07,371 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-14 06:54:07,378 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_create_users.py, test_name: test_create_user)
2025-11-14 06:54:07,882 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd
2025-11-14 06:54:07,883 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/19005
2025-11-14 06:54:07,884 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26819
2025-11-14 06:54:07,884 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22293
2025-11-14 06:54:07,884 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18888
2025-11-14 06:54:07,884 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5497
2025-11-14 06:54:07,885 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/kikimr_configs"
2025-11-14 06:54:07,885 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28485 --tenant=/Root/users/database --log-file-name=/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/slot_1/logfile_j44ss086.log --grpc-port=19005 --mon-port=26819 --ic-port=22293
2025-11-14 06:54:07,886 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:28485', '--tenant=/Root/users/database', '--log-file-name=/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/slot_1/logfile_j44ss086.log', '--grpc-port=19005', '--mon-port=26819', '--ic-port=22293')' in '/home/runner/.ya/build/build_root/rl7h/0030d5/ydb/tests/functional/tenants/test-results/py3test/testing_out_stuff/chunk0/testing_out_stuff/test_create_users.py.test_create_user/cluster/slot_1' (no wait)
2025-11-14 06:54:07,887 - DEBUG - ya.test - execute: Command pid: 1462102
2025-11-14 06:54:07,887 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:19005/1
2025-11-14 06:54:13,893 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:13,894 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-14 06:54:13,895 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 1, will create new one.
2025-11-14 06:54:13,896 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:13,899 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root
2025-11-14 06:54:13,900 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d228ea8f-6052-4f6d-902d-e619dbea53ca, localhost:28485): creating call state
2025-11-14 06:54:13,900 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d228ea8f-6052-4f6d-902d-e619dbea53ca, localhost:28485): request = { database: "/Root" }
2025-11-14 06:54:13,902 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d228ea8f-6052-4f6d-902d-e619dbea53ca, localhost:28485): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-iuibjpfjoa.auto.internal" port: 28485 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" location: "1" node_id: 1 } self_location: "1" } } } }
2025-11-14 06:54:13,902 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-iuibjpfjoa.auto.internal:28485, location 1, ssl: False>]>
2025-11-14 06:54:13,903 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:13,906 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:14,611 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 1, will create new one.
2025-11-14 06:54:14,612 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 5705fb11-2e96-409b-8809-e88f0c6b746e, ghrun-iuibjpfjoa.auto.internal:28485): creating call state
2025-11-14 06:54:14,612 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 5705fb11-2e96-409b-8809-e88f0c6b746e, ghrun-iuibjpfjoa.auto.internal:28485): request = {  }
2025-11-14 06:54:14,614 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 5705fb11-2e96-409b-8809-e88f0c6b746e, ghrun-iuibjpfjoa.auto.internal:28485): response = { status: SUCCESS session_id: "ydb://session/3?node_id=1&id=YjU1ZTczOTUtYmM3MTZmODMtOTUzODgyZTMtZjliM2M5ZWI=" node_id: 1 }
2025-11-14 06:54:14,614 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, f53ae8e6-ebf0-4cdd-8fd3-b15536768e72, ghrun-iuibjpfjoa.auto.internal:28485): creating call state
2025-11-14 06:54:14,615 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, f53ae8e6-ebf0-4cdd-8fd3-b15536768e72, ghrun-iuibjpfjoa.auto.internal:28485): request = { session_id: "ydb://session/3?node_id=1&id=YjU1ZTczOTUtYmM3MTZmODMtOTUzODgyZTMtZjliM2M5ZWI=" }
2025-11-14 06:54:14,616 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, f53ae8e6-ebf0-4cdd-8fd3-b15536768e72, ghrun-iuibjpfjoa.auto.internal:28485): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:14,617 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=1&id=YjU1ZTczOTUtYmM3MTZmODMtOTUzODgyZTMtZjliM2M5ZWI=
2025-11-14 06:54:14,617 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 468ab869-b2e8-41e8-a1e0-0ee3e2a5c362, ghrun-iuibjpfjoa.auto.internal:28485): creating call state
2025-11-14 06:54:14,618 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 468ab869-b2e8-41e8-a1e0-0ee3e2a5c362, ghrun-iuibjpfjoa.auto.internal:28485): request = { session_id: "ydb://session/3?node_id=1&id=YjU1ZTczOTUtYmM3MTZmODMtOTUzODgyZTMtZjliM2M5ZWI=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "CREATE USER user;" } stats_mode: STATS_MODE_NONE }
2025-11-14 06:54:14,618 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 468ab869-b2e8-41e8-a1e0-0ee3e2a5c362, ghrun-iuibjpfjoa.auto.internal:28485): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:14,625 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=1&id=YjU1ZTczOTUtYmM3MTZmODMtOTUzODgyZTMtZjliM2M5ZWI=
2025-11-14 06:54:14,625 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, e2221e1b-1d0a-4e9e-906d-a848d8e4727e, ghrun-iuibjpfjoa.auto.internal:28485): creating call state
2025-11-14 06:54:14,626 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, e2221e1b-1d0a-4e9e-906d-a848d8e4727e, ghrun-iuibjpfjoa.auto.internal:28485): request = { session_id: "ydb://session/3?node_id=1&id=YjU1ZTczOTUtYmM3MTZmODMtOTUzODgyZTMtZjliM2M5ZWI=" }
2025-11-14 06:54:14,627 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, e2221e1b-1d0a-4e9e-906d-a848d8e4727e, ghrun-iuibjpfjoa.auto.internal:28485): response = { status: SUCCESS }
2025-11-14 06:54:14,628 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-14 06:54:14,629 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:14,629 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-iuibjpfjoa.auto.internal:28485
2025-11-14 06:54:14,630 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-14 06:54:14,630 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:14,632 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-14 06:54:14,632 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 1, will create new one.
2025-11-14 06:54:14,632 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:14,636 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-14 06:54:14,636 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, d5a8ef96-ca10-49eb-b389-519558272fc4, localhost:28485): creating call state
2025-11-14 06:54:14,636 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, d5a8ef96-ca10-49eb-b389-519558272fc4, localhost:28485): request = { database: "/Root/users/database" }
2025-11-14 06:54:14,638 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, d5a8ef96-ca10-49eb-b389-519558272fc4, localhost:28485): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-iuibjpfjoa.auto.internal" port: 19005 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50000 } self_location: "1" } } } }
2025-11-14 06:54:14,639 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-iuibjpfjoa.auto.internal:19005, location , ssl: False>]>
2025-11-14 06:54:14,639 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:14,642 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:15,446 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 1, will create new one.
2025-11-14 06:54:15,447 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 1ef3afb6-bd0b-4da7-a381-d053f49bfb61, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:15,447 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 1ef3afb6-bd0b-4da7-a381-d053f49bfb61, ghrun-iuibjpfjoa.auto.internal:19005): request = {  }
2025-11-14 06:54:15,450 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 1ef3afb6-bd0b-4da7-a381-d053f49bfb61, ghrun-iuibjpfjoa.auto.internal:19005): response = { status: SUCCESS session_id: "ydb://session/3?node_id=50000&id=ZjFhYWZjLWY2YWRiNGFiLTk4MjVkZGE3LTEzNDhmZmU0" node_id: 50000 }
2025-11-14 06:54:15,450 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, f975752a-6a13-4de7-81f3-ce4c32aa118b, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:15,451 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, f975752a-6a13-4de7-81f3-ce4c32aa118b, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=ZjFhYWZjLWY2YWRiNGFiLTk4MjVkZGE3LTEzNDhmZmU0" }
2025-11-14 06:54:15,452 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, f975752a-6a13-4de7-81f3-ce4c32aa118b, ghrun-iuibjpfjoa.auto.internal:19005): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:15,453 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=50000&id=ZjFhYWZjLWY2YWRiNGFiLTk4MjVkZGE3LTEzNDhmZmU0
2025-11-14 06:54:15,454 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 40f4dd25-cf2b-4005-a6d5-30e26c0bc6bd, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:15,455 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 40f4dd25-cf2b-4005-a6d5-30e26c0bc6bd, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=ZjFhYWZjLWY2YWRiNGFiLTk4MjVkZGE3LTEzNDhmZmU0" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "GRANT ALL ON `/Root/users/database` TO user;" } stats_mode: STATS_MODE_NONE }
2025-11-14 06:54:15,455 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 40f4dd25-cf2b-4005-a6d5-30e26c0bc6bd, ghrun-iuibjpfjoa.auto.internal:19005): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:15,461 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=50000&id=ZjFhYWZjLWY2YWRiNGFiLTk4MjVkZGE3LTEzNDhmZmU0
2025-11-14 06:54:15,462 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 5d5e40d2-1459-4ce5-b8ae-97e1d469b665, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:15,462 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 5d5e40d2-1459-4ce5-b8ae-97e1d469b665, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=ZjFhYWZjLWY2YWRiNGFiLTk4MjVkZGE3LTEzNDhmZmU0" }
2025-11-14 06:54:15,464 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 5d5e40d2-1459-4ce5-b8ae-97e1d469b665, ghrun-iuibjpfjoa.auto.internal:19005): response = { status: SUCCESS }
2025-11-14 06:54:15,465 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-14 06:54:15,465 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:15,466 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-iuibjpfjoa.auto.internal:19005
2025-11-14 06:54:15,466 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-14 06:54:15,467 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:15,468 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-14 06:54:15,468 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 1, will create new one.
2025-11-14 06:54:15,469 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:15,472 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/users/database
2025-11-14 06:54:15,472 - DEBUG - ydb.credentials.StaticCredentials - _log_refresh_start: Start refresh token from metadata
2025-11-14 06:54:15,473 - INFO - ydb.credentials.StaticCredentials - _log_refresh_start: Cached token reached refresh_in deadline, current time 1763103255.4727542, deadline 0
2025-11-14 06:54:15,473 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:15,475 - DEBUG - ydb.connection - _prepare_call: RpcState(Login, 6e6e7cd9-b579-41ef-b305-a9edd3df018c, localhost:28485): creating call state
2025-11-14 06:54:15,476 - DEBUG - ydb.connection - _log_request: RpcState(Login, 6e6e7cd9-b579-41ef-b305-a9edd3df018c, localhost:28485): request = { operation_params { operation_timeout { seconds: 10 } cancel_after { seconds: 10 } } user: "user" }
2025-11-14 06:54:15,524 - DEBUG - ydb.connection - _log_response: RpcState(Login, 6e6e7cd9-b579-41ef-b305-a9edd3df018c, localhost:28485): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Auth.LoginResult] { token: "eyJhbGciOiJQUzI1NiIsImtpZCI6IjEifQ.eyJhdWQiOlsiXC9Sb290Il0sImV4cCI6MTc2MzE0NjQ1NSwiaWF0IjoxNzYzMTAzMjU1LCJzdWIiOiJ1c2VyIn0.1Wy4TPZYHgfNKzQLfG5L7A0Cow0ne9Lk0E5LljaNKPrArglSExUwIAy6bVxuibWTaPJpR00qrmgdqc5BbmHps_QoU6hgMa0z_bdBTATXUzSbK78Bkm-aeqgpISslp7ii6g6NLHHNz_ljurilhpBJIuxleXOu6TyDRpl3hPctxXz-2lWmeT1p4hg7RO289JX0lF9TMOECF_e8JitLSWiQj5m81SOJMrWLnQVGsFYtGo3r_7kfbLTAViWMjOClAUgSJoaVYWypCAbLY8vf8CJIlzR3EA_LiDe72SwDw9KCd0tVwVPj33xXZlKrkMavHVEaySBzD1aZtkmBQkc-rxVJtQ" } } } }
2025-11-14 06:54:15,525 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:15,678 - INFO - ydb.credentials.StaticCredentials - _refresh: Token refresh successful. current_time 1763103255.4727542, refresh_in 1763103705.6784027
2025-11-14 06:54:15,678 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 834c5250-1d31-4a4f-b713-6e59b53b0391, localhost:28485): creating call state
2025-11-14 06:54:15,679 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 834c5250-1d31-4a4f-b713-6e59b53b0391, localhost:28485): request = { database: "/Root/users/database" }
2025-11-14 06:54:15,682 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 834c5250-1d31-4a4f-b713-6e59b53b0391, localhost:28485): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-iuibjpfjoa.auto.internal" port: 19005 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50000 } self_location: "1" } } } }
2025-11-14 06:54:15,682 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/users/database: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-iuibjpfjoa.auto.internal:19005, location , ssl: False>]>
2025-11-14 06:54:15,683 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin')]
2025-11-14 06:54:15,686 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:16,317 - DEBUG - ydb.query.pool - acquire: Session pool is not large enough: 0 < 1, will create new one.
2025-11-14 06:54:16,318 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, 218e087b-159b-4c2e-98ef-4ff4edf19893, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:16,318 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, 218e087b-159b-4c2e-98ef-4ff4edf19893, ghrun-iuibjpfjoa.auto.internal:19005): request = {  }
2025-11-14 06:54:16,321 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, 218e087b-159b-4c2e-98ef-4ff4edf19893, ghrun-iuibjpfjoa.auto.internal:19005): response = { status: SUCCESS session_id: "ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=" node_id: 50000 }
2025-11-14 06:54:16,321 - DEBUG - ydb.connection - _prepare_call: RpcState(AttachSession, 1a6702f6-b54d-4532-8ce0-ad7d3455ca55, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:16,322 - DEBUG - ydb.connection - _log_request: RpcState(AttachSession, 1a6702f6-b54d-4532-8ce0-ad7d3455ca55, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=" }
2025-11-14 06:54:16,323 - DEBUG - ydb.connection - _log_response: RpcState(AttachSession, 1a6702f6-b54d-4532-8ce0-ad7d3455ca55, ghrun-iuibjpfjoa.auto.internal:19005): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:16,325 - DEBUG - ydb.query.pool - _create_new_session: New session was created for pool. Session id: ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=
2025-11-14 06:54:16,325 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 0687784b-6347-46b6-9954-a5cd25c72f3b, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:16,326 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 0687784b-6347-46b6-9954-a5cd25c72f3b, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "CREATE TABLE table (key Int32, value String, primary key(key));" } stats_mode: STATS_MODE_NONE }
2025-11-14 06:54:16,326 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 0687784b-6347-46b6-9954-a5cd25c72f3b, ghrun-iuibjpfjoa.auto.internal:19005): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:16,404 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=
2025-11-14 06:54:16,404 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=
2025-11-14 06:54:16,405 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 40d449be-e096-4316-9c39-e31c64fe2849, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:16,405 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 40d449be-e096-4316-9c39-e31c64fe2849, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "UPSERT INTO table (key, value) VALUES (1, \"value1\");" } stats_mode: STATS_MODE_NONE }
2025-11-14 06:54:16,406 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 40d449be-e096-4316-9c39-e31c64fe2849, ghrun-iuibjpfjoa.auto.internal:19005): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:16,420 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=
2025-11-14 06:54:16,420 - DEBUG - ydb.query.pool - acquire: Acquired active session from queue: ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=
2025-11-14 06:54:16,421 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteQuery, 722004f4-fca4-4c67-9c4a-0f0179a5213b, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:16,421 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteQuery, 722004f4-fca4-4c67-9c4a-0f0179a5213b, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=" exec_mode: EXEC_MODE_EXECUTE query_content { syntax: SYNTAX_YQL_V1 text: "SELECT * FROM table" } stats_mode: STATS_MODE_NONE }
2025-11-14 06:54:16,422 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteQuery, 722004f4-fca4-4c67-9c4a-0f0179a5213b, ghrun-iuibjpfjoa.auto.internal:19005): response = { <_MultiThreadedRendezvous object> }
2025-11-14 06:54:16,434 - DEBUG - ydb.query.pool - release: Session returned to queue: ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=
2025-11-14 06:54:16,434 - DEBUG - ydb.connection - _prepare_call: RpcState(DeleteSession, 499d750c-ee6a-4ee9-bf9f-763cad9c847a, ghrun-iuibjpfjoa.auto.internal:19005): creating call state
2025-11-14 06:54:16,435 - DEBUG - ydb.connection - _log_request: RpcState(DeleteSession, 499d750c-ee6a-4ee9-bf9f-763cad9c847a, ghrun-iuibjpfjoa.auto.internal:19005): request = { session_id: "ydb://session/3?node_id=50000&id=YjY5MTFhYzYtNGUzMzgwNTEtYjU2MzU2NDItZWZlYzk2ZDM=" }
2025-11-14 06:54:16,436 - DEBUG - ydb.connection - _log_response: RpcState(DeleteSession, 499d750c-ee6a-4ee9-bf9f-763cad9c847a, ghrun-iuibjpfjoa.auto.internal:19005): response = { status: SUCCESS }
2025-11-14 06:54:16,436 - DEBUG - ydb.query.pool - stop: All session were deleted.
2025-11-14 06:54:16,437 - INFO - ydb.connection - close: Closing channel for endpoint localhost:28485
2025-11-14 06:54:16,437 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-iuibjpfjoa.auto.internal:19005
2025-11-14 06:54:16,438 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-14 06:54:16,438 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - remove_database: /Root/users/database
2025-11-14 06:54:16,439 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: send console operation, token None
2025-11-14 06:54:16,441 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_send_op: /Root/users/database: response from console: RemoveTenantResponse {
  Response {
    operation {
      id: "ydb://cmsrequest/5?tenant=/Root/users/database&cmstid=72057594037936131&txid=1763103256439779&action=2"
    }
  }
}
Status {
  Code: STATUS_CODE_UNSPECIFIED
}

2025-11-14 06:54:16,442 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: wait console operation done
2025-11-14 06:54:16,943 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_op: /Root/users/database: console operation done
2025-11-14 06:54:16,943 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: wait tenant gone
2025-11-14 06:54:16,944 - DEBUG - ydb.tests.library.harness.kikimr_cluster_interface - _remove_database_wait_tenant_gone: /Root/users/database: tenant gone
2025-11-14 06:54:17,945 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:19005/1
2025-11-14 06:54:17,946 - INFO - ya.test - pytest_runtest_teardown: Test teardown
2025-11-14 06:54:17,947 - INFO - ydb.tests.library.fixtures - ydb_cluster: destroy ydb_cluster for __tests__.test_create_users
2025-11-14 06:54:24,948 - INFO - ydb.tests.library.harness.kikimr_runner - stop: Stopped node localhost:28485/1
2025-11-14 06:54:24,949 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5497
2025-11-14 06:54:24,949 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18888
2025-11-14 06:54:24,949 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/22293
2025-11-14 06:54:24,949 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/26819
2025-11-14 06:54:24,949 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/19005
2025-11-14 06:54:24,950 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/5663
2025-11-14 06:54:24,950 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28471
2025-11-14 06:54:24,950 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/1111
2025-11-14 06:54:24,950 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/28485
2025-11-14 06:54:24,950 - DEBUG - library.python.filelock - release: Ensuring FileLock released: /home/runner/.ya/build/port_sync_dir/18138
