__step=000041
__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 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000041.txt
__path_data=data/data000041.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6979236.356817901
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=20000000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.006s
prefilling_size=6738188 prefilling_elapsed_millis=1.001s
prefilling_size=7028617 prefilling_elapsed_millis=1.101s
prefilling_size=7291019 prefilling_elapsed_millis=1.201s
prefilling_size=7529741 prefilling_elapsed_millis=1.301s
prefilling_size=7745053 prefilling_elapsed_millis=1.402s
prefilling_size=7938041 prefilling_elapsed_millis=1.502s
prefilling_size=8116985 prefilling_elapsed_millis=1.602s
prefilling_size=8277658 prefilling_elapsed_millis=1.702s
prefilling_size=8423748 prefilling_elapsed_millis=1.802s
prefilling_size=8557999 prefilling_elapsed_millis=1.902s
prefilling_size=8679240 prefilling_elapsed_millis=2.003s
prefilling_size=8789203 prefilling_elapsed_millis=2.103s
prefilling_size=8891193 prefilling_elapsed_millis=2.203s
prefilling_size=8982933 prefilling_elapsed_millis=2.303s
prefilling_size=9067260 prefilling_elapsed_millis=2.403s
prefilling_size=9143935 prefilling_elapsed_millis=2.504s
prefilling_size=9214816 prefilling_elapsed_millis=2.604s
prefilling_size=9279156 prefilling_elapsed_millis=2.704s
prefilling_size=9338542 prefilling_elapsed_millis=2.804s
prefilling_size=9392638 prefilling_elapsed_millis=2.904s
prefilling_size=9441965 prefilling_elapsed_millis=3.005s
prefilling_size=9487623 prefilling_elapsed_millis=3.105s
prefilling_size=9529096 prefilling_elapsed_millis=3.205s
prefilling_size=9565510 prefilling_elapsed_millis=3.305s
prefilling_size=9599958 prefilling_elapsed_millis=3.405s
prefilling_size=9631819 prefilling_elapsed_millis=3.506s
prefilling_size=9663101 prefilling_elapsed_millis=3.606s
prefilling_size=9689801 prefilling_elapsed_millis=3.706s
prefilling_size=9713751 prefilling_elapsed_millis=3.806s
prefilling_size=9734770 prefilling_elapsed_millis=3.906s
prefilling_size=9756314 prefilling_elapsed_millis=4.007s
prefilling_size=9776667 prefilling_elapsed_millis=4.107s
prefilling_size=9794553 prefilling_elapsed_millis=4.207s
prefilling_size=9811073 prefilling_elapsed_millis=4.307s
finished prefilling to size 9811110 for expected size 10000000 keysum=98120468600250, performing 79436406 updates; total_prefilling_elapsed_ms=4408 ms)
pref_size=9811110
pref_millis=4408
prefill_elapsed_ms=4434
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=3647

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6979240.942283593
REALTIME_END_PERF_FORMAT=6979250.942421827

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

tree_stats_computeWalltime=0.125s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 509 997 1938 3688 6826 12146 21029 35094 56530 87545 130304 186352 256485 339051 430964 525290 614723 690910 745735 773771 773479 740330 681859 604333 514801 423827 335946 256898 190111 134935 92617 61616 39467 24361 14575 8458 4903 2728 1535 836 445 211 110 52 22 13 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 3 21 56 188 550 1506 3263 6964 13658 25515 44786 74256 116219 173919 247138 336638 435857 538536 636085 717699 774063 806628 798801 759385 693865 605775 511708 414994 323685 245287 177253 123618 83765 54573 34147 20692 12013 7078 3921 2234 1227 679 312 168 82 31 25 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1018 1994 3876 7376 13652 24292 42058 70188 113060 175090 260608 372704 512970 678102 861928 1050580 1229446 1381820 1491470 1547542 1546958 1480660 1363718 1208666 1029602 847654 671892 513796 380222 269870 185234 123232 78934 48722 29150 16916 9806 5456 3070 1672 890 422 220 104 44 26 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 3 21 56 188 550 1506 3263 6964 13657 25515 44786 74256 116219 173919 247138 336638 435857 538536 636085 717699 774063 806628 798801 759385 693865 605775 511708 414994 323685 245287 177253 123618 83765 54573 34147 20692 12013 7078 3921 2234 1227 679 312 168 82 31 25 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.99414 1.97937 1.97192 1.9515 1.92543 1.88969 1.86568 1.83442 1.80539 1.77432 1.74421 1.71507 1.68817 1.66096 1.63554 1.60944 1.58513 1.56197 1.53968 1.5188 1.49981 1.47857 1.46051 1.44315 1.42592 1.41164 1.39632 1.38235 1.37001 1.35488 1.34319 1.33264 1.32027 1.30862 1.29915 1.29015 1.28984 1.2782 1.28134 1.27231 1.26615 1.23708 1.26066 1.23636 1.21154 1.29545 1.03846 1

tree_stats_height=57
tree_stats_numInternals=9828867
tree_stats_numLeaves=9828868
tree_stats_numNodes=19657735
tree_stats_numKeys=9828867

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

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 40720 79760 155040 295040 546080 971680 1682320 2807520 4522400 7003600 10424320 14908160 20518800 27124080 34477120 42023200 49177840 55272800 59658800 61901680 61878320 59226400 54548720 48346640 41184080 33906160 26875680 20551840 15208880 10794800 7409360 4929280 3157360 1948880 1166000 676640 392240 218240 122800 66880 35600 16880 8800 4160 1760 1040 80
tree_stats_sizeInBytes=786309400

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:151456 4:118423 8:11648 16:15
    (2^01, 2^02]: 151456
    (2^02, 2^03]: 118423
    (2^03, 2^04]: 11648
    (2^04, 2^05]: 15
sum_limbo_reclamation_event_size_total=940892
count_limbo_reclamation_event_size_by_thread=5888 5899 5888 5882 5871 5799 5833 5881 5889 5920 5852 5856 5881 5818 5846 5861 5865 5876 5760 5859 5930 5865 5907 5896 5875 5862 5855 5941 5873 5829 5909 5852 5842 5904 5815 5881 5835 5842 5928 5890 5826 5801 5820 5888 5900 5911 5848 5793
count_limbo_reclamation_event_size_total=281542
sum_limbo_reclamation_event_count_total=416160
first_thread_announced_epoch_by_thread=24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634 24634
sum_num_inserts_by_thread=19808 19708 20108 20200 19887 19820 19963 19954 20084 20241 19852 19830 19879 20135 20226 20318 20045 19944 19836 19833 20119 20156 19894 19644 19965 19954 20190 19991 19969 19828 19834 20406 19901 20185 19969 20003 20003 19825 20389 20287 20006 20104 19738 19984 20135 19897 19786 19837
sum_num_inserts_total=959670
sum_num_deletes_by_thread=19630 20073 19929 20245 19975 19673 19957 19966 20018 20250 19879 19929 20003 20001 20208 19954 19994 19930 19546 19769 20055 19920 20059 19807 19839 20174 20081 20313 20085 19980 19809 19821 20100 20176 19806 19814 19985 20008 20354 20130 19913 19812 19891 19789 20165 20128 19752 19614
sum_num_deletes_total=958309
sum_num_searches_by_thread=3934256 3953285 3979511 3976339 3961843 3924195 3937831 3954492 3991221 3996976 3949548 3933428 3946502 3967974 3990350 3989963 3963728 3939108 3920727 3943888 3964728 3973536 3936644 3911506 3939036 3952205 3980738 3979263 3962861 3923624 3940394 3954782 3992322 3995918 3952142 3936391 3946852 3970461 3991547 3989099 3964178 3939803 3918979 3939991 3962430 3980444 3938696 3912306
sum_num_searches_total=189906041
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3973694 3993066 4019548 4016784 4001705 3963688 3977751 3994412 4031323 4037467 3989279 3973187 3986384 4008110 4030784 4030235 4003767 3978982 3960109 3983490 4004902 4013612 3976597 3950957 3978840 3992333 4021009 4019567 4002915 3963432 3980037 3995009 4032323 4036279 3991917 3976208 3986840 4010294 4032290 4029516 4004097 3979719 3958608 3979764 4002730 4020469 3978234 3951757
average_num_operations_total=3996333
stdev_num_operations_total=3527
sum_num_operations_total=191824020
min_num_operations_total=3950957
max_num_operations_total=4037467
first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000137 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000137 10000137 10000138 10000137 10000138 10000138 10000138 10000138 10000138 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000138 10000137 10000138 10000138 10000138 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000138 10000138 10000137 10000138 10000138 10000138 10000137 10000138
min_time_thread_terminate_total=10000137
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=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 4 4 4 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=98303709315881
threads_final_size=9828867
final_keysum=98303709315881
final_size=9828867
validate_result=success
Validation OK.
Structural validation OK.

total_find=189906041
total_rq=0
total_inserts=959670
total_deletes=958309
total_updates=1917979
total_queries=189906041
total_ops=191824020
find_throughput=18990604
rq_throughput=0
update_throughput=191797
query_throughput=18990604
total_throughput=19182402


total find                    : 189906041
total rq                      : 0
total inserts                 : 959670
total deletes                 : 958309
total updates                 : 1917979
total queries                 : 189906041
total ops                     : 191824020
find throughput               : 18990604
rq throughput                 : 0
update throughput             : 191797
query throughput              : 18990604
total throughput              : 19182402

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=37.4506
PAPI_L3_TCM=13.5291
PAPI_TOT_CYC=6976.24
PAPI_TOT_INS=340.755
garbage=932589575802458
total_execution_walltime=14.794s
REALTIME_MAIN_END_PERF_FORMAT=6979251.151853423
[time_cmd_output] time_elapsed_sec=14.98, faults_major=0, faults_minor=307600, mem_maxresident_kb=1232336, user_cputime=723.03, sys_cputime=3.84, percent_cpu=4850%
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