dqrun ABI version: 2.44.0 2025-12-06 03:04:52.474 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [default] storage.cpp:189: FileStorage initialized in "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmpoCRQZO/", temporary dir: "/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmpoCRQZO/3238379", locks dir:"/home/runner/.ya/build/build_root/o4ua/005281/r3tmp/tmpoCRQZO/locks", files: 0, total size: 0 2025-12-06 03:04:52.481 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [generic] client.cpp:436: Connector[default] endpoint: grpcs://connector.yqv2-dev.cloud.yandex.net:50051 2025-12-06 03:04:52.498 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [http gw] yql_dns_gateway.h:85: Filled DNS resolution table based on provided configuration 2025-12-06 03:04:52.498 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [http gw] yql_dns_gateway.h:126: Started DNS table update 2025-12-06 03:04:52.502 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] interconnect_helpers.cpp:215: Start listener ::1:31337 socket: 18 2025-12-06 03:04:52.527 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.660 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.662 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_dq_gateway.cpp:605: {dummy_op} OpenSession 2025-12-06 03:04:52.668 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok 2025-12-06 03:04:52.669 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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=,.AwsSigV4=}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0} 2025-12-06 03:04:52.669 INFO dqrun(pid=3238379, tid=0x00007F009DDFD640) [DQ] yql_dq_gateway.cpp:633: {dummy_op} OpenSession OK 2025-12-06 03:04:52.671 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.672 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000002s and ended with 30 entries 2025-12-06 03:04:52.673 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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=,.AwsSigV4=}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0} 2025-12-06 03:04:52.674 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.674 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 1 entries 2025-12-06 03:04:52.674 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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=,.AwsSigV4=}} with options TS3ListingOptions{.IsPartitionedDataset=0,.IsConcurrentListing=0} 2025-12-06 03:04:52.675 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.676 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_listing_strategy.cpp:1026: {dummy_op} [TLoggingS3ListingStrategy] Listing took 0.000000s and ended with 30 entries 2025-12-06 03:04:52.676 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.677 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.678 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [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:52.679 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_io_discovery.cpp:303: {dummy_op} YtIODiscovery - finish, status: Ok 2025-12-06 03:04:52.681 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [RESULT] yql_result_provider.cpp:1415: {dummy_op} RewriteIO 2025-12-06 03:04:52.727 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [RESULT] yql_result_provider.cpp:1154: {dummy_op} Setting result column order: [(ps_partkey->ps_partkey), (value->value)] 2025-12-06 03:04:52.758 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local 2025-12-06 03:04:52.759 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local 2025-12-06 03:04:52.759 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_dq_integration.cpp:252: {dummy_op} Wrap S3ReadObject! with token: cluster:default_yq-tpc-local 2025-12-06 03:04:52.760 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_dq_recapture.cpp:111: {dummy_op} DqsRecapture 2025-12-06 03:04:52.766 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings 2025-12-06 03:04:52.767 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource 2025-12-06 03:04:52.767 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings 2025-12-06 03:04:52.767 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource 2025-12-06 03:04:52.767 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:628: {dummy_op} ExtractMembers over DqSource with S3ParseSettings 2025-12-06 03:04:52.767 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_optimize.cpp:131: {dummy_op} LogicalOptimizer-ExtractMembersOverDqSource 2025-12-06 03:04:52.775 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 61 files with total size 35111964 bytes 2025-12-06 03:04:52.777 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.777 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.778 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld 2025-12-06 03:04:52.785 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 61 files with total size 35111964 bytes 2025-12-06 03:04:52.786 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.786 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.786 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld 2025-12-06 03:04:52.793 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 61 files with total size 35111964 bytes 2025-12-06 03:04:52.794 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.794 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.794 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_optimize.cpp:131: {dummy_op} PhysicalOptimizer-TrimReadWorld 2025-12-06 03:04:52.797 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [S3] yql_s3_logical_opt.cpp:434: {dummy_op} Will read from S3 61 files with total size 35111964 bytes 2025-12-06 03:04:52.800 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap 2025-12-06 03:04:52.801 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap 2025-12-06 03:04:52.801 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildStageWithSourceWrap 2025-12-06 03:04:52.808 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin 2025-12-06 03:04:52.817 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.817 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.818 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage 2025-12-06 03:04:52.823 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.823 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.824 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin 2025-12-06 03:04:52.829 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.829 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.830 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin 2025-12-06 03:04:52.835 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.836 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.837 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-PushExtractMembersToStage 2025-12-06 03:04:52.847 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.847 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.848 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage 2025-12-06 03:04:52.855 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.860 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.866 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.876 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.876 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.880 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] dqs_opt.cpp:220: {dummy_op} DqReplicateStageMultiOutput 2025-12-06 03:04:52.887 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.887 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.889 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-PushCombineToStage 2025-12-06 03:04:52.896 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.903 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.913 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [YT] yql_yt_phy_opt_map.cpp:54: {dummy_op} FlatMap: FlatMap can be pulled into parent EquiJoin 2025-12-06 03:04:52.918 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-BuildShuffleStage 2025-12-06 03:04:52.923 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteEquiJoin 2025-12-06 03:04:52.929 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-PushExtractMembersToStage 2025-12-06 03:04:52.936 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.941 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.946 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.959 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-PushCombineToStage 2025-12-06 03:04:52.972 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.977 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsLogical-RewriteAggregate 2025-12-06 03:04:52.992 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:93: {dummy_op} DqsPhy-BuildShuffleStage 2025-12-06 03:04:52.999 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildScalarPrecompute 2025-12-06 03:04:53.012 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildPrecompute 2025-12-06 03:04:53.018 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildAggregationResultStage 2025-12-06 03:04:53.031 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildJoin 2025-12-06 03:04:53.040 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildFlatmapStage 2025-12-06 03:04:53.048 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_optimize.cpp:131: {dummy_op} DqsPhy-BuildSortStage 2025-12-06 03:04:53.059 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [RESULT] yql_result_provider.cpp:771: {dummy_op} ResPull 2025-12-06 03:04:53.076 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core] yql_linear_checker.cpp:210: {dummy_op} Scanned 0 static linear types 2025-12-06 03:04:53.077 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #217054 2025-12-06 03:04:53.077 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #217054, status: Ok 2025-12-06 03:04:53.077 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:630: {dummy_op} Node #209737 finished execution 2025-12-06 03:04:53.077 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:647: {dummy_op} Node #209737 created 0 trackable nodes: 2025-12-06 03:04:53.078 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:630: {dummy_op} Node #217042 finished execution 2025-12-06 03:04:53.078 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:647: {dummy_op} Node #217042 created 0 trackable nodes: 2025-12-06 03:04:53.086 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Enabled wide channels for stage with logical id = 212673 2025-12-06 03:04:53.087 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Enabled wide channels for stage with logical id = 212963 2025-12-06 03:04:53.089 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Enabled wide channels for stage with logical id = 212645 2025-12-06 03:04:53.090 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Enabled wide channels for stage with logical id = 213063 2025-12-06 03:04:53.092 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Enabled wide channels for stage with logical id = 215994 2025-12-06 03:04:53.165 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Setting block status for stage #212645 to Full 2025-12-06 03:04:53.165 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Setting block status for stage #212673 to Full 2025-12-06 03:04:53.165 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Setting block status for stage #212963 to Partial 2025-12-06 03:04:53.166 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Setting block status for stage #213063 to None 2025-12-06 03:04:53.168 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Setting block status for stage #215994 to None 2025-12-06 03:04:53.169 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Setting block status for stage #216603 to None 2025-12-06 03:04:53.178 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:519: {dummy_op} Register async execution for node #217052 2025-12-06 03:04:53.178 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #217054, status: Async 2025-12-06 03:04:53.181 INFO dqrun(pid=3238379, tid=0x00007F00C8933640) [DQ] executer_actor.cpp:157: {dummy_op} Trying to allocate 6 workers [EnableComputeActor=1] 2025-12-06 03:04:53.184 INFO dqrun(pid=3238379, tid=0x00007F00C9438640) [DQ] executer_actor.cpp:415: {dummy_op} 6 workers allocated 2025-12-06 03:04:54.624 INFO dqrun(pid=3238379, tid=0x00007F009DDFD640) [DQ] yql_dq_exectransformer.cpp:2042: {dummy_op/#217052/#217064/DqPhyPrecompute(#217013)} Execution precomputes complete, duration: 1.545653s 2025-12-06 03:04:54.624 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:135: {dummy_op} Completed async execution for node #217052 2025-12-06 03:04:54.624 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:155: {dummy_op} State is ExecutionRequired after apply async changes for node #217052 2025-12-06 03:04:54.624 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #217054 2025-12-06 03:04:54.624 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #217054, status: Ok 2025-12-06 03:04:54.638 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 212673 2025-12-06 03:04:54.639 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 212963 2025-12-06 03:04:54.640 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 216738 2025-12-06 03:04:54.643 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 212645 2025-12-06 03:04:54.644 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 213063 2025-12-06 03:04:54.647 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 215994 2025-12-06 03:04:54.651 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 215014 2025-12-06 03:04:54.651 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 216813 2025-12-06 03:04:54.655 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 216937 2025-12-06 03:04:54.658 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] dq_opt_build.cpp:482: {dummy_op/#217052/#221033} Enabled wide channels for stage with logical id = 216949 2025-12-06 03:04:54.752 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #212645 to Full 2025-12-06 03:04:54.752 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #212673 to Full 2025-12-06 03:04:54.752 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #212963 to Partial 2025-12-06 03:04:54.752 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #216738 to None 2025-12-06 03:04:54.754 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #213063 to None 2025-12-06 03:04:54.754 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #216813 to None 2025-12-06 03:04:54.755 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #215994 to None 2025-12-06 03:04:54.757 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #215014 to None 2025-12-06 03:04:54.758 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #216937 to None 2025-12-06 03:04:54.759 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #216949 to None 2025-12-06 03:04:54.760 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core dq] yql_dq_exectransformer.cpp:379: {dummy_op/#217052/#221033} Setting block status for stage #217033 to None 2025-12-06 03:04:54.768 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:519: {dummy_op} Register async execution for node #217052 2025-12-06 03:04:54.768 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #217054, status: Async 2025-12-06 03:04:54.769 INFO dqrun(pid=3238379, tid=0x00007F00C9438640) [DQ] executer_actor.cpp:157: {dummy_op} Trying to allocate 11 workers [EnableComputeActor=1] 2025-12-06 03:04:54.774 INFO dqrun(pid=3238379, tid=0x00007F00BF9F2640) [DQ] executer_actor.cpp:415: {dummy_op} 11 workers allocated 2025-12-06 03:04:56.215 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:135: {dummy_op} Completed async execution for node #217052 2025-12-06 03:04:56.215 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [DQ] yql_dq_exectransformer.cpp:1526: {dummy_op} Execution Pull complete, duration: 1.590461s 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:155: {dummy_op} State is ExecutionComplete after apply async changes for node #217052 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:61: {dummy_op} Begin, root #217054 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:74: {dummy_op} Collect unused nodes for root #217054, status: Ok 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:630: {dummy_op} Node #217053 finished execution 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:647: {dummy_op} Node #217053 created 0 trackable nodes: 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:630: {dummy_op} Node #217054 finished execution 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:647: {dummy_op} Node #217054 created 0 trackable nodes: 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:89: {dummy_op} Finish, output #217054, status: Ok 2025-12-06 03:04:56.219 INFO dqrun(pid=3238379, tid=0x00007F00E7C62380) [core exec] yql_execution.cpp:95: {dummy_op} Creating finalizing transformer, output #217054 Getting results... Done