__step=000937
__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 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000937.txt
__path_data=data/data000937.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990237.400486702
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=200000
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.013s
prefilling_size=99948 prefilling_elapsed_millis=1.001s
finished prefilling to size 99906 for expected size 100000 keysum=10008252123, performing 66147638 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99906
pref_millis=1102
prefill_elapsed_ms=1119
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=3287

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6990238.666166406
REALTIME_END_PERF_FORMAT=6990248.666313497

###############################################################################
################################## 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 976 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 128 256 488 866 1436 2167 3081 4368 5839 7234 8592 9698 10177 10178 9270 7840 5939 4240 3002 2011 1275 797 471 251 134 43 14 3 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 24 110 296 705 1253 1794 2897 4444 5876 7486 9219 10176 11086 10700 9741 7638 5478 3993 2747 1753 1123 691 368 225 72 25 4 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 976 1732 2872 4334 6162 8736 11678 14468 17184 19396 20354 20356 18540 15680 11878 8480 6004 4022 2550 1594 942 502 268 86 28 6 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 24 110 296 705 1252 1794 2897 4444 5876 7486 9219 10176 11086 10700 9741 7638 5478 3993 2747 1753 1123 691 368 225 72 25 4 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 1.95312 1.8873 1.8291 1.75453 1.71066 1.70886 1.66838 1.61946 1.59386 1.56436 1.5247 1.50005 1.45539 1.42287 1.37876 1.35696 1.35401 1.33494 1.31701 1.31255 1.29548 1.26645 1.26693 1.16045 1.16279 1.10714 1.33333 1

tree_stats_height=37
tree_stats_numInternals=99927
tree_stats_numLeaves=99928
tree_stats_numNodes=199855
tree_stats_numKeys=99927

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99999
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.9883

tree_stats_bytesAtDepth=40 80 160 320 640 1280 2560 5120 10240 20480 39040 69280 114880 173360 246480 349440 467120 578720 687360 775840 814160 814240 741600 627200 475120 339200 240160 160880 102000 63760 37680 20080 10720 3440 1120 240 160
tree_stats_sizeInBytes=7994200

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


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:38 4:4 8:4 16:11 32:19 64:886 128:469971 256:8748 512:15 1024:94
    (2^01, 2^02]: 38
    (2^02, 2^03]: 4
    (2^03, 2^04]: 4
    (2^04, 2^05]: 11
    (2^05, 2^06]: 19
    (2^06, 2^07]: 886
    (2^07, 2^08]: 469971
    (2^08, 2^09]: 8748
    (2^09, 2^10]: 15
    (2^10, 2^11]: 94
sum_limbo_reclamation_event_size_total=100157350
count_limbo_reclamation_event_size_by_thread=9994 9995 9996 9996 9994 9994 9996 9994 9995 9994 9997 9998 9995 9995 9996 9997 9995 9996 9996 9995 9994 9995 9995 9995 9995 9997 9996 9996 9996 9996 9997 9996 9995 9995 9997 9995 9996 9996 9996 9996 9997 9996 9996 9996 9996 9996 9996 9995
count_limbo_reclamation_event_size_total=479790
sum_limbo_reclamation_event_count_total=1518105
first_thread_announced_epoch_by_thread=69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836 69836
sum_num_inserts_by_thread=6523225 6567036 6634059 6627732 6578779 6510287 6550361 6600430 6670327 6698720 6599377 6568150 6563099 6595448 6649237 6668492 6645121 6583932 6520630 6581789 6628395 6653120 6563644 6513949 6517630 6561008 6634130 6636071 6606421 6535224 6549346 6601735 6654923 6684202 6610066 6563051 6548860 6603804 6647985 6664084 6627004 6574517 6527069 6582400 6637657 6664325 6558319 6508575
sum_num_inserts_total=316593745
sum_num_deletes_by_thread=6527051 6570265 6642329 6628369 6581956 6509186 6549875 6602208 6675994 6700600 6594445 6567775 6560702 6597067 6643948 6664109 6639232 6575051 6520419 6580869 6624260 6654988 6562412 6516520 6521956 6562226 6636580 6643533 6604043 6534147 6549078 6595251 6654994 6680638 6610627 6567909 6548149 6597120 6640146 6670992 6621783 6573632 6528789 6578928 6635383 6665433 6558944 6512078
sum_num_deletes_total=316581989
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=13050276 13137301 13276388 13256101 13160735 13019473 13100236 13202638 13346321 13399320 13193822 13135925 13123801 13192515 13293185 13332601 13284353 13158983 13041049 13162658 13252655 13308108 13126056 13030469 13039586 13123234 13270710 13279604 13210464 13069371 13098424 13196986 13309917 13364840 13220693 13130960 13097009 13200924 13288131 13335076 13248787 13148149 13055858 13161328 13273040 13329758 13117263 13020653
average_num_operations_total=13191161
stdev_num_operations_total=15003
sum_num_operations_total=633175734
min_num_operations_total=13019473
max_num_operations_total=13399320
first_time_thread_terminate_by_thread=10000147 10000148 10000148 10000147 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000147 10000146 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000146 10000147 10000148 10000148 10000146 10000146 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000146 10000147 10000148 10000147 10000147 10000147 10000147 10000147 10000147 10000148 10000147 10000146
min_time_thread_terminate_total=10000146
max_time_thread_terminate_total=10000148
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
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=10005589848
threads_final_size=99927
final_keysum=10005589848
final_size=99927
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=316593745
total_deletes=316581989
total_updates=633175734
total_queries=0
total_ops=633175734
find_throughput=0
rq_throughput=0
update_throughput=63317573
query_throughput=0
total_throughput=63317573


total find                    : 0
total rq                      : 0
total inserts                 : 316593745
total deletes                 : 316581989
total updates                 : 633175734
total queries                 : 0
total ops                     : 633175734
find throughput               : 0
rq throughput                 : 0
update throughput             : 63317573
query throughput              : 0
total throughput              : 63317573

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=17.0282
PAPI_L3_TCM=0.00110577
PAPI_TOT_CYC=2094.34
PAPI_TOT_INS=658.348
garbage=0
total_execution_walltime=11.402s
REALTIME_MAIN_END_PERF_FORMAT=6990248.803458511
[time_cmd_output] time_elapsed_sec=11.52, faults_major=0, faults_minor=78087, mem_maxresident_kb=314276, user_cputime=560.96, sys_cputime=3.53, percent_cpu=4898%
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