__step=000620
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000620.txt
__path_data=data/data000620.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986328.750561301
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.061s
prefilling_size=100199 prefilling_elapsed_millis=1s
finished prefilling to size 100208 for expected size 100000 keysum=10030153206, performing 70150185 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100208
pref_millis=1102
prefill_elapsed_ms=1120
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=879

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6986330.108237111
REALTIME_END_PERF_FORMAT=6986340.108368477

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

tree_stats_computeWalltime=0.034s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 126 236 443 766 1278 2026 2977 4043 5049 5741 6329 6448 6297 5760 5062 4261 3165 2276 1474 817 418 188 78 45 19 13 11 8 7 1 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 10 13 72 138 295 608 1061 1637 2396 2728 3252 3461 3595 3432 3041 2815 2065 1624 1102 618 327 149 57 34 13 11 8 4 8 0 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 246 456 838 1416 2321 3585 5104 6686 8137 9057 9700 9758 9355 8494 7302 5980 4341 3098 1919 1036 515 227 102 53 26 22 16 11 9 1 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 246 456 838 1416 2321 3585 5104 6686 8137 9057 9700 9758 9355 8494 7302 5980 4341 3098 1919 1036 515 227 102 53 26 22 16 11 9 1 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.94488 1.89431 1.86623 1.77566 1.73658 1.67169 1.59331 1.51783 1.46186 1.40752 1.3722 1.34124 1.31338 1.29225 1.26372 1.23541 1.19666 1.18936 1.14364 1.11412 1.09363 1.07573 1.10573 1.07843 1.13208 1.34615 1.22727 1.1875 1.18182 1 1 1

tree_stats_height=39
tree_stats_numInternals=65490
tree_stats_numLeaves=34576
tree_stats_numNodes=100066
tree_stats_numKeys=100066

tree_stats_avgDegreeInternal=1.52796
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34553
tree_stats_avgKeyDepth=18.7244

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24384 47232 87552 160896 271872 445632 688320 979968 1283712 1562304 1738944 1862400 1873536 1796160 1630848 1401984 1148160 833472 594816 368448 198912 98880 43584 19584 10176 4992 4224 3072 2112 1728 192 192
tree_stats_sizeInBytes=19212672

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=19116


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:4 4:113 8:42728 16:879577 32:37385
    (2^01, 2^02]: 4
    (2^02, 2^03]: 113
    (2^03, 2^04]: 42728
    (2^04, 2^05]: 879577
    (2^05, 2^06]: 37385
sum_limbo_reclamation_event_size_total=22149007
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=959807
sum_limbo_reclamation_event_count_total=1750753
first_thread_announced_epoch_by_thread=38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232 38232
sum_num_inserts_by_thread=834030 843273 846793 846048 844736 836974 837707 839529 845011 848591 839829 835571 840004 839031 846805 846508 846192 843352 835081 839103 843555 846196 840214 836832 831448 843915 849468 844116 841761 834372 836636 845276 851632 849733 842893 836458 831454 840609 841480 846683 841042 838535 837126 834605 843916 846325 838067 837269 838026 842928 844793 843875 836944 839805 839607 846253 849187 856520 846088 841440 843135 844845 848503 847991 839512 833578 830979 833396 839382 839921 833473 834067 832245 837907 843587 842826 837749 836164 838765 846218 847650 849801 845524 837451 834953 844131 845244 845950 838102 833459 838701 837915 845573 847811 845465 841320
sum_num_inserts_total=80774543
sum_num_deletes_by_thread=834213 843805 847831 846725 843909 836987 838545 841783 845769 848474 840077 835916 838536 837757 847986 845110 845994 843976 835455 838884 844264 849233 841613 837306 830886 843604 847688 846204 843512 835171 836215 844736 853022 849957 842330 836728 833161 841288 845375 847679 841046 840073 837454 836067 844608 845009 838285 836746 838172 843196 847670 842086 838138 840870 838871 847230 848609 853531 847321 841661 842487 845541 846081 848366 838852 832939 830257 833123 841076 840024 832904 836847 831965 837737 840907 842572 835611 837713 838036 846250 847380 847740 843420 837554 836964 844690 846321 846233 836546 836379 839683 837131 845209 846980 843019 842507
sum_num_deletes_total=80791391
sum_num_searches_by_thread=15020003 15175731 15227741 15239826 15185536 15065459 15084794 15136962 15254047 15286578 15109660 15042956 15115086 15107462 15260433 15229593 15237868 15167416 15047631 15089291 15196856 15250010 15147716 15068677 14956235 15171860 15285539 15213125 15169510 15020749 15058830 15196093 15312311 15281262 15177321 15058164 15004960 15144525 15202107 15222587 15144888 15102134 15059802 15048897 15196357 15224832 15089952 15064198 15082918 15168614 15244987 15157650 15068533 15110868 15103095 15241877 15298998 15371600 15235131 15134083 15182688 15210674 15256809 15255303 15117754 14994539 14974068 15005960 15121454 15121832 15004553 15034698 14978012 15084987 15176897 15163960 15062717 15038312 15098397 15191692 15249488 15303390 15193868 15059061 15042182 15199151 15224905 15218291 15071962 15016850 15100142 15088043 15227450 15230583 15196266 15133200
sum_num_searches_total=1454002062
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=16688246 16862809 16922365 16932599 16874181 16739420 16761046 16818274 16944827 16983643 16789566 16714443 16793626 16784250 16955224 16921211 16930054 16854744 16718167 16767278 16884675 16945439 16829543 16742815 16618569 16859379 16982695 16903445 16854783 16690292 16731681 16886105 17016965 16980952 16862544 16731350 16669575 16826422 16888962 16916949 16826976 16780742 16734382 16719569 16884881 16916166 16766304 16738213 16759116 16854738 16937450 16843611 16743615 16791543 16781573 16935360 16996794 17081651 16928540 16817184 16868310 16901060 16951393 16951660 16796118 16661056 16635304 16672479 16801912 16801777 16670930 16705612 16642222 16760631 16861391 16849358 16736077 16712189 16775198 16884160 16944518 17000931 16882812 16734066 16714099 16887972 16916470 16910474 16746610 16686688 16778526 16763089 16918232 16925374 16884750 16817027
average_num_operations_total=16828833
stdev_num_operations_total=10345
sum_num_operations_total=1615567996
min_num_operations_total=16618569
max_num_operations_total=17081651
first_time_thread_terminate_by_thread=10000131 10000133 10000131 10000132 10000133 10000132 10000131 10000131 10000133 10000133 10000131 10000131 10000133 10000131 10000131 10000131 10000133 10000132 10000131 10000132 10000131 10000131 10000131 10000133 10000131 10000133 10000132 10000132 10000133 10000132 10000131 10000131 10000133 10000133 10000131 10000131 10000133 10000131 10000131 10000131 10000132 10000132 10000131 10000131 10000131 10000131 10000131 10000133 10000132 10000130 10000130 10000131 10000132 10000131 10000131 10000131 10000130 10000132 10000130 10000131 10000131 10000131 10000130 10000131 10000131 10000132 10000132 10000132 10000131 10000131 10000131 10000131 10000131 10000130 10000130 10000131 10000132 10000131 10000131 10000131 10000130 10000132 10000130 10000131 10000131 10000131 10000130 10000131 10000131 10000132 10000132 10000132 10000131 10000131 10000130 10000131
min_time_thread_terminate_total=10000130
max_time_thread_terminate_total=10000133
first_time_thread_start_by_thread=3 4 4 4 4 4 4 4 3 4 4 4 4 4 3 3 3 3 4 3 4 3 4 4 3 4 4 4 4 4 4 4 3 4 4 4 4 4 3 3 3 3 4 3 4 3 4 4 3 3 3 3 3 4 4 4 4 4 4 3 3 4 4 3 4 3 3 4 4 4 4 4 3 3 3 3 3 4 4 4 4 4 4 3 3 4 4 3 4 3 3 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10009680175
threads_final_size=100066
final_keysum=10009680175
final_size=100066
validate_result=success
Validation OK.
Structural validation OK.

total_find=1454002062
total_rq=0
total_inserts=80774543
total_deletes=80791391
total_updates=161565934
total_queries=1454002062
total_ops=1615567996
find_throughput=145400206
rq_throughput=0
update_throughput=16156593
query_throughput=145400206
total_throughput=161556799


total find                    : 1454002062
total rq                      : 0
total inserts                 : 80774543
total deletes                 : 80791391
total updates                 : 161565934
total queries                 : 1454002062
total ops                     : 1615567996
find throughput               : 145400206
rq throughput                 : 0
update throughput             : 16156593
query throughput              : 145400206
total throughput              : 161556799

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=4.91146
PAPI_L3_TCM=0.53897
PAPI_TOT_CYC=1652.47
PAPI_TOT_INS=330.777
garbage=72694482088374
total_execution_walltime=11.516s
REALTIME_MAIN_END_PERF_FORMAT=6986340.267560753
[time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=86167, mem_maxresident_kb=339328, user_cputime=1090.26, sys_cputime=2.74, percent_cpu=9393%
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=2