dqrun ABI version: 2.44.0
2025-12-06 03:04:22.554 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [default] storage.cpp:189: FileStorage initialized in "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmppHdrjt/", temporary dir: "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmppHdrjt/3235530", locks dir:"/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmppHdrjt/locks", files: 0, total size: 0
2025-12-06 03:04:22.561 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [generic] client.cpp:436: Connector[default] endpoint: grpcs://connector.yqv2-dev.cloud.yandex.net:50051
2025-12-06 03:04:22.575 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [http gw] yql_dns_gateway.h:85: Filled DNS resolution table based on provided configuration
2025-12-06 03:04:22.575 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [http gw] yql_dns_gateway.h:126: Started DNS table update
2025-12-06 03:04:22.579 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] interconnect_helpers.cpp:215: Start listener ::1:31337 socket: 18
2025-12-06 03:04:22.604 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] service_node.cpp:126: Starting GRPC on 31338
GRpc memory quota was set but disabled due to issues with grpc quoter, to enable it use EnableGRpcMemoryQuota option
Parse SQL...
Compile program...
2025-12-06 03:04:22.747 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [generic] yql_generic_settings.cpp:61: GenericConfiguration::AddCluster: name = ydb_dev, kind = YDB, database name = , database id = etnejle6hb72cdr6aqps, endpoint = {  }, use tls = 1, protocol = NATIVE
Run program...
2025-12-06 03:04:22.751 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_dq_gateway.cpp:605: {dummy_op} OpenSession
2025-12-06 03:04:22.757 INFO  dqrun(pid=3235530, tid=0x00007FE3C82FD640) [DQ] yql_dq_gateway.cpp:633: {dummy_op} OpenSession OK
2025-12-06 03:04:22.759 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok
2025-12-06 03:04:22.760 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/nation/,.Pattern=h/1/nation/*,.PatternType=Wildcard,.Credentials=TS3Credentials{.ServiceAccountAuth=1,.AwsUserPwd=<some token with length0>,.AwsSigV4=<some sig with length0>}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0}
2025-12-06 03:04:22.761 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:236: {dummy_op} [TCompositeS3ListingStrategy] Strategy successfully listed paths. Returning result: 1 objects, 0 path prefixes
2025-12-06 03:04:22.761 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 1 entries
2025-12-06 03:04:22.761 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/orders/,.Pattern=h/1/orders/*,.PatternType=Wildcard,.Credentials=TS3Credentials{.ServiceAccountAuth=1,.AwsUserPwd=<some token with length0>,.AwsSigV4=<some sig with length0>}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0}
2025-12-06 03:04:22.762 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:236: {dummy_op} [TCompositeS3ListingStrategy] Strategy successfully listed paths. Returning result: 30 objects, 0 path prefixes
2025-12-06 03:04:22.762 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries
2025-12-06 03:04:22.762 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/supplier/,.Pattern=h/1/supplier/*,.PatternType=Wildcard,.Credentials=TS3Credentials{.ServiceAccountAuth=1,.AwsUserPwd=<some token with length0>,.AwsSigV4=<some sig with length0>}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0}
2025-12-06 03:04:22.763 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:236: {dummy_op} [TCompositeS3ListingStrategy] Strategy successfully listed paths. Returning result: 30 objects, 0 path prefixes
2025-12-06 03:04:22.763 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 30 entries
2025-12-06 03:04:22.763 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/lineitem/,.Pattern=h/1/lineitem/*,.PatternType=Wildcard,.Credentials=TS3Credentials{.ServiceAccountAuth=1,.AwsUserPwd=<some token with length0>,.AwsSigV4=<some sig with length0>}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0}
2025-12-06 03:04:22.764 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:236: {dummy_op} [TCompositeS3ListingStrategy] Strategy successfully listed paths. Returning result: 30 objects, 0 path prefixes
2025-12-06 03:04:22.764 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 30 entries
2025-12-06 03:04:22.764 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/partsupp/,.Pattern=h/1/partsupp/*,.PatternType=Wildcard,.Credentials=TS3Credentials{.ServiceAccountAuth=1,.AwsUserPwd=<some token with length0>,.AwsSigV4=<some sig with length0>}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0}
2025-12-06 03:04:22.765 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:236: {dummy_op} [TCompositeS3ListingStrategy] Strategy successfully listed paths. Returning result: 30 objects, 0 path prefixes
2025-12-06 03:04:22.765 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries
2025-12-06 03:04:22.765 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/part/,.Pattern=h/1/part/*,.PatternType=Wildcard,.Credentials=TS3Credentials{.ServiceAccountAuth=1,.AwsUserPwd=<some token with length0>,.AwsSigV4=<some sig with length0>}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0}
2025-12-06 03:04:22.767 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:236: {dummy_op} [TCompositeS3ListingStrategy] Strategy successfully listed paths. Returning result: 30 objects, 0 path prefixes
2025-12-06 03:04:22.767 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries
2025-12-06 03:04:22.767 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/partsupp/* has 30 items with total size 34281114
2025-12-06 03:04:22.768 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/supplier/* has 30 items with total size 825819
2025-12-06 03:04:22.768 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/lineitem/* has 30 items with total size 188300741
2025-12-06 03:04:22.769 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/part/* has 30 items with total size 6089692
2025-12-06 03:04:22.769 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/orders/* has 30 items with total size 54575075
2025-12-06 03:04:22.769 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/nation/* has 1 items with total size 5031
2025-12-06 03:04:22.770 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok
2025-12-06 03:04:22.773 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [RESULT] yql_result_provider.cpp:1415: {dummy_op} RewriteIO
2025-12-06 03:04:22.901 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [RESULT] yql_result_provider.cpp:1154: {dummy_op} Setting result column order: [(nation->nation), (o_year->o_year), (sum_profit->sum_profit)]
2025-12-06 03:04:22.981 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:04:22.981 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:04:22.983 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:04:22.983 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:04:22.985 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:04:22.985 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:04:22.986 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_dq_recapture.cpp:111: {dummy_op} DqsRecapture
2025-12-06 03:04:22.999 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:04:22.999 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:04:23.000 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:04:23.015 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.019 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:04:23.031 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.033 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:04:23.044 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.046 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:04:23.055 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.056 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:04:23.065 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.066 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:04:23.073 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.074 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:04:23.079 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 151 files with total size 284077472 bytes
2025-12-06 03:04:23.079 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:04:23.080 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:04:23.080 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:04:23.080 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:04:23.080 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:04:23.081 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:04:23.090 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin
2025-12-06 03:04:23.112 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:04:23.120 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:04:23.129 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:04:23.141 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:04:23.152 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:04:23.163 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:04:23.174 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushExtractMembersToStage<false>
2025-12-06 03:04:23.193 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:04:23.201 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:04:23.208 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:04:23.215 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:04:23.231 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushCombineToStage<false>
2025-12-06 03:04:23.246 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:04:23.253 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:04:23.272 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildShuffleStage<false>
2025-12-06 03:04:23.281 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildSortStage<false>
2025-12-06 03:04:23.303 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [RESULT] yql_result_provider.cpp:771: {dummy_op} ResPull
2025-12-06 03:04:23.326 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core] yql_linear_checker.cpp:210: {dummy_op} Scanned 0 static linear types
2025-12-06 03:04:23.327 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #219553
2025-12-06 03:04:23.327 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #219553, status: Ok
2025-12-06 03:04:23.327 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:630: {dummy_op} Node #209740<Configure!> finished execution
2025-12-06 03:04:23.327 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:647: {dummy_op} Node #209740<Configure!> created 0 trackable nodes: 
2025-12-06 03:04:23.327 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:630: {dummy_op} Node #219541<DqCnResult> finished execution
2025-12-06 03:04:23.327 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:647: {dummy_op} Node #219541<DqCnResult> created 0 trackable nodes: 
2025-12-06 03:04:23.341 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 216059
2025-12-06 03:04:23.341 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 216637
2025-12-06 03:04:23.346 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 216028
2025-12-06 03:04:23.346 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 216742
2025-12-06 03:04:23.351 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 215988
2025-12-06 03:04:23.351 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 216902
2025-12-06 03:04:23.356 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 215960
2025-12-06 03:04:23.356 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 217090
2025-12-06 03:04:23.362 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 215932
2025-12-06 03:04:23.362 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 217296
2025-12-06 03:04:23.368 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 218710
2025-12-06 03:04:23.373 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 219396
2025-12-06 03:04:23.378 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] dq_opt_build.cpp:482: {dummy_op/#219551/#219563} Enabled wide channels for stage with logical id = 219408
2025-12-06 03:04:23.476 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #215932 to Full
2025-12-06 03:04:23.476 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #215960 to Full
2025-12-06 03:04:23.476 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #215988 to Full
2025-12-06 03:04:23.476 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #216028 to Full
2025-12-06 03:04:23.476 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #216059 to Full
2025-12-06 03:04:23.476 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #216637 to Partial
2025-12-06 03:04:23.478 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #216742 to None
2025-12-06 03:04:23.481 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #216902 to None
2025-12-06 03:04:23.483 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #217090 to None
2025-12-06 03:04:23.485 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #217296 to None
2025-12-06 03:04:23.487 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #218710 to None
2025-12-06 03:04:23.489 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #219396 to None
2025-12-06 03:04:23.491 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #219408 to None
2025-12-06 03:04:23.494 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#219551/#219563} Setting block status for stage #219532 to None
2025-12-06 03:04:23.512 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:519: {dummy_op} Register async execution for node #219551
2025-12-06 03:04:23.512 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #219553, status: Async
2025-12-06 03:04:23.518 INFO  dqrun(pid=3235530, tid=0x00007FE3F2E33640) [DQ] executer_actor.cpp:157: {dummy_op} Trying to allocate 14 workers [EnableComputeActor=1]
2025-12-06 03:04:23.523 INFO  dqrun(pid=3235530, tid=0x00007FE3E9EF2640) [DQ] executer_actor.cpp:415: {dummy_op} 14 workers allocated
2025-12-06 03:04:41.837 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:135: {dummy_op} Completed async execution for node #219551
2025-12-06 03:04:41.837 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [DQ] yql_dq_exectransformer.cpp:1526: {dummy_op} Execution Pull complete, duration: 18.509771s
2025-12-06 03:04:41.839 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:155: {dummy_op} State is ExecutionComplete after apply async changes for node #219551
2025-12-06 03:04:41.839 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #219553
2025-12-06 03:04:41.839 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #219553, status: Ok
2025-12-06 03:04:41.839 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:630: {dummy_op} Node #219552<Commit!> finished execution
2025-12-06 03:04:41.839 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:647: {dummy_op} Node #219552<Commit!> created 0 trackable nodes: 
2025-12-06 03:04:41.840 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:630: {dummy_op} Node #219553<Commit!> finished execution
2025-12-06 03:04:41.840 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:647: {dummy_op} Node #219553<Commit!> created 0 trackable nodes: 
2025-12-06 03:04:41.840 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #219553, status: Ok
2025-12-06 03:04:41.840 INFO  dqrun(pid=3235530, tid=0x00007FE412113380) [core exec] yql_execution.cpp:95: {dummy_op} Creating finalizing transformer, output #219553
Getting results...

Done
2025-12-06 03:04:42.760 INFO  dqrun(pid=3235530, tid=0x00007FE3C82FD640) [DQ] yql_dq_gateway.cpp:658: Session closed dummy_op