__step=000492
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000492.txt
__path_data=data/data000492.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6984829.224131754
binary=./guerraoui_ext_bst_ticket.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=2000000
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=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,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.023s
prefilling_size=1001321 prefilling_elapsed_millis=1.001s
finished prefilling to size 1001223 for expected size 1000000 keysum=1001264237969, performing 46941797 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=1001223
pref_millis=1103
prefill_elapsed_ms=1126
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=653

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6984830.581014177
REALTIME_END_PERF_FORMAT=6984840.581092836

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

tree_stats_computeWalltime=0.032s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 125 248 484 917 1677 2980 5127 8500 13643 21111 31261 43678 57745 71518 82933 90560 93520 91522 84647 74235 61324 48276 36785 26966 18588 12240 7745 4773 2838 1659 937 484 290 149 72 32 14 9 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 3 2 12 51 157 374 833 1754 3357 6175 10961 18844 29611 43972 60103 75306 87600 95518 98397 95059 87146 74372 59767 46604 35344 24936 16735 10717 6708 4017 2381 1390 678 431 226 112 50 19 17 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 250 496 968 1834 3354 5960 10254 17000 27286 42222 62522 87356 115490 143036 165866 181120 187040 183044 169294 148470 122648 96552 73570 53932 37176 24480 15490 9546 5676 3318 1874 968 580 298 144 64 28 18 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 3 2 12 51 157 374 833 1754 3357 6175 10961 18843 29611 43972 60103 75306 87600 95518 98397 95059 87146 74372 59767 46604 35344 24936 16735 10717 6708 4017 2381 1390 678 431 226 112 50 19 17 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.97656 1.992 1.97581 1.94731 1.91439 1.88849 1.86023 1.82894 1.80253 1.77369 1.7404 1.69859 1.66103 1.61926 1.57981 1.54598 1.51634 1.48932 1.46244 1.4385 1.41304 1.39361 1.38099 1.36654 1.34466 1.32924 1.31638 1.30813 1.2973 1.29228 1.2824 1.25827 1.29959 1.2569 1.24161 1.22222 1.21875 1.32143 1.05556 1

tree_stats_height=47
tree_stats_numInternals=999740
tree_stats_numLeaves=999741
tree_stats_numNodes=1999481
tree_stats_numKeys=999740

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=25.2819

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10000 19840 38720 73360 134160 238400 410160 680000 1091440 1688880 2500880 3494240 4619600 5721440 6634640 7244800 7481600 7321760 6771760 5938800 4905920 3862080 2942800 2157280 1487040 979200 619600 381840 227040 132720 74960 38720 23200 11920 5760 2560 1120 720 80
tree_stats_sizeInBytes=79979240

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:8 8:71 16:40058 32:829196 64:41155 128:253 256:299
    (2^02, 2^03]: 8
    (2^03, 2^04]: 71
    (2^04, 2^05]: 40058
    (2^05, 2^06]: 829196
    (2^06, 2^07]: 41155
    (2^07, 2^08]: 253
    (2^08, 2^09]: 299
sum_limbo_reclamation_event_size_total=42443426
count_limbo_reclamation_event_size_by_thread=9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490 9490
count_limbo_reclamation_event_size_total=911040
sum_limbo_reclamation_event_count_total=911232
first_thread_announced_epoch_by_thread=20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290 20290
sum_num_inserts_by_thread=436586 440449 444233 445612 442084 435510 439282 442915 446764 447385 441581 437462 439890 443686 446763 447069 444125 441560 436464 442309 444823 445405 440269 435876 437445 440950 444031 445544 442283 437481 440318 442647 446343 447350 441350 439770 438799 443789 445752 445829 443080 438830 436138 439836 444851 447127 440387 437614 439405 441872 446355 446047 441751 439618 439227 442199 448127 446820 444108 439983 439736 444121 445845 446635 442261 437015 434939 439473 444825 444963 440753 438651 438268 440315 445728 445908 442051 439030 439569 442560 449441 447392 444425 443137 441338 442970 444183 445986 441294 436999 435514 438468 445276 446402 444002 440063
sum_num_inserts_total=42450694
sum_num_deletes_by_thread=437711 439965 444801 445218 443250 437133 437917 443304 447004 448348 442201 438183 441364 443031 447289 447378 445488 441798 437687 441301 444254 446131 440387 436466 436781 440428 443928 445940 442329 436934 440192 441841 447069 448454 440880 437860 439070 442440 446464 446005 442040 439599 435650 440225 443058 445374 440292 436262 438871 441845 445891 444723 441101 439881 440336 442334 447256 446849 442864 440207 440422 442819 446291 447410 442915 435665 436539 439100 443811 445105 441269 439405 438877 442094 445787 446144 442097 439210 439466 441733 447987 448626 444662 441038 441813 443361 446419 446286 441803 437481 435399 439315 445259 445666 443085 439725
sum_num_deletes_total=42452966
sum_num_searches_by_thread=7875610 7929660 8013605 8008198 7958227 7862599 7902061 7956518 8046071 8057099 7954828 7864791 7925198 7968890 8048936 8052273 8001318 7939695 7872285 7940293 7996558 8032941 7920213 7847725 7863438 7932920 8018813 8017168 7953332 7867053 7913868 7958280 8049528 8058382 7944266 7885574 7908278 7967936 8036800 8039090 7974544 7900398 7860585 7939466 7995374 8043724 7939234 7868402 7902909 7962789 8035960 8027909 7959900 7933277 7913533 7969809 8050628 8041749 7972999 7912712 7912054 7983167 8034800 8026328 7961007 7865403 7847295 7899590 8012362 8013305 7935211 7897184 7875949 7929800 8023029 8025754 7939795 7894755 7913976 7964173 8069141 8085931 8001816 7943934 7951896 7973491 8022359 8021887 7943366 7855909 7837802 7903133 8014487 8034118 7971216 7917021
sum_num_searches_total=764098663
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8749907 8810074 8902639 8899028 8843561 8735242 8779260 8842737 8939839 8952832 8838610 8740436 8806452 8855607 8942988 8946720 8890931 8823053 8746436 8823903 8885635 8924477 8800869 8720067 8737664 8814298 8906772 8908652 8837944 8741468 8794378 8842768 8942940 8954186 8826496 8763204 8786147 8854165 8929016 8930924 8859664 8778827 8732373 8819527 8883283 8936225 8819913 8742278 8781185 8846506 8928206 8918679 8842752 8812776 8793096 8854342 8946011 8935418 8859971 8792902 8792212 8870107 8926936 8920373 8846183 8738083 8718773 8778163 8900998 8903373 8817233 8775240 8753094 8812209 8914544 8917806 8823943 8772995 8793011 8848466 8966569 8981949 8890903 8828109 8835047 8859822 8912961 8914159 8826463 8730389 8708715 8780916 8905022 8926186 8858303 8796809
average_num_operations_total=8843774
stdev_num_operations_total=7194
sum_num_operations_total=849002323
min_num_operations_total=8708715
max_num_operations_total=8981949
first_time_thread_terminate_by_thread=10000078 10000078 10000078 10000078 10000078 10000078 10000079 10000077 10000079 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000077 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000079 10000077 10000079 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000077 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000078 10000077 10000078 10000078 10000077 10000079 10000078 10000078 10000077 10000077 10000079 10000079 10000079 10000079 10000078 10000077 10000078 10000079 10000077 10000078 10000078 10000078 10000079 10000078 10000078 10000077 10000078 10000078 10000079 10000079 10000078 10000078 10000077 10000077 10000079 10000079 10000078 10000079 10000078 10000077 10000078 10000079 10000077
min_time_thread_terminate_total=10000077
max_time_thread_terminate_total=10000079
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 2 3 2 2 3 3 3 3 3 2 2 3 3 3 3 3 3 3 3 3 3 2 3 3 2 3 2 2 3 3 3 3 3 2 2 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=1000461553893
threads_final_size=999740
final_keysum=1000461553893
final_size=999740
validate_result=success
Validation OK.
Structural validation OK.

total_find=764098663
total_rq=0
total_inserts=42450694
total_deletes=42452966
total_updates=84903660
total_queries=764098663
total_ops=849002323
find_throughput=76409866
rq_throughput=0
update_throughput=8490366
query_throughput=76409866
total_throughput=84900232


total find                    : 764098663
total rq                      : 0
total inserts                 : 42450694
total deletes                 : 42452966
total updates                 : 84903660
total queries                 : 764098663
total ops                     : 849002323
find throughput               : 76409866
rq throughput                 : 0
update throughput             : 8490366
query throughput              : 76409866
total throughput              : 84900232

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=21.8306
PAPI_L3_TCM=4.71564
PAPI_TOT_CYC=3147.25
PAPI_TOT_INS=337.479
garbage=382056761405522
total_execution_walltime=11.535s
REALTIME_MAIN_END_PERF_FORMAT=6984840.759793293
[time_cmd_output] time_elapsed_sec=11.67, faults_major=0, faults_minor=103447, mem_maxresident_kb=411720, user_cputime=1090.94, sys_cputime=2.93, percent_cpu=9373%
timeout=false
algorithm=guerraoui_ext_bst_ticket.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2