dqrun ABI version: 2.44.0
2025-12-06 03:07:58.504 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [default] storage.cpp:189: FileStorage initialized in "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmp1BYOhY/", temporary dir: "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmp1BYOhY/3256170", locks dir:"/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmp1BYOhY/locks", files: 0, total size: 0
2025-12-06 03:07:58.511 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [generic] client.cpp:436: Connector[default] endpoint: grpcs://connector.yqv2-dev.cloud.yandex.net:50051
2025-12-06 03:07:58.530 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [http gw] yql_dns_gateway.h:85: Filled DNS resolution table based on provided configuration
2025-12-06 03:07:58.530 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [http gw] yql_dns_gateway.h:126: Started DNS table update
2025-12-06 03:07:58.534 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] interconnect_helpers.cpp:215: Start listener ::1:31337 socket: 18
2025-12-06 03:07:58.559 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.744 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.747 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_dq_gateway.cpp:605: {dummy_op} OpenSession
2025-12-06 03:07:58.750 INFO  dqrun(pid=3256170, tid=0x00007F9884D05640) [DQ] yql_dq_gateway.cpp:633: {dummy_op} OpenSession OK
2025-12-06 03:07:58.754 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok
2025-12-06 03:07:58.754 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1018: {dummy_op} [TLoggingS3ListingStrategy] Going to list request [TS3Lister] TListingRequest{.url=file://./tpc/,.Prefix=h/1/customer/,.Pattern=h/1/customer/*,.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:07:58.756 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.756 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 30 entries
2025-12-06 03:07:58.756 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.757 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.758 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries
2025-12-06 03:07:58.758 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.759 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.759 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 30 entries
2025-12-06 03:07:58.759 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.761 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.761 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries
2025-12-06 03:07:58.761 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.762 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.762 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 1 entries
2025-12-06 03:07:58.762 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.763 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [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:07:58.763 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000001s and ended with 1 entries
2025-12-06 03:07:58.763 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/lineitem/* has 30 items with total size 188300741
2025-12-06 03:07:58.764 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/nation/* has 1 items with total size 5031
2025-12-06 03:07:58.764 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/region/* has 1 items with total size 3524
2025-12-06 03:07:58.764 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/orders/* has 30 items with total size 54575075
2025-12-06 03:07:58.765 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/supplier/* has 30 items with total size 825819
2025-12-06 03:07:58.765 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_io_discovery.cpp:395: {dummy_op} Pattern h/1/customer/* has 30 items with total size 10260256
2025-12-06 03:07:58.766 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok
2025-12-06 03:07:58.769 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [RESULT] yql_result_provider.cpp:1415: {dummy_op} RewriteIO
2025-12-06 03:07:58.847 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [RESULT] yql_result_provider.cpp:1154: {dummy_op} Setting result column order: [(n_name->n_name), (revenue->revenue)]
2025-12-06 03:07:58.930 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:07:58.931 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:07:58.932 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:07:58.932 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:07:58.932 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:07:58.933 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local
2025-12-06 03:07:58.933 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_dq_recapture.cpp:111: {dummy_op} DqsRecapture
2025-12-06 03:07:58.944 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:07:58.945 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:07:58.946 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings
2025-12-06 03:07:58.946 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource
2025-12-06 03:07:58.961 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:58.966 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:07:58.977 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:58.978 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:07:58.989 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:58.990 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:07:58.999 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:59.000 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:07:59.008 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:59.009 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:07:59.015 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:59.016 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld
2025-12-06 03:07:59.020 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 122 files with total size 253970446 bytes
2025-12-06 03:07:59.021 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:07:59.021 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:07:59.021 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:07:59.021 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:07:59.021 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:07:59.021 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap
2025-12-06 03:07:59.030 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin
2025-12-06 03:07:59.042 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:07:59.043 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:07:59.051 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:07:59.052 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:07:59.061 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:07:59.069 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:07:59.080 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin<false>
2025-12-06 03:07:59.091 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushExtractMembersToStage<false>
2025-12-06 03:07:59.106 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage<false>
2025-12-06 03:07:59.113 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:07:59.119 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:07:59.126 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:07:59.139 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushCombineToStage<false>
2025-12-06 03:07:59.156 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:07:59.161 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate
2025-12-06 03:07:59.180 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildShuffleStage<false>
2025-12-06 03:07:59.191 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildSortStage<false>
2025-12-06 03:07:59.210 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [RESULT] yql_result_provider.cpp:771: {dummy_op} ResPull
2025-12-06 03:07:59.228 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core] yql_linear_checker.cpp:210: {dummy_op} Scanned 0 static linear types
2025-12-06 03:07:59.229 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #218006
2025-12-06 03:07:59.229 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #218006, status: Ok
2025-12-06 03:07:59.229 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:630: {dummy_op} Node #209722<Configure!> finished execution
2025-12-06 03:07:59.229 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:647: {dummy_op} Node #209722<Configure!> created 0 trackable nodes: 
2025-12-06 03:07:59.229 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:630: {dummy_op} Node #217994<DqCnResult> finished execution
2025-12-06 03:07:59.229 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:647: {dummy_op} Node #217994<DqCnResult> created 0 trackable nodes: 
2025-12-06 03:07:59.241 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 214796
2025-12-06 03:07:59.241 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 215230
2025-12-06 03:07:59.241 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 215278
2025-12-06 03:07:59.242 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 214885
2025-12-06 03:07:59.246 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 214765
2025-12-06 03:07:59.247 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 215403
2025-12-06 03:07:59.251 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 214737
2025-12-06 03:07:59.252 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 215630
2025-12-06 03:07:59.257 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 215790
2025-12-06 03:07:59.257 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 215476
2025-12-06 03:07:59.262 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 217218
2025-12-06 03:07:59.266 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 217851
2025-12-06 03:07:59.270 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] dq_opt_build.cpp:482: {dummy_op/#218004/#218016} Enabled wide channels for stage with logical id = 217863
2025-12-06 03:07:59.354 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #214737 to Full
2025-12-06 03:07:59.354 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #214765 to Full
2025-12-06 03:07:59.354 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #214796 to Full
2025-12-06 03:07:59.354 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #215230 to Partial
2025-12-06 03:07:59.354 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #215278 to Partial
2025-12-06 03:07:59.354 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #214885 to Full
2025-12-06 03:07:59.357 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #215403 to None
2025-12-06 03:07:59.357 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #215476 to None
2025-12-06 03:07:59.359 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #215630 to None
2025-12-06 03:07:59.362 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #215790 to None
2025-12-06 03:07:59.364 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #217218 to None
2025-12-06 03:07:59.366 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #217851 to None
2025-12-06 03:07:59.368 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #217863 to None
2025-12-06 03:07:59.370 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#218004/#218016} Setting block status for stage #217985 to None
2025-12-06 03:07:59.389 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:519: {dummy_op} Register async execution for node #218004
2025-12-06 03:07:59.389 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #218006, status: Async
2025-12-06 03:07:59.392 INFO  dqrun(pid=3256170, tid=0x00007F98AF83B640) [DQ] executer_actor.cpp:157: {dummy_op} Trying to allocate 14 workers [EnableComputeActor=1]
2025-12-06 03:07:59.399 INFO  dqrun(pid=3256170, tid=0x00007F98A5DF5640) [DQ] executer_actor.cpp:415: {dummy_op} 14 workers allocated
2025-12-06 03:08:14.000 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:135: {dummy_op} Completed async execution for node #218004
2025-12-06 03:08:14.000 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [DQ] yql_dq_exectransformer.cpp:1526: {dummy_op} Execution Pull complete, duration: 14.770519s
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:155: {dummy_op} State is ExecutionComplete after apply async changes for node #218004
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #218006
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #218006, status: Ok
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:630: {dummy_op} Node #218005<Commit!> finished execution
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:647: {dummy_op} Node #218005<Commit!> created 0 trackable nodes: 
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:630: {dummy_op} Node #218006<Commit!> finished execution
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:647: {dummy_op} Node #218006<Commit!> created 0 trackable nodes: 
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #218006, status: Ok
2025-12-06 03:08:14.001 INFO  dqrun(pid=3256170, tid=0x00007F98CD5E8380) [core exec] yql_execution.cpp:95: {dummy_op} Creating finalizing transformer, output #218006
Getting results...

Done