__step=000194
__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 0.5 0.5 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000194.txt
__path_data=data/data000194.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=209176.973451417
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,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=999975 prefilling_elapsed_millis=1s
finished prefilling to size 999977 for expected size 1000000 keysum=1000425747766, performing 18650896 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999977
pref_millis=1101
prefill_elapsed_ms=1110
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=802
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=209178.123077917
REALTIME_END_PERF_FORMAT=209188.123142477
###############################################################################
################################## 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.06s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8190 16344 32253 60994 104950 155156 187206 179359 132470 73529 29863 8707 1821 272 21 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 2 36 435 3512 17038 54744 123106 195053 226248 191411 117195 51019 15593 3370 523 40 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16380 32688 64506 121988 209900 310312 374412 358718 264940 147058 59726 17414 3642 544 42 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 2 36 435 3512 17038 54744 123106 195053 226248 191411 117195 51019 15593 3370 523 40 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 1.99976 1.9978 1.98669 1.94556 1.86033 1.73919 1.60328 1.47904 1.36929 1.27753 1.20307 1.14578 1.10457 1.07468 1.0386 1.04762 1
tree_stats_height=30
tree_stats_numInternals=999328
tree_stats_numLeaves=999329
tree_stats_numNodes=1998657
tree_stats_numKeys=999329
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.9674
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917280 1830528 3612336 6831328 11754400 17377472 20967072 20088208 14836640 8235248 3344656 975184 203952 30464 2352 224
tree_stats_sizeInBytes=111924792
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=12618
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:78452 2:165317 4:233398 8:107734 16:6544 32:159 64:30
[2^00, 2^01]: 78452
(2^01, 2^02]: 165317
(2^02, 2^03]: 233398
(2^03, 2^04]: 107734
(2^04, 2^05]: 6544
(2^05, 2^06]: 159
(2^06, 2^07]: 30
sum_limbo_reclamation_event_size_total=2931521
count_limbo_reclamation_event_size_by_thread=9312 9255 9230 9274 9246 9285 9320 9316 9271 9265 9319 9289 9274 9253 9227 9239 9250 9161 9197 9157 9237 9242 9200 9182 9272 9283 9268 9192 9190 9178 9188 9207 9176 9238 9224 9288 9266 9275 9279 9264 9280 9259 9219 9233 9242 9199 9194 9177 9286 9245 9245 9254 9237 9262 9231 9262 9227 9224 9267 9283 9175 9261 9334 9249
count_limbo_reclamation_event_size_total=591634
sum_limbo_reclamation_event_count_total=1512448
first_thread_announced_epoch_by_thread=25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236 25236
sum_num_inserts_by_thread=36766 36579 35955 35914 36086 36727 36204 36451 36564 36791 36203 36120 36727 36072 36059 36087 35204 35396 34987 34831 36114 35420 35410 35626 36026 36345 35678 35505 35329 35218 35018 35165 35069 34935 35776 35524 35660 35758 35614 35380 35700 36070 35387 35138 35452 35342 35345 34843 36169 35835 35577 36030 36183 36061 35609 35659 35425 35374 35368 35010 35682 35383 36556 36509
sum_num_inserts_total=2288000
sum_num_deletes_by_thread=36647 36424 36256 36296 36466 36501 36370 36551 37064 36514 36351 36672 36591 36180 35905 35981 35074 35018 34949 35044 35944 35649 35771 35248 35789 36040 35768 35432 35201 35050 35559 35107 35246 35100 35973 35987 35807 36198 35603 35722 35773 35715 35262 35100 35130 35348 35312 35150 35916 35682 35954 35710 35817 35845 35773 35451 35617 35394 35139 35105 35306 35724 36195 36323
sum_num_deletes_total=2288789
sum_num_searches_by_thread=7237655 7215586 7170972 7119819 7148208 7221718 7193011 7186635 7276746 7259810 7237214 7231111 7202722 7163116 7116872 7103137 6961978 6957395 6930992 6929359 7114482 7090761 7055204 7061979 7113907 7111293 7091176 7046906 7029340 7001728 6979588 6966053 6946444 6928055 7098411 7086069 7092049 7093714 7057583 7064358 7116110 7065342 7001261 6978109 7001397 6979093 6956284 6950800 7159936 7135857 7098881 7103361 7110917 7111189 7071314 7033912 7010143 6990844 6977833 6985421 7020871 7033530 7194221 7184509
sum_num_searches_total=453164291
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7311068 7288589 7243183 7192029 7220760 7294946 7265585 7259637 7350374 7333115 7309768 7303903 7276040 7235368 7188836 7175205 7032256 7027809 7000928 6999234 7186540 7161830 7126385 7132853 7185722 7183678 7162622 7117843 7099870 7071996 7050165 7036325 7016759 6998090 7170160 7157580 7163516 7165670 7128800 7135460 7187583 7137127 7071910 7048347 7071979 7049783 7026941 7020793 7232021 7207374 7170412 7175101 7182917 7183095 7142696 7105022 7081185 7061612 7048340 7055536 7091859 7104637 7266972 7257341
average_num_operations_total=7152204
stdev_num_operations_total=11795
sum_num_operations_total=457741080
min_num_operations_total=6998090
max_num_operations_total=7350374
first_time_thread_terminate_by_thread=10000067 10000067 10000067 10000067 10000067 10000068 10000068 10000067 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000065 10000065 10000065 10000065 10000066 10000066 10000066 10000066 10000065 10000065 10000065 10000065 10000066 10000066 10000066 10000066 10000066 10000066 10000066 10000066 10000063 10000063 10000063 10000063 10000065 10000065 10000065 10000065 10000065 10000065 10000065 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000064 10000067 10000067 10000067 10000067 10000067 10000067 10000067 10000067
min_time_thread_terminate_total=10000063
max_time_thread_terminate_total=10000068
first_time_thread_start_by_thread=4 4 4 4 5 5 5 5 3 3 3 3 4 4 4 4 3 3 3 3 3 3 3 3 5 5 5 5 6 6 5 6 5 5 5 5 7 7 7 7 6 6 6 6 7 6 6 6 7 7 7 7 6 6 6 6 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=999540859641
threads_final_size=999329
final_keysum=999540859641
final_size=999329
validate_result=success
Validation OK.
Structural validation OK.
total_find=453164291
total_rq=0
total_inserts=2288000
total_deletes=2288789
total_updates=4576789
total_queries=453164291
total_ops=457741080
find_throughput=45316429
rq_throughput=0
update_throughput=457678
query_throughput=45316429
total_throughput=45774108
total find : 453164291
total rq : 0
total inserts : 2288000
total deletes : 2288789
total updates : 4576789
total queries : 453164291
total ops : 457741080
find throughput : 45316429
rq throughput : 0
update throughput : 457678
query throughput : 45316429
total throughput : 45774108
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=35864084476901
total_execution_walltime=11.297s
REALTIME_MAIN_END_PERF_FORMAT=209188.271230373
[time_cmd_output] time_elapsed_sec=11.41, faults_major=0, faults_minor=131218, mem_maxresident_kb=525560, user_cputime=726.13, sys_cputime=4.72, percent_cpu=6403%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2