__step=000108
__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_avl_kcas_validate.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000108.txt
__path_data=data/data000108.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55abf9bd7400
addrof(kcasDescriptors[1])=0x55abf9bd7d00
addrof(rdcssDescriptors[0])=0x55abf9cf7400
addrof(rdcssDescriptors[1])=0x55abf9cf74c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6980135.478094230
binary=./sigouin_int_avl_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_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=0.5
DEL_FRAC=0.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=0.5 0.5
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,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.011s
prefilling_size=8302340 prefilling_elapsed_millis=1.001s
prefilling_size=8556701 prefilling_elapsed_millis=1.101s
prefilling_size=8770818 prefilling_elapsed_millis=1.201s
prefilling_size=8949968 prefilling_elapsed_millis=1.302s
prefilling_size=9103503 prefilling_elapsed_millis=1.402s
prefilling_size=9232898 prefilling_elapsed_millis=1.502s
prefilling_size=9340850 prefilling_elapsed_millis=1.602s
prefilling_size=9434548 prefilling_elapsed_millis=1.702s
prefilling_size=9516440 prefilling_elapsed_millis=1.803s
prefilling_size=9585958 prefilling_elapsed_millis=1.903s
prefilling_size=9645359 prefilling_elapsed_millis=2.003s
prefilling_size=9696613 prefilling_elapsed_millis=2.103s
prefilling_size=9739413 prefilling_elapsed_millis=2.203s
prefilling_size=9774158 prefilling_elapsed_millis=2.304s
prefilling_size=9806590 prefilling_elapsed_millis=2.404s
finished prefilling to size 9806591 for expected size 10000000 keysum=98066685654228, performing 80557775 updates; total_prefilling_elapsed_ms=2505 ms)
pref_size=9806591
pref_millis=2505
prefill_elapsed_ms=2529
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6980138.200968785
REALTIME_END_PERF_FORMAT=6980148.201137962

###############################################################################
################################## 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 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 131072 262097 520602 972601 1457087 1393057 662853 120823 5375 10 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 45 3300 59497 400614 1182730 1557506 831470 154224 6693 12
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523902 1032098 1857701 2575787 2220359 952293 159599 6703 12
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523902 1032098 1857701 2575787 2220359 952293 159599 6703 12
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99871 1.97632 1.85757 1.6022 1.32118 1.13036 1.04072 1.00832 1.0003 1

tree_stats_height=28
tree_stats_numInternals=5656648
tree_stats_numLeaves=4196091
tree_stats_numNodes=9852739
tree_stats_numKeys=9852739

tree_stats_avgDegreeInternal=1.7418
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42588
tree_stats_avgKeyDepth=21.6464


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:143978 2:292951 4:121428 8:1620 16:42
    [2^00, 2^01]: 143978
    (2^01, 2^02]: 292951
    (2^02, 2^03]: 121428
    (2^03, 2^04]: 1620
    (2^04, 2^05]: 42
sum_limbo_reclamation_event_size_total=1427498
count_limbo_reclamation_event_size_by_thread=5832 5879 5838 5866 5846 5799 5793 5822 5838 5818 5805 5793 5900 5852 5822 5797 5852 5836 5826 5877 5894 5841 5814 5835 5828 5819 5848 5864 5823 5799 5785 5812 5843 5831 5791 5825 5832 5811 5842 5825 5840 5851 5841 5840 5785 5854 5862 5883 5837 5798 5857 5835 5762 5822 5814 5824 5875 5890 5884 5833 5829 5820 5872 5884 5811 5797 5784 5825 5867 5770 5800 5844 5795 5883 5861 5827 5809 5845 5828 5796 5821 5816 5832 5796 5822 5862 5843 5871 5855 5830 5848 5869 5862 5828 5839 5838
count_limbo_reclamation_event_size_total=560019
sum_limbo_reclamation_event_count_total=622464
first_thread_announced_epoch_by_thread=14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856 14856
sum_num_inserts_by_thread=29788 29952 30282 30461 30339 29932 30142 30462 30535 30411 30116 29942 29959 30640 30602 30607 30386 29826 29722 30393 30364 30387 30050 29947 29867 30024 30237 30568 29862 29749 30149 30392 30561 30712 30191 30116 30480 30395 30631 30497 30181 29825 30092 30400 30623 30360 29780 29482 30281 30152 30615 30100 30247 29887 30184 30137 30876 30494 30336 29985 30148 30414 30395 30638 30004 30101 30016 30248 30600 30492 30033 29835 29918 30303 30106 30194 30484 30053 30283 30192 30534 30621 30041 30245 30479 30548 30038 30493 30096 30100 29846 30171 30421 30064 30299 30269
sum_num_inserts_total=2902435
sum_num_deletes_by_thread=30038 30172 30398 30480 30041 29907 30141 30478 30148 30671 30031 29998 30312 30634 30255 30441 30356 30079 30030 30074 30260 30624 30100 29997 30129 30177 30358 30771 30294 29769 30239 29953 30032 30520 30020 29993 30259 30448 30681 30622 30507 30096 29865 30115 30386 30385 29787 30101 30063 30227 30777 30754 30155 30005 30340 30299 30629 30774 30340 30146 30400 30602 30460 30869 29924 29985 30151 29849 30063 30283 29855 30226 29913 29951 30392 30408 30398 30026 29954 30474 30477 30453 30173 30166 30244 30475 30478 30713 30303 30162 29928 30007 30269 30312 30245 30038
sum_num_deletes_total=2904307
sum_num_searches_by_thread=5936450 5978415 6023000 6018307 5980015 5957493 5982297 5999269 6031601 6066676 5960756 5958828 5968881 6025694 6039189 6054537 5983332 5936035 5900499 5956201 5992601 6011409 5946663 5930693 5942147 5968950 6019037 6040340 5980118 5941690 5977965 5987075 6025449 6042793 5991648 5953030 5982718 6025522 6057724 6015621 6011170 5972655 5932734 5941499 6010165 5995381 5934887 5902439 5974456 5981557 6057300 6014829 6000191 5951713 5984897 5985203 6046355 6055340 5994887 5972752 5977925 6005752 6030858 6053863 5977867 5922710 5939580 5933888 6007884 6036242 5953662 5944454 5965011 5970498 6024695 6035220 6007633 5926072 5950713 5999459 6064662 6069790 5986951 5978275 6008414 6002590 6029844 6038144 6019018 5924390 5929748 5940716 6016861 6020930 5969393 5967361
sum_num_searches_total=574942151
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5996276 6038539 6083680 6079248 6040395 6017332 6042580 6060209 6092284 6127758 6020903 6018768 6029152 6086968 6100046 6115585 6044074 5995940 5960251 6016668 6053225 6072420 6006813 5990637 6002143 6029151 6079632 6101679 6040274 6001208 6038353 6047420 6086042 6104025 6051859 6013139 6043457 6086365 6119036 6076740 6071858 6032576 5992691 6002014 6071174 6056126 5994454 5962022 6034800 6041936 6118692 6075683 6060593 6011605 6045421 6045639 6107860 6116608 6055563 6032883 6038473 6066768 6091713 6115370 6037795 5982796 5999747 5993985 6068547 6097017 6013550 6004515 6024842 6030752 6085193 6095822 6068515 5986151 6010950 6060125 6125673 6130864 6047165 6038686 6069137 6063613 6090360 6099350 6079417 5984652 5989522 6000894 6077551 6081306 6029937 6027668
average_num_operations_total=6049467
stdev_num_operations_total=4223
sum_num_operations_total=580748893
min_num_operations_total=5960251
max_num_operations_total=6130864
first_time_thread_terminate_by_thread=10000169 10000170 10000170 10000169 10000169 10000170 10000169 10000169 10000169 10000169 10000169 10000170 10000170 10000169 10000169 10000169 10000169 10000169 10000169 10000168 10000169 10000170 10000170 10000170 10000169 10000170 10000170 10000169 10000169 10000170 10000169 10000169 10000169 10000169 10000169 10000170 10000170 10000169 10000169 10000169 10000169 10000169 10000169 10000168 10000169 10000169 10000170 10000170 10000169 10000168 10000168 10000169 10000169 10000171 10000169 10000169 10000169 10000169 10000169 10000169 10000170 10000169 10000170 10000169 10000168 10000168 10000169 10000168 10000169 10000170 10000168 10000169 10000169 10000168 10000168 10000169 10000169 10000170 10000169 10000169 10000169 10000169 10000169 10000169 10000170 10000169 10000170 10000169 10000168 10000168 10000169 10000168 10000169 10000170 10000168 10000169
min_time_thread_terminate_total=10000168
max_time_thread_terminate_total=10000171
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 4 3 3 4 3 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 4 3 3 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=98513644571415
threads_final_size=9852739
final_keysum=98513644571415
final_size=9852739
validate_result=success
Validation OK.
Structural validation OK.

total_find=574942151
total_rq=0
total_inserts=2902435
total_deletes=2904307
total_updates=5806742
total_queries=574942151
total_ops=580748893
find_throughput=57494215
rq_throughput=0
update_throughput=580674
query_throughput=57494215
total_throughput=58074889


total find                    : 574942151
total rq                      : 0
total inserts                 : 2902435
total deletes                 : 2904307
total updates                 : 5806742
total queries                 : 574942151
total ops                     : 580748893
find throughput               : 57494215
rq throughput                 : 0
update throughput             : 580674
query throughput              : 57494215
total throughput              : 58074889

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=27.4982
PAPI_L3_TCM=10.2893
PAPI_TOT_CYC=4601.29
PAPI_TOT_INS=1208.52
garbage=2828134341712826
total_execution_walltime=12.877s
REALTIME_MAIN_END_PERF_FORMAT=6980148.355811080
[time_cmd_output] time_elapsed_sec=13.05, faults_major=0, faults_minor=236029, mem_maxresident_kb=941772, user_cputime=1229.24, sys_cputime=3.58, percent_cpu=9442%
timeout=false
algorithm=sigouin_int_avl_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=2