__step=000977
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000977.txt
__path_data=data/data000977.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218591.8909774
binary=./brown_ext_chromatic_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.019s
prefilling_size=99697 prefilling_elapsed_millis=1s
finished prefilling to size 99737 for expected size 100000 keysum=9972384724, performing 25022542 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99737
pref_millis=1101
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=1157
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=218592.162748479
REALTIME_END_PERF_FORMAT=218602.162843220
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (256 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.089s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4089 8021 14476 21183 22337 15748 7295 2224 483 60 6 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 7 157 1566 7769 20029 28926 24201 12366 3965 906 114 12
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8178 16042 28952 42366 44674 31496 14590 4448 966 120 12
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 7 157 1566 7769 20029 28926 24201 12366 3965 906 114 12
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99829 1.9808 1.90238 1.73166 1.52724 1.35251 1.23162 1.15243 1.10859 1.06211 1.05 1
tree_stats_height=24
tree_stats_numInternals=100017
tree_stats_numLeaves=100018
tree_stats_numNodes=200035
tree_stats_numKeys=100018
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=17.2416
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 457968 898352 1621312 2372496 2501744 1763776 817040 249088 54096 6720 672
tree_stats_sizeInBytes=11201960
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=12894
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:14646 2:10946 4:3170 8:6686 16:14413 32:34692 64:75600 128:157581 256:198862 512:92575 1024:63
[2^00, 2^01]: 14646
(2^01, 2^02]: 10946
(2^02, 2^03]: 3170
(2^03, 2^04]: 6686
(2^04, 2^05]: 14413
(2^05, 2^06]: 34692
(2^06, 2^07]: 75600
(2^07, 2^08]: 157581
(2^08, 2^09]: 198862
(2^09, 2^10]: 92575
(2^10, 2^11]: 63
sum_limbo_reclamation_event_size_total=161066308
count_limbo_reclamation_event_size_by_thread=9576 9597 9571 9477 9588 9506 9600 9553 9568 9633 9566 9596 9634 9637 9594 9505 9438 9467 9444 9431 9321 9361 9424 9360 9524 9474 9504 9506 9528 9462 9501 9522 9566 9598 9524 9522 9587 9579 9615 9566 9604 9610 9594 9531 9557 9620 9597 9496 9536 9554 9445 9463 9488 9543 9446 9475 9515 9454 9460 9381 9479 9446 9433 9482
count_limbo_reclamation_event_size_total=609234
sum_limbo_reclamation_event_count_total=1500882
first_thread_announced_epoch_by_thread=25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788 25788
sum_num_inserts_by_thread=1974632 1981148 1957233 1940297 1968591 1972554 1969414 1958819 1971906 1976789 1966888 1959676 1982904 1982311 1972752 1969957 1955132 1954950 1942866 1946967 2050623 2079318 2063933 2057525 1940250 1945550 1931321 1933741 1949751 1962524 1957654 1955184 1990834 2002765 1966002 1980061 1992463 1983095 1964042 1975155 1991629 1991055 1971152 1973178 1985436 1989859 1966902 1975113 1964728 1956685 1943875 1939826 1961949 1946313 1949809 1948871 1947530 1955279 1949413 1948123 1961954 1964271 1940717 1946019
sum_num_inserts_total=126057263
sum_num_deletes_by_thread=1974651 1983736 1957586 1941059 1965321 1971931 1970321 1958565 1970852 1977304 1966327 1958746 1980587 1980207 1968263 1965823 1954451 1955760 1942899 1948722 2049485 2081255 2064578 2058600 1937861 1946289 1930923 1930699 1950409 1962931 1956390 1954312 1992850 1999882 1964878 1981416 1988928 1984359 1961362 1973454 1990458 1993386 1969295 1973360 1985427 1991032 1966245 1974143 1961044 1954284 1942689 1939507 1956932 1947517 1949027 1947206 1945724 1959486 1950447 1947337 1960480 1963447 1943203 1946317
sum_num_deletes_total=126021965
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3949283 3964884 3914819 3881356 3933912 3944485 3939735 3917384 3942758 3954093 3933215 3918422 3963491 3962518 3941015 3935780 3909583 3910710 3885765 3895689 4100108 4160573 4128511 4116125 3878111 3891839 3862244 3864440 3900160 3925455 3914044 3909496 3983684 4002647 3930880 3961477 3981391 3967454 3925404 3948609 3982087 3984441 3940447 3946538 3970863 3980891 3933147 3949256 3925772 3910969 3886564 3879333 3918881 3893830 3898836 3896077 3893254 3914765 3899860 3895460 3922434 3927718 3883920 3892336
average_num_operations_total=3938737
stdev_num_operations_total=7404
sum_num_operations_total=252079228
min_num_operations_total=3862244
max_num_operations_total=4160573
first_time_thread_terminate_by_thread=10000095 10000154 10000095 10000229 10000094 10000238 10000094 10000094 10000163 10000094 10000094 10000094 10000101 10000224 10000247 10000170 10000106 10000106 10000251 10000109 10000094 10000094 10000094 10000094 10000109 10000183 10000115 10000125 10000150 10000117 10000117 10000213 10000103 10000126 10000113 10000094 10000105 10000105 10000203 10000116 10000223 10000111 10000106 10000116 10000107 10000239 10000107 10000115 10000095 10000117 10000111 10000106 10000095 10000265 10000095 10000095 10000235 10000094 10000251 10000094 10000095 10000095 10000095 10000095
min_time_thread_terminate_total=10000094
max_time_thread_terminate_total=10000265
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 5 5 5 5 6 6 6 6 4 4 4 5 6 6 7 6 5 5 5 5 6 6 6 6 3 3 4 3 3 3 3 3 6 6 6 6 4 4 4 4 4 4 4 4 5 5 5 5 4 4 4 4 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=9997818882
threads_final_size=100018
final_keysum=9997818882
final_size=100018
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=126057263
total_deletes=126021965
total_updates=252079228
total_queries=0
total_ops=252079228
find_throughput=0
rq_throughput=0
update_throughput=25207922
query_throughput=0
total_throughput=25207922
total find : 0
total rq : 0
total inserts : 126057263
total deletes : 126021965
total updates : 252079228
total queries : 0
total ops : 252079228
find throughput : 0
rq throughput : 0
update throughput : 25207922
query throughput : 0
total throughput : 25207922
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=0
total_execution_walltime=11.437s
REALTIME_MAIN_END_PERF_FORMAT=218602.447012038
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=90221, mem_maxresident_kb=358676, user_cputime=727.56, sys_cputime=6.73, percent_cpu=6360%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1