__step=000394
__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_bst_kcas_validate_htm.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000394.txt
__path_data=data/data000394.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55699df27400
addrof(kcasDescriptors[1])=0x55699df27d00
addrof(rdcssDescriptors[0])=0x55699e047400
addrof(rdcssDescriptors[1])=0x55699e0474c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6999557.68131522
binary=./sigouin_int_bst_kcas_validate_htm.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=sigouin_int_bst_kcas_validate_htm
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=2000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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


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

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

REALTIME_START_PERF_FORMAT=6999558.346068066
REALTIME_END_PERF_FORMAT=6999568.346201431

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

tree_stats_computeWalltime=0.036s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 249 483 909 1596 2740 4505 7214 11184 16297 22643 30086 37958 45505 51503 54814 55762 54203 50253 44403 37585 30869 24686 19083 14605 10800 7879 5404 3695 2459 1469 846 492 248 132 68 36 12 5 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 6 36 132 248 547 1001 1788 3302 5497 8321 12117 16511 21148 25650 28900 30594 30822 29916 27174 23289 19398 15887 12350 9689 7207 5373 3729 2586 1824 1108 619 376 184 100 52 28 9 4 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 252 489 945 1728 2988 5052 8215 12972 19599 28140 38407 50075 62016 72651 80464 84662 84797 81075 74319 64759 54158 44084 34970 26955 20489 15086 10777 7424 5045 3293 1954 1111 624 316 168 88 40 14 6 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 252 489 945 1728 2988 5052 8215 12972 19599 28140 38407 50075 62016 72651 80464 84662 84797 81075 74319 64759 54158 44084 34970 26955 20489 15086 10777 7424 5045 3293 1954 1111 624 316 168 88 40 14 6 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.96875 1.95238 1.94479 1.86667 1.80556 1.77376 1.73436 1.70091 1.6487 1.60427 1.5602 1.52045 1.48044 1.43773 1.39863 1.37095 1.34295 1.3169 1.29684 1.2739 1.25592 1.24401 1.23328 1.22511 1.21829 1.20919 1.1921 1.18744 1.18184 1.16531 1.14728 1.13562 1.11881 1.10897 1.11392 1.11905 1.04545 1.05 1.07143 1 1

tree_stats_height=48
tree_stats_numInternals=652937
tree_stats_numLeaves=347527
tree_stats_numNodes=1000464
tree_stats_numKeys=1000464

tree_stats_avgDegreeInternal=1.53225
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34737
tree_stats_avgKeyDepth=24.0292


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:60 2:1657 4:56025 8:371539 16:50616 32:2
    [2^00, 2^01]: 60
    (2^01, 2^02]: 1657
    (2^02, 2^03]: 56025
    (2^03, 2^04]: 371539
    (2^04, 2^05]: 50616
    (2^05, 2^06]: 2
sum_limbo_reclamation_event_size_total=5424435
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479899
sum_limbo_reclamation_event_count_total=1014384
first_thread_announced_epoch_by_thread=45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948 45948
sum_num_inserts_by_thread=481854 483656 488093 488113 473146 466903 483080 471377 478712 480406 473811 471232 471667 474226 476976 477654 488660 470704 469321 471615 489736 478284 470562 480364 468047 471352 476090 475579 487440 468930 470165 471779 494028 479487 473406 484868 472548 488313 492381 478962 487161 470801 467180 485481 475481 479132 485518 468732
sum_num_inserts_total=22933013
sum_num_deletes_by_thread=480688 484982 489198 489014 471758 466690 483949 473080 477885 479617 474669 470729 471957 474544 477651 476714 488128 471569 468958 471173 489099 477586 471461 480813 468562 471397 475262 475228 488106 468738 471918 472800 493185 478315 473278 484184 471938 487252 493050 476731 487777 471023 467891 483709 474598 478634 486702 469161
sum_num_deletes_total=22931351
sum_num_searches_by_thread=8660910 8717750 8785668 8789795 8520216 8388446 8688278 8500574 8601339 8636953 8526546 8485986 8501276 8536705 8603820 8591478 8784543 8481276 8436339 8495827 8807671 8589196 8485167 8653700 8412977 8488499 8562714 8558571 8794545 8439995 8485537 8501230 8863975 8635690 8527630 8717653 8501954 8779045 8845486 8595003 8779243 8473688 8422244 8726879 8551967 8612874 8750584 8447423
sum_num_searches_total=412744865
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9623452 9686388 9762959 9766922 9465120 9322039 9655307 9445031 9557936 9596976 9475026 9427947 9444900 9485475 9558447 9545846 9761331 9423549 9374618 9438615 9786506 9545066 9427190 9614877 9349586 9431248 9514066 9509378 9770091 9377663 9427620 9445809 9851188 9593492 9474314 9686705 9446440 9754610 9830917 9550696 9754181 9415512 9357315 9696069 9502046 9570640 9722804 9385316
average_num_operations_total=9554358
stdev_num_operations_total=21293
sum_num_operations_total=458609229
min_num_operations_total=9322039
max_num_operations_total=9851188
first_time_thread_terminate_by_thread=10000133 10000133 10000133 10000133 10000133 10000134 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000134 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133 10000133
min_time_thread_terminate_total=10000133
max_time_thread_terminate_total=10000134
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 2
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=1000721203102
threads_final_size=1000464
final_keysum=1000721203102
final_size=1000464
validate_result=success
Validation OK.
Structural validation OK.

total_find=412744865
total_rq=0
total_inserts=22933013
total_deletes=22931351
total_updates=45864364
total_queries=412744865
total_ops=458609229
find_throughput=41274486
rq_throughput=0
update_throughput=4586436
query_throughput=41274486
total_throughput=45860922


total find                    : 412744865
total rq                      : 0
total inserts                 : 22933013
total deletes                 : 22931351
total updates                 : 45864364
total queries                 : 412744865
total ops                     : 458609229
find throughput               : 41274486
rq throughput                 : 0
update throughput             : 4586436
query throughput              : 41274486
total throughput              : 45860922

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=16.3601
PAPI_L3_TCM=2.21716
PAPI_TOT_CYC=2901.39
PAPI_TOT_INS=1311.78
garbage=206422947772960
total_execution_walltime=11.425s
REALTIME_MAIN_END_PERF_FORMAT=6999568.494525739
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=92101, mem_maxresident_kb=370600, user_cputime=562.60, sys_cputime=1.83, percent_cpu=4874%
timeout=false
algorithm=sigouin_int_bst_kcas_validate_htm.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2