2025-12-12 09:11:31,478 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 09:11:31,479 - INFO - ya.test - pytest_runtest_setup: test_clickbench[CheckCanonicalPolicy.NO]
2025-12-12 09:11:31,479 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-12-12 09:11:31,479 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-12-12 09:11:31,614 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd
2025-12-12 09:11:31,615 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13877
2025-12-12 09:11:31,616 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/yq5c/0003dd/r3tmp/kikimr_cluster_jz_dvlk9
2025-12-12 09:11:31,646 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd
2025-12-12 09:11:31,647 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/29816
2025-12-12 09:11:31,647 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11452
2025-12-12 09:11:31,648 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22644
2025-12-12 09:11:31,648 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/24828
2025-12-12 09:11:31,649 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/kikimr_configs"
2025-12-12 09:11:31,649 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/yq5c/0003dd/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/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/node_1/logfile_ot3icvn2.log --grpc-port=29816 --mon-port=11452 --ic-port=13877
2025-12-12 09:11:31,650 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:29816/1, disk_size 68719476736
2025-12-12 09:11:31,650 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/node_1/logfile_ot3icvn2.log', '--grpc-port=29816', '--mon-port=11452', '--ic-port=13877')' in '/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/node_1' (no wait)
2025-12-12 09:11:31,652 - DEBUG - ya.test - execute: Command pid: 1219229
2025-12-12 09:11:31,653 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:29816/1
2025-12-12 09:11:35,376 - WARNING - ydb.topic - __del__: Topic client was not closed properly. Consider using method close().
2025-12-12 09:11:35,911 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd
2025-12-12 09:11:35,911 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29816', '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: 13877\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-12-12 09:11:35,912 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-12-12 09:11:35,913 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-12-12 09:11:35,913 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29816', '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: 13877\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-12-12 09:11:35,915 - DEBUG - ya.test - execute: Command pid: 1219696
2025-12-12 09:11:36,708 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) rc: 0
2025-12-12 09:11:36,708 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) elapsed time (sec): 0.7920901775360107
2025-12-12 09:11:36,709 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) idrss: 0
2025-12-12 09:11:36,709 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) inblock: 0
2025-12-12 09:11:36,709 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) isrss: 0
2025-12-12 09:11:36,710 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) ixrss: 0
2025-12-12 09:11:36,710 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) majflt: 0
2025-12-12 09:11:36,710 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) maxrss: 719892
2025-12-12 09:11:36,711 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) minflt: 42264
2025-12-12 09:11:36,711 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) msgrcv: 0
2025-12-12 09:11:36,711 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) msgsnd: 0
2025-12-12 09:11:36,712 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) nivcsw: 60
2025-12-12 09:11:36,712 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) nsignals: 0
2025-12-12 09:11:36,712 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) nswap: 0
2025-12-12 09:11:36,712 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) nvcsw: 810
2025-12-12 09:11:36,713 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) oublock: 8
2025-12-12 09:11:36,713 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) stime: 0.247517
2025-12-12 09:11:36,713 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) utime: 0.486539
2025-12-12 09:11:36,714 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) wtime: 0.794
2025-12-12 09:11:36,714 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-12-12 09:11:36,714 - DEBUG - ya.test - _save_outputs: Command (pid 1219696) errors:

2025-12-12 09:11:36,716 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd
2025-12-12 09:11:36,717 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29816', '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-12-12 09:11:36,719 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-12-12 09:11:36,720 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-12-12 09:11:36,720 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:29816', '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-12-12 09:11:36,722 - DEBUG - ya.test - execute: Command pid: 1219851
2025-12-12 09:11:37,453 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) rc: 0
2025-12-12 09:11:37,453 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) elapsed time (sec): 0.7289996147155762
2025-12-12 09:11:37,454 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) idrss: 0
2025-12-12 09:11:37,454 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) inblock: 0
2025-12-12 09:11:37,454 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) isrss: 0
2025-12-12 09:11:37,454 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) ixrss: 0
2025-12-12 09:11:37,455 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) majflt: 0
2025-12-12 09:11:37,455 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) maxrss: 720300
2025-12-12 09:11:37,455 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) minflt: 42341
2025-12-12 09:11:37,456 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) msgrcv: 0
2025-12-12 09:11:37,456 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) msgsnd: 0
2025-12-12 09:11:37,456 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) nivcsw: 41
2025-12-12 09:11:37,456 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) nsignals: 0
2025-12-12 09:11:37,456 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) nswap: 0
2025-12-12 09:11:37,457 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) nvcsw: 583
2025-12-12 09:11:37,457 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) oublock: 8
2025-12-12 09:11:37,457 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) stime: 0.24792799999999998
2025-12-12 09:11:37,458 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) utime: 0.429332
2025-12-12 09:11:37,458 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) wtime: 0.731
2025-12-12 09:11:37,458 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-12-12 09:11:37,458 - DEBUG - ya.test - _save_outputs: Command (pid 1219851) errors:

2025-12-12 09:11:37,483 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-12-12 09:11:38,013 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd
2025-12-12 09:11:38,014 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62796
2025-12-12 09:11:38,015 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63584
2025-12-12 09:11:38,016 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17418
2025-12-12 09:11:38,016 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11587
2025-12-12 09:11:38,017 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21908
2025-12-12 09:11:38,018 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/kikimr_configs"
2025-12-12 09:11:38,019 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:29816 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/slot_1/logfile_nv36fgwk.log --grpc-port=62796 --mon-port=63584 --ic-port=17418
2025-12-12 09:11:38,020 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:29816', '--tenant=/local/test_db', '--log-file-name=/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/slot_1/logfile_nv36fgwk.log', '--grpc-port=62796', '--mon-port=63584', '--ic-port=17418')' in '/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/cluster/slot_1' (no wait)
2025-12-12 09:11:38,068 - DEBUG - ya.test - execute: Command pid: 1219935
2025-12-12 09:11:38,069 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:62796/1
2025-12-12 09:11:40,080 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydb/ydb
2025-12-12 09:11:40,082 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.7
2025-12-12 09:11:40,083 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.7
2025-12-12 09:11:40,083 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:29816', '-d', '/local/test_db', 'workload', 'clickbench', '-p', 'olap_yatests/clickbench/hits', 'init', '--store=column']' in 'None' (waiting)
2025-12-12 09:11:40,086 - DEBUG - ya.test - execute: Command pid: 1220295
2025-12-12 09:11:48,737 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) rc: 0
2025-12-12 09:11:48,737 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) elapsed time (sec): 8.65011191368103
2025-12-12 09:11:48,738 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) idrss: 0
2025-12-12 09:11:48,738 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) inblock: 0
2025-12-12 09:11:48,739 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) isrss: 0
2025-12-12 09:11:48,740 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) ixrss: 0
2025-12-12 09:11:48,740 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) majflt: 0
2025-12-12 09:11:48,740 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) maxrss: 721692
2025-12-12 09:11:48,741 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) minflt: 101858
2025-12-12 09:11:48,741 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) msgrcv: 0
2025-12-12 09:11:48,741 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) msgsnd: 0
2025-12-12 09:11:48,741 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) nivcsw: 127
2025-12-12 09:11:48,742 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) nsignals: 0
2025-12-12 09:11:48,742 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) nswap: 0
2025-12-12 09:11:48,742 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) nvcsw: 2682
2025-12-12 09:11:48,743 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) oublock: 16
2025-12-12 09:11:48,743 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) stime: 0.248029
2025-12-12 09:11:48,743 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) utime: 0.266418
2025-12-12 09:11:48,744 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) wtime: 8.653
2025-12-12 09:11:48,746 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) output:
Init tables ...
Init tables ...Ok

2025-12-12 09:11:48,746 - DEBUG - ya.test - _save_outputs: Command (pid 1220295) errors:
(!) New version of YDB CLI is available. Run 'ydb update' command for update. You can also disable further version checks with 'ydb version --disable-checks' command

2025-12-12 09:11:48,746 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-12-12 09:11:48,751 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:48,760 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:48,781 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 546
2025-12-12 09:11:48,784 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:48,784 - ERROR - root - _join_errors: Node ghrun-7uza2v6l2u.auto.internal too yong: 9.615892887115479
2025-12-12 09:11:48,786 - INFO - root - _create_ydb_driver: Connecting to grpc://localhost:29816 to local/test_db ydb_access_token is set False
2025-12-12 09:11:48,786 - 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-12-12 09:11:48,806 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-12-12 09:11:48,807 - 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-12-12 09:11:48,858 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-12-12 09:11:48,859 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 277aff10-bfdb-4a42-ab55-d32fd739e454, localhost:29816): creating call state
2025-12-12 09:11:48,860 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 277aff10-bfdb-4a42-ab55-d32fd739e454, localhost:29816): request = { database: "local/test_db" }
2025-12-12 09:11:48,869 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 277aff10-bfdb-4a42-ab55-d32fd739e454, localhost:29816): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-7uza2v6l2u.auto.internal" port: 62796 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" node_id: 50000 } self_location: "1" } } } }
2025-12-12 09:11:48,873 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-7uza2v6l2u.auto.internal:62796, location , ssl: False>]>
2025-12-12 09:11:48,873 - 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-12-12 09:11:48,899 - INFO - ydb.connection - close: Closing channel for endpoint localhost:29816
2025-12-12 09:11:48,901 - INFO - root - _create_ydb_driver: Connected
2025-12-12 09:11:48,902 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 6bce33c8-43f6-491a-969c-c550c5b01e38, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:48,903 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 6bce33c8-43f6-491a-969c-c550c5b01e38, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:48,910 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 6bce33c8-43f6-491a-969c-c550c5b01e38, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:49,019 - ERROR - root - _join_errors: Only 0 from 1 dynnodes are ok: Node ghrun-7uza2v6l2u.auto.internal too yong: 9.615892887115479
2025-12-12 09:11:50,025 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:50,029 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:50,041 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 549
2025-12-12 09:11:50,043 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:50,044 - ERROR - root - _join_errors: Node ghrun-7uza2v6l2u.auto.internal too yong: 10.87511944770813
2025-12-12 09:11:50,045 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 16f1ae34-2975-4f5f-bb96-2543969ce037, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:50,046 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 16f1ae34-2975-4f5f-bb96-2543969ce037, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:50,048 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 16f1ae34-2975-4f5f-bb96-2543969ce037, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:50,106 - ERROR - root - _join_errors: Only 0 from 1 dynnodes are ok: Node ghrun-7uza2v6l2u.auto.internal too yong: 10.87511944770813
2025-12-12 09:11:51,110 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:51,120 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:51,142 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 548
2025-12-12 09:11:51,144 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:51,145 - ERROR - root - _join_errors: Node ghrun-7uza2v6l2u.auto.internal too yong: 11.976001024246216
2025-12-12 09:11:51,148 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 0312fa53-00dc-4dc8-82d4-a1f970a15eac, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:51,149 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 0312fa53-00dc-4dc8-82d4-a1f970a15eac, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:51,152 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 0312fa53-00dc-4dc8-82d4-a1f970a15eac, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:51,281 - ERROR - root - _join_errors: Only 0 from 1 dynnodes are ok: Node ghrun-7uza2v6l2u.auto.internal too yong: 11.976001024246216
2025-12-12 09:11:52,285 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:52,292 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:52,306 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 550
2025-12-12 09:11:52,309 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:52,314 - ERROR - root - _join_errors: Node ghrun-7uza2v6l2u.auto.internal too yong: 13.144876480102539
2025-12-12 09:11:52,315 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 4e006c3c-d405-4f07-b28c-b7179b7adfaf, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:52,315 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 4e006c3c-d405-4f07-b28c-b7179b7adfaf, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:52,326 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 4e006c3c-d405-4f07-b28c-b7179b7adfaf, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:52,493 - ERROR - root - _join_errors: Only 0 from 1 dynnodes are ok: Node ghrun-7uza2v6l2u.auto.internal too yong: 13.144876480102539
2025-12-12 09:11:53,498 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:53,506 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:53,535 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-12-12 09:11:53,538 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:53,538 - ERROR - root - _join_errors: Node ghrun-7uza2v6l2u.auto.internal too yong: 14.369409322738647
2025-12-12 09:11:53,539 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, df76005e-fe93-4343-afd3-bc00b5f340d0, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:53,540 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, df76005e-fe93-4343-afd3-bc00b5f340d0, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:53,545 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, df76005e-fe93-4343-afd3-bc00b5f340d0, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:53,625 - ERROR - root - _join_errors: Only 0 from 1 dynnodes are ok: Node ghrun-7uza2v6l2u.auto.internal too yong: 14.369409322738647
2025-12-12 09:11:54,633 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:54,650 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:54,687 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-12-12 09:11:54,690 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:54,692 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, e7409ef1-0fef-4b74-82e7-52e8d3b5e135, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:54,692 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, e7409ef1-0fef-4b74-82e7-52e8d3b5e135, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:54,702 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, e7409ef1-0fef-4b74-82e7-52e8d3b5e135, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:54,755 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:54,776 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes HTTP/1.1" 200 766
2025-12-12 09:11:54,785 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:54,804 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes HTTP/1.1" 200 767
2025-12-12 09:11:54,810 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:29816/1
2025-12-12 09:11:54,811 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:62796/1
2025-12-12 09:11:54,817 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_diff_processing.py::TestClickbenchDiffProcessing, test_name: test_clickbench[CheckCanonicalPolicy.NO])
2025-12-12 09:11:54,821 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:54,830 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:54,855 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-12-12 09:11:54,862 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:54,868 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:54,880 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-12-12 09:11:54,882 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-12-12 09:11:54,883 - INFO - root - _get_tables: get_tables /local/test_db/olap_yatests/clickbench/hits
2025-12-12 09:11:54,883 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/clickbench/hits
2025-12-12 09:11:54,884 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, a4589b8d-7bb8-4f7c-8acb-5a2bee4d063a, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:54,885 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, a4589b8d-7bb8-4f7c-8acb-5a2bee4d063a, ghrun-7uza2v6l2u.auto.internal:62796): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/clickbench/hits" }
2025-12-12 09:11:54,892 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, a4589b8d-7bb8-4f7c-8acb-5a2bee4d063a, ghrun-7uza2v6l2u.auto.internal:62796): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "hits" owner: "root@builtin" type: COLUMN_TABLE effective_permissions { subject: "USERS" permission_names: "ydb.database.connect" } effective_permissions { subject: "METADATA-READERS" permission_names: "ydb.generic.list" } effective_permissions { subject: "DATA-READERS" permission_names: "ydb.granular.select_row" } effective_permissions { subject: "DATA-WRITERS" permission_names: "ydb.tables.modify" } effective_permissions { subject: "DDL-ADMINS" permission_names: "ydb.granular.create_directory" permission_names: "ydb.granular.write_attributes" permission_names: "ydb.granular.create_table" permission_names: "ydb.granular.remove_schema" permission_names: "ydb.granular.create_queue" permission_names: "ydb.granular.alter_schema" } effective_permissions { subject: "ACCESS-ADMINS" permission_names: "ydb.access.grant" } effective_permissions { subject: "DATABASE-ADMINS" permission_names: "ydb.generic.manage" } created_at { plan_step: 1765530707210 tx_id: 281474976720659 } } } } } }
2025-12-12 09:11:54,896 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:54,901 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/clickbench/hits&tablets=true HTTP/1.1" 307 0
2025-12-12 09:11:54,917 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/clickbench/hits&tablets=true HTTP/1.1" 200 580
2025-12-12 09:11:54,920 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/clickbench/hits balance: 128-128 shards.
2025-12-12 09:11:54,921 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, ea526e59-fc9b-412f-8392-24b00baf004e, ghrun-7uza2v6l2u.auto.internal:62796): creating call state
2025-12-12 09:11:54,922 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, ea526e59-fc9b-412f-8392-24b00baf004e, ghrun-7uza2v6l2u.auto.internal:62796): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-12-12 09:11:54,924 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, ea526e59-fc9b-412f-8392-24b00baf004e, ghrun-7uza2v6l2u.auto.internal:62796): response = { <_MultiThreadedRendezvous object> }
2025-12-12 09:11:54,984 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydb/ydb
2025-12-12 09:11:54,986 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.8
2025-12-12 09:11:54,987 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.8
2025-12-12 09:11:54,995 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:29816', '-d', '/local/test_db', 'workload', 'clickbench', '--path', 'olap_yatests/clickbench/hits', 'run', '--json', '/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/q1.json', '--output', '/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/q1.out', '--executer', 'generic', '--include', '1', '--iterations', '1', '--plan', '/home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/q1.plan', '--global-timeout', '1800.0s', '--verbose']' in 'None' (waiting)
2025-12-12 09:11:55,002 - DEBUG - ya.test - execute: Command pid: 1224444
2025-12-12 09:11:57,250 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) rc: 0
2025-12-12 09:11:57,251 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) elapsed time (sec): 2.2463254928588867
2025-12-12 09:11:57,251 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) idrss: 0
2025-12-12 09:11:57,251 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) inblock: 0
2025-12-12 09:11:57,252 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) isrss: 0
2025-12-12 09:11:57,252 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) ixrss: 0
2025-12-12 09:11:57,252 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) majflt: 0
2025-12-12 09:11:57,253 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) maxrss: 730328
2025-12-12 09:11:57,253 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) minflt: 99542
2025-12-12 09:11:57,258 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) msgrcv: 0
2025-12-12 09:11:57,258 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) msgsnd: 0
2025-12-12 09:11:57,258 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) nivcsw: 126
2025-12-12 09:11:57,259 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) nsignals: 0
2025-12-12 09:11:57,259 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) nswap: 0
2025-12-12 09:11:57,259 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) nvcsw: 1790
2025-12-12 09:11:57,260 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) oublock: 440
2025-12-12 09:11:57,260 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) stime: 0.201796
2025-12-12 09:11:57,261 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) utime: 0.247267
2025-12-12 09:11:57,261 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) wtime: 2.253
2025-12-12 09:11:57,265 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) output:
Query01:
Query text:
SELECT COUNT(*) FROM `olap_yatests/clickbench/hits` WHERE AdvEngineID <> 0

	iteration 0:	ok	1.032854s seconds

Results for 1 iterations
┌─────────┬──────────┬─────────┬─────────┬─────────┬─────────┬───────────┬─────────┬─────────┬─────────┬─────────┬──────────────┬────────────┬────────────┐
│ Query # │ ColdTime │ Min     │ Max     │ Mean    │ Median  │ UnixBench │ Std     │ RttMin  │ RttMax  │ RttAvg  │ SuccessCount │ FailsCount │ DiffsCount │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼──────────────┼────────────┼────────────┤
│ Query01 │   0.913  │   0.913 │   0.913 │   0.912 │   0.912 │   0.913   │   0.000 │   0.120 │   0.120 │   0.120 │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼──────────────┼────────────┼────────────┤
│ Sum     │   0.913  │   0.913 │   0.913 │   0.912 │   0.912 │   0.913   │   0.000 │   0.120 │   0.120 │   0.120 │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼──────────────┼────────────┼────────────┤
│ Avg     │   0.913  │   0.913 │   0.913 │   0.912 │   0.912 │   0.913   │   0.000 │   0.120 │   0.120 │   0.120 │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼──────────────┼────────────┼────────────┤
│ GAvg    │   0.913  │   0.913 │   0.913 │   0.912 │   0.912 │   0.913   │   0.000 │   0.120 │   0.120 │   0.001 │ 1            │            │            │
└─────────┴──────────┴─────────┴─────────┴─────────┴─────────┴───────────┴─────────┴─────────┴─────────┴─────────┴──────────────┴────────────┴────────────┘

Results saved to /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/q1.out
Json report saved to /home/runner/.ya/build/build_root/yq5c/0003dd/ydb/tests/functional/tpc/medium/test-results/py3test/testing_out_stuff/test_diff_processing/testing_out_stuff/test_diff_processing.py.TestClickbenchDiffProcessing.test_clickbench.CheckCanonicalPolicy.NO/q1.json

2025-12-12 09:11:57,266 - DEBUG - ya.test - _save_outputs: Command (pid 1224444) errors:
(!) New version of YDB CLI is available. Run 'ydb update' command for update. You can also disable further version checks with 'ydb version --disable-checks' command

[K|Progress: 0 rows read, 0 B read.
[K
[K|Progress: 0 rows read, 0 B read.
[K/Progress: 0 rows read, 0 B read.
[K
2025-12-12 09:11:57,267 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-12-12 09:11:57,290 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:57,294 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-12-12 09:11:57,319 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-12-12 09:11:57,324 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:11452
2025-12-12 09:11:57,331 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:11452 "GET /viewer/json/nodes HTTP/1.1" 200 773
2025-12-12 09:11:57,370 - INFO - ya.test - pytest_runtest_teardown: Test teardown
