__step=000553
__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 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000553.txt
__path_data=data/data000553.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x55b9eb3d83c0
addrof(kcasDescriptors[1])=0x55b9eb3d8cc0
addrof(rdcssDescriptors[0])=0x55b9eb4f83c0
addrof(rdcssDescriptors[1])=0x55b9eb4f8480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=213503.310637321
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=2000000
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.013s
prefilling_size=999782 prefilling_elapsed_millis=1s
finished prefilling to size 999757 for expected size 1000000 keysum=999784729367, performing 30273901 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=999757
pref_millis=1101
prefill_elapsed_ms=1117
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=213504.453331861
REALTIME_END_PERF_FORMAT=213514.453429930
###############################################################################
################################## 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.063s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32766 65325 123190 170498 116435 30473 2315 11 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 2 195 6711 63063 171038 143112 38856 2874 11
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65520 129901 233561 287473 173585 41171 2885 11
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65520 129901 233561 287473 173585 41171 2885 11
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99957 1.98559 1.84965 1.50083 1.1988 1.06163 1.01384 1 1
tree_stats_height=24
tree_stats_numInternals=573780
tree_stats_numLeaves=425862
tree_stats_numNodes=999642
tree_stats_numKeys=999642
tree_stats_avgDegreeInternal=1.7422
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42601
tree_stats_avgKeyDepth=18.2468
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:3 2:112 4:10235 8:361004 16:268113 32:141 64:222 128:41
[2^00, 2^01]: 3
(2^01, 2^02]: 112
(2^02, 2^03]: 10235
(2^03, 2^04]: 361004
(2^04, 2^05]: 268113
(2^05, 2^06]: 141
(2^06, 2^07]: 222
(2^07, 2^08]: 41
sum_limbo_reclamation_event_size_total=9549565
count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9997 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 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998
count_limbo_reclamation_event_size_total=639871
sum_limbo_reclamation_event_count_total=936256
first_thread_announced_epoch_by_thread=30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876 30876
sum_num_inserts_by_thread=456060 443659 452328 451774 450069 442208 440556 439328 450867 447304 433805 430663 430389 429430 427674 427155 434817 438758 446662 436176 447485 437282 435534 436137 431331 428234 434964 426365 434656 426528 431785 437312 440149 438898 444597 446187 436929 446841 432092 428894 437742 428271 425974 433448 435898 439883 447679 437209 436211 435170 433207 433896 430094 426061 424685 432966 436304 436367 435969 426992 441889 441309 440245 441903
sum_num_inserts_total=27971254
sum_num_deletes_by_thread=454368 443476 451216 454256 451786 442531 440855 440201 451497 447466 435667 430596 428888 428579 427135 428364 435993 438601 445760 436266 446547 435400 436194 435926 431371 428231 435254 426633 433191 425558 432296 436897 439490 439000 445846 445407 438944 446697 432437 429428 436741 427894 426390 435629 435576 439198 446602 437759 436627 436101 434609 433601 430622 426531 423939 434256 437159 436248 435762 426818 440787 440517 440557 440889
sum_num_deletes_total=27975060
sum_num_searches_by_thread=8184018 7981466 8126377 8155361 8122504 7954866 7945289 7917785 8105319 8057492 7827265 7754112 7744402 7739291 7688021 7694712 7841244 7910869 8036585 7859264 8044042 7854659 7845179 7829003 7773167 7705719 7832186 7666183 7816086 7666272 7782997 7878223 7902175 7893433 8026643 8023019 7887276 8041790 7782523 7724392 7868922 7704100 7675170 7821105 7842243 7922248 8042230 7870470 7848005 7836502 7802499 7805313 7747749 7682441 7650888 7812765 7850281 7843447 7851713 7694914 7952037 7942858 7928382 7944244
sum_num_searches_total=503561735
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9094446 8868601 9029921 9061391 9024359 8839605 8826700 8797314 9007683 8952262 8696737 8615371 8603679 8597300 8542830 8550231 8712054 8788228 8929007 8731706 8938074 8727341 8716907 8701066 8635869 8562184 8702404 8519181 8683933 8518358 8647078 8752432 8781814 8771331 8917086 8914613 8763149 8935328 8647052 8582714 8743405 8560265 8527534 8690182 8713717 8801329 8936511 8745438 8720843 8707773 8670315 8672810 8608465 8535033 8499512 8679987 8723744 8716062 8723444 8548724 8834713 8824684 8809184 8827036
average_num_operations_total=8742313
stdev_num_operations_total=18579
sum_num_operations_total=559508049
min_num_operations_total=8499512
max_num_operations_total=9094446
first_time_thread_terminate_by_thread=10000099 10000099 10000098 10000099 10000100 10000100 10000100 10000100 10000099 10000099 10000099 10000099 10000101 10000101 10000101 10000101 10000098 10000098 10000098 10000098 10000100 10000100 10000099 10000100 10000101 10000100 10000100 10000101 10000100 10000100 10000100 10000100 10000099 10000099 10000099 10000099 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000101 10000098 10000098 10000098 10000098 10000100 10000100 10000100 10000100 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000098 10000099 10000099 10000099 10000099
min_time_thread_terminate_total=10000098
max_time_thread_terminate_total=10000101
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 8 8 8 8 9 10 9 10 9 9 9 9 9 9 9 9 9 9 9 9 8 8 8 8 7 7 7 7 6 6 6 6 7 7 7 7 6 6 6 6
min_time_thread_start_total=4
max_time_thread_start_total=10
sum_duration_all_ops_total=
threads_final_keysum=999766326799
threads_final_size=999642
final_keysum=999766326799
final_size=999642
validate_result=success
Validation OK.
Structural validation OK.
total_find=503561735
total_rq=0
total_inserts=27971254
total_deletes=27975060
total_updates=55946314
total_queries=503561735
total_ops=559508049
find_throughput=50356173
rq_throughput=0
update_throughput=5594631
query_throughput=50356173
total_throughput=55950804
total find : 503561735
total rq : 0
total inserts : 27971254
total deletes : 27975060
total updates : 55946314
total queries : 503561735
total ops : 559508049
find throughput : 50356173
rq throughput : 0
update throughput : 5594631
query throughput : 50356173
total throughput : 55950804
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=122374336763490
total_execution_walltime=11.306s
REALTIME_MAIN_END_PERF_FORMAT=213514.617958584
[time_cmd_output] time_elapsed_sec=11.42, faults_major=0, faults_minor=91864, mem_maxresident_kb=368152, user_cputime=727.65, sys_cputime=5.00, percent_cpu=6410%
timeout=false
algorithm=sigouin_int_avl_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1