__step=000169
__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" ./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=data000169.txt
__path_data=data/data000169.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55fd30aa6400
addrof(kcasDescriptors[1])=0x55fd30aa6d00
addrof(rdcssDescriptors[0])=0x55fd30bc6400
addrof(rdcssDescriptors[1])=0x55fd30bc64c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996425.400133157
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=6960265 prefilling_elapsed_millis=1.001s
prefilling_size=7249997 prefilling_elapsed_millis=1.101s
prefilling_size=7510692 prefilling_elapsed_millis=1.201s
prefilling_size=7744743 prefilling_elapsed_millis=1.301s
prefilling_size=7955869 prefilling_elapsed_millis=1.402s
prefilling_size=8144517 prefilling_elapsed_millis=1.502s
prefilling_size=8316389 prefilling_elapsed_millis=1.602s
prefilling_size=8470911 prefilling_elapsed_millis=1.702s
prefilling_size=8609882 prefilling_elapsed_millis=1.802s
prefilling_size=8736621 prefilling_elapsed_millis=1.903s
prefilling_size=8850632 prefilling_elapsed_millis=2.003s
prefilling_size=8954422 prefilling_elapsed_millis=2.103s
prefilling_size=9047580 prefilling_elapsed_millis=2.203s
prefilling_size=9133689 prefilling_elapsed_millis=2.303s
prefilling_size=9210985 prefilling_elapsed_millis=2.404s
prefilling_size=9280489 prefilling_elapsed_millis=2.504s
prefilling_size=9343808 prefilling_elapsed_millis=2.604s
prefilling_size=9403458 prefilling_elapsed_millis=2.704s
prefilling_size=9456263 prefilling_elapsed_millis=2.804s
prefilling_size=9503146 prefilling_elapsed_millis=2.905s
prefilling_size=9546344 prefilling_elapsed_millis=3.005s
prefilling_size=9585804 prefilling_elapsed_millis=3.105s
prefilling_size=9621037 prefilling_elapsed_millis=3.205s
prefilling_size=9652638 prefilling_elapsed_millis=3.305s
prefilling_size=9683060 prefilling_elapsed_millis=3.406s
prefilling_size=9712334 prefilling_elapsed_millis=3.506s
prefilling_size=9737235 prefilling_elapsed_millis=3.606s
prefilling_size=9759853 prefilling_elapsed_millis=3.706s
prefilling_size=9780133 prefilling_elapsed_millis=3.806s
prefilling_size=9797779 prefilling_elapsed_millis=3.907s
prefilling_size=9815789 prefilling_elapsed_millis=4.007s
finished prefilling to size 9815796 for expected size 10000000 keysum=98177064287334, performing 84635523 updates; total_prefilling_elapsed_ms=4108 ms)
pref_size=9815796
pref_millis=4108
prefill_elapsed_ms=4132
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6996429.714031248
REALTIME_END_PERF_FORMAT=6996439.714168930
###############################################################################
################################## 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 1002 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.084s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 505 995 1928 3658 6820 12244 21342 35759 57656 89266 131969 185782 249163 317840 386018 447219 494537 522796 529130 514249 480497 432646 373656 311627 250532 193812 144428 105224 73807 49857 32593 20540 12594 7409 4110 2172 1091 536 260 106 44 22 6 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 5 7 29 111 282 748 1756 3785 7611 14094 25210 42200 65727 96857 133766 173064 212605 247146 272572 286892 288404 277102 257968 228295 194037 160028 126733 95452 71034 50834 34762 23148 14702 9143 5564 3142 1668 861 417 220 80 35 18 5 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 1002 1957 3769 7102 12992 23098 39544 65267 103360 157179 227982 314890 414697 519784 620283 707142 769942 801702 801141 768901 709748 631624 539922 444569 353840 271161 200676 144841 100691 67355 43688 27296 16552 9674 5314 2759 1397 677 326 124 57 24 6 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 510 1002 1957 3769 7102 12992 23098 39544 65267 103360 157179 227982 314890 414697 519784 620283 707142 769942 801702 801141 768901 709748 631624 539922 444569 353840 271161 200676 144841 100691 67355 43688 27296 16552 9674 5314 2759 1397 677 326 124 57 24 6 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99219 1.97451 1.96008 1.94073 1.91377 1.86905 1.83544 1.78803 1.74621 1.70026 1.65705 1.61085 1.56631 1.52569 1.48697 1.4507 1.41904 1.38946 1.36224 1.33929 1.31786 1.29815 1.28035 1.26324 1.24622 1.23238 1.2186 1.20743 1.19742 1.18561 1.17378 1.16472 1.15464 1.145 1.13684 1.12446 1.11046 1.11091 1.10093 1.09749 1.05521 1.10484 1.03509 1 1 1
tree_stats_height=54
tree_stats_numInternals=6506957
tree_stats_numLeaves=3428120
tree_stats_numNodes=9935077
tree_stats_numKeys=9935077
tree_stats_avgDegreeInternal=1.52684
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34505
tree_stats_avgKeyDepth=27.8148
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:67 2:1647 4:55932 8:370922 16:51330
[2^00, 2^01]: 67
(2^01, 2^02]: 1647
(2^02, 2^03]: 55932
(2^03, 2^04]: 370922
(2^04, 2^05]: 51330
sum_limbo_reclamation_event_size_total=5429750
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9997 9998 9997 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479898
sum_limbo_reclamation_event_count_total=509136
first_thread_announced_epoch_by_thread=28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938 28938
sum_num_inserts_by_thread=240088 243746 245282 244260 242565 239418 242622 241279 244035 243578 241081 242908 241396 242676 245305 245861 241715 240063 242239 242557 242305 245676 240795 239590 241397 240618 245239 242426 241662 239555 243331 244288 243405 245588 241162 242537 240988 242257 244652 246097 243876 240351 238937 242583 243971 243432 243409 239284
sum_num_inserts_total=11642085
sum_num_deletes_by_thread=239508 243291 244720 245554 241677 239508 242302 241110 243745 243353 241903 242776 241960 244172 245246 245700 241894 240477 241992 242370 242212 245557 240642 237687 240812 241775 244684 242546 242270 239095 243531 243888 244074 246264 241519 242698 241512 242222 243267 245712 244926 240996 240647 242243 244614 242910 242868 239473
sum_num_deletes_total=11643902
sum_num_searches_by_thread=4323338 4383042 4407506 4409036 4352677 4311966 4368296 4345843 4391095 4398184 4345393 4362718 4342368 4361337 4425669 4421361 4359377 4328292 4352769 4372750 4360100 4416803 4335886 4302262 4323484 4343651 4413502 4374203 4354438 4312593 4372700 4388854 4393808 4426035 4345132 4358642 4343773 4359208 4391260 4427713 4403202 4331227 4313646 4372156 4396907 4377585 4373665 4303054
sum_num_searches_total=209578506
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4802934 4870079 4897508 4898850 4836919 4790892 4853220 4828232 4878875 4885115 4828377 4848402 4825724 4848185 4916220 4912922 4842986 4808832 4837000 4857677 4844617 4908036 4817323 4779539 4805693 4826044 4903425 4859175 4838370 4791243 4859562 4877030 4881287 4917887 4827813 4843877 4826273 4843687 4879179 4919522 4892004 4812574 4793230 4856982 4885492 4863927 4859942 4781811
average_num_operations_total=4851343
stdev_num_operations_total=5594
sum_num_operations_total=232864493
min_num_operations_total=4779539
max_num_operations_total=4919522
first_time_thread_terminate_by_thread=10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138 10000138
min_time_thread_terminate_total=10000138
max_time_thread_terminate_total=10000138
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=99364663248014
threads_final_size=9935077
final_keysum=99364663248014
final_size=9935077
validate_result=success
Validation OK.
Structural validation OK.
total_find=209578506
total_rq=0
total_inserts=11642085
total_deletes=11643902
total_updates=23285987
total_queries=209578506
total_ops=232864493
find_throughput=20957850
rq_throughput=0
update_throughput=2328598
query_throughput=20957850
total_throughput=23286449
total find : 209578506
total rq : 0
total inserts : 11642085
total deletes : 11643902
total updates : 23285987
total queries : 209578506
total ops : 232864493
find throughput : 20957850
rq throughput : 0
update throughput : 2328598
query throughput : 20957850
total throughput : 23286449
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=30.9416
PAPI_L3_TCM=9.83573
PAPI_TOT_CYC=5746.26
PAPI_TOT_INS=1503.16
garbage=1037447335845720
total_execution_walltime=14.513s
REALTIME_MAIN_END_PERF_FORMAT=6996439.914096533
[time_cmd_output] time_elapsed_sec=14.71, faults_major=0, faults_minor=235202, mem_maxresident_kb=942840, user_cputime=707.36, sys_cputime=3.23, percent_cpu=4830%
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