2025-11-11 15:25:56,447 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-11 15:25:56,447 - INFO - ya.test - pytest_runtest_setup: test_user_can_change_password_for_himself[dbadmin]
2025-11-11 15:25:56,447 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-11 15:25:56,447 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-11 15:25:56,449 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_user_administration.py, test_name: test_user_can_change_password_for_himself[dbadmin])
2025-11-11 15:25:56,450 - 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'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-11 15:25:56,468 - DEBUG - ydb.connection - _prepare_call: RpcState(Login, 81d03370-897f-43cf-9d58-c362025bbdc9, localhost:13404): creating call state
2025-11-11 15:25:56,469 - DEBUG - ydb.connection - _log_request: RpcState(Login, 81d03370-897f-43cf-9d58-c362025bbdc9, localhost:13404): request = { operation_params { operation_timeout { seconds: 10 } cancel_after { seconds: 10 } } user: "dbadmin4" password: "1234" }
2025-11-11 15:25:56,484 - DEBUG - ydb.connection - _log_response: RpcState(Login, 81d03370-897f-43cf-9d58-c362025bbdc9, localhost:13404): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Auth.LoginResult] { token: "eyJhbGciOiJQUzI1NiIsImtpZCI6IjEifQ.eyJhdWQiOlsiXC9Sb290XC90ZXN0X3VzZXJfYWRtaW5pc3RyYXRpb24iXSwiZXhwIjoxNzYyOTE3OTU2LCJpYXQiOjE3NjI4NzQ3NTYsInN1YiI6ImRiYWRtaW40In0.KKPKw3UH9IBou3vuXFyiUYxGiGISls5LiLBHhZ_ROkTOxZd8FYFAeJtBsEQBx09G5yRMCprTYVwayT_GEC38VivQd9vkUxaUw-gfmRKGZrqKlPP3zNAuUKjUL1d1ShFwl6qIsLIH4zsJrY7QFPzfx6c41_FIaTR_gVdwztuojYSwqti7vNsKiFgdukWUQ5LBdtGsHV3bwXkD8VELFRNCdXutba7upgVcxbkqy8EPspG6SgPkt6YW1fzdjx6I3KwqWwFSoM5Rin36OL4jcPQNKSaEl3RCBuWcfTICuG4W3QbbuoWd-4pf29v7BLb0IJHPoRUFaGFO2oZy_WAIRRT0Xg" } } } }
2025-11-11 15:25:56,484 - INFO - ydb.connection - close: Closing channel for endpoint localhost:13404
2025-11-11 15:25:56,672 - 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'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-11 15:25:56,674 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-11 15:25:56,674 - 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'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-11 15:25:56,681 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database /Root/test_user_administration
2025-11-11 15:25:56,681 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ec812551-12fa-4e6a-a91f-1110b636dba6, localhost:13404): creating call state
2025-11-11 15:25:56,682 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ec812551-12fa-4e6a-a91f-1110b636dba6, localhost:13404): request = { database: "/Root/test_user_administration" }
2025-11-11 15:25:56,687 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ec812551-12fa-4e6a-a91f-1110b636dba6, localhost:13404): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-l3u76ogmey.auto.internal" port: 12329 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-11 15:25:56,687 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database /Root/test_user_administration: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-l3u76ogmey.auto.internal:12329, location , ssl: False>]>
2025-11-11 15:25:56,688 - 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'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-11 15:25:56,698 - INFO - ydb.connection - close: Closing channel for endpoint localhost:13404
2025-11-11 15:25:56,700 - DEBUG - ydb.table.SessionPool - subscribe: Active session queue is empty, subscribe waiter for a session
2025-11-11 15:25:56,701 - DEBUG - ydb.table.SessionPool - subscribe: Subscribe waiter <Future at 0x7f320ab069a0 state=pending>
2025-11-11 15:25:56,701 - DEBUG - ydb.table.SessionPool - subscribe: Session pool is not large enough (active_count < size: 0 < 100). will create a new session.
2025-11-11 15:25:56,701 - DEBUG - ydb.table.SessionPool - _create: Created session <ydb.table.Session object at 0x7f320ab06d10>
2025-11-11 15:25:56,701 - DEBUG - ydb.table.SessionPool - _prepare: Preparing session <ydb.table.Session object at 0x7f320ab06d10>
2025-11-11 15:25:56,702 - DEBUG - ydb.connection - _prepare_call: RpcState(CreateSession, a2a19a05-c8ff-4ea8-ab62-4e97ef3a114b, ghrun-l3u76ogmey.auto.internal:12329): creating call state
2025-11-11 15:25:56,702 - DEBUG - ydb.connection - _log_request: RpcState(CreateSession, a2a19a05-c8ff-4ea8-ab62-4e97ef3a114b, ghrun-l3u76ogmey.auto.internal:12329): request = { operation_params { operation_timeout { seconds: 3 } cancel_after { seconds: 3 } } }
2025-11-11 15:25:56,705 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, a2a19a05-c8ff-4ea8-ab62-4e97ef3a114b, ghrun-l3u76ogmey.auto.internal:12329): on response callback started
2025-11-11 15:25:56,706 - DEBUG - ydb.connection - _log_response: RpcState(CreateSession, a2a19a05-c8ff-4ea8-ab62-4e97ef3a114b, ghrun-l3u76ogmey.auto.internal:12329): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Table.CreateSessionResult] { session_id: "ydb://session/3?node_id=50000&id=NDc0NDU0NzMtZWFiMGFmMWYtYjdjODc0ODQtZjI1YzRjZjI=" } } } }
2025-11-11 15:25:56,706 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f320ab06d10>
2025-11-11 15:25:56,707 - DEBUG - ydb.table.SessionPool - put: Replying to waiter with a session <ydb.table.Session object at 0x7f320ab06d10>
2025-11-11 15:25:56,707 - DEBUG - ydb.connection - _prepare_call: RpcState(ExecuteSchemeQuery, 65a6befe-9e39-4b9b-ba74-db37d9226b82, ghrun-l3u76ogmey.auto.internal:12329): creating call state
2025-11-11 15:25:56,708 - DEBUG - ydb.connection - _log_request: RpcState(ExecuteSchemeQuery, 65a6befe-9e39-4b9b-ba74-db37d9226b82, ghrun-l3u76ogmey.auto.internal:12329): request = { session_id: "ydb://session/3?node_id=50000&id=NDc0NDU0NzMtZWFiMGFmMWYtYjdjODc0ODQtZjI1YzRjZjI=" yql_text: "alter user dbadmin4 password \'4321\'" operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } }
2025-11-11 15:25:56,708 - DEBUG - ydb.connection - _on_response_callback: RpcState(CreateSession, a2a19a05-c8ff-4ea8-ab62-4e97ef3a114b, ghrun-l3u76ogmey.auto.internal:12329): on response callback success
2025-11-11 15:25:56,718 - DEBUG - ydb.connection - _log_response: RpcState(ExecuteSchemeQuery, 65a6befe-9e39-4b9b-ba74-db37d9226b82, ghrun-l3u76ogmey.auto.internal:12329): response = { operation { ready: true status: SUCCESS } }
2025-11-11 15:25:56,719 - DEBUG - ydb.table.SessionPool - put: Put on session <ydb.table.Session object at 0x7f320ab06d10>
2025-11-11 15:25:56,719 - DEBUG - ydb.topic - close: Close topic client
2025-11-11 15:25:56,719 - DEBUG - ydb.topic - close: Topic client was closed
2025-11-11 15:25:56,720 - INFO - ydb.connection - close: Closing channel for endpoint localhost:13404
2025-11-11 15:25:56,884 - INFO - ydb.connection - close: Closing channel for endpoint ghrun-l3u76ogmey.auto.internal:12329
2025-11-11 15:25:56,901 - INFO - ydb.pool.Discovery - run: Successfully terminated discovery process
2025-11-11 15:25:56,902 - 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'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-11 15:25:56,909 - DEBUG - ydb.connection - _prepare_call: RpcState(Login, e652189c-db84-4ed0-a094-510eed3aba4b, localhost:13404): creating call state
2025-11-11 15:25:56,909 - DEBUG - ydb.connection - _log_request: RpcState(Login, e652189c-db84-4ed0-a094-510eed3aba4b, localhost:13404): request = { operation_params { operation_timeout { seconds: 10 } cancel_after { seconds: 10 } } user: "dbadmin4" password: "4321" }
2025-11-11 15:25:56,920 - DEBUG - ydb.connection - _log_response: RpcState(Login, e652189c-db84-4ed0-a094-510eed3aba4b, localhost:13404): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Auth.LoginResult] { token: "eyJhbGciOiJQUzI1NiIsImtpZCI6IjEifQ.eyJhdWQiOlsiXC9Sb290XC90ZXN0X3VzZXJfYWRtaW5pc3RyYXRpb24iXSwiZXhwIjoxNzYyOTE3OTU2LCJpYXQiOjE3NjI4NzQ3NTYsInN1YiI6ImRiYWRtaW40In0.n4UUEtgp2kL1j3uqol4RlWDrvBGML-RMkOLyScutjOcYxX3MZzqvJAfIAx7lS2yY-cewb7GM2E9CgqQYm2_Lt599KH878cB6UmhTB1BvNIwEuyb_757xAqQyoBvWYzT2avvmtc5BNNuC_hkVOPZ4u1dIOg_BgrGCxjHnSf4LZYwYwGDHTw6Tp6xaNM0bwClGXbv1VcAplLu_ITdnrKvrSie5-aSAkSY6Wqde2iS1bqwp_Mmke4MiXL5eaJiCo0E4qnAIfe7b5LEYbB6MTMDiDS1DZ_fslbFjV-5x_ApFxqFnjq6NL5u5magau4Vcv_wslJmd1t4E7Yt66WgIedjIZg" } } } }
2025-11-11 15:25:56,920 - INFO - ydb.connection - close: Closing channel for endpoint localhost:13404
2025-11-11 15:25:57,113 - INFO - ya.test - pytest_runtest_teardown: Test teardown
