__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000642.txt
__path_data=data/data000642.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=214537.711723441
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=5
DEL_FRAC=5
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=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,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.024s
prefilling_size=99896 prefilling_elapsed_millis=1s
finished prefilling to size 99837 for expected size 100000 keysum=9980651137, performing 26563932 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99837
pref_millis=1101
prefill_elapsed_ms=1115
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=1272
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=214538.875603763
REALTIME_END_PERF_FORMAT=214548.875696474
###############################################################################
################################## 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 (256 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.081s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4084 7984 14228 20658 21909 15909 7710 2531 588 102 13 5 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 12 184 1740 7798 19407 27909 24108 12889 4474 1074 191 21 9 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8168 15968 28456 41316 43818 31818 15420 5062 1176 204 26 10 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 12 184 1740 7798 19407 27909 24108 12889 4474 1074 191 21 9 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99707 1.97747 1.89103 1.72596 1.53028 1.36307 1.24232 1.16414 1.11616 1.08673 1.06373 1.19231 1.1 1.5 1
tree_stats_height=27
tree_stats_numInternals=99818
tree_stats_numLeaves=99819
tree_stats_numNodes=199637
tree_stats_numKeys=99819
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=17.2781
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 457408 894208 1593536 2313696 2453808 1781808 863520 283472 65856 11424 1456 560 112 112
tree_stats_sizeInBytes=11179672
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=27544
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:28 2:28 4:69 8:7212 16:228953 32:326503 64:76129 128:12 256:186 512:179 1024:1
[2^00, 2^01]: 28
(2^01, 2^02]: 28
(2^02, 2^03]: 69
(2^03, 2^04]: 7212
(2^04, 2^05]: 228953
(2^05, 2^06]: 326503
(2^06, 2^07]: 76129
(2^07, 2^08]: 12
(2^08, 2^09]: 186
(2^09, 2^10]: 179
(2^10, 2^11]: 1
sum_limbo_reclamation_event_size_total=26773516
count_limbo_reclamation_event_size_by_thread=9990 9988 9992 9996 9990 9988 9990 9990 9986 9988 9990 9988 9988 9988 9990 9990 9990 9990 9990 9990 9990 9992 9988 9990 9990 9988 9990 9990 9984 9992 9990 9986 9990 9986 9990 9988 9990 9990 9988 9988 9988 9990 9989 9986 9987 9990 9992 9990 9988 9988 9992 9988 9987 9990 9986 9988 9988 9990 9989 9990 9990 9986 9988 9988
count_limbo_reclamation_event_size_total=639300
sum_limbo_reclamation_event_count_total=3360372
first_thread_announced_epoch_by_thread=55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088 55088
sum_num_inserts_by_thread=749710 752989 746380 741002 745215 730909 729641 723842 721271 716383 711299 695535 770353 718009 802786 797343 731264 731353 817930 819070 717670 711032 791339 786276 687761 686027 683947 721655 711589 723606 722552 719317 720077 719139 709712 699498 683047 680271 677938 674839 676928 721016 712048 709957 715489 714336 700157 709915 698062 689109 678843 673277 675070 679825 681913 684689 741856 738243 726272 743009 784704 787318 788903 794870
sum_num_inserts_total=46405385
sum_num_deletes_by_thread=750192 750953 745417 740904 744533 731568 729048 723139 720158 717132 708862 693879 767822 719223 802703 797428 730740 731646 818116 820673 717661 710939 791308 785989 683252 686884 683862 720639 710496 722855 721218 719036 719362 718434 708807 698653 683385 679857 678360 676244 677769 719347 712313 709817 715232 712954 699379 710614 700065 689074 679495 674621 674305 680068 678668 684095 743682 740779 726066 742024 784682 785946 786758 793773
sum_num_deletes_total=46382903
sum_num_searches_by_thread=13532201 13565193 13431705 13330260 13410002 13161448 13125744 13028873 12971661 12894833 12768952 12498260 13844331 12936057 14444578 14370052 13180736 13169464 14756880 14731161 12922299 12797026 14231495 14134726 12352352 12363558 12319475 12975702 12810943 13028754 12987762 12944363 12964588 12947479 12771839 12596426 12297831 12255479 12206354 12160834 12202405 12949509 12809394 12778439 12867710 12863107 12618094 12769087 12599393 12416922 12212214 12130778 12152431 12231267 12266894 12299947 13380027 13319580 13075577 13362510 14132051 14175986 14190795 14301755
sum_num_searches_total=835327548
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=15032103 15069135 14923502 14812166 14899750 14623925 14584433 14475854 14413090 14328348 14189113 13887674 15382506 14373289 16050067 15964823 14642740 14632463 16392926 16370904 14357630 14218997 15814142 15706991 13723365 13736469 13687284 14417996 14233028 14475215 14431532 14382716 14404027 14385052 14190358 13994577 13664263 13615607 13562652 13511917 13557102 14389872 14233755 14198213 14298431 14290397 14017630 14189616 13997520 13795105 13570552 13478676 13501806 13591160 13627475 13668731 14865565 14798602 14527915 14847543 15701437 15749250 15766456 15890398
average_num_operations_total=14501809
stdev_num_operations_total=96902
sum_num_operations_total=928115836
min_num_operations_total=13478676
max_num_operations_total=16392926
first_time_thread_terminate_by_thread=10000095 10000095 10000095 10000095 10000093 10000093 10000093 10000093 10000095 10000095 10000095 10000095 10000095 10000095 10000095 10000095 10000092 10000092 10000092 10000092 10000094 10000094 10000094 10000094 10000094 10000094 10000094 10000094 10000094 10000094 10000094 10000094 10000092 10000092 10000092 10000092 10000093 10000092 10000093 10000093 10000093 10000093 10000093 10000093 10000094 10000094 10000094 10000094 10000095 10000095 10000095 10000095 10000095 10000096 10000096 10000095 10000092 10000092 10000092 10000092 10000096 10000096 10000096 10000096
min_time_thread_terminate_total=10000092
max_time_thread_terminate_total=10000096
first_time_thread_start_by_thread=9 9 9 9 10 10 10 10 9 9 9 9 10 10 10 10 7 8 7 7 10 10 10 10 10 10 10 10 10 10 10 10 11 11 11 11 11 11 11 11 8 8 8 8 8 8 8 8 11 11 11 11 9 9 9 9 9 9 9 9 11 11 11 11
min_time_thread_start_total=7
max_time_thread_start_total=11
sum_duration_all_ops_total=
threads_final_keysum=9972294157
threads_final_size=99819
final_keysum=9972294157
final_size=99819
validate_result=success
Validation OK.
Structural validation OK.
total_find=835327548
total_rq=0
total_inserts=46405385
total_deletes=46382903
total_updates=92788288
total_queries=835327548
total_ops=928115836
find_throughput=83532754
rq_throughput=0
update_throughput=9278828
query_throughput=83532754
total_throughput=92811583
total find : 835327548
total rq : 0
total inserts : 46405385
total deletes : 46382903
total updates : 92788288
total queries : 835327548
total ops : 928115836
find throughput : 83532754
rq throughput : 0
update throughput : 9278828
query throughput : 83532754
total throughput : 92811583
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=41789006110610
total_execution_walltime=11.339s
REALTIME_MAIN_END_PERF_FORMAT=214549.51257002
[time_cmd_output] time_elapsed_sec=11.44, faults_major=0, faults_minor=84297, mem_maxresident_kb=333328, user_cputime=732.90, sys_cputime=4.56, percent_cpu=6443%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2