__step=000946
__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" ./natarajan_ext_bst_lf.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000946.txt
__path_data=data/data000946.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990342.877365744
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=natarajan_ext_bst_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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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=32
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=100261 prefilling_elapsed_millis=1.001s
finished prefilling to size 100288 for expected size 100000 keysum=10040979608, performing 67139684 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100288
pref_millis=1102
prefill_elapsed_ms=1125
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=3383
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6990344.166546415
REALTIME_END_PERF_FORMAT=6990354.166686104
###############################################################################
################################## 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 962 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.031s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 251 481 876 1525 2413 3716 5393 7189 8822 10138 10830 10570 9628 8145 6314 4631 3296 2274 1444 852 467 210 99 50 21 8 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 3 21 86 227 637 1110 2039 3597 5556 7506 9446 11090 11512 11111 9976 7997 5966 4318 3104 2036 1237 724 321 148 79 34 15 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 502 962 1752 3050 4826 7432 10786 14378 17644 20276 21660 21140 19256 16290 12628 9262 6592 4548 2888 1704 934 420 198 100 42 16 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 3 21 86 227 637 1110 2039 3597 5556 7506 9446 11090 11512 11111 9976 7997 5966 4318 3104 2036 1237 724 321 148 79 34 15 1 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.98819 1.95817 1.9106 1.87043 1.79115 1.77 1.72565 1.66651 1.61358 1.57459 1.53413 1.488 1.45544 1.42299 1.3876 1.36672 1.35586 1.34496 1.3175 1.29501 1.27406 1.22484 1.23571 1.25253 1.21 1.19048 1.0625 1.5 1
tree_stats_height=37
tree_stats_numInternals=99899
tree_stats_numLeaves=99900
tree_stats_numNodes=199799
tree_stats_numKeys=99900
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.3532
tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8128 16064 30784 56064 97600 154432 237824 345152 460096 564608 648832 693120 676480 616192 521280 404096 296384 210944 145536 92416 54528 29888 13440 6336 3200 1344 512 64 64
tree_stats_sizeInBytes=6393568
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=36469
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:12 4:4 8:3 16:5 32:18 64:491 128:470842 256:8498
(2^01, 2^02]: 12
(2^02, 2^03]: 4
(2^03, 2^04]: 3
(2^04, 2^05]: 5
(2^05, 2^06]: 18
(2^06, 2^07]: 491
(2^07, 2^08]: 470842
(2^08, 2^09]: 8498
sum_limbo_reclamation_event_size_total=99418060
count_limbo_reclamation_event_size_by_thread=9998 9997 9997 9996 9998 9997 9998 9997 9996 9998 9998 9997 9998 9998 9997 9997 9998 9997 9998 9998 9996 9997 9998 9997 9998 9997 9997 9997 9998 9997 9998 9997 9997 9998 9998 9996 9998 9998 9997 9996 9998 9998 9998 9998 9996 9998 9997 9997
count_limbo_reclamation_event_size_total=479873
sum_limbo_reclamation_event_count_total=1588125
first_thread_announced_epoch_by_thread=72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938 72938
sum_num_inserts_by_thread=6787622 6820995 6873518 6870049 6857598 6780566 6812831 6850065 6911301 6929408 6849061 6806099 6793196 6853000 6880379 6897509 6879959 6810685 6789177 6830699 6889853 6915286 6832543 6805132 6789428 6809969 6876383 6863747 6852216 6788471 6807086 6849696 6916504 6915925 6859447 6821205 6822512 6842501 6905015 6914361 6877507 6831190 6791296 6815090 6888378 6916914 6845276 6794111
sum_num_inserts_total=328720759
sum_num_deletes_by_thread=6792386 6822656 6880005 6869048 6855448 6784049 6809883 6855942 6909585 6925032 6851475 6805452 6792415 6846104 6885115 6896537 6878377 6810797 6788089 6832977 6885623 6918069 6832247 6803397 6791495 6812487 6873050 6863995 6850275 6787150 6806746 6848295 6916567 6913376 6860260 6828168 6822903 6843838 6898050 6917708 6882937 6828902 6788888 6811147 6891906 6919776 6843176 6795101
sum_num_deletes_total=328726904
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=13580008 13643651 13753523 13739097 13713046 13564615 13622714 13706007 13820886 13854440 13700536 13611551 13585611 13699104 13765494 13794046 13758336 13621482 13577266 13663676 13775476 13833355 13664790 13608529 13580923 13622456 13749433 13727742 13702491 13575621 13613832 13697991 13833071 13829301 13719707 13649373 13645415 13686339 13803065 13832069 13760444 13660092 13580184 13626237 13780284 13836690 13688452 13589212
average_num_operations_total=13696826
stdev_num_operations_total=12677
sum_num_operations_total=657447663
min_num_operations_total=13564615
max_num_operations_total=13854440
first_time_thread_terminate_by_thread=10000138 10000138 10000137 10000138 10000137 10000138 10000138 10000137 10000138 10000137 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000138 10000137 10000137 10000138 10000137 10000138 10000138 10000137 10000138 10000137 10000138 10000138 10000137 10000138 10000137 10000138 10000138 10000138 10000137 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000138 10000137
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=3 3 3 4 4 3 4 3 3 3 3 4 4 4 4 4 4 4 3 4 4 3 4 4 3 3 3 4 4 3 4 3 3 3 3 4 4 4 4 4 4 4 3 4 4 3 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=9988461450
threads_final_size=99900
final_keysum=9988461450
final_size=99900
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=328720759
total_deletes=328726904
total_updates=657447663
total_queries=0
total_ops=657447663
find_throughput=0
rq_throughput=0
update_throughput=65744766
query_throughput=0
total_throughput=65744766
total find : 0
total rq : 0
total inserts : 328720759
total deletes : 328726904
total updates : 657447663
total queries : 0
total ops : 657447663
find throughput : 0
rq throughput : 0
update throughput : 65744766
query throughput : 0
total throughput : 65744766
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=10.0068
PAPI_L3_TCM=0.000310254
PAPI_TOT_CYC=2026.6
PAPI_TOT_INS=838.954
garbage=0
total_execution_walltime=11.423s
REALTIME_MAIN_END_PERF_FORMAT=6990354.307469900
[time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=76870, mem_maxresident_kb=309384, user_cputime=562.53, sys_cputime=3.93, percent_cpu=4905%
timeout=false
algorithm=natarajan_ext_bst_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