Query (id=a7420b313faa4b7d:a438981b00000000) Summary Session ID: 3b4f9a13350299e7:dd081efae5f122b7 Session Type: BEESWAX Start Time: 2023-03-28 08:28:59.211864000 End Time: 2023-03-28 08:29:25.970844000 Query Type: DML Query State: FINISHED Impala Query State: FINISHED Query Status: OK Impala Version: impalad version 3.4.0-SNAPSHOT RELEASE (build bc0299cf11ff42368fcb39ddaf04f4fe32c1c445) User: hduser@PRODBD.SERVICE-NOW.COM Connected User: hduser@PRODBD.SERVICE-NOW.COM Delegated User: Network Address: 10.174.33.15:45895 Default Db: default Sql Statement: insert into uadata.gcf partition (year, month,day,hour) select NULL as return_code,collection_timestamp,NULL as server,snc_provision_unique_id,NULL as usage_category,definition_id,bucket_key1,bucket_value1,bucket_key2,bucket_value2,bucket_key3,bucket_value3,bucket_key4,bucket_value4,bucket_key5,bucket_value5,count,start_time,end_time,instance_name,instance_id,NULL as node_id,snc_provision_unique_id as sys_id,NULL as sys_updated_by,end_time as sys_updated_on,NULL as sys_created_by,NULL as sys_mod_count,end_time as sys_created_on,processing_timestamp, a.payload_version as version ,bucket_key6 ,bucket_value6 ,bucket_key7 ,bucket_value7 ,bucket_key8 ,bucket_value8,NULL as batch_number,year,month,day,hour from (select *, row_number() over( partition by instance_id,snc_provision_unique_id order by collection_timestamp desc) as rown from uadata.gcf_v2 s where s.year=2023 and s.month=3 and s.day= 28 and s.hour=10) a where rown = 1 and a.snc_provision_unique_id not in (select snc_provision_unique_id from uadata.gcf where year=2023 and month=3 and day= 28 and hour = 10) Coordinator: hclient305.phx101.service-now.com:27000 Query Options (set by configuration): MEM_LIMIT=2147483648,IDLE_SESSION_TIMEOUT=600,EXEC_TIME_LIMIT_S=13600,TIMEZONE=America/Los_Angeles,CLIENT_IDENTIFIER=Impala Shell v3.4.0-SNAPSHOT (bc0299c) built on Sat Jan 28 00:12:31 UTC 2023,DEFAULT_FILE_FORMAT=PARQUET,DEFAULT_TRANSACTIONAL_TYPE=INSERT_ONLY Query Options (set by configuration and planner): MEM_LIMIT=2147483648,MT_DOP=0,IDLE_SESSION_TIMEOUT=600,EXEC_TIME_LIMIT_S=13600,TIMEZONE=America/Los_Angeles,CLIENT_IDENTIFIER=Impala Shell v3.4.0-SNAPSHOT (bc0299c) built on Sat Jan 28 00:12:31 UTC 2023,DEFAULT_FILE_FORMAT=PARQUET,DEFAULT_TRANSACTIONAL_TYPE=INSERT_ONLY Plan:

Max Per-Host Resource Reservation: Memory=176.00MB Threads=6 Per-Host Resource Estimates: Memory=43.41TB Dedicated Coordinator Resource Estimate: Memory=100MB WARNING: The following tables are missing relevant table and/or column statistics. uadata.gcf, uadata.gcf_v2 Analyzed query: SELECT NULL return_code, collection_timestamp, NULL server, snc_provision_unique_id, NULL usage_category, definition_id, bucket_key1, bucket_value1, bucket_key2, bucket_value2, bucket_key3, bucket_value3, bucket_key4, bucket_value4, bucket_key5, bucket_value5, count, start_time, end_time, instance_name, instance_id, NULL node_id, snc_provision_unique_id sys_id, NULL sys_updated_by, end_time sys_updated_on, NULL sys_created_by, NULL sys_mod_count, end_time sys_created_on, processing_timestamp, a.payload_version version, bucket_key6, bucket_value6, bucket_key7, bucket_value7, bucket_key8, bucket_value8, NULL batch_number, year, month, day, hour FROM (SELECT *, row_number() OVER (PARTITION BY instance_id, snc_provision_unique_id ORDER BY collection_timestamp DESC) rown FROM uadata.gcf_v2 s WHERE s.year = CAST(2023 AS INT) AND s.month = CAST(3 AS INT) AND s.day = CAST(28 AS INT) AND s.hour = CAST(10 AS INT)) a NULL AWARE LEFT ANTI JOIN (SELECT snc_provision_unique_id FROM uadata.gcf WHERE year = CAST(2023 AS INT) AND month = CAST(3 AS INT) AND day = CAST(28 AS INT) AND hour = CAST(10 AS INT)) $a$1 ($c$1) ON a.snc_provision_unique_id = $a$1.$c$1 WHERE rown = CAST(1 AS BIGINT) AND TRUE

F03:PLAN FRAGMENT [HASH(year,month,day,hour)] hosts=5 instances=5 | Per-Host Resources: mem-estimate=5.53GB mem-reservation=12.00MB thread-reservation=1 WRITE TO HDFS [uadata.gcf, OVERWRITE=false, PARTITION-KEYS=(year,month,day,hour)] | partitions=13392 | output exprs: NULL, collection_timestamp, NULL, snc_provision_unique_id, NULL, definition_id, bucket_key1, bucket_value1, bucket_key2, bucket_value2, bucket_key3, bucket_value3, bucket_key4, bucket_value4, bucket_key5, bucket_value5, count, start_time, end_time, instance_name, instance_id, NULL, snc_provision_unique_id, NULL, end_time, NULL, NULL, end_time, processing_timestamp, payload_version, bucket_key6, bucket_value6, bucket_key7, bucket_value7, bucket_key8, bucket_value8, NULL, year, month, day, hour | mem-estimate=1.00GB mem-reservation=0B thread-reservation=0 | 09:SORT | order by: year ASC NULLS LAST, month ASC NULLS LAST, day ASC NULLS LAST, hour ASC NULLS LAST | mem-estimate=4.53GB mem-reservation=12.00MB spill-buffer=2.00MB thread-reservation=0 | tuple-ids=10 row-size=604B cardinality=37.35G | in pipelines: 09(GETNEXT), 01(OPEN) | 08:EXCHANGE [HASH(year,month,day,hour)] | mem-estimate=13.03MB mem-reservation=0B thread-reservation=0 | tuple-ids=7,6 row-size=612B cardinality=37.35G | in pipelines: 01(GETNEXT) | F01:PLAN FRAGMENT [HASH(instance_id,snc_provision_unique_id)] hosts=5 instances=5 Per-Host Resources: mem-estimate=43.41TB mem-reservation=56.00MB thread-reservation=1 05:HASH JOIN [NULL AWARE LEFT ANTI JOIN, BROADCAST] | hash predicates: snc_provision_unique_id = snc_provision_unique_id | mem-estimate=43.40TB mem-reservation=40.00MB spill-buffer=2.00MB thread-reservation=0 | tuple-ids=7,6 row-size=612B cardinality=37.35G | in pipelines: 01(GETNEXT), 04(OPEN) | |--07:EXCHANGE [BROADCAST] | | mem-estimate=10.86MB mem-reservation=0B thread-reservation=0 | | tuple-ids=3 row-size=76B cardinality=570.82G | | in pipelines: 04(GETNEXT) | | | F02:PLAN FRAGMENT [RANDOM] hosts=11 instances=11 | Per-Host Resources: mem-estimate=64.00MB mem-reservation=4.00MB thread-reservation=2 | 04:SCAN HDFS [uadata.gcf, RANDOM] | partition predicates: year = CAST(2023 AS INT), month = CAST(3 AS INT), day = CAST(28 AS INT), hour = CAST(10 AS INT) | HDFS partitions=1/13212 files=11 size=544.81MB | stored statistics: | table: rows=570.82G size=74.87TB | partitions: 0/1 rows=unavailable | columns: all | extrapolated-rows=disabled max-scan-range-rows=261.25G | mem-estimate=64.00MB mem-reservation=4.00MB thread-reservation=1 | tuple-ids=3 row-size=76B cardinality=570.82G | in pipelines: 04(GETNEXT) | 03:SELECT | predicates: row_number() = CAST(1 AS BIGINT) | mem-estimate=0B mem-reservation=0B thread-reservation=0 | tuple-ids=7,6 row-size=612B cardinality=37.35G | in pipelines: 01(GETNEXT) | 02:ANALYTIC | functions: row_number() | partition by: instance_id, snc_provision_unique_id | order by: collection_timestamp DESC | window: ROWS BETWEEN UNBOUNDED PRECEDING AND CURRENT ROW | mem-estimate=4.00MB mem-reservation=4.00MB spill-buffer=2.00MB thread-reservation=0 | tuple-ids=7,6 row-size=612B cardinality=37.35G | in pipelines: 01(GETNEXT) | 01:SORT | order by: instance_id ASC NULLS FIRST, snc_provision_unique_id ASC NULLS FIRST, collection_timestamp DESC | mem-estimate=4.53GB mem-reservation=12.00MB spill-buffer=2.00MB thread-reservation=0 | tuple-ids=7 row-size=604B cardinality=37.35G | in pipelines: 01(GETNEXT), 00(OPEN) | 06:EXCHANGE [HASH(instance_id,snc_provision_unique_id)] | mem-estimate=12.97MB mem-reservation=0B thread-reservation=0 | tuple-ids=0 row-size=604B cardinality=37.35G | in pipelines: 00(GETNEXT) | F00:PLAN FRAGMENT [RANDOM] hosts=5 instances=5 Per-Host Resources: mem-estimate=2.03GB mem-reservation=104.00MB thread-reservation=2 00:SCAN HDFS [uadata.gcf_v2 s, RANDOM] partition predicates: s.year = CAST(2023 AS INT), s.month = CAST(3 AS INT), s.day = CAST(28 AS INT), s.hour = CAST(10 AS INT) HDFS partitions=1/6200 files=5 size=352.14MB stored statistics: table: rows=37.35G size=4.36TB partitions: 0/1 rows=unavailable columns: all extrapolated-rows=disabled max-scan-range-rows=25.78G mem-estimate=2.03GB mem-reservation=104.00MB thread-reservation=1 tuple-ids=0 row-size=604B cardinality=37.35G in pipelines: 00(GETNEXT)

Estimated Per-Host Mem: 47733905219936
Tables Missing Stats: uadata.gcf,uadata.gcf_v2
Request Pool: root.hduser
Per Host Min Memory Reservation: hslave701.phx101.service-now.com:27000(4.00 MB) hslave416.phx101.service-now.com:27000(4.00 MB) hslave518.phx101.service-now.com:27000(4.00 MB) hslave411.phx101.service-now.com:27000(4.00 MB) hslave309.phx101.service-now.com:27000(4.00 MB) hslave612.phx101.service-now.com:27000(172.00 MB) hslave702.phx101.service-now.com:27000(4.00 MB) hslave514.phx101.service-now.com:27000(172.00 MB) hslave505.phx101.service-now.com:27000(176.00 MB) hclient305.phx101.service-now.com:27000(0) hslave618.phx101.service-now.com:27000(4.00 MB) hslave412.phx101.service-now.com:27000(176.00 MB) hslave713.phx101.service-now.com:27000(4.00 MB) hslave608.phx101.service-now.com:27000(176.00 MB)
Per Host Number of Fragment Instances: hslave701.phx101.service-now.com:27000(1) hslave416.phx101.service-now.com:27000(1) hslave518.phx101.service-now.com:27000(1) hslave411.phx101.service-now.com:27000(1) hslave309.phx101.service-now.com:27000(1) hslave612.phx101.service-now.com:27000(3) hslave702.phx101.service-now.com:27000(1) hslave514.phx101.service-now.com:27000(3) hslave505.phx101.service-now.com:27000(4) hclient305.phx101.service-now.com:27000(0) hslave618.phx101.service-now.com:27000(1) hslave412.phx101.service-now.com:27000(4) hslave713.phx101.service-now.com:27000(1) hslave608.phx101.service-now.com:27000(4)
Admission result: Admitted immediately
Cluster Memory Admitted: 28.00 GB
Executor Group: default
ExecSummary: 

Operator #Hosts #Inst Avg Time Max Time #Rows Est. #Rows Peak Mem Est. Peak Mem Detail

F03:HDFS WRITER 5 5 4.287ms 21.324ms 5.00 MB 1.00 GB
09:SORT 5 5 487.418us 640.614us 92 37.35B 12.02 MB 4.53 GB
08:EXCHANGE 5 5 26.700us 65.590us 92 37.35B 80.00 KB 13.03 MB HASH(year,month,day,hour)
F01:EXCHANGE SENDER 5 5 225.529us 250.074us 15.98 KB 0
05:HASH JOIN 5 5 323.179ms 463.975ms 92 37.35B 430.05 MB 44443.48 GB NULL AWARE LEFT ANTI JOIN, BROADCAST
|--07:EXCHANGE 5 5 75.174ms 91.658ms 3.83M 570.82B 16.63 MB 10.86 MB BROADCAST
| F02:EXCHANGE SENDER 11 11 149.930ms 755.078ms 49.22 KB 0
| 04:SCAN HDFS 11 11 19.394ms 66.172ms 3.83M 570.82B 44.86 MB 64.00 MB uadata.gcf
03:SELECT 5 5 6.623ms 7.752ms 3.82M 37.35B 8.02 MB 0
02:ANALYTIC 5 5 566.567ms 604.689ms 3.82M 37.35B 12.55 MB 4.00 MB
01:SORT 5 5 2s775ms 3s002ms 3.82M 37.35B 408.02 MB 4.53 GB
06:EXCHANGE 5 5 98.001ms 107.020ms 3.82M 37.35B 14.88 MB 12.97 MB HASH(instance_id,snc_provision_unique_id) F00:EXCHANGE SENDER 5 5 2s050ms 6s752ms 302.07 KB 0
00:SCAN HDFS 5 5 62.271ms 184.554ms 3.82M 37.35B 143.38 MB 2.03 GB uadata.gcf_v2 s Errors: - AdmissionControlTimeSinceLastUpdate: 44ms (44000000) - ComputeScanRangeAssignmentTimer: 133.63us (133630) - InactiveTotalTime: 0ns (0) - TotalTime: 0ns (0) Query Compilation Metadata of all 2 tables cached: 277ms (277475723) Analysis finished: 280ms (280424706) Authorization finished (ranger): 281ms (281916135) Value transfer graph computed: 282ms (282130263) Single node plan created: 286ms (286782766) Runtime filters computed: 286ms (286869319) Distributed plan created: 287ms (287139303) Lineage info computed: 287ms (287374276) Planning finished: 10.38s (10380386352) Query Timeline Query submitted: 51.07us (51068) Planning finished: 10.40s (10402337660) Submit for admission: 10.41s (10414432868) Completed admission: 10.41s (10414771668) Ready to start on 14 backends: 10.42s (10423295543) All 14 execution backends (26 fragment instances) started: 10.63s (10631305973) Last row fetched: 26.76s (26758813900) Released admission control resources: 26.76s (26758970318) DML data written: 26.76s (26762964432) DML Metastore update finished: 30.01s (30014138326) Request finished: 30.01s (30014930605) Unregister query: 30.04s (30043796068) Frontend - CatalogFetch.ColumnStats.Hits: 46 (46) - CatalogFetch.ColumnStats.Misses: 41 (41) - CatalogFetch.ColumnStats.Requests: 87 (87) - CatalogFetch.ColumnStats.Time: 1ms (1) - CatalogFetch.Config.Hits: 1 (1) - CatalogFetch.Config.Misses: 0 (0) - CatalogFetch.Config.Requests: 1 (1) - CatalogFetch.Config.Time: 0ms (0) - CatalogFetch.DatabaseList.Hits: 1 (1) - CatalogFetch.DatabaseList.Misses: 0 (0) - CatalogFetch.DatabaseList.Requests: 1 (1) - CatalogFetch.DatabaseList.Time: 0ms (0) - CatalogFetch.PartitionLists.Hits: 1 (1) - CatalogFetch.PartitionLists.Misses: 1 (1) - CatalogFetch.PartitionLists.Requests: 2 (2) - CatalogFetch.PartitionLists.Time: 103ms (103) - CatalogFetch.Partitions.Hits: 39,639 (39639) - CatalogFetch.Partitions.Misses: 13,213 (13213) - CatalogFetch.Partitions.Requests: 52,852 (52852) - CatalogFetch.Partitions.Time: 9.97s (9971) - CatalogFetch.RPCs.Bytes: 218.0 MiB (228585076) - CatalogFetch.RPCs.Requests: 6 (6) - CatalogFetch.RPCs.Time: 2.17s (2167) - CatalogFetch.StorageLoad.Time: 3ms (3) - CatalogFetch.TableList.Hits: 2 (2) - CatalogFetch.TableList.Misses: 0 (0) - CatalogFetch.TableList.Requests: 2 (2) - CatalogFetch.TableList.Time: 0ms (0) - CatalogFetch.Tables.Hits: 1 (1) - CatalogFetch.Tables.Misses: 1 (1) - CatalogFetch.Tables.Requests: 2 (2) - CatalogFetch.Tables.Time: 1ms (1) - InactiveTotalTime: 0ns (0) - TotalTime: 0ns (0) ImpalaServer - ClientFetchWaitTimer: 28ms (28864372) - InactiveTotalTime: 0ns (0) - MetastoreUpdateTimer: 3.25s (3251935791) - NumRowsFetched: 0 (0) - NumRowsFetchedFromCache: 0 (0) - RowMaterializationRate: 0 per second (0) - RowMaterializationTimer: 0ns (0) - TotalTime: 0ns (0) Execution Profile a7420b313faa4b7d:a438981b00000000 Number of filters: 0 Filter routing table: ID Src. Node Tgt. Node(s) Target type Partition filter Pending (Expected) First arrived Completed Enabled

Backend startup latencies: Count: 14, min / max: 0 / 201ms, 25th %-ile: 52ms, 50th %-ile: 55ms, 75th %-ile: 59ms, 90th %-ile: 68ms, 95th %-ile: 68ms, 99.9th %-ile: 201ms
Slowest backend to start up: hslave505.phx101.service-now.com:27000
Per Node Peak Memory Usage: hslave701.phx101.service-now.com:27000(4.11 MB) hslave416.phx101.service-now.com:27000(4.17 MB) hslave518.phx101.service-now.com:27000(4.11 MB) hslave411.phx101.service-now.com:27000(44.92 MB) hslave309.phx101.service-now.com:27000(4.16 MB) hslave612.phx101.service-now.com:27000(860.82 MB) hslave702.phx101.service-now.com:27000(4.11 MB) hslave514.phx101.service-now.com:27000(860.71 MB) hslave505.phx101.service-now.com:27000(860.99 MB) hclient305.phx101.service-now.com:27000(0) hslave618.phx101.service-now.com:27000(16.04 MB) hslave412.phx101.service-now.com:27000(860.95 MB) hslave713.phx101.service-now.com:27000(4.13 MB) hslave608.phx101.service-now.com:27000(999.96 MB)
Per Node Bytes Read: hslave701.phx101.service-now.com:27000(26.20 KB) hslave416.phx101.service-now.com:27000(165.10 KB) hslave518.phx101.service-now.com:27000(16.66 KB) hslave411.phx101.service-now.com:27000(53.77 MB) hslave309.phx101.service-now.com:27000(164.51 KB) hslave612.phx101.service-now.com:27000(86.60 MB) hslave702.phx101.service-now.com:27000(24.67 KB) hslave514.phx101.service-now.com:27000(36.10 KB) hslave505.phx101.service-now.com:27000(70.16 MB) hclient305.phx101.service-now.com:27000(0) hslave618.phx101.service-now.com:27000(5.51 MB) hslave412.phx101.service-now.com:27000(13.37 MB) hslave713.phx101.service-now.com:27000(84.57 KB) hslave608.phx101.service-now.com:27000(339.66 MB)
Per Node User Time: hslave701.phx101.service-now.com:27000(30.461ms) hslave416.phx101.service-now.com:27000(36.859ms) hslave518.phx101.service-now.com:27000(32.214ms) hslave411.phx101.service-now.com:27000(506.191ms) hslave309.phx101.service-now.com:27000(33.183ms) hslave612.phx101.service-now.com:27000(7s872ms) hslave702.phx101.service-now.com:27000(50.184ms) hslave514.phx101.service-now.com:27000(4s895ms) hslave505.phx101.service-now.com:27000(5s966ms) hclient305.phx101.service-now.com:27000(0.000ns) hslave618.phx101.service-now.com:27000(85.822ms) hslave412.phx101.service-now.com:27000(5s422ms) hslave713.phx101.service-now.com:27000(51.030ms) hslave608.phx101.service-now.com:27000(13s854ms)
Per Node System Time: hslave701.phx101.service-now.com:27000(3.050ms) hslave416.phx101.service-now.com:27000(0.000ns) hslave518.phx101.service-now.com:27000(994.000us) hslave411.phx101.service-now.com:27000(72.594ms) hslave309.phx101.service-now.com:27000(2.892ms) hslave612.phx101.service-now.com:27000(1s502ms) hslave702.phx101.service-now.com:27000(2.990ms) hslave514.phx101.service-now.com:27000(650.140ms) hslave505.phx101.service-now.com:27000(880.583ms) hclient305.phx101.service-now.com:27000(0.000ns) hslave618.phx101.service-now.com:27000(12.461ms) hslave412.phx101.service-now.com:27000(809.774ms) hslave713.phx101.service-now.com:27000(1.950ms) hslave608.phx101.service-now.com:27000(2s392ms)
DML Stats: 

Partition: year=2023/month=3/day=28/hour=10 NumModifiedRows: 92 BytesWritten: 26.99 KB Per Column Sizes: snc_provision_unique_id: 6.15 KB bucket_key1: 278.00 B bucket_key2: 252.00 B bucket_key3: 215.00 B batch_number: 41.00 B bucket_key4: 136.00 B bucket_key5: 108.00 B bucket_key6: 81.00 B bucket_key7: 88.00 B bucket_key8: 107.00 B return_code: 41.00 B usage_category: 41.00 B server: 41.00 B start_time: 54.00 B node_id: 41.00 B sys_updated_on: 54.00 B processing_timestamp: 96.00 B sys_updated_by: 41.00 B collection_timestamp: 96.00 B bucket_value1: 742.00 B sys_id: 6.15 KB bucket_value2: 648.00 B definition_id: 266.00 B bucket_value3: 257.00 B sys_mod_count: 41.00 B bucket_value4: 141.00 B bucket_value5: 276.00 B bucket_value6: 72.00 B bucket_value7: 70.00 B sys_created_on: 54.00 B bucket_value8: 73.00 B version: 51.00 B sys_created_by: 41.00 B instance_id: 210.00 B instance_name: 119.00 B end_time: 54.00 B count: 375.00 B - ExchangeScanRatio: 3.91 (3.9106776985288096) - FiltersReceived: 0 (0) - FinalizationTimer: 260ms (260671370) - FileDeletionTimer: 3ms (3235883) - FileMoveTimer: 2ms (2418285) - Overwrite/PartitionCreationTimer: 1ms (1095311) - InactiveTotalTime: 0ns (0) - InnerNodeSelectivityRatio: 0.00 (1.0514999130978715E-5) - NumBackends: 14 (14) - NumCompletedBackends: 14 (14) - NumFragmentInstances: 26 (26) - NumFragments: 4 (4) - TotalBytesRead: 569.6 MiB (597240724) - TotalBytesSent: 2.2 GiB (2335640539) - TotalCpuTime: 45.17s (45169624000) - TotalInnerBytesSent: 24.0 KiB (24559) - TotalScanBytesSent: 2.2 GiB (2335615980) - TotalTime: 16.35s (16347227014) Per Node Profiles hslave701.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 0 (0) - CodegenTotalWallClockTime: 32ms (32385942) - CodegenSysTime: 2ms (2982000) - CodegenUserTime: 29ms (29440000) - CodegenVoluntaryContextSwitches: 2 (2) - CompileTime: 4ms (4368568) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 456.42us (456416) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 7ms (7347658) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 19ms (19352628) - TotalTime: 32ms (32395138) hslave416.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 0 (0) - CodegenTotalWallClockTime: 34ms (34689380) - CodegenSysTime: 0ns (0) - CodegenUserTime: 34ms (34628000) - CodegenVoluntaryContextSwitches: 4 (4) - CompileTime: 5ms (5190932) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 383.19us (383190) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 8ms (8334595) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 20ms (20007417) - TotalTime: 34ms (34698201) hslave518.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 0 (0) - CodegenTotalWallClockTime: 31ms (31424900) - CodegenSysTime: 994.00us (994000) - CodegenUserTime: 30ms (30815000) - CodegenVoluntaryContextSwitches: 0 (0) - CompileTime: 4ms (4658225) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 371.40us (371399) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 7ms (7574208) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 17ms (17912167) - TotalTime: 31ms (31433528) hslave411.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 0 (0) - CodegenTotalWallClockTime: 30ms (30434145) - CodegenSysTime: 1ms (1025000) - CodegenUserTime: 29ms (29740000) - CodegenVoluntaryContextSwitches: 2 (2) - CompileTime: 4ms (4532052) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 389.44us (389439) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 7ms (7656452) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 16ms (16723203) - TotalTime: 30ms (30445420) hslave309.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 1 (1) - CodegenTotalWallClockTime: 35ms (35180707) - CodegenSysTime: 1ms (1917000) - CodegenUserTime: 32ms (32559000) - CodegenVoluntaryContextSwitches: 16 (16) - CompileTime: 4ms (4956467) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 429.90us (429896) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 8ms (8390577) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 20ms (20215222) - TotalTime: 35ms (35190861) hslave612.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F03 CodeGen - CodegenInvoluntaryContextSwitches: 9 (9) - CodegenTotalWallClockTime: 137ms (137741112) - CodegenSysTime: 3ms (3984000) - CodegenUserTime: 131ms (131082000) - CodegenVoluntaryContextSwitches: 10 (10) - CompileTime: 48ms (48930261) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 2ms (2756206) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 87 (87) - NumInstructions: 2,402 (2402) - OptimizationTime: 64ms (64780623) - PeakMemoryUsage: 1.2 MiB (1229824) - PrepareTime: 20ms (20082097) - TotalTime: 137ms (137752288) Fragment F01 CodeGen - CodegenInvoluntaryContextSwitches: 7 (7) - CodegenTotalWallClockTime: 526ms (526964695) - CodegenSysTime: 3ms (3972000) - CodegenUserTime: 506ms (506337000) - CodegenVoluntaryContextSwitches: 18 (18) - CompileTime: 158ms (158599949) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 14ms (14643432) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 198 (198) - NumInstructions: 7,335 (7335) - OptimizationTime: 330ms (330903057) - PeakMemoryUsage: 3.6 MiB (3755520) - PrepareTime: 20ms (20740706) - TotalTime: 526ms (526975406) Fragment F00 CodeGen - CodegenInvoluntaryContextSwitches: 5 (5) - CodegenTotalWallClockTime: 99ms (99438266) - CodegenSysTime: 0ns (0) - CodegenUserTime: 97ms (97581000) - CodegenVoluntaryContextSwitches: 9 (9) - CompileTime: 21ms (21087149) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 1ms (1356722) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 23 (23) - NumInstructions: 544 (544) - OptimizationTime: 55ms (55557633) - PeakMemoryUsage: 272.0 KiB (278528) - PrepareTime: 20ms (20401708) - TotalTime: 99ms (99448289) hslave702.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 8 (8) - CodegenTotalWallClockTime: 52ms (52249758) - CodegenSysTime: 2ms (2990000) - CodegenUserTime: 48ms (48842000) - CodegenVoluntaryContextSwitches: 8 (8) - CompileTime: 7ms (7238446) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 558.89us (558891) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 12ms (12160886) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 30ms (30385429) - TotalTime: 52ms (52264542) hslave514.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F03 CodeGen - CodegenInvoluntaryContextSwitches: 20 (20) - CodegenTotalWallClockTime: 193ms (193874127) - CodegenSysTime: 3ms (3998000) - CodegenUserTime: 184ms (184941000) - CodegenVoluntaryContextSwitches: 1 (1) - CompileTime: 72ms (72390737) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 3ms (3567517) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 87 (87) - NumInstructions: 2,402 (2402) - OptimizationTime: 88ms (88106235) - PeakMemoryUsage: 1.2 MiB (1229824) - PrepareTime: 27ms (27065169) - TotalTime: 193ms (193888559) Fragment F01 CodeGen - CodegenInvoluntaryContextSwitches: 38 (38) - CodegenTotalWallClockTime: 713ms (713392138) - CodegenSysTime: 4ms (4991000) - CodegenUserTime: 687ms (687339000) - CodegenVoluntaryContextSwitches: 2 (2) - CompileTime: 210ms (210632915) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 19ms (19478563) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 198 (198) - NumInstructions: 7,335 (7335) - OptimizationTime: 451ms (451273276) - PeakMemoryUsage: 3.6 MiB (3755520) - PrepareTime: 28ms (28527055) - TotalTime: 713ms (713407745) Fragment F00 CodeGen - CodegenInvoluntaryContextSwitches: 6 (6) - CodegenTotalWallClockTime: 139ms (139783082) - CodegenSysTime: 2ms (2990000) - CodegenUserTime: 136ms (136584000) - CodegenVoluntaryContextSwitches: 1 (1) - CompileTime: 32ms (32508178) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 1ms (1806658) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 23 (23) - NumInstructions: 544 (544) - OptimizationTime: 75ms (75610742) - PeakMemoryUsage: 272.0 KiB (278528) - PrepareTime: 27ms (27768231) - TotalTime: 139ms (139796660) hslave505.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F03 CodeGen - CodegenInvoluntaryContextSwitches: 10 (10) - CodegenTotalWallClockTime: 212ms (212129938) - CodegenSysTime: 3ms (3987000) - CodegenUserTime: 204ms (204008000) - CodegenVoluntaryContextSwitches: 8 (8) - CompileTime: 71ms (71836678) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 4ms (4926576) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 87 (87) - NumInstructions: 2,402 (2402) - OptimizationTime: 94ms (94686296) - PeakMemoryUsage: 1.2 MiB (1229824) - PrepareTime: 36ms (36953396) - TotalTime: 212ms (212149582) Fragment F01 CodeGen - CodegenInvoluntaryContextSwitches: 307 (307) - CodegenTotalWallClockTime: 830ms (830787129) - CodegenSysTime: 12ms (12978000) - CodegenUserTime: 762ms (762632000) - CodegenVoluntaryContextSwitches: 20 (20) - CompileTime: 238ms (238806233) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 20ms (20808038) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 198 (198) - NumInstructions: 7,335 (7335) - OptimizationTime: 518ms (518050984) - PeakMemoryUsage: 3.6 MiB (3755520) - PrepareTime: 29ms (29034937) - TotalTime: 830ms (830805618) Fragment F00 CodeGen - CodegenInvoluntaryContextSwitches: 2 (2) - CodegenTotalWallClockTime: 149ms (149956896) - CodegenSysTime: 1ms (1991000) - CodegenUserTime: 136ms (136425000) - CodegenVoluntaryContextSwitches: 7 (7) - CompileTime: 48ms (48388443) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 2ms (2306510) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 23 (23) - NumInstructions: 544 (544) - OptimizationTime: 60ms (60725227) - PeakMemoryUsage: 272.0 KiB (278528) - PrepareTime: 35ms (35246243) - TotalTime: 149ms (149970959) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 23 (23) - CodegenTotalWallClockTime: 70ms (70655194) - CodegenSysTime: 3ms (3111000) - CodegenUserTime: 59ms (59863000) - CodegenVoluntaryContextSwitches: 7 (7) - CompileTime: 12ms (12587126) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 730.01us (730010) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 13ms (13282322) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 41ms (41215631) - TotalTime: 70ms (70674367) hclient305.phx101.service-now.com:27000 - AdmissionSlots: 0 (0) - InactiveTotalTime: 0ns (0) - TotalTime: 0ns (0) hslave618.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 0 (0) - CodegenTotalWallClockTime: 50ms (50285385) - CodegenSysTime: 3ms (3984000) - CodegenUserTime: 45ms (45314000) - CodegenVoluntaryContextSwitches: 7 (7) - CompileTime: 7ms (7015575) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 544.86us (544863) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 10ms (10357587) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 31ms (31321847) - TotalTime: 50ms (50298105) hslave412.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F03 CodeGen - CodegenInvoluntaryContextSwitches: 9 (9) - CodegenTotalWallClockTime: 202ms (202610260) - CodegenSysTime: 2ms (2981000) - CodegenUserTime: 195ms (195360000) - CodegenVoluntaryContextSwitches: 14 (14) - CompileTime: 67ms (67097724) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 4ms (4272849) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 87 (87) - NumInstructions: 2,402 (2402) - OptimizationTime: 93ms (93037790) - PeakMemoryUsage: 1.2 MiB (1229824) - PrepareTime: 35ms (35451724) - TotalTime: 202ms (202626217) Fragment F01 CodeGen - CodegenInvoluntaryContextSwitches: 44 (44) - CodegenTotalWallClockTime: 730ms (730943651) - CodegenSysTime: 11ms (11910000) - CodegenUserTime: 702ms (702471000) - CodegenVoluntaryContextSwitches: 26 (26) - CompileTime: 210ms (210605467) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 20ms (20331016) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 198 (198) - NumInstructions: 7,335 (7335) - OptimizationTime: 470ms (470850113) - PeakMemoryUsage: 3.6 MiB (3755520) - PrepareTime: 26ms (26434547) - TotalTime: 730ms (730956918) Fragment F00 CodeGen - CodegenInvoluntaryContextSwitches: 27 (27) - CodegenTotalWallClockTime: 135ms (135493458) - CodegenSysTime: 5ms (5938000) - CodegenUserTime: 125ms (125461000) - CodegenVoluntaryContextSwitches: 18 (18) - CompileTime: 31ms (31222033) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 2ms (2309974) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 23 (23) - NumInstructions: 544 (544) - OptimizationTime: 66ms (66747040) - PeakMemoryUsage: 272.0 KiB (278528) - PrepareTime: 32ms (32601012) - TotalTime: 135ms (135510209) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 7 (7) - CodegenTotalWallClockTime: 60ms (60901487) - CodegenSysTime: 3ms (3993000) - CodegenUserTime: 53ms (53441000) - CodegenVoluntaryContextSwitches: 24 (24) - CompileTime: 8ms (8453026) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 542.41us (542407) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 14ms (14217998) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 35ms (35145898) - TotalTime: 60ms (60914999) hslave713.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 17 (17) - CodegenTotalWallClockTime: 52ms (52126165) - CodegenSysTime: 1ms (1950000) - CodegenUserTime: 49ms (49568000) - CodegenVoluntaryContextSwitches: 12 (12) - CompileTime: 7ms (7102005) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 567.18us (567184) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 12ms (12107419) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 30ms (30581170) - TotalTime: 52ms (52138190) hslave608.phx101.service-now.com:27000 - AdmissionSlots: 1 (1) - BloomFilterBytes: 0 B (0) - InactiveTotalTime: 0ns (0) - ScratchBytesRead: 0 B (0) - ScratchBytesWritten: 0 B (0) - ScratchFileUsedBytes: 0 B (0) - ScratchReads: 0 (0) - ScratchWrites: 0 (0) - TotalEncryptionTime: 0ns (0) - TotalReadBlockTime: 0ns (0) - TotalTime: 0ns (0) - UncompressedScratchBytesWritten: 0 B (0) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - ReservationLimit: 0 B (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F03 CodeGen - CodegenInvoluntaryContextSwitches: 4 (4) - CodegenTotalWallClockTime: 123ms (123673498) - CodegenSysTime: 0ns (0) - CodegenUserTime: 122ms (122879000) - CodegenVoluntaryContextSwitches: 18 (18) - CompileTime: 45ms (45659371) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 2ms (2656181) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 87 (87) - NumInstructions: 2,402 (2402) - OptimizationTime: 53ms (53928258) - PeakMemoryUsage: 1.2 MiB (1229824) - PrepareTime: 20ms (20083174) - TotalTime: 123ms (123682837) Fragment F01 CodeGen - CodegenInvoluntaryContextSwitches: 13 (13) - CodegenTotalWallClockTime: 574ms (574431207) - CodegenSysTime: 5ms (5967000) - CodegenUserTime: 557ms (557403000) - CodegenVoluntaryContextSwitches: 11 (11) - CompileTime: 155ms (155316374) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 18ms (18888893) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 198 (198) - NumInstructions: 7,335 (7335) - OptimizationTime: 376ms (376700499) - PeakMemoryUsage: 3.6 MiB (3755520) - PrepareTime: 19ms (19256502) - TotalTime: 574ms (574444138) Fragment F00 CodeGen - CodegenInvoluntaryContextSwitches: 3 (3) - CodegenTotalWallClockTime: 95ms (95088077) - CodegenSysTime: 2ms (2976000) - CodegenUserTime: 89ms (89990000) - CodegenVoluntaryContextSwitches: 18 (18) - CompileTime: 23ms (23952220) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 1ms (1234013) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 23 (23) - NumInstructions: 544 (544) - OptimizationTime: 49ms (49469529) - PeakMemoryUsage: 272.0 KiB (278528) - PrepareTime: 19ms (19351407) - TotalTime: 95ms (95099147) Fragment F02 CodeGen - CodegenInvoluntaryContextSwitches: 2 (2) - CodegenTotalWallClockTime: 36ms (36488347) - CodegenSysTime: 3ms (3067000) - CodegenUserTime: 33ms (33277000) - CodegenVoluntaryContextSwitches: 13 (13) - CompileTime: 5ms (5146172) - InactiveTotalTime: 0ns (0) - IrGenerationTime: 462.20us (462202) - LoadTime: 0ns (0) - ModuleBitcodeSize: 2.5 MiB (2614144) - NumFunctions: 3 (3) - NumInstructions: 102 (102) - OptimizationTime: 8ms (8571181) - PeakMemoryUsage: 51.0 KiB (52224) - PrepareTime: 21ms (21108355) - TotalTime: 36ms (36499376) Averaged Fragment F03 split sizes: min: 0, max: 0, avg: 0, stddev: 0 completion times: min:15s833ms max:16s015ms mean: 15s930ms stddev:60.262ms execution rates: min:0.00 /sec max:0.00 /sec mean:0.00 /sec stddev:0.00 /sec num instances: 5 - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 13.0 MiB (13653688) - PeakReservation: 12.0 MiB (12582912) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 888.7 MiB (931853590) - RowsProduced: 18 (18) - TotalNetworkReceiveTime: 15.26s (15261046842) - TotalNetworkSendTime: 0ns (0) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 11 (11) - TotalThreadsTotalWallClockTime: 15.55s (15546814144) - TotalThreadsSysTime: 62ms (62453800) - TotalThreadsUserTime: 216ms (216867400) - TotalThreadsVoluntaryContextSwitches: 21 (21) - TotalTime: 15.55s (15547147139) Fragment Instance Lifecycle Timings - ExecTime: 4ms (4070383) - ExecTreeExecTime: 16.82us (16823) - InactiveTotalTime: 0ns (0) - OpenTime: 15.54s (15542764999) - ExecTreeOpenTime: 15.26s (15261380193) - PrepareTime: 270.91us (270908) - ExecTreePrepareTime: 161.75us (161746) - TotalTime: 0ns (0) HdfsTableSink - BytesWritten: 5.4 KiB (5527) - CompressTimer: 21.36us (21359) - EncodeTimer: 99.06us (99058) - FilesCreated: 0 (0) - FinalizePartitionFileTimer: 11ms (11564766) - HdfsWriteTimer: 381.88us (381885) - InactiveTotalTime: 0ns (0) - PartitionsCreated: 0 (0) - PeakMemoryUsage: 1,023.8 KiB (1048360) - RowsInserted: 18 (18) - TmpFileCreateTimer: 4ms (4548860) - TotalTime: 4ms (4287217) SORT_NODE (id=9) - InMemorySortTime: 12.72us (12722) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 12.0 MiB (12607488) - RowsReturned: 18 (18) - RowsReturnedRate: 1 per second (1) - SortDataSize: 8.8 KiB (9027) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 15.26s (15261552153) Buffer pool - AllocTime: 3.04us (3042) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 6.0 MiB (6291456) - CumulativeAllocations: 3 (3) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 12.0 MiB (12582912) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 6.0 MiB (6291456) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=8) - ConvertRowBatchTime: 2.64us (2642) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 16.0 KiB (16384) - RowsReturned: 18 (18) - RowsReturnedRate: 1 per second (1) - TotalTime: 15.26s (15261064734) Buffer pool - AllocTime: 3.06us (3058) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 22.4 KiB (22937) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.0 KiB (16384) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.0 KiB (16384) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 15.14s (15138681216) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 9.3 KiB (9487) - TotalGetBatchTime: 15.26s (15261044043) - DataWaitTime: 15.26s (15261038034) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 28.52us (28525) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 1 (1) - TotalBatchesReceived: 1 (1) - TotalBytesReceived: 4.8 KiB (4911) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Fragment F03 Instance a7420b313faa4b7d:a438981b00000016 (host=hslave612.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.663 - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.0 MiB (12615680) - PeakReservation: 12.0 MiB (12582912) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 860.8 MiB (902638532) - RowsProduced: 0 (0) - TotalNetworkReceiveTime: 15.37s (15365004983) - TotalNetworkSendTime: 0ns (0) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 10 (10) - TotalThreadsTotalWallClockTime: 15.62s (15622071545) - TotalThreadsSysTime: 75ms (75528000) - TotalThreadsUserTime: 178ms (178473000) - TotalThreadsVoluntaryContextSwitches: 14 (14) - TotalTime: 15.62s (15622360896) Fragment Instance Lifecycle Event Timeline Prepare Finished: 688.49us (688485) Open Finished: 15.62s (15622739663) First Batch Produced: 15.62s (15622755132) First Batch Sent: 15.62s (15622758032) ExecInternal Finished: 15.62s (15622889597) Fragment Instance Lifecycle Timings - ExecTime: 86.40us (86399) - ExecTreeExecTime: 12.62us (12623) - InactiveTotalTime: 0ns (0) - OpenTime: 15.62s (15622013863) - ExecTreeOpenTime: 15.37s (15365224454) - PrepareTime: 227.37us (227366) - ExecTreePrepareTime: 108.19us (108186) - TotalTime: 0ns (0) HdfsTableSink - BytesWritten: 0 B (0) - CompressTimer: 0ns (0) - EncodeTimer: 0ns (0) - FilesCreated: 0 (0) - HdfsWriteTimer: 0ns (0) - InactiveTotalTime: 0ns (0) - PartitionsCreated: 0 (0) - PeakMemoryUsage: 0 B (0) - RowsInserted: 0 (0) - TotalTime: 30.93us (30935) SORT_NODE (id=9) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 524ns (524) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 12.0 MiB (12607488) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - SortDataSize: 0 B (0) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 15.37s (15365339326) Node Lifecycle Event Timeline Open Started: 138ms (138488433) Open Finished: 15.50s (15503709222) First Batch Requested: 15.62s (15622744237) First Batch Returned: 15.62s (15622753104) Last Batch Returned: 15.62s (15622753517) Closed: 15.62s (15622799373) Buffer pool - AllocTime: 2.43us (2426) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 6.0 MiB (6291456) - CumulativeAllocations: 3 (3) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 12.0 MiB (12582912) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 6.0 MiB (6291456) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=8) - ConvertRowBatchTime: 334ns (334) - InactiveTotalTime: 15.37s (15365002025) - PeakMemoryUsage: 0 B (0) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - TotalTime: 15.37s (15365014956) Node Lifecycle Event Timeline Open Started: 138ms (138493033) Open Finished: 15.50s (15503499255) First Batch Requested: 15.50s (15503607088) First Batch Returned: 15.50s (15503609665) Last Batch Returned: 15.50s (15503609997) Closed: 15.50s (15503696431) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 15.37s (15365002025) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 0 B (0) - TotalGetBatchTime: 15.37s (15365003512) - DataWaitTime: 15.37s (15365002025) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 0 (0) - TotalBatchesReceived: 0 (0) - TotalBytesReceived: 0 B (0) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000015 (host=hslave514.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.603 - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 17.0 MiB (17805724) - PeakReservation: 12.0 MiB (12582912) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 860.7 MiB (902515652) - RowsProduced: 92 (92) - TotalNetworkReceiveTime: 15.34s (15338924772) - TotalNetworkSendTime: 0ns (0) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 20 (20) - TotalThreadsTotalWallClockTime: 15.59s (15592952593) - TotalThreadsSysTime: 17ms (17102000) - TotalThreadsUserTime: 219ms (219309000) - TotalThreadsVoluntaryContextSwitches: 25 (25) - TotalTime: 15.59s (15593208361) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1239686) Open Finished: 15.57s (15574160804) First Batch Produced: 15.57s (15574170083) First Batch Sent: 15.58s (15582598883) ExecInternal Finished: 15.60s (15595589529) Fragment Instance Lifecycle Timings - ExecTime: 20ms (20051172) - ExecTreeExecTime: 15.60us (15600) - InactiveTotalTime: 0ns (0) - OpenTime: 15.57s (15572910382) - ExecTreeOpenTime: 15.34s (15339331953) - PrepareTime: 212.14us (212140) - ExecTreePrepareTime: 112.71us (112714) - TotalTime: 0ns (0) HdfsTableSink - BytesWritten: 27.0 KiB (27636) - CompressTimer: 106.80us (106799) - EncodeTimer: 495.29us (495292) - FilesCreated: 1 (1) - FinalizePartitionFileTimer: 11ms (11564766) - HdfsWriteTimer: 1ms (1909426) - InactiveTotalTime: 0ns (0) - PartitionsCreated: 1 (1) - PeakMemoryUsage: 5.0 MiB (5241803) - RowsInserted: 92 (92) - TmpFileCreateTimer: 4ms (4548860) - TotalTime: 21ms (21324261) SORT_NODE (id=9) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 53.50us (53498) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 12.0 MiB (12607488) - RowsReturned: 92 (92) - RowsReturnedRate: 5 per second (5) - SortDataSize: 44.1 KiB (45136) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 15.34s (15339451757) Node Lifecycle Event Timeline Open Started: 195ms (195199006) Open Finished: 15.53s (15534527021) First Batch Requested: 15.57s (15574164072) First Batch Returned: 15.57s (15574169439) Last Batch Returned: 15.58s (15582607875) Closed: 15.58s (15582633214) Buffer pool - AllocTime: 2.25us (2248) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 6.0 MiB (6291456) - CumulativeAllocations: 3 (3) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 12.0 MiB (12582912) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 6.0 MiB (6291456) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=8) - ConvertRowBatchTime: 11.11us (11113) - InactiveTotalTime: 15.34s (15338896542) - PeakMemoryUsage: 80.0 KiB (81920) - RowsReturned: 92 (92) - RowsReturnedRate: 5 per second (5) - TotalTime: 15.34s (15338962132) Node Lifecycle Event Timeline Open Started: 195ms (195201991) Open Finished: 14.92s (14922320361) First Batch Requested: 14.92s (14922424349) First Batch Returned: 15.53s (15534258103) Last Batch Returned: 15.53s (15534258899) Closed: 15.53s (15534464480) Buffer pool - AllocTime: 15.29us (15290) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 112.0 KiB (114688) - CumulativeAllocations: 10 (10) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 80.0 KiB (81920) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 80.0 KiB (81920) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 14.73s (14727112452) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 46.3 KiB (47436) - TotalGetBatchTime: 15.34s (15338918891) - DataWaitTime: 15.34s (15338896542) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 142.63us (142629) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 5 (5) - TotalBatchesReceived: 5 (5) - TotalBytesReceived: 24.0 KiB (24559) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000018 (host=hslave412.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.622 - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.0 MiB (12615680) - PeakReservation: 12.0 MiB (12582912) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 860.9 MiB (902769876) - RowsProduced: 0 (0) - TotalNetworkReceiveTime: 15.29s (15292124650) - TotalNetworkSendTime: 0ns (0) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 9 (9) - TotalThreadsTotalWallClockTime: 15.57s (15573378411) - TotalThreadsSysTime: 30ms (30937000) - TotalThreadsUserTime: 246ms (246371000) - TotalThreadsVoluntaryContextSwitches: 20 (20) - TotalTime: 15.57s (15573678122) Fragment Instance Lifecycle Event Timeline Prepare Finished: 893.83us (893825) Open Finished: 15.57s (15574235520) First Batch Produced: 15.57s (15574271982) First Batch Sent: 15.57s (15574275243) ExecInternal Finished: 15.57s (15574373963) Fragment Instance Lifecycle Timings - ExecTime: 85.54us (85539) - ExecTreeExecTime: 35.14us (35142) - InactiveTotalTime: 0ns (0) - OpenTime: 15.57s (15573315371) - ExecTreeOpenTime: 15.29s (15292441945) - PrepareTime: 228.78us (228777) - ExecTreePrepareTime: 130.48us (130479) - TotalTime: 0ns (0) HdfsTableSink - BytesWritten: 0 B (0) - CompressTimer: 0ns (0) - EncodeTimer: 0ns (0) - FilesCreated: 0 (0) - HdfsWriteTimer: 0ns (0) - InactiveTotalTime: 0ns (0) - PartitionsCreated: 0 (0) - PeakMemoryUsage: 0 B (0) - RowsInserted: 0 (0) - TotalTime: 21.65us (21653) SORT_NODE (id=9) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 740ns (740) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 12.0 MiB (12607488) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - SortDataSize: 0 B (0) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 15.29s (15292601855) Node Lifecycle Event Timeline Open Started: 203ms (203596152) Open Finished: 15.50s (15496034281) First Batch Requested: 15.57s (15574238610) First Batch Returned: 15.57s (15574270401) Last Batch Returned: 15.57s (15574270613) Closed: 15.57s (15574300525) Buffer pool - AllocTime: 4.04us (4040) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 6.0 MiB (6291456) - CumulativeAllocations: 3 (3) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 12.0 MiB (12582912) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 6.0 MiB (6291456) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=8) - ConvertRowBatchTime: 609ns (609) - InactiveTotalTime: 15.29s (15292120419) - PeakMemoryUsage: 0 B (0) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - TotalTime: 15.29s (15292135824) Node Lifecycle Event Timeline Open Started: 203ms (203599054) Open Finished: 15.49s (15495725411) First Batch Requested: 15.49s (15495911985) First Batch Returned: 15.49s (15495915882) Last Batch Returned: 15.49s (15495916775) Closed: 15.50s (15496019974) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 15.29s (15292120419) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 0 B (0) - TotalGetBatchTime: 15.29s (15292122504) - DataWaitTime: 15.29s (15292120419) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 0 (0) - TotalBatchesReceived: 0 (0) - TotalBytesReceived: 0 B (0) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000019 (host=hslave608.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.709 - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.0 MiB (12615680) - PeakReservation: 12.0 MiB (12582912) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 1,000.0 MiB (1048533058) - RowsProduced: 0 (0) - TotalNetworkReceiveTime: 15.22s (15223863274) - TotalNetworkSendTime: 0ns (0) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 4 (4) - TotalThreadsTotalWallClockTime: 15.51s (15514398810) - TotalThreadsSysTime: 107ms (107184000) - TotalThreadsUserTime: 181ms (181081000) - TotalThreadsVoluntaryContextSwitches: 26 (26) - TotalTime: 15.51s (15514768832) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1817937) Open Finished: 15.52s (15516200970) First Batch Produced: 15.52s (15516212817) First Batch Sent: 15.52s (15516215568) ExecInternal Finished: 15.52s (15516324422) Fragment Instance Lifecycle Timings - ExecTime: 76.46us (76457) - ExecTreeExecTime: 10.82us (10820) - InactiveTotalTime: 0ns (0) - OpenTime: 15.51s (15514351941) - ExecTreeOpenTime: 15.22s (15224167934) - PrepareTime: 308.27us (308270) - ExecTreePrepareTime: 220.98us (220978) - TotalTime: 0ns (0) HdfsTableSink - BytesWritten: 0 B (0) - CompressTimer: 0ns (0) - EncodeTimer: 0ns (0) - FilesCreated: 0 (0) - HdfsWriteTimer: 0ns (0) - InactiveTotalTime: 0ns (0) - PartitionsCreated: 0 (0) - PeakMemoryUsage: 0 B (0) - RowsInserted: 0 (0) - TotalTime: 31.60us (31599) SORT_NODE (id=9) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 656ns (656) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 12.0 MiB (12607488) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - SortDataSize: 0 B (0) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 15.22s (15224394531) Node Lifecycle Event Timeline Open Started: 125ms (125560327) Open Finished: 15.35s (15349725060) First Batch Requested: 15.52s (15516203671) First Batch Returned: 15.52s (15516211082) Last Batch Returned: 15.52s (15516211309) Closed: 15.52s (15516250023) Buffer pool - AllocTime: 2.94us (2938) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 6.0 MiB (6291456) - CumulativeAllocations: 3 (3) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 12.0 MiB (12582912) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 6.0 MiB (6291456) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=8) - ConvertRowBatchTime: 562ns (562) - InactiveTotalTime: 15.22s (15223860019) - PeakMemoryUsage: 0 B (0) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - TotalTime: 15.22s (15223878080) Node Lifecycle Event Timeline Open Started: 125ms (125563202) Open Finished: 15.35s (15349428174) First Batch Requested: 15.35s (15349611582) First Batch Returned: 15.35s (15349615278) Last Batch Returned: 15.35s (15349615788) Closed: 15.35s (15349710583) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 15.22s (15223860019) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 0 B (0) - TotalGetBatchTime: 15.22s (15223861708) - DataWaitTime: 15.22s (15223860019) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 0 (0) - TotalBatchesReceived: 0 (0) - TotalBytesReceived: 0 B (0) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000017 (host=hslave505.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.676 - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.0 MiB (12615680) - PeakReservation: 12.0 MiB (12582912) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 861.0 MiB (902810836) - RowsProduced: 0 (0) - TotalNetworkReceiveTime: 15.09s (15085316531) - TotalNetworkSendTime: 0ns (0) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 14 (14) - TotalThreadsTotalWallClockTime: 15.43s (15431269364) - TotalThreadsSysTime: 81ms (81518000) - TotalThreadsUserTime: 259ms (259103000) - TotalThreadsVoluntaryContextSwitches: 22 (22) - TotalTime: 15.43s (15431719484) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1280045) Open Finished: 15.43s (15432533294) First Batch Produced: 15.43s (15432544305) First Batch Sent: 15.43s (15432547228) ExecInternal Finished: 15.43s (15432893197) Fragment Instance Lifecycle Timings - ExecTime: 52.35us (52352) - ExecTreeExecTime: 9.93us (9930) - InactiveTotalTime: 0ns (0) - OpenTime: 15.43s (15431233441) - ExecTreeOpenTime: 15.09s (15085734681) - PrepareTime: 377.99us (377988) - ExecTreePrepareTime: 236.38us (236375) - TotalTime: 0ns (0) HdfsTableSink - BytesWritten: 0 B (0) - CompressTimer: 0ns (0) - EncodeTimer: 0ns (0) - FilesCreated: 0 (0) - HdfsWriteTimer: 0ns (0) - InactiveTotalTime: 0ns (0) - PartitionsCreated: 0 (0) - PeakMemoryUsage: 0 B (0) - RowsInserted: 0 (0) - TotalTime: 27.64us (27637) SORT_NODE (id=9) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 8.20us (8195) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 12.0 MiB (12607488) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - SortDataSize: 0 B (0) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 15.09s (15085973296) Node Lifecycle Event Timeline Open Started: 213ms (213527513) Open Finished: 15.30s (15299256450) First Batch Requested: 15.43s (15432536113) First Batch Returned: 15.43s (15432542468) Last Batch Returned: 15.43s (15432542735) Closed: 15.43s (15432570588) Buffer pool - AllocTime: 3.56us (3562) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 6.0 MiB (6291456) - CumulativeAllocations: 3 (3) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 12.0 MiB (12582912) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 6.0 MiB (6291456) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=8) - ConvertRowBatchTime: 596ns (596) - InactiveTotalTime: 15.09s (15085311169) - PeakMemoryUsage: 0 B (0) - RowsReturned: 0 (0) - RowsReturnedRate: 0 per second (0) - TotalTime: 15.09s (15085332682) Node Lifecycle Event Timeline Open Started: 213ms (213531904) Open Finished: 15.30s (15298849061) First Batch Requested: 15.30s (15299117410) First Batch Returned: 15.30s (15299129302) Last Batch Returned: 15.30s (15299129754) Closed: 15.30s (15299231861) Buffer pool - AllocTime: 0ns (0) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 0 B (0) - CumulativeAllocations: 0 (0) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 0 B (0) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 0 B (0) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 15.09s (15085311169) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 0 B (0) - TotalGetBatchTime: 15.09s (15085313602) - DataWaitTime: 15.09s (15085311169) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 0 (0) - TotalBatchesReceived: 0 (0) - TotalBytesReceived: 0 B (0) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Averaged Fragment F01 split sizes: min: 0, max: 0, avg: 0, stddev: 0 completion times: min:15s324ms max:16s015ms mean: 15s727ms stddev:297.078ms execution rates: min:0.00 /sec max:0.00 /sec mean:0.00 /sec stddev:0.00 /sec num instances: 5 - AverageThreadTokens: 1.23 (1.231486837226548) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 844.8 MiB (885866326) - PeakReservation: 834.0 MiB (874512384) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 888.7 MiB (931853590) - RowsProduced: 18 (18) - TotalNetworkReceiveTime: 13.13s (13128813220) - TotalNetworkSendTime: 1ms (1491713) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 707 (707) - TotalThreadsTotalWallClockTime: 18.64s (18640933187) - TotalThreadsSysTime: 741ms (741967000) - TotalThreadsUserTime: 4.62s (4624669800) - TotalThreadsVoluntaryContextSwitches: 15,052 (15052) - TotalTime: 15.10s (15102197414) Fragment Instance Lifecycle Timings - ExecTime: 899ms (899855419) - ExecTreeExecTime: 895ms (895535852) - InactiveTotalTime: 0ns (0) - OpenTime: 14.20s (14201548881) - ExecTreeOpenTime: 13.53s (13526146849) - PrepareTime: 726.70us (726703) - ExecTreePrepareTime: 530.94us (530936) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=8) - EosSent: 5 (5) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 16.0 KiB (16368) - RowsSent: 18 (18) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 51.87us (51868) - TotalBytesSent: 4.8 KiB (4911) - TotalTime: 1ms (1717243) - UncompressedRowBatchSize: 9.3 KiB (9487) HASH_JOIN_NODE (id=5) - BuildRows: 3,826,392 (3826392) - BuildTime: 1.05s (1054167814) - InactiveTotalTime: 0ns (0) - LocalTime: 323ms (323179651) - NullAwareAntiJoinEvalTime: 0ns (0) - PeakMemoryUsage: 430.0 MiB (450935040) - ProbeRows: 764,782 (764782) - ProbeRowsPartitioned: 0 (0) - ProbeTime: 317ms (317842435) - RowsReturned: 18 (18) - RowsReturnedRate: 1 per second (1) - TotalTime: 14.42s (14422421821) Buffer pool - AllocTime: 10ms (10160623) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 416.0 MiB (436207616) - CumulativeAllocations: 160 (160) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 422.0 MiB (442499072) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 416.0 MiB (436207616) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 9ms (9692777) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Hash Join Builder (join_node_id=5) - BuildRowsPartitionTime: 634ms (634529836) - BuildRowsPartitioned: 3,826,392 (3826392) - HashTablesBuildTime: 415ms (415103309) - InactiveTotalTime: 0ns (0) - LargestPartitionPercent: 6 (6) - MaxPartitionLevel: 0 (0) - NumHashTableBuildsSkipped: 0 (0) - NumRepartitions: 0 (0) - PartitionsCreated: 16 (16) - PeakMemoryUsage: 25.1 KiB (25728) - RepartitionTime: 0ns (0) - SpilledPartitions: 0 (0) - TotalTime: 1.05s (1050514441) Hash Table - HashBuckets: 8,388,608 (8388608) - HashCollisions: 2,067 (2067) - InactiveTotalTime: 0ns (0) - Probes: 4,591,174 (4591174) - Resizes: 0 (0) - TotalTime: 0ns (0) - Travel: 1,712,082 (1712082) EXCHANGE_NODE (id=7) - ConvertRowBatchTime: 56ms (56316340) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 16.5 MiB (17301066) - RowsReturned: 3,826,392 (3826392) - RowsReturnedRate: 1557186 per second (1557186) - TotalTime: 2.48s (2476404358) Buffer pool - AllocTime: 9ms (9869268) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 496.3 MiB (520445952) - CumulativeAllocations: 7,486 (7486) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.3 MiB (17073766) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.3 MiB (17073766) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 3ms (3011025) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 310.2 MiB (325243320) - TotalGetBatchTime: 2.42s (2415711239) - DataWaitTime: 2.40s (2401230103) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 195ms (195444450) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 3,743 (3743) - TotalBatchesReceived: 3,743 (3743) - TotalBytesReceived: 259.9 MiB (272547623) - TotalEarlySenders: 5 (5) - TotalEosReceived: 11 (11) - TotalHasDeferredRPCsTime: 528ms (528575783) - TotalRPCsDeferred: 57 (57) - TotalTime: 0ns (0) SELECT_NODE (id=3) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 8.0 MiB (8404992) - RowsReturned: 764,782 (764782) - RowsReturnedRate: 54250 per second (54250) - TotalTime: 14.10s (14101423960) ANALYTIC_EVAL_NODE (id=2) - EvaluationTime: 563ms (563717728) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.5 MiB (13156352) - RowsReturned: 764,782 (764782) - RowsReturnedRate: 54276 per second (54276) - TotalTime: 14.09s (14094800487) Buffer pool - AllocTime: 300.09us (300093) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 404.4 MiB (424044134) - CumulativeAllocations: 202 (202) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 4.0 MiB (4194304) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 65.94us (65942) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) SORT_NODE (id=1) - InMemorySortTime: 1.69s (1692837423) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 408.0 MiB (427835392) - RowsReturned: 764,782 (764782) - RowsReturnedRate: 56545 per second (56545) - SortDataSize: 403.5 MiB (423148563) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 13.53s (13528232617) Buffer pool - AllocTime: 16ms (16116724) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 408.0 MiB (427819008) - CumulativeAllocations: 204 (204) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 408.0 MiB (427819008) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 408.0 MiB (427819008) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 15ms (15481643) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=6) - ConvertRowBatchTime: 30ms (30067012) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 14.8 MiB (15468430) - RowsReturned: 764,782 (764782) - RowsReturnedRate: 71132 per second (71132) - TotalTime: 10.75s (10753052736) Buffer pool - AllocTime: 148ms (148712977) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 563.8 MiB (591170764) - CumulativeAllocations: 28,865 (28865) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 14.7 MiB (15459942) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 14.7 MiB (15459942) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 111ms (111078650) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 409.4 MiB (429266821) - TotalGetBatchTime: 10.71s (10708068190) - DataWaitTime: 10.65s (10655051293) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 804ms (804864329) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 14,432 (14432) - TotalBatchesReceived: 14,432 (14432) - TotalBytesReceived: 185.6 MiB (194575573) - TotalEarlySenders: 1 (1) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 302ms (302969855) - TotalRPCsDeferred: 3 (3) - TotalTime: 0ns (0) Fragment F01 Instance a7420b313faa4b7d:a438981b00000014 (host=hslave608.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.709 - AverageThreadTokens: 1.23 (1.2333333333333334) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 844.8 MiB (885823728) - PeakReservation: 834.0 MiB (874512384) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 1,000.0 MiB (1048533058) - RowsProduced: 15 (15) - TotalNetworkReceiveTime: 13.06s (13056223715) - TotalNetworkSendTime: 634.33us (634334) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 717 (717) - TotalThreadsTotalWallClockTime: 18.90s (18897080507) - TotalThreadsSysTime: 809ms (809837000) - TotalThreadsUserTime: 4.82s (4817528000) - TotalThreadsVoluntaryContextSwitches: 15,097 (15097) - TotalTime: 15.35s (15347837860) Fragment Instance Lifecycle Event Timeline Prepare Finished: 2ms (2247325) Open Finished: 14.28s (14275629505) First Batch Produced: 14.31s (14312750261) First Batch Sent: 14.31s (14312756089) ExecInternal Finished: 15.35s (15349682949) Fragment Instance Lifecycle Timings - ExecTime: 1.07s (1073969818) - ExecTreeExecTime: 1.07s (1070121982) - InactiveTotalTime: 0ns (0) - OpenTime: 14.27s (14273367307) - ExecTreeOpenTime: 13.70s (13698842311) - PrepareTime: 459.86us (459860) - ExecTreePrepareTime: 352.25us (352255) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=8) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 634.33us (634334) - PeakMemoryUsage: 16.0 KiB (16368) - RowsSent: 15 (15) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 47.53us (47532) - TotalBytesSent: 4.1 KiB (4188) - TotalTime: 848.69us (848689) - UncompressedRowBatchSize: 7.5 KiB (7634) HASH_JOIN_NODE (id=5) ExecOption: Join Build-Side Prepared Asynchronously, Probe Side Codegen Enabled - BuildRows: 3,826,392 (3826392) - BuildTime: 1.08s (1080022714) - InactiveTotalTime: 0ns (0) - LocalTime: 459ms (459369309) - NullAwareAntiJoinEvalTime: 0ns (0) - PeakMemoryUsage: 430.0 MiB (450935040) - ProbeRows: 765,338 (765338) - ProbeRowsPartitioned: 0 (0) - ProbeTime: 454ms (454110415) - RowsReturned: 15 (15) - RowsReturnedRate: 1 per second (1) - TotalTime: 14.77s (14769302323) Node Lifecycle Event Timeline Open Started: 576ms (576745899) Open Finished: 14.28s (14275584331) First Batch Requested: 14.28s (14275635645) First Batch Returned: 14.31s (14312748220) Last Batch Returned: 15.35s (15348602398) Closed: 15.35s (15348851488) Buffer pool - AllocTime: 12ms (12631263) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 416.0 MiB (436207616) - CumulativeAllocations: 160 (160) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 422.0 MiB (442499072) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 416.0 MiB (436207616) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 10ms (10972082) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Hash Join Builder (join_node_id=5) ExecOption: Build Side Codegen Enabled, Hash Table Construction Codegen Enabled - BuildRowsPartitionTime: 669ms (669429317) - BuildRowsPartitioned: 3,826,392 (3826392) - HashTablesBuildTime: 407ms (407552084) - InactiveTotalTime: 0ns (0) - LargestPartitionPercent: 6 (6) - MaxPartitionLevel: 0 (0) - NumHashTableBuildsSkipped: 0 (0) - NumRepartitions: 0 (0) - PartitionsCreated: 16 (16) - PeakMemoryUsage: 25.1 KiB (25728) - RepartitionTime: 0ns (0) - SpilledPartitions: 0 (0) - TotalTime: 1.08s (1077669518) Hash Table - HashBuckets: 8,388,608 (8388608) - HashCollisions: 2,078 (2078) - InactiveTotalTime: 0ns (0) - Probes: 4,591,730 (4591730) - Resizes: 0 (0) - TotalTime: 0ns (0) - Travel: 1,711,568 (1711568) EXCHANGE_NODE (id=7) - ConvertRowBatchTime: 54ms (54589781) - InactiveTotalTime: 2.39s (2386469624) - PeakMemoryUsage: 16.6 MiB (17376692) - RowsReturned: 3,826,392 (3826392) - RowsReturnedRate: 1557731 per second (1557731) - TotalTime: 2.46s (2456386987) Node Lifecycle Event Timeline Open Started: 576ms (576910694) Open Finished: 576ms (576919837) First Batch Requested: 577ms (577174867) First Batch Returned: 577ms (577211707) Last Batch Returned: 3.71s (3713308221) Closed: 4.13s (4126660993) Buffer pool - AllocTime: 8ms (8130053) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 496.3 MiB (520445952) - CumulativeAllocations: 7,486 (7486) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.3 MiB (17080320) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.3 MiB (17080320) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 1ms (1612918) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 310.2 MiB (325243320) - TotalGetBatchTime: 2.40s (2397369265) - DataWaitTime: 2.39s (2386469624) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 190ms (190446447) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 3,743 (3743) - TotalBatchesReceived: 3,743 (3743) - TotalBytesReceived: 259.9 MiB (272547623) - TotalEarlySenders: 9 (9) - TotalEosReceived: 11 (11) - TotalHasDeferredRPCsTime: 506ms (506439541) - TotalRPCsDeferred: 15 (15) - TotalTime: 0ns (0) SELECT_NODE (id=3) ExecOption: Codegen Enabled - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 8.0 MiB (8404992) - RowsReturned: 765,338 (765338) - RowsReturnedRate: 53474 per second (53474) - TotalTime: 14.31s (14312098816) Node Lifecycle Event Timeline Open Started: 576ms (576912843) Open Finished: 14.27s (14273370695) First Batch Requested: 14.27s (14273503169) First Batch Returned: 14.28s (14275580771) Last Batch Returned: 15.35s (15347536334) Closed: 15.35s (15348847491) ANALYTIC_EVAL_NODE (id=2) - EvaluationTime: 601ms (601754888) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.5 MiB (13156352) - RowsReturned: 765,338 (765338) - RowsReturnedRate: 53503 per second (53503) - TotalTime: 14.30s (14304346093) Node Lifecycle Event Timeline Open Started: 576ms (576922872) Open Finished: 14.27s (14272126470) First Batch Requested: 14.27s (14273511251) First Batch Returned: 14.28s (14275551096) Last Batch Returned: 15.35s (15347531436) Closed: 15.35s (15348838501) Buffer pool - AllocTime: 326.05us (326053) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 404.0 MiB (423624704) - CumulativeAllocations: 202 (202) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 4.0 MiB (4194304) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 44.42us (44419) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) SORT_NODE (id=1) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 1.85s (1850657952) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 408.0 MiB (427835392) - RowsReturned: 765,338 (765338) - RowsReturnedRate: 55865 per second (55865) - SortDataSize: 403.9 MiB (423530689) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 13.70s (13699657019) Node Lifecycle Event Timeline Open Started: 576ms (576925354) Open Finished: 14.27s (14271832051) First Batch Requested: 14.27s (14273525733) First Batch Returned: 14.27s (14273533075) Last Batch Returned: 15.35s (15347496001) Closed: 15.35s (15348836159) Buffer pool - AllocTime: 19ms (19017817) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 408.0 MiB (427819008) - CumulativeAllocations: 204 (204) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 408.0 MiB (427819008) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 408.0 MiB (427819008) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 18ms (18589062) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=6) - ConvertRowBatchTime: 28ms (28250706) - InactiveTotalTime: 10.60s (10596138811) - PeakMemoryUsage: 14.7 MiB (15431578) - RowsReturned: 765,338 (765338) - RowsReturnedRate: 71545 per second (71545) - TotalTime: 10.70s (10697244201) Node Lifecycle Event Timeline Open Started: 576ms (576926980) Open Finished: 576ms (576930346) First Batch Requested: 576ms (576977798) First Batch Returned: 577ms (577027447) Last Batch Returned: 12.42s (12420274295) Closed: 12.42s (12421130360) Buffer pool - AllocTime: 202ms (202076845) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 564.2 MiB (591577088) - CumulativeAllocations: 28,888 (28888) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 14.7 MiB (15417344) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 14.7 MiB (15417344) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 177ms (177361616) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 409.7 MiB (429653393) - TotalGetBatchTime: 10.65s (10654036700) - DataWaitTime: 10.60s (10596138811) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 899ms (899287450) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 14,444 (14444) - TotalBatchesReceived: 14,444 (14444) - TotalBytesReceived: 185.7 MiB (194745351) - TotalEarlySenders: 2 (2) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 342ms (342080195) - TotalRPCsDeferred: 3 (3) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000011 (host=hslave612.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.662 - AverageThreadTokens: 1.26 (1.2580645161290323) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 844.8 MiB (885831920) - PeakReservation: 834.0 MiB (874512384) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 860.8 MiB (902638532) - RowsProduced: 18 (18) - TotalNetworkReceiveTime: 13.54s (13544628253) - TotalNetworkSendTime: 778.22us (778220) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 436 (436) - TotalThreadsTotalWallClockTime: 19.08s (19077545501) - TotalThreadsSysTime: 919ms (919505000) - TotalThreadsUserTime: 4.40s (4404011000) - TotalThreadsVoluntaryContextSwitches: 15,463 (15463) - TotalTime: 15.32s (15316118138) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1226834) Open Finished: 14.25s (14251767349) First Batch Produced: 14.28s (14276566541) First Batch Sent: 14.28s (14276569662) ExecInternal Finished: 15.32s (15316800946) Fragment Instance Lifecycle Timings - ExecTime: 1.06s (1064969598) - ExecTreeExecTime: 1.06s (1061259489) - InactiveTotalTime: 0ns (0) - OpenTime: 14.25s (14250537815) - ExecTreeOpenTime: 13.72s (13723470241) - PrepareTime: 578.35us (578346) - ExecTreePrepareTime: 442.95us (442948) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=8) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 778.22us (778220) - PeakMemoryUsage: 16.0 KiB (16368) - RowsSent: 18 (18) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 56.87us (56870) - TotalBytesSent: 5.2 KiB (5351) - TotalTime: 986.16us (986158) - UncompressedRowBatchSize: 9.2 KiB (9398) HASH_JOIN_NODE (id=5) ExecOption: Join Build-Side Prepared Asynchronously, Probe Side Codegen Enabled - BuildRows: 3,826,392 (3826392) - BuildTime: 963ms (963800903) - InactiveTotalTime: 0ns (0) - LocalTime: 463ms (463975857) - NullAwareAntiJoinEvalTime: 0ns (0) - PeakMemoryUsage: 430.0 MiB (450935040) - ProbeRows: 764,779 (764779) - ProbeRowsPartitioned: 0 (0) - ProbeTime: 458ms (458781090) - RowsReturned: 18 (18) - RowsReturnedRate: 1 per second (1) - TotalTime: 14.79s (14785337280) Node Lifecycle Event Timeline Open Started: 528ms (528269740) Open Finished: 14.25s (14251736496) First Batch Requested: 14.25s (14251769666) First Batch Returned: 14.28s (14276564024) Last Batch Returned: 15.31s (15315702829) Closed: 15.31s (15315835470) Buffer pool - AllocTime: 6ms (6848643) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 416.0 MiB (436207616) - CumulativeAllocations: 160 (160) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 422.0 MiB (442499072) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 416.0 MiB (436207616) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 6ms (6706010) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Hash Join Builder (join_node_id=5) ExecOption: Build Side Codegen Enabled, Hash Table Construction Codegen Enabled - BuildRowsPartitionTime: 538ms (538419052) - BuildRowsPartitioned: 3,826,392 (3826392) - HashTablesBuildTime: 422ms (422679336) - InactiveTotalTime: 0ns (0) - LargestPartitionPercent: 6 (6) - MaxPartitionLevel: 0 (0) - NumHashTableBuildsSkipped: 0 (0) - NumRepartitions: 0 (0) - PartitionsCreated: 16 (16) - PeakMemoryUsage: 25.1 KiB (25728) - RepartitionTime: 0ns (0) - SpilledPartitions: 0 (0) - TotalTime: 961ms (961912716) Hash Table - HashBuckets: 8,388,608 (8388608) - HashCollisions: 2,035 (2035) - InactiveTotalTime: 0ns (0) - Probes: 4,591,171 (4591171) - Resizes: 0 (0) - TotalTime: 0ns (0) - Travel: 1,710,774 (1710774) EXCHANGE_NODE (id=7) - ConvertRowBatchTime: 49ms (49284970) - InactiveTotalTime: 2.73s (2729588081) - PeakMemoryUsage: 16.4 MiB (17221105) - RowsReturned: 3,826,392 (3826392) - RowsReturnedRate: 1370527 per second (1370527) - TotalTime: 2.79s (2791911513) Node Lifecycle Event Timeline Open Started: 528ms (528434715) Open Finished: 528ms (528450068) First Batch Requested: 528ms (528751324) First Batch Returned: 528ms (528776300) Last Batch Returned: 3.87s (3867483489) Closed: 4.29s (4290477694) Buffer pool - AllocTime: 7ms (7143648) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 496.3 MiB (520445952) - CumulativeAllocations: 7,486 (7486) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.3 MiB (17072128) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.3 MiB (17072128) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 1ms (1795528) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 310.2 MiB (325243320) - TotalGetBatchTime: 2.74s (2738906055) - DataWaitTime: 2.73s (2729588081) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 169ms (169435138) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 3,743 (3743) - TotalBatchesReceived: 3,743 (3743) - TotalBytesReceived: 259.9 MiB (272547623) - TotalEarlySenders: 4 (4) - TotalEosReceived: 11 (11) - TotalHasDeferredRPCsTime: 303ms (303144819) - TotalRPCsDeferred: 9 (9) - TotalTime: 0ns (0) SELECT_NODE (id=3) ExecOption: Codegen Enabled - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 8.0 MiB (8404992) - RowsReturned: 764,779 (764779) - RowsReturnedRate: 53394 per second (53394) - TotalTime: 14.32s (14323221348) Node Lifecycle Event Timeline Open Started: 528ms (528435412) Open Finished: 14.25s (14249559715) First Batch Requested: 14.25s (14249628976) First Batch Returned: 14.25s (14251732457) Last Batch Returned: 15.31s (15314059523) Closed: 15.31s (15315832068) ANALYTIC_EVAL_NODE (id=2) - EvaluationTime: 587ms (587820980) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.5 MiB (13156352) - RowsReturned: 764,779 (764779) - RowsReturnedRate: 53419 per second (53419) - TotalTime: 14.32s (14316531293) Node Lifecycle Event Timeline Open Started: 528ms (528448280) Open Finished: 14.25s (14249540405) First Batch Requested: 14.25s (14249632821) First Batch Returned: 14.25s (14251712713) Last Batch Returned: 15.31s (15314047497) Closed: 15.31s (15315823851) Buffer pool - AllocTime: 353.74us (353739) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 404.0 MiB (423624704) - CumulativeAllocations: 202 (202) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 4.0 MiB (4194304) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 100.26us (100261) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) SORT_NODE (id=1) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 1.67s (1673857573) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 408.0 MiB (427835392) - RowsReturned: 764,779 (764779) - RowsReturnedRate: 55718 per second (55718) - SortDataSize: 403.4 MiB (423013770) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 13.72s (13725661561) Node Lifecycle Event Timeline Open Started: 528ms (528450712) Open Finished: 14.25s (14249342716) First Batch Requested: 14.25s (14249635766) First Batch Returned: 14.25s (14249641928) Last Batch Returned: 15.31s (15313917350) Closed: 15.31s (15315819624) Buffer pool - AllocTime: 17ms (17727828) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 408.0 MiB (427819008) - CumulativeAllocations: 204 (204) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 408.0 MiB (427819008) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 408.0 MiB (427819008) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 17ms (17337729) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=6) - ConvertRowBatchTime: 28ms (28857540) - InactiveTotalTime: 10.76s (10756138729) - PeakMemoryUsage: 14.7 MiB (15453743) - RowsReturned: 764,779 (764779) - RowsReturnedRate: 70531 per second (70531) - TotalTime: 10.84s (10843157236) Node Lifecycle Event Timeline Open Started: 528ms (528452359) Open Finished: 528ms (528455624) First Batch Requested: 528ms (528500541) First Batch Returned: 528ms (528586152) Last Batch Returned: 12.57s (12574365030) Closed: 12.57s (12575471434) Buffer pool - AllocTime: 227ms (227089863) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 563.7 MiB (591126528) - CumulativeAllocations: 28,864 (28864) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 14.7 MiB (15425536) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 14.7 MiB (15425536) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 200ms (200861312) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 409.3 MiB (429132002) - TotalGetBatchTime: 10.80s (10800672862) - DataWaitTime: 10.76s (10756138729) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 897ms (897798684) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 14,432 (14432) - TotalBatchesReceived: 14,432 (14432) - TotalBytesReceived: 185.5 MiB (194516225) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 145ms (145041943) - TotalRPCsDeferred: 2 (2) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000013 (host=hslave412.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.621 - AverageThreadTokens: 1.23 (1.2258064516129032) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 844.9 MiB (885962992) - PeakReservation: 834.0 MiB (874512384) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 860.9 MiB (902769876) - RowsProduced: 20 (20) - TotalNetworkReceiveTime: 13.21s (13214998614) - TotalNetworkSendTime: 628.88us (628879) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 437 (437) - TotalThreadsTotalWallClockTime: 18.73s (18732525820) - TotalThreadsSysTime: 717ms (717976000) - TotalThreadsUserTime: 4.71s (4711152000) - TotalThreadsVoluntaryContextSwitches: 15,366 (15366) - TotalTime: 15.23s (15232680543) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1550458) Open Finished: 14.32s (14323266998) First Batch Produced: 14.33s (14334522995) First Batch Sent: 14.33s (14334525992) ExecInternal Finished: 15.23s (15233508763) Fragment Instance Lifecycle Timings - ExecTime: 910ms (910176675) - ExecTreeExecTime: 906ms (906696061) - InactiveTotalTime: 0ns (0) - OpenTime: 14.32s (14321689975) - ExecTreeOpenTime: 13.59s (13590660536) - PrepareTime: 678.66us (678659) - ExecTreePrepareTime: 418.59us (418588) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=8) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 628.88us (628879) - PeakMemoryUsage: 16.0 KiB (16368) - RowsSent: 20 (20) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 50.92us (50920) - TotalBytesSent: 5.0 KiB (5169) - TotalTime: 852.47us (852471) - UncompressedRowBatchSize: 10.0 KiB (10284) HASH_JOIN_NODE (id=5) ExecOption: Join Build-Side Prepared Asynchronously, Probe Side Codegen Enabled - BuildRows: 3,826,392 (3826392) - BuildTime: 956ms (956553490) - InactiveTotalTime: 0ns (0) - LocalTime: 317ms (317843181) - NullAwareAntiJoinEvalTime: 0ns (0) - PeakMemoryUsage: 430.0 MiB (450935040) - ProbeRows: 764,000 (764000) - ProbeRowsPartitioned: 0 (0) - ProbeTime: 312ms (312754706) - RowsReturned: 20 (20) - RowsReturnedRate: 1 per second (1) - TotalTime: 14.50s (14497873281) Node Lifecycle Event Timeline Open Started: 732ms (732564636) Open Finished: 14.32s (14323218204) First Batch Requested: 14.32s (14323275122) First Batch Returned: 14.33s (14334521210) Last Batch Returned: 15.23s (15232539318) Closed: 15.23s (15232692145) Buffer pool - AllocTime: 4ms (4841105) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 416.0 MiB (436207616) - CumulativeAllocations: 160 (160) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 422.0 MiB (442499072) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 416.0 MiB (436207616) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 4ms (4676416) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Hash Join Builder (join_node_id=5) ExecOption: Build Side Codegen Enabled, Hash Table Construction Codegen Enabled - BuildRowsPartitionTime: 574ms (574198436) - BuildRowsPartitioned: 3,826,392 (3826392) - HashTablesBuildTime: 373ms (373194429) - InactiveTotalTime: 0ns (0) - LargestPartitionPercent: 6 (6) - MaxPartitionLevel: 0 (0) - NumHashTableBuildsSkipped: 0 (0) - NumRepartitions: 0 (0) - PartitionsCreated: 16 (16) - PeakMemoryUsage: 25.1 KiB (25728) - RepartitionTime: 0ns (0) - SpilledPartitions: 0 (0) - TotalTime: 948ms (948262703) Hash Table - HashBuckets: 8,388,608 (8388608) - HashCollisions: 2,071 (2071) - InactiveTotalTime: 0ns (0) - Probes: 4,590,392 (4590392) - Resizes: 0 (0) - TotalTime: 0ns (0) - Travel: 1,713,131 (1713131) EXCHANGE_NODE (id=7) - ConvertRowBatchTime: 51ms (51268984) - InactiveTotalTime: 2.47s (2466993111) - PeakMemoryUsage: 16.4 MiB (17220406) - RowsReturned: 3,826,392 (3826392) - RowsReturnedRate: 1508599 per second (1508599) - TotalTime: 2.54s (2536386321) Node Lifecycle Event Timeline Open Started: 732ms (732735961) Open Finished: 732ms (732745042) First Batch Requested: 733ms (733169977) First Batch Returned: 733ms (733197824) Last Batch Returned: 3.86s (3859667918) Closed: 4.23s (4233402440) Buffer pool - AllocTime: 8ms (8754466) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 496.3 MiB (520445952) - CumulativeAllocations: 7,486 (7486) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.3 MiB (17072128) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.3 MiB (17072128) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 2ms (2104038) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 310.2 MiB (325243320) - TotalGetBatchTime: 2.48s (2480728557) - DataWaitTime: 2.47s (2466993111) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 177ms (177332056) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 3,743 (3743) - TotalBatchesReceived: 3,743 (3743) - TotalBytesReceived: 259.9 MiB (272547623) - TotalEarlySenders: 4 (4) - TotalEosReceived: 11 (11) - TotalHasDeferredRPCsTime: 515ms (515507009) - TotalRPCsDeferred: 8 (8) - TotalTime: 0ns (0) SELECT_NODE (id=3) ExecOption: Codegen Enabled - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 8.0 MiB (8404992) - RowsReturned: 764,000 (764000) - RowsReturnedRate: 53870 per second (53870) - TotalTime: 14.18s (14182255736) Node Lifecycle Event Timeline Open Started: 732ms (732739348) Open Finished: 14.32s (14321629852) First Batch Requested: 14.32s (14321689986) First Batch Returned: 14.32s (14323210806) Last Batch Returned: 15.23s (15231282439) Closed: 15.23s (15232685993) ANALYTIC_EVAL_NODE (id=2) - EvaluationTime: 580ms (580120089) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.5 MiB (13156352) - RowsReturned: 764,000 (764000) - RowsReturnedRate: 53894 per second (53894) - TotalTime: 14.18s (14175867912) Node Lifecycle Event Timeline Open Started: 732ms (732749979) Open Finished: 14.32s (14321619951) First Batch Requested: 14.32s (14321692512) First Batch Returned: 14.32s (14323187738) Last Batch Returned: 15.23s (15231277405) Closed: 15.23s (15232680928) Buffer pool - AllocTime: 314.78us (314781) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 404.0 MiB (423624704) - CumulativeAllocations: 202 (202) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 4.0 MiB (4194304) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 58.75us (58750) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) SORT_NODE (id=1) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 1.75s (1754577750) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 408.0 MiB (427835392) - RowsReturned: 764,000 (764000) - RowsReturnedRate: 56205 per second (56205) - SortDataSize: 403.2 MiB (422760013) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 13.59s (13592876436) Node Lifecycle Event Timeline Open Started: 732ms (732752022) Open Finished: 14.32s (14321425418) First Batch Requested: 14.32s (14321697752) First Batch Returned: 14.32s (14321704485) Last Batch Returned: 15.23s (15231201074) Closed: 15.23s (15232678421) Buffer pool - AllocTime: 12ms (12682509) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 408.0 MiB (427819008) - CumulativeAllocations: 204 (204) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 408.0 MiB (427819008) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 408.0 MiB (427819008) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 12ms (12182202) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=6) - ConvertRowBatchTime: 30ms (30482621) - InactiveTotalTime: 10.67s (10670510299) - PeakMemoryUsage: 14.8 MiB (15556608) - RowsReturned: 764,000 (764000) - RowsReturnedRate: 70904 per second (70904) - TotalTime: 10.78s (10775082162) Node Lifecycle Event Timeline Open Started: 732ms (732754864) Open Finished: 732ms (732759208) First Batch Requested: 732ms (732843714) First Batch Returned: 732ms (732968693) Last Batch Returned: 12.57s (12566495581) Closed: 12.57s (12566831028) Buffer pool - AllocTime: 113ms (113309810) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 563.3 MiB (590659584) - CumulativeAllocations: 28,836 (28836) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 14.8 MiB (15556608) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 14.8 MiB (15556608) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 81ms (81792287) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 409.0 MiB (428872013) - TotalGetBatchTime: 10.73s (10729023897) - DataWaitTime: 10.67s (10670510299) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 809ms (809131025) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 14,418 (14418) - TotalBatchesReceived: 14,418 (14418) - TotalBytesReceived: 185.4 MiB (194380498) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 372ms (372506002) - TotalRPCsDeferred: 4 (4) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000010 (host=hslave514.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.014 - AverageThreadTokens: 1.23 (1.2333333333333334) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 844.7 MiB (885709040) - PeakReservation: 834.0 MiB (874512384) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 860.7 MiB (902515652) - RowsProduced: 21 (21) - TotalNetworkReceiveTime: 13.27s (13271950781) - TotalNetworkSendTime: 4ms (4536865) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 720 (720) - TotalThreadsTotalWallClockTime: 18.53s (18532660371) - TotalThreadsSysTime: 630ms (630018000) - TotalThreadsUserTime: 4.54s (4536744000) - TotalThreadsVoluntaryContextSwitches: 14,670 (14670) - TotalTime: 14.93s (14927952938) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1705527) Open Finished: 14.19s (14185623526) First Batch Produced: 14.19s (14191257762) First Batch Sent: 14.19s (14191261222) ExecInternal Finished: 14.93s (14929159579) Fragment Instance Lifecycle Timings - ExecTime: 743ms (743427107) - ExecTreeExecTime: 736ms (736154010) - InactiveTotalTime: 0ns (0) - OpenTime: 14.18s (14183909526) - ExecTreeOpenTime: 13.47s (13470427944) - PrepareTime: 579.69us (579688) - ExecTreePrepareTime: 442.24us (442236) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=8) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 4ms (4536865) - PeakMemoryUsage: 16.0 KiB (16368) - RowsSent: 21 (21) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 62.23us (62228) - TotalBytesSent: 4.9 KiB (5028) - TotalTime: 4ms (4786939) - UncompressedRowBatchSize: 10.7 KiB (11006) HASH_JOIN_NODE (id=5) ExecOption: Join Build-Side Prepared Asynchronously, Probe Side Codegen Enabled - BuildRows: 3,826,392 (3826392) - BuildTime: 1.12s (1120550973) - InactiveTotalTime: 0ns (0) - LocalTime: 181ms (181508788) - NullAwareAntiJoinEvalTime: 0ns (0) - PeakMemoryUsage: 430.0 MiB (450935040) - ProbeRows: 764,092 (764092) - ProbeRowsPartitioned: 0 (0) - ProbeTime: 176ms (176431454) - RowsReturned: 21 (21) - RowsReturnedRate: 1 per second (1) - TotalTime: 14.21s (14207169850) Node Lifecycle Event Timeline Open Started: 715ms (715173746) Open Finished: 14.19s (14185597040) First Batch Requested: 14.19s (14185626190) First Batch Returned: 14.19s (14191255549) Last Batch Returned: 14.92s (14923909800) Closed: 14.92s (14924363142) Buffer pool - AllocTime: 12ms (12680505) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 416.0 MiB (436207616) - CumulativeAllocations: 160 (160) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 422.0 MiB (442499072) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 416.0 MiB (436207616) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 12ms (12477619) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Hash Join Builder (join_node_id=5) ExecOption: Build Side Codegen Enabled, Hash Table Construction Codegen Enabled - BuildRowsPartitionTime: 694ms (694261407) - BuildRowsPartitioned: 3,826,392 (3826392) - HashTablesBuildTime: 422ms (422159727) - InactiveTotalTime: 0ns (0) - LargestPartitionPercent: 6 (6) - MaxPartitionLevel: 0 (0) - NumHashTableBuildsSkipped: 0 (0) - NumRepartitions: 0 (0) - PartitionsCreated: 16 (16) - PeakMemoryUsage: 25.1 KiB (25728) - RepartitionTime: 0ns (0) - SpilledPartitions: 0 (0) - TotalTime: 1.12s (1117255093) Hash Table - HashBuckets: 8,388,608 (8388608) - HashCollisions: 2,078 (2078) - InactiveTotalTime: 0ns (0) - Probes: 4,590,484 (4590484) - Resizes: 0 (0) - TotalTime: 0ns (0) - Travel: 1,712,342 (1712342) EXCHANGE_NODE (id=7) - ConvertRowBatchTime: 62ms (62845869) - InactiveTotalTime: 2.38s (2383973340) - PeakMemoryUsage: 16.4 MiB (17245485) - RowsReturned: 3,826,392 (3826392) - RowsReturnedRate: 1545622 per second (1545622) - TotalTime: 2.48s (2475632289) Node Lifecycle Event Timeline Open Started: 715ms (715334039) Open Finished: 715ms (715347925) First Batch Requested: 715ms (715673153) First Batch Returned: 715ms (715703342) Last Batch Returned: 3.90s (3898201153) Closed: 4.32s (4320662265) Buffer pool - AllocTime: 12ms (12377896) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 496.3 MiB (520445952) - CumulativeAllocations: 7,486 (7486) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.3 MiB (17072128) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.3 MiB (17072128) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 4ms (4450532) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 310.2 MiB (325243320) - TotalGetBatchTime: 2.41s (2408090028) - DataWaitTime: 2.38s (2383973340) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 215ms (215869836) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 3,743 (3743) - TotalBatchesReceived: 3,743 (3743) - TotalBytesReceived: 259.9 MiB (272547623) - TotalEarlySenders: 1 (1) - TotalEosReceived: 11 (11) - TotalHasDeferredRPCsTime: 459ms (459184112) - TotalRPCsDeferred: 6 (6) - TotalTime: 0ns (0) SELECT_NODE (id=3) ExecOption: Codegen Enabled - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 8.0 MiB (8404992) - RowsReturned: 764,092 (764092) - RowsReturnedRate: 54468 per second (54468) - TotalTime: 14.03s (14028016514) Node Lifecycle Event Timeline Open Started: 715ms (715336813) Open Finished: 14.18s (14183249611) First Batch Requested: 14.18s (14183292802) First Batch Returned: 14.19s (14185594264) Last Batch Returned: 14.92s (14922541313) Closed: 14.92s (14924357729) ANALYTIC_EVAL_NODE (id=2) - EvaluationTime: 547ms (547046987) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.5 MiB (13156352) - RowsReturned: 764,092 (764092) - RowsReturnedRate: 54493 per second (54493) - TotalTime: 14.02s (14021653774) Node Lifecycle Event Timeline Open Started: 715ms (715352415) Open Finished: 14.18s (14183236925) First Batch Requested: 14.18s (14183295242) First Batch Returned: 14.19s (14185572441) Last Batch Returned: 14.92s (14922531841) Closed: 14.92s (14924349086) Buffer pool - AllocTime: 275.13us (275131) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 404.0 MiB (423624704) - CumulativeAllocations: 202 (202) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 4.0 MiB (4194304) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 60.46us (60464) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) SORT_NODE (id=1) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 1.58s (1577738899) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 408.0 MiB (427835392) - RowsReturned: 764,092 (764092) - RowsReturnedRate: 56716 per second (56716) - SortDataSize: 403.2 MiB (422755229) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 13.47s (13472149763) Node Lifecycle Event Timeline Open Started: 715ms (715355244) Open Finished: 14.18s (14183108037) First Batch Requested: 14.18s (14183298016) First Batch Returned: 14.18s (14183305074) Last Batch Returned: 14.92s (14922448981) Closed: 14.92s (14924345528) Buffer pool - AllocTime: 23ms (23379173) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 408.0 MiB (427819008) - CumulativeAllocations: 204 (204) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 408.0 MiB (427819008) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 408.0 MiB (427819008) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 21ms (21957183) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=6) - ConvertRowBatchTime: 35ms (35267349) - InactiveTotalTime: 10.80s (10802775417) - PeakMemoryUsage: 14.6 MiB (15302656) - RowsReturned: 764,092 (764092) - RowsReturnedRate: 70037 per second (70037) - TotalTime: 10.91s (10909795962) Node Lifecycle Event Timeline Open Started: 715ms (715356642) Open Finished: 715ms (715358876) First Batch Requested: 715ms (715409497) First Batch Returned: 715ms (715471437) Last Batch Returned: 12.61s (12605114229) Closed: 12.61s (12605354741) Buffer pool - AllocTime: 77ms (77832203) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 563.3 MiB (590643200) - CumulativeAllocations: 28,838 (28838) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 14.6 MiB (15302656) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 14.6 MiB (15302656) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 45ms (45918861) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 409.0 MiB (428867965) - TotalGetBatchTime: 10.86s (10858714480) - DataWaitTime: 10.80s (10802775417) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 754ms (754195079) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 14,419 (14419) - TotalBatchesReceived: 14,419 (14419) - TotalBytesReceived: 185.4 MiB (194418380) - TotalEarlySenders: 0 (0) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 0ns (0) - TotalRPCsDeferred: 0 (0) - TotalTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000012 (host=hslave505.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.251 - AverageThreadTokens: 1.21 (1.206896551724138) - ExchangeScanRatio: 0.00 (0.0) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 845.0 MiB (886003952) - PeakReservation: 834.0 MiB (874512384) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 861.0 MiB (902810836) - RowsProduced: 18 (18) - TotalNetworkReceiveTime: 12.56s (12556264738) - TotalNetworkSendTime: 880.27us (880270) - TotalStorageWaitTime: 0ns (0) - TotalThreadsInvoluntaryContextSwitches: 1,227 (1227) - TotalThreadsTotalWallClockTime: 17.96s (17964853739) - TotalThreadsSysTime: 632ms (632499000) - TotalThreadsUserTime: 4.65s (4653914000) - TotalThreadsVoluntaryContextSwitches: 14,667 (14667) - TotalTime: 14.69s (14686397594) Fragment Instance Lifecycle Event Timeline Prepare Finished: 2ms (2388130) Open Finished: 13.98s (13980642965) First Batch Produced: 13.99s (13987459339) First Batch Sent: 13.99s (13987462439) ExecInternal Finished: 14.69s (14687464920) Fragment Instance Lifecycle Timings - ExecTime: 706ms (706733897) - ExecTreeExecTime: 703ms (703447719) - InactiveTotalTime: 0ns (0) - OpenTime: 13.98s (13978239784) - ExecTreeOpenTime: 13.15s (13147333217) - PrepareTime: 1ms (1336966) - ExecTreePrepareTime: 998.65us (998653) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=8) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 880.27us (880270) - PeakMemoryUsage: 16.0 KiB (16368) - RowsSent: 18 (18) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 41.79us (41793) - TotalBytesSent: 4.7 KiB (4823) - TotalTime: 1ms (1111960) - UncompressedRowBatchSize: 8.9 KiB (9114) HASH_JOIN_NODE (id=5) ExecOption: Join Build-Side Prepared Asynchronously, Probe Side Codegen Enabled - BuildRows: 3,826,392 (3826392) - BuildTime: 1.15s (1149910992) - InactiveTotalTime: 0ns (0) - LocalTime: 193ms (193201123) - NullAwareAntiJoinEvalTime: 0ns (0) - PeakMemoryUsage: 430.0 MiB (450935040) - ProbeRows: 765,702 (765702) - ProbeRowsPartitioned: 0 (0) - ProbeTime: 187ms (187134514) - RowsReturned: 18 (18) - RowsReturnedRate: 1 per second (1) - TotalTime: 13.85s (13852426371) Node Lifecycle Event Timeline Open Started: 833ms (833275656) Open Finished: 13.98s (13980606018) First Batch Requested: 13.98s (13980645829) First Batch Returned: 13.99s (13987457986) Last Batch Returned: 14.69s (14685916141) Closed: 14.69s (14686379996) Buffer pool - AllocTime: 13ms (13801601) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 416.0 MiB (436207616) - CumulativeAllocations: 160 (160) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 422.0 MiB (442499072) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 416.0 MiB (436207616) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 13ms (13631762) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Hash Join Builder (join_node_id=5) ExecOption: Build Side Codegen Enabled, Hash Table Construction Codegen Enabled - BuildRowsPartitionTime: 696ms (696340972) - BuildRowsPartitioned: 3,826,392 (3826392) - HashTablesBuildTime: 449ms (449930972) - InactiveTotalTime: 0ns (0) - LargestPartitionPercent: 6 (6) - MaxPartitionLevel: 0 (0) - NumHashTableBuildsSkipped: 0 (0) - NumRepartitions: 0 (0) - PartitionsCreated: 16 (16) - PeakMemoryUsage: 25.1 KiB (25728) - RepartitionTime: 0ns (0) - SpilledPartitions: 0 (0) - TotalTime: 1.15s (1147472179) Hash Table - HashBuckets: 8,388,608 (8388608) - HashCollisions: 2,077 (2077) - InactiveTotalTime: 0ns (0) - Probes: 4,592,094 (4592094) - Resizes: 0 (0) - TotalTime: 0ns (0) - Travel: 1,712,598 (1712598) EXCHANGE_NODE (id=7) - ConvertRowBatchTime: 63ms (63592099) - InactiveTotalTime: 2.04s (2039126362) - PeakMemoryUsage: 16.6 MiB (17441643) - RowsReturned: 3,826,392 (3826392) - RowsReturnedRate: 1803451 per second (1803451) - TotalTime: 2.12s (2121704682) Node Lifecycle Event Timeline Open Started: 833ms (833432243) Open Finished: 833ms (833444940) First Batch Requested: 834ms (834211572) First Batch Returned: 834ms (834259994) Last Batch Returned: 3.66s (3663044633) Closed: 4.11s (4113319528) Buffer pool - AllocTime: 12ms (12940277) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 496.3 MiB (520445952) - CumulativeAllocations: 7,486 (7486) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 16.3 MiB (17072128) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.3 MiB (17072128) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 5ms (5092110) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 310.2 MiB (325243320) - TotalGetBatchTime: 2.05s (2053462294) - DataWaitTime: 2.04s (2039126362) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 224ms (224138773) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 3,743 (3743) - TotalBatchesReceived: 3,743 (3743) - TotalBytesReceived: 259.9 MiB (272547623) - TotalEarlySenders: 9 (9) - TotalEosReceived: 11 (11) - TotalHasDeferredRPCsTime: 858ms (858603435) - TotalRPCsDeferred: 251 (251) - TotalTime: 0ns (0) SELECT_NODE (id=3) ExecOption: Codegen Enabled - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 8.0 MiB (8404992) - RowsReturned: 765,702 (765702) - RowsReturnedRate: 56048 per second (56048) - TotalTime: 13.66s (13661527390) Node Lifecycle Event Timeline Open Started: 833ms (833432276) Open Finished: 13.98s (13978547448) First Batch Requested: 13.98s (13978587288) First Batch Returned: 13.98s (13980600517) Last Batch Returned: 14.68s (14684512126) Closed: 14.69s (14686376563) ANALYTIC_EVAL_NODE (id=2) - EvaluationTime: 501ms (501845699) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 12.5 MiB (13156352) - RowsReturned: 765,702 (765702) - RowsReturnedRate: 56072 per second (56072) - TotalTime: 13.65s (13655603363) Node Lifecycle Event Timeline Open Started: 833ms (833439364) Open Finished: 13.98s (13978541431) First Batch Requested: 13.98s (13978590340) First Batch Returned: 13.98s (13980580078) Last Batch Returned: 14.68s (14684509018) Closed: 14.69s (14686367502) Buffer pool - AllocTime: 230.76us (230762) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 406.0 MiB (425721856) - CumulativeAllocations: 203 (203) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 4.0 MiB (4194304) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 65.82us (65820) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) SORT_NODE (id=1) SortType: Total ExecOption: Codegen Enabled - InMemorySortTime: 1.61s (1607354944) - InactiveTotalTime: 0ns (0) - InitialRunsCreated: 1 (1) - PeakMemoryUsage: 408.0 MiB (427835392) - RowsReturned: 765,702 (765702) - RowsReturnedRate: 58224 per second (58224) - SortDataSize: 404.1 MiB (423683116) - SpilledRuns: 0 (0) - TotalMergesPerformed: 0 (0) - TotalTime: 13.15s (13150818310) Node Lifecycle Event Timeline Open Started: 833ms (833445151) Open Finished: 13.98s (13977962029) First Batch Requested: 13.98s (13978593871) First Batch Returned: 13.98s (13978599503) Last Batch Returned: 14.68s (14684362303) Closed: 14.69s (14686364026) Buffer pool - AllocTime: 7ms (7776296) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 408.0 MiB (427819008) - CumulativeAllocations: 204 (204) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 408.0 MiB (427819008) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 408.0 MiB (427819008) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 7ms (7342041) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) EXCHANGE_NODE (id=6) - ConvertRowBatchTime: 27ms (27476846) - InactiveTotalTime: 10.45s (10449693210) - PeakMemoryUsage: 14.9 MiB (15597568) - RowsReturned: 765,702 (765702) - RowsReturnedRate: 72647 per second (72647) - TotalTime: 10.54s (10539984119) Node Lifecycle Event Timeline Open Started: 833ms (833446942) Open Finished: 833ms (833451695) First Batch Requested: 833ms (833491863) First Batch Returned: 833ms (833568086) Last Batch Returned: 12.37s (12369588837) Closed: 12.37s (12370591123) Buffer pool - AllocTime: 123ms (123256164) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 564.4 MiB (591847424) - CumulativeAllocations: 28,900 (28900) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 14.9 MiB (15597568) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 14.9 MiB (15597568) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 49ms (49459176) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Dequeue - FirstBatchWaitTime: 0ns (0) - InactiveTotalTime: 0ns (0) - TotalBytesDequeued: 409.9 MiB (429808732) - TotalGetBatchTime: 10.50s (10497893014) - DataWaitTime: 10.45s (10449693210) - TotalTime: 0ns (0) Enqueue - DeserializeRowBatchTime: 663ms (663909407) - InactiveTotalTime: 0ns (0) - TotalBatchesEnqueued: 14,450 (14450) - TotalBatchesReceived: 14,450 (14450) - TotalBytesReceived: 185.8 MiB (194817411) - TotalEarlySenders: 3 (3) - TotalEosReceived: 5 (5) - TotalHasDeferredRPCsTime: 655ms (655221139) - TotalRPCsDeferred: 7 (7) - TotalTime: 0ns (0) Averaged Fragment F00 split sizes: min: 25.24 KB, max: 243.14 MB, avg: 70.43 MB, stddev: 92.61 MB completion times: min:5s320ms max:15s515ms mean: 8s387ms stddev:4s053ms execution rates: min:4.74 KB/sec max:15.67 MB/sec mean:5.55 MB/sec stddev:5.92 MB/sec num instances: 5 - AverageThreadTokens: 1.73 (1.7333333333333336) - ExchangeScanRatio: 2.28 (2.2829240422933137) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 128.3 MiB (134556681) - PeakReservation: 104.2 MiB (109266534) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 731.5 MiB (767038139) - RowsProduced: 764,782 (764782) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 1.82s (1824092105) - TotalStorageWaitTime: 25ms (25569089) - TotalThreadsInvoluntaryContextSwitches: 877 (877) - TotalThreadsTotalWallClockTime: 9.09s (9087757008) - TotalThreadsSysTime: 382ms (382287200) - TotalThreadsUserTime: 2.42s (2423969600) - TotalThreadsVoluntaryContextSwitches: 2,660 (2660) - TotalTime: 4.65s (4648695616) Fragment Instance Lifecycle Timings - ExecTime: 4.52s (4524278972) - ExecTreeExecTime: 63ms (63275959) - InactiveTotalTime: 0ns (0) - OpenTime: 124ms (124157720) - ExecTreeOpenTime: 114.21us (114207) - PrepareTime: 220.85us (220854) - ExecTreePrepareTime: 99.53us (99531) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=6) - EosSent: 5 (5) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 247.7 KiB (253614) - RowsSent: 764,782 (764782) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 1.34s (1339157199) - TotalBytesSent: 185.6 MiB (194575573) - TotalTime: 3.87s (3874771338) - UncompressedRowBatchSize: 409.4 MiB (429266821) HDFS_SCAN_NODE (id=0) - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.80 (0.8) - BytesRead: 67.3 MiB (70574995) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 67.3 MiB (70574995) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 67.3 MiB (70574995) - CachedFileHandlesHitCount: 33 (33) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 384ms (384498513) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 505ms (505592627) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 26 (26) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1,664 (1664) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 127.9 MiB (134114714) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 584.0 MiB/s (612403028) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 325.2 MiB (341034750) - RowBatchQueueGetWaitTime: 47ms (47372325) - RowBatchQueuePeakMemoryUsage: 20.2 MiB (21130393) - RowBatchQueuePutWaitTime: 3.47s (3471445654) - RowBatchesEnqueued: 749 (749) - RowsRead: 764,782 (764782) - RowsReturned: 764,782 (764782) - RowsReturnedRate: 7162756 per second (7162756) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 25ms (25569089) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 132 (132) - ScannerThreadsTotalWallClockTime: 4.44s (4439332574) - ScannerThreadsSysTime: 216ms (216053600) - ScannerThreadsUserTime: 421ms (421119600) - ScannerThreadsVoluntaryContextSwitches: 1,349 (1349) - TotalRawHdfsOpenFileTime: 418.50us (418502) - TotalRawHdfsReadTime: 80ms (80164435) - TotalReadThroughput: 8.8 MiB/s (9242016) - TotalTime: 62ms (62271563) Buffer pool - AllocTime: 1ms (1307851) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 37.0 MiB (38807142) - CumulativeAllocations: 28 (28) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 104.2 MiB (109266534) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 36.9 MiB (38695731) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 1ms (1290653) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F00 Instance a7420b313faa4b7d:a438981b00000004 (host=hslave608.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:25.209 Hdfs split stats (:<# splits>/): 0:1/243.14 MB - AverageThreadTokens: 2.00 (2.0) - ExchangeScanRatio: 2.78 (2.780227952705038) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 143.8 MiB (150836814) - PeakReservation: 105.0 MiB (110125056) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 1,000.0 MiB (1048533058) - RowsProduced: 2,652,844 (2652844) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 3.81s (3814884468) - TotalStorageWaitTime: 86ms (86425733) - TotalThreadsInvoluntaryContextSwitches: 2,738 (2738) - TotalThreadsTotalWallClockTime: 24.73s (24730771521) - TotalThreadsSysTime: 1.30s (1300498000) - TotalThreadsUserTime: 7.86s (7861814000) - TotalThreadsVoluntaryContextSwitches: 8,605 (8605) - TotalTime: 12.42s (12419385089) Fragment Instance Lifecycle Event Timeline Prepare Finished: 1ms (1324316) Open Finished: 96ms (96583538) First Batch Produced: 228ms (228608508) First Batch Sent: 886ms (886696720) ExecInternal Finished: 12.42s (12420664625) Fragment Instance Lifecycle Timings - ExecTime: 12.32s (12323890267) - ExecTreeExecTime: 188ms (188600591) - InactiveTotalTime: 0ns (0) - OpenTime: 95ms (95257048) - ExecTreeOpenTime: 86.48us (86484) - PrepareTime: 202.39us (202386) - ExecTreePrepareTime: 86.99us (86989) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=6) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 3.81s (3814884468) - PeakMemoryUsage: 302.1 KiB (309320) - RowsSent: 2,652,844 (2652844) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 4.50s (4505455816) - TotalBytesSent: 649.5 MiB (681026654) - TotalTime: 10.57s (10567159480) - UncompressedRowBatchSize: 1.4 GiB (1513714582) HDFS_SCAN_NODE (id=0) Table Name: uadata.gcf_v2 Hdfs split stats (:<# splits>/): 0:1/243.14 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 1.00 (1.0) - BytesRead: 233.6 MiB (244953531) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 233.6 MiB (244953531) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 233.6 MiB (244953531) - CachedFileHandlesHitCount: 52 (52) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 1.28s (1278269020) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 1.65s (1645987835) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 26 (26) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 6,184 (6184) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 143.4 MiB (150341761) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 820.5 MiB/s (860315988) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 1.1 GiB (1195845635) - RowBatchQueueGetWaitTime: 131ms (131813732) - RowBatchQueuePeakMemoryUsage: 32.0 MiB (33506125) - RowBatchQueuePutWaitTime: 9.15s (9147653871) - RowBatchesEnqueued: 2,593 (2593) - RowsRead: 2,652,844 (2652844) - RowsReturned: 2,652,844 (2652844) - RowsReturnedRate: 14374342 per second (14374342) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 86ms (86425733) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 502 (502) - ScannerThreadsTotalWallClockTime: 12.31s (12311636571) - ScannerThreadsSysTime: 755ms (755130000) - ScannerThreadsUserTime: 1.43s (1430352000) - ScannerThreadsVoluntaryContextSwitches: 4,566 (4566) - TotalRawHdfsOpenFileTime: 307.83us (307829) - TotalRawHdfsReadTime: 284ms (284725071) - TotalReadThroughput: 19.5 MiB/s (20411093) - TotalTime: 184ms (184554105) Node Lifecycle Event Timeline Open Started: 96ms (96486250) Open Finished: 96ms (96570298) First Batch Requested: 96ms (96585216) First Batch Returned: 228ms (228606329) Last Batch Returned: 12.42s (12419333222) Closed: 12.42s (12419377383) Buffer pool - AllocTime: 5ms (5412402) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 101.1 MiB (106061824) - CumulativeAllocations: 32 (32) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 105.0 MiB (110125056) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 101.0 MiB (105930752) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 5ms (5401001) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000001 (host=hslave612.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:20.043 Hdfs split stats (:<# splits>/): 3:1/91.76 MB - AverageThreadTokens: 2.00 (2.0) - ExchangeScanRatio: 2.71 (2.7096431636956066) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 135.9 MiB (142504662) - PeakReservation: 104.0 MiB (109051904) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 806.9 MiB (846118906) - RowsProduced: 992,310 (992310) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 3.69s (3688278933) - TotalStorageWaitTime: 23ms (23778940) - TotalThreadsInvoluntaryContextSwitches: 1,407 (1407) - TotalThreadsTotalWallClockTime: 16.17s (16173971072) - TotalThreadsSysTime: 507ms (507131000) - TotalThreadsUserTime: 3.29s (3290191000) - TotalThreadsVoluntaryContextSwitches: 4,272 (4272) - TotalTime: 8.16s (8160593136) Fragment Instance Lifecycle Event Timeline Prepare Finished: 509.52us (509525) Open Finished: 100ms (100121387) First Batch Produced: 153ms (153045757) First Batch Sent: 207ms (207666262) ExecInternal Finished: 8.16s (8161276741) Fragment Instance Lifecycle Timings - ExecTime: 8.06s (8060745521) - ExecTreeExecTime: 72ms (72083044) - InactiveTotalTime: 0ns (0) - OpenTime: 99ms (99609353) - ExecTreeOpenTime: 90.54us (90543) - PrepareTime: 206.01us (206014) - ExecTreePrepareTime: 100.20us (100201) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=6) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 3.69s (3688278933) - PeakMemoryUsage: 302.1 KiB (309320) - RowsSent: 992,310 (992310) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 1.85s (1853771414) - TotalBytesSent: 234.7 MiB (246064102) - TotalTime: 6.67s (6665501880) - UncompressedRowBatchSize: 510.7 MiB (535486130) HDFS_SCAN_NODE (id=0) Table Name: uadata.gcf_v2 Hdfs split stats (:<# splits>/): 3:1/91.76 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 1.00 (1.0) - BytesRead: 86.6 MiB (90810519) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 86.6 MiB (90810519) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 86.6 MiB (90810519) - CachedFileHandlesHitCount: 34 (34) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 621ms (621426458) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 790ms (790292415) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 26 (26) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1,931 (1931) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 135.3 MiB (141896754) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 1.0 GiB/s (1096341499) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 413.4 MiB (433448231) - RowBatchQueueGetWaitTime: 52ms (52681844) - RowBatchQueuePeakMemoryUsage: 25.9 MiB (27119041) - RowBatchQueuePutWaitTime: 6.50s (6503304738) - RowBatchesEnqueued: 972 (972) - RowsRead: 992,310 (992310) - RowsReturned: 992,310 (992310) - RowsReturnedRate: 14068544 per second (14068544) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 23ms (23778940) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 118 (118) - ScannerThreadsTotalWallClockTime: 8.01s (8013626567) - ScannerThreadsSysTime: 271ms (271141000) - ScannerThreadsUserTime: 584ms (584840000) - ScannerThreadsVoluntaryContextSwitches: 2,001 (2001) - TotalRawHdfsOpenFileTime: 79.59us (79588) - TotalRawHdfsReadTime: 82ms (82830504) - TotalReadThroughput: 10.8 MiB/s (11351314) - TotalTime: 70ms (70533949) Node Lifecycle Event Timeline Open Started: 100ms (100021523) Open Finished: 100ms (100109818) First Batch Requested: 100ms (100123136) First Batch Returned: 153ms (153042669) Last Batch Returned: 8.16s (8159801840) Closed: 8.16s (8159882915) Buffer pool - AllocTime: 108.55us (108554) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 60.6 MiB (63594496) - CumulativeAllocations: 29 (29) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 104.0 MiB (109051904) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 60.5 MiB (63463424) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 93.05us (93050) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000002 (host=hslave505.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:15.247 Hdfs split stats (:<# splits>/): 6:1/9.21 MB - AverageThreadTokens: 2.00 (2.0) - ExchangeScanRatio: 2.65 (2.6468158109953976) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 129.7 MiB (136047234) - PeakReservation: 104.0 MiB (109051904) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 623.0 MiB (653249748) - RowsProduced: 87,915 (87915) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 728ms (728148241) - TotalStorageWaitTime: 8ms (8273517) - TotalThreadsInvoluntaryContextSwitches: 171 (171) - TotalThreadsTotalWallClockTime: 2.17s (2172297785) - TotalThreadsSysTime: 52ms (52849000) - TotalThreadsUserTime: 462ms (462217000) - TotalThreadsVoluntaryContextSwitches: 216 (216) - TotalTime: 1.24s (1241640774) Fragment Instance Lifecycle Event Timeline Prepare Finished: 923.44us (923443) Open Finished: 151ms (151130030) First Batch Produced: 181ms (181480403) First Batch Sent: 836ms (836192776) ExecInternal Finished: 1.24s (1242459090) Fragment Instance Lifecycle Timings - ExecTime: 1.09s (1091122321) - ExecTreeExecTime: 31ms (31434980) - InactiveTotalTime: 0ns (0) - OpenTime: 150ms (150206164) - ExecTreeOpenTime: 132.65us (132648) - PrepareTime: 263.98us (263977) - ExecTreePrepareTime: 114.25us (114253) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=6) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 728ms (728148241) - PeakMemoryUsage: 302.1 KiB (309320) - RowsSent: 87,915 (87915) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 185ms (185520810) - TotalBytesSent: 23.2 MiB (24337789) - TotalTime: 1.03s (1028581155) - UncompressedRowBatchSize: 47.6 MiB (49946946) HDFS_SCAN_NODE (id=0) Table Name: uadata.gcf_v2 Hdfs split stats (:<# splits>/): 6:1/9.21 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 1.00 (1.0) - BytesRead: 8.8 MiB (9195120) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 8.8 MiB (9195120) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 8.8 MiB (9195120) - CachedFileHandlesHitCount: 27 (27) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 12ms (12409673) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 52ms (52952991) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 26 (26) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 89 (89) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 129.2 MiB (135469246) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 481.1 MiB/s (504495271) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 36.4 MiB (38134389) - RowBatchQueueGetWaitTime: 30ms (30084431) - RowBatchQueuePeakMemoryUsage: 22.3 MiB (23355156) - RowBatchQueuePutWaitTime: 836ms (836371873) - RowBatchesEnqueued: 88 (88) - RowsRead: 87,915 (87915) - RowsReturned: 87,915 (87915) - RowsReturnedRate: 2784987 per second (2784987) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 8ms (8273517) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 21 (21) - ScannerThreadsTotalWallClockTime: 930ms (930982096) - ScannerThreadsSysTime: 30ms (30939000) - ScannerThreadsUserTime: 53ms (53894000) - ScannerThreadsVoluntaryContextSwitches: 80 (80) - TotalRawHdfsOpenFileTime: 50.40us (50402) - TotalRawHdfsReadTime: 18ms (18226375) - TotalReadThroughput: 8.8 MiB/s (9195120) - TotalTime: 31ms (31567468) Node Lifecycle Event Timeline Open Started: 150ms (150985478) Open Finished: 151ms (151115096) First Batch Requested: 151ms (151131987) First Batch Returned: 181ms (181477325) Last Batch Returned: 1.23s (1233049994) Closed: 1.24s (1240933386) Buffer pool - AllocTime: 29.83us (29830) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 12.5 MiB (13082624) - CumulativeAllocations: 27 (27) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 104.0 MiB (109051904) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 12.4 MiB (12951552) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 7.94us (7937) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000003 (host=hslave412.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:15.053 Hdfs split stats (:<# splits>/): 6:1/8.01 MB - AverageThreadTokens: 1.67 (1.6666666666666667) - ExchangeScanRatio: 2.72 (2.719778023048075) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 127.6 MiB (133795903) - PeakReservation: 104.0 MiB (109051904) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 614.9 MiB (644820180) - RowsProduced: 90,750 (90750) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 790ms (790438829) - TotalStorageWaitTime: 6ms (6521584) - TotalThreadsInvoluntaryContextSwitches: 63 (63) - TotalThreadsTotalWallClockTime: 2.11s (2109788514) - TotalThreadsSysTime: 47ms (47938000) - TotalThreadsUserTime: 366ms (366355000) - TotalThreadsVoluntaryContextSwitches: 176 (176) - TotalTime: 1.17s (1173941144) Fragment Instance Lifecycle Event Timeline Prepare Finished: 743.19us (743192) Open Finished: 136ms (136448543) First Batch Produced: 154ms (154827160) First Batch Sent: 200ms (200443931) ExecInternal Finished: 1.17s (1174777143) Fragment Instance Lifecycle Timings - ExecTime: 1.04s (1038008080) - ExecTreeExecTime: 19ms (19759017) - InactiveTotalTime: 0ns (0) - OpenTime: 135ms (135702780) - ExecTreeOpenTime: 114.38us (114376) - PrepareTime: 196.84us (196843) - ExecTreePrepareTime: 93.75us (93751) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=6) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 790ms (790438829) - PeakMemoryUsage: 270.1 KiB (276552) - RowsSent: 90,750 (90750) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 150ms (150769016) - TotalBytesSent: 20.4 MiB (21428685) - TotalTime: 1.01s (1009528033) - UncompressedRowBatchSize: 45.0 MiB (47140575) HDFS_SCAN_NODE (id=0) Table Name: uadata.gcf_v2 Hdfs split stats (:<# splits>/): 6:1/8.01 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 1.00 (1.0) - BytesRead: 7.5 MiB (7878836) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 7.5 MiB (7878836) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 7.5 MiB (7878836) - CachedFileHandlesHitCount: 27 (27) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 10ms (10343563) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 38ms (38424513) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 26 (26) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 92 (92) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 127.1 MiB (133294071) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 544.8 MiB/s (571221509) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 35.6 MiB (37311322) - RowBatchQueueGetWaitTime: 18ms (18128278) - RowBatchQueuePeakMemoryUsage: 20.3 MiB (21262046) - RowBatchQueuePutWaitTime: 869ms (869897792) - RowBatchesEnqueued: 91 (91) - RowsRead: 90,750 (90750) - RowsReturned: 90,750 (90750) - RowsReturnedRate: 4566866 per second (4566866) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 6ms (6521584) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 21 (21) - ScannerThreadsTotalWallClockTime: 936ms (936090161) - ScannerThreadsSysTime: 23ms (23058000) - ScannerThreadsUserTime: 35ms (35185000) - ScannerThreadsVoluntaryContextSwitches: 71 (71) - TotalRawHdfsOpenFileTime: 35.80us (35804) - TotalRawHdfsReadTime: 13ms (13792961) - TotalReadThroughput: 5.0 MiB/s (5252557) - TotalTime: 19ms (19871394) Node Lifecycle Event Timeline Open Started: 136ms (136321643) Open Finished: 136ms (136433644) First Batch Requested: 136ms (136450402) First Batch Returned: 154ms (154824645) Last Batch Returned: 1.17s (1172111109) Closed: 1.17s (1172140791) Buffer pool - AllocTime: 963.45us (963452) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 10.5 MiB (11051008) - CumulativeAllocations: 27 (27) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 104.0 MiB (109051904) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 10.4 MiB (10919936) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 940.04us (940037) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000000 (host=hslave514.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:15.010 Hdfs split stats (:<# splits>/): 0:1/25.24 KB - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.56 (0.5581552610224506) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 104.5 MiB (109598792) - PeakReservation: 104.0 MiB (109051904) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 612.7 MiB (642468804) - RowsProduced: 92 (92) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 98ms (98710056) - TotalStorageWaitTime: 2ms (2845675) - TotalThreadsInvoluntaryContextSwitches: 10 (10) - TotalThreadsTotalWallClockTime: 251ms (251956152) - TotalThreadsSysTime: 3ms (3020000) - TotalThreadsUserTime: 139ms (139271000) - TotalThreadsVoluntaryContextSwitches: 35 (35) - TotalTime: 247ms (247917939) Fragment Instance Lifecycle Event Timeline Prepare Finished: 548.41us (548409) Open Finished: 140ms (140566540) First Batch Produced: 144ms (144955653) First Batch Sent: 145ms (145025712) ExecInternal Finished: 248ms (248292419) Fragment Instance Lifecycle Timings - ExecTime: 107ms (107628673) - ExecTreeExecTime: 4ms (4502165) - InactiveTotalTime: 0ns (0) - OpenTime: 140ms (140013258) - ExecTreeOpenTime: 146.98us (146984) - PrepareTime: 235.05us (235051) - ExecTreePrepareTime: 102.46us (102462) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=6) ExecOption: Hash Partitioned Sender Codegen Enabled - EosSent: 5 (5) - InactiveTotalTime: 98ms (98710056) - PeakMemoryUsage: 62.1 KiB (63560) - RowsSent: 92 (92) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 268.94us (268941) - TotalBytesSent: 20.2 KiB (20635) - TotalTime: 103ms (103086142) - UncompressedRowBatchSize: 44.8 KiB (45872) HDFS_SCAN_NODE (id=0) Table Name: uadata.gcf_v2 Hdfs split stats (:<# splits>/): 0:1/25.24 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 36.1 KiB (36970) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 36.1 KiB (36970) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 36.1 KiB (36970) - CachedFileHandlesHitCount: 26 (26) - CachedFileHandlesMissCount: 1 (1) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 43.85us (43855) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 305.38us (305385) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 26 (26) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 26 (26) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 104.5 MiB (109571740) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 28.3 MiB/s (29640877) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 424.0 KiB (434176) - RowBatchQueueGetWaitTime: 4ms (4153342) - RowBatchQueuePeakMemoryUsage: 400.0 KiB (409600) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 92 (92) - RowsReturned: 92 (92) - RowsReturnedRate: 19044 per second (19044) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 2ms (2845675) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 4ms (4327476) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 1ms (1327000) - ScannerThreadsVoluntaryContextSwitches: 28 (28) - TotalRawHdfsOpenFileTime: 1ms (1618888) - TotalRawHdfsReadTime: 1ms (1247264) - TotalReadThroughput: 0 B/s (0) - TotalTime: 4ms (4830903) Node Lifecycle Event Timeline Open Started: 140ms (140406544) Open Finished: 140ms (140550874) First Batch Requested: 140ms (140568547) First Batch Returned: 144ms (144952823) Last Batch Returned: 145ms (145210195) Closed: 145ms (145253739) Buffer pool - AllocTime: 25.02us (25021) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 240.0 KiB (245760) - CumulativeAllocations: 27 (27) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 104.0 MiB (109051904) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 208.0 KiB (212992) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 11.24us (11244) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Averaged Fragment F02 split sizes: min: 14.80 KB, max: 249.35 MB, avg: 49.53 MB, stddev: 80.70 MB completion times: min:540.252ms max:5s503ms mean: 2s102ms stddev:2s087ms execution rates: min:26.80 KB/sec max:59.79 MB/sec mean:13.08 MB/sec stddev:20.29 MB/sec num instances: 11 - AverageThreadTokens: 0.96 (0.9642857142857143) - ExchangeScanRatio: 3.30 (3.297900292611328) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 17.4 MiB (18288487) - PeakReservation: 10.2 MiB (10676410) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 189.8 MiB (199045759) - RowsProduced: 347,853 (347853) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 739ms (739148414) - TotalStorageWaitTime: 10ms (10242702) - TotalThreadsInvoluntaryContextSwitches: 157 (157) - TotalThreadsTotalWallClockTime: 1.57s (1567125124) - TotalThreadsSysTime: 36ms (36211272) - TotalThreadsUserTime: 228ms (228202363) - TotalThreadsVoluntaryContextSwitches: 770 (770) - TotalTime: 973ms (973834232) Fragment Instance Lifecycle Timings - ExecTime: 929ms (929084204) - ExecTreeExecTime: 19ms (19407983) - InactiveTotalTime: 0ns (0) - OpenTime: 44ms (44475800) - ExecTreeOpenTime: 110.09us (110094) - PrepareTime: 230.05us (230047) - ExecTreePrepareTime: 108.82us (108823) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) - EosSent: 5 (5) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 347,853 (347853) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 125ms (125771829) - TotalBytesSent: 118.1 MiB (123885283) - TotalTime: 889ms (889079064) - UncompressedRowBatchSize: 141.0 MiB (147837872) HDFS_SCAN_NODE (id=4) - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.24 (0.237012987012987) - BytesRead: 21.2 MiB (22215068) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 21.2 MiB (22215068) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 21.2 MiB (22215068) - CachedFileHandlesHitCount: 4 (4) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 59ms (59219025) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 6ms (6040179) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 343 (343) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 17.4 MiB (18227474) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 415.1 MiB/s (435247413) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 26.9 MiB (28225380) - RowBatchQueueGetWaitTime: 12ms (12135431) - RowBatchQueuePeakMemoryUsage: 6.9 MiB (7205748) - RowBatchQueuePutWaitTime: 509ms (509582682) - RowBatchesEnqueued: 342 (342) - RowsRead: 347,853 (347853) - RowsReturned: 347,853 (347853) - RowsReturnedRate: 9116691 per second (9116691) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 10ms (10242702) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 33 (33) - ScannerThreadsTotalWallClockTime: 593ms (593579256) - ScannerThreadsSysTime: 14ms (14859181) - ScannerThreadsUserTime: 49ms (49635909) - ScannerThreadsVoluntaryContextSwitches: 333 (333) - TotalRawHdfsOpenFileTime: 147.04us (147038) - TotalRawHdfsReadTime: 25ms (25209644) - TotalReadThroughput: 9.5 MiB/s (9913172) - TotalTime: 19ms (19394370) Buffer pool - AllocTime: 74.79us (74786) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 8.1 MiB (8514466) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 10.2 MiB (10676410) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 8.0 MiB (8425844) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 64.60us (64598) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Fragment F02 Instance a7420b313faa4b7d:a438981b0000000e (host=hslave608.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:15.196 Hdfs split stats (:<# splits>/): 6:1/249.35 MB - AverageThreadTokens: 1.86 (1.8571428571428572) - ExchangeScanRatio: 5.62 (5.616270779738557) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 44.9 MiB (47098304) - PeakReservation: 24.0 MiB (25165824) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 764.4 MiB (801530082) - RowsProduced: 1,764,734 (1764734) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 2.77s (2769786785) - TotalStorageWaitTime: 12ms (12504133) - TotalThreadsInvoluntaryContextSwitches: 408 (408) - TotalThreadsTotalWallClockTime: 6.90s (6902947525) - TotalThreadsSysTime: 174ms (174753000) - TotalThreadsUserTime: 994ms (994483000) - TotalThreadsVoluntaryContextSwitches: 4,045 (4045) - TotalTime: 3.71s (3714992088) Fragment Instance Lifecycle Event Timeline Prepare Finished: 928.19us (928187) Open Finished: 37ms (37596918) First Batch Produced: 57ms (57749270) First Batch Sent: 58ms (58406198) ExecInternal Finished: 3.72s (3716142434) Fragment Instance Lifecycle Timings - ExecTime: 3.68s (3678092468) - ExecTreeExecTime: 44ms (44324750) - InactiveTotalTime: 0ns (0) - OpenTime: 36ms (36664773) - ExecTreeOpenTime: 94.35us (94350) - PrepareTime: 198.47us (198473) - ExecTreePrepareTime: 94.82us (94821) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 2.77s (2769786785) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 1,764,734 (1764734) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 619ms (619499717) - TotalBytesSent: 595.6 MiB (624582845) - TotalTime: 3.52s (3524865647) - UncompressedRowBatchSize: 715.3 MiB (750011950) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 6:1/249.35 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.86 (0.8571428571428571) - BytesRead: 106.1 MiB (111209532) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 106.1 MiB (111209532) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 106.1 MiB (111209532) - CachedFileHandlesHitCount: 15 (15) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 326ms (326414069) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 30ms (30371702) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1,794 (1794) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 44.9 MiB (47039712) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 1.1 GiB/s (1227638494) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 136.4 MiB (143048463) - RowBatchQueueGetWaitTime: 19ms (19961429) - RowBatchQueuePeakMemoryUsage: 20.0 MiB (20982671) - RowBatchQueuePutWaitTime: 2.79s (2785838515) - RowBatchesEnqueued: 1,726 (1726) - RowsRead: 1,764,734 (1764734) - RowsReturned: 1,764,734 (1764734) - RowsReturnedRate: 41036909 per second (41036909) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 12ms (12504133) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 159 (159) - ScannerThreadsTotalWallClockTime: 3.19s (3188204180) - ScannerThreadsSysTime: 74ms (74922000) - ScannerThreadsUserTime: 264ms (264252000) - ScannerThreadsVoluntaryContextSwitches: 1,871 (1871) - TotalRawHdfsOpenFileTime: 143.41us (143411) - TotalRawHdfsReadTime: 90ms (90588176) - TotalReadThroughput: 30.3 MiB/s (31774152) - TotalTime: 43ms (43003580) Node Lifecycle Event Timeline Open Started: 37ms (37492990) Open Finished: 37ms (37584841) First Batch Requested: 37ms (37599418) First Batch Returned: 57ms (57746131) Last Batch Returned: 3.71s (3713142107) Closed: 3.71s (3713202169) Buffer pool - AllocTime: 219.83us (219826) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 24.1 MiB (25296896) - CumulativeAllocations: 4 (4) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 24.0 MiB (25165824) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 24.0 MiB (25165824) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 214.92us (214918) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000008 (host=hslave411.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:11.825 Hdfs split stats (:<# splits>/): 4:1/127.01 MB - AverageThreadTokens: 1.75 (1.75) - ExchangeScanRatio: 5.60 (5.596747369042185) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 44.9 MiB (47102231) - PeakReservation: 24.0 MiB (25165824) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 44.9 MiB (47102503) - RowsProduced: 888,110 (888110) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 1.40s (1397901920) - TotalStorageWaitTime: 10ms (10766831) - TotalThreadsInvoluntaryContextSwitches: 183 (183) - TotalThreadsTotalWallClockTime: 3.56s (3560158579) - TotalThreadsSysTime: 72ms (72594000) - TotalThreadsUserTime: 506ms (506191000) - TotalThreadsVoluntaryContextSwitches: 2,026 (2026) - TotalTime: 1.85s (1850262977) Fragment Instance Lifecycle Event Timeline Prepare Finished: 444.42us (444423) Open Finished: 31ms (31066567) First Batch Produced: 47ms (47999995) First Batch Sent: 48ms (48450706) ExecInternal Finished: 1.85s (1850587750) Fragment Instance Lifecycle Timings - ExecTime: 1.82s (1819447472) - ExecTreeExecTime: 24ms (24700142) - InactiveTotalTime: 0ns (0) - OpenTime: 30ms (30619028) - ExecTreeOpenTime: 93.16us (93162) - PrepareTime: 164.32us (164323) - ExecTreePrepareTime: 78.78us (78782) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 1.40s (1397901920) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 888,110 (888110) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 305ms (305419150) - TotalBytesSent: 300.9 MiB (315559185) - TotalTime: 1.75s (1750618650) - UncompressedRowBatchSize: 360.0 MiB (377446750) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 4:1/127.01 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.75 (0.75) - BytesRead: 53.8 MiB (56382603) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 53.8 MiB (56382603) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 53.8 MiB (56382603) - CachedFileHandlesHitCount: 8 (8) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 148ms (148276212) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 13ms (13513684) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 883 (883) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 44.9 MiB (47043639) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 1.3 GiB/s (1362729822) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 68.7 MiB (72032577) - RowBatchQueueGetWaitTime: 16ms (16716560) - RowBatchQueuePeakMemoryUsage: 20.0 MiB (20958651) - RowBatchQueuePutWaitTime: 1.52s (1521961882) - RowBatchesEnqueued: 870 (870) - RowsRead: 888,110 (888110) - RowsReturned: 888,110 (888110) - RowsReturnedRate: 36618251 per second (36618251) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 10ms (10766831) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 69 (69) - ScannerThreadsTotalWallClockTime: 1.71s (1710103977) - ScannerThreadsSysTime: 26ms (26250000) - ScannerThreadsUserTime: 132ms (132347000) - ScannerThreadsVoluntaryContextSwitches: 783 (783) - TotalRawHdfsOpenFileTime: 39.42us (39416) - TotalRawHdfsReadTime: 41ms (41374748) - TotalReadThroughput: 26.9 MiB/s (28191301) - TotalTime: 24ms (24253206) Node Lifecycle Event Timeline Open Started: 30ms (30964351) Open Finished: 31ms (31055055) First Batch Requested: 31ms (31068472) First Batch Returned: 47ms (47997241) Last Batch Returned: 1.85s (1849678500) Closed: 1.85s (1849704933) Buffer pool - AllocTime: 47.37us (47367) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 24.1 MiB (25296896) - CumulativeAllocations: 4 (4) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 24.0 MiB (25165824) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 24.0 MiB (25165824) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 38.27us (38268) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000006 (host=hslave505.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:15.247 Hdfs split stats (:<# splits>/): 9:1/141.23 MB - AverageThreadTokens: 2.00 (2.0) - ExchangeScanRatio: 5.55 (5.552100321425402) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 44.9 MiB (47102225) - PeakReservation: 24.0 MiB (25165824) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 623.0 MiB (653249748) - RowsProduced: 992,310 (992310) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 1.07s (1066808684) - TotalStorageWaitTime: 40ms (40186606) - TotalThreadsInvoluntaryContextSwitches: 1,079 (1079) - TotalThreadsTotalWallClockTime: 3.29s (3288097612) - TotalThreadsSysTime: 113ms (113717000) - TotalThreadsUserTime: 590ms (590964000) - TotalThreadsVoluntaryContextSwitches: 1,948 (1948) - TotalTime: 1.75s (1745507158) Fragment Instance Lifecycle Event Timeline Prepare Finished: 832.88us (832884) Open Finished: 71ms (71769812) First Batch Produced: 94ms (94661707) First Batch Sent: 95ms (95258479) ExecInternal Finished: 1.75s (1746370365) Fragment Instance Lifecycle Timings - ExecTime: 1.67s (1674220533) - ExecTreeExecTime: 66ms (66867292) - InactiveTotalTime: 0ns (0) - OpenTime: 70ms (70934186) - ExecTreeOpenTime: 134.25us (134255) - PrepareTime: 297.76us (297758) - ExecTreePrepareTime: 137.33us (137330) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 1.07s (1066808684) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 992,310 (992310) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 400ms (400341872) - TotalBytesSent: 340.8 MiB (357391235) - TotalTime: 1.54s (1538436684) - UncompressedRowBatchSize: 402.2 MiB (421731750) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 9:1/141.23 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 1.00 (1.0) - BytesRead: 61.4 MiB (64370457) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 61.4 MiB (64370457) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 61.4 MiB (64370457) - CachedFileHandlesHitCount: 9 (9) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 163ms (163154328) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 20ms (20244553) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 991 (991) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 44.9 MiB (47043633) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 627.1 MiB/s (657522524) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 76.7 MiB (80476741) - RowBatchQueueGetWaitTime: 22ms (22575074) - RowBatchQueuePeakMemoryUsage: 19.9 MiB (20906488) - RowBatchQueuePutWaitTime: 1.30s (1297609113) - RowBatchesEnqueued: 972 (972) - RowsRead: 992,310 (992310) - RowsReturned: 992,310 (992310) - RowsReturnedRate: 14995880 per second (14995880) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 40ms (40186606) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 137 (137) - ScannerThreadsTotalWallClockTime: 1.54s (1542957559) - ScannerThreadsSysTime: 52ms (52505000) - ScannerThreadsUserTime: 125ms (125914000) - ScannerThreadsVoluntaryContextSwitches: 957 (957) - TotalRawHdfsOpenFileTime: 78.19us (78191) - TotalRawHdfsReadTime: 97ms (97898482) - TotalReadThroughput: 37.4 MiB/s (39215104) - TotalTime: 66ms (66172173) Node Lifecycle Event Timeline Open Started: 71ms (71622770) Open Finished: 71ms (71753307) First Batch Requested: 71ms (71771978) First Batch Returned: 94ms (94658079) Last Batch Returned: 1.75s (1745499101) Closed: 1.75s (1745565892) Buffer pool - AllocTime: 74.50us (74501) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 24.1 MiB (25296896) - CumulativeAllocations: 4 (4) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 24.0 MiB (25165824) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 24.0 MiB (25165824) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 63.98us (63980) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b0000000c (host=hslave412.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:15.053 Hdfs split stats (:<# splits>/): 6:1/13.11 MB - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 5.37 (5.370684784757234) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 16.3 MiB (17075117) - PeakReservation: 8.0 MiB (8388608) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 614.9 MiB (644820180) - RowsProduced: 90,750 (90750) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 948ms (948347895) - TotalStorageWaitTime: 33ms (33869613) - TotalThreadsInvoluntaryContextSwitches: 29 (29) - TotalThreadsTotalWallClockTime: 1.14s (1141586733) - TotalThreadsSysTime: 12ms (12923000) - TotalThreadsUserTime: 98ms (98835000) - TotalThreadsVoluntaryContextSwitches: 184 (184) - TotalTime: 1.09s (1090179143) Fragment Instance Lifecycle Event Timeline Prepare Finished: 705.73us (705730) Open Finished: 61ms (61849489) First Batch Produced: 103ms (103813632) First Batch Sent: 104ms (104629989) ExecInternal Finished: 1.09s (1090668886) Fragment Instance Lifecycle Timings - ExecTime: 1.03s (1028746264) - ExecTreeExecTime: 42ms (42364935) - InactiveTotalTime: 0ns (0) - OpenTime: 61ms (61136736) - ExecTreeOpenTime: 134.70us (134700) - PrepareTime: 254.32us (254317) - ExecTreePrepareTime: 102.57us (102571) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 948ms (948347895) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 90,750 (90750) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 30ms (30175060) - TotalBytesSent: 31.4 MiB (32957900) - TotalTime: 984ms (984276040) - UncompressedRowBatchSize: 36.8 MiB (38568750) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 6:1/13.11 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 5.9 MiB (6136629) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 5.9 MiB (6136629) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 5.9 MiB (6136629) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 8ms (8225925) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 1ms (1318447) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 55 (55) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 16.2 MiB (17003213) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 173.2 MiB/s (181642206) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 7.1 MiB (7436237) - RowBatchQueueGetWaitTime: 41ms (41715555) - RowBatchQueuePeakMemoryUsage: 7.8 MiB (8138701) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 91 (91) - RowsRead: 90,750 (90750) - RowsReturned: 90,750 (90750) - RowsReturnedRate: 2130598 per second (2130598) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 33ms (33869613) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 2 (2) - ScannerThreadsTotalWallClockTime: 51ms (51716483) - ScannerThreadsSysTime: 6ms (6690000) - ScannerThreadsUserTime: 8ms (8921000) - ScannerThreadsVoluntaryContextSwitches: 32 (32) - TotalRawHdfsOpenFileTime: 22.80us (22795) - TotalRawHdfsReadTime: 33ms (33784158) - TotalReadThroughput: 3.9 MiB/s (4091086) - TotalTime: 42ms (42593675) Node Lifecycle Event Timeline Open Started: 61ms (61701186) Open Finished: 61ms (61833069) First Batch Requested: 61ms (61851274) First Batch Returned: 103ms (103810677) Last Batch Returned: 1.09s (1089722388) Closed: 1.09s (1089739050) Buffer pool - AllocTime: 10.57us (10567) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 8.1 MiB (8519680) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 8.0 MiB (8388608) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 8.0 MiB (8388608) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000005 (host=hslave618.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:11.128 Hdfs split stats (:<# splits>/): 3:1/13.80 MB - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 5.42 (5.424756125401723) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 16.0 MiB (16817804) - PeakReservation: 8.0 MiB (8388608) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 16.0 MiB (16818076) - RowsProduced: 87,915 (87915) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 916ms (916315071) - TotalStorageWaitTime: 7ms (7290456) - TotalThreadsInvoluntaryContextSwitches: 0 (0) - TotalThreadsTotalWallClockTime: 1.04s (1045217146) - TotalThreadsSysTime: 12ms (12461000) - TotalThreadsUserTime: 85ms (85822000) - TotalThreadsVoluntaryContextSwitches: 146 (146) - TotalTime: 1.02s (1020436105) Fragment Instance Lifecycle Event Timeline Prepare Finished: 93ms (93132085) Open Finished: 143ms (143658631) First Batch Produced: 162ms (162941700) First Batch Sent: 163ms (163483004) ExecInternal Finished: 1.11s (1113480111) Fragment Instance Lifecycle Timings - ExecTime: 969ms (969475748) - ExecTreeExecTime: 19ms (19577642) - InactiveTotalTime: 0ns (0) - OpenTime: 50ms (50523763) - ExecTreeOpenTime: 113.88us (113878) - PrepareTime: 372.61us (372608) - ExecTreePrepareTime: 205.48us (205476) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 916ms (916315071) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 87,915 (87915) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 26ms (26853500) - TotalBytesSent: 29.9 MiB (31318495) - TotalTime: 947ms (947383635) - UncompressedRowBatchSize: 35.6 MiB (37363875) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 3:1/13.80 MB Hdfs Read Thread Concurrency Bucket: 0:100% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 5.5 MiB (5773254) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 5.5 MiB (5773254) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 5.5 MiB (5773254) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 5ms (5304510) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 929.85us (929845) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 52 (52) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 16.0 MiB (16745900) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 759.8 MiB/s (796729591) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 6.9 MiB (7203500) - RowBatchQueueGetWaitTime: 18ms (18770951) - RowBatchQueuePeakMemoryUsage: 7.5 MiB (7881388) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 88 (88) - RowsRead: 87,915 (87915) - RowsReturned: 87,915 (87915) - RowsReturnedRate: 4399325 per second (4399325) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 7ms (7290456) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 25ms (25228706) - ScannerThreadsSysTime: 3ms (3084000) - ScannerThreadsUserTime: 11ms (11309000) - ScannerThreadsVoluntaryContextSwitches: 9 (9) - TotalRawHdfsOpenFileTime: 16.80us (16800) - TotalRawHdfsReadTime: 7ms (7246190) - TotalReadThroughput: 5.5 MiB/s (5773254) - TotalTime: 19ms (19983744) Node Lifecycle Event Timeline Open Started: 143ms (143533956) Open Finished: 143ms (143644735) First Batch Requested: 143ms (143660323) First Batch Returned: 162ms (162939298) Last Batch Returned: 1.11s (1112678633) Closed: 1.11s (1112699439) Buffer pool - AllocTime: 405.37us (405369) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 8.1 MiB (8519680) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 8.0 MiB (8388608) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 8.0 MiB (8388608) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 393.41us (393413) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b0000000d (host=hslave701.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:10.246 Hdfs split stats (:<# splits>/): 8:1/20.69 KB - AverageThreadTokens: 0.00 (0.0) - ExchangeScanRatio: 1.10 (1.1032618825722273) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 4.1 MiB (4304484) - PeakReservation: 4.0 MiB (4194304) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 4.1 MiB (4305120) - RowsProduced: 81 (81) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 262ms (262497428) - TotalStorageWaitTime: 1ms (1004143) - TotalThreadsInvoluntaryContextSwitches: 0 (0) - TotalThreadsTotalWallClockTime: 298ms (298098076) - TotalThreadsSysTime: 3ms (3050000) - TotalThreadsUserTime: 30ms (30461000) - TotalThreadsVoluntaryContextSwitches: 17 (17) - TotalTime: 297ms (297051315) Fragment Instance Lifecycle Event Timeline Prepare Finished: 523.21us (523213) Open Finished: 33ms (33117752) First Batch Produced: 34ms (34582781) First Batch Sent: 34ms (34662044) ExecInternal Finished: 297ms (297430552) Fragment Instance Lifecycle Timings - ExecTime: 264ms (264208561) - ExecTreeExecTime: 1ms (1499736) - InactiveTotalTime: 0ns (0) - OpenTime: 32ms (32591795) - ExecTreeOpenTime: 98.71us (98711) - PrepareTime: 212.10us (212099) - ExecTreePrepareTime: 92.41us (92407) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 262ms (262497428) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 81 (81) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 29.84us (29838) - TotalBytesSent: 28.9 KiB (29595) - TotalTime: 262ms (262761447) - UncompressedRowBatchSize: 33.6 KiB (34425) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 8:1/20.69 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 26.2 KiB (26825) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 26.2 KiB (26825) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 26.2 KiB (26825) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 3.33us (3331) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 7.80us (7802) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1 (1) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 4.0 MiB (4245892) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 27.8 MiB/s (29129777) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 22.4 KiB (22916) - RowBatchQueueGetWaitTime: 1ms (1268672) - RowBatchQueuePeakMemoryUsage: 46.4 KiB (47492) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 81 (81) - RowsReturned: 81 (81) - RowsReturnedRate: 45912 per second (45912) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 1ms (1004143) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 1ms (1308523) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 335.00us (335000) - ScannerThreadsVoluntaryContextSwitches: 3 (3) - TotalRawHdfsOpenFileTime: 40.83us (40831) - TotalRawHdfsReadTime: 920.88us (920879) - TotalReadThroughput: 0 B/s (0) - TotalTime: 1ms (1764235) Node Lifecycle Event Timeline Open Started: 33ms (33011829) Open Finished: 33ms (33108065) First Batch Requested: 33ms (33119308) First Batch Returned: 34ms (34581954) Last Batch Returned: 34ms (34699480) Closed: 34ms (34709804) Buffer pool - AllocTime: 9.85us (9850) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 40.0 KiB (40960) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 32.0 KiB (32768) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b0000000b (host=hslave416.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:10.249 Hdfs split stats (:<# splits>/): 5:1/108.75 KB - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 2.07 (2.070594150178925) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 4.2 MiB (4367744) - PeakReservation: 4.0 MiB (4194304) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 4.2 MiB (4368016) - RowsProduced: 962 (962) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 235ms (235220627) - TotalStorageWaitTime: 968.95us (968951) - TotalThreadsInvoluntaryContextSwitches: 0 (0) - TotalThreadsTotalWallClockTime: 274ms (274144476) - TotalThreadsSysTime: 0ns (0) - TotalThreadsUserTime: 36ms (36859000) - TotalThreadsVoluntaryContextSwitches: 22 (22) - TotalTime: 272ms (272805328) Fragment Instance Lifecycle Event Timeline Prepare Finished: 484.12us (484124) Open Finished: 35ms (35394068) First Batch Produced: 37ms (37206704) First Batch Sent: 37ms (37666551) ExecInternal Finished: 273ms (273254395) Fragment Instance Lifecycle Timings - ExecTime: 237ms (237663490) - ExecTreeExecTime: 1ms (1862430) - InactiveTotalTime: 0ns (0) - OpenTime: 34ms (34904918) - ExecTreeOpenTime: 110.02us (110022) - PrepareTime: 193.60us (193604) - ExecTreePrepareTime: 93.38us (93378) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 235ms (235220627) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 962 (962) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 376.10us (376103) - TotalBytesSent: 341.9 KiB (350065) - TotalTime: 235ms (235819976) - UncompressedRowBatchSize: 399.3 KiB (408850) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 5:1/108.75 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 165.1 KiB (169065) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 165.1 KiB (169065) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 165.1 KiB (169065) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 8.32us (8316) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 16.02us (16025) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1 (1) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 4.1 MiB (4309152) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 196.3 MiB/s (205840706) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 80.9 KiB (82824) - RowBatchQueueGetWaitTime: 1ms (1514253) - RowBatchQueuePeakMemoryUsage: 87.9 KiB (89992) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 962 (962) - RowsReturned: 962 (962) - RowsReturnedRate: 449879 per second (449879) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 968.95us (968951) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 1ms (1602549) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 766.00us (766000) - ScannerThreadsVoluntaryContextSwitches: 4 (4) - TotalRawHdfsOpenFileTime: 19.28us (19283) - TotalRawHdfsReadTime: 821.34us (821339) - TotalReadThroughput: 0 B/s (0) - TotalTime: 2ms (2138349) Node Lifecycle Event Timeline Open Started: 35ms (35270780) Open Finished: 35ms (35378499) First Batch Requested: 35ms (35395771) First Batch Returned: 37ms (37205774) Last Batch Returned: 37ms (37720161) Closed: 37ms (37731094) Buffer pool - AllocTime: 11.33us (11328) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 256.0 KiB (262144) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 128.0 KiB (131072) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b0000000a (host=hslave518.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:10.247 Hdfs split stats (:<# splits>/): 7:1/14.80 KB - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 0.58 (0.5811159301371469) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 4.1 MiB (4303072) - PeakReservation: 4.0 MiB (4194304) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 4.1 MiB (4305120) - RowsProduced: 27 (27) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 209ms (209574997) - TotalStorageWaitTime: 1ms (1919087) - TotalThreadsInvoluntaryContextSwitches: 0 (0) - TotalThreadsTotalWallClockTime: 246ms (246711146) - TotalThreadsSysTime: 994.00us (994000) - TotalThreadsUserTime: 32ms (32214000) - TotalThreadsVoluntaryContextSwitches: 14 (14) - TotalTime: 244ms (244470026) Fragment Instance Lifecycle Event Timeline Prepare Finished: 538.95us (538950) Open Finished: 32ms (32129449) First Batch Produced: 34ms (34836419) First Batch Sent: 34ms (34910047) ExecInternal Finished: 244ms (244860771) Fragment Instance Lifecycle Timings - ExecTime: 212ms (212627361) - ExecTreeExecTime: 2ms (2754659) - InactiveTotalTime: 0ns (0) - OpenTime: 31ms (31588670) - ExecTreeOpenTime: 80.42us (80422) - PrepareTime: 202.13us (202131) - ExecTreePrepareTime: 94.93us (94928) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 209ms (209574997) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 27 (27) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 13.98us (13985) - TotalBytesSent: 9.7 KiB (9915) - TotalTime: 209ms (209849378) - UncompressedRowBatchSize: 11.2 KiB (11475) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 7:1/14.80 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 16.7 KiB (17062) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 16.7 KiB (17062) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 16.7 KiB (17062) - CachedFileHandlesHitCount: 1 (1) - CachedFileHandlesMissCount: 1 (1) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 6.93us (6930) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 9.95us (9951) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1 (1) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 4.0 MiB (4244480) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 23.8 MiB/s (24932561) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 21.0 KiB (21504) - RowBatchQueueGetWaitTime: 2ms (2447091) - RowBatchQueuePeakMemoryUsage: 37.0 KiB (37888) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 27 (27) - RowsReturned: 27 (27) - RowsReturnedRate: 8967 per second (8967) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 1ms (1919087) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 2ms (2510563) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 719.00us (719000) - ScannerThreadsVoluntaryContextSwitches: 2 (2) - TotalRawHdfsOpenFileTime: 1ms (1170425) - TotalRawHdfsReadTime: 684.33us (684326) - TotalReadThroughput: 0 B/s (0) - TotalTime: 3ms (3011036) Node Lifecycle Event Timeline Open Started: 32ms (32041799) Open Finished: 32ms (32119977) First Batch Requested: 32ms (32131071) First Batch Returned: 34ms (34834795) Last Batch Returned: 34ms (34960472) Closed: 35ms (35030315) Buffer pool - AllocTime: 6.29us (6289) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 24.0 KiB (24576) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 16.0 KiB (16384) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000007 (host=hslave309.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:10.249 Hdfs split stats (:<# splits>/): 1:1/107.54 KB - AverageThreadTokens: 1.00 (1.0) - ExchangeScanRatio: 2.06 (2.0570095510586897) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 4.2 MiB (4367024) - PeakReservation: 4.0 MiB (4194304) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 4.2 MiB (4367296) - RowsProduced: 953 (953) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 153ms (153874925) - TotalStorageWaitTime: 789.53us (789533) - TotalThreadsInvoluntaryContextSwitches: 1 (1) - TotalThreadsTotalWallClockTime: 193ms (193163360) - TotalThreadsSysTime: 2ms (2892000) - TotalThreadsUserTime: 33ms (33183000) - TotalThreadsVoluntaryContextSwitches: 31 (31) - TotalTime: 191ms (191992381) Fragment Instance Lifecycle Event Timeline Prepare Finished: 619.50us (619503) Open Finished: 36ms (36030243) First Batch Produced: 37ms (37654672) First Batch Sent: 38ms (38179984) ExecInternal Finished: 192ms (192459356) Fragment Instance Lifecycle Timings - ExecTime: 156ms (156325652) - ExecTreeExecTime: 1ms (1675172) - InactiveTotalTime: 0ns (0) - OpenTime: 35ms (35405726) - ExecTreeOpenTime: 103.25us (103250) - PrepareTime: 224.03us (224028) - ExecTreePrepareTime: 98.31us (98314) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 153ms (153874925) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 953 (953) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 454.48us (454482) - TotalBytesSent: 338.4 KiB (346530) - TotalTime: 154ms (154553504) - UncompressedRowBatchSize: 395.5 KiB (405025) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 1:1/107.54 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 164.5 KiB (168463) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 164.5 KiB (168463) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 164.5 KiB (168463) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 5.80us (5799) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 10.55us (10553) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1 (1) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 4.1 MiB (4308432) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 216.7 MiB/s (227224354) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 80.3 KiB (82212) - RowBatchQueueGetWaitTime: 1ms (1395707) - RowBatchQueuePeakMemoryUsage: 96.3 KiB (98596) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 953 (953) - RowsReturned: 953 (953) - RowsReturnedRate: 487612 per second (487612) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 789.53us (789533) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 1ms (1443605) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 432.00us (432000) - ScannerThreadsVoluntaryContextSwitches: 4 (4) - TotalRawHdfsOpenFileTime: 21.26us (21257) - TotalRawHdfsReadTime: 741.39us (741395) - TotalReadThroughput: 0 B/s (0) - TotalTime: 1ms (1954420) Node Lifecycle Event Timeline Open Started: 35ms (35913345) Open Finished: 36ms (36014095) First Batch Requested: 36ms (36032223) First Batch Returned: 37ms (37653116) Last Batch Returned: 38ms (38381682) Closed: 38ms (38395679) Buffer pool - AllocTime: 9.97us (9973) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 256.0 KiB (262144) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 128.0 KiB (131072) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b0000000f (host=hslave713.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:10.249 Hdfs split stats (:<# splits>/): 5:1/53.43 KB - AverageThreadTokens: 0.00 (0.0) - ExchangeScanRatio: 1.94 (1.9398702018568987) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 4.1 MiB (4331820) - PeakReservation: 4.0 MiB (4194304) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 4.1 MiB (4332092) - RowsProduced: 483 (483) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 111ms (111588296) - TotalStorageWaitTime: 2ms (2723445) - TotalThreadsInvoluntaryContextSwitches: 17 (17) - TotalThreadsTotalWallClockTime: 174ms (174055105) - TotalThreadsSysTime: 1ms (1950000) - TotalThreadsUserTime: 51ms (51030000) - TotalThreadsVoluntaryContextSwitches: 24 (24) - TotalTime: 171ms (171069741) Fragment Instance Lifecycle Event Timeline Prepare Finished: 543.30us (543302) Open Finished: 52ms (52889305) First Batch Produced: 59ms (59256224) First Batch Sent: 59ms (59612860) ExecInternal Finished: 171ms (171471342) Fragment Instance Lifecycle Timings - ExecTime: 118ms (118495705) - ExecTreeExecTime: 6ms (6430527) - InactiveTotalTime: 0ns (0) - OpenTime: 52ms (52341211) - ExecTreeOpenTime: 118.17us (118175) - PrepareTime: 194.96us (194958) - ExecTreePrepareTime: 94.89us (94891) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 111ms (111588296) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 483 (483) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 278.85us (278847) - TotalBytesSent: 164.0 KiB (167985) - TotalTime: 112ms (112088536) - UncompressedRowBatchSize: 200.5 KiB (205275) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 5:1/53.43 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 84.6 KiB (86596) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 84.6 KiB (86596) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 84.6 KiB (86596) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 5.03us (5030) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 11.20us (11200) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1 (1) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 4.1 MiB (4273228) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 31.3 MiB/s (32830291) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 49.1 KiB (50252) - RowBatchQueueGetWaitTime: 6ms (6125971) - RowBatchQueuePeakMemoryUsage: 73.1 KiB (74828) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 483 (483) - RowsReturned: 483 (483) - RowsReturnedRate: 71899 per second (71899) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 2ms (2723445) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 3ms (3230664) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 518.00us (518000) - ScannerThreadsVoluntaryContextSwitches: 3 (3) - TotalRawHdfsOpenFileTime: 30.82us (30821) - TotalRawHdfsReadTime: 2ms (2637686) - TotalReadThroughput: 0 B/s (0) - TotalTime: 6ms (6717665) Node Lifecycle Event Timeline Open Started: 52ms (52759478) Open Finished: 52ms (52875397) First Batch Requested: 52ms (52891310) First Batch Returned: 59ms (59254371) Last Batch Returned: 59ms (59681063) Closed: 59ms (59701078) Buffer pool - AllocTime: 11.26us (11264) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 96.0 KiB (98304) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 64.0 KiB (65536) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0) Instance a7420b313faa4b7d:a438981b00000009 (host=hslave702.phx101.service-now.com:27000) Last report received time: 2023-03-28 08:29:10.245 Hdfs split stats (:<# splits>/): 7:1/20.11 KB - AverageThreadTokens: 0.00 (0.0) - ExchangeScanRatio: 0.96 (0.9644921225556171) - InactiveTotalTime: 0ns (0) - PeakMemoryUsage: 4.1 MiB (4303532) - PeakReservation: 4.0 MiB (4194304) - PeakUsedReservation: 0 B (0) - PerHostPeakMemUsage: 4.1 MiB (4305120) - RowsProduced: 67 (67) - TotalNetworkReceiveTime: 0ns (0) - TotalNetworkSendTime: 58ms (58715929) - TotalStorageWaitTime: 646.93us (646929) - TotalThreadsInvoluntaryContextSwitches: 10 (10) - TotalThreadsTotalWallClockTime: 114ms (114196613) - TotalThreadsSysTime: 2ms (2990000) - TotalThreadsUserTime: 50ms (50184000) - TotalThreadsVoluntaryContextSwitches: 21 (21) - TotalTime: 113ms (113410296) Fragment Instance Lifecycle Event Timeline Prepare Finished: 481.34us (481337) Open Finished: 53ms (53008201) First Batch Produced: 54ms (54354337) First Batch Sent: 54ms (54573943) ExecInternal Finished: 113ms (113763080) Fragment Instance Lifecycle Timings - ExecTime: 60ms (60622990) - ExecTreeExecTime: 1ms (1430535) - InactiveTotalTime: 0ns (0) - OpenTime: 52ms (52522994) - ExecTreeOpenTime: 130.12us (130116) - PrepareTime: 216.22us (216221) - ExecTreePrepareTime: 104.17us (104165) - TotalTime: 0ns (0) KrpcDataStreamSender (dst_id=7) ExecOption: Unpartitioned Sender Codegen Disabled: not needed - EosSent: 5 (5) - InactiveTotalTime: 58ms (58715929) - PeakMemoryUsage: 49.2 KiB (50400) - RowsSent: 67 (67) - RpcFailure: 0 (0) - RpcRetry: 0 (0) - SerializeBatchTime: 47.57us (47573) - TotalBytesSent: 23.8 KiB (24365) - TotalTime: 59ms (59216212) - UncompressedRowBatchSize: 27.8 KiB (28475) HDFS_SCAN_NODE (id=4) Table Name: uadata.gcf Hdfs split stats (:<# splits>/): 7:1/20.11 KB Hdfs Read Thread Concurrency Bucket: 0:0% 1:0% 2:0% 3:0% 4:0% 5:0% 6:0% 7:0% 8:0% 9:0% 10:0% 11:0% 12:0% 13:0% 14:0% 15:0% 16:0% 17:0% 18:0% 19:0% 20:0% File Formats: PARQUET/SNAPPY:1 ExecOption: Codegen enabled: 1 out of 1, PARQUET Codegen Enabled - AverageHdfsReadThreadConcurrency: 0.00 (0.0) - AverageScannerThreadConcurrency: 0.00 (0.0) - BytesRead: 24.7 KiB (25262) - BytesReadDataNodeCache: 0 B (0) - BytesReadLocal: 24.7 KiB (25262) - BytesReadRemoteUnexpected: 0 B (0) - BytesReadShortCircuit: 24.7 KiB (25262) - CachedFileHandlesHitCount: 2 (2) - CachedFileHandlesMissCount: 0 (0) - CollectionItemsRead: 0 (0) - DataCacheHitBytes: 0 B (0) - DataCacheHitCount: 0 (0) - DataCacheMissBytes: 0 B (0) - DataCacheMissCount: 0 (0) - DataCachePartialHitCount: 0 (0) - DecompressionTime: 4.83us (4829) - InactiveTotalTime: 0ns (0) - MaterializeTupleTime: 8.21us (8213) - MaxCompressedTextFileLength: 0 B (0) - NumColumns: 1 (1) - NumDictFilteredRowGroups: 0 (0) - NumDisksAccessed: 1 (1) - NumPages: 1 (1) - NumRowGroups: 1 (1) - NumRowGroupsWithPageIndex: 1 (1) - NumScannerThreadMemUnavailable: 0 (0) - NumScannerThreadReservationsDenied: 0 (0) - NumScannerThreadsStarted: 1 (1) - NumScannersWithNoReads: 0 (0) - NumStatsFilteredPages: 0 (0) - NumStatsFilteredRowGroups: 0 (0) - PeakMemoryUsage: 4.0 MiB (4244940) - PeakScannerThreadConcurrency: 1 (1) - PerReadThreadRawHdfsThroughput: 39.6 MiB/s (41501219) - RemoteScanRanges: 0 (0) - RowBatchBytesEnqueued: 21.4 KiB (21964) - RowBatchQueueGetWaitTime: 998.49us (998487) - RowBatchQueuePeakMemoryUsage: 45.4 KiB (46540) - RowBatchQueuePutWaitTime: 0ns (0) - RowBatchesEnqueued: 3 (3) - RowsRead: 67 (67) - RowsReturned: 67 (67) - RowsReturnedRate: 38373 per second (38373) - ScanRangesComplete: 1 (1) - ScannerIoWaitTime: 646.93us (646929) - ScannerThreadWorklessLoops: 0 (0) - ScannerThreadsInvoluntaryContextSwitches: 0 (0) - ScannerThreadsTotalWallClockTime: 1ms (1065007) - ScannerThreadsSysTime: 0ns (0) - ScannerThreadsUserTime: 482.00us (482000) - ScannerThreadsVoluntaryContextSwitches: 3 (3) - TotalRawHdfsOpenFileTime: 34.20us (34198) - TotalRawHdfsReadTime: 608.71us (608705) - TotalReadThroughput: 0 B/s (0) - TotalTime: 1ms (1745989) Node Lifecycle Event Timeline Open Started: 52ms (52866207) Open Finished: 52ms (52993077) First Batch Requested: 53ms (53010536) First Batch Returned: 54ms (54352345) Last Batch Returned: 54ms (54661974) Closed: 54ms (54687747) Buffer pool - AllocTime: 16.32us (16319) - CompressionTime: 0ns (0) - CumulativeAllocationBytes: 40.0 KiB (40960) - CumulativeAllocations: 2 (2) - EncryptionTime: 0ns (0) - InactiveTotalTime: 0ns (0) - PeakReservation: 4.0 MiB (4194304) - PeakUnpinnedBytes: 0 B (0) - PeakUsedReservation: 32.0 KiB (32768) - ReadIoBytes: 0 B (0) - ReadIoOps: 0 (0) - ReadIoWaitTime: 0ns (0) - SystemAllocTime: 0ns (0) - TotalTime: 0ns (0) - WriteIoBytes: 0 B (0) - WriteIoOps: 0 (0) - WriteIoWaitTime: 0ns (0)