__step=000426
__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_htm.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=data000426.txt
__path_data=data/data000426.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x5556e28ab400
addrof(kcasDescriptors[1])=0x5556e28abd00
addrof(rdcssDescriptors[0])=0x5556e29cb400
addrof(rdcssDescriptors[1])=0x5556e29cb4c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6999932.84451585
binary=./sigouin_int_avl_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_avl_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=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.004s
prefilling_size=1000756 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000807 for expected size 1000000 keysum=1000234085959, performing 33488303 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000807
pref_millis=1102
prefill_elapsed_ms=1126
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6999933.406748726
REALTIME_END_PERF_FORMAT=6999943.406880909
###############################################################################
################################## 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.04s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32767 65313 122199 166673 116576 33891 3195 24 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 1 210 7505 64192 165343 141378 43228 4014 26
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65523 129704 230865 281919 175269 46423 4038 26
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65523 129704 230865 281919 175269 46423 4038 26
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99963 1.98272 1.8378 1.49919 1.20819 1.0715 1.01816 1.0005 1
tree_stats_height=24
tree_stats_numInternals=573405
tree_stats_numLeaves=425897
tree_stats_numNodes=999302
tree_stats_numKeys=999302
tree_stats_avgDegreeInternal=1.74275
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42619
tree_stats_avgKeyDepth=18.2653
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:39 2:1405 4:53263 8:374290 16:50900
[2^00, 2^01]: 39
(2^01, 2^02]: 1405
(2^02, 2^03]: 53263
(2^03, 2^04]: 374290
(2^04, 2^05]: 50900
sum_limbo_reclamation_event_size_total=5452006
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9997 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9996 9997 9998 9998 9998 9998 9998 9998 9998 9998 9997
count_limbo_reclamation_event_size_total=479897
sum_limbo_reclamation_event_count_total=1083456
first_thread_announced_epoch_by_thread=48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282 48282
sum_num_inserts_by_thread=506910 510349 513012 515994 513864 509466 508155 511605 515746 520924 514189 507772 509359 515494 516867 516372 516557 507960 505452 510457 516412 516847 511977 510956 510134 513409 513973 515252 512904 506686 511472 514244 517399 520821 513070 507429 513328 512585 518723 516071 518230 510145 509220 509201 514168 519884 514152 504779
sum_num_inserts_total=24619975
sum_num_deletes_by_thread=507776 509633 511659 517475 514204 509950 509605 511860 516833 521210 513843 508505 508943 514231 515083 516572 516551 508816 507012 508830 516801 516335 511803 509474 509578 511425 514650 516441 512335 507754 512567 514069 516317 520565 513885 507893 513872 512549 518716 515601 516587 509711 508861 510157 513733 518682 512184 506029
sum_num_deletes_total=24617165
sum_num_searches_by_thread=9126037 9191534 9224670 9318128 9266923 9166448 9145873 9208530 9307127 9372313 9260454 9153765 9153202 9262090 9282716 9283431 9300227 9155207 9121504 9197185 9297883 9276736 9210173 9168668 9188719 9216594 9247862 9267927 9235994 9130335 9225549 9253855 9302921 9379212 9253298 9149418 9235304 9226549 9340117 9282202 9295377 9181403 9161561 9177439 9243619 9355041 9243481 9109251
sum_num_searches_total=443153852
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=10140723 10211516 10249341 10351597 10294991 10185864 10163633 10231995 10339706 10414447 10288486 10170042 10171504 10291815 10314666 10316375 10333335 10171983 10133968 10216472 10331096 10309918 10233953 10189098 10208431 10241428 10276485 10299620 10261233 10144775 10249588 10282168 10336637 10420598 10280253 10164740 10262504 10251683 10377556 10313874 10330194 10201259 10179642 10196797 10271520 10393607 10269817 10120059
average_num_operations_total=10258145
stdev_num_operations_total=11119
sum_num_operations_total=492390992
min_num_operations_total=10120059
max_num_operations_total=10420598
first_time_thread_terminate_by_thread=10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132 10000132
min_time_thread_terminate_total=10000132
max_time_thread_terminate_total=10000132
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=999613789400
threads_final_size=999302
final_keysum=999613789400
final_size=999302
validate_result=success
Validation OK.
Structural validation OK.
total_find=443153852
total_rq=0
total_inserts=24619975
total_deletes=24617165
total_updates=49237140
total_queries=443153852
total_ops=492390992
find_throughput=44315385
rq_throughput=0
update_throughput=4923714
query_throughput=44315385
total_throughput=49239099
total find : 443153852
total rq : 0
total inserts : 24619975
total deletes : 24617165
total updates : 49237140
total queries : 443153852
total ops : 492390992
find throughput : 44315385
rq throughput : 0
update throughput : 4923714
query throughput : 44315385
total throughput : 49239099
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=15.2054
PAPI_L3_TCM=2.08209
PAPI_TOT_CYC=2702.31
PAPI_TOT_INS=1150.82
garbage=217022743754817
total_execution_walltime=11.464s
REALTIME_MAIN_END_PERF_FORMAT=6999943.549491559
[time_cmd_output] time_elapsed_sec=11.58, faults_major=0, faults_minor=91224, mem_maxresident_kb=366916, user_cputime=561.77, sys_cputime=2.77, percent_cpu=4871%
timeout=false
algorithm=sigouin_int_avl_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=2