__step=000372
__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" ./ellen_ext_bst_lf.debra -nwork 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000372.txt
__path_data=data/data000372.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=211295.591388076
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=ellen_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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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=40 descriptor=64
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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.038s
prefilling_size=7625132 prefilling_elapsed_millis=1s
prefilling_size=7911837 prefilling_elapsed_millis=1.101s
prefilling_size=8160862 prefilling_elapsed_millis=1.201s
prefilling_size=8374163 prefilling_elapsed_millis=1.301s
prefilling_size=8565286 prefilling_elapsed_millis=1.401s
prefilling_size=8735360 prefilling_elapsed_millis=1.501s
prefilling_size=8881652 prefilling_elapsed_millis=1.601s
prefilling_size=9012728 prefilling_elapsed_millis=1.701s
prefilling_size=9128340 prefilling_elapsed_millis=1.801s
prefilling_size=9229838 prefilling_elapsed_millis=1.902s
prefilling_size=9320271 prefilling_elapsed_millis=2.002s
prefilling_size=9397556 prefilling_elapsed_millis=2.102s
prefilling_size=9468624 prefilling_elapsed_millis=2.202s
prefilling_size=9528188 prefilling_elapsed_millis=2.302s
prefilling_size=9580413 prefilling_elapsed_millis=2.402s
prefilling_size=9630757 prefilling_elapsed_millis=2.502s
prefilling_size=9671857 prefilling_elapsed_millis=2.602s
prefilling_size=9710289 prefilling_elapsed_millis=2.702s
prefilling_size=9744573 prefilling_elapsed_millis=2.803s
prefilling_size=9773837 prefilling_elapsed_millis=2.903s
prefilling_size=9801755 prefilling_elapsed_millis=3.003s
finished prefilling to size 9801753 for expected size 10000000 keysum=98027671974865, performing 78896436 updates; total_prefilling_elapsed_ms=3105 ms)
pref_size=9801753
pref_millis=3105
prefill_elapsed_ms=3118
6node_tIxPvE_object_size=40
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=621

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=211298.789538466
REALTIME_END_PERF_FORMAT=211308.789585946

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

tree_stats_computeWalltime=0.422s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 255 506 979 1874 3511 6380 11243 19275 32060 51210 78875 116376 164817 224934 294674 371572 451220 527304 595806 650283 686757 703204 698196 673616 630244 571258 503234 431722 360200 291840 231115 176868 130076 93062 64965 43598 28319 18074 11233 6701 3778 2154 1049 516 267 106 32 10 5 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 1 4 33 84 237 642 1517 3211 6490 12910 23545 41374 67935 104700 155194 217776 291924 375136 458802 541329 613809 670310 708212 722776 716988 689230 639282 574746 503244 428560 352565 285362 223660 167090 121159 86332 58877 38564 24915 15765 9624 5402 3259 1582 765 428 180 54 15 9 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 510 1012 1958 3748 7022 12760 22486 38550 64120 102420 157750 232752 329634 449868 589348 743144 902440 1054608 1191612 1300566 1373514 1406408 1396392 1347232 1260488 1142516 1006468 863444 720400 583680 462230 353736 260152 186124 129930 87196 56638 36148 22466 13402 7556 4308 2098 1032 534 212 64 20 10 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 1 4 33 84 237 642 1517 3211 6490 12910 23545 41374 67935 104700 155194 217776 291924 375136 458802 541329 613809 670310 708212 722776 716988 689230 639282 574746 503244 428560 352565 285362 223660 167090 121159 86332 58877 38564 24915 15765 9624 5402 3259 1582 765 428 180 54 15 9 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.99609 1.99216 1.96739 1.9571 1.93677 1.90857 1.88111 1.8572 1.83165 1.79866 1.77011 1.73772 1.70812 1.68237 1.65502 1.63048 1.60718 1.58431 1.56495 1.54572 1.52804 1.51197 1.49644 1.4824 1.46781 1.4532 1.44046 1.42895 1.41717 1.40511 1.39596 1.38264 1.36772 1.35772 1.34904 1.33555 1.32477 1.31911 1.31075 1.29827 1.2819 1.28507 1.2435 1.24595 1.25872 1.1985 1.15094 1.15625 1.25 1.1 1

tree_stats_height=61
tree_stats_numInternals=9965611
tree_stats_numLeaves=9965612
tree_stats_numNodes=19931223
tree_stats_numKeys=9965610

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=33.5787

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20400 40480 78320 149920 280880 510400 899440 1542000 2564800 4096800 6310000 9310080 13185360 17994720 23573920 29725760 36097600 42184320 47664480 52022640 54940560 56256320 55855680 53889280 50419520 45700640 40258720 34537760 28816000 23347200 18489200 14149440 10406080 7444960 5197200 3487840 2265520 1445920 898640 536080 302240 172320 83920 41280 21360 8480 2560 800 400 80
tree_stats_sizeInBytes=797248920

6node_tIxPvE_object_size=40
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=2932

6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:0 8:0 16:4 32:172791 64:415957 128:2350 256:2
    (2^04, 2^05]: 4
    (2^05, 2^06]: 172791
    (2^06, 2^07]: 415957
    (2^07, 2^08]: 2350
    (2^08, 2^09]: 2
sum_limbo_reclamation_event_size_total=45933910
count_limbo_reclamation_event_size_by_thread=4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618 4618
count_limbo_reclamation_event_size_total=591104
sum_limbo_reclamation_event_count_total=591616
first_thread_announced_epoch_by_thread=5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864 5864
sum_num_inserts_by_thread=144937 145151 144582 143789 145306 144100 144103 145163 145391 145080 144736 144540 144671 144929 144178 143411 143061 143798 142951 143954 144516 145401 144129 144274 144672 145178 144607 144090 144494 144233 143316 143339 144286 144222 143867 143812 145371 144408 144839 144389 144896 144139 143340 144842 144778 144394 143900 144111 143144 142942 143651 144048 144033 143559 143674 143609 143836 143117 143286 142864 143671 142538 142550 142963 144600 144545 143835 143570 144726 144131 143953 143218 143960 143914 143756 142656 143878 143754 144079 143887 144362 144499 143702 143830 144713 144253 143292 142437 142922 143167 142793 142945 144394 144320 144042 144497 145214 144720 143813 142741 144193 144317 143657 143842 143389 144099 143664 144484 144895 144315 144069 144277 143806 144255 143397 143171 143221 142347 142569 142504 142872 144296 143661 143969 143477 144732 143543 144065
sum_num_inserts_total=18427363
sum_num_deletes_by_thread=145189 145146 144087 143865 144751 144558 144915 144091 144737 145147 144593 144675 145548 144985 143574 144606 144218 144497 142806 144004 143960 144661 144627 144514 144812 144448 144061 143985 144236 144277 143434 143171 145154 144118 143888 144083 145955 144295 144598 144559 144966 145378 143880 143256 144570 143669 143540 143370 143465 143321 143504 144269 144186 143871 143896 143362 143770 144185 143008 142478 143649 142903 142994 142989 144733 143970 143890 144508 144585 144989 144350 144007 143259 143637 143753 143508 143692 143095 144416 143965 143619 144136 144183 143938 145328 143877 142921 143561 143418 142668 142987 143428 144819 144531 143871 143753 144551 144563 144359 143943 144399 143717 143301 143253 143120 143732 143653 144108 144455 145261 144445 143940 144525 143563 142724 142974 143188 143530 142045 142662 142701 143865 144132 143374 144049 144760 143797 143252
sum_num_deletes_total=18430643
sum_num_searches_by_thread=2612943 2612537 2604308 2585886 2606346 2604421 2596627 2604977 2613157 2606708 2601513 2601487 2609119 2608717 2591563 2590244 2588657 2588996 2581966 2581542 2591808 2608169 2598109 2599264 2603435 2600569 2593807 2597885 2597108 2591525 2580665 2579217 2596421 2591042 2588455 2605736 2613408 2610228 2601829 2604110 2605778 2609255 2599675 2593336 2598297 2599434 2588662 2586502 2581772 2579067 2592255 2588888 2597535 2594954 2587712 2589457 2594644 2584893 2572227 2571073 2580600 2578602 2570681 2570162 2605087 2599418 2595800 2596846 2603844 2598998 2592640 2585637 2590446 2584298 2578604 2579456 2587907 2585733 2596565 2593271 2594303 2599821 2588764 2588529 2601029 2588618 2579402 2577320 2581598 2579859 2569995 2569554 2601960 2599934 2592719 2592025 2608651 2602134 2598996 2586869 2596051 2591036 2587943 2582811 2589250 2589107 2580942 2600265 2605925 2607503 2596520 2596366 2594455 2588717 2575330 2572143 2583445 2574336 2568785 2568705 2574253 2594609 2589962 2585875 2598961 2600152 2593991 2587602
sum_num_searches_total=331811635
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2903069 2902834 2892977 2873540 2896403 2893079 2885645 2894231 2903285 2896935 2890842 2890702 2899338 2898631 2879315 2878261 2875936 2877291 2867723 2869500 2880284 2898231 2886865 2888052 2892919 2890195 2882475 2885960 2885838 2880035 2867415 2865727 2885861 2879382 2876210 2893631 2904734 2898931 2891266 2893058 2895640 2898772 2886895 2881434 2887645 2887497 2876102 2873983 2868381 2865330 2879410 2877205 2885754 2882384 2875282 2876428 2882250 2872195 2858521 2856415 2867920 2864043 2856225 2856114 2894420 2887933 2883525 2884924 2893155 2888118 2880943 2872862 2877665 2871849 2866113 2865620 2875477 2872582 2885060 2881123 2882284 2888456 2876649 2876297 2891070 2876748 2865615 2863318 2867938 2865694 2855775 2855927 2891173 2888785 2880632 2880275 2898416 2891417 2887168 2873553 2884643 2879070 2874901 2869906 2875759 2876938 2868259 2888857 2895275 2897079 2885034 2884583 2882786 2876535 2861451 2858288 2869854 2860213 2853399 2853871 2859826 2882770 2877755 2873218 2886487 2889644 2881331 2874919
average_num_operations_total=2880231
stdev_num_operations_total=1085
sum_num_operations_total=368669641
min_num_operations_total=2853399
max_num_operations_total=2904734
first_time_thread_terminate_by_thread=10000051 10000051 10000051 10000051 10000049 10000051 10000049 10000049 10000052 10000052 10000052 10000052 10000052 10000052 10000052 10000052 10000050 10000050 10000050 10000050 10000050 10000051 10000050 10000050 10000052 10000052 10000052 10000052 10000053 10000053 10000053 10000053 10000050 10000050 10000048 10000048 10000050 10000050 10000050 10000048 10000051 10000051 10000050 10000050 10000051 10000050 10000050 10000051 10000052 10000052 10000052 10000052 10000051 10000051 10000051 10000052 10000053 10000049 10000049 10000050 10000048 10000050 10000048 10000048 10000051 10000051 10000051 10000051 10000049 10000051 10000051 10000049 10000052 10000052 10000052 10000052 10000052 10000052 10000052 10000052 10000050 10000051 10000051 10000051 10000050 10000050 10000050 10000050 10000052 10000052 10000052 10000052 10000053 10000053 10000053 10000053 10000050 10000050 10000050 10000048 10000048 10000050 10000050 10000050 10000051 10000050 10000050 10000050 10000050 10000050 10000050 10000051 10000052 10000052 10000052 10000052 10000052 10000052 10000051 10000051 10000049 10000050 10000050 10000049 10000050 10000048 10000050 10000050
min_time_thread_terminate_total=10000048
max_time_thread_terminate_total=10000053
first_time_thread_start_by_thread=7 7 7 7 8 7 8 8 6 6 6 6 4 4 4 4 7 7 7 7 8 8 8 8 8 8 8 8 8 8 8 8 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7 7 7 7 7 8 7 8 8 6 6 6 6 4 4 4 4 7 7 7 7 8 8 8 8 8 8 8 8 8 8 8 8 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7
min_time_thread_start_total=4
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=99644058730494
threads_final_size=9965610
final_keysum=99644058730494
final_size=9965610
validate_result=success
Validation OK.
Structural validation OK.

total_find=331811635
total_rq=0
total_inserts=18427363
total_deletes=18430643
total_updates=36858006
total_queries=331811635
total_ops=368669641
find_throughput=33181163
rq_throughput=0
update_throughput=3685800
query_throughput=33181163
total_throughput=36866964


total find                    : 331811635
total rq                      : 0
total inserts                 : 18427363
total deletes                 : 18430643
total updates                 : 36858006
total queries                 : 331811635
total ops                     : 368669641
find throughput               : 33181163
rq throughput                 : 0
update throughput             : 3685800
query throughput              : 33181163
total throughput              : 36866964

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=1644170395171504
total_execution_walltime=13.678s
REALTIME_MAIN_END_PERF_FORMAT=211309.269820899
[time_cmd_output] time_elapsed_sec=13.84, faults_major=0, faults_minor=321979, mem_maxresident_kb=1259480, user_cputime=1673.79, sys_cputime=21.94, percent_cpu=12247%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2