__step=000105
__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 48 -nprefill 48 -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=data000105.txt
__path_data=data/data000105.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55ae98196400
addrof(kcasDescriptors[1])=0x55ae98196d00
addrof(rdcssDescriptors[0])=0x55ae982b6400
addrof(rdcssDescriptors[1])=0x55ae982b64c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6980091.820620444
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=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.02s
prefilling_size=6379971 prefilling_elapsed_millis=1.001s
prefilling_size=6694203 prefilling_elapsed_millis=1.101s
prefilling_size=6979271 prefilling_elapsed_millis=1.201s
prefilling_size=7239528 prefilling_elapsed_millis=1.302s
prefilling_size=7476276 prefilling_elapsed_millis=1.402s
prefilling_size=7692043 prefilling_elapsed_millis=1.502s
prefilling_size=7887267 prefilling_elapsed_millis=1.602s
prefilling_size=8065467 prefilling_elapsed_millis=1.702s
prefilling_size=8230023 prefilling_elapsed_millis=1.803s
prefilling_size=8379495 prefilling_elapsed_millis=1.903s
prefilling_size=8514943 prefilling_elapsed_millis=2.003s
prefilling_size=8638710 prefilling_elapsed_millis=2.103s
prefilling_size=8751468 prefilling_elapsed_millis=2.203s
prefilling_size=8855767 prefilling_elapsed_millis=2.304s
prefilling_size=8951060 prefilling_elapsed_millis=2.404s
prefilling_size=9037507 prefilling_elapsed_millis=2.504s
prefilling_size=9116890 prefilling_elapsed_millis=2.604s
prefilling_size=9189579 prefilling_elapsed_millis=2.704s
prefilling_size=9256564 prefilling_elapsed_millis=2.805s
prefilling_size=9318158 prefilling_elapsed_millis=2.905s
prefilling_size=9373944 prefilling_elapsed_millis=3.005s
prefilling_size=9427701 prefilling_elapsed_millis=3.105s
prefilling_size=9473388 prefilling_elapsed_millis=3.205s
prefilling_size=9516561 prefilling_elapsed_millis=3.306s
prefilling_size=9555585 prefilling_elapsed_millis=3.406s
prefilling_size=9590700 prefilling_elapsed_millis=3.506s
prefilling_size=9625130 prefilling_elapsed_millis=3.606s
prefilling_size=9655982 prefilling_elapsed_millis=3.706s
prefilling_size=9682872 prefilling_elapsed_millis=3.807s
prefilling_size=9707286 prefilling_elapsed_millis=3.907s
prefilling_size=9731615 prefilling_elapsed_millis=4.007s
prefilling_size=9753118 prefilling_elapsed_millis=4.107s
prefilling_size=9773285 prefilling_elapsed_millis=4.207s
prefilling_size=9793921 prefilling_elapsed_millis=4.308s
prefilling_size=9810713 prefilling_elapsed_millis=4.408s
finished prefilling to size 9810691 for expected size 10000000 keysum=98099008006103, performing 80438969 updates; total_prefilling_elapsed_ms=4509 ms)
pref_size=9810691
pref_millis=4509
prefill_elapsed_ms=4531
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6980096.542028064
REALTIME_END_PERF_FORMAT=6980106.542187265

###############################################################################
################################## 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.044s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262101 521120 976625 1453626 1362043 659281 138193 9829 107 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 41 2853 57242 411183 1197520 1511601 818397 176235 12391 123
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523973 1033867 1864809 2559563 2170882 956590 186064 12498 123
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131072 262142 523973 1033867 1864809 2559563 2170882 956590 186064 12498 123
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99998 1.99897 1.97858 1.85909 1.59306 1.31601 1.13695 1.05004 1.01434 1.00128 1

tree_stats_height=28
tree_stats_numInternals=5645068
tree_stats_numLeaves=4187586
tree_stats_numNodes=9832654
tree_stats_numKeys=9832654

tree_stats_avgDegreeInternal=1.74181
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42589
tree_stats_avgKeyDepth=21.6509


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:175782 2:136655 4:13394 8:14
    [2^00, 2^01]: 175782
    (2^01, 2^02]: 136655
    (2^02, 2^03]: 13394
    (2^03, 2^04]: 14
sum_limbo_reclamation_event_size_total=543495
count_limbo_reclamation_event_size_by_thread=6736 6805 6679 6785 6867 6703 6799 6699 6855 6815 6825 6778 6830 6811 6857 6867 6788 6827 6847 6834 6890 6814 6797 6676 6729 6796 6727 6795 6770 6705 6745 6827 6836 6837 6732 6846 6849 6739 6757 6852 6764 6755 6699 6791 6801 6828 6823 6658
count_limbo_reclamation_event_size_total=325845
sum_limbo_reclamation_event_count_total=569664
first_thread_announced_epoch_by_thread=31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198 31198
sum_num_inserts_by_thread=26927 27160 27492 27702 27380 27180 27106 27234 27585 27425 27100 27106 27207 27306 27504 27491 27199 27195 26919 26887 27310 27379 26973 27030 27076 27256 27560 27404 27348 27304 27351 27230 27832 27946 27345 27218 27298 27550 27382 27684 27355 27055 27442 27539 27760 27476 27417 27304
sum_num_inserts_total=1311929
sum_num_deletes_by_thread=27161 27563 27505 27309 27664 26935 27392 27419 27550 27896 27316 27149 27183 27256 27551 27714 27350 26925 27003 27356 27428 27303 27114 26960 27093 27027 27471 27770 27214 27112 27307 27455 27699 27554 27148 27335 27418 27598 27602 27459 27318 27277 27012 27305 27329 27641 27261 26966
sum_num_deletes_total=1312373
sum_num_searches_by_thread=5364347 5399532 5456588 5426571 5425327 5359050 5370201 5424608 5458162 5481789 5399155 5366457 5401615 5424492 5445316 5471530 5418003 5381963 5349951 5380385 5416207 5442690 5401312 5363115 5364327 5394911 5452651 5449919 5407238 5381685 5401064 5404407 5471614 5475494 5409963 5386886 5394874 5440989 5449804 5445547 5439774 5384902 5372338 5379311 5434806 5436961 5405032 5366294
sum_num_searches_total=259779157
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=5418435 5454255 5511585 5481582 5480371 5413165 5424699 5479261 5513297 5537110 5453571 5420712 5456005 5479054 5500371 5526735 5472552 5436083 5403873 5434628 5470945 5497372 5455399 5417105 5418496 5449194 5507682 5505093 5461800 5436101 5455722 5459092 5527145 5530994 5464456 5441439 5449590 5496137 5504788 5500690 5494447 5439234 5426792 5434155 5489895 5492078 5459710 5420564
average_num_operations_total=5466738
stdev_num_operations_total=5223
sum_num_operations_total=262403459
min_num_operations_total=5403873
max_num_operations_total=5537110
first_time_thread_terminate_by_thread=10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000159 10000158 10000158 10000158 10000158 10000158 10000158 10000158 10000158
min_time_thread_terminate_total=10000158
max_time_thread_terminate_total=10000159
first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=5
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=98325268509224
threads_final_size=9832654
final_keysum=98325268509224
final_size=9832654
validate_result=success
Validation OK.
Structural validation OK.

total_find=259779157
total_rq=0
total_inserts=1311929
total_deletes=1312373
total_updates=2624302
total_queries=259779157
total_ops=262403459
find_throughput=25977915
rq_throughput=0
update_throughput=262430
query_throughput=25977915
total_throughput=26240345


total find                    : 259779157
total rq                      : 0
total inserts                 : 1311929
total deletes                 : 1312373
total updates                 : 2624302
total queries                 : 259779157
total ops                     : 262403459
find throughput               : 25977915
rq throughput                 : 0
update throughput             : 262430
query throughput              : 25977915
total throughput              : 26240345

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=27.3659
PAPI_L3_TCM=9.23481
PAPI_TOT_CYC=5099.92
PAPI_TOT_INS=1209.14
garbage=1276358399846039
total_execution_walltime=14.861s
REALTIME_MAIN_END_PERF_FORMAT=6980106.682902177
[time_cmd_output] time_elapsed_sec=15.03, faults_major=0, faults_minor=233132, mem_maxresident_kb=934496, user_cputime=726.64, sys_cputime=3.03, percent_cpu=4852%
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=1