2025-11-01 17:23:44,130 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 17:23:44,131 - INFO - ya.test - pytest_runtest_setup: test_tpch[1]
2025-11-01 17:23:44,131 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-01 17:23:44,132 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-01 17:23:44,261 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd
2025-11-01 17:23:44,262 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22446
2025-11-01 17:23:44,263 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/ewjv/000e0b/r3tmp/kikimr_cluster_z7hy13md
2025-11-01 17:23:44,307 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd
2025-11-01 17:23:44,308 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9388
2025-11-01 17:23:44,309 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/17000
2025-11-01 17:23:44,309 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12155
2025-11-01 17:23:44,310 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/12504
2025-11-01 17:23:44,311 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs"
2025-11-01 17:23:44,311 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/ewjv/000e0b/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/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/node_1/logfile_r3ok1qk2.log --grpc-port=9388 --mon-port=17000 --ic-port=22446
2025-11-01 17:23:44,312 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:9388/1, disk_size 68719476736
2025-11-01 17:23:44,312 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs"
2025-11-01 17:23:44,313 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/ewjv/000e0b/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/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/node_1/logfile_r3ok1qk2.log --grpc-port=9388 --mon-port=17000 --ic-port=22446
2025-11-01 17:23:44,314 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/node_1/logfile_r3ok1qk2.log', '--grpc-port=9388', '--mon-port=17000', '--ic-port=22446')' in '/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/node_1' (no wait)
2025-11-01 17:23:44,323 - DEBUG - ya.test - execute: Command pid: 1423815
2025-11-01 17:23:44,324 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:9388/1
2025-11-01 17:23:44,328 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.47
2025-11-01 17:23:44,334 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.47
2025-11-01 17:23:44,355 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 17:23:44,363 - DEBUG - ya.test - execute: Command pid: 1423831
2025-11-01 17:23:45,287 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) rc: 0
2025-11-01 17:23:45,288 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) elapsed time (sec): 0.915015697479248
2025-11-01 17:23:45,289 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) idrss: 0
2025-11-01 17:23:45,289 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) inblock: 0
2025-11-01 17:23:45,290 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) isrss: 0
2025-11-01 17:23:45,290 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) ixrss: 0
2025-11-01 17:23:45,291 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) majflt: 0
2025-11-01 17:23:45,291 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) maxrss: 777688
2025-11-01 17:23:45,292 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) minflt: 45373
2025-11-01 17:23:45,292 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) msgrcv: 0
2025-11-01 17:23:45,292 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) msgsnd: 0
2025-11-01 17:23:45,293 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) nivcsw: 135
2025-11-01 17:23:45,293 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) nsignals: 0
2025-11-01 17:23:45,293 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) nswap: 0
2025-11-01 17:23:45,294 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) nvcsw: 14
2025-11-01 17:23:45,294 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) oublock: 8
2025-11-01 17:23:45,294 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) stime: 0.201531
2025-11-01 17:23:45,296 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) utime: 0.48439499999999996
2025-11-01 17:23:45,297 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) wtime: 0.931
2025-11-01 17:23:45,297 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-jzwpcuvpwq
    Host information: 
        Linux ghrun-jzwpcuvpwq 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-11-01 17:23:45,298 - DEBUG - ya.test - _save_outputs: Command (pid 1423831) errors:

2025-11-01 17:23:45,298 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 17:23:52,791 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd
2025-11-01 17:23:52,792 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9388', '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: 22446\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-01 17:23:52,827 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.48
2025-11-01 17:23:52,829 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.48
2025-11-01 17:23:52,830 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9388', '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: 22446\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 17:23:52,847 - DEBUG - ya.test - execute: Command pid: 1426567
2025-11-01 17:23:54,031 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) rc: 0
2025-11-01 17:23:54,032 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) elapsed time (sec): 1.1830601692199707
2025-11-01 17:23:54,032 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) idrss: 0
2025-11-01 17:23:54,033 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) inblock: 0
2025-11-01 17:23:54,033 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) isrss: 0
2025-11-01 17:23:54,033 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) ixrss: 0
2025-11-01 17:23:54,033 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) majflt: 0
2025-11-01 17:23:54,034 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) maxrss: 831916
2025-11-01 17:23:54,034 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) minflt: 51704
2025-11-01 17:23:54,034 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) msgrcv: 0
2025-11-01 17:23:54,034 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) msgsnd: 0
2025-11-01 17:23:54,034 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) nivcsw: 220
2025-11-01 17:23:54,035 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) nsignals: 0
2025-11-01 17:23:54,037 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) nswap: 0
2025-11-01 17:23:54,037 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) nvcsw: 763
2025-11-01 17:23:54,038 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) oublock: 8
2025-11-01 17:23:54,038 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) stime: 0.250083
2025-11-01 17:23:54,038 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) utime: 0.5100239999999999
2025-11-01 17:23:54,038 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) wtime: 1.198
2025-11-01 17:23:54,039 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-01 17:23:54,039 - DEBUG - ya.test - _save_outputs: Command (pid 1426567) errors:

2025-11-01 17:23:54,040 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd
2025-11-01 17:23:54,041 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9388', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']
2025-11-01 17:23:54,048 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.49
2025-11-01 17:23:54,055 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.49
2025-11-01 17:23:54,056 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:9388', 'admin', 'blobstorage', 'config', 'invoke', '--proto=Command {\n  DefineStoragePool {\n    BoxId: 1\n    StoragePoolId: 1\n    Name: "dynamic_storage_pool:1"\n    ErasureSpecies: "none"\n    VDiskKind: "Default"\n    Kind: "hdd"\n    NumGroups: 2\n    PDiskFilter {\n      Property {\n        Type: ROT\n      }\n      Property {\n        Kind: 0\n      }\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-01 17:23:54,074 - DEBUG - ya.test - execute: Command pid: 1427046
2025-11-01 17:23:55,148 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) rc: 0
2025-11-01 17:23:55,148 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) elapsed time (sec): 1.0723040103912354
2025-11-01 17:23:55,148 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) idrss: 0
2025-11-01 17:23:55,149 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) inblock: 0
2025-11-01 17:23:55,149 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) isrss: 0
2025-11-01 17:23:55,149 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) ixrss: 0
2025-11-01 17:23:55,149 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) majflt: 0
2025-11-01 17:23:55,150 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) maxrss: 831916
2025-11-01 17:23:55,150 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) minflt: 51798
2025-11-01 17:23:55,150 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) msgrcv: 0
2025-11-01 17:23:55,151 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) msgsnd: 0
2025-11-01 17:23:55,152 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) nivcsw: 205
2025-11-01 17:23:55,152 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) nsignals: 0
2025-11-01 17:23:55,152 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) nswap: 0
2025-11-01 17:23:55,157 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) nvcsw: 495
2025-11-01 17:23:55,157 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) oublock: 8
2025-11-01 17:23:55,158 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) stime: 0.29409799999999997
2025-11-01 17:23:55,158 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) utime: 0.492278
2025-11-01 17:23:55,158 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) wtime: 1.091
2025-11-01 17:23:55,158 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-01 17:23:55,159 - DEBUG - ya.test - _save_outputs: Command (pid 1427046) errors:

2025-11-01 17:23:55,159 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain local: {'dynamic_storage_pool:1': 'hdd'}
2025-11-01 17:23:55,203 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-01 17:23:55,824 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd
2025-11-01 17:23:55,825 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20466
2025-11-01 17:23:55,828 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/5309
2025-11-01 17:23:55,829 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/21270
2025-11-01 17:23:55,829 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/18424
2025-11-01 17:23:55,830 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/9192
2025-11-01 17:23:55,831 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs"
2025-11-01 17:23:55,831 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:9388 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/slot_1/logfile_ao6jxhnc.log --grpc-port=20466 --mon-port=5309 --ic-port=21270
2025-11-01 17:23:55,832 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs"
2025-11-01 17:23:55,832 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:9388 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/slot_1/logfile_ao6jxhnc.log --grpc-port=20466 --mon-port=5309 --ic-port=21270
2025-11-01 17:23:55,833 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:9388', '--tenant=/local/test_db', '--log-file-name=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/slot_1/logfile_ao6jxhnc.log', '--grpc-port=20466', '--mon-port=5309', '--ic-port=21270')' in '/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/slot_1' (no wait)
2025-11-01 17:23:55,842 - DEBUG - ya.test - execute: Command pid: 1427760
2025-11-01 17:23:55,843 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:20466/1
2025-11-01 17:23:55,846 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.50
2025-11-01 17:23:55,854 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.50
2025-11-01 17:23:55,855 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 17:23:55,857 - DEBUG - ya.test - execute: Command pid: 1427778
2025-11-01 17:23:56,724 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) rc: 0
2025-11-01 17:23:56,724 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) elapsed time (sec): 0.8657102584838867
2025-11-01 17:23:56,725 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) idrss: 0
2025-11-01 17:23:56,725 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) inblock: 0
2025-11-01 17:23:56,725 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) isrss: 0
2025-11-01 17:23:56,726 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) ixrss: 0
2025-11-01 17:23:56,726 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) majflt: 0
2025-11-01 17:23:56,726 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) maxrss: 831916
2025-11-01 17:23:56,726 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) minflt: 45422
2025-11-01 17:23:56,727 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) msgrcv: 0
2025-11-01 17:23:56,727 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) msgsnd: 0
2025-11-01 17:23:56,727 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) nivcsw: 176
2025-11-01 17:23:56,727 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) nsignals: 0
2025-11-01 17:23:56,728 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) nswap: 0
2025-11-01 17:23:56,728 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) nvcsw: 14
2025-11-01 17:23:56,728 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) oublock: 8
2025-11-01 17:23:56,728 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) stime: 0.219211
2025-11-01 17:23:56,728 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) utime: 0.450963
2025-11-01 17:23:56,729 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) wtime: 0.868
2025-11-01 17:23:56,729 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-jzwpcuvpwq
    Host information: 
        Linux ghrun-jzwpcuvpwq 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-11-01 17:23:56,729 - DEBUG - ya.test - _save_outputs: Command (pid 1427778) errors:

2025-11-01 17:23:56,730 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 17:24:02,765 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydb/ydb
2025-11-01 17:24:02,772 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.23
2025-11-01 17:24:02,774 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.23
2025-11-01 17:24:02,781 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:9388', '-d', '/local/test_db', 'workload', 'tpch', '-p', 'olap_yatests/tpch/s0_2', 'init', '--store=column', '--datetime-types=dt64']' in 'None' (waiting)
2025-11-01 17:24:02,811 - DEBUG - ya.test - execute: Command pid: 1431094
2025-11-01 17:24:25,628 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) rc: 0
2025-11-01 17:24:25,628 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) elapsed time (sec): 22.808600902557373
2025-11-01 17:24:25,628 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) idrss: 0
2025-11-01 17:24:25,629 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) inblock: 0
2025-11-01 17:24:25,629 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) isrss: 0
2025-11-01 17:24:25,629 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) ixrss: 0
2025-11-01 17:24:25,629 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) majflt: 0
2025-11-01 17:24:25,630 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) maxrss: 831916
2025-11-01 17:24:25,630 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) minflt: 116503
2025-11-01 17:24:25,630 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) msgrcv: 0
2025-11-01 17:24:25,630 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) msgsnd: 0
2025-11-01 17:24:25,630 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) nivcsw: 284
2025-11-01 17:24:25,631 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) nsignals: 0
2025-11-01 17:24:25,643 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) nswap: 0
2025-11-01 17:24:25,644 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) nvcsw: 7139
2025-11-01 17:24:25,644 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) oublock: 8
2025-11-01 17:24:25,644 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) stime: 0.372867
2025-11-01 17:24:25,644 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) utime: 0.449708
2025-11-01 17:24:25,645 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) wtime: 22.829
2025-11-01 17:24:25,645 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) output:
Init tables ...
Init tables ...Ok

2025-11-01 17:24:25,645 - DEBUG - ya.test - _save_outputs: Command (pid 1431094) errors:

2025-11-01 17:24:25,651 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydb/ydb
2025-11-01 17:24:25,653 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.24
2025-11-01 17:24:25,663 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.24
2025-11-01 17:24:25,664 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:9388', '-d', '/local/test_db', 'workload', 'tpch', '-p', 'olap_yatests/tpch/s0_2', 'import', 'generator', '--scale=0.2']' in 'None' (waiting)
2025-11-01 17:24:25,680 - DEBUG - ya.test - execute: Command pid: 1441750
2025-11-01 17:25:14,634 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 17:25:14,635 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 17:25:14,660 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-01 17:25:14,663 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 7b343cba-3e4e-4180-840b-5f967f370807, localhost:9636): creating call state
2025-11-01 17:25:14,664 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 7b343cba-3e4e-4180-840b-5f967f370807, localhost:9636): request = { database: "local/test_db" }
2025-11-01 17:25:14,691 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 7b343cba-3e4e-4180-840b-5f967f370807, localhost:9636): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-jzwpcuvpwq.auto.internal" port: 9387 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50000 } self_location: "1" } } } }
2025-11-01 17:25:14,692 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-jzwpcuvpwq.auto.internal:9387, location , ssl: False>]>
2025-11-01 17:25:14,692 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:9636
2025-11-01 17:25:53,086 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) rc: 0
2025-11-01 17:25:53,086 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) elapsed time (sec): 87.40426993370056
2025-11-01 17:25:53,087 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) idrss: 0
2025-11-01 17:25:53,092 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) inblock: 0
2025-11-01 17:25:53,098 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) isrss: 0
2025-11-01 17:25:53,099 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) ixrss: 0
2025-11-01 17:25:53,099 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) majflt: 0
2025-11-01 17:25:53,100 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) maxrss: 1365240
2025-11-01 17:25:53,105 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) minflt: 1243709
2025-11-01 17:25:53,106 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) msgrcv: 0
2025-11-01 17:25:53,108 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) msgsnd: 0
2025-11-01 17:25:53,109 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) nivcsw: 10494
2025-11-01 17:25:53,110 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) nsignals: 0
2025-11-01 17:25:53,111 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) nswap: 0
2025-11-01 17:25:53,111 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) nvcsw: 191495
2025-11-01 17:25:53,112 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) oublock: 32
2025-11-01 17:25:53,113 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) stime: 7.590701
2025-11-01 17:25:53,114 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) utime: 45.892775
2025-11-01 17:25:53,115 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) wtime: 87.421
2025-11-01 17:25:53,115 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) output:
Fill table supplier...
Fill table supplier OK 2000 / 2000 (14.534352s)
Fill table customer...
Fill table customer OK 30000 / 30000 (1.481920s)
Fill table orders...
Fill table orders OK 300000 / 300000 (60.619497s)
Fill table part...
Fill table part OK 40000 / 40000 (7.587624s)
Fill table nation...
Fill table nation OK 25 / 25 (0.631560s)
Fill table region...
Fill table region OK 5 / 5 (0.545854s)

2025-11-01 17:25:53,116 - DEBUG - ya.test - _save_outputs: Command (pid 1441750) errors:







2025-11-01 17:25:53,117 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-11-01 17:25:53,125 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,132 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:25:53,153 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 555
2025-11-01 17:25:53,161 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-11-01 17:25:53,162 - INFO - root - _create_ydb_driver: Connecting to grpc://localhost:9388 to local/test_db ydb_access_token is set False
2025-11-01 17:25:53,165 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 17:25:53,179 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-01 17:25:53,180 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 17:25:53,211 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-01 17:25:53,220 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, 364578cf-456f-4440-ac9d-5a9e4d37f251, localhost:9388): creating call state
2025-11-01 17:25:53,229 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, 364578cf-456f-4440-ac9d-5a9e4d37f251, localhost:9388): request = { database: "local/test_db" }
2025-11-01 17:25:53,240 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, 364578cf-456f-4440-ac9d-5a9e4d37f251, localhost:9388): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-jzwpcuvpwq.auto.internal" port: 20466 service: "legacy" service: "tablet_service" service: "yql" service: "discovery" service: "cms" service: "locking" service: "kesus" service: "pq" service: "pqcd" service: "pqv1" service: "topic" service: "datastreams" service: "scripting" service: "clickhouse_internal" service: "rate_limiter" service: "analytics" service: "export" service: "import" service: "yq" service: "keyvalue" service: "monitoring" service: "auth" service: "query_service" service: "view" node_id: 50000 } self_location: "1" } } } }
2025-11-01 17:25:53,241 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-jzwpcuvpwq.auto.internal:20466, location , ssl: False>]>
2025-11-01 17:25:53,244 - DEBUG - ydb.connection - channel_factory: Channel options: [('grpc.max_receive_message_length', 64000000), ('grpc.max_send_message_length', 64000000), ('grpc.primary_user_agent', 'python-library'), ('grpc.lb_policy_name', 'round_robin'), ('grpc.keepalive_time_ms', 1250), ('grpc.keepalive_timeout_ms', 10000), ('grpc.http2.max_pings_without_data', 0), ('grpc.keepalive_permit_without_calls', 0)]
2025-11-01 17:25:53,293 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:9388
2025-11-01 17:25:53,294 - INFO - root - _create_ydb_driver: Connected
2025-11-01 17:25:53,297 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 1de31c57-531f-4188-a32a-d332ac75e772, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:53,298 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 1de31c57-531f-4188-a32a-d332ac75e772, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:25:53,301 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 1de31c57-531f-4188-a32a-d332ac75e772, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:25:53,461 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,474 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:25:53,490 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 553
2025-11-01 17:25:53,493 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-11-01 17:25:53,495 - INFO - root - get_tables: get_tables /local/test_db/olap_yatests/tpch/s0_2
2025-11-01 17:25:53,496 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/tpch/s0_2
2025-11-01 17:25:53,497 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, ecc9b302-0205-4c99-9341-716299f3783b, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:53,498 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, ecc9b302-0205-4c99-9341-716299f3783b, ghrun-jzwpcuvpwq.auto.internal:20466): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_2" }
2025-11-01 17:25:53,507 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, ecc9b302-0205-4c99-9341-716299f3783b, ghrun-jzwpcuvpwq.auto.internal:20466): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "s0_2" 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: 1762017848040 tx_id: 281474976720659 } } } } } }
2025-11-01 17:25:53,508 - INFO - root - list_directory: list /local/test_db/olap_yatests/tpch/s0_2
2025-11-01 17:25:53,509 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 8d4b4777-3964-49b0-bec1-7e82655548bd, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:53,510 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 8d4b4777-3964-49b0-bec1-7e82655548bd, ghrun-jzwpcuvpwq.auto.internal:20466): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_2" }
2025-11-01 17:25:53,518 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 8d4b4777-3964-49b0-bec1-7e82655548bd, ghrun-jzwpcuvpwq.auto.internal:20466): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "s0_2" 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: 1762017848040 tx_id: 281474976720659 } } children { name: "customer" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017848040 tx_id: 281474976720659 } } children { name: "lineitem" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017850830 tx_id: 281474976720660 } } children { name: "nation" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017851330 tx_id: 281474976720661 } } children { name: "orders" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017854490 tx_id: 281474976720662 } } children { name: "part" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017858150 tx_id: 281474976720663 } } children { name: "partsupp" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017861360 tx_id: 281474976720664 } } children { name: "region" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017862000 tx_id: 281474976720665 } } children { name: "supplier" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017864810 tx_id: 281474976720666 } } } } } }
2025-11-01 17:25:53,524 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,528 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/customer&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,550 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/customer&tablets=true HTTP/1.1" 200 581
2025-11-01 17:25:53,553 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/customer balance: 64-64 shards.
2025-11-01 17:25:53,564 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,569 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/lineitem&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,587 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/lineitem&tablets=true HTTP/1.1" 200 581
2025-11-01 17:25:53,599 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/lineitem balance: 64-64 shards.
2025-11-01 17:25:53,613 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,625 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/nation&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,653 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/nation&tablets=true HTTP/1.1" 200 580
2025-11-01 17:25:53,679 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/nation balance: 1-1 shards.
2025-11-01 17:25:53,704 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,710 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/orders&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,738 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/orders&tablets=true HTTP/1.1" 200 581
2025-11-01 17:25:53,741 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/orders balance: 64-64 shards.
2025-11-01 17:25:53,745 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,756 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/part&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,769 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/part&tablets=true HTTP/1.1" 200 581
2025-11-01 17:25:53,772 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/part balance: 64-64 shards.
2025-11-01 17:25:53,776 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,786 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/partsupp&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,807 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/partsupp&tablets=true HTTP/1.1" 200 582
2025-11-01 17:25:53,814 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/partsupp balance: 64-64 shards.
2025-11-01 17:25:53,830 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,839 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/region&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,859 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/region&tablets=true HTTP/1.1" 200 581
2025-11-01 17:25:53,866 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/region balance: 1-1 shards.
2025-11-01 17:25:53,879 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:25:53,885 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/supplier&tablets=true HTTP/1.1" 307 0
2025-11-01 17:25:53,907 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/supplier&tablets=true HTTP/1.1" 200 582
2025-11-01 17:25:53,917 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/supplier balance: 64-64 shards.
2025-11-01 17:25:53,924 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, dc8355bb-5bc1-4a2f-9e1f-d5982cfd8472, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:53,933 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, dc8355bb-5bc1-4a2f-9e1f-d5982cfd8472, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:25:53,945 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, dc8355bb-5bc1-4a2f-9e1f-d5982cfd8472, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:25:54,009 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 06738457-6085-4e37-9105-8230a549ae3e, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:54,017 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 06738457-6085-4e37-9105-8230a549ae3e, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/customer`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:25:54,025 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 06738457-6085-4e37-9105-8230a549ae3e, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:25:54,026 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:25:56,835 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 997040e7-ec93-4604-a79b-400e7de84b99, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:56,853 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 997040e7-ec93-4604-a79b-400e7de84b99, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/nation`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:25:56,868 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 997040e7-ec93-4604-a79b-400e7de84b99, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:25:56,873 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:25:58,587 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 0031935e-bf86-4285-ba85-a678397c3437, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:25:58,600 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 0031935e-bf86-4285-ba85-a678397c3437, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/orders`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:25:58,624 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 0031935e-bf86-4285-ba85-a678397c3437, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:25:58,639 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:26:00,968 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 6b8150f6-8c24-453a-ab61-6ccacb2aae42, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:00,976 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 6b8150f6-8c24-453a-ab61-6ccacb2aae42, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/part`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:26:00,983 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 6b8150f6-8c24-453a-ab61-6ccacb2aae42, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:26:00,997 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:26:02,917 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 25343400-ea56-4493-86cc-d82574aaf1d8, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:02,920 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 25343400-ea56-4493-86cc-d82574aaf1d8, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/partsupp`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:26:02,923 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 25343400-ea56-4493-86cc-d82574aaf1d8, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:26:02,945 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:26:05,068 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, e4ccc282-6c6a-490f-b738-24fd89013362, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:05,077 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, e4ccc282-6c6a-490f-b738-24fd89013362, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/region`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:26:05,081 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, e4ccc282-6c6a-490f-b738-24fd89013362, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:26:05,087 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:26:07,023 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 600cd3ed-9541-45be-a191-08560fda9c7c, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:07,024 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 600cd3ed-9541-45be-a191-08560fda9c7c, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/supplier`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:26:07,056 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 600cd3ed-9541-45be-a191-08560fda9c7c, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:26:07,114 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:26:09,071 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 58deeb2f-2d07-43cf-97f5-f7e566ec7502, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:09,072 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 58deeb2f-2d07-43cf-97f5-f7e566ec7502, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_2/lineitem`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:26:09,083 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 58deeb2f-2d07-43cf-97f5-f7e566ec7502, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:26:09,092 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-01 17:26:14,601 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:14,630 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes HTTP/1.1" 200 810
2025-11-01 17:26:14,642 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:14,668 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes HTTP/1.1" 200 810
2025-11-01 17:26:14,678 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:14,692 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:26:14,748 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 560
2025-11-01 17:26:14,751 - INFO - root - __create_iterations_table: All nodes before filtering: [('21270@ghrun-jzwpcuvpwq.auto.internal', <Role.UNKNOWN: 0>)]
2025-11-01 17:26:14,763 - INFO - root - __create_iterations_table: Auto-discovered hosts (all roles): 1 hosts from 1 total nodes
2025-11-01 17:26:14,764 - INFO - root - __create_iterations_table: Host to nodes mapping: [('ghrun-jzwpcuvpwq.auto.internal', 1)]
2025-11-01 17:26:14,772 - INFO - root - allure_test_description: iterations_table created, length: 514
2025-11-01 17:26:14,772 - INFO - root - allure_test_description: Added iterations table to description HTML
2025-11-01 17:26:14,809 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs"
2025-11-01 17:26:14,819 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/ewjv/000e0b/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/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/node_1/logfile_r3ok1qk2.log --grpc-port=9388 --mon-port=17000 --ic-port=22446
2025-11-01 17:26:14,823 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:9388/1
2025-11-01 17:26:14,847 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.51
2025-11-01 17:26:14,863 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.51
2025-11-01 17:26:14,864 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 17:26:14,876 - DEBUG - ya.test - execute: Command pid: 1457797
2025-11-01 17:26:16,110 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) rc: 0
2025-11-01 17:26:16,117 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) elapsed time (sec): 1.2331910133361816
2025-11-01 17:26:16,121 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) idrss: 0
2025-11-01 17:26:16,121 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) inblock: 8
2025-11-01 17:26:16,121 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) isrss: 0
2025-11-01 17:26:16,121 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) ixrss: 0
2025-11-01 17:26:16,122 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) majflt: 0
2025-11-01 17:26:16,122 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) maxrss: 831916
2025-11-01 17:26:16,123 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) minflt: 45326
2025-11-01 17:26:16,123 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) msgrcv: 0
2025-11-01 17:26:16,123 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) msgsnd: 0
2025-11-01 17:26:16,150 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) nivcsw: 189
2025-11-01 17:26:16,157 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) nsignals: 0
2025-11-01 17:26:16,199 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) nswap: 0
2025-11-01 17:26:16,199 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) nvcsw: 17
2025-11-01 17:26:16,200 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) oublock: 8
2025-11-01 17:26:16,202 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) stime: 0.242144
2025-11-01 17:26:16,219 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) utime: 0.469501
2025-11-01 17:26:16,220 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) wtime: 1.241
2025-11-01 17:26:16,220 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-jzwpcuvpwq
    Host information: 
        Linux ghrun-jzwpcuvpwq 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-11-01 17:26:16,241 - DEBUG - ya.test - _save_outputs: Command (pid 1457797) errors:

2025-11-01 17:26:16,246 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 17:26:16,247 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/kikimr_configs"
2025-11-01 17:26:16,281 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:9388 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_s_float/testing_out_stuff/test_s_float.py.TestTpchS0_2.test_tpch.1/cluster/slot_1/logfile_ao6jxhnc.log --grpc-port=20466 --mon-port=5309 --ic-port=21270
2025-11-01 17:26:16,289 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:20466/1
2025-11-01 17:26:16,305 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.52
2025-11-01 17:26:16,357 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.52
2025-11-01 17:26:16,368 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-01 17:26:16,392 - DEBUG - ya.test - execute: Command pid: 1457932
2025-11-01 17:26:17,722 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) rc: 0
2025-11-01 17:26:17,724 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) elapsed time (sec): 1.3150784969329834
2025-11-01 17:26:17,734 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) idrss: 0
2025-11-01 17:26:17,734 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) inblock: 0
2025-11-01 17:26:17,735 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) isrss: 0
2025-11-01 17:26:17,735 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) ixrss: 0
2025-11-01 17:26:17,736 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) majflt: 0
2025-11-01 17:26:17,736 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) maxrss: 831916
2025-11-01 17:26:17,736 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) minflt: 45352
2025-11-01 17:26:17,737 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) msgrcv: 0
2025-11-01 17:26:17,738 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) msgsnd: 0
2025-11-01 17:26:17,741 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) nivcsw: 226
2025-11-01 17:26:17,743 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) nsignals: 0
2025-11-01 17:26:17,743 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) nswap: 0
2025-11-01 17:26:17,744 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) nvcsw: 15
2025-11-01 17:26:17,748 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) oublock: 8
2025-11-01 17:26:17,748 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) stime: 0.253853
2025-11-01 17:26:17,753 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) utime: 0.43349499999999996
2025-11-01 17:26:17,774 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) wtime: 1.346
2025-11-01 17:26:17,775 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) output:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-jzwpcuvpwq
    Host information: 
        Linux ghrun-jzwpcuvpwq 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-11-01 17:26:17,778 - DEBUG - ya.test - _save_outputs: Command (pid 1457932) errors:

2025-11-01 17:26:17,795 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 34ddad56c8a7bb530ecf731d374c04f98d3d2aca
    Branch: 
    Author: azevaykin <145343289+azevaykin@users.noreply.github.com>
    Summary: Merge f53a17d638f4ee7a8f08354cd76c33a88c4925c5 into 5dbd26ce2068671edb74bb9f072505a44ea73d1e
2025-11-01 17:26:17,821 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_s_float.py::TestTpchS0_2, test_name: test_tpch[1])
2025-11-01 17:26:17,832 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:17,847 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:26:17,880 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 559
2025-11-01 17:26:17,892 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:17,909 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:26:17,937 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 559
2025-11-01 17:26:17,947 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-11-01 17:26:17,947 - INFO - root - get_tables: get_tables /local/test_db/olap_yatests/tpch/s0_2
2025-11-01 17:26:17,948 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/tpch/s0_2
2025-11-01 17:26:17,976 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 7c567536-3e27-4c8a-b840-5e30f7fb58f4, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:17,976 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 7c567536-3e27-4c8a-b840-5e30f7fb58f4, ghrun-jzwpcuvpwq.auto.internal:20466): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_2" }
2025-11-01 17:26:18,071 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 7c567536-3e27-4c8a-b840-5e30f7fb58f4, ghrun-jzwpcuvpwq.auto.internal:20466): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "s0_2" 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: 1762017848040 tx_id: 281474976720659 } } } } } }
2025-11-01 17:26:18,072 - INFO - root - list_directory: list /local/test_db/olap_yatests/tpch/s0_2
2025-11-01 17:26:18,073 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 50ef8a1c-d819-446c-b43c-731f835ab422, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:18,101 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 50ef8a1c-d819-446c-b43c-731f835ab422, ghrun-jzwpcuvpwq.auto.internal:20466): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_2" }
2025-11-01 17:26:18,147 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 50ef8a1c-d819-446c-b43c-731f835ab422, ghrun-jzwpcuvpwq.auto.internal:20466): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "s0_2" 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: 1762017848040 tx_id: 281474976720659 } } children { name: "customer" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017848040 tx_id: 281474976720659 } } children { name: "lineitem" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017850830 tx_id: 281474976720660 } } children { name: "nation" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017851330 tx_id: 281474976720661 } } children { name: "orders" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017854490 tx_id: 281474976720662 } } children { name: "part" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017858150 tx_id: 281474976720663 } } children { name: "partsupp" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017861360 tx_id: 281474976720664 } } children { name: "region" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017862000 tx_id: 281474976720665 } } children { name: "supplier" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762017864810 tx_id: 281474976720666 } } } } } }
2025-11-01 17:26:18,180 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,218 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/customer&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,265 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/customer&tablets=true HTTP/1.1" 200 589
2025-11-01 17:26:18,268 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/customer balance: 64-64 shards.
2025-11-01 17:26:18,271 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,285 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/lineitem&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,317 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/lineitem&tablets=true HTTP/1.1" 200 589
2025-11-01 17:26:18,333 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/lineitem balance: 64-64 shards.
2025-11-01 17:26:18,345 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,394 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/nation&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,426 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/nation&tablets=true HTTP/1.1" 200 587
2025-11-01 17:26:18,429 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/nation balance: 1-1 shards.
2025-11-01 17:26:18,446 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,461 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/orders&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,499 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/orders&tablets=true HTTP/1.1" 200 589
2025-11-01 17:26:18,501 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/orders balance: 64-64 shards.
2025-11-01 17:26:18,509 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,522 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/part&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,572 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/part&tablets=true HTTP/1.1" 200 589
2025-11-01 17:26:18,599 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/part balance: 64-64 shards.
2025-11-01 17:26:18,602 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,635 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/partsupp&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,702 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/partsupp&tablets=true HTTP/1.1" 200 589
2025-11-01 17:26:18,705 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/partsupp balance: 64-64 shards.
2025-11-01 17:26:18,726 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,740 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/region&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,762 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/region&tablets=true HTTP/1.1" 200 587
2025-11-01 17:26:18,772 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/region balance: 1-1 shards.
2025-11-01 17:26:18,780 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:18,800 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/supplier&tablets=true HTTP/1.1" 307 0
2025-11-01 17:26:18,843 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_2/supplier&tablets=true HTTP/1.1" 200 589
2025-11-01 17:26:18,854 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_2/supplier balance: 64-64 shards.
2025-11-01 17:26:18,870 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 01b5fdb3-a35e-446c-88e4-b26c99a664f8, ghrun-jzwpcuvpwq.auto.internal:20466): creating call state
2025-11-01 17:26:18,876 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 01b5fdb3-a35e-446c-88e4-b26c99a664f8, ghrun-jzwpcuvpwq.auto.internal:20466): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-01 17:26:18,879 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 01b5fdb3-a35e-446c-88e4-b26c99a664f8, ghrun-jzwpcuvpwq.auto.internal:20466): response = { <_MultiThreadedRendezvous object> }
2025-11-01 17:26:19,005 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydb/ydb
2025-11-01 17:26:19,071 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.25
2025-11-01 17:26:19,084 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.25
2025-11-01 17:26:19,085 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/ewjv/000e0b/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:9388', '-d', '/local/test_db', 'workload', 'tpch', '--path', 'olap_yatests/tpch/s0_2', 'run', '--json', 'Query01.stats.json', '--output', 'Query01.result', '--include', 'Query01', '--iterations', '1', '--plan', 'Query01.plan', '--global-timeout', '1800.0s', '--verbose', '--check-canonical', '--scale', '0.2']' in 'None' (waiting)
2025-11-01 17:26:19,118 - DEBUG - ya.test - execute: Command pid: 1457977
2025-11-01 17:26:36,976 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) rc: 0
2025-11-01 17:26:36,977 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) elapsed time (sec): 17.857038497924805
2025-11-01 17:26:36,978 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) idrss: 0
2025-11-01 17:26:36,978 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) inblock: 0
2025-11-01 17:26:36,983 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) isrss: 0
2025-11-01 17:26:36,983 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) ixrss: 0
2025-11-01 17:26:37,018 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) majflt: 0
2025-11-01 17:26:37,019 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) maxrss: 831916
2025-11-01 17:26:37,019 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) minflt: 116479
2025-11-01 17:26:37,027 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) msgrcv: 0
2025-11-01 17:26:37,028 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) msgsnd: 0
2025-11-01 17:26:37,028 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) nivcsw: 436
2025-11-01 17:26:37,028 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) nsignals: 0
2025-11-01 17:26:37,028 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) nswap: 0
2025-11-01 17:26:37,029 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) nvcsw: 3034
2025-11-01 17:26:37,029 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) oublock: 1512
2025-11-01 17:26:37,030 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) stime: 0.465493
2025-11-01 17:26:37,030 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) utime: 0.6968409999999999
2025-11-01 17:26:37,030 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) wtime: 17.865
2025-11-01 17:26:37,030 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) 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/s0_2/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	11.704459s seconds

Results for 1 iterations
┌─────────┬──────────┬─────────┬─────────┬─────────┬─────────┬───────────┬─────────┬─────────┬─────────┬─────────┬────────────────┬────────────────┬────────────────┬───────────┬──────────────┬────────────┬────────────┐
│ Query # │ ColdTime │ Min     │ Max     │ Mean    │ Median  │ UnixBench │ Std     │ RttMin  │ RttMax  │ RttAvg  │ CompilationMin │ CompilationMax │ CompilationAvg │ GrossTime │ SuccessCount │ FailsCount │ DiffsCount │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query01 │  11.404  │  11.404 │  11.404 │  11.404 │  11.403 │  11.404   │   0.001 │   0.301 │   0.301 │   0.301 │   2.276        │   2.276        │   2.276        │  11.704   │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Sum     │  11.404  │  11.404 │  11.404 │  11.404 │  11.403 │  11.404   │   0.000 │   0.301 │   0.301 │   0.301 │   2.276        │   2.276        │   2.277        │  15.920   │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Avg     │  11.404  │  11.404 │  11.404 │  11.404 │  11.403 │  11.404   │   0.000 │   0.301 │   0.301 │   0.301 │   2.276        │   2.276        │   2.277        │  15.920   │ 1            │            │            │
├─────────┼──────────┼─────────┼─────────┼─────────┼─────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ GAvg    │  11.404  │  11.404 │  11.404 │  11.404 │  11.403 │  11.404   │   0.000 │   0.301 │   0.301 │   0.001 │   2.276        │   2.276        │   0.001        │   0.000   │ 1            │            │            │
└─────────┴──────────┴─────────┴─────────┴─────────┴─────────┴───────────┴─────────┴─────────┴─────────┴─────────┴────────────────┴────────────────┴────────────────┴───────────┴──────────────┴────────────┴────────────┘

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

2025-11-01 17:26:37,031 - DEBUG - ya.test - _save_outputs: Command (pid 1457977) errors:

[K
[K
2025-11-01 17:26:37,037 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-11-01 17:26:37,073 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:37,077 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:26:37,097 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 554
2025-11-01 17:26:37,110 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:37,127 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes HTTP/1.1" 200 799
2025-11-01 17:26:37,136 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:17000
2025-11-01 17:26:37,144 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-01 17:26:37,175 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:17000 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 556
2025-11-01 17:26:37,184 - INFO - root - __create_iterations_table: All nodes before filtering: [('21270@ghrun-jzwpcuvpwq.auto.internal', <Role.UNKNOWN: 0>)]
2025-11-01 17:26:37,190 - INFO - root - __create_iterations_table: Auto-discovered hosts (all roles): 1 hosts from 1 total nodes
2025-11-01 17:26:37,194 - INFO - root - __create_iterations_table: Host to nodes mapping: [('ghrun-jzwpcuvpwq.auto.internal', 1)]
2025-11-01 17:26:37,219 - INFO - root - allure_test_description: iterations_table created, length: 514
2025-11-01 17:26:37,224 - INFO - root - allure_test_description: Added iterations table to description HTML
2025-11-01 17:26:37,304 - INFO - ya.test - pytest_runtest_teardown: Test teardown
