__step=000554
__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 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000554.txt
__path_data=data/data000554.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55b2badc1400
addrof(kcasDescriptors[1])=0x55b2badc1d00
addrof(rdcssDescriptors[0])=0x55b2baee1400
addrof(rdcssDescriptors[1])=0x55b2baee14c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6985556.35927683
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=2000000
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.016s
prefilling_size=1000451 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000427 for expected size 1000000 keysum=1000835913283, performing 28547900 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000427
pref_millis=1102
prefill_elapsed_ms=1124
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6985557.330427877
REALTIME_END_PERF_FORMAT=6985567.330558788

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

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65262 121328 165966 119969 33967 2348 4 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 260 8125 63139 161691 146404 43533 2973 5
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65522 129453 229105 281660 180371 45881 2977 5
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65522 129453 229105 281660 180371 45881 2977 5
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99957 1.97969 1.83256 1.50498 1.21445 1.06605 1.01371 1.00034 1

tree_stats_height=24
tree_stats_numInternals=574379
tree_stats_numLeaves=426130
tree_stats_numNodes=1000509
tree_stats_numKeys=1000509

tree_stats_avgDegreeInternal=1.7419
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42591
tree_stats_avgKeyDepth=18.2692


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:34 2:1494 4:55136 8:376908 16:46331
    [2^00, 2^01]: 34
    (2^01, 2^02]: 1494
    (2^02, 2^03]: 55136
    (2^03, 2^04]: 376908
    (2^04, 2^05]: 46331
sum_limbo_reclamation_event_size_total=5395965
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 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=479903
sum_limbo_reclamation_event_count_total=1062144
first_thread_announced_epoch_by_thread=46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962 46962
sum_num_inserts_by_thread=492378 495322 502751 502878 496411 494741 493919 495353 501999 505787 497459 498246 499089 499132 504293 499925 497604 499790 491894 496170 501114 499955 495718 496217 496814 495972 498780 504635 500640 494511 498873 500044 506501 501748 501297 494012 493812 500292 500604 500032 498154 494215 495381 493515 497260 500292 494783 492492
sum_num_inserts_total=23912804
sum_num_deletes_by_thread=491967 494554 503453 503159 494597 495053 494201 495667 502586 506356 497184 497551 497680 500529 503570 500624 497546 499555 493248 495820 501236 500100 494174 495766 496415 496553 498912 504121 499629 494651 498743 501066 506791 504160 499608 494457 495111 500475 499375 500618 498102 493756 494853 493422 497348 500536 495669 491648
sum_num_deletes_total=23912195
sum_num_searches_by_thread=8868629 8925463 9061792 9068542 8936177 8893087 8892916 8921516 9044990 9111928 8953539 8970555 8968005 8996429 9063516 9015431 8953319 8986888 8865154 8923569 9020799 9003949 8900475 8911063 8939645 8914564 8977503 9074784 9016029 8905898 8969496 9013080 9119774 9039424 9018433 8894173 8901194 9000478 8995539 9009730 8955124 8889707 8917160 8883972 8965973 9004794 8919600 8854946
sum_num_searches_total=430438751
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9852974 9915339 10067996 10074579 9927185 9882881 9881036 9912536 10049575 10124071 9948182 9966352 9964774 9996090 10071379 10015980 9948469 9986233 9850296 9915559 10023149 10004004 9890367 9903046 9932874 9907089 9975195 10083540 10016298 9895060 9967112 10014190 10133066 10045332 10019338 9882642 9890117 10001245 9995518 10010380 9951380 9877678 9907394 9870909 9960581 10005622 9910052 9839086
average_num_operations_total=9963828
stdev_num_operations_total=10789
sum_num_operations_total=478263750
min_num_operations_total=9839086
max_num_operations_total=10133066
first_time_thread_terminate_by_thread=10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000130 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000131 10000130 10000131
min_time_thread_terminate_total=10000130
max_time_thread_terminate_total=10000131
first_time_thread_start_by_thread=3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=1001170045783
threads_final_size=1000509
final_keysum=1001170045783
final_size=1000509
validate_result=success
Validation OK.
Structural validation OK.

total_find=430438751
total_rq=0
total_inserts=23912804
total_deletes=23912195
total_updates=47824999
total_queries=430438751
total_ops=478263750
find_throughput=43043875
rq_throughput=0
update_throughput=4782499
query_throughput=43043875
total_throughput=47826375


total find                    : 430438751
total rq                      : 0
total inserts                 : 23912804
total deletes                 : 23912195
total updates                 : 47824999
total queries                 : 430438751
total ops                     : 478263750
find throughput               : 43043875
rq throughput                 : 0
update throughput             : 4782499
query throughput              : 43043875
total throughput              : 47826375

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=15.1809
PAPI_L3_TCM=2.11096
PAPI_TOT_CYC=2792.77
PAPI_TOT_INS=1235.77
garbage=215281570401297
total_execution_walltime=11.434s
REALTIME_MAIN_END_PERF_FORMAT=6985567.470759035
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=91313, mem_maxresident_kb=367260, user_cputime=563.06, sys_cputime=3.26, percent_cpu=4893%
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