__step=000641
__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=data000641.txt
__path_data=data/data000641.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=214526.207507282
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.022s
prefilling_size=99887 prefilling_elapsed_millis=1s
finished prefilling to size 99892 for expected size 100000 keysum=9993192083, performing 25938897 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99892
pref_millis=1101
prefill_elapsed_ms=1109
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=1238
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=214527.355037299
REALTIME_END_PERF_FORMAT=214537.355129990
###############################################################################
################################## 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.086s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4084 7962 14279 20839 22000 16025 7733 2500 564 87 7 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 12 206 1645 7719 19678 27975 24317 12966 4436 1041 167 13 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8168 15924 28558 41678 44000 32050 15466 5000 1128 174 14 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 12 206 1645 7719 19678 27975 24317 12966 4436 1041 167 13 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99707 1.97478 1.8967 1.72971 1.52786 1.3642 1.24128 1.16164 1.1128 1.07713 1.04023 1.07143 1
tree_stats_height=25
tree_stats_numInternals=100176
tree_stats_numLeaves=100177
tree_stats_numNodes=200353
tree_stats_numKeys=100177
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=17.2766
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 457408 891744 1599248 2333968 2464000 1794800 866096 280000 63168 9744 784 112
tree_stats_sizeInBytes=11219768
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=28649
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:16 2:29 4:117 8:11329 16:249014 32:324338 64:54372 128:29 256:116 512:102 1024:5
[2^00, 2^01]: 16
(2^01, 2^02]: 29
(2^02, 2^03]: 117
(2^03, 2^04]: 11329
(2^04, 2^05]: 249014
(2^05, 2^06]: 324338
(2^06, 2^07]: 54372
(2^07, 2^08]: 29
(2^08, 2^09]: 116
(2^09, 2^10]: 102
(2^10, 2^11]: 5
sum_limbo_reclamation_event_size_total=25417322
count_limbo_reclamation_event_size_by_thread=9990 9990 9992 9996 9992 9992 9991 9992 9992 9988 9992 9992 9992 9992 9992 9992 9994 9992 9990 9992 9992 9990 9992 9992 9992 9992 9992 9992 9992 9992 9991 9992 9990 9992 9992 9990 9992 9992 9992 9992 9992 9992 9992 9992 9990 9992 9992 9992 9992 9992 9992 9992 9992 9990 9992 9992 9992 9990 9990 9991 9992 9992 9992 9992
count_limbo_reclamation_event_size_total=639467
sum_limbo_reclamation_event_count_total=3506646
first_thread_announced_epoch_by_thread=57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298 57298
sum_num_inserts_by_thread=737686 739777 731653 728670 724992 705331 719540 716664 715024 707880 713243 722497 717671 716074 703184 711824 719105 708269 776474 768170 685892 681756 679953 678524 759339 752491 748644 748019 745973 743245 740859 727694 665951 667041 667461 662766 665000 655465 656375 705876 694630 706681 705001 705752 693571 689986 682091 670887 729268 727539 731171 659135 751470 712042 797719 785785 728691 735192 729972 737600 860964 756020 754543 859024
sum_num_inserts_total=46126786
sum_num_deletes_by_thread=737007 740398 733593 730378 726473 707338 719603 716562 714505 707525 712376 721968 716481 716173 701313 712565 719728 707400 775588 766240 685764 682683 680022 677337 760921 752515 749504 749199 743900 743938 740193 726521 664829 669433 668010 663053 663832 657404 654982 705056 694995 706717 705312 703496 694646 691588 683287 671549 730074 728671 731475 657492 751169 712169 796250 786168 728517 735479 730162 735504 861520 757292 753013 858441
sum_num_deletes_total=46127296
sum_num_searches_by_thread=13269560 13316727 13188626 13128454 13065275 12703946 12963162 12890479 12855537 12751823 12812321 12986188 12899969 12867361 12639761 12807647 12949678 12747004 13963566 13813482 12342461 12276493 12256773 12200798 13691036 13561664 13493633 13473192 13411345 13385942 13337176 13078596 11981630 12020149 12007803 11957913 11958730 11823681 11795944 12701318 12507904 12716226 12683831 12662060 12486598 12444905 12275172 12083407 13135349 13101777 13156120 11854624 13531067 12803711 14348527 14167894 13112341 13232827 13171092 13253403 15496919 13606833 13583644 15435977
sum_num_searches_total=830229051
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=14744253 14796902 14653872 14587502 14516740 14116615 14402305 14323705 14285066 14167228 14237940 14430653 14334121 14299608 14044258 14232036 14388511 14162673 15515628 15347892 13714117 13640932 13616748 13556659 15211296 15066670 14991781 14970410 14901218 14873125 14818228 14532811 13312410 13356623 13343274 13283732 13287562 13136550 13107301 14112250 13897529 14129624 14094144 14071308 13874815 13826479 13640550 13425843 14594691 14557987 14618766 13171251 15033706 14227922 15942496 15739847 14569549 14703498 14631226 14726507 17219403 15120145 15091200 17153442
average_num_operations_total=14413798
stdev_num_operations_total=103670
sum_num_operations_total=922483133
min_num_operations_total=13107301
max_num_operations_total=17219403
first_time_thread_terminate_by_thread=10000093 10000093 10000093 10000093 10000092 10000092 10000092 10000092 10000094 10000094 10000094 10000094 10000092 10000092 10000092 10000092 10000093 10000093 10000093 10000093 10000093 10000093 10000093 10000093 10000093 10000094 10000093 10000093 10000094 10000094 10000094 10000094 10000091 10000091 10000091 10000091 10000090 10000090 10000090 10000093 10000093 10000093 10000093 10000093 10000091 10000091 10000091 10000091 10000092 10000092 10000092 10000092 10000093 10000092 10000092 10000092 10000091 10000091 10000091 10000091 10000094 10000094 10000094 10000094
min_time_thread_terminate_total=10000090
max_time_thread_terminate_total=10000094
first_time_thread_start_by_thread=5 5 5 5 4 4 4 4 4 4 4 4 3 3 3 3 5 5 5 5 6 6 6 6 6 6 6 6 5 5 5 5 3 3 3 3 6 6 6 6 5 5 5 5 3 3 3 3 6 6 6 6 4 4 4 4 3 3 3 3 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=6
sum_duration_all_ops_total=
threads_final_keysum=10022489366
threads_final_size=100177
final_keysum=10022489366
final_size=100177
validate_result=success
Validation OK.
Structural validation OK.
total_find=830229051
total_rq=0
total_inserts=46126786
total_deletes=46127296
total_updates=92254082
total_queries=830229051
total_ops=922483133
find_throughput=83022905
rq_throughput=0
update_throughput=9225408
query_throughput=83022905
total_throughput=92248313
total find : 830229051
total rq : 0
total inserts : 46126786
total deletes : 46127296
total updates : 92254082
total queries : 830229051
total ops : 922483133
find throughput : 83022905
rq throughput : 0
update throughput : 9225408
query throughput : 83022905
total throughput : 92248313
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=40187024728973
total_execution_walltime=11.332s
REALTIME_MAIN_END_PERF_FORMAT=214537.540275112
[time_cmd_output] time_elapsed_sec=11.43, faults_major=0, faults_minor=84250, mem_maxresident_kb=333492, user_cputime=732.44, sys_cputime=5.07, percent_cpu=6449%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1