__step=000716
__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" ./guerraoui_ext_bst_ticket.debra -nwork 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000716.txt
__path_data=data/data000716.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215464.414320980
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=guerraoui_ext_bst_ticket
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=20000000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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=40
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.044s
prefilling_size=8640105 prefilling_elapsed_millis=1s
prefilling_size=8845250 prefilling_elapsed_millis=1.1s
prefilling_size=9017049 prefilling_elapsed_millis=1.2s
prefilling_size=9164224 prefilling_elapsed_millis=1.301s
prefilling_size=9287827 prefilling_elapsed_millis=1.401s
prefilling_size=9392557 prefilling_elapsed_millis=1.501s
prefilling_size=9477340 prefilling_elapsed_millis=1.601s
prefilling_size=9551139 prefilling_elapsed_millis=1.701s
prefilling_size=9615277 prefilling_elapsed_millis=1.801s
prefilling_size=9670308 prefilling_elapsed_millis=1.901s
prefilling_size=9718404 prefilling_elapsed_millis=2.001s
prefilling_size=9758436 prefilling_elapsed_millis=2.101s
prefilling_size=9794042 prefilling_elapsed_millis=2.201s
prefilling_size=9824698 prefilling_elapsed_millis=2.302s
finished prefilling to size 9824743 for expected size 10000000 keysum=98252099497668, performing 81313822 updates; total_prefilling_elapsed_ms=2403 ms)
pref_size=9824743
pref_millis=2403
prefill_elapsed_ms=2417
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=546

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=215466.907755129
REALTIME_END_PERF_FORMAT=215476.907801823

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
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=1.046s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1020 2009 3851 7107 12578 21278 34494 53403 79512 113975 157392 210047 269262 331730 394323 454510 508867 552126 582714 599094 602782 595574 577813 550527 514284 473271 428378 380235 329167 277189 226600 180387 138894 103952 75220 53274 36731 24613 16270 10365 6542 4023 2353 1385 731 395 212 82 35 12 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 4 31 167 595 1636 3878 8062 15585 27294 45049 70558 104737 150832 206794 269137 334136 400153 465608 521538 566334 595406 609990 613335 605099 586770 555297 518164 476521 431303 381145 327778 272813 221880 173836 132684 97166 69817 48849 32956 22175 14188 9061 5693 3321 2039 1067 578 342 129 58 21 6
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2040 4018 7702 14214 25156 42556 68988 106806 159024 227950 314784 420094 538524 663460 788646 909020 1017734 1104252 1165428 1198188 1205564 1191148 1155626 1101054 1028568 946542 856756 760470 658334 554378 453200 360774 277788 207904 150440 106548 73462 49226 32540 20730 13084 8046 4706 2770 1462 790 424 164 70 24 6
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 4 31 167 594 1636 3878 8062 15585 27294 45049 70558 104737 150832 206794 269137 334136 400153 465608 521538 566334 595406 609990 613335 605099 586770 555297 518164 476521 431303 381145 327778 272813 221880 173836 132684 97166 69817 48849 32956 22175 14188 9061 5693 3321 2039 1067 578 342 129 58 21 6
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 1.99609 1.9848 1.95844 1.92262 1.8849 1.84584 1.81056 1.77409 1.74445 1.71672 1.69047 1.66727 1.64096 1.616 1.59434 1.57632 1.5598 1.54251 1.5277 1.51405 1.50308 1.49402 1.48509 1.47639 1.46708 1.46013 1.45257 1.44381 1.43285 1.42105 1.40875 1.39803 1.38499 1.37421 1.3618 1.35412 1.34474 1.33504 1.33052 1.31853 1.31558 1.30747 1.29244 1.29431 1.2639 1.27018 1.26835 1.1934 1.21341 1.17143 1.125 1

tree_stats_height=62
tree_stats_numInternals=10001614
tree_stats_numLeaves=10001615
tree_stats_numNodes=20003229
tree_stats_numKeys=10001614

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 40960 81600 160720 308080 568560 1006240 1702240 2759520 4272240 6360960 9118000 12591360 16803760 21540960 26538400 31545840 36360800 40709360 44170080 46617120 47927520 48222560 47645920 46225040 44042160 41142720 37861680 34270240 30418800 26333360 22175120 18128000 14430960 11111520 8316160 6017600 4261920 2938480 1969040 1301600 829200 523360 321840 188240 110800 58480 31600 16960 6560 2800 960 240
tree_stats_sizeInBytes=800129160

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:22 4:6 8:8 16:10 32:26 64:36 128:52 256:48929 512:228692 1024:322
    (2^01, 2^02]: 22
    (2^02, 2^03]: 6
    (2^03, 2^04]: 8
    (2^04, 2^05]: 10
    (2^05, 2^06]: 26
    (2^06, 2^07]: 36
    (2^07, 2^08]: 52
    (2^08, 2^09]: 48929
    (2^09, 2^10]: 228692
    (2^10, 2^11]: 322
sum_limbo_reclamation_event_size_total=154879964
count_limbo_reclamation_event_size_by_thread=2173 2172 2172 2172 2172 2173 2173 2173 2173 2173 2171 2173 2172 2172 2172 2172 2172 2172 2173 2172 2173 2173 2172 2173 2173 2173 2173 2173 2173 2173 2173 2173 2173 2172 2173 2173 2173 2172 2173 2173 2173 2173 2173 2173 2172 2172 2173 2172 2173 2173 2173 2173 2173 2173 2173 2172 2173 2173 2173 2172 2173 2173 2173 2173 2172 2173 2173 2173 2173 2173 2173 2173 2172 2173 2172 2173 2173 2173 2173 2173 2173 2173 2173 2172 2172 2173 2173 2173 2173 2173 2173 2173 2173 2173 2173 2172 2173 2172 2172 2172 2173 2172 2173 2173 2171 2172 2173 2173 2173 2173 2172 2173 2173 2172 2173 2173 2173 2173 2172 2172 2173 2173 2172 2173 2173 2173 2172 2172
count_limbo_reclamation_event_size_total=278103
sum_limbo_reclamation_event_count_total=278400
first_thread_announced_epoch_by_thread=5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442 5442
sum_num_inserts_by_thread=1220786 1217103 1221052 1212088 1218262 1211348 1215330 1212442 1214712 1210031 1202268 1206839 1216533 1214059 1209258 1212756 1210082 1215253 1214156 1207633 1212882 1207451 1209916 1196575 1208011 1206982 1198473 1213872 1209968 1217360 1213430 1211904 1218686 1225086 1214465 1207597 1217539 1213408 1211534 1213142 1213269 1225416 1219960 1221961 1213830 1223371 1219592 1217450 1211021 1208284 1200031 1206915 1207321 1206743 1204840 1210981 1215674 1208825 1213567 1214800 1214265 1212082 1203946 1204895 1202135 1210620 1208333 1203745 1206031 1212133 1214827 1216144 1212482 1213516 1213867 1211853 1206579 1213185 1206209 1202537 1209034 1204509 1201518 1208153 1217509 1217398 1216329 1213763 1213438 1215513 1210050 1207100 1211631 1209302 1199012 1199228 1211829 1211806 1220969 1221139 1218891 1222085 1217971 1219160 1224942 1220083 1217492 1207030 1223908 1221827 1221366 1210273 1215962 1215512 1215424 1212924 1214721 1220810 1217353 1212971 1215029 1221106 1214007 1209018 1217902 1221289 1215153 1219412
sum_num_inserts_total=155246358
sum_num_deletes_by_thread=1218539 1218188 1219318 1215951 1219254 1210291 1213249 1211693 1211036 1208832 1204703 1204455 1214566 1214354 1208091 1213797 1212774 1217540 1214004 1207845 1212362 1207872 1207618 1196939 1208516 1207043 1200485 1211721 1212002 1217169 1212507 1213507 1217928 1224180 1213894 1209695 1214259 1213012 1210552 1214701 1213253 1224570 1221243 1220755 1212830 1223974 1218766 1219881 1210957 1207991 1199132 1206583 1208453 1206898 1202391 1212349 1217362 1209560 1215016 1210857 1213703 1213378 1204726 1202842 1200889 1211413 1207514 1204218 1206189 1210784 1214327 1214648 1213534 1213740 1211532 1212511 1206326 1213184 1206081 1206493 1209010 1205003 1201171 1207135 1216700 1217812 1216035 1215525 1214123 1215906 1208131 1207526 1209384 1209052 1197798 1198206 1211253 1211030 1223638 1218101 1217916 1221527 1217777 1220447 1225096 1218969 1217061 1207783 1224282 1218488 1220251 1213133 1215905 1212553 1215842 1210178 1217137 1216918 1216851 1212565 1216120 1223001 1216468 1211530 1217946 1221535 1215423 1219966
sum_num_deletes_total=155230502
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2439325 2435291 2440370 2428039 2437516 2421639 2428579 2424135 2425748 2418863 2406971 2411294 2431099 2428413 2417349 2426553 2422856 2432793 2428160 2415478 2425244 2415323 2417534 2393514 2416527 2414025 2398958 2425593 2421970 2434529 2425937 2425411 2436614 2449266 2428359 2417292 2431798 2426420 2422086 2427843 2426522 2449986 2441203 2442716 2426660 2447345 2438358 2437331 2421978 2416275 2399163 2413498 2415774 2413641 2407231 2423330 2433036 2418385 2428583 2425657 2427968 2425460 2408672 2407737 2403024 2422033 2415847 2407963 2412220 2422917 2429154 2430792 2426016 2427256 2425399 2424364 2412905 2426369 2412290 2409030 2418044 2409512 2402689 2415288 2434209 2435210 2432364 2429288 2427561 2431419 2418181 2414626 2421015 2418354 2396810 2397434 2423082 2422836 2444607 2439240 2436807 2443612 2435748 2439607 2450038 2439052 2434553 2414813 2448190 2440315 2441617 2423406 2431867 2428065 2431266 2423102 2431858 2437728 2434204 2425536 2431149 2444107 2430475 2420548 2435848 2442824 2430576 2439378
average_num_operations_total=2425600
stdev_num_operations_total=1063
sum_num_operations_total=310476860
min_num_operations_total=2393514
max_num_operations_total=2450038
first_time_thread_terminate_by_thread=10000050 10000050 10000050 10000050 10000050 10000050 10000074 10000050 10000067 10000049 10000049 10000049 10000051 10000051 10000051 10000051 10000050 10000050 10000050 10000050 10000050 10000050 10000050 10000048 10000049 10000051 10000051 10000049 10000049 10000051 10000059 10000049 10000049 10000049 10000049 10000047 10000052 10000052 10000051 10000110 10000047 10000047 10000047 10000047 10000048 10000048 10000048 10000048 10000048 10000048 10000048 10000050 10000050 10000050 10000050 10000050 10000049 10000049 10000049 10000069 10000050 10000050 10000048 10000048 10000050 10000050 10000050 10000050 10000050 10000055 10000050 10000050 10000049 10000049 10000049 10000049 10000051 10000051 10000051 10000052 10000050 10000090 10000050 10000065 10000048 10000048 10000050 10000048 10000049 10000051 10000095 10000049 10000049 10000049 10000049 10000049 10000049 10000047 10000049 10000049 10000095 10000051 10000051 10000051 10000047 10000053 10000053 10000048 10000066 10000048 10000114 10000048 10000057 10000050 10000048 10000048 10000098 10000050 10000050 10000050 10000049 10000054 10000049 10000049 10000050 10000048 10000048 10000048
min_time_thread_terminate_total=10000047
max_time_thread_terminate_total=10000114
first_time_thread_start_by_thread=5 5 5 5 7 7 7 7 5 5 5 5 5 5 5 5 7 7 7 7 5 5 5 5 8 8 8 8 8 8 8 8 7 7 7 7 6 6 6 6 4 4 4 4 6 6 6 6 6 6 6 6 8 8 8 8 8 8 8 8 7 7 7 7 5 5 5 5 7 7 7 7 5 5 5 5 5 5 5 5 8 7 7 7 5 5 5 5 8 8 8 8 8 8 8 8 7 7 7 7 6 6 6 6 4 4 4 4 6 6 6 6 6 6 6 6 8 8 8 8 8 8 8 8 7 7 7 7
min_time_thread_start_total=4
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=100012157226034
threads_final_size=10001614
final_keysum=100012157226034
final_size=10001614
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=155246358
total_deletes=155230502
total_updates=310476860
total_queries=0
total_ops=310476860
find_throughput=0
rq_throughput=0
update_throughput=31047686
query_throughput=0
total_throughput=31047686


total find                    : 0
total rq                      : 0
total inserts                 : 155246358
total deletes                 : 155230502
total updates                 : 310476860
total queries                 : 0
total ops                     : 310476860
find throughput               : 0
rq throughput                 : 0
update throughput             : 31047686
query throughput              : 0
total throughput              : 31047686

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=0
total_execution_walltime=13.683s
REALTIME_MAIN_END_PERF_FORMAT=215478.97778208
[time_cmd_output] time_elapsed_sec=13.85, faults_major=0, faults_minor=320141, mem_maxresident_kb=1278096, user_cputime=1542.43, sys_cputime=41.01, percent_cpu=11427%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2