__step=000497
__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" ./natarajan_ext_bst_lf.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=data000497.txt
__path_data=data/data000497.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984888.1636346
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=natarajan_ext_bst_lf
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=32
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=1000621 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000604 for expected size 1000000 keysum=1000590615619, performing 39727376 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000604
pref_millis=1102
prefill_elapsed_ms=1125
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=1889

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984889.274028507
REALTIME_END_PERF_FORMAT=6984899.274186079

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

tree_stats_computeWalltime=0.039s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 500 956 1788 3237 5538 9121 14144 20742 28889 38258 48317 58500 67675 75080 79727 80981 79120 73913 66496 57791 48408 39172 30430 22870 16762 11721 7862 4977 2949 1606 793 389 168 78 31 8 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 10 44 124 339 936 1955 4098 7546 12595 19520 28199 38134 49325 60270 70433 78473 82842 84327 81330 75201 67174 57644 47914 37990 28978 21803 15580 10747 7005 4292 2419 1197 610 258 125 54 13 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1000 1912 3576 6474 11076 18242 28288 41484 57778 76516 96634 117000 135350 150160 159454 161962 158240 147826 132992 115582 96816 78344 60860 45740 33524 23442 15724 9954 5898 3212 1586 778 336 156 62 16 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 10 44 124 339 936 1955 4098 7546 12595 19520 28199 38134 49325 60270 70433 78473 82842 84327 81330 75201 67174 57644 47914 37990 28978 21803 15580 10747 7005 4292 2419 1197 610 258 125 54 13 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.98039 1.956 1.93515 1.9052 1.85542 1.82349 1.77535 1.73324 1.69639 1.66216 1.63146 1.60538 1.57842 1.55471 1.53095 1.50786 1.48851 1.46709 1.44983 1.43454 1.41882 1.4046 1.38842 1.37578 1.36646 1.34963 1.33538 1.31652 1.29626 1.2723 1.24689 1.24527 1.21594 1.23214 1.19872 1.12903 1.1875 1.16667 1

tree_stats_height=48
tree_stats_numInternals=999511
tree_stats_numLeaves=999512
tree_stats_numNodes=1999023
tree_stats_numKeys=999512

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=26.1517

tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16320 32000 61184 114432 207168 354432 583744 905216 1327488 1848896 2448512 3092288 3744000 4331200 4805120 5102528 5182784 5063680 4730432 4255744 3698624 3098112 2507008 1947520 1463680 1072768 750144 503168 318528 188736 102784 50752 24896 10752 4992 1984 512 192 64
tree_stats_sizeInBytes=63968736

6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=24351


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:59 4:1478 8:52598 16:370894 32:54861 64:11
    (2^01, 2^02]: 59
    (2^02, 2^03]: 1478
    (2^03, 2^04]: 52598
    (2^04, 2^05]: 370894
    (2^05, 2^06]: 54861
    (2^06, 2^07]: 11
sum_limbo_reclamation_event_size_total=10981710
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 9997 9998 9998 9997 9998 9998 9998 9998 9997
count_limbo_reclamation_event_size_total=479901
sum_limbo_reclamation_event_count_total=1078176
first_thread_announced_epoch_by_thread=48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702 48702
sum_num_inserts_by_thread=507420 512296 515259 517882 513714 508651 510377 514553 521532 520643 514957 511845 511877 514636 519775 519083 516851 513614 508373 512581 516202 519925 514732 509003 508458 511418 516350 515863 513347 508048 512154 513095 521325 520985 515160 512090 511931 514488 520714 519284 517432 513623 508479 512542 517716 520743 514073 509500
sum_num_inserts_total=24694599
sum_num_deletes_by_thread=507292 511285 516278 518517 515648 508042 510930 513970 520696 521426 516533 512051 510670 514107 519954 518315 517172 514277 506396 512197 516638 519732 515184 509200 508717 511202 517381 515621 514511 508590 511045 513995 521434 522642 514438 512784 509798 513983 519474 520235 516732 514189 510503 513406 518146 520955 513391 509322
sum_num_deletes_total=24699004
sum_num_searches_by_thread=9133324 9206244 9294374 9312815 9264326 9150027 9191332 9265349 9383187 9393176 9272672 9208404 9208600 9254530 9352737 9353997 9310614 9253214 9152371 9241330 9301729 9349063 9253171 9166452 9147415 9204780 9311013 9293004 9256506 9149526 9198762 9249221 9367130 9383055 9269385 9220804 9192247 9247922 9344004 9344550 9300406 9245268 9159763 9234979 9321268 9374985 9266783 9166070
sum_num_searches_total=444521884
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10148036 10229825 10325911 10349214 10293688 10166720 10212639 10293872 10425415 10435245 10304162 10232300 10231147 10283273 10392466 10391395 10344637 10281105 10167140 10266108 10334569 10388720 10283087 10184655 10164590 10227400 10344744 10324488 10284364 10166164 10221961 10276311 10409889 10426682 10298983 10245678 10213976 10276393 10384192 10384069 10334570 10273080 10178745 10260927 10357130 10416683 10294247 10184892
average_num_operations_total=10289905
stdev_num_operations_total=11818
sum_num_operations_total=493915487
min_num_operations_total=10148036
max_num_operations_total=10435245
first_time_thread_terminate_by_thread=10000157 10000158 10000158 10000158 10000157 10000158 10000157 10000157 10000157 10000158 10000157 10000158 10000157 10000157 10000158 10000158 10000157 10000157 10000158 10000158 10000157 10000158 10000158 10000158 10000157 10000158 10000158 10000158 10000157 10000158 10000157 10000157 10000157 10000158 10000157 10000158 10000157 10000157 10000158 10000158 10000157 10000157 10000158 10000158 10000157 10000158 10000158 10000158
min_time_thread_terminate_total=10000157
max_time_thread_terminate_total=10000158
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 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=999610705251
threads_final_size=999512
final_keysum=999610705251
final_size=999512
validate_result=success
Validation OK.
Structural validation OK.

total_find=444521884
total_rq=0
total_inserts=24694599
total_deletes=24699004
total_updates=49393603
total_queries=444521884
total_ops=493915487
find_throughput=44452188
rq_throughput=0
update_throughput=4939360
query_throughput=44452188
total_throughput=49391548


total find                    : 444521884
total rq                      : 0
total inserts                 : 24694599
total deletes                 : 24699004
total updates                 : 49393603
total queries                 : 444521884
total ops                     : 493915487
find throughput               : 44452188
rq throughput                 : 0
update throughput             : 4939360
query throughput              : 44452188
total throughput              : 49391548

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=12.0441
PAPI_L3_TCM=1.72869
PAPI_TOT_CYC=2708.81
PAPI_TOT_INS=381.234
garbage=222262078815884
total_execution_walltime=11.398s
REALTIME_MAIN_END_PERF_FORMAT=6984899.400866351
[time_cmd_output] time_elapsed_sec=11.52, faults_major=0, faults_minor=91557, mem_maxresident_kb=368688, user_cputime=559.83, sys_cputime=2.72, percent_cpu=4880%
timeout=false
algorithm=natarajan_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1