__step=000148
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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_htm.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000148.txt
__path_data=data/data000148.txt
__hostname=jax
sizeof(kcasdesc_t)=1920
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x56067e0d7480
addrof(kcasDescriptors[1])=0x56067e0d7c00
addrof(rdcssDescriptors[0])=0x56067e1c7480
addrof(rdcssDescriptors[1])=0x56067e1c7540
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996158.585070426
binary=./brown_sigouin_abtree_kcas_validate_htm.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_htm
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=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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=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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.013s
prefilling_size=9751676 prefilling_elapsed_millis=1.001s
prefilling_size=9829050 prefilling_elapsed_millis=1.101s
finished prefilling to size 9829049 for expected size 10000000 keysum=98274568823785, performing 91095069 updates; total_prefilling_elapsed_ms=1203 ms)
pref_size=9829049
pref_millis=1203
prefill_elapsed_ms=1236
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996160.20807965
REALTIME_END_PERF_FORMAT=6996170.20943404

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

tree_stats_computeWalltime=0.062s

tree_stats_numInternalsAtDepth=1 1 8 72 534 4015 30053 234901 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1839478
tree_stats_numNodesAtDepth=1 1 8 72 534 4015 30053 234901 1839478
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9994929
tree_stats_avgDegreeAtDepth=1 8 9 7.41667 7.51873 7.48518 7.81622 7.83086 5.43357

tree_stats_height=9
tree_stats_numInternals=269585
tree_stats_numLeaves=1839478
tree_stats_numNodes=2109063
tree_stats_numKeys=9994929

tree_stats_avgDegreeInternal=7.82337
tree_stats_avgDegreeLeaves=5.43357
tree_stats_avgDegree=5.73904
tree_stats_avgKeyDepth=8


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:151692 2:201479 4:46631 8:1812 16:4
    [2^00, 2^01]: 151692
    (2^01, 2^02]: 201479
    (2^02, 2^03]: 46631
    (2^03, 2^04]: 1812
    (2^04, 2^05]: 4
sum_limbo_reclamation_event_size_total=818592
count_limbo_reclamation_event_size_by_thread=4304 4350 4100 4382 4106 3980 4080 4336 4390 4128 3998 4464 4004 4358 4040 4016 3966 4436 4032 4264 4056 4310 4002 3922 3980 4092 4004 4488 4438 3968 4114 4026 4528 4488 4028 4030 3808 4388 4184 4198 3944 4436 3938 4370 4474 4192 4066 4076 3936 3934 4088 4378 4066 4298 4484 4300 4306 4150 4434 4340 4078 4090 4020 4092 3850 4482 4430 4362 4168 4096 4172 4526 4098 4094 4068 4042 4332 4502 3990 4250 4080 4536 3958 4362 3930 4028 4388 4082 4026 4312 3984 4294 4156 4096 4196 4452
count_limbo_reclamation_event_size_total=401618
sum_limbo_reclamation_event_count_total=2118144
first_thread_announced_epoch_by_thread=24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158 24158
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=217
sum_abtree_erase_repeat_total=29
sum_abtree_search_repeat_total=1
sum_abtree_search_complete_total=98979905
sum_abtree_fix_weight_viol_attempt_total=284346
sum_abtree_fix_degree_viol_attempt_total=334093
sum_abtree_rebalancing_kcas_attempt_total=618427
sum_abtree_update_kcas_attempt_total=49181602
sum_abtree_internal_complex_search_while_iters_total=98979911
sum_abtree_internal_basic_search_while_iters_total=885264984
sum_kcas_desc_new_total=
sum_num_inserts_by_thread=506108 509813 511954 510907 511183 503285 508773 512083 511805 514834 512446 509276 505315 512373 516027 517717 510825 502408 507590 511194 510960 514241 510606 504289 503661 507144 513646 515448 509849 505713 508885 511208 512567 517288 510792 511179 506673 510045 516663 518777 513671 508436 505723 509591 509292 513306 508403 507331 507905 515949 521397 517038 512617 509918 513741 512271 515846 518005 515199 508940 504777 515284 519316 519182 514530 509256 510700 512294 517537 516652 514848 510546 512907 517193 522580 517054 510663 507198 515243 515563 515757 516011 517864 512645 511124 513924 520562 516954 514680 507314 509116 510738 517879 516418 518550 510292
sum_num_inserts_total=49183280
sum_num_deletes_by_thread=505904 507923 512406 508305 509998 504247 509258 512447 512354 517211 512162 508704 504861 512806 516456 517276 511271 502364 506209 510669 510509 511636 509087 504691 503004 507474 515108 515704 510465 507584 509219 512707 512420 514983 509574 510877 505753 510386 516398 518957 514272 508930 504694 509709 507111 514305 509807 507305 508439 515634 520879 517528 513557 510189 515121 512094 517677 516113 515171 509136 505922 515277 519696 519346 513690 508088 510642 511900 518789 516170 516872 510377 512398 515484 521181 517986 509423 508069 514175 512899 516224 515297 516693 512653 510366 513598 520657 517010 515010 507018 509984 512290 518240 517816 517765 511819
sum_num_deletes_total=49177862
sum_num_searches_by_thread=9101472 9154737 9225233 9187847 9172751 9069446 9186036 9214999 9212233 9289054 9215762 9160724 9086559 9220312 9302399 9311813 9188376 9025378 9134889 9202160 9191159 9232234 9161685 9090173 9071288 9129817 9265301 9279432 9180947 9124953 9179452 9220747 9237514 9282456 9191009 9199056 9107664 9201062 9299828 9340702 9242639 9138875 9096984 9173069 9138048 9243147 9168105 9116188 9136892 9286387 9363533 9310918 9244361 9179467 9252593 9228034 9287516 9313360 9268620 9165073 9095506 9276667 9341617 9331383 9257834 9176374 9177439 9218662 9328403 9300148 9291931 9185260 9231008 9300698 9393572 9328343 9198238 9149428 9257094 9262720 9275290 9288083 9316547 9223268 9193264 9255982 9358070 9320672 9271368 9136007 9160942 9198905 9326047 9315593 9335742 9182491
sum_num_searches_total=885263064
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10113484 10172473 10249593 10207059 10193932 10076978 10204067 10239529 10236392 10321099 10240370 10178704 10096735 10245491 10334882 10346806 10210472 10030150 10148688 10224023 10212628 10258111 10181378 10099153 10077953 10144435 10294055 10310584 10201261 10138250 10197556 10244662 10262501 10314727 10211375 10221112 10120090 10221493 10332889 10378436 10270582 10156241 10107401 10192369 10154451 10270758 10186315 10130824 10153236 10317970 10405809 10345484 10270535 10199574 10281455 10252399 10321039 10347478 10298990 10183149 10106205 10307228 10380629 10369911 10286054 10193718 10198781 10242856 10364729 10332970 10323651 10206183 10256313 10333375 10437333 10363383 10218324 10164695 10286512 10291182 10307271 10319391 10351104 10248566 10214754 10283504 10399289 10354636 10301058 10150339 10180042 10221933 10362166 10349827 10372057 10204602
average_num_operations_total=10246085
stdev_num_operations_total=8891
sum_num_operations_total=983624206
min_num_operations_total=10030150
max_num_operations_total=10437333
first_time_thread_terminate_by_thread=10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000137 10000136 10000136 10000137 10000137 10000136 10000137 10000136 10000137 10000136 10000136 10000136 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137 10000137 10000137 10000137 10000137 10000136 10000136 10000137 10000137 10000136 10000137 10000136 10000137 10000136 10000136 10000136 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000137 10000137
min_time_thread_terminate_total=10000136
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=5 4 5 4 5 4 4 5 5 4 4 5 5 5 5 4 4 5 5 4 5 5 5 5 5 4 5 4 5 4 4 5 5 4 4 5 5 5 5 4 4 5 5 4 5 5 5 5 4 5 5 4 4 4 5 4 5 4 5 5 4 4 4 4 5 5 4 5 4 4 5 4 4 5 5 4 4 4 5 4 5 4 5 5 4 4 4 4 4 5 4 5 4 4 5 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=99936845011561
threads_final_size=9994929
final_keysum=99936845011561
final_size=9994929
validate_result=success
Validation OK.
Structural validation OK.

total_find=885263064
total_rq=0
total_inserts=49183280
total_deletes=49177862
total_updates=98361142
total_queries=885263064
total_ops=983624206
find_throughput=88526306
rq_throughput=0
update_throughput=9836114
query_throughput=88526306
total_throughput=98362420


total find                    : 885263064
total rq                      : 0
total inserts                 : 49183280
total deletes                 : 49177862
total updates                 : 98361142
total queries                 : 885263064
total ops                     : 983624206
find throughput               : 88526306
rq throughput                 : 0
update throughput             : 9836114
query throughput              : 88526306
total throughput              : 98362420

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=18.9123
PAPI_L3_TCM=6.80272
PAPI_TOT_CYC=2699.73
PAPI_TOT_INS=949.398
garbage=4410999433784428
total_execution_walltime=11.599s
REALTIME_MAIN_END_PERF_FORMAT=6996170.199824786
[time_cmd_output] time_elapsed_sec=11.76, faults_major=0, faults_minor=193902, mem_maxresident_kb=770924, user_cputime=1108.20, sys_cputime=2.50, percent_cpu=9439%
timeout=false
algorithm=brown_sigouin_abtree_kcas_validate_htm.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2