__step=000553
__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" ./sigouin_int_avl_kcas_validate.debra -nwork 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000553.txt
__path_data=data/data000553.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55f20f3ff400
addrof(kcasDescriptors[1])=0x55f20f3ffd00
addrof(rdcssDescriptors[0])=0x55f20f51f400
addrof(rdcssDescriptors[1])=0x55f20f51f4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6985544.441556608
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=sigouin_int_avl_kcas_validate
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=5
DEL_FRAC=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=5.0 5.0
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56
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=1000853 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000856 for expected size 1000000 keysum=1000336110540, performing 28774647 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000856
pref_millis=1102
prefill_elapsed_ms=1123
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6985545.706140950
REALTIME_END_PERF_FORMAT=6985555.706299507

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

tree_stats_computeWalltime=0.046s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65337 122785 169462 118343 30607 2045 8 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 190 7061 63044 168253 145671 39099 2552 9
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65527 129846 232506 286596 176278 41144 2560 9
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65527 129846 232506 286596 176278 41144 2560 9
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99973 1.98446 1.84501 1.50379 1.20215 1.05977 1.01252 1.00039 1

tree_stats_height=24
tree_stats_numInternals=574122
tree_stats_numLeaves=425879
tree_stats_numNodes=1000001
tree_stats_numKeys=1000001

tree_stats_avgDegreeInternal=1.74179
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42588
tree_stats_avgKeyDepth=18.2498


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:41 2:1500 4:54583 8:377050 16:46672 32:1 64:0 128:47
    [2^00, 2^01]: 41
    (2^01, 2^02]: 1500
    (2^02, 2^03]: 54583
    (2^03, 2^04]: 377050
    (2^04, 2^05]: 46672
    (2^05, 2^06]: 1
    (2^06, 2^07]: 0
    (2^07, 2^08]: 47
sum_limbo_reclamation_event_size_total=5410055
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9996 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9996 9998 9998 9997 9998 9998
count_limbo_reclamation_event_size_total=479894
sum_limbo_reclamation_event_count_total=1058491
first_thread_announced_epoch_by_thread=46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836 46836
sum_num_inserts_by_thread=491591 495794 498982 502962 499532 493277 496582 496455 502551 502138 498883 493359 493487 500334 500370 500929 497110 496119 493627 493329 498048 499638 497707 493280 495433 496682 501036 499503 497929 491544 497281 496396 504411 504725 497882 494474 497717 500517 500019 502441 498119 493575 494138 492941 499057 504087 495536 494373
sum_num_inserts_total=23885900
sum_num_deletes_by_thread=491412 494995 497334 501776 500558 492403 496677 495115 502178 502543 499109 493910 493044 501030 501210 501424 496797 495923 494651 494329 498418 500262 498061 492785 494969 496164 502523 501338 496449 491751 497153 497915 505924 504513 497386 493301 496600 501265 501698 503125 498265 494789 493589 494025 500133 504107 495155 493421
sum_num_deletes_total=23891502
sum_num_searches_by_thread=8853551 8908576 8956158 9047706 9001054 8857211 8947220 8931281 9047598 9036699 8989854 8889169 8897060 9006426 9011077 9010246 8957555 8946059 8912471 8899208 8980026 9006234 8965612 8857447 8912408 8948844 9033980 9004959 8960002 8862319 8960526 8953108 9081309 9073456 8953605 8891726 8947561 9017062 9010122 9056747 8957287 8894906 8888480 8889137 8993348 9069708 8914183 8894179
sum_num_searches_total=430084460
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9836554 9899365 9952474 10052444 10001144 9842891 9940479 9922851 10052327 10041380 9987846 9876438 9883591 10007790 10012657 10012599 9951462 9938101 9900749 9886866 9976492 10006134 9961380 9843512 9902810 9941690 10037539 10005800 9954380 9845614 9954960 9947419 10091644 10082694 9948873 9879501 9941878 10018844 10011839 10062313 9953671 9883270 9876207 9876103 9992538 10077902 9904874 9881973
average_num_operations_total=9955455
stdev_num_operations_total=10218
sum_num_operations_total=477861862
min_num_operations_total=9836554
max_num_operations_total=10091644
first_time_thread_terminate_by_thread=10000158 10000158 10000158 10000158 10000159 10000159 10000158 10000159 10000158 10000158 10000159 10000162 10000158 10000159 10000159 10000159 10000159 10000159 10000159 10000159 10000158 10000159 10000158 10000158 10000158 10000158 10000158 10000158 10000159 10000159 10000158 10000159 10000158 10000158 10000159 10000159 10000158 10000159 10000158 10000159 10000159 10000159 10000159 10000159 10000158 10000159 10000158 10000158
min_time_thread_terminate_total=10000158
max_time_thread_terminate_total=10000162
first_time_thread_start_by_thread=3 3 3 2 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=

threads_final_keysum=1000127872806
threads_final_size=1000001
final_keysum=1000127872806
final_size=1000001
validate_result=success
Validation OK.
Structural validation OK.

total_find=430084460
total_rq=0
total_inserts=23885900
total_deletes=23891502
total_updates=47777402
total_queries=430084460
total_ops=477861862
find_throughput=43008446
rq_throughput=0
update_throughput=4777740
query_throughput=43008446
total_throughput=47786186


total find                    : 430084460
total rq                      : 0
total inserts                 : 23885900
total deletes                 : 23891502
total updates                 : 47777402
total queries                 : 430084460
total ops                     : 477861862
find throughput               : 43008446
rq throughput                 : 0
update throughput             : 4777740
query throughput              : 43008446
total throughput              : 47786186

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=15.1717
PAPI_L3_TCM=2.10331
PAPI_TOT_CYC=2792.42
PAPI_TOT_INS=1235.07
garbage=210642036477776
total_execution_walltime=11.396s
REALTIME_MAIN_END_PERF_FORMAT=6985555.838838905
[time_cmd_output] time_elapsed_sec=11.52, faults_major=0, faults_minor=91231, mem_maxresident_kb=366768, user_cputime=559.74, sys_cputime=2.38, percent_cpu=4877%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1