__step=000265
__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_bst_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 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000265.txt
__path_data=data/data000265.txt
__hostname=nasus
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x562fe63133c0
addrof(kcasDescriptors[1])=0x562fe6313cc0
addrof(rdcssDescriptors[0])=0x562fe64333c0
addrof(rdcssDescriptors[1])=0x562fe6433480
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=223067.491980677
binary=./sigouin_int_bst_kcas_validate.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=sigouin_int_bst_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=200000
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.023s
prefilling_size=99978 prefilling_elapsed_millis=1s
finished prefilling to size 99982 for expected size 100000 keysum=9997009914, performing 48260106 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=99982
pref_millis=1101
prefill_elapsed_ms=1115
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=223068.644483860
REALTIME_END_PERF_FORMAT=223078.644574842
###############################################################################
################################## 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 1545 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.101s
tree_stats_numInternalsAtDepth=1 2 4 8 16 31 53 87 152 268 475 839 1374 2119 3059 4157 5229 6143 6651 6868 6564 5829 4783 3636 2667 1820 1222 738 391 157 53 20 3 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 1 6 10 8 19 32 60 171 347 641 1058 1671 2336 3011 3417 3811 3884 3550 3098 2397 1803 1272 881 553 332 129 38 18 1 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 59 97 160 287 507 899 1545 2466 3700 5215 6900 8479 9662 10285 10375 9713 8333 6734 5064 3623 2494 1619 944 489 182 58 21 3 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 59 97 160 287 507 899 1545 2466 3700 5215 6900 8479 9662 10285 10375 9713 8333 6734 5064 3623 2494 1619 944 489 182 58 21 3 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.875 1.74576 1.75258 1.84375 1.83275 1.83629 1.78532 1.7068 1.64112 1.5827 1.52598 1.47101 1.41503 1.37611 1.34098 1.30352 1.2578 1.23413 1.21206 1.18878 1.18603 1.15918 1.12724 1.10381 1.05112 1.02747 1.01724 1 1 1
tree_stats_height=35
tree_stats_numInternals=65421
tree_stats_numLeaves=34557
tree_stats_numNodes=99978
tree_stats_numKeys=99978
tree_stats_avgDegreeInternal=1.52822
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34565
tree_stats_avgKeyDepth=19.441
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:12 2:415 4:23335 8:424528 16:191244 32:16 64:74 128:115 256:63
[2^00, 2^01]: 12
(2^01, 2^02]: 415
(2^02, 2^03]: 23335
(2^03, 2^04]: 424528
(2^04, 2^05]: 191244
(2^05, 2^06]: 16
(2^06, 2^07]: 74
(2^07, 2^08]: 115
(2^08, 2^09]: 63
sum_limbo_reclamation_event_size_total=8802377
count_limbo_reclamation_event_size_by_thread=9997 9997 9997 9998 9997 9997 9997 9997 9997 9996 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9996 9997 9997 9997 9997 9996 9996 9997 9997 9997 9997 9997 9997 9996 9997 9996 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9997 9996 9997 9997
count_limbo_reclamation_event_size_total=639802
sum_limbo_reclamation_event_count_total=1912010
first_thread_announced_epoch_by_thread=62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570 62570
sum_num_inserts_by_thread=787591 820765 816876 812705 805237 799550 799055 797038 789886 780960 774907 779224 891491 805406 801034 916307 944279 847912 852811 850156 785058 782149 771990 761433 759692 764476 762731 759238 791018 908414 903937 817581 781674 782779 782443 779766 762846 756376 752389 755271 825264 749667 824243 861803 813818 907204 815823 907186 775729 778558 777624 766959 766944 773205 776626 782063 886456 889296 906587 906136 909191 909949 916295 915912
sum_num_inserts_total=52336989
sum_num_deletes_by_thread=787135 820111 816598 812734 804571 799422 799178 797718 787853 781177 775857 778232 891804 803516 801541 914804 946230 848147 851114 849022 786045 779965 771434 762315 760957 765197 761242 757754 789565 906995 903738 818079 781819 783264 782841 779045 761682 756793 752291 754543 823629 748514 824170 862771 814315 910015 816111 907575 777246 778430 776078 766298 766987 772305 775927 782171 888022 889586 907636 906141 909948 910133 915779 915360
sum_num_deletes_total=52327475
sum_num_searches_by_thread=14179736 14771503 14696158 14626895 14481583 14394734 14403151 14356857 14213416 14066919 13965849 14025687 16045752 14487752 14416405 16472019 17023144 15261360 15335312 15299277 14130316 14066312 13884148 13736364 13693574 13771860 13697614 13647978 14217891 16358200 16271952 14734750 14060921 14092267 14072954 14026244 13729614 13615813 13542560 13564627 14845171 13467236 14842165 15524583 14679526 16340376 14680088 16338603 13982220 14014317 13980976 13806066 13809944 13907720 13975583 14062231 15937038 15995846 16344613 16315695 16384685 16378941 16495419 16477713
sum_num_searches_total=942026223
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=15754462 16412379 16329632 16252334 16091391 15993706 16001384 15951613 15791155 15629056 15516613 15583143 17829047 16096674 16018980 18303130 18913653 16957419 17039237 16998455 15701419 15628426 15427572 15260112 15214223 15301533 15221587 15164970 15798474 18173609 18079627 16370410 15624414 15658310 15638238 15585055 15254142 15128982 15047240 15074441 16494064 14965417 16490578 17249157 16307659 18157595 16312022 18153364 15535195 15571305 15534678 15339323 15343875 15453230 15528136 15626465 17711516 17774728 18158836 18127972 18203824 18199023 18327493 18308985
average_num_operations_total=16354541
stdev_num_operations_total=141911
sum_num_operations_total=1046690687
min_num_operations_total=14965417
max_num_operations_total=18913653
first_time_thread_terminate_by_thread=10000089 10000089 10000089 10000089 10000090 10000090 10000090 10000090 10000088 10000088 10000088 10000088 10000090 10000090 10000090 10000090 10000087 10000087 10000087 10000087 10000089 10000089 10000089 10000089 10000087 10000087 10000087 10000087 10000090 10000090 10000090 10000090 10000086 10000086 10000086 10000086 10000088 10000088 10000088 10000088 10000088 10000088 10000088 10000088 10000089 10000089 10000089 10000089 10000086 10000086 10000086 10000086 10000088 10000088 10000088 10000088 10000088 10000088 10000088 10000088 10000089 10000089 10000089 10000089
min_time_thread_terminate_total=10000086
max_time_thread_terminate_total=10000090
first_time_thread_start_by_thread=5 5 5 5 4 4 4 4 4 4 4 4 6 6 6 6 4 5 5 4 7 7 7 7 7 7 7 7 6 6 6 6 4 4 4 4 6 6 6 6 6 5 5 5 6 6 6 6 4 4 4 4 7 7 7 7 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=9996847465
threads_final_size=99978
final_keysum=9996847465
final_size=99978
validate_result=success
Validation OK.
Structural validation OK.
total_find=942026223
total_rq=0
total_inserts=52336989
total_deletes=52327475
total_updates=104664464
total_queries=942026223
total_ops=1046690687
find_throughput=94202622
rq_throughput=0
update_throughput=10466446
query_throughput=94202622
total_throughput=104669068
total find : 942026223
total rq : 0
total inserts : 52336989
total deletes : 52327475
total updates : 104664464
total queries : 942026223
total ops : 1046690687
find throughput : 94202622
rq throughput : 0
update throughput : 10466446
query throughput : 94202622
total throughput : 104669068
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=32842625065006
total_execution_walltime=11.347s
REALTIME_MAIN_END_PERF_FORMAT=223078.840293120
[time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=77328, mem_maxresident_kb=309796, user_cputime=735.94, sys_cputime=4.33, percent_cpu=6463%
timeout=false
algorithm=sigouin_int_bst_kcas_validate.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1