__step=000281
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 numactl -i all /usr/bin/time -f "[time_cmd_output] time_elapsed_sec=%e, faults_major=%F, faults_minor=%R, mem_maxresident_kb=%M, user_cputime=%U, sys_cputime=%S, percent_cpu=%P" ./sigouin_int_avl_kcas_validate.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000281.txt
__path_data=data/data000281.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5630939f33c0
addrof(kcasDescriptors[1])=0x5630939f3cc0
addrof(rdcssDescriptors[0])=0x563093b133c0
addrof(rdcssDescriptors[1])=0x563093b13480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=223252.650780730
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_avl_kcas_validate
FIND_FUNC=FIND_FUNC
INSERT_FUNC=insertIfAbsent
ERASE_FUNC=ERASE_FUNC
RQ_FUNC=RQ_FUNC
RECLAIM=reclaimer_debra
ALLOC=allocator_new
POOL=pool_none
MAX_THREADS_POW2=512
CPU_FREQ_GHZ=2.1
MILLIS_TO_RUN=10000
INS_FRAC=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=5.0 5.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56
ACTUAL_THREAD_BINDINGS=0,1,2,3,4,5,6,7,8,9,10,11,12,13,14,15,16,17,18,19,20,21,22,23,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.02s
prefilling_size=100097 prefilling_elapsed_millis=1s
finished prefilling to size 100094 for expected size 100000 keysum=10021593953, performing 30551800 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=100094
pref_millis=1101
prefill_elapsed_ms=1113
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=223253.797886339
REALTIME_END_PERF_FORMAT=223263.797949446
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.063s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8164 14996 17426 7921 737 7 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 27 1189 10317 19937 10245 914 10
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16185 27743 27858 10982 921 10
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16185 27743 27858 10982 921 10
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99976 1.97925 1.78758 1.37602 1.10988 1.01675 1.00326 1
tree_stats_height=20
tree_stats_numInternals=57442
tree_stats_numLeaves=42639
tree_stats_numNodes=100081
tree_stats_numKeys=100081
tree_stats_avgDegreeInternal=1.7423
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42604
tree_stats_avgKeyDepth=14.8732
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:5 2:344 4:24213 8:436313 16:178666 32:60 64:144 128:127
[2^00, 2^01]: 5
(2^01, 2^02]: 344
(2^02, 2^03]: 24213
(2^03, 2^04]: 436313
(2^04, 2^05]: 178666
(2^05, 2^06]: 60
(2^06, 2^07]: 144
(2^07, 2^08]: 127
sum_limbo_reclamation_event_size_total=8672594
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639872
sum_limbo_reclamation_event_count_total=1487230
first_thread_announced_epoch_by_thread=48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178 48178
sum_num_inserts_by_thread=624809 627760 628836 616664 617484 617250 609605 600394 603617 600098 595704 596728 617581 606693 610235 603779 601826 600816 604736 596151 586709 580996 578785 578129 583472 581666 599745 603696 603433 598247 596931 600077 690422 686266 668545 665283 658423 657435 609008 611105 689211 673884 666007 670126 604728 603427 597462 596824 678012 619011 667771 621259 628104 690659 691735 661250 712623 715795 720059 716083 628387 627582 631664 635734
sum_num_inserts_total=40266536
sum_num_deletes_by_thread=624980 627392 629287 616683 617970 616659 609223 599071 602173 600657 596390 594412 617764 607307 611023 604149 603124 600366 605393 597210 588331 579629 578276 577518 583362 582044 598761 601613 604216 598758 595797 601358 688023 683968 669139 663862 659008 657742 608381 610660 688399 673569 665688 669893 604043 602910 596197 597070 678661 618633 668334 623233 629031 689985 691619 660156 713402 715896 719457 717031 629366 628474 630483 635887
sum_num_deletes_total=40259096
sum_num_searches_by_thread=11220290 11297852 11330957 11100315 11134033 11116790 10980494 10803467 10839102 10815357 10717664 10708169 11119832 10910094 10996102 10870058 10832163 10813136 10884602 10737427 10575173 10454312 10405258 10398314 10501775 10471834 10805526 10865181 10862350 10765451 10733315 10818856 12410359 12338657 12040375 11957661 11859489 11834260 10956743 10991159 12394858 12135554 11971617 12058978 10880445 10867364 10747517 10751819 12202626 11147097 12048386 11200774 11317931 12424189 12458615 11884406 12849223 12879349 12960817 12905577 11323832 11332568 11360838 11449280
sum_num_searches_total=724827612
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=12470079 12553004 12589080 12333662 12369487 12350699 12199322 12002932 12044892 12016112 11909758 11899309 12355177 12124094 12217360 12077986 12037113 12014318 12094731 11930788 11750213 11614937 11562319 11553961 11668609 11635544 12004032 12070490 12069999 11962456 11926043 12020291 13788804 13708891 13378059 13286806 13176920 13149437 12174132 12212924 13772468 13483007 13303312 13398997 12089216 12073701 11941176 11945713 13559299 12384741 13384491 12445266 12575066 13804833 13841969 13205812 14275248 14311040 14400333 14338691 12581585 12588624 12622985 12720901
average_num_operations_total=12583644
stdev_num_operations_total=98514
sum_num_operations_total=805353244
min_num_operations_total=11553961
max_num_operations_total=14400333
first_time_thread_terminate_by_thread=10000062 10000062 10000062 10000062 10000059 10000059 10000059 10000059 10000061 10000061 10000061 10000061 10000060 10000060 10000060 10000060 10000061 10000061 10000061 10000061 10000062 10000062 10000062 10000062 10000061 10000061 10000061 10000061 10000060 10000060 10000060 10000060 10000060 10000060 10000060 10000060 10000061 10000061 10000061 10000061 10000059 10000059 10000059 10000059 10000061 10000061 10000061 10000061 10000061 10000061 10000061 10000061 10000062 10000062 10000062 10000062 10000062 10000062 10000062 10000062 10000059 10000059 10000059 10000059
min_time_thread_terminate_total=10000059
max_time_thread_terminate_total=10000062
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 4 4 4 4 3 3 3 3 6 6 6 6 4 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 3 3 3 3 3 3 3 3 6 6 6 6 4 4 4 4 4 4 4 4 6 7 6 6 6 6 6 6
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=10004317764
threads_final_size=100081
final_keysum=10004317764
final_size=100081
validate_result=success
Validation OK.
Structural validation OK.
total_find=724827612
total_rq=0
total_inserts=40266536
total_deletes=40259096
total_updates=80525632
total_queries=724827612
total_ops=805353244
find_throughput=72482761
rq_throughput=0
update_throughput=8052563
query_throughput=72482761
total_throughput=80535324
total find : 724827612
total rq : 0
total inserts : 40266536
total deletes : 40259096
total updates : 80525632
total queries : 724827612
total ops : 805353244
find throughput : 72482761
rq throughput : 0
update throughput : 8052563
query throughput : 72482761
total throughput : 80535324
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=11674537688861
total_execution_walltime=11.31s
REALTIME_MAIN_END_PERF_FORMAT=223263.962046413
[time_cmd_output] time_elapsed_sec=11.41, faults_major=0, faults_minor=77036, mem_maxresident_kb=308484, user_cputime=726.93, sys_cputime=5.23, percent_cpu=6415%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1