dqrun ABI version: 2.44.0
2025-12-06 03:03:24.724 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [default] storage.cpp:189: FileStorage initialized in "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmpingFC1/", temporary dir: "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmpingFC1/3228124", locks dir:"/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmpingFC1/locks", files: 0, total size: 0
2025-12-06 03:03:24.731 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [generic] client.cpp:436: Connector[default] endpoint: grpcs://connector.yqv2-dev.cloud.yandex.net:50051
2025-12-06 03:03:24.749 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [http gw] yql_dns_gateway.h:85: Filled DNS resolution table based on provided configuration
2025-12-06 03:03:24.749 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [http gw] yql_dns_gateway.h:126: Started DNS table update
2025-12-06 03:03:24.753 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] interconnect_helpers.cpp:215: Start listener ::1:31337 socket: 18
2025-12-06 03:03:24.780 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.932 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.935 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_dq_gateway.cpp:605: {dummy_op} OpenSession
2025-12-06 03:03:24.938 INFO  dqrun(pid=3228124, tid=0x00007F6D89CFD640) [DQ] yql_dq_gateway.cpp:633: {dummy_op} OpenSession OK
2025-12-06 03:03:24.945 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok
2025-12-06 03:03:24.945 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.947 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.947 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 30 entries
2025-12-06 03:03:24.947 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.949 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.949 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 30 entries
2025-12-06 03:03:24.949 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.950 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.950 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries
2025-12-06 03:03:24.950 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.951 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.951 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 1 entries
2025-12-06 03:03:24.951 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/region/,.Pattern=h/1/region/*,.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:03:24.953 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [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:03:24.953 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 1 entries
2025-12-06 03:03:24.953 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/nation/* has 1 items with total size 5031
2025-12-06 03:03:24.954 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/supplier/* has 30 items with total size 825819
2025-12-06 03:03:24.955 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/supplier/* has 30 items with total size 825819
2025-12-06 03:03:24.955 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/partsupp/* has 30 items with total size 34281114
2025-12-06 03:03:24.955 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/region/* has 1 items with total size 3524
2025-12-06 03:03:24.955 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/part/* has 30 items with total size 6089692
2025-12-06 03:03:24.956 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/partsupp/* has 30 items with total size 34281114
2025-12-06 03:03:24.957 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok
2025-12-06 03:03:24.962 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [RESULT] yql_result_provider.cpp:1415: {dummy_op} RewriteIO
2025-12-06 03:03:25.111 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [RESULT] yql_result_provider.cpp:1154: {dummy_op} Setting result column order: [(s_acctbal->s_acctbal), (s_name->s_name), (n_name->n_name), (p_partkey->p_partkey), (p_mfgr->p_mfgr), (s_address->s_address), (s_phone->s_phone), (s_comment->s_comment)]
2025-12-06 03:03:25.220 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.221 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.222 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.222 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.222 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.223 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.223 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:03:25.224 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_dq_recapture.cpp:111: {dummy_op} DqsRecapture
2025-12-06 03:03:25.236 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:03:25.236 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:03:25.236 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:03:25.236 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:03:25.237 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:03:25.250 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 152 files with total size 76312113 bytes
2025-12-06 03:03:25.259 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.273 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 152 files with total size 76312113 bytes
2025-12-06 03:03:25.275 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.287 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 152 files with total size 76312113 bytes
2025-12-06 03:03:25.289 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.300 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 152 files with total size 76312113 bytes
2025-12-06 03:03:25.301 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.311 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 152 files with total size 76312113 bytes
2025-12-06 03:03:25.313 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.320 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 42030999 bytes
2025-12-06 03:03:25.321 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.328 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 42030999 bytes
2025-12-06 03:03:25.330 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:03:25.335 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 42030999 bytes
2025-12-06 03:03:25.336 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:03:25.336 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:03:25.337 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:03:25.337 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:03:25.337 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:03:25.337 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:03:25.351 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin
2025-12-06 03:03:25.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin
2025-12-06 03:03:25.384 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin
2025-12-06 03:03:25.400 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:03:25.400 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:03:25.415 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:03:25.427 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushExtractMembersToStage<false>
2025-12-06 03:03:25.446 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:03:25.463 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] dqs_opt.cpp:220: {dummy_op} DqReplicateStageMultiOutput
2025-12-06 03:03:25.474 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-BuildJoin<true>
2025-12-06 03:03:25.488 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] dqs_opt.cpp:220: {dummy_op} DqReplicateStageMultiOutput
2025-12-06 03:03:25.499 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-BuildJoin<true>
2025-12-06 03:03:25.514 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:03:25.528 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-PushExtractMembersToStage<true>
2025-12-06 03:03:25.539 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-BuildJoin<true>
2025-12-06 03:03:25.551 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-BuildJoin<true>
2025-12-06 03:03:25.563 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushExtractMembersToStage<false>
2025-12-06 03:03:25.580 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:03:25.587 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:03:25.595 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:03:25.611 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushCombineToStage<false>
2025-12-06 03:03:25.621 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:03:25.628 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:03:25.642 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildShuffleStage<false>
2025-12-06 03:03:25.652 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:03:25.665 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushExtractMembersToStage<false>
2025-12-06 03:03:25.686 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:03:25.697 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildTopSortStage<false>
2025-12-06 03:03:25.714 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [RESULT] yql_result_provider.cpp:771: {dummy_op} ResPull
2025-12-06 03:03:25.739 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core] yql_linear_checker.cpp:210: {dummy_op} Scanned 0 static linear types
2025-12-06 03:03:25.740 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #221033
2025-12-06 03:03:25.740 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #221033, status: Ok
2025-12-06 03:03:25.740 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:630: {dummy_op} Node #209739<Configure!> finished execution
2025-12-06 03:03:25.740 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:647: {dummy_op} Node #209739<Configure!> created 0 trackable nodes: 
2025-12-06 03:03:25.740 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:630: {dummy_op} Node #221021<DqCnResult> finished execution
2025-12-06 03:03:25.740 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:647: {dummy_op} Node #221021<DqCnResult> created 0 trackable nodes: 
2025-12-06 03:03:25.755 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 217934
2025-12-06 03:03:25.755 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 217238
2025-12-06 03:03:25.755 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 217975
2025-12-06 03:03:25.762 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 217207
2025-12-06 03:03:25.762 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 217298
2025-12-06 03:03:25.768 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 218530
2025-12-06 03:03:25.768 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 218747
2025-12-06 03:03:25.769 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 219148
2025-12-06 03:03:25.777 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 219913
2025-12-06 03:03:25.783 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 218942
2025-12-06 03:03:25.784 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 220271
2025-12-06 03:03:25.791 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 220884
2025-12-06 03:03:25.798 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] dq_opt_build.cpp:482: {dummy_op/#221031/#221043} Enabled wide channels for stage with logical id = 220897
2025-12-06 03:03:25.917 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #218414 to Partial
2025-12-06 03:03:25.917 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #217934 to Partial
2025-12-06 03:03:25.917 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #217207 to Full
2025-12-06 03:03:25.917 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #217238 to Full
2025-12-06 03:03:25.917 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #217975 to Partial
2025-12-06 03:03:25.917 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #217298 to Full
2025-12-06 03:03:25.920 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #218530 to None
2025-12-06 03:03:25.920 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #219050 to None
2025-12-06 03:03:25.923 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #218747 to None
2025-12-06 03:03:25.923 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #219148 to None
2025-12-06 03:03:25.926 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #218942 to None
2025-12-06 03:03:25.926 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #219913 to None
2025-12-06 03:03:25.929 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #220271 to None
2025-12-06 03:03:25.931 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #220884 to None
2025-12-06 03:03:25.934 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #220897 to None
2025-12-06 03:03:25.937 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#221031/#221043} Setting block status for stage #221012 to None
2025-12-06 03:03:25.961 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:519: {dummy_op} Register async execution for node #221031
2025-12-06 03:03:25.962 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #221033, status: Async
2025-12-06 03:03:25.965 INFO  dqrun(pid=3228124, tid=0x00007F6DB5338640) [DQ] executer_actor.cpp:157: {dummy_op} Trying to allocate 16 workers [EnableComputeActor=1]
2025-12-06 03:03:25.980 INFO  dqrun(pid=3228124, tid=0x00007F6DB2724640) [DQ] executer_actor.cpp:415: {dummy_op} 16 workers allocated
2025-12-06 03:03:28.369 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:135: {dummy_op} Completed async execution for node #221031
2025-12-06 03:03:28.369 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [DQ] yql_dq_exectransformer.cpp:1526: {dummy_op} Execution Pull complete, duration: 2.628793s
2025-12-06 03:03:28.371 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:155: {dummy_op} State is ExecutionComplete after apply async changes for node #221031
2025-12-06 03:03:28.371 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #221033
2025-12-06 03:03:28.371 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #221033, status: Ok
2025-12-06 03:03:28.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:630: {dummy_op} Node #221032<Commit!> finished execution
2025-12-06 03:03:28.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:647: {dummy_op} Node #221032<Commit!> created 0 trackable nodes: 
2025-12-06 03:03:28.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:630: {dummy_op} Node #221033<Commit!> finished execution
2025-12-06 03:03:28.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:647: {dummy_op} Node #221033<Commit!> created 0 trackable nodes: 
2025-12-06 03:03:28.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #221033, status: Ok
2025-12-06 03:03:28.372 INFO  dqrun(pid=3228124, tid=0x00007F6DD3BAA380) [core exec] yql_execution.cpp:95: {dummy_op} Creating finalizing transformer, output #221033
Getting results...

Done