__step=000217
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 60 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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000217.txt
__path_data=data/data000217.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55e6798a8400
addrof(kcasDescriptors[1])=0x55e6798a8d00
addrof(rdcssDescriptors[0])=0x55e6799c8400
addrof(rdcssDescriptors[1])=0x55e6799c84c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6981416.656935435
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=999555 prefilling_elapsed_millis=1.001s
finished prefilling to size 999572 for expected size 1000000 keysum=1000433872443, performing 28578958 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999572
pref_millis=1102
prefill_elapsed_ms=1123
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6981417.969891606
REALTIME_END_PERF_FORMAT=6981427.970052051

###############################################################################
################################## 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.055s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32752 64387 114262 155245 126703 44221 4076 23 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 16 1015 12248 58961 141434 150679 56480 5086 26
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65402 126510 214206 268137 194900 60556 5109 26
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65402 126510 214206 268137 194900 60556 5109 26
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.9964 1.94986 1.79001 1.52703 1.25434 1.08381 1.01706 1.00059 1

tree_stats_height=24
tree_stats_numInternals=574436
tree_stats_numLeaves=425945
tree_stats_numNodes=1000381
tree_stats_numKeys=1000381

tree_stats_avgDegreeInternal=1.7415
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42578
tree_stats_avgKeyDepth=18.3406


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175607 2:138717 4:13638 8:38 16:45
    [2^00, 2^01]: 175607
    (2^01, 2^02]: 138717
    (2^02, 2^03]: 13638
    (2^03, 2^04]: 38
    (2^04, 2^05]: 45
sum_limbo_reclamation_event_size_total=550344
count_limbo_reclamation_event_size_by_thread=6761 6851 6884 6829 6826 6709 6890 6825 6845 6858 6865 6812 6815 6913 6837 6809 6873 6765 6784 6867 6921 6838 6892 6807 6781 6854 6850 6868 6827 6867 6824 6885 6893 6859 6807 6806 6840 6827 6800 6826 6792 6809 6821 6838 6794 6919 6741 6841
count_limbo_reclamation_event_size_total=328045
sum_limbo_reclamation_event_count_total=1149984
first_thread_announced_epoch_by_thread=50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632 50632
sum_num_inserts_by_thread=55098 54945 55178 54711 54456 53641 54063 54773 55574 55031 55115 54479 54598 54559 54931 55661 54610 55205 54568 54813 55182 55310 54933 54277 54091 55068 55610 55651 55123 54233 54531 54597 55244 55906 54741 54294 54193 54548 55493 55554 55007 55001 54474 54596 55109 55500 54985 54376
sum_num_inserts_total=2633636
sum_num_deletes_by_thread=54589 55054 54898 54529 54625 53710 54249 54172 55577 55324 55016 54043 54468 54965 54951 55249 54832 54567 53756 54860 55369 54882 55055 54229 54023 55334 55520 55142 54961 54842 54303 54885 55176 56113 54701 54356 54250 54524 55160 55115 54885 54970 55083 54446 54989 55619 54367 54345
sum_num_deletes_total=2630078
sum_num_searches_by_thread=10793102 10866457 10905480 10876021 10831565 10693694 10729674 10806443 10998005 11024439 10905048 10754924 10782784 10835242 10912391 10964778 10870121 10872468 10724413 10854756 10886072 10900435 10864870 10701802 10731411 10886481 10986729 10972777 10853882 10770878 10749295 10816671 10952282 11045044 10823094 10756522 10768427 10843425 10923055 10972289 10953151 10859917 10776965 10819266 10859991 10988298 10793796 10713193
sum_num_searches_total=520971823
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10902789 10976456 11015556 10985261 10940646 10801045 10837986 10915388 11109156 11134794 11015179 10863446 10891850 10944766 11022273 11075688 10979563 10982240 10832737 10964429 10996623 11010627 10974858 10810308 10839525 10996883 11097859 11083570 10963966 10879953 10858129 10926153 11062702 11157063 10932536 10865172 10876870 10952497 11033708 11082958 11063043 10969888 10886522 10928308 10970089 11099417 10903148 10821914
average_num_operations_total=10963240
stdev_num_operations_total=13353
sum_num_operations_total=526235537
min_num_operations_total=10801045
max_num_operations_total=11157063
first_time_thread_terminate_by_thread=10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000160 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000161 10000160 10000161 10000162 10000161
min_time_thread_terminate_total=10000160
max_time_thread_terminate_total=10000162
first_time_thread_start_by_thread=3 3 3 3 3 3 4 3 3 4 3 3 4 4 4 4 3 3 3 3 4 4 3 4 3 3 3 3 3 3 4 3 3 4 3 3 4 4 4 4 3 3 3 3 4 4 3 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=1000403504534
threads_final_size=1000381
final_keysum=1000403504534
final_size=1000381
validate_result=success
Validation OK.
Structural validation OK.

total_find=520971823
total_rq=0
total_inserts=2633636
total_deletes=2630078
total_updates=5263714
total_queries=520971823
total_ops=526235537
find_throughput=52097182
rq_throughput=0
update_throughput=526371
query_throughput=52097182
total_throughput=52623553


total find                    : 520971823
total rq                      : 0
total inserts                 : 2633636
total deletes                 : 2630078
total updates                 : 5263714
total queries                 : 520971823
total ops                     : 526235537
find throughput               : 52097182
rq throughput                 : 0
update throughput             : 526371
query throughput              : 52097182
total throughput              : 52623553

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=14.9723
PAPI_L3_TCM=1.94479
PAPI_TOT_CYC=2530.93
PAPI_TOT_INS=1067.26
garbage=260727027286293
total_execution_walltime=11.446s
REALTIME_MAIN_END_PERF_FORMAT=6981428.106484407
[time_cmd_output] time_elapsed_sec=11.59, faults_major=0, faults_minor=91121, mem_maxresident_kb=366456, user_cputime=561.39, sys_cputime=1.90, percent_cpu=4860%
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