__step=000747
__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_bst_kcas_validate.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000747.txt
__path_data=data/data000747.txt
__hostname=jax
sizeof(kcasdesc_t)=2304
sizeof(rdcssdesc_t)=192
addrof(kcasDescriptors[0])=0x56540b114400
addrof(kcasDescriptors[1])=0x56540b114d00
addrof(rdcssDescriptors[0])=0x56540b234400
addrof(rdcssDescriptors[1])=0x56540b2344c0
sizeof(validationSet)=1608
REALTIME_MAIN_START_PERF_FORMAT=6987943.537682735
binary=./sigouin_int_bst_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_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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=50.0 50.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,24,25,26,27,28,29,30,31,32,33,34,35,36,37,38,39,40,41,42,43,44,45,46,47,120,121,122,123,124,125,126,127,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.033s
prefilling_size=8836570 prefilling_elapsed_millis=1s
prefilling_size=9033691 prefilling_elapsed_millis=1.1s
prefilling_size=9193010 prefilling_elapsed_millis=1.201s
prefilling_size=9324855 prefilling_elapsed_millis=1.301s
prefilling_size=9436283 prefilling_elapsed_millis=1.401s
prefilling_size=9529004 prefilling_elapsed_millis=1.501s
prefilling_size=9606048 prefilling_elapsed_millis=1.601s
prefilling_size=9672506 prefilling_elapsed_millis=1.701s
prefilling_size=9725161 prefilling_elapsed_millis=1.802s
prefilling_size=9767810 prefilling_elapsed_millis=1.902s
prefilling_size=9806635 prefilling_elapsed_millis=2.002s
finished prefilling to size 9806649 for expected size 10000000 keysum=98050603386769, performing 80062524 updates; total_prefilling_elapsed_ms=2104 ms)
pref_size=9806649
pref_millis=2104
prefill_elapsed_ms=2126
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6987945.920157525
REALTIME_END_PERF_FORMAT=6987955.920243240
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10.1s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 828 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.219s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 121 230 431 772 1381 2413 4171 6949 11389 18320 28669 43499 63832 90755 125225 167860 217513 271572 327225 379738 425387 460550 481982 486592 475209 447899 407167 357489 302562 247449 196361 149895 111413 79965 55603 37288 24422 15199 9177 5317 2952 1525 816 431 184 68 23 7 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 4 8 15 56 77 204 360 777 1355 2480 4351 7502 12584 19938 30425 44340 63357 87919 115486 146765 178083 208428 233046 252317 263391 264898 257258 239643 216273 187270 156164 126602 97917 74310 54250 38348 25976 17479 10953 6756 3954 2265 1160 590 354 153 58 20 5 3
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 125 238 446 828 1458 2617 4531 7726 12744 20800 33020 51001 76416 110693 155650 212200 280870 359491 442711 526503 603470 668978 715028 738909 738600 712797 664425 597132 518835 434719 352525 276497 209330 154275 109853 75636 50398 32678 20130 12073 6906 3790 1976 1021 538 221 81 27 8 3
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 125 238 446 828 1458 2617 4531 7726 12744 20800 33020 51001 76416 110693 155650 212200 280870 359491 442711 526503 603470 668978 715028 738909 738600 712797 664425 597132 518835 434719 352525 276497 209330 154275 109853 75636 50398 32678 20130 12073 6906 3790 1976 1021 538 221 81 27 8 3
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.95312 1.936 1.90756 1.89013 1.8285 1.84774 1.80932 1.7846 1.75006 1.73847 1.70673 1.67632 1.64542 1.61324 1.58626 1.55879 1.53256 1.50549 1.47606 1.45013 1.42494 1.40365 1.3804 1.35932 1.34105 1.32167 1.30377 1.28591 1.2702 1.25472 1.24171 1.22732 1.21496 1.20476 1.19373 1.18236 1.17333 1.16382 1.1509 1.14386 1.13162 1.12134 1.119 1.10374 1.1048 1.06877 1.05882 1.04938 1.03704 1 1
tree_stats_height=57
tree_stats_numInternals=6545127
tree_stats_numLeaves=3455927
tree_stats_numNodes=10001054
tree_stats_numKeys=10001054
tree_stats_avgDegreeInternal=1.52802
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34556
tree_stats_avgKeyDepth=30.4652
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:14 2:1 4:1 8:1 16:2 32:14 64:60 128:410317 256:4282 512:95
[2^00, 2^01]: 14
(2^01, 2^02]: 1
(2^02, 2^03]: 1
(2^03, 2^04]: 1
(2^04, 2^05]: 2
(2^05, 2^06]: 14
(2^06, 2^07]: 60
(2^07, 2^08]: 410317
(2^08, 2^09]: 4282
(2^09, 2^10]: 95
sum_limbo_reclamation_event_size_total=90423063
count_limbo_reclamation_event_size_by_thread=4321 4321 4321 4321 4321 4321 4321 4319 4321 4321 4320 4321 4321 4321 4321 4319 4321 4321 4321 4321 4321 4320 4321 4321 4320 4321 4321 4321 4321 4320 4320 4321 4321 4319 4321 4321 4321 4320 4321 4320 4321 4321 4321 4321 4321 4321 4321 4321 4321 4320 4321 4321 4321 4321 4320 4320 4321 4321 4319 4321 4321 4321 4320 4321 4319 4320 4320 4321 4321 4321 4321 4320 4320 4321 4321 4321 4320 4321 4321 4321 4321 4321 4321 4321 4321 4321 4321 4321 4320 4321 4320 4321 4321 4321 4320 4321
count_limbo_reclamation_event_size_total=414787
sum_limbo_reclamation_event_count_total=415008
first_thread_announced_epoch_by_thread=10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482 10482
sum_num_inserts_by_thread=1876777 1884043 1899007 1893712 1884115 1872286 1878872 1885570 1901662 1904383 1889951 1882066 1887190 1891491 1903008 1898917 1887851 1878195 1872524 1885535 1891612 1896588 1882213 1864125 1866989 1879857 1893201 1889320 1883056 1870611 1877360 1889803 1903257 1899031 1884273 1870980 1879653 1887959 1902171 1899462 1891210 1881737 1870494 1887329 1892081 1898359 1880667 1873845 1881641 1886883 1897637 1897005 1874477 1872728 1872137 1884287 1897342 1902506 1886359 1878241 1878124 1888610 1892921 1891965 1890734 1873892 1874659 1880448 1895853 1895637 1878451 1871895 1879159 1890822 1900607 1895611 1890615 1878103 1882364 1890117 1898757 1903103 1885523 1883218 1877008 1889405 1896132 1900543 1894841 1877915 1878435 1884398 1902763 1902914 1883723 1884118
sum_num_inserts_total=181139024
sum_num_deletes_by_thread=1875682 1883897 1896839 1889447 1882145 1870497 1878974 1887511 1898068 1902660 1886752 1879564 1883755 1890704 1903638 1896811 1889599 1880961 1872586 1883031 1890779 1898487 1881615 1865695 1867200 1878189 1895274 1892851 1884559 1868078 1878117 1887058 1902527 1899156 1886111 1869957 1879512 1887685 1901829 1899642 1892186 1881747 1873385 1884089 1895568 1895823 1881902 1873269 1881400 1885321 1898588 1896132 1876845 1870993 1871363 1883980 1896250 1903647 1887122 1877694 1877753 1887972 1893087 1890811 1887019 1874970 1873317 1877184 1890732 1895652 1880214 1876106 1878525 1889034 1898934 1899617 1886854 1879839 1882312 1887883 1897719 1903306 1887179 1881252 1878367 1890763 1894040 1901480 1896837 1876637 1878990 1887346 1899976 1901556 1886470 1883234
sum_num_deletes_total=181107713
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3752459 3767940 3795846 3783159 3766260 3742783 3757846 3773081 3799730 3807043 3776703 3761630 3770945 3782195 3806646 3795728 3777450 3759156 3745110 3768566 3782391 3795075 3763828 3729820 3734189 3758046 3788475 3782171 3767615 3738689 3755477 3776861 3805784 3798187 3770384 3740937 3759165 3775644 3804000 3799104 3783396 3763484 3743879 3771418 3787649 3794182 3762569 3747114 3763041 3772204 3796225 3793137 3751322 3743721 3743500 3768267 3793592 3806153 3773481 3755935 3755877 3776582 3786008 3782776 3777753 3748862 3747976 3757632 3786585 3791289 3758665 3748001 3757684 3779856 3799541 3795228 3777469 3757942 3764676 3778000 3796476 3806409 3772702 3764470 3755375 3780168 3790172 3802023 3791678 3754552 3757425 3771744 3802739 3804470 3770193 3767352
average_num_operations_total=3773403
stdev_num_operations_total=2012
sum_num_operations_total=362246737
min_num_operations_total=3729820
max_num_operations_total=3807043
first_time_thread_terminate_by_thread=10000086 10000086 10000088 10000089 10000088 10000086 10000102 10000089 10000086 10000198 10000088 10000087 10000088 10000088 10000089 10000088 10000088 10000087 10000213 10000086 10000087 10000089 10000169 10000088 10000087 10000086 10000088 10000089 10000087 10000087 10000119 10000090 10000086 10000088 10000089 10000086 10000088 10000086 10000105 10000087 10000088 10000128 10000086 10000087 10000086 10000089 10000123 10000088 10000087 10000137 10000136 10000137 10000086 10000154 10000088 10000086 10000087 10000086 10000087 10000085 10000086 10000105 10000086 10000086 10000088 10000088 10000087 10000088 10000086 10000086 10000085 10000191 10000087 10000085 10000150 10000127 10000086 10000086 10000089 10000089 10000087 10000086 10000088 10000086 10000086 10000107 10000134 10000123 10000086 10000089 10000087 10000086 10000086 10000086 10000085 10000085
min_time_thread_terminate_total=10000085
max_time_thread_terminate_total=10000213
first_time_thread_start_by_thread=7 6 6 7 7 7 7 6 6 6 6 7 6 7 7 6 7 6 7 6 7 6 6 6 7 6 6 7 7 7 7 6 6 6 6 7 6 7 7 6 7 6 7 6 7 6 6 6 6 6 6 9 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6
min_time_thread_start_total=5
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=100005619016189
threads_final_size=10001054
final_keysum=100005619016189
final_size=10001054
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=181139024
total_deletes=181107713
total_updates=362246737
total_queries=0
total_ops=362246737
find_throughput=0
rq_throughput=0
update_throughput=36224673
query_throughput=0
total_throughput=36224673
total find : 0
total rq : 0
total inserts : 181139024
total deletes : 181107713
total updates : 362246737
total queries : 0
total ops : 362246737
find throughput : 0
rq throughput : 0
update throughput : 36224673
query throughput : 0
total throughput : 36224673
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=30.8351
PAPI_L3_TCM=10.8386
PAPI_TOT_CYC=7382.58
PAPI_TOT_INS=2392.53
garbage=0
total_execution_walltime=12.768s
REALTIME_MAIN_END_PERF_FORMAT=6987956.306568060
[time_cmd_output] time_elapsed_sec=12.93, faults_major=0, faults_minor=242934, mem_maxresident_kb=969376, user_cputime=1191.91, sys_cputime=5.40, percent_cpu=9254%
timeout=false
algorithm=sigouin_int_bst_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