__step=000825
__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000825.txt
__path_data=data/data000825.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6988924.980131362
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=2000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.004s
prefilling_size=999772 prefilling_elapsed_millis=1.001s
finished prefilling to size 999821 for expected size 1000000 keysum=999688222228, performing 32388897 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999821
pref_millis=1102
prefill_elapsed_ms=1122
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=1517

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6988926.278463753
REALTIME_END_PERF_FORMAT=6988936.278602955

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

tree_stats_computeWalltime=0.044s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 250 462 855 1521 2592 4338 7132 11358 17346 25443 35423 46663 58379 69621 78787 84951 86911 83939 77660 69037 59111 48102 37168 27624 20040 14150 10166 7223 5100 3452 2159 1339 859 546 306 149 71 30 10 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 6 38 69 189 450 846 1544 2906 5370 9249 15463 24183 34947 47137 60455 72623 82991 89883 90218 86283 78963 70120 59036 46712 35208 25930 18134 13109 9346 6748 4745 2979 1819 1172 786 463 227 112 50 17 5 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 500 924 1710 3042 5184 8676 14264 22716 34692 50886 70846 93326 116758 139242 157574 169902 173822 167878 155320 138074 118222 96204 74336 55248 40080 28300 20332 14446 10200 6904 4318 2678 1718 1092 612 298 142 60 20 6 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 6 38 69 188 450 846 1544 2906 5370 9249 15463 24183 34947 47137 60455 72623 82991 89883 90218 86283 78963 70120 59036 46712 35208 25930 18134 13109 9346 6748 4745 2979 1819 1172 786 463 227 112 50 17 5 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.97656 1.924 1.92532 1.88889 1.85207 1.83681 1.82204 1.79627 1.7636 1.7334 1.69612 1.65865 1.62554 1.59628 1.56583 1.53912 1.51154 1.4829 1.4626 1.44448 1.42811 1.40688 1.38635 1.37161 1.36273 1.35304 1.35922 1.35525 1.35304 1.33843 1.31272 1.3101 1.32076 1.31781 1.28022 1.24346 1.23826 1.21127 1.16667 1.15 1.16667 1

tree_stats_height=50
tree_stats_numInternals=1000532
tree_stats_numLeaves=1000533
tree_stats_numNodes=2001065
tree_stats_numKeys=1000532

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20000 36960 68400 121680 207360 347040 570560 908640 1387680 2035440 2833840 3733040 4670320 5569680 6302960 6796080 6952880 6715120 6212800 5522960 4728880 3848160 2973440 2209920 1603200 1132000 813280 577840 408000 276160 172720 107120 68720 43680 24480 11920 5680 2400 800 240 80
tree_stats_sizeInBytes=80042600

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:27 4:0 8:2 16:13 32:30 64:111 128:455358 256:24221 512:39 1024:41
    (2^01, 2^02]: 27
    (2^02, 2^03]: 0
    (2^03, 2^04]: 2
    (2^04, 2^05]: 13
    (2^05, 2^06]: 30
    (2^06, 2^07]: 111
    (2^07, 2^08]: 455358
    (2^08, 2^09]: 24221
    (2^09, 2^10]: 39
    (2^10, 2^11]: 41
sum_limbo_reclamation_event_size_total=106837304
count_limbo_reclamation_event_size_by_thread=9996 9995 9996 9996 9997 9997 9997 9997 9998 9997 9996 9998 9995 9997 9997 9996 9996 9995 9997 9998 9997 9996 9996 9997 9996 9998 9997 9997 9998 9996 9996 9997 9998 9997 9997 9996 9997 9997 9997 9997 9996 9996 9997 9998 9996 9998 9995 9998
count_limbo_reclamation_event_size_total=479842
sum_limbo_reclamation_event_count_total=711594
first_thread_announced_epoch_by_thread=32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684 32684
sum_num_inserts_by_thread=3272216 3290786 3317921 3317943 3296654 3261501 3290681 3306157 3335366 3328614 3305900 3277876 3294632 3313103 3332567 3330624 3303493 3287936 3269181 3295451 3314004 3328813 3284745 3264662 3268967 3285732 3323120 3317161 3302795 3282605 3292535 3297983 3337266 3338750 3300961 3283660 3286460 3314084 3319909 3334922 3310524 3284349 3267823 3289110 3311746 3318754 3280550 3268174
sum_num_inserts_total=158438766
sum_num_deletes_by_thread=3271919 3299875 3315710 3320855 3297413 3266328 3287882 3308764 3333031 3332111 3304210 3277794 3291300 3314190 3328734 3333820 3306002 3289431 3269417 3296401 3316959 3328454 3287171 3264740 3270912 3286866 3320075 3316604 3300594 3274758 3289813 3297765 3334157 3339990 3302493 3283527 3286936 3313870 3321400 3331637 3310134 3283624 3266683 3290223 3308075 3313676 3281547 3267248
sum_num_deletes_total=158435118
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=6544135 6590661 6633631 6638798 6594067 6527829 6578563 6614921 6668397 6660725 6610110 6555670 6585932 6627293 6661301 6664444 6609495 6577367 6538598 6591852 6630963 6657267 6571916 6529402 6539879 6572598 6643195 6633765 6603389 6557363 6582348 6595748 6671423 6678740 6603454 6567187 6573396 6627954 6641309 6666559 6620658 6567973 6534506 6579333 6619821 6632430 6562097 6535422
average_num_operations_total=6601539
stdev_num_operations_total=6317
sum_num_operations_total=316873884
min_num_operations_total=6527829
max_num_operations_total=6678740
first_time_thread_terminate_by_thread=10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139
min_time_thread_terminate_total=10000139
max_time_thread_terminate_total=10000140
first_time_thread_start_by_thread=3 3 3 3 3 3 2 3 3 2 3 3 3 3 2 2 3 3 3 3 3 2 2 3 3 3 3 3 3 3 2 3 3 2 3 3 3 3 2 2 3 3 3 3 3 2 2 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=1000798405546
threads_final_size=1000532
final_keysum=1000798405546
final_size=1000532
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=158438766
total_deletes=158435118
total_updates=316873884
total_queries=0
total_ops=316873884
find_throughput=0
rq_throughput=0
update_throughput=31687388
query_throughput=0
total_throughput=31687388


total find                    : 0
total rq                      : 0
total inserts                 : 158438766
total deletes                 : 158435118
total updates                 : 316873884
total queries                 : 0
total ops                     : 316873884
find throughput               : 0
rq throughput                 : 0
update throughput             : 31687388
query throughput              : 0
total throughput              : 31687388

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=30.9753
PAPI_L3_TCM=6.18881
PAPI_TOT_CYC=4217.63
PAPI_TOT_INS=768.522
garbage=0
total_execution_walltime=11.44s
REALTIME_MAIN_END_PERF_FORMAT=6988936.421483679
[time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=101336, mem_maxresident_kb=406096, user_cputime=557.91, sys_cputime=1.86, percent_cpu=4840%
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=1