__step=000196
__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" ./brown_ext_chromatic_lf.debra -nwork 96 -nprefill 96 -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=data000196.txt
__path_data=data/data000196.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6981170.439599674
binary=./brown_ext_chromatic_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_ext_chromatic_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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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 descriptor=128
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.011s
prefilling_size=1000470 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000491 for expected size 1000000 keysum=1000831589333, performing 21953590 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000491
pref_millis=1102
prefill_elapsed_ms=1125
4NodeIxPvE_object_size=56
4NodeIxPvE_allocated_count=0
4NodeIxPvE_allocated_size=0MB
4NodeIxPvE_get_from_pool=0
4NodeIxPvE_deallocated=0
4NodeIxPvE_limbo_count=0
4NodeIxPvE_limbo_details=0 0 0 

global_epoch_counter=494

9SCXRecordIxPvE_object_size=128
9SCXRecordIxPvE_allocated_count=0
9SCXRecordIxPvE_allocated_size=0MB
9SCXRecordIxPvE_get_from_pool=0
9SCXRecordIxPvE_deallocated=0
9SCXRecordIxPvE_limbo_count=0
9SCXRecordIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6981171.753049109
REALTIME_END_PERF_FORMAT=6981181.753197880

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16368 32394 61675 106866 158749 191505 180889 129625 69336 27114 7533 1529 205 19 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 16 342 3113 16484 54983 125993 202121 232153 189914 111558 46695 13537 2853 391 38
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32736 64788 123350 213732 317498 383010 361778 259250 138672 54228 15066 3058 410 38
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 16 342 3113 16484 54983 125993 202121 232153 189914 111558 46695 13537 2853 391 38
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99902 1.98955 1.95195 1.86636 1.74275 1.60317 1.47228 1.3583 1.26745 1.19553 1.13891 1.10149 1.06704 1.04634 1

tree_stats_height=29
tree_stats_numInternals=1000190
tree_stats_numLeaves=1000191
tree_stats_numNodes=2000381
tree_stats_numKeys=1000191

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

tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1833216 3628128 6907600 11968992 17779888 21448560 20259568 14518000 7765632 3036768 843696 171248 22960 2128
tree_stats_sizeInBytes=112021336

4NodeIxPvE_object_size=56
4NodeIxPvE_allocated_count=0
4NodeIxPvE_allocated_size=0MB
4NodeIxPvE_get_from_pool=0
4NodeIxPvE_deallocated=0
4NodeIxPvE_limbo_count=0
4NodeIxPvE_limbo_details=0 0 0 

global_epoch_counter=10262

9SCXRecordIxPvE_object_size=128
9SCXRecordIxPvE_allocated_count=0
9SCXRecordIxPvE_allocated_size=0MB
9SCXRecordIxPvE_get_from_pool=0
9SCXRecordIxPvE_deallocated=0
9SCXRecordIxPvE_limbo_count=0
9SCXRecordIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:47960 2:161586 4:368383 8:311140 16:51657 32:86
    [2^00, 2^01]: 47960
    (2^01, 2^02]: 161586
    (2^02, 2^03]: 368383
    (2^03, 2^04]: 311140
    (2^04, 2^05]: 51657
    (2^05, 2^06]: 86
sum_limbo_reclamation_event_size_total=6690693
count_limbo_reclamation_event_size_by_thread=9779 9806 9820 9789 9848 9789 9792 9782 9796 9809 9780 9787 9796 9817 9802 9829 9795 9790 9810 9801 9779 9796 9796 9809 9787 9816 9815 9795 9797 9775 9790 9804 9816 9775 9802 9809 9821 9791 9816 9820 9799 9781 9749 9758 9806 9772 9823 9779 9766 9810 9790 9784 9758 9784 9790 9864 9796 9805 9806 9803 9823 9819 9828 9826 9826 9794 9777 9799 9781 9806 9809 9788 9814 9782 9820 9818 9811 9795 9815 9781 9809 9829 9824 9815 9783 9838 9806 9796 9770 9778 9819 9798 9822 9769 9794 9801
count_limbo_reclamation_event_size_total=940812
sum_limbo_reclamation_event_count_total=1875456
first_thread_announced_epoch_by_thread=20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524 20524
sum_num_inserts_by_thread=45513 45166 45759 45372 45238 44863 45550 45550 46048 45946 45552 45107 45456 45855 45855 46265 45365 45216 45053 45142 45449 45562 44943 44629 44864 44902 45794 46028 45550 44513 44843 45417 46321 45956 45438 45147 45408 46031 46150 46167 45720 44946 44108 45119 45494 45434 44877 44570 44366 45435 45673 45823 45042 44842 44844 45313 45892 46242 45435 45302 45406 45535 45847 45907 45507 44969 45156 45080 45656 45900 45213 45223 45016 45326 45485 45680 45261 45084 44935 45533 46019 45397 45514 45157 45171 45456 45657 46164 45418 45089 44902 45090 45971 45477 45367 44803
sum_num_inserts_total=4357831
sum_num_deletes_by_thread=44915 45121 46111 45518 45531 44726 45084 45425 45734 45732 45451 45279 45176 45562 45731 46230 45001 45217 44729 45188 45690 45745 45043 45180 44925 45168 45243 46098 45115 44846 45414 45580 46220 45783 45500 45070 45030 45781 45864 45877 45434 45373 44344 44796 45703 45869 45335 44545 44879 44935 45904 45774 45126 45042 45255 45750 45811 46325 45575 44927 44934 45554 45963 45837 45565 44450 44753 45208 46004 46069 44737 45059 44744 45166 45384 45668 45275 44866 44845 45019 45902 45623 45320 45133 44933 45788 46124 45885 45305 44799 45420 45160 46039 46175 45759 45846
sum_num_deletes_total=4357646
sum_num_searches_by_thread=8911337 8972814 9047946 9045640 8985329 8882461 8926737 8994143 9107750 9117300 8996380 8935036 8953887 9013315 9068683 9087903 9028475 8945071 8869706 8941065 9015250 9059480 8936229 8874378 8913710 8950841 9051000 9058659 8984848 8886639 8934238 8993383 9098657 9108807 8982248 8921256 8931662 9018352 9071930 9085345 9007655 8920113 8843115 8916738 9001313 9068661 8922027 8828615 8898165 8966615 9055663 9044051 8955638 8920061 8934323 8978802 9116554 9109077 9031936 8959125 8947383 9027865 9073236 9092516 9021969 8904863 8879618 8940590 9064630 9072504 8969456 8906513 8898090 8958559 9052460 9051139 8941604 8897226 8911593 8951434 9090395 9103340 9015951 8940953 8955619 9016773 9079856 9077190 9001840 8888423 8858698 8946219 9064457 9089795 9020283 8941082
sum_num_searches_total=862840259
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9001765 9063101 9139816 9136530 9076098 8972050 9017371 9085118 9199532 9208978 9087383 9025422 9044519 9104732 9160269 9180398 9118841 9035504 8959488 9031395 9106389 9150787 9026215 8964187 9003499 9040911 9142037 9150785 9075513 8975998 9024495 9084380 9191198 9200546 9073186 9011473 9022100 9110164 9163944 9177389 9098809 9010432 8931567 9006653 9092510 9159964 9012239 8917730 8987410 9056985 9147240 9135648 9045806 9009945 9024422 9069865 9208257 9201644 9122946 9049354 9037723 9118954 9165046 9184260 9113041 8994282 8969527 9030878 9156290 9164473 9059406 8996795 8987850 9049051 9143329 9142487 9032140 8987176 9001373 9041986 9182316 9194360 9106785 9031243 9045723 9108017 9171637 9169239 9092563 8978311 8949020 9036469 9156467 9181447 9111409 9031731
average_num_operations_total=9078705
stdev_num_operations_total=7668
sum_num_operations_total=871555736
min_num_operations_total=8917730
max_num_operations_total=9208978
first_time_thread_terminate_by_thread=10000147 10000147 10000147 10000149 10000147 10000148 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000149 10000147 10000149 10000147 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000149 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148 10000148
min_time_thread_terminate_total=10000147
max_time_thread_terminate_total=10000149
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 4 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 4 4 4 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 4 4 4 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=1000679627088
threads_final_size=1000191
final_keysum=1000679627088
final_size=1000191
validate_result=success
Validation OK.
Structural validation OK.

total_find=862840259
total_rq=0
total_inserts=4357831
total_deletes=4357646
total_updates=8715477
total_queries=862840259
total_ops=871555736
find_throughput=86284025
rq_throughput=0
update_throughput=871547
query_throughput=86284025
total_throughput=87155573


total find                    : 862840259
total rq                      : 0
total inserts                 : 4357831
total deletes                 : 4357646
total updates                 : 8715477
total queries                 : 862840259
total ops                     : 871555736
find throughput               : 86284025
rq throughput                 : 0
update throughput             : 871547
query throughput              : 86284025
total throughput              : 87155573

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.1541
PAPI_L3_TCM=4.8217
PAPI_TOT_CYC=3065.98
PAPI_TOT_INS=333.548
garbage=431654518470183
total_execution_walltime=11.48s
REALTIME_MAIN_END_PERF_FORMAT=6981181.920391053
[time_cmd_output] time_elapsed_sec=11.64, faults_major=0, faults_minor=138863, mem_maxresident_kb=552508, user_cputime=1088.20, sys_cputime=3.60, percent_cpu=9379%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2