__step=000203
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000203.txt
__path_data=data/data000203.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55c636c61400
addrof(kcasDescriptors[1])=0x55c636c61d00
addrof(rdcssDescriptors[0])=0x55c636d81400
addrof(rdcssDescriptors[1])=0x55c636d814c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996875.912800898
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.018s
prefilling_size=8280586 prefilling_elapsed_millis=1.001s
prefilling_size=8537898 prefilling_elapsed_millis=1.101s
prefilling_size=8752213 prefilling_elapsed_millis=1.201s
prefilling_size=8936028 prefilling_elapsed_millis=1.301s
prefilling_size=9088648 prefilling_elapsed_millis=1.402s
prefilling_size=9219252 prefilling_elapsed_millis=1.502s
prefilling_size=9334054 prefilling_elapsed_millis=1.602s
prefilling_size=9422872 prefilling_elapsed_millis=1.702s
prefilling_size=9507632 prefilling_elapsed_millis=1.802s
prefilling_size=9574698 prefilling_elapsed_millis=1.903s
prefilling_size=9636962 prefilling_elapsed_millis=2.003s
prefilling_size=9688486 prefilling_elapsed_millis=2.103s
prefilling_size=9732128 prefilling_elapsed_millis=2.203s
prefilling_size=9771247 prefilling_elapsed_millis=2.303s
prefilling_size=9803086 prefilling_elapsed_millis=2.404s
finished prefilling to size 9803091 for expected size 10000000 keysum=98027321756248, performing 80140780 updates; total_prefilling_elapsed_ms=2505 ms)
pref_size=9803091
pref_millis=2505
prefill_elapsed_ms=2528
main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6996878.644745981
REALTIME_END_PERF_FORMAT=6996888.644879552

###############################################################################
################################## 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 (192 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.046s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131071 262076 521314 985593 1498056 1415080 657679 122727 7103 39 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 60 2591 49851 391964 1230553 1589076 822411 156522 8873 45
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262136 523905 1035444 1890020 2645633 2246755 945138 163625 8912 45
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262136 523905 1035444 1890020 2645633 2246755 945138 163625 8912 45
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99995 1.99883 1.98134 1.87347 1.60718 1.31436 1.12794 1.04327 1.01106 1.00067 1

tree_stats_height=28
tree_stats_numInternals=5731809
tree_stats_numLeaves=4251947
tree_stats_numNodes=9983756
tree_stats_numKeys=9983756

tree_stats_avgDegreeInternal=1.74182
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42589
tree_stats_avgKeyDepth=21.6504


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:40 8:27634 16:527615 32:20903
    (2^02, 2^03]: 40
    (2^03, 2^04]: 27634
    (2^04, 2^05]: 527615
    (2^05, 2^06]: 20903
sum_limbo_reclamation_event_size_total=13208377
count_limbo_reclamation_event_size_by_thread=6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002 6002
count_limbo_reclamation_event_size_total=576192
sum_limbo_reclamation_event_count_total=576384
first_thread_announced_epoch_by_thread=13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886 13886
sum_num_inserts_by_thread=275790 278328 276458 278088 277511 273817 274598 276367 278704 281907 276388 275094 276625 277822 280324 281766 278704 275097 274262 275666 277554 279753 274864 272500 275730 277826 277172 277697 277109 274142 274989 276222 280515 280633 276169 274428 277395 276753 280821 280775 278315 276583 275155 277508 278548 277953 275871 272940 278040 276947 279606 278445 277360 276250 277048 277244 279109 281232 279949 274197 277632 276736 278815 278913 278847 274423 273191 274796 277032 279166 277917 274380 274677 277280 281362 279208 276597 276250 275706 277449 280573 280637 277124 276663 275735 278981 278457 278502 276932 274066 274863 275860 279043 279709 277368 276505
sum_num_inserts_total=26616058
sum_num_deletes_by_thread=274372 279091 277397 278216 277867 273067 274714 275122 278687 281226 277179 275148 277879 277631 278970 280595 277770 274974 274601 276672 278181 279514 275058 273017 275888 277380 276954 278772 277199 274018 275275 276292 279658 280914 276000 274823 276934 277016 280799 280672 278887 276145 275859 277378 279305 278907 275216 272539 277189 277435 278366 278709 277351 276000 276763 277040 279640 281268 280398 274860 277030 277088 278574 278240 278818 274446 273772 274868 278368 278358 277696 274121 275113 276061 280150 278836 276670 277788 275631 278140 278650 279728 277685 275734 275908 278767 278451 278322 276895 274496 274433 275726 278135 279687 278592 277256
sum_num_deletes_total=26613030
sum_num_searches_by_thread=4946497 5000121 4992741 5007178 4995854 4921325 4946308 4973788 5026398 5057696 4973650 4948815 4988345 4992775 5039607 5047029 5008741 4956171 4931849 4956036 5016141 5032514 4948044 4909164 4965680 4989747 4989791 4997733 4970800 4925150 4948738 4972069 5034517 5047081 4967955 4937101 4980897 4978785 5047263 5052501 5015811 4972667 4960486 4984452 5009905 5012622 4949066 4906015 4989314 4987862 5025058 5013102 4991984 4968652 4973859 4998704 5028606 5057718 5016952 4948801 4993410 4989596 5013238 5016842 5012902 4942310 4936887 4946162 5009250 5032691 4994843 4942224 4953315 4984967 5048611 5015616 4981913 4978465 4950594 5002451 5021675 5058398 4990052 4982284 4972844 5006966 5013113 5010195 4978888 4932324 4950950 4969285 5010986 5039781 5007563 4979033
sum_num_searches_total=478904855
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5496659 5557540 5546596 5563482 5551232 5468209 5495620 5525277 5583789 5620829 5527217 5499057 5542849 5548228 5598901 5609390 5565215 5506242 5480712 5508374 5571876 5591781 5497966 5454681 5517298 5544953 5543917 5554202 5525108 5473310 5499002 5524583 5594690 5608628 5520124 5486352 5535226 5532554 5608883 5613948 5573013 5525395 5511500 5539338 5567758 5569482 5500153 5451494 5544543 5542244 5583030 5570256 5546695 5520902 5527670 5552988 5587355 5620218 5577299 5497858 5548072 5543420 5570627 5573995 5570567 5491179 5483850 5495826 5564650 5590215 5550456 5490725 5503105 5538308 5610123 5573660 5535180 5532503 5501931 5558040 5580898 5618763 5544861 5534681 5524487 5564714 5570021 5567019 5532715 5480886 5500246 5520871 5568164 5599177 5563523 5532794
average_num_operations_total=5543061
stdev_num_operations_total=4083
sum_num_operations_total=532133943
min_num_operations_total=5451494
max_num_operations_total=5620829
first_time_thread_terminate_by_thread=10000135 10000134 10000136 10000134 10000134 10000134 10000134 10000136 10000134 10000135 10000134 10000134 10000134 10000134 10000135 10000134 10000135 10000135 10000135 10000134 10000134 10000135 10000136 10000138 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000136 10000134 10000134 10000134 10000134 10000134 10000134 10000135 10000134 10000134 10000138 10000135 10000134 10000134 10000134 10000136 10000134 10000134 10000136 10000134 10000134 10000134 10000136 10000134 10000136 10000134 10000135 10000136 10000134 10000135 10000135 10000137 10000134 10000136 10000134 10000138 10000134 10000134 10000134 10000136 10000136 10000134 10000136 10000134 10000134 10000134 10000136 10000134 10000136 10000134 10000135 10000134 10000134 10000135 10000136 10000136 10000134 10000136 10000135 10000135 10000134 10000134 10000134 10000136 10000134
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=99835760218424
threads_final_size=9983756
final_keysum=99835760218424
final_size=9983756
validate_result=success
Validation OK.
Structural validation OK.

total_find=478904855
total_rq=0
total_inserts=26616058
total_deletes=26613030
total_updates=53229088
total_queries=478904855
total_ops=532133943
find_throughput=47890485
rq_throughput=0
update_throughput=5322908
query_throughput=47890485
total_throughput=53213394


total find                    : 478904855
total rq                      : 0
total inserts                 : 26616058
total deletes                 : 26613030
total updates                 : 53229088
total queries                 : 478904855
total ops                     : 532133943
find throughput               : 47890485
rq throughput                 : 0
update throughput             : 5322908
query throughput              : 47890485
total throughput              : 53213394

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=27.8356
PAPI_L3_TCM=10.166
PAPI_TOT_CYC=5024.7
PAPI_TOT_INS=1379.34
garbage=2378255653936100
total_execution_walltime=12.866s
REALTIME_MAIN_END_PERF_FORMAT=6996888.788869845
[time_cmd_output] time_elapsed_sec=13.05, faults_major=0, faults_minor=238357, mem_maxresident_kb=950928, user_cputime=1227.77, sys_cputime=3.67, percent_cpu=9429%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1