__step=000177
__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_htm.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=data000177.txt
__path_data=data/data000177.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x555fe0861400
addrof(kcasDescriptors[1])=0x555fe0861d00
addrof(rdcssDescriptors[0])=0x555fe0981400
addrof(rdcssDescriptors[1])=0x555fe09814c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6996529.936958296
binary=./sigouin_int_bst_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=sigouin_int_bst_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=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=6969193 prefilling_elapsed_millis=1.001s
prefilling_size=7258684 prefilling_elapsed_millis=1.101s
prefilling_size=7516311 prefilling_elapsed_millis=1.201s
prefilling_size=7747031 prefilling_elapsed_millis=1.301s
prefilling_size=7954062 prefilling_elapsed_millis=1.401s
prefilling_size=8142927 prefilling_elapsed_millis=1.502s
prefilling_size=8312679 prefilling_elapsed_millis=1.602s
prefilling_size=8466277 prefilling_elapsed_millis=1.702s
prefilling_size=8604083 prefilling_elapsed_millis=1.802s
prefilling_size=8728440 prefilling_elapsed_millis=1.903s
prefilling_size=8842330 prefilling_elapsed_millis=2.003s
prefilling_size=8945162 prefilling_elapsed_millis=2.103s
prefilling_size=9037030 prefilling_elapsed_millis=2.203s
prefilling_size=9121945 prefilling_elapsed_millis=2.303s
prefilling_size=9198797 prefilling_elapsed_millis=2.403s
prefilling_size=9267873 prefilling_elapsed_millis=2.504s
prefilling_size=9330407 prefilling_elapsed_millis=2.604s
prefilling_size=9388157 prefilling_elapsed_millis=2.704s
prefilling_size=9440688 prefilling_elapsed_millis=2.804s
prefilling_size=9488676 prefilling_elapsed_millis=2.905s
prefilling_size=9532422 prefilling_elapsed_millis=3.005s
prefilling_size=9573600 prefilling_elapsed_millis=3.105s
prefilling_size=9609252 prefilling_elapsed_millis=3.205s
prefilling_size=9642463 prefilling_elapsed_millis=3.305s
prefilling_size=9673166 prefilling_elapsed_millis=3.406s
prefilling_size=9702818 prefilling_elapsed_millis=3.506s
prefilling_size=9728778 prefilling_elapsed_millis=3.606s
prefilling_size=9752184 prefilling_elapsed_millis=3.706s
prefilling_size=9775628 prefilling_elapsed_millis=3.806s
prefilling_size=9793776 prefilling_elapsed_millis=3.907s
prefilling_size=9810571 prefilling_elapsed_millis=4.007s
finished prefilling to size 9810618 for expected size 10000000 keysum=98101486609965, performing 85954042 updates; total_prefilling_elapsed_ms=4108 ms)
pref_size=9810618
pref_millis=4108
prefill_elapsed_ms=4131
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6996534.265936423
REALTIME_END_PERF_FORMAT=6996544.266076788

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

tree_stats_computeWalltime=0.115s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 249 485 928 1765 3287 5937 10382 17651 28952 45630 68859 100278 140773 189307 244993 304688 365256 420959 467628 498880 511942 505557 479324 438012 384555 323920 262221 204477 153143 109970 76473 51091 32764 20325 12201 6976 3876 2107 1066 481 238 108 42 16 5 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 3 8 31 51 132 347 826 1719 3496 6719 12146 20274 32377 49838 71740 99385 130534 165214 199186 231554 257696 274151 281072 273884 258105 233304 201874 167226 133342 102300 74430 52767 35929 23336 14773 9034 5178 2891 1627 881 376 185 86 34 14 5
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 252 493 959 1816 3419 6284 11208 19370 32448 52349 81005 120552 173150 239145 316733 404073 495790 586173 666814 730434 769638 779708 760396 711896 642660 557224 464095 371703 286485 212270 150903 103858 68693 43661 26974 16010 9054 4998 2693 1362 614 293 128 50 19 5
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 252 493 959 1816 3419 6284 11208 19370 32448 52349 81005 120552 173150 239145 316733 404073 495790 586173 666814 730434 769638 779708 760396 711896 642660 557224 464095 371703 286485 212270 150903 103858 68693 43661 26974 16010 9054 4998 2693 1362 614 293 128 50 19 5
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 1.97656 1.96825 1.96146 1.92596 1.91079 1.87657 1.8388 1.80193 1.76391 1.72106 1.67575 1.63815 1.60449 1.56813 1.53284 1.50225 1.47294 1.44559 1.41942 1.39412 1.37068 1.34791 1.32684 1.30586 1.28747 1.26868 1.25156 1.2359 1.22063 1.20639 1.19283 1.18147 1.16948 1.15863 1.15229 1.14121 1.12979 1.12392 1.11725 1.10991 1.09765 1.08958 1.06826 1.0625 1.06 1 1

tree_stats_height=54
tree_stats_numInternals=6498031
tree_stats_numLeaves=3430081
tree_stats_numNodes=9928112
tree_stats_numKeys=9928112

tree_stats_avgDegreeInternal=1.52786
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34549
tree_stats_avgKeyDepth=28.8157


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:63 2:1539 4:55969 8:371080 16:51248
    [2^00, 2^01]: 63
    (2^01, 2^02]: 1539
    (2^02, 2^03]: 55969
    (2^03, 2^04]: 371080
    (2^04, 2^05]: 51248
sum_limbo_reclamation_event_size_total=5434054
count_limbo_reclamation_event_size_by_thread=9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=479899
sum_limbo_reclamation_event_count_total=507552
first_thread_announced_epoch_by_thread=29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004 29004
sum_num_inserts_by_thread=242386 242801 245346 244961 241669 240974 239628 241114 242692 243346 240903 241556 243106 243398 243247 245431 241672 239903 239950 241624 241413 245464 239913 239832 239770 243496 242278 245357 240544 242500 239373 240958 243715 243530 240935 241997 241574 240587 242942 242924 244671 242500 237194 242145 241756 242082 239234 241559
sum_num_inserts_total=11615950
sum_num_deletes_by_thread=241961 243738 246667 244492 240442 240708 239916 241818 243549 243086 240869 242489 243027 243960 242611 245528 241665 239854 238143 240229 241762 245167 239778 241168 239555 243497 242527 244676 239325 241101 238908 241593 243240 241864 240481 241984 239935 241153 244172 242850 243928 242698 237452 243473 241726 242582 239697 240691
sum_num_deletes_total=11611735
sum_num_searches_by_thread=4354382 4378725 4405499 4408087 4340816 4348093 4314902 4332633 4381956 4385066 4331348 4361312 4370648 4396310 4378894 4423610 4343004 4323609 4303055 4321099 4348219 4418391 4319769 4335890 4311680 4381436 4363418 4407311 4328517 4349369 4308015 4334575 4377530 4383051 4326944 4357981 4323659 4348067 4375203 4371344 4391800 4369922 4286992 4370885 4344851 4369719 4310471 4335586
sum_num_searches_total=209053643
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4838729 4865264 4897512 4897540 4822927 4829775 4794446 4815565 4868197 4871498 4813120 4845357 4856781 4883668 4864752 4914569 4826341 4803366 4781148 4802952 4831394 4909022 4799460 4816890 4791005 4868429 4848223 4897344 4808386 4832970 4786296 4817126 4864485 4868445 4808360 4841962 4805168 4829807 4862317 4857118 4880399 4855120 4761638 4856503 4828333 4854383 4789402 4817836
average_num_operations_total=4839194
stdev_num_operations_total=5288
sum_num_operations_total=232281328
min_num_operations_total=4761638
max_num_operations_total=4914569
first_time_thread_terminate_by_thread=10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000138 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000138 10000139 10000139 10000139
min_time_thread_terminate_total=10000138
max_time_thread_terminate_total=10000140
first_time_thread_start_by_thread=4 3 4 3 4 3 3 3 3 3 3 3 3 3 3 3 4 4 3 4 4 3 3 3 4 3 4 3 4 3 3 3 3 3 3 3 3 3 3 3 4 4 3 4 4 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=99271625859058
threads_final_size=9928112
final_keysum=99271625859058
final_size=9928112
validate_result=success
Validation OK.
Structural validation OK.

total_find=209053643
total_rq=0
total_inserts=11615950
total_deletes=11611735
total_updates=23227685
total_queries=209053643
total_ops=232281328
find_throughput=20905364
rq_throughput=0
update_throughput=2322768
query_throughput=20905364
total_throughput=23228132


total find                    : 209053643
total rq                      : 0
total inserts                 : 11615950
total deletes                 : 11611735
total updates                 : 23227685
total queries                 : 209053643
total ops                     : 232281328
find throughput               : 20905364
rq throughput                 : 0
update throughput             : 2322768
query throughput              : 20905364
total throughput              : 23228132

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=30.7458
PAPI_L3_TCM=9.81859
PAPI_TOT_CYC=5761.34
PAPI_TOT_INS=1512.87
garbage=1034744087046815
total_execution_walltime=14.562s
REALTIME_MAIN_END_PERF_FORMAT=6996544.499529758
[time_cmd_output] time_elapsed_sec=14.73, faults_major=0, faults_minor=235069, mem_maxresident_kb=942604, user_cputime=707.68, sys_cputime=2.90, percent_cpu=4821%
timeout=false
algorithm=sigouin_int_bst_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=1