2025-11-03 09:54:38,277 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-03 09:54:38,278 - INFO - ya.test - pytest_runtest_setup: test[Query01]
2025-11-03 09:54:38,278 - INFO - ya.test - pytest_runtest_setup: ####################################################################################################
2025-11-03 09:54:38,278 - INFO - ya.test - pytest_runtest_setup: Test setup
2025-11-03 09:54:38,388 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd
2025-11-03 09:54:38,390 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/4041
2025-11-03 09:54:38,393 - DEBUG - ydb.tests.library.harness.kikimr_runner - start: Working directory: /home/runner/.ya/build/build_root/oa3o/000d62/r3tmp/kikimr_cluster_c01orwqd
2025-11-03 09:54:38,432 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd
2025-11-03 09:54:38,433 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/28762
2025-11-03 09:54:38,434 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/27282
2025-11-03 09:54:38,434 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/11464
2025-11-03 09:54:38,434 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/23653
2025-11-03 09:54:38,435 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs"
2025-11-03 09:54:38,436 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/oa3o/000d62/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/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/node_1/logfile_b3n92y0o.log --grpc-port=28762 --mon-port=27282 --ic-port=4041
2025-11-03 09:54:38,436 - DEBUG - ydb.tests.library.harness.kikimr_runner - format_pdisk: Formatting pdisk SectorMap:1:64 on node localhost:28762/1, disk_size 68719476736
2025-11-03 09:54:38,437 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs"
2025-11-03 09:54:38,437 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/oa3o/000d62/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/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/node_1/logfile_b3n92y0o.log --grpc-port=28762 --mon-port=27282 --ic-port=4041
2025-11-03 09:54:38,438 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs/config.yaml', '--node=1', '--log-file-name=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/node_1/logfile_b3n92y0o.log', '--grpc-port=28762', '--mon-port=27282', '--ic-port=4041')' in '/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/node_1' (no wait)
2025-11-03 09:54:38,448 - DEBUG - ya.test - execute: Command pid: 1351511
2025-11-03 09:54:38,449 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28762/1
2025-11-03 09:54:38,451 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out
2025-11-03 09:54:38,452 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err
2025-11-03 09:54:38,452 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-03 09:54:38,453 - DEBUG - ya.test - execute: Command pid: 1351513
2025-11-03 09:54:39,126 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) rc: 0
2025-11-03 09:54:39,127 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) elapsed time (sec): 0.672076940536499
2025-11-03 09:54:39,128 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) idrss: 0
2025-11-03 09:54:39,128 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) inblock: 0
2025-11-03 09:54:39,128 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) isrss: 0
2025-11-03 09:54:39,129 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) ixrss: 0
2025-11-03 09:54:39,129 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) majflt: 1
2025-11-03 09:54:39,129 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) maxrss: 579044
2025-11-03 09:54:39,129 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) minflt: 45887
2025-11-03 09:54:39,130 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) msgrcv: 0
2025-11-03 09:54:39,130 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) msgsnd: 0
2025-11-03 09:54:39,130 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) nivcsw: 6
2025-11-03 09:54:39,130 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) nsignals: 0
2025-11-03 09:54:39,131 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) nswap: 0
2025-11-03 09:54:39,131 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) nvcsw: 14
2025-11-03 09:54:39,131 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) oublock: 8
2025-11-03 09:54:39,131 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) stime: 0.21712599999999999
2025-11-03 09:54:39,131 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) utime: 0.41016199999999997
2025-11-03 09:54:39,132 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) wtime: 0.674
2025-11-03 09:54:39,133 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) output:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mh4kzsenyi
    Host information: 
        Linux ghrun-mh4kzsenyi 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-03 09:54:39,133 - DEBUG - ya.test - _save_outputs: Command (pid 1351513) errors:

2025-11-03 09:54:39,134 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e
2025-11-03 09:54:41,752 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd
2025-11-03 09:54:41,752 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28762', '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: 4041\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']
2025-11-03 09:54:41,754 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.0
2025-11-03 09:54:41,754 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.0
2025-11-03 09:54:41,755 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28762', '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: 4041\n      }\n      HostConfigId: 1\n    }\n  }\n}\n']' in 'None' (waiting)
2025-11-03 09:54:41,756 - DEBUG - ya.test - execute: Command pid: 1352144
2025-11-03 09:54:42,598 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) rc: 0
2025-11-03 09:54:42,599 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) elapsed time (sec): 0.8374366760253906
2025-11-03 09:54:42,599 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) idrss: 0
2025-11-03 09:54:42,599 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) inblock: 0
2025-11-03 09:54:42,600 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) isrss: 0
2025-11-03 09:54:42,602 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) ixrss: 0
2025-11-03 09:54:42,602 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) majflt: 0
2025-11-03 09:54:42,603 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) maxrss: 641904
2025-11-03 09:54:42,604 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) minflt: 51688
2025-11-03 09:54:42,605 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) msgrcv: 0
2025-11-03 09:54:42,606 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) msgsnd: 0
2025-11-03 09:54:42,606 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) nivcsw: 30
2025-11-03 09:54:42,606 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) nsignals: 0
2025-11-03 09:54:42,606 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) nswap: 0
2025-11-03 09:54:42,607 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) nvcsw: 1121
2025-11-03 09:54:42,607 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) oublock: 8
2025-11-03 09:54:42,609 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) stime: 0.24336999999999998
2025-11-03 09:54:42,610 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) utime: 0.5456869999999999
2025-11-03 09:54:42,610 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) wtime: 0.839
2025-11-03 09:54:42,610 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) output:
Status {
  Success: true
}
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 5

2025-11-03 09:54:42,610 - DEBUG - ya.test - _save_outputs: Command (pid 1352144) errors:

2025-11-03 09:54:42,612 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd
2025-11-03 09:54:42,612 - DEBUG - ydb.tests.library.harness.kikimr_runner - __call_kikimr_new_cli: Executing command = ['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28762', '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-03 09:54:42,614 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.1
2025-11-03 09:54:42,614 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.1
2025-11-03 09:54:42,615 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '--server', 'grpc://localhost:28762', '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-03 09:54:42,616 - DEBUG - ya.test - execute: Command pid: 1352477
2025-11-03 09:54:43,424 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) rc: 0
2025-11-03 09:54:43,424 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) elapsed time (sec): 0.8057856559753418
2025-11-03 09:54:43,425 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) idrss: 0
2025-11-03 09:54:43,425 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) inblock: 0
2025-11-03 09:54:43,425 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) isrss: 0
2025-11-03 09:54:43,426 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) ixrss: 0
2025-11-03 09:54:43,426 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) majflt: 0
2025-11-03 09:54:43,426 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) maxrss: 642992
2025-11-03 09:54:43,426 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) minflt: 51520
2025-11-03 09:54:43,427 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) msgrcv: 0
2025-11-03 09:54:43,427 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) msgsnd: 0
2025-11-03 09:54:43,427 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) nivcsw: 9
2025-11-03 09:54:43,428 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) nsignals: 0
2025-11-03 09:54:43,428 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) nswap: 0
2025-11-03 09:54:43,428 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) nvcsw: 732
2025-11-03 09:54:43,428 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) oublock: 8
2025-11-03 09:54:43,429 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) stime: 0.197013
2025-11-03 09:54:43,429 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) utime: 0.582661
2025-11-03 09:54:43,430 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) wtime: 0.807
2025-11-03 09:54:43,430 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) output:
Status {
  Success: true
}
Success: true
ConfigTxSeqNo: 6

2025-11-03 09:54:43,430 - DEBUG - ya.test - _save_outputs: Command (pid 1352477) errors:

2025-11-03 09:54:43,431 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Binding storage pools to domain local: {'dynamic_storage_pool:1': 'hdd'}
2025-11-03 09:54:43,488 - INFO - ydb.tests.library.harness.kikimr_runner - __run: Cluster started and initialized
2025-11-03 09:54:44,054 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd
2025-11-03 09:54:44,056 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/2928
2025-11-03 09:54:44,057 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/22319
2025-11-03 09:54:44,058 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/20365
2025-11-03 09:54:44,059 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/61431
2025-11-03 09:54:44,060 - DEBUG - library.python.filelock - acquire: Acquiring FileLock (blocking=False): /home/runner/.ya/build/port_sync_dir/62693
2025-11-03 09:54:44,062 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs"
2025-11-03 09:54:44,063 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28762 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/slot_1/logfile__jwtqhb9.log --grpc-port=2928 --mon-port=22319 --ic-port=20365
2025-11-03 09:54:44,064 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs"
2025-11-03 09:54:44,064 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28762 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/slot_1/logfile__jwtqhb9.log --grpc-port=2928 --mon-port=22319 --ic-port=20365
2025-11-03 09:54:44,065 - DEBUG - ya.test - execute: Executing '('/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', 'server', '--suppress-version-check', '--yaml-config=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs/config.yaml', '--node-broker=localhost:28762', '--tenant=/local/test_db', '--log-file-name=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/slot_1/logfile__jwtqhb9.log', '--grpc-port=2928', '--mon-port=22319', '--ic-port=20365')' in '/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/slot_1' (no wait)
2025-11-03 09:54:44,069 - DEBUG - ya.test - execute: Command pid: 1353109
2025-11-03 09:54:44,071 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:2928/1
2025-11-03 09:54:44,077 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.2
2025-11-03 09:54:44,083 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.2
2025-11-03 09:54:44,084 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-03 09:54:44,086 - DEBUG - ya.test - execute: Command pid: 1353110
2025-11-03 09:54:44,815 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) rc: 0
2025-11-03 09:54:44,816 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) elapsed time (sec): 0.7235610485076904
2025-11-03 09:54:44,816 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) idrss: 0
2025-11-03 09:54:44,816 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) inblock: 0
2025-11-03 09:54:44,817 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) isrss: 0
2025-11-03 09:54:44,817 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) ixrss: 0
2025-11-03 09:54:44,817 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) majflt: 0
2025-11-03 09:54:44,818 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) maxrss: 655404
2025-11-03 09:54:44,818 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) minflt: 45312
2025-11-03 09:54:44,818 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) msgrcv: 0
2025-11-03 09:54:44,819 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) msgsnd: 0
2025-11-03 09:54:44,819 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) nivcsw: 30
2025-11-03 09:54:44,819 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) nsignals: 0
2025-11-03 09:54:44,819 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) nswap: 0
2025-11-03 09:54:44,820 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) nvcsw: 14
2025-11-03 09:54:44,820 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) oublock: 8
2025-11-03 09:54:44,820 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) stime: 0.167018
2025-11-03 09:54:44,821 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) utime: 0.510845
2025-11-03 09:54:44,821 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) wtime: 0.731
2025-11-03 09:54:44,821 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) output:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mh4kzsenyi
    Host information: 
        Linux ghrun-mh4kzsenyi 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-03 09:54:44,822 - DEBUG - ya.test - _save_outputs: Command (pid 1353110) errors:

2025-11-03 09:54:44,822 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e
2025-11-03 09:54:50,849 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydb/ydb
2025-11-03 09:54:50,851 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out
2025-11-03 09:54:50,851 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err
2025-11-03 09:54:50,852 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:28762', '-d', '/local/test_db', 'workload', 'tpch', '-p', 'olap_yatests/tpch/s0_1', 'init', '--store=column', '--datetime-types=dt64']' in 'None' (waiting)
2025-11-03 09:54:50,853 - DEBUG - ya.test - execute: Command pid: 1354427
2025-11-03 09:55:02,274 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) rc: 0
2025-11-03 09:55:02,275 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) elapsed time (sec): 11.420245170593262
2025-11-03 09:55:02,275 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) idrss: 0
2025-11-03 09:55:02,276 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) inblock: 0
2025-11-03 09:55:02,276 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) isrss: 0
2025-11-03 09:55:02,276 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) ixrss: 0
2025-11-03 09:55:02,276 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) majflt: 0
2025-11-03 09:55:02,277 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) maxrss: 656292
2025-11-03 09:55:02,277 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) minflt: 109396
2025-11-03 09:55:02,277 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) msgrcv: 0
2025-11-03 09:55:02,277 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) msgsnd: 0
2025-11-03 09:55:02,278 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) nivcsw: 14
2025-11-03 09:55:02,278 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) nsignals: 0
2025-11-03 09:55:02,278 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) nswap: 0
2025-11-03 09:55:02,278 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) nvcsw: 3940
2025-11-03 09:55:02,279 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) oublock: 16
2025-11-03 09:55:02,279 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) stime: 0.282091
2025-11-03 09:55:02,279 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) utime: 0.395026
2025-11-03 09:55:02,280 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) wtime: 11.422
2025-11-03 09:55:02,280 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) output:
Init tables ...
Init tables ...Ok

2025-11-03 09:55:02,280 - DEBUG - ya.test - _save_outputs: Command (pid 1354427) errors:

2025-11-03 09:55:02,281 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydb/ydb
2025-11-03 09:55:02,282 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.0
2025-11-03 09:55:02,283 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.0
2025-11-03 09:55:02,283 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:28762', '-d', '/local/test_db', 'workload', 'tpch', '-p', 'olap_yatests/tpch/s0_1', 'import', 'generator', '--scale=0.1']' in 'None' (waiting)
2025-11-03 09:55:02,285 - DEBUG - ya.test - execute: Command pid: 1356065
2025-11-03 09:55:34,659 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) rc: 0
2025-11-03 09:55:34,660 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) elapsed time (sec): 32.37354564666748
2025-11-03 09:55:34,660 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) idrss: 0
2025-11-03 09:55:34,660 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) inblock: 0
2025-11-03 09:55:34,661 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) isrss: 0
2025-11-03 09:55:34,661 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) ixrss: 0
2025-11-03 09:55:34,661 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) majflt: 0
2025-11-03 09:55:34,662 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) maxrss: 1200688
2025-11-03 09:55:34,662 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) minflt: 748041
2025-11-03 09:55:34,662 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) msgrcv: 0
2025-11-03 09:55:34,662 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) msgsnd: 0
2025-11-03 09:55:34,663 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) nivcsw: 1258
2025-11-03 09:55:34,663 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) nsignals: 0
2025-11-03 09:55:34,663 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) nswap: 0
2025-11-03 09:55:34,664 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) nvcsw: 112115
2025-11-03 09:55:34,664 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) oublock: 32
2025-11-03 09:55:34,664 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) stime: 5.248296
2025-11-03 09:55:34,664 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) utime: 31.605382
2025-11-03 09:55:34,665 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) wtime: 32.375
2025-11-03 09:55:34,665 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) output:
Fill table supplier...
Fill table supplier OK 1000 / 1000 (11.568207s)
Fill table customer...
Fill table customer OK 15000 / 15000 (0.785882s)
Fill table orders...
Fill table orders OK 150000 / 150000 (16.603429s)
Fill table part...
Fill table part OK 20000 / 20000 (2.159956s)
Fill table nation...
Fill table nation OK 25 / 25 (0.144798s)
Fill table region...
Fill table region OK 5 / 5 (0.161063s)

2025-11-03 09:55:34,666 - DEBUG - ya.test - _save_outputs: Command (pid 1356065) errors:







2025-11-03 09:55:34,667 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-11-03 09:55:34,676 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:34,680 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 09:55:34,692 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-11-03 09:55:34,695 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-11-03 09:55:34,696 - INFO - root - _create_ydb_driver: Connecting to grpc://localhost:28762 to local/test_db ydb_access_token is set False
2025-11-03 09:55:34,697 - 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-03 09:55:34,700 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-03 09:55:34,702 - 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-03 09:55:34,718 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-03 09:55:34,719 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, aa599901-8830-43dd-a675-2c4cd2d268d7, localhost:28762): creating call state
2025-11-03 09:55:34,720 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, aa599901-8830-43dd-a675-2c4cd2d268d7, localhost:28762): request = { database: "local/test_db" }
2025-11-03 09:55:34,725 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, aa599901-8830-43dd-a675-2c4cd2d268d7, localhost:28762): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mh4kzsenyi.auto.internal" port: 2928 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-03 09:55:34,726 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mh4kzsenyi.auto.internal:2928, location , ssl: False>]>
2025-11-03 09:55:34,727 - 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-03 09:55:34,744 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28762
2025-11-03 09:55:34,744 - INFO - root - _create_ydb_driver: Connected
2025-11-03 09:55:34,748 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, da156d0e-716e-43f9-be06-c1144769832b, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:34,749 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, da156d0e-716e-43f9-be06-c1144769832b, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:34,754 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, da156d0e-716e-43f9-be06-c1144769832b, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:34,957 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:34,962 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 09:55:34,975 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 551
2025-11-03 09:55:34,978 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-11-03 09:55:34,978 - INFO - root - get_tables: get_tables /local/test_db/olap_yatests/tpch/s0_1
2025-11-03 09:55:34,979 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/tpch/s0_1
2025-11-03 09:55:34,980 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 32b46853-bdc4-4927-be5e-694789c8c7a8, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:34,980 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 32b46853-bdc4-4927-be5e-694789c8c7a8, ghrun-mh4kzsenyi.auto.internal:2928): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_1" }
2025-11-03 09:55:34,987 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 32b46853-bdc4-4927-be5e-694789c8c7a8, ghrun-mh4kzsenyi.auto.internal:2928): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "s0_1" 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: 1762163693250 tx_id: 281474976720659 } } } } } }
2025-11-03 09:55:34,988 - INFO - root - list_directory: list /local/test_db/olap_yatests/tpch/s0_1
2025-11-03 09:55:34,989 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, a66dc74f-4781-4dbc-9f3b-2b6259fdb2ac, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:34,990 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, a66dc74f-4781-4dbc-9f3b-2b6259fdb2ac, ghrun-mh4kzsenyi.auto.internal:2928): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_1" }
2025-11-03 09:55:34,997 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, a66dc74f-4781-4dbc-9f3b-2b6259fdb2ac, ghrun-mh4kzsenyi.auto.internal:2928): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "s0_1" 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: 1762163693250 tx_id: 281474976720659 } } children { name: "customer" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163693250 tx_id: 281474976720659 } } children { name: "lineitem" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163695070 tx_id: 281474976720660 } } children { name: "nation" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163695330 tx_id: 281474976720661 } } children { name: "orders" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163696690 tx_id: 281474976720662 } } children { name: "part" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163698340 tx_id: 281474976720663 } } children { name: "partsupp" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163699950 tx_id: 281474976720664 } } children { name: "region" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163700250 tx_id: 281474976720665 } } children { name: "supplier" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163701860 tx_id: 281474976720666 } } } } } }
2025-11-03 09:55:35,002 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,007 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/customer&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,020 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/customer&tablets=true HTTP/1.1" 200 579
2025-11-03 09:55:35,022 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/customer balance: 64-64 shards.
2025-11-03 09:55:35,025 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,030 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/lineitem&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,042 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/lineitem&tablets=true HTTP/1.1" 200 579
2025-11-03 09:55:35,044 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/lineitem balance: 64-64 shards.
2025-11-03 09:55:35,048 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,051 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/nation&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,062 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/nation&tablets=true HTTP/1.1" 200 577
2025-11-03 09:55:35,065 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/nation balance: 1-1 shards.
2025-11-03 09:55:35,068 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,072 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/orders&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,084 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/orders&tablets=true HTTP/1.1" 200 579
2025-11-03 09:55:35,086 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/orders balance: 64-64 shards.
2025-11-03 09:55:35,089 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,093 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/part&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,107 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/part&tablets=true HTTP/1.1" 200 579
2025-11-03 09:55:35,110 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/part balance: 64-64 shards.
2025-11-03 09:55:35,114 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,117 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/partsupp&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,130 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/partsupp&tablets=true HTTP/1.1" 200 579
2025-11-03 09:55:35,132 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/partsupp balance: 64-64 shards.
2025-11-03 09:55:35,136 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,139 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/region&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,151 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/region&tablets=true HTTP/1.1" 200 577
2025-11-03 09:55:35,154 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/region balance: 1-1 shards.
2025-11-03 09:55:35,157 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:35,182 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/supplier&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:35,195 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/supplier&tablets=true HTTP/1.1" 200 579
2025-11-03 09:55:35,198 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/supplier balance: 64-64 shards.
2025-11-03 09:55:35,199 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 3f23bf77-615b-4109-bdd7-61ad7b2656f3, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:35,200 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 3f23bf77-615b-4109-bdd7-61ad7b2656f3, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:35,202 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 3f23bf77-615b-4109-bdd7-61ad7b2656f3, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:35,276 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, a118acba-5bac-4df2-94bf-c8e2db89bab8, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:35,277 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, a118acba-5bac-4df2-94bf-c8e2db89bab8, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/customer`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:35,279 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, a118acba-5bac-4df2-94bf-c8e2db89bab8, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:35,280 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:36,536 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, a9f5bd05-b267-46b9-8880-2b5619538233, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:36,537 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, a9f5bd05-b267-46b9-8880-2b5619538233, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/nation`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:36,538 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, a9f5bd05-b267-46b9-8880-2b5619538233, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:36,539 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:37,530 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, ede6d3be-96fc-49f1-862b-e59e4d466bdd, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:37,531 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, ede6d3be-96fc-49f1-862b-e59e4d466bdd, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/orders`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:37,533 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, ede6d3be-96fc-49f1-862b-e59e4d466bdd, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:37,534 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:38,819 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 18f55e07-e6d1-4a1e-8c56-137c98b9eb54, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:38,820 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 18f55e07-e6d1-4a1e-8c56-137c98b9eb54, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/part`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:38,822 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 18f55e07-e6d1-4a1e-8c56-137c98b9eb54, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:38,822 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:39,718 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 5fcf309d-ea6b-4a5f-a4c4-98e2499b1b15, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:39,720 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 5fcf309d-ea6b-4a5f-a4c4-98e2499b1b15, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/partsupp`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:39,722 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 5fcf309d-ea6b-4a5f-a4c4-98e2499b1b15, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:39,722 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:40,706 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 8ef8cc9c-b342-46b6-b0de-b2f312d97dd2, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:40,707 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 8ef8cc9c-b342-46b6-b0de-b2f312d97dd2, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/region`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:40,708 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 8ef8cc9c-b342-46b6-b0de-b2f312d97dd2, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:40,709 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:41,603 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, a26669ee-6b8f-46da-ba83-748cf0e49eb7, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:41,604 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, a26669ee-6b8f-46da-ba83-748cf0e49eb7, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/supplier`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:41,606 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, a26669ee-6b8f-46da-ba83-748cf0e49eb7, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:41,607 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:42,665 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, a371a5b0-9bb7-4d72-8a63-4e42a7daa88b, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:42,666 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, a371a5b0-9bb7-4d72-8a63-4e42a7daa88b, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "SELECT count(*) FROM `/local/test_db/olap_yatests/tpch/s0_1/lineitem`" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:42,668 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, a371a5b0-9bb7-4d72-8a63-4e42a7daa88b, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:42,669 - INFO - ydb.tests.olap.scenario.helpers.scenario_tests_helper - _run_with_expected_status: Success operation
2025-11-03 09:55:44,512 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,516 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 09:55:44,527 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 548
2025-11-03 09:55:44,535 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,538 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 09:55:44,549 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 548
2025-11-03 09:55:44,552 - DEBUG - root - check_if_ydb_alive: Expected nodes count: 1
2025-11-03 09:55:44,553 - INFO - root - get_tables: get_tables /local/test_db/olap_yatests/tpch/s0_1
2025-11-03 09:55:44,553 - INFO - root - _describe_path_impl: describe /local/test_db/olap_yatests/tpch/s0_1
2025-11-03 09:55:44,554 - DEBUG - ydb.connection - _prepare_call: RpcState(DescribePath, 9a0a44fb-8fec-48dd-b6c8-c92a5c38e31a, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:44,555 - DEBUG - ydb.connection - _log_request: RpcState(DescribePath, 9a0a44fb-8fec-48dd-b6c8-c92a5c38e31a, ghrun-mh4kzsenyi.auto.internal:2928): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_1" }
2025-11-03 09:55:44,562 - DEBUG - ydb.connection - _log_response: RpcState(DescribePath, 9a0a44fb-8fec-48dd-b6c8-c92a5c38e31a, ghrun-mh4kzsenyi.auto.internal:2928): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.DescribePathResult] { self { name: "s0_1" 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: 1762163693250 tx_id: 281474976720659 } } } } } }
2025-11-03 09:55:44,563 - INFO - root - list_directory: list /local/test_db/olap_yatests/tpch/s0_1
2025-11-03 09:55:44,563 - DEBUG - ydb.connection - _prepare_call: RpcState(ListDirectory, 44ef82dc-2809-47eb-ae27-8457d0f4f720, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:44,564 - DEBUG - ydb.connection - _log_request: RpcState(ListDirectory, 44ef82dc-2809-47eb-ae27-8457d0f4f720, ghrun-mh4kzsenyi.auto.internal:2928): request = { operation_params { operation_timeout { seconds: 600 } cancel_after { seconds: 600 } } path: "/local/test_db/olap_yatests/tpch/s0_1" }
2025-11-03 09:55:44,573 - DEBUG - ydb.connection - _log_response: RpcState(ListDirectory, 44ef82dc-2809-47eb-ae27-8457d0f4f720, ghrun-mh4kzsenyi.auto.internal:2928): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Scheme.ListDirectoryResult] { self { name: "s0_1" 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: 1762163693250 tx_id: 281474976720659 } } children { name: "customer" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163693250 tx_id: 281474976720659 } } children { name: "lineitem" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163695070 tx_id: 281474976720660 } } children { name: "nation" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163695330 tx_id: 281474976720661 } } children { name: "orders" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163696690 tx_id: 281474976720662 } } children { name: "part" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163698340 tx_id: 281474976720663 } } children { name: "partsupp" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163699950 tx_id: 281474976720664 } } children { name: "region" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163700250 tx_id: 281474976720665 } } children { name: "supplier" owner: "root@builtin" type: COLUMN_TABLE created_at { plan_step: 1762163701860 tx_id: 281474976720666 } } } } } }
2025-11-03 09:55:44,577 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,582 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/customer&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,595 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/customer&tablets=true HTTP/1.1" 200 576
2025-11-03 09:55:44,597 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/customer balance: 64-64 shards.
2025-11-03 09:55:44,600 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,604 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/lineitem&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,618 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/lineitem&tablets=true HTTP/1.1" 200 576
2025-11-03 09:55:44,621 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/lineitem balance: 64-64 shards.
2025-11-03 09:55:44,624 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,630 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/nation&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,644 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/nation&tablets=true HTTP/1.1" 200 575
2025-11-03 09:55:44,647 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/nation balance: 1-1 shards.
2025-11-03 09:55:44,650 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,653 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/orders&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,665 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/orders&tablets=true HTTP/1.1" 200 576
2025-11-03 09:55:44,667 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/orders balance: 64-64 shards.
2025-11-03 09:55:44,670 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,674 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/part&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,686 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/part&tablets=true HTTP/1.1" 200 576
2025-11-03 09:55:44,689 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/part balance: 64-64 shards.
2025-11-03 09:55:44,692 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,697 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/partsupp&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,710 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/partsupp&tablets=true HTTP/1.1" 200 576
2025-11-03 09:55:44,713 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/partsupp balance: 64-64 shards.
2025-11-03 09:55:44,716 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,719 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/region&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,732 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/region&tablets=true HTTP/1.1" 200 575
2025-11-03 09:55:44,734 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/region balance: 1-1 shards.
2025-11-03 09:55:44,737 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 09:55:44,741 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/supplier&tablets=true HTTP/1.1" 307 0
2025-11-03 09:55:44,762 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db&path=/local/test_db/olap_yatests/tpch/s0_1/supplier&tablets=true HTTP/1.1" 200 576
2025-11-03 09:55:44,764 - INFO - root - check_if_ydb_alive: Table /local/test_db/olap_yatests/tpch/s0_1/supplier balance: 64-64 shards.
2025-11-03 09:55:44,765 - DEBUG - ydb.connection - _prepare_call: RpcState(StreamExecuteScanQuery, 5cac696d-d0b6-412e-b898-514fe9f7c7d7, ghrun-mh4kzsenyi.auto.internal:2928): creating call state
2025-11-03 09:55:44,766 - DEBUG - ydb.connection - _log_request: RpcState(StreamExecuteScanQuery, 5cac696d-d0b6-412e-b898-514fe9f7c7d7, ghrun-mh4kzsenyi.auto.internal:2928): request = { query { yql_text: "select 1" } mode: MODE_EXEC collect_stats: STATS_COLLECTION_NONE }
2025-11-03 09:55:44,769 - DEBUG - ydb.connection - _log_response: RpcState(StreamExecuteScanQuery, 5cac696d-d0b6-412e-b898-514fe9f7c7d7, ghrun-mh4kzsenyi.auto.internal:2928): response = { <_MultiThreadedRendezvous object> }
2025-11-03 09:55:44,846 - DEBUG - ya.test - get_binary: Binary was found by /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydb/ydb
2025-11-03 09:55:44,848 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydb.out.1
2025-11-03 09:55:44,849 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydb.err.1
2025-11-03 09:55:44,850 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydb/ydb', '-e', 'grpc://localhost:28762', '-d', '/local/test_db', 'workload', 'tpch', '--path', 'olap_yatests/tpch/s0_1', 'run', '--json', 'f824baa9cfbbd7f7b5193c0ff93cc740.stats.json', '--output', 'f824baa9cfbbd7f7b5193c0ff93cc740.result', '--include', 'Query01,Query02,Query03,Query04,Query05,Query06,Query07,Query08,Query09,Query10,Query11,Query12,Query13,Query14,Query15,Query16,Query17,Query18,Query19,Query20,Query21,Query22', '--iterations', '1', '--plan', 'f824baa9cfbbd7f7b5193c0ff93cc740.plan', '--global-timeout', '1800.0s', '--verbose', '--scale', '0.1', '--threads', '10']' in 'None' (waiting)
2025-11-03 09:55:44,852 - DEBUG - ya.test - execute: Command pid: 1368395
2025-11-03 09:56:40,106 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-03 09:56:40,107 - 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-03 09:56:40,146 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-03 09:56:40,146 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, bc575fa9-527d-4091-9414-cbeac837b19b, localhost:28762): creating call state
2025-11-03 09:56:40,147 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, bc575fa9-527d-4091-9414-cbeac837b19b, localhost:28762): request = { database: "local/test_db" }
2025-11-03 09:56:40,153 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, bc575fa9-527d-4091-9414-cbeac837b19b, localhost:28762): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mh4kzsenyi.auto.internal" port: 2928 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-03 09:56:40,154 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mh4kzsenyi.auto.internal:2928, location , ssl: False>]>
2025-11-03 09:56:40,154 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28762
2025-11-03 09:57:50,850 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-03 09:57:50,851 - 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-03 09:57:50,897 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-03 09:57:50,898 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, ebe1dbe0-8074-488e-908e-a7fdea4455e9, localhost:28762): creating call state
2025-11-03 09:57:50,899 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, ebe1dbe0-8074-488e-908e-a7fdea4455e9, localhost:28762): request = { database: "local/test_db" }
2025-11-03 09:57:50,909 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, ebe1dbe0-8074-488e-908e-a7fdea4455e9, localhost:28762): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mh4kzsenyi.auto.internal" port: 2928 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-03 09:57:50,910 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mh4kzsenyi.auto.internal:2928, location , ssl: False>]>
2025-11-03 09:57:50,910 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28762
2025-11-03 09:59:04,087 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-03 09:59:04,087 - 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-03 09:59:04,101 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-03 09:59:04,102 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, cc91b056-c4cb-4e25-a404-30d6c5f12bdd, localhost:28762): creating call state
2025-11-03 09:59:04,102 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, cc91b056-c4cb-4e25-a404-30d6c5f12bdd, localhost:28762): request = { database: "local/test_db" }
2025-11-03 09:59:04,114 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, cc91b056-c4cb-4e25-a404-30d6c5f12bdd, localhost:28762): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mh4kzsenyi.auto.internal" port: 2928 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-03 09:59:04,115 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mh4kzsenyi.auto.internal:2928, location , ssl: False>]>
2025-11-03 09:59:04,116 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28762
2025-11-03 10:00:28,125 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Preparing initial endpoint to resolve endpoints
2025-11-03 10:00:28,126 - 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-03 10:00:28,140 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - context_resolve: Resolving endpoints for database local/test_db
2025-11-03 10:00:28,141 - DEBUG - ydb.connection - _prepare_call: RpcState(ListEndpoints, c848d0d8-6f5e-4473-abd9-579241cd3b60, localhost:28762): creating call state
2025-11-03 10:00:28,155 - DEBUG - ydb.connection - _log_request: RpcState(ListEndpoints, c848d0d8-6f5e-4473-abd9-579241cd3b60, localhost:28762): request = { database: "local/test_db" }
2025-11-03 10:00:28,167 - DEBUG - ydb.connection - _log_response: RpcState(ListEndpoints, c848d0d8-6f5e-4473-abd9-579241cd3b60, localhost:28762): response = { operation { ready: true status: SUCCESS result { [type.googleapis.com/Ydb.Discovery.ListEndpointsResult] { endpoints { address: "ghrun-mh4kzsenyi.auto.internal" port: 2928 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-03 10:00:28,168 - DEBUG - ydb.resolver.DiscoveryEndpointsResolver - _add_debug_details: Resolved endpoints for database local/test_db: DiscoveryResult <self_location: 1, endpoints [<Endpoint ghrun-mh4kzsenyi.auto.internal:2928, location , ssl: False>]>
2025-11-03 10:00:28,168 - DEBUG - ydb.connection - close: Closing channel for endpoint localhost:28762
2025-11-03 10:00:31,043 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) rc: 0
2025-11-03 10:00:31,043 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) elapsed time (sec): 286.17850136756897
2025-11-03 10:00:31,044 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) idrss: 0
2025-11-03 10:00:31,045 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) inblock: 8
2025-11-03 10:00:31,045 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) isrss: 0
2025-11-03 10:00:31,046 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) ixrss: 0
2025-11-03 10:00:31,046 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) majflt: 0
2025-11-03 10:00:31,046 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) maxrss: 661436
2025-11-03 10:00:31,047 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) minflt: 473353
2025-11-03 10:00:31,047 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) msgrcv: 0
2025-11-03 10:00:31,047 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) msgsnd: 0
2025-11-03 10:00:31,048 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) nivcsw: 6647
2025-11-03 10:00:31,048 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) nsignals: 0
2025-11-03 10:00:31,048 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) nswap: 0
2025-11-03 10:00:31,049 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) nvcsw: 27280
2025-11-03 10:00:31,049 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) oublock: 672096
2025-11-03 10:00:31,050 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) stime: 3.086581
2025-11-03 10:00:31,050 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) utime: 22.859628
2025-11-03 10:00:31,050 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) wtime: 286.18
2025-11-03 10:00:31,051 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) 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_1/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	138.282394s seconds
Query02:
Query text:
$r = (
select
    r_regionkey
from 
    `olap_yatests/tpch/s0_1/region`
where
    r_name='EUROPE'
);
$n = (
select
    n_name,
    n_nationkey
from
    `olap_yatests/tpch/s0_1/nation` as n 
left semi join
    $r as r
on 
    n.n_regionkey = r.r_regionkey
);
$s1 = (
select
    s_suppkey
from
    `olap_yatests/tpch/s0_1/supplier` as s
left semi join
    $n as n
on
    s.s_nationkey = n.n_nationkey
);
$min_ps_supplycost = (
select
    min(ps_supplycost) as min_ps_supplycost,
    ps.ps_partkey as ps_partkey
from
    `olap_yatests/tpch/s0_1/partsupp` as ps
left semi join
    $s1 as s
on
    ps.ps_suppkey = s.s_suppkey
group by
    ps.ps_partkey
);
$p = (
select
    p_partkey,
    p_mfgr
from
    `olap_yatests/tpch/s0_1/part`
where
    p_size = 15
    and p_type like '%BRASS'
);
$ps = (
select
    ps.ps_partkey as ps_partkey,
    p.p_mfgr as p_mfgr,
    ps.ps_supplycost as ps_supplycost,
    ps.ps_suppkey as ps_suppkey
from
    `olap_yatests/tpch/s0_1/partsupp` as ps
join
    $p as p
on
    p.p_partkey = ps.ps_partkey
);
$s2 = (
select
    s_acctbal,
    s_name,
    s_address,
    s_phone,
    s_comment,
    s_suppkey,
    n_name
from
    `olap_yatests/tpch/s0_1/supplier` as s
join
    $n as n
on
    s.s_nationkey = n.n_nationkey
);
$jp =(
select
    ps_partkey,
    ps_supplycost,
    p_mfgr,
    s_acctbal,
    s_name,
    s_address,
    s_phone,
    s_comment,
    n_name
from
    $ps as ps
join    
    $s2 as s
on
    ps.ps_suppkey = s.s_suppkey  
);
select
    s_acctbal,
    s_name,
    n_name,
    jp.ps_partkey as p_partkey,
    p_mfgr,
    s_address,
    s_phone,
    s_comment
from
    $jp as jp
join
    $min_ps_supplycost as m
on
    jp.ps_partkey = m.ps_partkey
where
    min_ps_supplycost = ps_supplycost
order by
    s_acctbal desc,
    n_name,
    s_name,
    p_partkey
limit 100;

	iteration 0:	ok	56.714493s seconds
Query03:
Query text:
$z1_12 = 1;
$round = ($x, $y) -> { return Math::Round($x, $y); };
$c = (
select
    c_custkey
from
    `olap_yatests/tpch/s0_1/customer`
where
    c_mktsegment = 'BUILDING'
);
$o = (
select
    o_orderdate,
    o_shippriority,
    o_orderkey
from
    `olap_yatests/tpch/s0_1/orders` as o
left semi join
    $c as c
on
    c.c_custkey = o.o_custkey
where
    o_orderdate < Date('1995-03-15')
);
$join2 = (
select
    o.o_orderdate as o_orderdate,
    o.o_shippriority as o_shippriority,
    l.l_orderkey as l_orderkey,
    l.l_discount as l_discount,
    l.l_extendedprice as l_extendedprice
from
    `olap_yatests/tpch/s0_1/lineitem` as l
join
    $o as o
on
    l.l_orderkey = o.o_orderkey
where
    l_shipdate > Date('1995-03-15')
);
select
    l_orderkey,
    $round(sum(l_extendedprice * ($z1_12 - l_discount)), -3) as revenue,
    o_orderdate,
    o_shippriority
from
    $join2
group by
    l_orderkey,
    o_orderdate,
    o_shippriority
order by
    revenue desc,
    o_orderdate,
    l_orderkey
limit 10;

	iteration 0:	ok	81.753383s seconds
Query04:
Query text:
$border = Date("1993-07-01");
$o = (
select
    o_orderpriority,
    o_orderkey
from
    `olap_yatests/tpch/s0_1/orders`
where
    o_orderdate >= $border
    and o_orderdate < DateTime::MakeDate(DateTime::ShiftMonths($border, 3))
);
$l = (
select
    distinct l_orderkey
from
    `olap_yatests/tpch/s0_1/lineitem`
where
    l_commitdate < l_receiptdate
);
select
    o.o_orderpriority as o_orderpriority,
    count(*) as order_count
from
    $o as o
join
    $l as l
on
    o.o_orderkey = l.l_orderkey
group by
    o.o_orderpriority
order by
    o_orderpriority;

	iteration 0:	ok	100.861587s seconds
Query05:
Query text:
$z1_12 = 1;
$border = Date("1994-01-01");
$j1 = (
select
    n.n_name as n_name,
    n.n_nationkey as n_nationkey
from
    `olap_yatests/tpch/s0_1/nation` as n
join
    `olap_yatests/tpch/s0_1/region` as r
on
    n.n_regionkey = r.r_regionkey
where
    r_name = 'ASIA'
);
$j2 = (
select
    j.n_name as n_name,
    j.n_nationkey as n_nationkey,
    s.s_suppkey as s_suppkey
from
    `olap_yatests/tpch/s0_1/supplier` as s
join
    $j1 as j
on
    j.n_nationkey = s.s_nationkey
);
$j3 = (
select
    j.n_name as n_name,
    j.n_nationkey as n_nationkey,
    l.l_extendedprice as l_extendedprice,
    l.l_discount as l_discount,
    l.l_orderkey as l_orderkey
from
    `olap_yatests/tpch/s0_1/lineitem` as l
join
    $j2 as j
on
    l.l_suppkey = j.s_suppkey
);
$j4 = (
select
    o.o_orderkey as o_orderkey,
    c.c_nationkey as c_nationkey
from
    `olap_yatests/tpch/s0_1/orders` as o
join
    `olap_yatests/tpch/s0_1/customer` as c
on
    c.c_custkey = o.o_custkey
where
    o.o_orderdate >= $border
    and o.o_orderdate < ($border + Interval("P365D"))
);
$j5 = (
select
    j3.n_name as n_name,
    j3.l_extendedprice as l_extendedprice,
    j3.l_discount as l_discount
from
    $j3 as j3
join
    $j4 as j4
on
    j3.n_nationkey = j4.c_nationkey
    and j3.l_orderkey = j4.o_orderkey
);
select
    n_name,
    sum(l_extendedprice * ($z1_12 - l_discount)) as revenue
from
    $j5
group by
    n_name
order by
    revenue desc;

	iteration 0:	ok	177.232903s seconds
Query06:
Query text:
$z0_0100001_12 = 0.0100001;
$z0_06_12 = 0.06;
$border = Date("1994-01-01");
select
    sum(l_extendedprice * l_discount) as revenue
from
    `olap_yatests/tpch/s0_1/lineitem`
where
    l_shipdate >= $border 
    and l_shipdate < ($border + Interval("P365D"))
    and l_discount between $z0_06_12 - $z0_0100001_12 and $z0_06_12 + $z0_0100001_12
    and l_quantity < 24;

	iteration 0:	ok	117.071579s seconds
Query07:
Query text:
$z1_12 = 1;
$n = select n_name, n_nationkey from `olap_yatests/tpch/s0_1/nation` as n
    where n_name = 'FRANCE' or n_name = 'GERMANY';
$l = select 
    l_orderkey, l_suppkey,
    DateTime::GetYear(cast(l_shipdate as timestamp)) as l_year,
    l_extendedprice * ($z1_12 - l_discount) as volume
from 
    `olap_yatests/tpch/s0_1/lineitem` as l
where 
    l.l_shipdate between Date('1995-01-01') and Date('1996-12-31');
$j1 = select 
    n_name as supp_nation,
    s_suppkey
from 
    `olap_yatests/tpch/s0_1/supplier` as supplier
join 
    $n as n1
on 
    supplier.s_nationkey = n1.n_nationkey;
$j2 = select
    n_name as cust_nation,
    c_custkey
from 
    `olap_yatests/tpch/s0_1/customer` as customer
join 
    $n as n2
on 
    customer.c_nationkey = n2.n_nationkey;
$j3 = select
    cust_nation, o_orderkey
from 
    `olap_yatests/tpch/s0_1/orders` as orders
join 
    $j2 as customer
on 
    orders.o_custkey = customer.c_custkey;
$j4 = select
    cust_nation,
    l_orderkey, l_suppkey,
    l_year,
    volume
from 
    $l as lineitem
join 
    $j3 as orders
on 
    lineitem.l_orderkey = orders.o_orderkey;
$j5 = select
    supp_nation, cust_nation,
    l_year, volume
from 
    $j4 as lineitem
join 
    $j1 as supplier
on 
    lineitem.l_suppkey = supplier.s_suppkey
where (supp_nation = 'FRANCE' and cust_nation = 'GERMANY')
    OR (supp_nation = 'GERMANY' and cust_nation = 'FRANCE');
select
    supp_nation,
    cust_nation,
    l_year, 
    sum(volume) as revenue
from
    $j5 as shipping
group by
    supp_nation,
    cust_nation,
    l_year
order by
    supp_nation,
    cust_nation,
    l_year;

	iteration 0:	ok	129.683581s seconds
Query08:
Query text:
$z0_12 = 0.;
$z1_12 = 1;
$join1 = (
select
    l.l_extendedprice * ($z1_12 - l.l_discount) as volume,
    l.l_suppkey as l_suppkey,
    l.l_orderkey as l_orderkey
from
    `olap_yatests/tpch/s0_1/part` as p
join
    `olap_yatests/tpch/s0_1/lineitem` as l
on
    p.p_partkey = l.l_partkey
where
    p.p_type = 'ECONOMY ANODIZED STEEL'
);
$join2 = (
select
    j.volume as volume,
    j.l_orderkey as l_orderkey,
    s.s_nationkey as s_nationkey
from
    $join1 as j
join
    `olap_yatests/tpch/s0_1/supplier` as s
on
    s.s_suppkey = j.l_suppkey
);
$join3 = (
select
    j.volume as volume,
    j.l_orderkey as l_orderkey,
    n.n_name as nation
from
    $join2 as j
join
    `olap_yatests/tpch/s0_1/nation` as n
on
    n.n_nationkey = j.s_nationkey
);
$join4 = (
select
    j.volume as volume,
    j.nation as nation,
    DateTime::GetYear(cast(o.o_orderdate as Timestamp)) as o_year,
    o.o_custkey as o_custkey
from
    $join3 as j
join
    `olap_yatests/tpch/s0_1/orders` as o
on
    o.o_orderkey = j.l_orderkey
where o_orderdate between Date('1995-01-01') and Date('1996-12-31')
);
$join5 = (
select
    j.volume as volume,
    j.nation as nation,
    j.o_year as o_year,
    c.c_nationkey as c_nationkey
from
    $join4 as j
join
    `olap_yatests/tpch/s0_1/customer` as c
on
    c.c_custkey = j.o_custkey
);
$join6 = (
select
    j.volume as volume,
    j.nation as nation,
    j.o_year as o_year,
    n.n_regionkey as n_regionkey
from
    $join5 as j
join
    `olap_yatests/tpch/s0_1/nation` as n
on
    n.n_nationkey = j.c_nationkey
);
$join7 = (
select
    j.volume as volume,
    j.nation as nation,
    j.o_year as o_year
from
    $join6 as j
join
    `olap_yatests/tpch/s0_1/region` as r
on
    r.r_regionkey = j.n_regionkey
where
    r.r_name = 'AMERICA'
);
select
    o_year,
    sum(case
        when nation = 'BRAZIL' then volume
        else $z0_12
    end) / sum(volume) as mkt_share
from
    $join7 as all_nations
group by
    o_year
order by
    o_year;

	iteration 0:	ok	114.788861s seconds
Query09:
Query text:
$z1_12 = 1;
$p = (select p_partkey, p_name
from
    `olap_yatests/tpch/s0_1/part`
where p_name like '%green%');
$j1 = (select ps_partkey, ps_suppkey, ps_supplycost
from
    `olap_yatests/tpch/s0_1/partsupp` as ps
join $p as p
on ps.ps_partkey = p.p_partkey);
$j2 = (select l_suppkey, l_partkey, l_orderkey, l_extendedprice, l_discount, ps_supplycost, l_quantity
from
    `olap_yatests/tpch/s0_1/lineitem` as l
join $j1 as j
on l.l_suppkey = j.ps_suppkey AND l.l_partkey = j.ps_partkey);
$j3 = (select l_orderkey, s_nationkey, l_extendedprice, l_discount, ps_supplycost, l_quantity
from
    `olap_yatests/tpch/s0_1/supplier` as s
join $j2 as j
on j.l_suppkey = s.s_suppkey);
$j4 = (select o_orderdate, l_extendedprice, l_discount, ps_supplycost, l_quantity, s_nationkey
from
    `olap_yatests/tpch/s0_1/orders` as o
join $j3 as j
on o.o_orderkey = j.l_orderkey);
$j5 = (select n_name, o_orderdate, l_extendedprice, l_discount, ps_supplycost, l_quantity
from
    `olap_yatests/tpch/s0_1/nation` as n
join $j4 as j
on j.s_nationkey = n.n_nationkey
);
$profit = (select 
    n_name as nation,
    DateTime::GetYear(cast(o_orderdate as timestamp)) as o_year,
    l_extendedprice * ($z1_12 - l_discount) - ps_supplycost * l_quantity as amount
from $j5);
select
    nation,
    o_year,
    sum(amount) as sum_profit
from $profit
group by
    nation,
    o_year
order by
    nation,
    o_year desc;

	iteration 0:	ok	137.662815s seconds
Query10:
Query text:
$z1_12 = 1;
$border = Date("1993-10-01");
$join1 = (
select
    c.c_custkey as c_custkey,
    c.c_name as c_name,
    c.c_acctbal as c_acctbal,
    c.c_address as c_address,
    c.c_phone as c_phone,
    c.c_comment as c_comment,
    c.c_nationkey as c_nationkey,
    o.o_orderkey as o_orderkey
from
    `olap_yatests/tpch/s0_1/customer` as c
join
    `olap_yatests/tpch/s0_1/orders` as o
on
    c.c_custkey = o.o_custkey
where
    o.o_orderdate >= $border
    and o.o_orderdate < ($border + Interval("P92D"))
);
$join2 = (
select
    j.c_custkey as c_custkey,
    j.c_name as c_name,
    j.c_acctbal as c_acctbal,
    j.c_address as c_address,
    j.c_phone as c_phone,
    j.c_comment as c_comment,
    j.c_nationkey as c_nationkey,
    l.l_extendedprice as l_extendedprice,
    l.l_discount as l_discount
from
    $join1 as j 
join
    `olap_yatests/tpch/s0_1/lineitem` as l
on
    l.l_orderkey = j.o_orderkey
where
    l.l_returnflag = 'R'
);
$join3 = (
select
    j.c_custkey as c_custkey,
    j.c_name as c_name,
    j.c_acctbal as c_acctbal,
    j.c_address as c_address,
    j.c_phone as c_phone,
    j.c_comment as c_comment,
    j.c_nationkey as c_nationkey,
    j.l_extendedprice as l_extendedprice,
    j.l_discount as l_discount,
    n.n_name as n_name
from
    $join2 as j 
join
    `olap_yatests/tpch/s0_1/nation` as n
on
    n.n_nationkey = j.c_nationkey
);
select
    c_custkey,
    c_name,
    sum(l_extendedprice * ($z1_12 - l_discount)) as revenue,
    c_acctbal,
    n_name,
    c_address,
    c_phone,
    c_comment
from
    $join3
group by
    c_custkey,
    c_name,
    c_acctbal,
    c_phone,
    n_name,
    c_address,
    c_comment
order by
    revenue desc
limit 20;

	iteration 0:	ok	165.873969s seconds
Query11:
Query text:
$z0_0001_35 = 0.0001;
$scale_factor = 0.1;
$j1 = (
select
    s.s_suppkey as s_suppkey
from
    `olap_yatests/tpch/s0_1/supplier` as s
join
    `olap_yatests/tpch/s0_1/nation` as n
on
    n.n_nationkey = s.s_nationkey
where
    n.n_name = 'GERMANY'
);
$j2 = (
select
    ps.ps_partkey as ps_partkey,
    ps.ps_supplycost as ps_supplycost,
    ps.ps_availqty as ps_availqty
from
    `olap_yatests/tpch/s0_1/partsupp` as ps
join
    $j1 as j
on
    ps.ps_suppkey = j.s_suppkey
);
$threshold = (
select
    sum(ps_supplycost * ps_availqty) * $z0_0001_35 / $scale_factor as threshold
from
    $j2
);
$values = (
select
    ps_partkey,
    sum(ps_supplycost * ps_availqty) as value
from
    $j2
group by
    ps_partkey
);
select
    v.ps_partkey as ps_partkey,
    v.value as value
from
    $values as v
cross join
    $threshold as t
where
    v.value > t.threshold
order by
    value desc;

	iteration 0:	ok	67.904836s seconds
Query12:
Query text:
$join = (
    select
        l.l_shipmode as l_shipmode,
        o.o_orderpriority as o_orderpriority,
        l.l_commitdate as l_commitdate,
        l.l_shipdate as l_shipdate,
        l.l_receiptdate as l_receiptdate
    from
        `olap_yatests/tpch/s0_1/orders` as o
        join `olap_yatests/tpch/s0_1/lineitem` as l
        on o.o_orderkey = l.l_orderkey
);
$border = Date("1994-01-01");
select
    l_shipmode,
    sum(case
        when o_orderpriority = '1-URGENT'
            or o_orderpriority = '2-HIGH'
            then 1
        else 0
    end) as high_line_count,
    sum(case
        when o_orderpriority <> '1-URGENT'
            and o_orderpriority <> '2-HIGH'
            then 1
        else 0
    end) as low_line_count
from $join
where
    (l_shipmode = 'MAIL' or l_shipmode = 'SHIP')
    and l_commitdate < l_receiptdate
    and l_shipdate < l_commitdate
    and l_receiptdate >= $border
    and l_receiptdate < ($border + Interval("P365D"))
group by
    l_shipmode
order by
    l_shipmode;

	iteration 0:	ok	92.547396s seconds
Query13:
Query text:
$orders = (
    select
        o_orderkey,
        o_custkey
    from
        `olap_yatests/tpch/s0_1/orders`
    where
        o_comment NOT LIKE "%special%requests%"
);
select
    c_count as c_count,
    count(*) as custdist
from
    (
        select
            c.c_custkey as c_custkey,
            count(o.o_orderkey) as c_count
        from
            `olap_yatests/tpch/s0_1/customer` as c left outer join $orders as o on
                c.c_custkey = o.o_custkey
        group by
            c.c_custkey
    ) as c_orders
group by
    c_count
order by
    custdist desc,
    c_count desc;

	iteration 0:	ok	89.141171s seconds
Query14:
Query text:
$z100_35 = 100.;
$z0_12 = 0.;
$z1_12 = 1;
$border = Date("1995-09-01");
select
    $z100_35 * sum(case
        when p.p_type like 'PROMO%'
            then l.l_extendedprice * ($z1_12 - l.l_discount)
        else $z0_12
    end) / sum(l.l_extendedprice * ($z1_12 - l.l_discount)) as promo_revenue
from
    `olap_yatests/tpch/s0_1/lineitem` as l
join
    `olap_yatests/tpch/s0_1/part` as p
on
    l.l_partkey = p.p_partkey
where
    l.l_shipdate >= $border
    and l.l_shipdate < ($border + Interval("P30D"));

	iteration 0:	ok	159.435712s seconds
Query15:
Query text:
$z1_12 = 1;
$round = ($x, $y) -> { return Math::Round($x, $y); };
$border = Date("1996-01-01");
$revenue0 = (
    select
        l_suppkey as supplier_no,
        $round(sum(l_extendedprice * ($z1_12 - l_discount)), -8) as total_revenue
    from
        `olap_yatests/tpch/s0_1/lineitem`
    where
        l_shipdate  >= $border
        and l_shipdate < ($border + Interval("P91D"))
    group by
        l_suppkey
);
$max_revenue = (
select
    max(total_revenue) as max_revenue
from
    $revenue0
);
$join1 = (
select
    s.s_suppkey as s_suppkey,
    s.s_name as s_name,
    s.s_address as s_address,
    s.s_phone as s_phone,
    r.total_revenue as total_revenue
from
    `olap_yatests/tpch/s0_1/supplier` as s
join
    $revenue0 as r
on
    s.s_suppkey = r.supplier_no
);
select
    j.s_suppkey as s_suppkey,
    j.s_name as s_name,
    j.s_address as s_address,
    j.s_phone as s_phone,
    j.total_revenue as total_revenue
from
    $join1 as j
join
    $max_revenue as m
on
    j.total_revenue = m.max_revenue
order by
    s_suppkey;

	iteration 0:	ok	143.539140s seconds
Query16:
Query text:
$p = (
select
    p.p_brand as p_brand,
    p.p_type as p_type,
    p.p_size as p_size,
    ps.ps_suppkey as ps_suppkey
from
    `olap_yatests/tpch/s0_1/part` as p
join
    `olap_yatests/tpch/s0_1/partsupp` as ps
on
    p.p_partkey = ps.ps_partkey
where
    p.p_brand <> 'Brand#45'
    and p.p_type not like 'MEDIUM POLISHED%'
    and (p.p_size = 49 or p.p_size = 14 or p.p_size = 23 or p.p_size = 45 or p.p_size = 19 or p.p_size = 3 or p.p_size = 36 or p.p_size = 9)
);
$s = (
select
    s_suppkey
from
    `olap_yatests/tpch/s0_1/supplier`
where
    s_comment like "%Customer%Complaints%"
);
$j = (
select
    p.p_brand as p_brand,
    p.p_type as p_type,
    p.p_size as p_size,
    p.ps_suppkey as ps_suppkey
from
    $p as p
left only join
    $s as s
on
    p.ps_suppkey = s.s_suppkey
);
select
    j.p_brand as p_brand,
    j.p_type as p_type,
    j.p_size as p_size,
    count(distinct j.ps_suppkey) as supplier_cnt
from
    $j as j
group by
    j.p_brand,
    j.p_type,
    j.p_size
order by
    supplier_cnt desc,
    p_brand,
    p_type,
    p_size
;

	iteration 0:	ok	43.215706s seconds
Query17:
Query text:
$z7_35 = 7.;
$z0_2_12 = 0.2;
$p = select p_partkey from `olap_yatests/tpch/s0_1/part`
where
    p_brand = 'Brand#23'
    and p_container = 'MED BOX'
;
$threshold = (
select
    $z0_2_12 * avg(l_quantity) as threshold,
    l.l_partkey as l_partkey
from
    `olap_yatests/tpch/s0_1/lineitem` as l
left semi join
    $p as p
on  
    p.p_partkey = l.l_partkey
group by
    l.l_partkey
);
$l = select l.l_partkey as l_partkey, l.l_quantity as l_quantity, l.l_extendedprice as l_extendedprice
from
    `olap_yatests/tpch/s0_1/lineitem` as l
join
    $p as p
on  
    p.p_partkey = l.l_partkey;
select
    sum(l.l_extendedprice) / $z7_35 as avg_yearly
from
    $l as l
join
    $threshold as t
on  
    t.l_partkey = l.l_partkey
where
    l.l_quantity < t.threshold;

	iteration 0:	ok	111.820060s seconds
Query18:
Query text:
$in = (
select
    l_orderkey,
    sum(l_quantity) as sum_l_quantity
from
    `olap_yatests/tpch/s0_1/lineitem`
group by
    l_orderkey having
        sum(l_quantity) > 300
);
$join1 = (
select
    c.c_name as c_name,
    c.c_custkey as c_custkey,
    o.o_orderkey as o_orderkey,
    o.o_orderdate as o_orderdate,
    o.o_totalprice as o_totalprice
from
    `olap_yatests/tpch/s0_1/customer` as c
join
    `olap_yatests/tpch/s0_1/orders` as o
on
    c.c_custkey = o.o_custkey
);
select
    j.c_name as c_name,
    j.c_custkey as c_custkey,
    j.o_orderkey as o_orderkey,
    j.o_orderdate as o_orderdate,
    j.o_totalprice as o_totalprice,
    sum(i.sum_l_quantity) as sum_l_quantity
from
    $join1 as j
join
    $in as i
on
    i.l_orderkey = j.o_orderkey
group by
    j.c_name,
    j.c_custkey,
    j.o_orderkey,
    j.o_orderdate,
    j.o_totalprice
order by
    o_totalprice desc,
    o_orderdate,
    o_orderkey
limit 100;

	iteration 0:	ok	100.307281s seconds
Query19:
Query text:
$z1_12 = 1;
select
    sum(l.l_extendedprice* ($z1_12 - l.l_discount)) as revenue
from
    `olap_yatests/tpch/s0_1/lineitem` as l
join
    `olap_yatests/tpch/s0_1/part` as p
on
    p.p_partkey = l.l_partkey
where
    (
        p.p_brand = 'Brand#12'
        and (p.p_container = 'SM CASE' or p.p_container = 'SM BOX' or p.p_container = 'SM PACK' or p.p_container = 'SM PKG')
        and l.l_quantity >= 1 and l.l_quantity <= 1 + 10
        and p.p_size between 1 and 5
        and (l.l_shipmode = 'AIR' or l.l_shipmode = 'AIR REG')
        and l.l_shipinstruct = 'DELIVER IN PERSON'
    )
    or
    (
        p.p_brand = 'Brand#23'
        and (p.p_container = 'MED BAG' or p.p_container = 'MED BOX' or p.p_container = 'MED PKG' or p.p_container = 'MED PACK')
        and l.l_quantity >= 10 and l.l_quantity <= 10 + 10
        and p.p_size between 1 and 10
        and (l.l_shipmode = 'AIR' or l.l_shipmode = 'AIR REG')
        and l.l_shipinstruct = 'DELIVER IN PERSON'
    )
    or
    (
        p.p_brand = 'Brand#34'
        and (p.p_container = 'LG CASE' or p.p_container = 'LG BOX' or p.p_container = 'LG PACK' or p.p_container = 'LG PKG')
        and l.l_quantity >= 20 and l.l_quantity <= 20 + 10
        and p.p_size between 1 and 15
        and (l.l_shipmode = 'AIR' or l.l_shipmode = 'AIR REG')
        and l.l_shipinstruct = 'DELIVER IN PERSON'
    );

	iteration 0:	ok	110.410306s seconds
Query20:
Query text:
$z0_5_35 = 0.5;
$border = Date("1994-01-01");
$threshold = (
select
    $z0_5_35 * sum(l_quantity) as threshold,
    l_partkey as l_partkey,
    l_suppkey as l_suppkey
from
    `olap_yatests/tpch/s0_1/lineitem`
where
    l_shipdate >= $border
    and l_shipdate < ($border + Interval("P365D"))
group by
    l_partkey, l_suppkey
);
$parts = (
select
    p_partkey
from
    `olap_yatests/tpch/s0_1/part`
where
    p_name like 'forest%'
);
$join1 = (
select
    ps.ps_suppkey as ps_suppkey,
    ps.ps_availqty as ps_availqty,
    ps.ps_partkey as ps_partkey
from
    `olap_yatests/tpch/s0_1/partsupp` as ps
join any
    $parts as p
on
    ps.ps_partkey = p.p_partkey
);
$join2 = (
select
    distinct(j.ps_suppkey) as ps_suppkey
from
    $join1 as j
join any
    $threshold as t
on
    j.ps_partkey = t.l_partkey and j.ps_suppkey = t.l_suppkey
where
    j.ps_availqty > t.threshold
);
$join3 = (
select
    j.ps_suppkey as ps_suppkey,
    s.s_name as s_name,
    s.s_address as s_address,
    s.s_nationkey as s_nationkey
from
    $join2 as j
join any
    `olap_yatests/tpch/s0_1/supplier` as s
on
    j.ps_suppkey = s.s_suppkey
);
select
    j.s_name as s_name,
    j.s_address as s_address
from
    $join3 as j
join
    `olap_yatests/tpch/s0_1/nation` as n
on
    j.s_nationkey = n.n_nationkey
where
    n.n_name = 'CANADA'
order by
    s_name;

	iteration 0:	ok	159.781037s seconds
Query21:
Query text:
$n = select n_nationkey from `olap_yatests/tpch/s0_1/nation`
where n_name = 'SAUDI ARABIA';
$s = select s_name, s_suppkey from `olap_yatests/tpch/s0_1/supplier` as supplier
join $n as nation
on supplier.s_nationkey = nation.n_nationkey;
$l = select l_suppkey, l_orderkey from `olap_yatests/tpch/s0_1/lineitem`
where l_receiptdate > l_commitdate;
$j1 = select s_name, l_suppkey, l_orderkey from $l as l1
join $s as supplier
on l1.l_suppkey = supplier.s_suppkey;
$j2 = select l1.l_orderkey as l_orderkey, l1.l_suppkey as l_suppkey, l1.s_name as s_name, l2.l_receiptdate as l_receiptdate, l2.l_commitdate as l_commitdate from $j1 as l1
join `olap_yatests/tpch/s0_1/lineitem` as l2
on l1.l_orderkey = l2.l_orderkey
where l2.l_suppkey <> l1.l_suppkey;
$j2_1 = select s_name, l1.l_suppkey as l_suppkey, l1.l_orderkey as l_orderkey from $j1 as l1
left semi join $j2 as l2
on l1.l_orderkey = l2.l_orderkey;
$j2_2 = select l_orderkey from $j2 where l_receiptdate > l_commitdate;
$j3 = select s_name, l_suppkey, l_orderkey from $j2_1 as l1
left only join $j2_2 as l3
on l1.l_orderkey = l3.l_orderkey;
$j4 = select s_name from $j3 as l1
join `olap_yatests/tpch/s0_1/orders` as orders
on orders.o_orderkey = l1.l_orderkey
where o_orderstatus = 'F';
select s_name,
    count(*) as numwait from $j4
group by
    s_name
order by
    numwait desc,
    s_name
limit 100;

	iteration 0:	ok	92.140517s seconds
Query22:
Query text:
$z0_12 = 0.;
$customers = (
select
    c_acctbal,
    c_custkey,
    Substring(CAST(c_phone AS STRING), 0u, 2u) as cntrycode
from
    `olap_yatests/tpch/s0_1/customer`
);
$c = (
select
    c_acctbal,
    c_custkey,
    cntrycode
from
    $customers
where
    cntrycode = '13' or cntrycode = '31' or cntrycode = '23' or cntrycode = '29' or cntrycode = '30' or cntrycode = '18' or cntrycode = '17'
);
$avg = (
select
    avg(c_acctbal) as a
from
    $c
where
    c_acctbal > $z0_12
);
$join1 = (
select
    c.c_acctbal as c_acctbal,
    c.c_custkey as c_custkey,
    c.cntrycode as cntrycode
from
    $c as c
cross join
    $avg as a
where
    c.c_acctbal > a.a
);
$join2 = (
select
    j.cntrycode as cntrycode,
    c_custkey,
    j.c_acctbal as c_acctbal
from
    $join1 as j
left only join 
    `olap_yatests/tpch/s0_1/orders` as o
on
    o.o_custkey = j.c_custkey
);
select
    cntrycode,
    count(*) as numcust,
    sum(c_acctbal) as totacctbal
from
    $join2 as custsale
group by
    cntrycode
order by
    cntrycode;

	iteration 0:	ok	72.022588s seconds

Results for 1 iterations
┌─────────┬──────────┬──────────┬──────────┬──────────┬──────────┬───────────┬─────────┬─────────┬─────────┬─────────┬────────────────┬────────────────┬────────────────┬───────────┬──────────────┬────────────┬────────────┐
│ Query # │ ColdTime │ Min      │ Max      │ Mean     │ Median   │ UnixBench │ Std     │ RttMin  │ RttMax  │ RttAvg  │ CompilationMin │ CompilationMax │ CompilationAvg │ GrossTime │ SuccessCount │ FailsCount │ DiffsCount │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query01 │ 137.594  │ 137.594  │ 137.594  │ 137.594  │ 137.593  │ 137.594   │   0.001 │   0.689 │   0.689 │   0.689 │   4.700        │   4.700        │   4.700        │ 138.282   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query02 │  54.300  │  54.300  │  54.300  │  54.300  │  54.300  │  54.300   │   0.000 │   2.414 │   2.414 │   2.414 │  14.199        │  14.199        │  14.199        │  56.714   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query03 │  79.979  │  79.979  │  79.979  │  79.979  │  79.978  │  79.979   │   0.001 │   1.775 │   1.775 │   1.775 │  10.610        │  10.610        │  10.610        │  81.753   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query04 │  99.853  │  99.853  │  99.853  │  99.853  │  99.852  │  99.853   │   0.001 │   1.009 │   1.009 │   1.009 │   8.758        │   8.758        │   8.758        │ 100.862   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query05 │ 174.298  │ 174.298  │ 174.298  │ 174.298  │ 174.297  │ 174.298   │   0.001 │   2.935 │   2.935 │   2.935 │   7.370        │   7.370        │   7.370        │ 177.233   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query06 │ 114.938  │ 114.938  │ 114.938  │ 114.938  │ 114.937  │ 114.938   │   0.001 │   2.134 │   2.134 │   2.134 │   3.713        │   3.713        │   3.713        │ 117.072   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query07 │ 128.589  │ 128.589  │ 128.589  │ 128.589  │ 128.588  │ 128.589   │   0.001 │   1.095 │   1.095 │   1.095 │   8.681        │   8.681        │   8.681        │ 129.684   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query08 │ 112.610  │ 112.610  │ 112.610  │ 112.610  │ 112.610  │ 112.610   │   0.000 │   2.179 │   2.179 │   2.179 │  12.487        │  12.487        │  12.487        │ 114.789   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query09 │ 136.708  │ 136.708  │ 136.708  │ 136.708  │ 136.708  │ 136.708   │   0.000 │   0.955 │   0.955 │   0.955 │   8.450        │   8.450        │   8.450        │ 137.663   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query10 │ 163.067  │ 163.067  │ 163.067  │ 163.067  │ 163.066  │ 163.067   │   0.001 │   2.807 │   2.807 │   2.807 │   4.803        │   4.803        │   4.803        │ 165.874   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query11 │  67.030  │  67.030  │  67.030  │  67.030  │  67.029  │  67.030   │   0.001 │   0.875 │   0.875 │   0.875 │   8.925        │   8.925        │   8.925        │  67.905   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query12 │  91.550  │  91.550  │  91.550  │  91.550  │  91.549  │  91.550   │   0.001 │   0.998 │   0.998 │   0.998 │  10.886        │  10.886        │  10.886        │  92.547   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query13 │  88.078  │  88.078  │  88.078  │  88.078  │  88.078  │  88.078   │   0.000 │   1.063 │   1.063 │   1.063 │   7.617        │   7.617        │   7.617        │  89.141   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query14 │ 158.928  │ 158.928  │ 158.928  │ 158.928  │ 158.928  │ 158.928   │   0.000 │   0.508 │   0.508 │   0.508 │   5.010        │   5.010        │   5.010        │ 159.436   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query15 │ 142.929  │ 142.929  │ 142.929  │ 142.929  │ 142.929  │ 142.929   │   0.000 │   0.610 │   0.610 │   0.610 │   5.709        │   5.709        │   5.709        │ 143.539   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query16 │  41.628  │  41.628  │  41.628  │  41.628  │  41.628  │  41.628   │   0.000 │   1.588 │   1.588 │   1.588 │   6.203        │   6.203        │   6.203        │  43.216   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query17 │ 109.408  │ 109.408  │ 109.408  │ 109.408  │ 109.408  │ 109.408   │   0.000 │   2.412 │   2.412 │   2.412 │   2.589        │   2.589        │   2.589        │ 111.820   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query18 │  99.024  │  99.024  │  99.024  │  99.024  │  99.023  │  99.024   │   0.001 │   1.284 │   1.284 │   1.284 │   6.731        │   6.731        │   6.731        │ 100.307   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query19 │ 109.278  │ 109.278  │ 109.278  │ 109.278  │ 109.277  │ 109.278   │   0.001 │   1.133 │   1.133 │   1.133 │   5.080        │   5.080        │   5.080        │ 110.410   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query20 │ 158.566  │ 158.566  │ 158.566  │ 158.566  │ 158.566  │ 158.566   │   0.000 │   1.215 │   1.215 │   1.215 │  11.471        │  11.471        │  11.471        │ 159.781   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query21 │  90.285  │  90.285  │  90.285  │  90.285  │  90.284  │  90.285   │   0.001 │   1.856 │   1.856 │   1.856 │  12.220        │  12.220        │  12.220        │  92.141   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Query22 │  69.112  │  69.112  │  69.112  │  69.112  │  69.112  │  69.112   │   0.000 │   2.910 │   2.910 │   2.910 │   4.050        │   4.050        │   4.050        │  72.023   │ 1            │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Sum     │ 2427.751 │ 2427.751 │ 2427.751 │ 2427.751 │ 2427.740 │ 2427.751  │   0.000 │  34.441 │  34.441 │  34.441 │ 170.263        │ 170.263        │ 170.264        │ 284.539   │ 22           │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ Avg     │ 110.352  │ 110.352  │ 110.352  │ 110.352  │ 110.352  │ 110.352   │   0.000 │   1.565 │   1.565 │   1.565 │   7.739        │   7.739        │   7.739        │  12.934   │ 22           │            │            │
├─────────┼──────────┼──────────┼──────────┼──────────┼──────────┼───────────┼─────────┼─────────┼─────────┼─────────┼────────────────┼────────────────┼────────────────┼───────────┼──────────────┼────────────┼────────────┤
│ GAvg    │ 103.879  │ 103.879  │ 103.879  │ 103.879  │ 103.879  │ 103.879   │   0.000 │   1.383 │   1.383 │   0.001 │   7.074        │   7.074        │   0.001        │   0.000   │ 22           │            │            │
└─────────┴──────────┴──────────┴──────────┴──────────┴──────────┴───────────┴─────────┴─────────┴─────────┴─────────┴────────────────┴────────────────┴────────────────┴───────────┴──────────────┴────────────┴────────────┘

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

2025-11-03 10:00:31,059 - DEBUG - ya.test - _save_outputs: Command (pid 1368395) errors:

[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
[K
2025-11-03 10:00:31,060 - DEBUG - ya.test - verify_sanitize_errors: No sanitizer errors found
2025-11-03 10:00:34,531 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:34,558 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes HTTP/1.1" 200 792
2025-11-03 10:00:34,581 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:34,600 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 10:00:34,629 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 555
2025-11-03 10:00:34,643 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:34,682 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 10:00:34,710 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 555
2025-11-03 10:00:36,843 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:36,862 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes HTTP/1.1" 200 801
2025-11-03 10:00:36,870 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:36,884 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 10:00:36,925 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 554
2025-11-03 10:00:36,928 - INFO - root - __create_iterations_table: All nodes before filtering: [('20365@ghrun-mh4kzsenyi.auto.internal', <Role.UNKNOWN: 0>)]
2025-11-03 10:00:36,929 - INFO - root - __create_iterations_table: Auto-discovered hosts (all roles): 1 hosts from 1 total nodes
2025-11-03 10:00:36,929 - INFO - root - __create_iterations_table: Host to nodes mapping: [('ghrun-mh4kzsenyi.auto.internal', 1)]
2025-11-03 10:00:36,934 - INFO - root - allure_test_description: iterations_table created, length: 515
2025-11-03 10:00:36,935 - INFO - root - allure_test_description: Added iterations table to description HTML
2025-11-03 10:00:37,599 - DEBUG - matplotlib - wrapper: CACHEDIR=/home/runner/.cache/matplotlib
2025-11-03 10:00:37,612 - DEBUG - matplotlib.font_manager - _load_fontmanager: Using fontManager instance from /home/runner/.cache/matplotlib/fontlist-v330.json
2025-11-03 10:00:39,031 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs"
2025-11-03 10:00:39,032 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/oa3o/000d62/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/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/node_1/logfile_b3n92y0o.log --grpc-port=28762 --mon-port=27282 --ic-port=4041
2025-11-03 10:00:39,032 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:28762/1
2025-11-03 10:00:39,034 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.3
2025-11-03 10:00:39,035 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.3
2025-11-03 10:00:39,036 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-03 10:00:39,038 - DEBUG - ya.test - execute: Command pid: 1424267
2025-11-03 10:00:40,053 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) rc: 0
2025-11-03 10:00:40,053 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) elapsed time (sec): 1.0132505893707275
2025-11-03 10:00:40,054 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) idrss: 0
2025-11-03 10:00:40,054 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) inblock: 0
2025-11-03 10:00:40,055 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) isrss: 0
2025-11-03 10:00:40,055 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) ixrss: 0
2025-11-03 10:00:40,055 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) majflt: 0
2025-11-03 10:00:40,056 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) maxrss: 829444
2025-11-03 10:00:40,056 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) minflt: 45331
2025-11-03 10:00:40,056 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) msgrcv: 0
2025-11-03 10:00:40,057 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) msgsnd: 0
2025-11-03 10:00:40,057 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) nivcsw: 173
2025-11-03 10:00:40,057 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) nsignals: 0
2025-11-03 10:00:40,060 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) nswap: 0
2025-11-03 10:00:40,060 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) nvcsw: 13
2025-11-03 10:00:40,061 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) oublock: 8
2025-11-03 10:00:40,061 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) stime: 0.17146599999999998
2025-11-03 10:00:40,062 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) utime: 0.505285
2025-11-03 10:00:40,062 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) wtime: 1.016
2025-11-03 10:00:40,062 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) output:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mh4kzsenyi
    Host information: 
        Linux ghrun-mh4kzsenyi 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-03 10:00:40,063 - DEBUG - ya.test - _save_outputs: Command (pid 1424267) errors:

2025-11-03 10:00:40,065 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e
2025-11-03 10:00:40,066 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: CFG_DIR_PATH="/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/kikimr_configs"
2025-11-03 10:00:40,066 - INFO - ydb.tests.library.harness.kikimr_runner - __make_run_command: Final command: /home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd server --suppress-version-check --yaml-config=$CFG_DIR_PATH/config.yaml --node-broker=localhost:28762 --tenant=/local/test_db --log-file-name=/home/runner/.ya/build/build_root/oa3o/000d62/ydb/tests/functional/tpc/medium/tpch/test-results/py3test/testing_out_stuff/test_parallel/testing_out_stuff/test_parallel.py.TestTpchParallelS0_1T10.test.Query01/cluster/slot_1/logfile__jwtqhb9.log --grpc-port=2928 --mon-port=22319 --ic-port=20365
2025-11-03 10:00:40,067 - INFO - ydb.tests.library.harness.kikimr_runner - start: Started node localhost:2928/1
2025-11-03 10:00:40,070 - DEBUG - ya.test - _get_command_output_file: Command out will be placed to ydbd.out.4
2025-11-03 10:00:40,071 - DEBUG - ya.test - _get_command_output_file: Command err will be placed to ydbd.err.4
2025-11-03 10:00:40,072 - DEBUG - ya.test - execute: Executing '['/home/runner/.ya/build/build_root/oa3o/000d62/ydb/apps/ydbd/ydbd', '-V']' in 'None' (waiting)
2025-11-03 10:00:40,094 - DEBUG - ya.test - execute: Command pid: 1424388
2025-11-03 10:00:40,938 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) rc: 0
2025-11-03 10:00:40,939 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) elapsed time (sec): 0.8427643775939941
2025-11-03 10:00:40,939 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) idrss: 0
2025-11-03 10:00:40,940 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) inblock: 0
2025-11-03 10:00:40,940 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) isrss: 0
2025-11-03 10:00:40,940 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) ixrss: 0
2025-11-03 10:00:40,941 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) majflt: 0
2025-11-03 10:00:40,941 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) maxrss: 829444
2025-11-03 10:00:40,941 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) minflt: 45364
2025-11-03 10:00:40,947 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) msgrcv: 0
2025-11-03 10:00:40,948 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) msgsnd: 0
2025-11-03 10:00:40,948 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) nivcsw: 154
2025-11-03 10:00:40,948 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) nsignals: 0
2025-11-03 10:00:40,949 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) nswap: 0
2025-11-03 10:00:40,949 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) nvcsw: 14
2025-11-03 10:00:40,949 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) oublock: 8
2025-11-03 10:00:40,949 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) stime: 0.22691899999999998
2025-11-03 10:00:40,950 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) utime: 0.466202
2025-11-03 10:00:40,951 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) wtime: 0.865
2025-11-03 10:00:40,952 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) output:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e

Other info:
    Build by: runner
    Top src dir: /home/runner/actions_runner/_work/ydb/ydb
    Top build dir: /home/runner/.ya/build
    Hostname: ghrun-mh4kzsenyi
    Host information: 
        Linux ghrun-mh4kzsenyi 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-03 10:00:40,952 - DEBUG - ya.test - _save_outputs: Command (pid 1424388) errors:

2025-11-03 10:00:40,953 - INFO - ydb.tests.library.harness.kikimr_runner - start: Node 1 version:
Git info:
    Commit: 7474ee92b939097df91b2c8b83ab73b5ef4c35f3
    Branch: 
    Author: Pisarenko Grigoriy <grigoriypisar@ydb.tech>
    Summary: Merge 369c90d1e9f0af1fc543bd61e9a44167f3d3c11c into d9296557d60450f010fbc580016b144ca30d423e
2025-11-03 10:00:41,020 - INFO - ya.test - pytest_runtest_call: Test call (class_name: test_parallel.py::TestTpchParallelS0_1T10, test_name: test[Query01])
2025-11-03 10:00:41,057 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:41,087 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes HTTP/1.1" 200 793
2025-11-03 10:00:41,102 - DEBUG - urllib3.connectionpool - _new_conn: Starting new HTTP connection (1): localhost:27282
2025-11-03 10:00:41,109 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /viewer/json/nodes?database=/local/test_db HTTP/1.1" 307 0
2025-11-03 10:00:41,130 - DEBUG - urllib3.connectionpool - _make_request: http://localhost:27282 "GET /node/50000/viewer/json/nodes?database=/local/test_db HTTP/1.1" 200 557
2025-11-03 10:00:41,133 - INFO - root - __create_iterations_table: All nodes before filtering: [('20365@ghrun-mh4kzsenyi.auto.internal', <Role.UNKNOWN: 0>)]
2025-11-03 10:00:41,142 - INFO - root - __create_iterations_table: Auto-discovered hosts (all roles): 1 hosts from 1 total nodes
2025-11-03 10:00:41,142 - INFO - root - __create_iterations_table: Host to nodes mapping: [('ghrun-mh4kzsenyi.auto.internal', 1)]
2025-11-03 10:00:41,143 - INFO - root - allure_test_description: iterations_table created, length: 515
2025-11-03 10:00:41,143 - INFO - root - allure_test_description: Added iterations table to description HTML
2025-11-03 10:00:41,150 - INFO - ya.test - pytest_runtest_teardown: Test teardown
