__step=000156
__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 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=data000156.txt
__path_data=data/data000156.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980702.90040518
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=0.5
DEL_FRAC=0.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=0.5 0.5
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.035s
prefilling_size=1000110 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000075 for expected size 1000000 keysum=1000257818918, performing 46938812 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=1000075
pref_millis=1103
prefill_elapsed_ms=1125
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=654

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6980703.415820912
REALTIME_END_PERF_FORMAT=6980713.415966730

###############################################################################
################################## 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 984 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 127 251 492 966 1850 3401 5968 9921 15691 23395 32981 44131 56014 67541 77274 83653 86283 84799 80105 72448 62696 52012 41970 32269 23445 16072 10128 6095 3522 1937 1001 510 249 102 41 13 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 3 10 18 82 299 834 2015 4151 7987 13809 21831 32248 44487 57808 70895 81023 87767 89493 87762 82200 73380 62054 51671 41093 30818 22016 14161 8668 5107 2873 1492 771 396 163 69 23 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 254 502 984 1932 3700 6802 11936 19842 31382 46790 65962 88262 112028 135082 154548 167306 172566 169598 160210 144896 125392 104024 83940 64538 46890 32144 20256 12190 7044 3874 2002 1020 498 204 82 26 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 1 3 10 18 82 298 834 2015 4151 7987 13809 21831 32248 44487 57808 70895 81023 87767 89493 87762 82200 73380 62054 51671 41093 30818 22016 14161 8668 5107 2873 1492 771 396 163 69 23 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.99219 1.98819 1.98008 1.98171 1.95756 1.91892 1.87739 1.83118 1.7908 1.74549 1.70487 1.66904 1.63463 1.60289 1.57205 1.54128 1.51572 1.4914 1.47232 1.45221 1.4327 1.4148 1.40346 1.38443 1.36327 1.34276 1.31508 1.3009 1.28893 1.27499 1.25839 1.25475 1.24412 1.20482 1.20098 1.15854 1.11538 1.16667 1

tree_stats_height=46
tree_stats_numInternals=999484
tree_stats_numLeaves=999485
tree_stats_numNodes=1998969
tree_stats_numKeys=999484

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10160 20080 39360 77280 148000 272080 477440 793680 1255280 1871600 2638480 3530480 4481120 5403280 6181920 6692240 6902640 6783920 6408400 5795840 5015680 4160960 3357600 2581520 1875600 1285760 810240 487600 281760 154960 80080 40800 19920 8160 3280 1040 240 80
tree_stats_sizeInBytes=79958760

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:215567 4:447742 8:193399 16:2839 32:97
    (2^01, 2^02]: 215567
    (2^02, 2^03]: 447742
    (2^03, 2^04]: 193399
    (2^04, 2^05]: 2839
    (2^05, 2^06]: 97
sum_limbo_reclamation_event_size_total=4440040
count_limbo_reclamation_event_size_by_thread=8897 8945 8942 8983 9007 8961 8948 8923 8985 8970 8924 8980 8928 8947 9021 8949 8976 8956 8940 8952 8978 9000 8967 8913 8907 8950 8987 8975 8965 8959 8931 8930 9009 9058 8968 8928 8972 8939 8994 8963 8945 8954 8911 8917 8956 8955 8950 8936 8960 8912 8986 8992 8914 8915 8907 8967 8923 8970 8945 8985 8946 8917 8987 8978 8949 8884 8986 8929 9003 8983 8968 8946 8965 8961 8970 9043 8923 8899 8891 8941 8993 9000 8918 8933 8934 8951 8982 8924 8927 8923 8920 8915 8994 9010 8983 8941
count_limbo_reclamation_event_size_total=859644
sum_limbo_reclamation_event_count_total=952512
first_thread_announced_epoch_by_thread=21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152 21152
sum_num_inserts_by_thread=46076 46033 46544 46802 46091 45962 46211 46349 46715 46839 46385 45775 45404 46665 46826 46780 45933 46092 45494 46441 46316 46555 45882 45374 45567 46101 46941 46582 46017 45765 45810 46199 46973 47093 45886 46009 46101 46298 46712 46846 46496 46238 45432 46148 45983 46794 45847 45661 45740 46238 46619 46509 45600 45715 46018 45861 46644 46617 46431 45761 46062 45979 47047 46734 46709 45807 45722 46059 46996 46732 46489 45591 45355 46255 46806 47149 46087 45887 45335 45750 46532 46944 46458 46479 46073 46616 46942 46692 46266 45851 45668 45831 46510 46974 46372 45833
sum_num_inserts_total=4439388
sum_num_deletes_by_thread=45817 46397 46759 46841 46332 45616 46188 45726 46889 46983 46233 45958 46271 46511 47111 46649 46603 45769 45245 46337 46620 46774 46024 45460 45398 46205 46339 46219 46456 45561 46027 46131 46896 46806 46333 46079 46220 46243 46582 46687 46129 45521 45792 45857 46009 46896 45927 45293 46198 46146 46785 46874 45728 46011 45834 46417 46465 46946 46060 45973 45730 46125 46542 46480 46581 45899 45837 46365 47025 46623 46429 46026 45551 46006 46445 46664 45890 45669 45464 45769 46627 46812 46357 45921 46121 46736 46531 46588 46213 45641 45482 46064 46484 46924 46608 45641
sum_num_deletes_total=4438026
sum_num_searches_by_thread=9064001 9140055 9232870 9234636 9172827 9034623 9091530 9135196 9257076 9277480 9165778 9083040 9130303 9176941 9242036 9214667 9167537 9111595 9026827 9119035 9197155 9240349 9095479 8995630 9015824 9121002 9211035 9225678 9173396 9045387 9112218 9150376 9272615 9289197 9158491 9086932 9122861 9167019 9247859 9246689 9179429 9090976 9008593 9087846 9142601 9217639 9098417 8995069 9059995 9118020 9215689 9228477 9115698 9087551 9089662 9149293 9228533 9284390 9181962 9087945 9087861 9158126 9264421 9240768 9192091 9084878 9034223 9118489 9253915 9260389 9163907 9049287 9045620 9103835 9220203 9230640 9133534 9084211 9086862 9092150 9255102 9269597 9172504 9108342 9108956 9194017 9257961 9256717 9134374 9047050 9000109 9108229 9261352 9267159 9183644 9111354
sum_num_searches_total=878562907
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9155894 9232485 9326173 9328279 9265250 9126201 9183929 9227271 9350680 9371302 9258396 9174773 9221978 9270117 9335973 9308096 9260073 9203456 9117566 9211813 9290091 9333678 9187385 9086464 9106789 9213308 9304315 9318479 9265869 9136713 9204055 9242706 9366484 9383096 9250710 9179020 9215182 9259560 9341153 9340222 9272054 9182735 9099817 9179851 9234593 9311329 9190191 9086023 9151933 9210404 9309093 9321860 9207026 9179277 9181514 9241571 9321642 9377953 9274453 9179679 9179653 9250230 9358010 9333982 9285381 9176584 9125782 9210913 9347936 9353744 9256825 9140904 9136526 9196096 9313454 9324453 9225511 9175767 9177661 9183669 9348261 9363353 9265319 9200742 9201150 9287369 9351434 9349997 9226853 9138542 9091259 9200124 9354346 9361057 9276624 9202828
average_num_operations_total=9244170
stdev_num_operations_total=8169
sum_num_operations_total=887440321
min_num_operations_total=9086023
max_num_operations_total=9383096
first_time_thread_terminate_by_thread=10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000146 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000146 10000148 10000146 10000146 10000146 10000147 10000147 10000147 10000147 10000147 10000146 10000146 10000146 10000147 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000147 10000146 10000147 10000146 10000148 10000146 10000146 10000146 10000147 10000147 10000147 10000147 10000147 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000146 10000147 10000146 10000147 10000146
min_time_thread_terminate_total=10000146
max_time_thread_terminate_total=10000148
first_time_thread_start_by_thread=3 4 3 3 4 3 3 3 3 3 4 4 4 4 4 3 4 4 3 3 3 4 4 4 3 4 3 3 4 3 3 3 3 3 4 4 4 4 4 3 4 4 3 3 3 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 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=999674012927
threads_final_size=999484
final_keysum=999674012927
final_size=999484
validate_result=success
Validation OK.
Structural validation OK.

total_find=878562907
total_rq=0
total_inserts=4439388
total_deletes=4438026
total_updates=8877414
total_queries=878562907
total_ops=887440321
find_throughput=87856290
rq_throughput=0
update_throughput=887741
query_throughput=87856290
total_throughput=88744032


total find                    : 878562907
total rq                      : 0
total inserts                 : 4439388
total deletes                 : 4438026
total updates                 : 8877414
total queries                 : 878562907
total ops                     : 887440321
find throughput               : 87856290
rq throughput                 : 0
update throughput             : 887741
query throughput              : 87856290
total throughput              : 88744032

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=21.6519
PAPI_L3_TCM=4.56714
PAPI_TOT_CYC=3010.35
PAPI_TOT_INS=309.657
garbage=434722189147442
total_execution_walltime=11.472s
REALTIME_MAIN_END_PERF_FORMAT=6980713.563767594
[time_cmd_output] time_elapsed_sec=11.60, faults_major=0, faults_minor=102293, mem_maxresident_kb=407436, user_cputime=1095.24, sys_cputime=3.11, percent_cpu=9464%
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