__step=000169
__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" ./drachsler_pext_bst_lock.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000169.txt
__path_data=data/data000169.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980854.176942669
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=drachsler_pext_bst_lock
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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=192
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=999575 prefilling_elapsed_millis=1s
finished prefilling to size 999613 for expected size 1000000 keysum=999912227780, performing 35659748 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999613
pref_millis=1101
prefill_elapsed_ms=1131
6node_tIxPvE_object_size=192
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=1642

main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6980855.457807095
REALTIME_END_PERF_FORMAT=6980865.457960757

###############################################################################
################################## 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 937 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.042s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 251 478 904 1636 2847 4743 7644 11786 17467 24267 32177 40327 47418 53319 56929 57352 55528 51593 45826 38975 31363 23885 17142 11816 7668 4736 2807 1559 876 461 238 116 47 11 6 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 3 16 33 107 247 507 1019 1963 3356 5851 8824 12822 17915 22007 26541 29913 31266 31324 30247 27569 24210 20241 15954 11563 8272 5451 3439 2102 1149 692 352 182 95 48 7 6 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 494 937 1743 3094 5250 8663 13749 20823 30118 41001 53149 65333 75326 83470 87265 86794 82917 76073 66544 55573 44126 33096 23379 15940 10187 6246 3661 2025 1153 590 298 142 59 13 7 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 254 494 937 1743 3094 5250 8663 13749 20823 30118 41001 53149 65333 75326 83470 87265 86794 82917 76073 66544 55573 44126 33096 23379 15940 10187 6246 3661 2025 1153 590 298 142 59 13 7 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.98438 1.95669 1.92915 1.89541 1.83649 1.77666 1.74667 1.70472 1.65728 1.60755 1.55561 1.5115 1.47049 1.42717 1.40027 1.36344 1.33739 1.31556 1.29523 1.27234 1.24943 1.22966 1.20874 1.18845 1.1764 1.15803 1.14823 1.13673 1.12729 1.13679 1.11188 1.10169 1.08725 1.08451 1.0339 1.07692 1 1

tree_stats_height=45
tree_stats_numInternals=654454
tree_stats_numLeaves=345294
tree_stats_numNodes=999748
tree_stats_numKeys=999748

tree_stats_avgDegreeInternal=1.52761
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34538
tree_stats_avgKeyDepth=23.6296

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24576 48768 94848 179904 334656 594048 1008000 1663296 2639808 3998016 5782656 7872192 10204608 12543936 14462592 16026240 16754880 16664448 15920064 14606016 12776448 10670016 8472192 6354432 4488768 3060480 1955904 1199232 702912 388800 221376 113280 57216 27264 11328 2496 1344 192
tree_stats_sizeInBytes=191951616

6node_tIxPvE_object_size=192
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=23289


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175798 2:137185 4:13809 8:60 16:2
    [2^00, 2^01]: 175798
    (2^01, 2^02]: 137185
    (2^02, 2^03]: 13809
    (2^03, 2^04]: 60
    (2^04, 2^05]: 2
sum_limbo_reclamation_event_size_total=547343
count_limbo_reclamation_event_size_by_thread=6849 6719 6706 6840 6712 6789 6833 6846 6879 6827 6872 6844 6799 6783 6885 6923 6846 6771 6682 6760 6812 6816 6796 6779 6716 6857 6744 6858 6797 6735 6913 6740 6884 6875 6819 6733 6873 6832 6875 6799 6814 6785 6798 6765 6799 6885 6797 6793
count_limbo_reclamation_event_size_total=326854
sum_limbo_reclamation_event_count_total=1039056
first_thread_announced_epoch_by_thread=46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578 46578
sum_num_inserts_by_thread=48798 48878 49920 49899 49294 48783 48931 48883 50411 49747 48971 48627 48777 49186 49688 49601 49432 49073 48797 48766 49610 49523 49404 48918 48885 49095 49337 49689 49445 49027 49353 49572 50586 49724 49448 48888 49685 49614 50248 49394 49248 49306 48513 48708 49157 49896 49088 48245
sum_num_inserts_total=2366068
sum_num_deletes_by_thread=48905 48394 49264 49692 49188 49020 49234 49349 50298 49716 49652 49066 49312 49073 49860 50039 49235 48976 48667 48670 49596 49298 49562 49186 48345 48868 49262 49955 49714 49014 49563 49132 50380 50057 49262 48615 49427 49391 50261 49436 49345 49004 48832 48765 49240 50011 48608 48453
sum_num_deletes_total=2366192
sum_num_searches_by_thread=9679438 9656559 9848826 9848464 9810959 9680642 9750026 9720952 9938365 9851876 9799486 9663159 9665866 9727210 9913179 9822277 9790860 9696664 9617306 9683818 9868951 9808554 9801835 9710150 9605007 9672522 9776610 9886429 9828206 9704461 9762250 9805393 9945219 9852915 9731642 9667413 9760760 9813649 9915532 9827980 9769216 9698634 9603360 9675033 9761873 9899126 9692886 9601090
sum_num_searches_total=468612628
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9777141 9753831 9948010 9948055 9909441 9778445 9848191 9819184 10039074 9951339 9898109 9760852 9763955 9825469 10012727 9921917 9889527 9794713 9714770 9781254 9968157 9907375 9900801 9808254 9702237 9770485 9875209 9986073 9927365 9802502 9861166 9904097 10046185 9952696 9830352 9764916 9859872 9912654 10016041 9926810 9867809 9796944 9700705 9772506 9860270 9999033 9790582 9697788
average_num_operations_total=9861351
stdev_num_operations_total=13715
sum_num_operations_total=473344888
min_num_operations_total=9697788
max_num_operations_total=10046185
first_time_thread_terminate_by_thread=10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154 10000154
min_time_thread_terminate_total=10000154
max_time_thread_terminate_total=10000154
first_time_thread_start_by_thread=3 3 3 4 4 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 4 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=999554688059
threads_final_size=999748
final_keysum=999554688059
final_size=999748
validate_result=success
Validation OK.
Structural validation OK.

total_find=468612628
total_rq=0
total_inserts=2366068
total_deletes=2366192
total_updates=4732260
total_queries=468612628
total_ops=473344888
find_throughput=46861262
rq_throughput=0
update_throughput=473226
query_throughput=46861262
total_throughput=47334488


total find                    : 468612628
total rq                      : 0
total inserts                 : 2366068
total deletes                 : 2366192
total updates                 : 4732260
total queries                 : 468612628
total ops                     : 473344888
find throughput               : 46861262
rq throughput                 : 0
update throughput             : 473226
query throughput              : 46861262
total throughput              : 47334488

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=12.2851
PAPI_L3_TCM=1.68524
PAPI_TOT_CYC=2827.52
PAPI_TOT_INS=358.275
garbage=234398760654326
total_execution_walltime=11.415s
REALTIME_MAIN_END_PERF_FORMAT=6980865.596332218
[time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=123883, mem_maxresident_kb=497384, user_cputime=560.48, sys_cputime=2.13, percent_cpu=4867%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1