__step=000089
__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_avl_kcas_validate.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000089.txt
__path_data=data/data000089.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5599821303c0
addrof(kcasDescriptors[1])=0x559982130cc0
addrof(rdcssDescriptors[0])=0x5599822503c0
addrof(rdcssDescriptors[1])=0x559982250480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=220863.887704542
binary=./sigouin_int_avl_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_avl_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=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.019s
prefilling_size=7254240 prefilling_elapsed_millis=1s
prefilling_size=7558692 prefilling_elapsed_millis=1.101s
prefilling_size=7826953 prefilling_elapsed_millis=1.201s
prefilling_size=8062173 prefilling_elapsed_millis=1.301s
prefilling_size=8269045 prefilling_elapsed_millis=1.401s
prefilling_size=8452011 prefilling_elapsed_millis=1.501s
prefilling_size=8615498 prefilling_elapsed_millis=1.601s
prefilling_size=8760034 prefilling_elapsed_millis=1.701s
prefilling_size=8887860 prefilling_elapsed_millis=1.801s
prefilling_size=9002018 prefilling_elapsed_millis=1.902s
prefilling_size=9103868 prefilling_elapsed_millis=2.002s
prefilling_size=9194204 prefilling_elapsed_millis=2.102s
prefilling_size=9275017 prefilling_elapsed_millis=2.202s
prefilling_size=9347060 prefilling_elapsed_millis=2.302s
prefilling_size=9414392 prefilling_elapsed_millis=2.402s
prefilling_size=9473636 prefilling_elapsed_millis=2.502s
prefilling_size=9525640 prefilling_elapsed_millis=2.602s
prefilling_size=9573064 prefilling_elapsed_millis=2.703s
prefilling_size=9614956 prefilling_elapsed_millis=2.803s
prefilling_size=9653052 prefilling_elapsed_millis=2.903s
prefilling_size=9686590 prefilling_elapsed_millis=3.003s
prefilling_size=9716388 prefilling_elapsed_millis=3.104s
prefilling_size=9745201 prefilling_elapsed_millis=3.204s
prefilling_size=9770853 prefilling_elapsed_millis=3.304s
prefilling_size=9792876 prefilling_elapsed_millis=3.404s
prefilling_size=9813142 prefilling_elapsed_millis=3.504s
finished prefilling to size 9813175 for expected size 10000000 keysum=98123630459761, performing 85228806 updates; total_prefilling_elapsed_ms=3605 ms)
pref_size=9813175
pref_millis=3605
prefill_elapsed_ms=3623
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=220867.549325929
REALTIME_END_PERF_FORMAT=220877.549419736

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

tree_stats_computeWalltime=0.059s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131071 262063 519879 969110 1441192 1375297 703483 165285 13784 113 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 75 3830 61105 407593 1168123 1501057 865800 210578 17335 151
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262138 523709 1030215 1848785 2543420 2204540 1031085 224362 17448 151
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262138 523709 1030215 1848785 2543420 2204540 1031085 224362 17448 151
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99996 1.99812 1.97446 1.85388 1.59619 1.32603 1.1486 1.0573 1.01633 1.00218 1

tree_stats_height=28
tree_stats_numInternals=5712348
tree_stats_numLeaves=4235648
tree_stats_numNodes=9947996
tree_stats_numKeys=9947996

tree_stats_avgDegreeInternal=1.74149
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42578
tree_stats_avgKeyDepth=21.6892


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:2 2:52 4:7160 8:266483 16:226464 32:189 64:61
    [2^00, 2^01]: 2
    (2^01, 2^02]: 52
    (2^02, 2^03]: 7160
    (2^03, 2^04]: 266483
    (2^04, 2^05]: 226464
    (2^05, 2^06]: 189
    (2^06, 2^07]: 61
sum_limbo_reclamation_event_size_total=7611608
count_limbo_reclamation_event_size_by_thread=7819 7819 7819 7814 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819 7819
count_limbo_reclamation_event_size_total=500411
sum_limbo_reclamation_event_count_total=500540
first_thread_announced_epoch_by_thread=20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058 20058
sum_num_inserts_by_thread=243247 242991 239536 241544 240404 241762 241851 241950 241722 239741 241720 238501 240353 240005 236738 236788 237877 237382 239319 240905 243313 240619 240159 239989 239777 240584 238246 237273 236659 237844 236786 236640 238098 244764 241708 242855 241548 240989 240625 242858 242435 237774 237385 239780 240204 239726 239164 236899 240685 241937 241298 238915 239848 239760 239184 237799 240354 239561 238351 236109 237208 237337 243551 243398
sum_num_inserts_total=15354332
sum_num_deletes_by_thread=243919 243500 240801 240715 240286 241583 242265 242111 242989 240272 241767 238985 241002 240012 237254 236847 237744 239430 239645 241531 244212 241528 240742 239121 239436 240213 239009 237678 238241 237399 236049 236673 237252 244534 240842 242234 242166 240849 240098 242774 242740 239256 237428 239500 238725 239890 238682 236261 241459 242205 241553 238815 238856 239881 240211 239170 239327 238934 238645 236948 236778 238644 243327 242652
sum_num_deletes_total=15363595
sum_num_searches_by_thread=4391162 4385266 4323724 4334376 4323418 4348953 4367479 4364080 4363241 4322225 4342552 4299398 4338004 4313834 4259342 4259564 4289094 4290363 4309244 4339198 4378170 4332798 4324961 4322912 4321041 4322013 4288946 4271932 4277302 4271564 4258803 4254401 4286316 4397799 4336039 4372697 4343768 4344955 4329334 4365862 4347254 4293712 4272866 4310810 4319274 4315752 4300410 4257774 4331596 4363609 4348747 4309535 4319298 4316413 4299842 4284171 4315352 4312578 4300038 4256109 4276279 4284294 4381811 4377325
sum_num_searches_total=276460979
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4878328 4871757 4804061 4816635 4804108 4832298 4851595 4848141 4847952 4802238 4826039 4776884 4819359 4793851 4733334 4733199 4764715 4767175 4788208 4821634 4865695 4814945 4805862 4802022 4800254 4802810 4766201 4746883 4752202 4746807 4731638 4727714 4761666 4887097 4818589 4857786 4827482 4826793 4810057 4851494 4832429 4770742 4747679 4790090 4798203 4795368 4778256 4730934 4813740 4847751 4831598 4787265 4798002 4796054 4779237 4761140 4795033 4791073 4777034 4729166 4750265 4760275 4868689 4863375
average_num_operations_total=4799670
stdev_num_operations_total=5214
sum_num_operations_total=307178906
min_num_operations_total=4727714
max_num_operations_total=4887097
first_time_thread_terminate_by_thread=10000098 10000098 10000098 10000098 10000095 10000095 10000095 10000095 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000093 10000093 10000093 10000093 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000096 10000099 10000099 10000099 10000099 10000096 10000096 10000096 10000096 10000094 10000094 10000094 10000094 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099 10000095 10000095 10000095 10000095 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000097 10000095 10000095 10000095 10000095
min_time_thread_terminate_total=10000093
max_time_thread_terminate_total=10000099
first_time_thread_start_by_thread=8 8 8 8 9 9 9 9 10 10 10 10 11 11 11 11 6 6 6 6 8 8 8 8 11 10 11 10 9 9 8 9 10 10 10 10 10 10 10 10 7 7 7 7 8 8 8 8 12 12 12 12 11 11 11 11 9 9 9 9 12 12 12 12
min_time_thread_start_total=6
max_time_thread_start_total=12
sum_duration_all_ops_total=

threads_final_keysum=99453781451937
threads_final_size=9947996
final_keysum=99453781451937
final_size=9947996
validate_result=success
Validation OK.
Structural validation OK.

total_find=276460979
total_rq=0
total_inserts=15354332
total_deletes=15363595
total_updates=30717927
total_queries=276460979
total_ops=307178906
find_throughput=27646097
rq_throughput=0
update_throughput=3071792
query_throughput=27646097
total_throughput=30717890


total find                    : 276460979
total rq                      : 0
total inserts                 : 15354332
total deletes                 : 15363595
total updates                 : 30717927
total queries                 : 276460979
total ops                     : 307178906
find throughput               : 27646097
rq throughput                 : 0
update throughput             : 3071792
query throughput              : 27646097
total throughput              : 30717890

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=576937390735625
total_execution_walltime=13.794s
REALTIME_MAIN_END_PERF_FORMAT=220877.682214818
[time_cmd_output] time_elapsed_sec=13.94, faults_major=1, faults_minor=235339, mem_maxresident_kb=942164, user_cputime=887.59, sys_cputime=5.40, percent_cpu=6402%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1