__step=000409
__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_bst_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 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000409.txt
__path_data=data/data000409.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55ca8fc47400
addrof(kcasDescriptors[1])=0x55ca8fc47d00
addrof(rdcssDescriptors[0])=0x55ca8fd67400
addrof(rdcssDescriptors[1])=0x55ca8fd674c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6983784.428923546
binary=./sigouin_int_bst_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_bst_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=20000000
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.006s
prefilling_size=6956976 prefilling_elapsed_millis=1.001s
prefilling_size=7249162 prefilling_elapsed_millis=1.101s
prefilling_size=7510429 prefilling_elapsed_millis=1.201s
prefilling_size=7746071 prefilling_elapsed_millis=1.301s
prefilling_size=7956276 prefilling_elapsed_millis=1.402s
prefilling_size=8144847 prefilling_elapsed_millis=1.502s
prefilling_size=8317826 prefilling_elapsed_millis=1.602s
prefilling_size=8472019 prefilling_elapsed_millis=1.702s
prefilling_size=8612336 prefilling_elapsed_millis=1.802s
prefilling_size=8737655 prefilling_elapsed_millis=1.903s
prefilling_size=8851608 prefilling_elapsed_millis=2.003s
prefilling_size=8955254 prefilling_elapsed_millis=2.103s
prefilling_size=9050258 prefilling_elapsed_millis=2.203s
prefilling_size=9135321 prefilling_elapsed_millis=2.303s
prefilling_size=9213243 prefilling_elapsed_millis=2.404s
prefilling_size=9284130 prefilling_elapsed_millis=2.504s
prefilling_size=9346270 prefilling_elapsed_millis=2.604s
prefilling_size=9403746 prefilling_elapsed_millis=2.704s
prefilling_size=9453989 prefilling_elapsed_millis=2.804s
prefilling_size=9503065 prefilling_elapsed_millis=2.904s
prefilling_size=9546219 prefilling_elapsed_millis=3.005s
prefilling_size=9585805 prefilling_elapsed_millis=3.105s
prefilling_size=9622087 prefilling_elapsed_millis=3.205s
prefilling_size=9655670 prefilling_elapsed_millis=3.305s
prefilling_size=9686883 prefilling_elapsed_millis=3.405s
prefilling_size=9713923 prefilling_elapsed_millis=3.506s
prefilling_size=9738762 prefilling_elapsed_millis=3.606s
prefilling_size=9760519 prefilling_elapsed_millis=3.706s
prefilling_size=9781264 prefilling_elapsed_millis=3.806s
prefilling_size=9798662 prefilling_elapsed_millis=3.906s
prefilling_size=9816309 prefilling_elapsed_millis=4.007s
finished prefilling to size 9816365 for expected size 10000000 keysum=98165712809607, performing 84675992 updates; total_prefilling_elapsed_ms=4108 ms)
pref_size=9816365
pref_millis=4108
prefill_elapsed_ms=4134
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983788.730099977
REALTIME_END_PERF_FORMAT=6983798.730234153

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

tree_stats_computeWalltime=0.106s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 255 507 1004 1952 3709 6894 12448 21724 36506 58723 90142 132065 184916 246659 313686 381171 441857 489927 519242 525648 510436 475443 426276 368758 308598 249199 195696 149423 110862 79759 56126 38540 25245 16304 10079 6277 3776 2146 1198 651 342 130 59 21 11 4 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 3 5 31 108 282 744 1692 3844 7805 14960 26127 42881 66392 96381 131916 170634 209497 243828 271328 285453 286985 275923 253459 224579 192212 157903 126293 97920 74093 53750 38092 27023 17644 11625 7103 4505 2836 1589 873 489 279 97 47 16 10 3 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1009 1983 3817 7176 13192 23416 40350 66528 105102 158192 227797 313051 410067 513087 612491 699424 763070 796976 795889 762428 702199 622217 533177 441411 353599 275716 208782 153852 109876 76632 52268 33948 21704 13380 8281 4982 2787 1524 831 409 156 68 27 14 4 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 510 1009 1983 3817 7176 13192 23416 40350 66528 105102 158192 227797 313051 410067 513087 612491 699424 763070 796976 795889 762428 702199 622217 533177 441411 353599 275716 208782 153852 109876 76632 52268 33948 21704 13380 8281 4982 2787 1524 831 409 156 68 27 14 4 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.98431 1.97027 1.94049 1.9083 1.87765 1.83141 1.79544 1.74404 1.69714 1.64747 1.60516 1.5625 1.52199 1.48626 1.45084 1.42052 1.39053 1.36397 1.33908 1.31662 1.29741 1.27904 1.26425 1.2491 1.23651 1.2263 1.21529 1.20591 1.19575 1.18663 1.17914 1.16651 1.15907 1.15209 1.14978 1.14563 1.12866 1.11697 1.11811 1.08063 1.06357 1.05769 1.08824 1.11111 1 1.25 1

tree_stats_height=56
tree_stats_numInternals=6504650
tree_stats_numLeaves=3429262
tree_stats_numNodes=9933912
tree_stats_numKeys=9933912

tree_stats_avgDegreeInternal=1.5272
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34521
tree_stats_avgKeyDepth=27.8984


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:59 2:1633 4:55504 8:371093 16:51531 32:32 64:47
    [2^00, 2^01]: 59
    (2^01, 2^02]: 1633
    (2^02, 2^03]: 55504
    (2^03, 2^04]: 371093
    (2^04, 2^05]: 51531
    (2^05, 2^06]: 32
    (2^06, 2^07]: 47
sum_limbo_reclamation_event_size_total=5435927
count_limbo_reclamation_event_size_by_thread=9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9997 9997 9998
count_limbo_reclamation_event_size_total=479899
sum_limbo_reclamation_event_count_total=508272
first_thread_announced_epoch_by_thread=28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908 28908
sum_num_inserts_by_thread=240616 241343 242880 244972 244113 239351 239464 241207 243620 243171 242985 239831 242181 244484 243849 242484 244951 240634 238703 240978 245098 244796 241039 240997 240057 241452 243874 245035 244231 239014 240918 243836 243748 244088 241584 242551 242950 242406 245869 244947 241161 240742 241399 240602 244902 245737 240709 238054
sum_num_inserts_total=11633613
sum_num_deletes_by_thread=242346 241919 242285 245008 244093 239423 238951 239995 243746 243728 242544 239432 243099 244400 244659 244872 244013 240322 239904 240396 244344 244899 240455 240309 240450 242244 242575 245124 244324 239471 239575 243776 244099 243932 240458 242122 243533 242366 245048 245674 242227 240502 241127 240135 244272 245547 241037 239159
sum_num_deletes_total=11633919
sum_num_searches_by_thread=4354242 4337209 4370638 4408222 4391211 4309384 4323295 4340719 4383334 4387812 4379368 4322794 4378223 4395852 4385291 4385970 4394725 4327364 4310188 4332464 4398477 4414228 4328769 4328899 4322078 4341022 4372620 4407842 4388602 4311426 4327846 4386865 4390070 4390973 4341617 4358047 4377430 4358967 4424128 4425572 4354685 4329726 4348946 4325430 4397740 4418234 4328475 4298383
sum_num_searches_total=209415402
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4837204 4820471 4855803 4898202 4879417 4788158 4801710 4821921 4870700 4874711 4864897 4802057 4863503 4884736 4873799 4873326 4883689 4808320 4788795 4813838 4887919 4903923 4810263 4810205 4802585 4824718 4859069 4898001 4877157 4789911 4808339 4874477 4877917 4878993 4823659 4842720 4863913 4843739 4915045 4916193 4838073 4810970 4831472 4806167 4886914 4909518 4810221 4775596
average_num_operations_total=4847561
stdev_num_operations_total=5690
sum_num_operations_total=232682934
min_num_operations_total=4775596
max_num_operations_total=4916193
first_time_thread_terminate_by_thread=10000134 10000134 10000135 10000134 10000134 10000133 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000135 10000134 10000134 10000133 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134 10000134
min_time_thread_terminate_total=10000133
max_time_thread_terminate_total=10000135
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 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=99341005002625
threads_final_size=9933912
final_keysum=99341005002625
final_size=9933912
validate_result=success
Validation OK.
Structural validation OK.

total_find=209415402
total_rq=0
total_inserts=11633613
total_deletes=11633919
total_updates=23267532
total_queries=209415402
total_ops=232682934
find_throughput=20941540
rq_throughput=0
update_throughput=2326753
query_throughput=20941540
total_throughput=23268293


total find                    : 209415402
total rq                      : 0
total inserts                 : 11633613
total deletes                 : 11633919
total updates                 : 23267532
total queries                 : 209415402
total ops                     : 232682934
find throughput               : 20941540
rq throughput                 : 0
update throughput             : 2326753
query throughput              : 20941540
total throughput              : 23268293

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=30.8905
PAPI_L3_TCM=9.83858
PAPI_TOT_CYC=5751.48
PAPI_TOT_INS=1507.02
garbage=1036076034038469
total_execution_walltime=14.514s
REALTIME_MAIN_END_PERF_FORMAT=6983798.944734432
[time_cmd_output] time_elapsed_sec=14.69, faults_major=0, faults_minor=235194, mem_maxresident_kb=943044, user_cputime=707.54, sys_cputime=2.21, percent_cpu=4829%
timeout=false
algorithm=sigouin_int_bst_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