2025-10-16 17:44:52,986 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:44:52,986 - INFO - ya.test - pytest_runtest_setup: test_tpch[1]
2025-10-16 17:44:52,986 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-10-16 17:44:52,987 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-10-16 17:44:53,058 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd
2025-10-16 17:44:53,059 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28892
2025-10-16 17:44:53,060 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/b9t0/0021dd/r3tmp/kikimr_cluster_zmehs83v
2025-10-16 17:44:53,088 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd
2025-10-16 17:44:53,089 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/26008
2025-10-16 17:44:53,089 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/30455
2025-10-16 17:44:53,090 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28105
2025-10-16 17:44:53,090 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/13459
2025-10-16 17:44:53,091 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs"
2025-10-16 17:44:53,091 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0021dd/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/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/node_1/logfile_3_f5dhor.log --grpc-port=26008 --mon-port=30455 --ic-port=28892
2025-10-16 17:44:53,092 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:26008/1, disk_size 68719476736
2025-10-16 17:44:53,092 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs"
2025-10-16 17:44:53,092 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0021dd/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/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/node_1/logfile_3_f5dhor.log --grpc-port=26008 --mon-port=30455 --ic-port=28892
2025-10-16 17:44:53,093 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/node_1/logfile_3_f5dhor.log', '--grpc-port=26008', '--mon-port=30455', '--ic-port=28892')' in '/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/node_1' (no wait)
2025-10-16 17:44:53,095 - DEBUG - ya.test - execute: Command pid: 1309592
2025-10-16 17:44:53,096 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:26008/1
2025-10-16 17:44:53,097 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-10-16 17:44:53,097 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-10-16 17:44:53,098 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:44:53,099 - DEBUG - ya.test - execute: Command pid: 1309593
2025-10-16 17:44:53,667 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) rc: 0
2025-10-16 17:44:53,667 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) elapsed time (sec): 0.567420482635498
2025-10-16 17:44:53,668 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) idrss: 0
2025-10-16 17:44:53,668 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) inblock: 0
2025-10-16 17:44:53,668 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) isrss: 0
2025-10-16 17:44:53,668 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) ixrss: 0
2025-10-16 17:44:53,669 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) majflt: 0
2025-10-16 17:44:53,669 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) maxrss: 573468
2025-10-16 17:44:53,669 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) minflt: 45117
2025-10-16 17:44:53,669 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) msgrcv: 0
2025-10-16 17:44:53,670 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) msgsnd: 0
2025-10-16 17:44:53,670 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) nivcsw: 3
2025-10-16 17:44:53,670 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) nsignals: 0
2025-10-16 17:44:53,670 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) nswap: 0
2025-10-16 17:44:53,670 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) nvcsw: 15
2025-10-16 17:44:53,670 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) oublock: 8
2025-10-16 17:44:53,671 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) stime: 0.164373
2025-10-16 17:44:53,671 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) utime: 0.358275
2025-10-16 17:44:53,671 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) wtime: 0.569
2025-10-16 17:44:53,671 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-10-16 17:44:53,672 - DEBUG - ya.test - _save_outputs: Command (pid 1309593) errors:

2025-10-16 17:44:53,672 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:44:56,018 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd
2025-10-16 17:44:56,018 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:26008', '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: 28892\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-10-16 17:44:56,019 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-10-16 17:44:56,020 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-10-16 17:44:56,020 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:26008', '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: 28892\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-16 17:44:56,022 - DEBUG - ya.test - execute: Command pid: 1310168
2025-10-16 17:44:56,654 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) rc: 0
2025-10-16 17:44:56,654 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) elapsed time (sec): 0.6312987804412842
2025-10-16 17:44:56,654 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) idrss: 0
2025-10-16 17:44:56,655 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) inblock: 0
2025-10-16 17:44:56,655 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) isrss: 0
2025-10-16 17:44:56,655 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) ixrss: 0
2025-10-16 17:44:56,655 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) majflt: 0
2025-10-16 17:44:56,655 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) maxrss: 648836
2025-10-16 17:44:56,656 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) minflt: 51385
2025-10-16 17:44:56,656 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) msgrcv: 0
2025-10-16 17:44:56,656 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) msgsnd: 0
2025-10-16 17:44:56,656 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) nivcsw: 0
2025-10-16 17:44:56,656 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) nsignals: 0
2025-10-16 17:44:56,657 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) nswap: 0
2025-10-16 17:44:56,657 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) nvcsw: 661
2025-10-16 17:44:56,657 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) oublock: 8
2025-10-16 17:44:56,657 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) stime: 0.183854
2025-10-16 17:44:56,657 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) utime: 0.42468
2025-10-16 17:44:56,658 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) wtime: 0.633
2025-10-16 17:44:56,658 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 4

2025-10-16 17:44:56,658 - DEBUG - ya.test - _save_outputs: Command (pid 1310168) errors:

2025-10-16 17:44:56,659 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd
2025-10-16 17:44:56,659 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:26008', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-10-16 17:44:56,660 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-10-16 17:44:56,661 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-10-16 17:44:56,661 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '--server=grpc://localhost:26008', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-10-16 17:44:56,663 - DEBUG - ya.test - execute: Command pid: 1310250
2025-10-16 17:44:57,277 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) rc: 0
2025-10-16 17:44:57,277 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) elapsed time (sec): 0.6131796836853027
2025-10-16 17:44:57,277 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) idrss: 0
2025-10-16 17:44:57,277 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) inblock: 0
2025-10-16 17:44:57,278 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) isrss: 0
2025-10-16 17:44:57,278 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) ixrss: 0
2025-10-16 17:44:57,278 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) majflt: 0
2025-10-16 17:44:57,278 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) maxrss: 649072
2025-10-16 17:44:57,278 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) minflt: 51446
2025-10-16 17:44:57,279 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) msgrcv: 0
2025-10-16 17:44:57,279 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) msgsnd: 0
2025-10-16 17:44:57,279 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) nivcsw: 2
2025-10-16 17:44:57,279 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) nsignals: 0
2025-10-16 17:44:57,279 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) nswap: 0
2025-10-16 17:44:57,279 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) nvcsw: 709
2025-10-16 17:44:57,280 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) oublock: 8
2025-10-16 17:44:57,280 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) stime: 0.183578
2025-10-16 17:44:57,280 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) utime: 0.406956
2025-10-16 17:44:57,280 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) wtime: 0.615
2025-10-16 17:44:57,280 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-10-16 17:44:57,281 - DEBUG - ya.test - _save_outputs: Command (pid 1310250) errors:

2025-10-16 17:44:57,281 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain local: {'dynamic_storage_pool:1': 'hdd'}
2025-10-16 17:44:57,318 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-10-16 17:44:57,867 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd
2025-10-16 17:44:57,867 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23904
2025-10-16 17:44:57,868 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/25441
2025-10-16 17:44:57,868 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/3694
2025-10-16 17:44:57,868 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/63289
2025-10-16 17:44:57,869 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21186
2025-10-16 17:44:57,869 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs"
2025-10-16 17:44:57,870 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:26008 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/slot_1/logfile_w6m6nbqd.log --grpc-port=23904 --mon-port=25441 --ic-port=3694
2025-10-16 17:44:57,870 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs"
2025-10-16 17:44:57,870 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:26008 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/slot_1/logfile_w6m6nbqd.log --grpc-port=23904 --mon-port=25441 --ic-port=3694
2025-10-16 17:44:57,871 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:26008', '--tenant=/local/test_db', '--log-file-name=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/slot_1/logfile_w6m6nbqd.log', '--grpc-port=23904', '--mon-port=25441', '--ic-port=3694')' in '/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/slot_1' (no wait)
2025-10-16 17:44:57,873 - DEBUG - ya.test - execute: Command pid: 1310589
2025-10-16 17:44:57,873 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:23904/1
2025-10-16 17:44:57,874 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-10-16 17:44:57,875 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-10-16 17:44:57,875 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:44:57,876 - DEBUG - ya.test - execute: Command pid: 1310590
2025-10-16 17:44:58,468 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) rc: 0
2025-10-16 17:44:58,468 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) elapsed time (sec): 0.5906987190246582
2025-10-16 17:44:58,469 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) idrss: 0
2025-10-16 17:44:58,469 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) inblock: 0
2025-10-16 17:44:58,469 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) isrss: 0
2025-10-16 17:44:58,469 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) ixrss: 0
2025-10-16 17:44:58,470 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) majflt: 0
2025-10-16 17:44:58,470 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) maxrss: 661260
2025-10-16 17:44:58,470 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) minflt: 45113
2025-10-16 17:44:58,470 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) msgrcv: 0
2025-10-16 17:44:58,470 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) msgsnd: 0
2025-10-16 17:44:58,471 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) nivcsw: 1
2025-10-16 17:44:58,471 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) nsignals: 0
2025-10-16 17:44:58,471 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) nswap: 0
2025-10-16 17:44:58,471 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) nvcsw: 15
2025-10-16 17:44:58,471 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) oublock: 8
2025-10-16 17:44:58,472 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) stime: 0.184779
2025-10-16 17:44:58,472 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) utime: 0.361243
2025-10-16 17:44:58,472 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) wtime: 0.592
2025-10-16 17:44:58,472 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-10-16 17:44:58,473 - DEBUG - ya.test - _save_outputs: Command (pid 1310590) errors:

2025-10-16 17:44:58,473 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:45:00,486 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydb/ydb
2025-10-16 17:45:00,488 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-10-16 17:45:00,488 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-10-16 17:45:00,489 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:26008', '-d', '/local/test_db', 'workload', 'tpch', '-p', 'olap_yatests/tpch/s1', 'init', '--store=column', '--datetime-types=dt64']' in 'None' (waiting)
2025-10-16 17:45:00,490 - DEBUG - ya.test - execute: Command pid: 1311700
2025-10-16 17:45:13,293 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) rc: 0
2025-10-16 17:45:13,293 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) elapsed time (sec): 12.801607847213745
2025-10-16 17:45:13,294 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) idrss: 0
2025-10-16 17:45:13,294 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) inblock: 0
2025-10-16 17:45:13,294 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) isrss: 0
2025-10-16 17:45:13,295 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) ixrss: 0
2025-10-16 17:45:13,295 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) majflt: 0
2025-10-16 17:45:13,295 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) maxrss: 661940
2025-10-16 17:45:13,296 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) minflt: 110347
2025-10-16 17:45:13,296 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) msgrcv: 0
2025-10-16 17:45:13,296 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) msgsnd: 0
2025-10-16 17:45:13,297 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) nivcsw: 4
2025-10-16 17:45:13,297 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) nsignals: 0
2025-10-16 17:45:13,297 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) nswap: 0
2025-10-16 17:45:13,297 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) nvcsw: 4803
2025-10-16 17:45:13,298 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) oublock: 8
2025-10-16 17:45:13,298 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) stime: 0.298668
2025-10-16 17:45:13,298 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) utime: 0.42106
2025-10-16 17:45:13,299 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) wtime: 12.803
2025-10-16 17:45:13,299 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) output:
Init tables ...
Init tables ...Ok

2025-10-16 17:45:13,299 - DEBUG - ya.test - _save_outputs: Command (pid 1311700) errors:

2025-10-16 17:45:13,300 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydb/ydb
2025-10-16 17:45:13,301 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-10-16 17:45:13,302 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-10-16 17:45:13,303 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:26008', '-d', '/local/test_db', 'workload', 'tpch', '-p', 'olap_yatests/tpch/s1', 'import', 'generator', '--scale=1']' in 'None' (waiting)
2025-10-16 17:45:13,304 - DEBUG - ya.test - execute: Command pid: 1314683
2025-10-16 17:48:36,285 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) rc: 0
2025-10-16 17:48:36,286 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) elapsed time (sec): 202.98015785217285
2025-10-16 17:48:36,286 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) idrss: 0
2025-10-16 17:48:36,287 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) inblock: 0
2025-10-16 17:48:36,287 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) isrss: 0
2025-10-16 17:48:36,287 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) ixrss: 0
2025-10-16 17:48:36,288 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) majflt: 0
2025-10-16 17:48:36,288 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) maxrss: 2898352
2025-10-16 17:48:36,288 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) minflt: 5392088
2025-10-16 17:48:36,289 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) msgrcv: 0
2025-10-16 17:48:36,289 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) msgsnd: 0
2025-10-16 17:48:36,289 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) nivcsw: 8239
2025-10-16 17:48:36,290 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) nsignals: 0
2025-10-16 17:48:36,290 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) nswap: 0
2025-10-16 17:48:36,290 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) nvcsw: 726553
2025-10-16 17:48:36,290 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) oublock: 40
2025-10-16 17:48:36,291 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) stime: 36.063076
2025-10-16 17:48:36,291 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) utime: 205.74598
2025-10-16 17:48:36,292 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) wtime: 202.982
2025-10-16 17:48:36,292 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) output:
Fill table supplier...
Fill table supplier OK 10000 / 10000 (10.445640s)
Fill table customer...
Fill table customer OK 150000 / 150000 (3.936843s)
Fill table orders...
Fill table orders OK 1500000 / 1500000 (170.746318s)
Fill table part...
Fill table part OK 200000 / 200000 (16.488907s)
Fill table nation...
Fill table nation OK 25 / 25 (0.166579s)
Fill table region...
Fill table region OK 5 / 5 (0.158765s)

2025-10-16 17:48:36,292 - DEBUG - ya.test - _save_outputs: Command (pid 1314683) errors:







2025-10-16 17:48:36,293 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-10-16 17:48:36,301 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,305 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:48:36,317 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 552
2025-10-16 17:48:36,321 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-10-16 17:48:36,322 - INFO - root - _create_ydb_driver: Connecting to grpc://localhost:26008 to local/test_db ydb_access_token is set False
2025-10-16 17:48:36,323 - 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-10-16 17:48:36,326 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-10-16 17:48:36,327 - 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-10-16 17:48:36,345 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-10-16 17:48:36,346 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 4fb15cd0-84b1-4ce7-bd63-095b2581e320, localhost:26008): creating call state
2025-10-16 17:48:36,347 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 4fb15cd0-84b1-4ce7-bd63-095b2581e320, localhost:26008): request = { database: "local/test_db" }
2025-10-16 17:48:36,352 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 4fb15cd0-84b1-4ce7-bd63-095b2581e320, localhost:26008): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-2kszfvc6cm.auto.internal" port: 23904 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-10-16 17:48:36,353 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-2kszfvc6cm.auto.internal:23904, location , ssl: False>]>
2025-10-16 17:48:36,353 - 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-10-16 17:48:36,365 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:26008
2025-10-16 17:48:36,366 - INFO - root - _create_ydb_driver: Connected
2025-10-16 17:48:36,368 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 248fc4ee-1d4d-4e18-a9ca-c5c7789444cd, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:36,369 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 248fc4ee-1d4d-4e18-a9ca-c5c7789444cd, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:36,372 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 248fc4ee-1d4d-4e18-a9ca-c5c7789444cd, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:36,540 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,545 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:48:36,556 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 552
2025-10-16 17:48:36,559 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-10-16 17:48:36,559 - INFO - root - get_tables: get_tables /local/test_db/olap_yatests/tpch/s1
2025-10-16 17:48:36,560 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/tpch/s1
2025-10-16 17:48:36,560 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 5bb86f98-9fa3-41a1-beba-92c06a297b50, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:36,561 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 5bb86f98-9fa3-41a1-beba-92c06a297b50, ghrun-2kszfvc6cm.auto.internal:23904): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s1" }
2025-10-16 17:48:36,571 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 5bb86f98-9fa3-41a1-beba-92c06a297b50, ghrun-2kszfvc6cm.auto.internal:23904): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "s1" owner: "root@builtin" type: DIRECTORY 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: 1760636703640 tx_id: 281474976720659 } } } } } }
2025-10-16 17:48:36,572 - INFO - root - list_directory: list /local/test_db/olap_yatests/tpch/s1
2025-10-16 17:48:36,573 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 610cd1ba-c31a-4154-8233-53963a98af27, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:36,573 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 610cd1ba-c31a-4154-8233-53963a98af27, ghrun-2kszfvc6cm.auto.internal:23904): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s1" }
2025-10-16 17:48:36,581 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 610cd1ba-c31a-4154-8233-53963a98af27, ghrun-2kszfvc6cm.auto.internal:23904): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "s1" owner: "root@builtin" type: DIRECTORY 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: 1760636703640 tx_id: 281474976720659 } } children { name: "customer" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636703640 tx_id: 281474976720659 } } children { name: "lineitem" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636705540 tx_id: 281474976720660 } } children { name: "nation" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636705790 tx_id: 281474976720661 } } children { name: "orders" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636707430 tx_id: 281474976720662 } } children { name: "part" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636709250 tx_id: 281474976720663 } } children { name: "partsupp" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636710990 tx_id: 281474976720664 } } children { name: "region" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636711290 tx_id: 281474976720665 } } children { name: "supplier" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636712890 tx_id: 281474976720666 } } } } } }
2025-10-16 17:48:36,586 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,589 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/customer&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,603 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/customer&tablets=true HTTP/1.1" 200 582
2025-10-16 17:48:36,606 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/customer balance: 64-64 shards.
2025-10-16 17:48:36,609 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,613 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/lineitem&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,623 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/lineitem&tablets=true HTTP/1.1" 200 582
2025-10-16 17:48:36,626 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/lineitem balance: 64-64 shards.
2025-10-16 17:48:36,629 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,633 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/nation&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,644 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/nation&tablets=true HTTP/1.1" 200 581
2025-10-16 17:48:36,647 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/nation balance: 1-1 shards.
2025-10-16 17:48:36,650 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,654 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/orders&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,667 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/orders&tablets=true HTTP/1.1" 200 582
2025-10-16 17:48:36,670 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/orders balance: 64-64 shards.
2025-10-16 17:48:36,674 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,678 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/part&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,689 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/part&tablets=true HTTP/1.1" 200 582
2025-10-16 17:48:36,692 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/part balance: 64-64 shards.
2025-10-16 17:48:36,696 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,699 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/partsupp&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,711 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/partsupp&tablets=true HTTP/1.1" 200 582
2025-10-16 17:48:36,714 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/partsupp balance: 64-64 shards.
2025-10-16 17:48:36,717 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,721 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/region&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,734 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/region&tablets=true HTTP/1.1" 200 581
2025-10-16 17:48:36,737 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/region balance: 1-1 shards.
2025-10-16 17:48:36,741 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:48:36,745 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/supplier&tablets=true HTTP/1.1" 307 0
2025-10-16 17:48:36,759 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/supplier&tablets=true HTTP/1.1" 200 582
2025-10-16 17:48:36,762 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/supplier balance: 64-64 shards.
2025-10-16 17:48:36,764 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, c468699b-d6d3-4836-9f14-5fc99a78fb9d, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:36,765 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, c468699b-d6d3-4836-9f14-5fc99a78fb9d, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:36,767 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, c468699b-d6d3-4836-9f14-5fc99a78fb9d, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:36,847 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 7b6a3398-b92e-4a3e-a3cf-465113003b2f, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:36,849 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 7b6a3398-b92e-4a3e-a3cf-465113003b2f, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/customer`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:36,851 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 7b6a3398-b92e-4a3e-a3cf-465113003b2f, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:36,851 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:38,336 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, a541c663-2d2d-456a-85c7-d76f07f9ab6f, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:38,337 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, a541c663-2d2d-456a-85c7-d76f07f9ab6f, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/nation`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:38,339 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, a541c663-2d2d-456a-85c7-d76f07f9ab6f, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:38,340 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:39,440 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 58147350-d6ef-4ab0-bf71-540972c11389, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:39,441 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 58147350-d6ef-4ab0-bf71-540972c11389, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/orders`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:39,443 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 58147350-d6ef-4ab0-bf71-540972c11389, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:39,444 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:42,766 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, f5fe7153-d2d5-4a72-ad29-cbcb3153e634, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:42,767 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, f5fe7153-d2d5-4a72-ad29-cbcb3153e634, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/part`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:42,769 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, f5fe7153-d2d5-4a72-ad29-cbcb3153e634, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:42,769 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:44,386 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 9a9b75dd-ff35-43c8-be40-304c9397c632, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:44,387 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 9a9b75dd-ff35-43c8-be40-304c9397c632, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/partsupp`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:44,389 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 9a9b75dd-ff35-43c8-be40-304c9397c632, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:44,389 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:46,162 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 57fb43e0-309f-42f8-815b-ce8f1af511d9, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:46,163 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 57fb43e0-309f-42f8-815b-ce8f1af511d9, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/region`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:46,165 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 57fb43e0-309f-42f8-815b-ce8f1af511d9, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:46,166 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:47,280 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 8cc46687-ad88-497f-8edb-7bb2223ab888, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:47,281 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 8cc46687-ad88-497f-8edb-7bb2223ab888, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/supplier`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:47,283 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 8cc46687-ad88-497f-8edb-7bb2223ab888, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:47,284 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:48:48,418 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 1b0a3fce-d3d4-4119-938e-200bbb9f794d, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:48:48,419 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 1b0a3fce-d3d4-4119-938e-200bbb9f794d, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s1/lineitem`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:48:48,421 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 1b0a3fce-d3d4-4119-938e-200bbb9f794d, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:48:48,422 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-10-16 17:49:02,430 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:02,437 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes HTTP/1.1" 200 804
2025-10-16 17:49:02,443 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:02,447 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:49:02,457 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 552
2025-10-16 17:49:03,215 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:03,222 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes HTTP/1.1" 200 804
2025-10-16 17:49:03,228 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:03,231 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:49:03,243 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 546
2025-10-16 17:49:03,245 - INFO - root - __create_iterations_table: All nodes before filtering: [('3694@ghrun-2kszfvc6cm.auto.internal', <Role.UNKNOWN: 0>)]
2025-10-16 17:49:03,246 - INFO - root - __create_iterations_table: Auto-discovered hosts (all roles): 1 hosts from 1 total nodes
2025-10-16 17:49:03,247 - INFO - root - __create_iterations_table: Host to nodes mapping: [('ghrun-2kszfvc6cm.auto.internal', 1)]
2025-10-16 17:49:03,248 - INFO - root - allure_test_description: iterations_table created, length: 514
2025-10-16 17:49:03,248 - INFO - root - allure_test_description: Added iterations table to description HTML
2025-10-16 17:49:03,572 - DEBUG - matplotlib - wrapper: CACHEDIR=/home/runner/.cache/matplotlib
2025-10-16 17:49:03,576 - DEBUG - matplotlib.font_manager - _load_fontmanager: Using fontManager instance from /home/runner/.cache/matplotlib/fontlist-v330.json
2025-10-16 17:49:04,895 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs"
2025-10-16 17:49:04,896 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0021dd/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/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/node_1/logfile_3_f5dhor.log --grpc-port=26008 --mon-port=30455 --ic-port=28892
2025-10-16 17:49:04,896 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:26008/1
2025-10-16 17:49:04,898 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-10-16 17:49:04,899 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-10-16 17:49:04,899 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:49:04,901 - DEBUG - ya.test - execute: Command pid: 1345011
2025-10-16 17:49:05,668 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) rc: 0
2025-10-16 17:49:05,669 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) elapsed time (sec): 0.7667434215545654
2025-10-16 17:49:05,669 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) idrss: 0
2025-10-16 17:49:05,670 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) inblock: 0
2025-10-16 17:49:05,670 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) isrss: 0
2025-10-16 17:49:05,670 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) ixrss: 0
2025-10-16 17:49:05,670 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) majflt: 0
2025-10-16 17:49:05,671 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) maxrss: 753652
2025-10-16 17:49:05,671 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) minflt: 45094
2025-10-16 17:49:05,671 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) msgrcv: 0
2025-10-16 17:49:05,671 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) msgsnd: 0
2025-10-16 17:49:05,672 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) nivcsw: 15
2025-10-16 17:49:05,672 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) nsignals: 0
2025-10-16 17:49:05,672 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) nswap: 0
2025-10-16 17:49:05,673 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) nvcsw: 15
2025-10-16 17:49:05,673 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) oublock: 8
2025-10-16 17:49:05,673 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) stime: 0.189031
2025-10-16 17:49:05,673 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) utime: 0.529095
2025-10-16 17:49:05,674 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) wtime: 0.768
2025-10-16 17:49:05,674 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-10-16 17:49:05,674 - DEBUG - ya.test - _save_outputs: Command (pid 1345011) errors:

2025-10-16 17:49:05,675 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:49:05,675 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/kikimr_configs"
2025-10-16 17:49:05,676 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:26008 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s1/testing_out_stuff/test_s1.py.TestTpchS1.test_tpch.1/cluster/slot_1/logfile_w6m6nbqd.log --grpc-port=23904 --mon-port=25441 --ic-port=3694
2025-10-16 17:49:05,676 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:23904/1
2025-10-16 17:49:05,678 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-10-16 17:49:05,679 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-10-16 17:49:05,679 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-10-16 17:49:05,681 - DEBUG - ya.test - execute: Command pid: 1345165
2025-10-16 17:49:06,506 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) rc: 0
2025-10-16 17:49:06,507 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) elapsed time (sec): 0.8247425556182861
2025-10-16 17:49:06,507 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) idrss: 0
2025-10-16 17:49:06,508 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) inblock: 0
2025-10-16 17:49:06,508 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) isrss: 0
2025-10-16 17:49:06,508 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) ixrss: 0
2025-10-16 17:49:06,508 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) majflt: 0
2025-10-16 17:49:06,509 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) maxrss: 753652
2025-10-16 17:49:06,509 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) minflt: 45144
2025-10-16 17:49:06,509 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) msgrcv: 0
2025-10-16 17:49:06,510 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) msgsnd: 0
2025-10-16 17:49:06,510 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) nivcsw: 77
2025-10-16 17:49:06,510 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) nsignals: 0
2025-10-16 17:49:06,510 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) nswap: 0
2025-10-16 17:49:06,510 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) nvcsw: 13
2025-10-16 17:49:06,512 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) oublock: 8
2025-10-16 17:49:06,512 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) stime: 0.227688
2025-10-16 17:49:06,512 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) utime: 0.5451579999999999
2025-10-16 17:49:06,512 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) wtime: 0.827
2025-10-16 17:49:06,513 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) output:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-2kszfvc6cm
    Host information: 
        Linux ghrun-2kszfvc6cm 5.15.0-157-generic #167-Ubuntu SMP Wed Sep 17 21:35:53 UTC 2025 x86_64

    
Build info:
    Compiler: /home/runner/.ya/tools/v4/9944335923/bin/clang++
    Compiler version: 
        clang version 20.1.8
        Target: x86_64-unknown-linux-gnu
        Thread model: posix
        InstalledDir: /home/runner/.ya/tools/v4/9944335923/bin
    Compile flags: -Xclang -fdebug-compilation-dir -Xclang /tmp -pipe -m64 -O3 -gline-tables-only -fno-common -ffunction-sections -fdata-sections -fsized-deallocation -fexceptions -fuse-init-array -fcolor-diagnostics -faligned-allocation -Werror -Wall -Wextra -Wno-parentheses -Wno-implicit-const-int-float-conversion -Wno-unknown-warning-option -D_THREAD_SAFE -D_PTHREADS -D_REENTRANT -D_LARGEFILE_SOURCE -D__STDC_CONSTANT_MACROS -D__STDC_FORMAT_MACROS -D_FILE_OFFSET_BITS=64 -D_GNU_SOURCE -D_YNDX_LIBUNWIND_ENABLE_EXCEPTION_BACKTRACE -D__LONG_LONG_SUPPORTED -fno-omit-frame-pointer -Wno-unknown-argument -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -DCATBOOST_OPENSOURCE=yes -fsanitize=address -Daddress_sanitizer_enabled -fno-omit-frame-pointer -fsanitize-blacklist=/home/runner/actions_runner/_work/ydb/ydb/build/sanitize-blacklist.txt -fno-sanitize-link-runtime -msse2 -msse3 -mssse3 -msse4.1 -msse4.2 -mpopcnt -mcx16 -DNDEBUG -Wno-array-parameter -Wno-deprecate-lax-vec-conv-all -Wno-unqualified-std-cast-call -Wno-unused-but-set-parameter -Wno-implicit-function-declaration -Wno-int-conversion -Wno-incompatible-function-pointer-types -Wno-address-of-packed-member -Wno-deprecated-this-capture -Wno-missing-designated-field-initializers -Wno-format -Wno-vla-cxx-extension -Wno-invalid-offsetof -Wno-alias-template-in-declaration-name -Wno-cast-function-type-mismatch -Wno-explicit-specialization-storage-class -Wno-extraneous-template-head -Wno-missing-template-arg-list-after-template-kw -Wno-nontrivial-memcall -Wno-strict-primary-template-shadow -std=c++20 -Wimport-preprocessor-directive-pedantic -Woverloaded-virtual -Wno-ambiguous-reversed-operator -Wno-defaulted-function-deleted -Wno-deprecated-anon-enum-enum-conversion -Wno-deprecated-enum-enum-conversion -Wno-deprecated-enum-float-conversion -Wno-deprecated-volatile -Wno-pessimizing-move -Wno-undefined-var-template -nostdinc++ -DCATBOOST_OPENSOURCE=yes -nostdinc++

2025-10-16 17:49:06,513 - DEBUG - ya.test - _save_outputs: Command (pid 1345165) errors:

2025-10-16 17:49:06,514 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: d615d0ffd6e2f23c896ca96121aca842413fb672
    Branch: 
    Author: Andrey Zaspa <zacpa@ya.ru>
    Summary: Merge 2f4fc663ace566d7ea72dd9c85ebd0092851e7e4 into 6819ac59eb1f43dd80b94010061f13b3ff17d91a
2025-10-16 17:49:06,526 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_s1.py::TestTpchS1, test_name: test_tpch[1])
2025-10-16 17:49:06,531 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,535 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:49:06,546 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 550
2025-10-16 17:49:06,554 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,559 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:49:06,572 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 550
2025-10-16 17:49:06,575 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-10-16 17:49:06,575 - INFO - root - get_tables: get_tables /local/test_db/olap_yatests/tpch/s1
2025-10-16 17:49:06,575 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/tpch/s1
2025-10-16 17:49:06,576 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 4f54f2ea-caf5-44eb-9d1a-7df40a7c1ac3, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:49:06,577 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 4f54f2ea-caf5-44eb-9d1a-7df40a7c1ac3, ghrun-2kszfvc6cm.auto.internal:23904): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s1" }
2025-10-16 17:49:06,584 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 4f54f2ea-caf5-44eb-9d1a-7df40a7c1ac3, ghrun-2kszfvc6cm.auto.internal:23904): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "s1" owner: "root@builtin" type: DIRECTORY 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: 1760636703640 tx_id: 281474976720659 } } } } } }
2025-10-16 17:49:06,585 - INFO - root - list_directory: list /local/test_db/olap_yatests/tpch/s1
2025-10-16 17:49:06,586 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, fe58871e-bda5-47e6-bfda-c57378aa7903, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:49:06,586 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, fe58871e-bda5-47e6-bfda-c57378aa7903, ghrun-2kszfvc6cm.auto.internal:23904): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s1" }
2025-10-16 17:49:06,595 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, fe58871e-bda5-47e6-bfda-c57378aa7903, ghrun-2kszfvc6cm.auto.internal:23904): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "s1" owner: "root@builtin" type: DIRECTORY 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: 1760636703640 tx_id: 281474976720659 } } children { name: "customer" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636703640 tx_id: 281474976720659 } } children { name: "lineitem" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636705540 tx_id: 281474976720660 } } children { name: "nation" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636705790 tx_id: 281474976720661 } } children { name: "orders" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636707430 tx_id: 281474976720662 } } children { name: "part" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636709250 tx_id: 281474976720663 } } children { name: "partsupp" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636710990 tx_id: 281474976720664 } } children { name: "region" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636711290 tx_id: 281474976720665 } } children { name: "supplier" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1760636712890 tx_id: 281474976720666 } } } } } }
2025-10-16 17:49:06,599 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,603 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/customer&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,615 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/customer&tablets=true HTTP/1.1" 200 585
2025-10-16 17:49:06,618 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/customer balance: 64-64 shards.
2025-10-16 17:49:06,622 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,625 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/lineitem&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,640 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/lineitem&tablets=true HTTP/1.1" 200 585
2025-10-16 17:49:06,642 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/lineitem balance: 64-64 shards.
2025-10-16 17:49:06,646 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,649 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/nation&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,664 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/nation&tablets=true HTTP/1.1" 200 583
2025-10-16 17:49:06,666 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/nation balance: 1-1 shards.
2025-10-16 17:49:06,670 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,673 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/orders&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,685 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/orders&tablets=true HTTP/1.1" 200 585
2025-10-16 17:49:06,688 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/orders balance: 64-64 shards.
2025-10-16 17:49:06,691 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,695 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/part&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,710 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/part&tablets=true HTTP/1.1" 200 585
2025-10-16 17:49:06,713 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/part balance: 64-64 shards.
2025-10-16 17:49:06,717 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,721 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/partsupp&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,734 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/partsupp&tablets=true HTTP/1.1" 200 585
2025-10-16 17:49:06,737 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/partsupp balance: 64-64 shards.
2025-10-16 17:49:06,740 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,746 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/region&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,759 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/region&tablets=true HTTP/1.1" 200 583
2025-10-16 17:49:06,761 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/region balance: 1-1 shards.
2025-10-16 17:49:06,764 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:06,768 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/supplier&tablets=true HTTP/1.1" 307 0
2025-10-16 17:49:06,781 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s1/supplier&tablets=true HTTP/1.1" 200 585
2025-10-16 17:49:06,784 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s1/supplier balance: 64-64 shards.
2025-10-16 17:49:06,785 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 4181bad4-eca6-419a-afdf-88ba82262922, ghrun-2kszfvc6cm.auto.internal:23904): creating call state
2025-10-16 17:49:06,786 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 4181bad4-eca6-419a-afdf-88ba82262922, ghrun-2kszfvc6cm.auto.internal:23904): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-10-16 17:49:06,788 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 4181bad4-eca6-419a-afdf-88ba82262922, ghrun-2kszfvc6cm.auto.internal:23904): response = { <_MultiThreadedRendezvous object> }
2025-10-16 17:49:06,886 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydb/ydb
2025-10-16 17:49:06,888 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-10-16 17:49:06,889 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-10-16 17:49:06,889 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/b9t0/0021dd/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:26008', '-d', '/local/test_db', 'workload', 'tpch', '--path', 'olap_yatests/tpch/s1', 'run', '--json', 'Query01.stats.json', '--output', 'Query01.result', '--include', 'Query01', '--iterations', '1', '--plan', 'Query01.plan', '--global-timeout', '1800.0s', '--verbose', '--check-canonical', '--scale', '1']' in 'None' (waiting)
2025-10-16 17:49:06,891 - DEBUG - ya.test - execute: Command pid: 1345333
2025-10-16 17:49:38,617 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) rc: 0
2025-10-16 17:49:38,618 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) elapsed time (sec): 31.72445511817932
2025-10-16 17:49:38,618 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) idrss: 0
2025-10-16 17:49:38,618 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) inblock: 0
2025-10-16 17:49:38,619 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) isrss: 0
2025-10-16 17:49:38,619 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) ixrss: 0
2025-10-16 17:49:38,619 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) majflt: 0
2025-10-16 17:49:38,619 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) maxrss: 757064
2025-10-16 17:49:38,619 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) minflt: 119105
2025-10-16 17:49:38,620 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) msgrcv: 0
2025-10-16 17:49:38,620 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) msgsnd: 0
2025-10-16 17:49:38,620 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) nivcsw: 132
2025-10-16 17:49:38,625 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) nsignals: 0
2025-10-16 17:49:38,625 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) nswap: 0
2025-10-16 17:49:38,626 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) nvcsw: 5298
2025-10-16 17:49:38,626 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) oublock: 3128
2025-10-16 17:49:38,626 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) stime: 0.38665499999999997
2025-10-16 17:49:38,626 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) utime: 0.824066
2025-10-16 17:49:38,627 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) wtime: 31.726
2025-10-16 17:49:38,627 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) output:
Query01:
Query text:
$z1_12 = 1;
select
    l_returnflag,
    l_linestatus,
    sum(l_quantity) as sum_qty,
    sum(l_extendedprice) as sum_base_price,
    sum(l_extendedprice * ($z1_12 - l_discount)) as sum_disc_price,
    sum(l_extendedprice * ($z1_12 - l_discount) * ($z1_12 + l_tax)) as sum_charge,
    avg(l_quantity) as avg_qty,
    avg(l_extendedprice) as avg_price,
    avg(l_discount) as avg_disc,
    count(*) as count_order
from
    `olap_yatests/tpch/s1/lineitem`
where
    l_shipdate <= Date('1998-12-01') - Interval("P90D")
group by
    l_returnflag,
    l_linestatus
order by
    l_returnflag,
    l_linestatus;

	iteration 0:	ok	28.694326s seconds

Results for 1 iterations
┌─────────┬──────────┬─────────┬─────────┬─────────┬─────────┬───────────┬─────────┬─────────┬─────────┬─────────┬────────────────┬────────────────┬────────────────┬───────────┬──────────────┬────────────┬────────────┐
│ Query # │ ColdTime │ Min     │ Max     │ Mean    │ Median  │ UnixBench │ Std     │ RttMin  │ RttMax  │ RttAvg  │ CompilationMin │ CompilationMax │ CompilationAvg │ GrossTime │ SuccessCount │ FailsCount │ DiffsCount │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query01 │  28.473  │  28.473 │  28.473 │  28.473 │  28.472 │  28.473   │   0.001 │   0.221 │   0.221 │   0.221 │   1.684        │   1.684        │   1.684        │  28.694   │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Sum     │  28.473  │  28.473 │  28.473 │  28.473 │  28.472 │  28.473   │   0.000 │   0.221 │   0.221 │   0.221 │   1.684        │   1.684        │   1.685        │  30.738   │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Avg     │  28.473  │  28.473 │  28.473 │  28.473 │  28.472 │  28.473   │   0.000 │   0.221 │   0.221 │   0.221 │   1.684        │   1.684        │   1.685        │  30.738   │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ GAvg    │  28.473  │  28.473 │  28.473 │  28.473 │  28.472 │  28.473   │   0.000 │   0.221 │   0.221 │   0.001 │   1.684        │   1.684        │   0.001        │   0.000   │ 1            │            │            │
└─────────┴──────────┴─────────┴─────────┴─────────┴─────────┴───────────┴─────────┴─────────┴─────────┴─────────┴────────────────┴────────────────┴────────────────┴───────────┴──────────────┴────────────┴────────────┘

Results saved to Query01.result
Json report saved to Query01.stats.json

2025-10-16 17:49:38,627 - DEBUG - ya.test - _save_outputs: Command (pid 1345333) errors:

[K
[K
2025-10-16 17:49:38,628 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-10-16 17:49:38,723 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:38,748 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:49:38,760 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 549
2025-10-16 17:49:38,767 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:38,783 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes HTTP/1.1" 200 806
2025-10-16 17:49:38,790 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:30455
2025-10-16 17:49:38,794 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-10-16 17:49:38,807 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:30455 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 548
2025-10-16 17:49:38,812 - INFO - root - __create_iterations_table: All nodes before filtering: [('3694@ghrun-2kszfvc6cm.auto.internal', <Role.UNKNOWN: 0>)]
2025-10-16 17:49:38,813 - INFO - root - __create_iterations_table: Auto-discovered hosts (all roles): 1 hosts from 1 total nodes
2025-10-16 17:49:38,814 - INFO - root - __create_iterations_table: Host to nodes mapping: [('ghrun-2kszfvc6cm.auto.internal', 1)]
2025-10-16 17:49:38,814 - INFO - root - allure_test_description: iterations_table created, length: 514
2025-10-16 17:49:38,815 - INFO - root - allure_test_description: Added iterations table to description HTML
2025-10-16 17:49:38,841 - INFO - ya.test - pytest_runtest_teardown: Test teardown
