__step=000017
__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" ./brown_sigouin_abtree_kcas_validate.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=data000017.txt
__path_data=data/data000017.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x562649140480
addrof(kcasDescriptors[1])=0x562649140c00
addrof(rdcssDescriptors[0])=0x562649230480
addrof(rdcssDescriptors[1])=0x562649230540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6978897.652132868
binary=./brown_sigouin_abtree_kcas_validate.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_sigouin_abtree_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=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.004s
prefilling_size=8906355 prefilling_elapsed_millis=1.001s
prefilling_size=9115748 prefilling_elapsed_millis=1.101s
prefilling_size=9283635 prefilling_elapsed_millis=1.201s
prefilling_size=9415519 prefilling_elapsed_millis=1.301s
prefilling_size=9526185 prefilling_elapsed_millis=1.402s
prefilling_size=9613375 prefilling_elapsed_millis=1.502s
prefilling_size=9686399 prefilling_elapsed_millis=1.602s
prefilling_size=9746242 prefilling_elapsed_millis=1.702s
prefilling_size=9793611 prefilling_elapsed_millis=1.802s
prefilling_size=9832634 prefilling_elapsed_millis=1.902s
finished prefilling to size 9832679 for expected size 10000000 keysum=98333321381259, performing 81972044 updates; total_prefilling_elapsed_ms=2004 ms)
pref_size=9832679
pref_millis=2004
prefill_elapsed_ms=2024
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6978899.846100397
REALTIME_END_PERF_FORMAT=6978909.846250001

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

tree_stats_computeWalltime=0.055s

tree_stats_numInternalsAtDepth=1 1 8 64 457 3454 26300 204798 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1613379
tree_stats_numNodesAtDepth=1 1 8 64 457 3454 26300 204798 1613379
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9867753
tree_stats_avgDegreeAtDepth=1 8 8 7.14062 7.55799 7.61436 7.787 7.8779 6.1162

tree_stats_height=9
tree_stats_numInternals=235083
tree_stats_numLeaves=1613379
tree_stats_numNodes=1848462
tree_stats_numKeys=9867753

tree_stats_avgDegreeInternal=7.86302
tree_stats_avgDegreeLeaves=6.1162
tree_stats_avgDegree=6.33836
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:7038 2:6519 4:711 8:14
    [2^00, 2^01]: 7038
    (2^01, 2^02]: 6519
    (2^02, 2^03]: 711
    (2^03, 2^04]: 14
sum_limbo_reclamation_event_size_total=23295
count_limbo_reclamation_event_size_by_thread=278 298 280 280 308 304 316 308 270 310 302 274 290 294 316 328 308 278 322 242 296 310 354 212 290 300 320 292 274 318 300 304 262 304 298 276 298 334 348 292 296 310 264 302 318 294 328 282
count_limbo_reclamation_event_size_total=14282
sum_limbo_reclamation_event_count_total=2095488
first_thread_announced_epoch_by_thread=51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232 51232
sum_commit_tx_reader_total=
sum_commit_tx_reader_by_thread=
sum_commit_tx_writer_total=
sum_commit_tx_writer_by_thread=
sum_abort_tx_total=
sum_abort_tx_by_thread=
max_ht_capacity_by_thread=

linear_histogram_of_none_tx_rdset_size_full_data=

linear_histogram_of_none_tx_wrset_size_full_data=
sum_fasthtm_commit_total=
sum_fasthtm_abort_total=
sum_htmpostfix_commit_total=
sum_htmpostfix_abort_total=
sum_htmprefix_commit_total=
sum_htmprefix_abort_total=
sum_htmprefix_abort_explicit_total=
sum_htmprefix_abort_conflict_total=
sum_htmprefix_abort_capacity_total=
sum_htmprefix_abort_nesting_total=
sum_htmprefix_abort_illegal_total=
sum_htmprefix_abort_zero_total=
sum_stmprefix_abort_total=
sum_stmprefix_commit_total=
sum_slow_commit_total=
sum_abtree_insert_repeat_total=
sum_abtree_erase_repeat_total=
sum_abtree_search_repeat_total=
sum_abtree_search_complete_total=4877287
sum_abtree_fix_weight_viol_attempt_total=26148
sum_abtree_fix_degree_viol_attempt_total=8307
sum_abtree_rebalancing_kcas_attempt_total=34455
sum_abtree_update_kcas_attempt_total=2420788
sum_abtree_internal_complex_search_while_iters_total=4877287
sum_abtree_internal_basic_search_while_iters_total=479234949
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=49803 50473 50240 50692 50558 49723 50372 50243 50914 51525 50707 50010 50871 51075 51173 51258 50272 50050 50243 50274 50403 50808 50297 49988 50121 50067 50661 50598 50467 49988 50382 50549 50637 50389 50483 50163 50190 50188 50702 51239 50536 50470 50015 49887 49885 50850 50204 49483
sum_num_inserts_total=2420126
sum_num_deletes_by_thread=49814 50052 50994 50483 50705 50640 50429 50126 50621 51212 50493 49946 50562 50386 50854 50866 50596 50366 50323 50553 50466 50892 50228 49752 50118 50470 50582 50873 50666 49962 50555 50346 50966 50701 50049 50408 50642 50372 50732 51053 50656 50153 50087 50585 50595 50764 50070 49941
sum_num_deletes_total=2422705
sum_num_searches_by_thread=9914642 9967028 10028419 10021745 10004400 9873787 9943508 9974583 10068833 10088468 9990685 9911520 9961187 10015353 10083085 10059435 9993853 9948680 9917819 9960215 10022672 10049423 9963553 9886782 9910810 9970108 10028278 10026675 10015213 9916271 9946636 9979383 10061067 10075848 9968205 9923257 9960418 9995748 10078653 10058243 10001868 9944210 9896184 9940622 10009546 10048755 9956998 9872211
sum_num_searches_total=479234882
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10014259 10067553 10129653 10122920 10105663 9974150 10044309 10074952 10170368 10191205 10091885 10011476 10062620 10116814 10185112 10161559 10094721 10049096 10018385 10061042 10123541 10151123 10064078 9986522 10011049 10070645 10129521 10128146 10116346 10016221 10047573 10080278 10162670 10176938 10068737 10023828 10061250 10096308 10180087 10160535 10103060 10044833 9996286 10041094 10110026 10150369 10057272 9971635
average_num_operations_total=10084952
stdev_num_operations_total=8717
sum_num_operations_total=484077713
min_num_operations_total=9971635
max_num_operations_total=10191205
first_time_thread_terminate_by_thread=10000151 10000151 10000151 10000151 10000151 10000150 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000150 10000151 10000150 10000151 10000151 10000150 10000150 10000151 10000151 10000150 10000151 10000151 10000151 10000151 10000151 10000150 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000151 10000150 10000151 10000150 10000151 10000151 10000150 10000150 10000151 10000151 10000150
min_time_thread_terminate_total=10000150
max_time_thread_terminate_total=10000151
first_time_thread_start_by_thread=4 3 4 4 3 4 4 3 3 3 4 3 3 3 3 3 3 3 4 3 3 4 3 4 4 3 4 4 3 4 4 3 3 3 4 3 3 3 3 3 3 3 4 3 3 4 3 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=98695391400311
threads_final_size=9867753
final_keysum=98695391400311
final_size=9867753
validate_result=success
Validation OK.
Structural validation OK.

total_find=479234882
total_rq=0
total_inserts=2420126
total_deletes=2422705
total_updates=4842831
total_queries=479234882
total_ops=484077713
find_throughput=47923488
rq_throughput=0
update_throughput=484283
query_throughput=47923488
total_throughput=48407771


total find                    : 479234882
total rq                      : 0
total inserts                 : 2420126
total deletes                 : 2422705
total updates                 : 4842831
total queries                 : 479234882
total ops                     : 484077713
find throughput               : 47923488
rq throughput                 : 0
update throughput             : 484283
query throughput              : 47923488
total throughput              : 48407771

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.1628
PAPI_L3_TCM=6.207
PAPI_TOT_CYC=2759.04
PAPI_TOT_INS=919.563
garbage=2360933050066999
total_execution_walltime=12.336s
REALTIME_MAIN_END_PERF_FORMAT=6978909.989327368
[time_cmd_output] time_elapsed_sec=12.51, faults_major=0, faults_minor=176701, mem_maxresident_kb=707328, user_cputime=608.22, sys_cputime=2.18, percent_cpu=4878%
timeout=false
algorithm=brown_sigouin_abtree_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