__step=000642
__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000642.txt
__path_data=data/data000642.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986586.641622800
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=200000
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 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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.005s
prefilling_size=99869 prefilling_elapsed_millis=1.001s
finished prefilling to size 99844 for expected size 100000 keysum=9982673775, performing 28762070 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99844
pref_millis=1102
prefill_elapsed_ms=1119
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=2135
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=6986587.922242142
REALTIME_END_PERF_FORMAT=6986597.922384595
###############################################################################
################################## 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.04s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4087 7959 14188 20623 21987 16039 7718 2549 566 107 11 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 9 215 1730 7753 19259 27935 24360 12887 4532 1025 203 22
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8174 15918 28376 41246 43974 32078 15436 5098 1132 214 22
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 9 215 1730 7753 19259 27935 24360 12887 4532 1025 203 22
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.9978 1.9737 1.89132 1.72678 1.53307 1.36474 1.2406 1.16513 1.11102 1.09452 1.0514 1
tree_stats_height=24
tree_stats_numInternals=99929
tree_stats_numLeaves=99930
tree_stats_numNodes=199859
tree_stats_numKeys=99930
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=17.2814
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 457744 891408 1589056 2309776 2462544 1796368 864416 285488 63392 11984 1232
tree_stats_sizeInBytes=11192104
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=42157
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:2 2:6 4:343 8:23264 16:215585 32:229218 64:11386 128:4
[2^00, 2^01]: 2
(2^01, 2^02]: 6
(2^02, 2^03]: 343
(2^03, 2^04]: 23264
(2^04, 2^05]: 215585
(2^05, 2^06]: 229218
(2^06, 2^07]: 11386
(2^07, 2^08]: 4
sum_limbo_reclamation_event_size_total=16486665
count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=479808
sum_limbo_reclamation_event_count_total=3841448
first_thread_announced_epoch_by_thread=84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314 84314
sum_num_inserts_by_thread=911283 917768 920870 921940 915696 903629 908967 918787 927176 932862 918905 914218 915144 919461 928354 927748 922768 916982 905894 917874 928603 927689 915486 908496 910157 917362 917867 921888 916787 906539 909773 916028 928777 932180 913846 914190 915223 918965 927585 927021 919396 914995 903232 915498 926246 927357 917360 907471
sum_num_inserts_total=44072343
sum_num_deletes_by_thread=910786 916985 920417 919430 916266 905299 910187 917694 929160 932958 916636 914632 915220 919092 927627 928292 922045 916257 905280 921239 927728 928101 915498 909975 910431 918090 918448 922735 918303 906729 912002 916879 927209 928849 915184 914779 917665 920291 926259 927153 919825 915815 904723 915823 927393 928334 917493 907302
sum_num_deletes_total=44084518
sum_num_searches_by_thread=16399159 16520856 16564077 16584056 16492012 16307384 16383427 16525973 16709491 16775576 16510300 16460915 16478255 16555205 16728237 16719187 16610221 16497899 16294583 16562759 16713270 16684526 16463412 16379489 16380376 16497280 16538871 16601985 16522614 16307994 16410555 16495187 16692860 16751542 16456863 16456244 16499452 16567713 16696927 16697490 16544382 16481023 16272634 16476255 16672625 16716590 16509583 16320846
sum_num_searches_total=793488160
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=18221228 18355609 18405364 18425426 18323974 18116312 18202581 18362454 18565827 18641396 18345841 18289765 18308619 18393758 18584218 18575227 18455034 18331138 18105757 18401872 18569601 18540316 18294396 18197960 18200964 18332732 18375186 18446608 18357704 18121262 18232330 18328094 18548846 18612571 18285893 18285213 18332340 18406969 18550771 18551664 18383603 18311833 18080589 18307576 18526264 18572281 18344436 18135619
average_num_operations_total=18367604
stdev_num_operations_total=21491
sum_num_operations_total=881645021
min_num_operations_total=18080589
max_num_operations_total=18641396
first_time_thread_terminate_by_thread=10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000141 10000142 10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000141 10000141 10000142 10000142 10000142 10000142 10000141 10000141 10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000141 10000142 10000142 10000142 10000141 10000142 10000142 10000142 10000142 10000141 10000141 10000142 10000142 10000142 10000142 10000141 10000141
min_time_thread_terminate_total=10000141
max_time_thread_terminate_total=10000142
first_time_thread_start_by_thread=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 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=9980007102
threads_final_size=99930
final_keysum=9980007102
final_size=99930
validate_result=success
Validation OK.
Structural validation OK.
total_find=793488160
total_rq=0
total_inserts=44072343
total_deletes=44084518
total_updates=88156861
total_queries=793488160
total_ops=881645021
find_throughput=79348816
rq_throughput=0
update_throughput=8815686
query_throughput=79348816
total_throughput=88164502
total find : 793488160
total rq : 0
total inserts : 44072343
total deletes : 44084518
total updates : 88156861
total queries : 793488160
total ops : 881645021
find throughput : 79348816
rq throughput : 0
update throughput : 8815686
query throughput : 79348816
total throughput : 88164502
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=8.45696
PAPI_L3_TCM=0.0185871
PAPI_TOT_CYC=1511.6
PAPI_TOT_INS=378.583
garbage=39679051227785
total_execution_walltime=11.42s
REALTIME_MAIN_END_PERF_FORMAT=6986598.62610718
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=82422, mem_maxresident_kb=330020, user_cputime=562.05, sys_cputime=2.47, percent_cpu=4888%
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