__step=000145
__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" ./ellen_ext_bst_lf.debra -nwork 48 -nprefill 48 -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=data000145.txt
__path_data=data/data000145.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6980573.228709126
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=ellen_ext_bst_lf
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=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 descriptor=64
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.018s
prefilling_size=999687 prefilling_elapsed_millis=1.001s
finished prefilling to size 999646 for expected size 1000000 keysum=999730264840, performing 26334189 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999646
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=1267
6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0
global_epoch_counter=0
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6980574.558887221
REALTIME_END_PERF_FORMAT=6980584.559028504
###############################################################################
################################## 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 938 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.04s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 126 248 469 845 1513 2662 4669 7919 12833 19789 28980 39682 51949 64558 75613 84123 88781 88464 84900 76941 66369 54548 43071 32559 23818 16511 10876 6926 4244 2436 1426 791 446 238 111 59 24 10 4 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 2 4 27 93 177 364 655 1419 3005 5877 10598 18278 27415 39340 53503 67103 79465 89098 92028 92859 87513 78190 66025 53583 41300 31125 22146 14826 9608 6052 3446 2061 1136 654 365 163 94 38 16 7 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 252 496 938 1690 3026 5324 9338 15838 25666 39578 57960 79364 103898 129116 151226 168246 177562 176928 169800 153882 132738 109096 86142 65118 47636 33022 21752 13852 8488 4872 2852 1582 892 476 222 118 48 20 8 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 2 4 27 93 177 364 655 1419 3005 5877 10598 18278 27415 39340 53503 67103 79465 89098 92028 92859 87513 78190 66025 53583 41300 31125 22146 14826 9608 6052 3446 2061 1136 654 365 163 94 38 16 7 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 1.98438 1.98413 1.94556 1.90085 1.89527 1.87971 1.87697 1.84804 1.81027 1.77102 1.73222 1.68464 1.65457 1.62136 1.58562 1.55627 1.52769 1.49821 1.47986 1.45313 1.4313 1.41094 1.3948 1.37797 1.36577 1.34661 1.32936 1.31841 1.30638 1.28699 1.29269 1.27735 1.28192 1.26682 1.23319 1.26577 1.20339 1.20833 1.2 1.125 1
tree_stats_height=50
tree_stats_numInternals=999661
tree_stats_numLeaves=999662
tree_stats_numNodes=1999323
tree_stats_numKeys=999660
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999998
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=27.7262
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10080 19840 37520 67600 121040 212960 373520 633520 1026640 1583120 2318400 3174560 4155920 5164640 6049040 6729840 7102480 7077120 6792000 6155280 5309520 4363840 3445680 2604720 1905440 1320880 870080 554080 339520 194880 114080 63280 35680 19040 8880 4720 1920 800 320 80
tree_stats_sizeInBytes=79972920
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=18644
6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0
global_epoch_counter=0
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:83360 2:194778 4:138324 8:15115 16:23
[2^00, 2^01]: 83360
(2^01, 2^02]: 194778
(2^02, 2^03]: 138324
(2^03, 2^04]: 15115
(2^04, 2^05]: 23
sum_limbo_reclamation_event_size_total=1372711
count_limbo_reclamation_event_size_by_thread=8946 8996 8962 9044 8992 8930 8972 9030 8952 9068 8934 8936 8914 8934 9024 9038 9048 8978 8986 8986 8980 9052 8928 8912 8950 8934 8962 9006 9054 8998 8944 9070 8966 9110 9030 9056 9068 8958 9048 9012 8968 9006 8940 8956 9056 9034 8956 8976
count_limbo_reclamation_event_size_total=431600
sum_limbo_reclamation_event_count_total=1668192
first_thread_announced_epoch_by_thread=37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288 37288
sum_num_inserts_by_thread=39540 39831 40174 39845 39752 39586 39603 39697 40021 40529 39982 39490 39652 39776 40584 40112 39728 39857 39611 39181 39876 40115 39821 39145 39082 39547 40173 40101 39639 39462 39462 39939 39875 40367 40241 39979 39504 39775 40188 40114 39911 39647 39330 39933 40109 40236 39504 39806
sum_num_inserts_total=1911432
sum_num_deletes_by_thread=39307 39542 39942 39889 39805 39440 39601 40065 40107 39996 40162 39428 39772 39809 40144 39899 39832 39803 39415 39747 40031 40011 39710 39547 39555 39806 40028 40213 40137 39451 39965 39695 40439 40051 40017 39752 39798 39991 40199 40171 39669 39768 39410 39773 39956 40074 39740 39288
sum_num_deletes_total=1911950
sum_num_searches_by_thread=7821806 7852151 7936042 7936499 7898469 7808517 7837621 7889558 7958579 7986272 7893636 7857786 7873854 7905262 7960458 7964560 7914745 7863418 7809741 7864166 7915582 7957803 7853159 7790627 7792804 7849401 7928550 7940654 7909745 7818143 7853862 7898273 7979540 7989885 7900867 7859862 7850731 7904360 7973695 7974934 7914837 7862461 7802754 7855629 7925332 7955392 7871306 7811575
sum_num_searches_total=378774903
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=7900653 7931524 8016158 8016233 7978026 7887543 7916825 7969320 8038707 8066797 7973780 7936704 7953278 7984847 8041186 8044571 7994305 7943078 7888767 7943094 7995489 8037929 7932690 7869319 7871441 7928754 8008751 8020968 7989521 7897056 7933289 7977907 8059854 8070303 7981125 7939593 7930033 7984126 8054082 8055219 7994417 7941876 7881494 7935335 8005397 8035702 7950550 7890669
average_num_operations_total=7970797
stdev_num_operations_total=8311
sum_num_operations_total=382598285
min_num_operations_total=7869319
max_num_operations_total=8070303
first_time_thread_terminate_by_thread=10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141 10000141
min_time_thread_terminate_total=10000141
max_time_thread_terminate_total=10000141
first_time_thread_start_by_thread=3 4 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 4 3 3 3 4 4 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 4 3 3 3 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=1000212109030
threads_final_size=999660
final_keysum=1000212109030
final_size=999660
validate_result=success
Validation OK.
Structural validation OK.
total_find=378774903
total_rq=0
total_inserts=1911432
total_deletes=1911950
total_updates=3823382
total_queries=378774903
total_ops=382598285
find_throughput=37877490
rq_throughput=0
update_throughput=382338
query_throughput=37877490
total_throughput=38259828
total find : 378774903
total rq : 0
total inserts : 1911432
total deletes : 1911950
total updates : 3823382
total queries : 378774903
total ops : 382598285
find throughput : 37877490
rq throughput : 0
update throughput : 382338
query throughput : 37877490
total throughput : 38259828
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=21.4557
PAPI_L3_TCM=4.24394
PAPI_TOT_CYC=3496.76
PAPI_TOT_INS=341.52
garbage=189412215193488
total_execution_walltime=11.452s
REALTIME_MAIN_END_PERF_FORMAT=6980584.682514851
[time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=101911, mem_maxresident_kb=409648, user_cputime=558.74, sys_cputime=1.62, percent_cpu=4837%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1