__step=000367
__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" ./wang_openbwtree -nwork 190 -nprefill 190 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000367.txt
__path_data=data/data000367.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6983213.405357721
binary=./wang_openbwtree
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=wang_openbwtree
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=20000000
PREFILL_THREADS=190
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=190
WORK_THREADS=190
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
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,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.03s
prefilling_size=3721705 prefilling_elapsed_millis=1.001s
prefilling_size=4010413 prefilling_elapsed_millis=1.102s
prefilling_size=4287380 prefilling_elapsed_millis=1.202s
prefilling_size=4557234 prefilling_elapsed_millis=1.303s
prefilling_size=4806775 prefilling_elapsed_millis=1.404s
prefilling_size=5047660 prefilling_elapsed_millis=1.504s
prefilling_size=5280648 prefilling_elapsed_millis=1.605s
prefilling_size=5498570 prefilling_elapsed_millis=1.706s
prefilling_size=5706250 prefilling_elapsed_millis=1.807s
prefilling_size=5906707 prefilling_elapsed_millis=1.907s
prefilling_size=6097264 prefilling_elapsed_millis=2.008s
prefilling_size=6277426 prefilling_elapsed_millis=2.109s
prefilling_size=6451113 prefilling_elapsed_millis=2.21s
prefilling_size=6614747 prefilling_elapsed_millis=2.31s
prefilling_size=6771253 prefilling_elapsed_millis=2.411s
prefilling_size=6923726 prefilling_elapsed_millis=2.512s
prefilling_size=7065668 prefilling_elapsed_millis=2.613s
prefilling_size=7201690 prefilling_elapsed_millis=2.713s
prefilling_size=7332029 prefilling_elapsed_millis=2.814s
prefilling_size=7454743 prefilling_elapsed_millis=2.914s
prefilling_size=7573286 prefilling_elapsed_millis=3.015s
prefilling_size=7685933 prefilling_elapsed_millis=3.116s
prefilling_size=7793061 prefilling_elapsed_millis=3.216s
prefilling_size=7894268 prefilling_elapsed_millis=3.317s
prefilling_size=7992973 prefilling_elapsed_millis=3.418s
prefilling_size=8085073 prefilling_elapsed_millis=3.519s
prefilling_size=8174690 prefilling_elapsed_millis=3.619s
prefilling_size=8259148 prefilling_elapsed_millis=3.72s
prefilling_size=8339441 prefilling_elapsed_millis=3.821s
prefilling_size=8416076 prefilling_elapsed_millis=3.922s
prefilling_size=8489659 prefilling_elapsed_millis=4.022s
prefilling_size=8559898 prefilling_elapsed_millis=4.123s
prefilling_size=8626364 prefilling_elapsed_millis=4.224s
prefilling_size=8689708 prefilling_elapsed_millis=4.324s
prefilling_size=8748928 prefilling_elapsed_millis=4.425s
prefilling_size=8807330 prefilling_elapsed_millis=4.526s
prefilling_size=8862441 prefilling_elapsed_millis=4.627s
prefilling_size=8914849 prefilling_elapsed_millis=4.728s
prefilling_size=8964428 prefilling_elapsed_millis=4.828s
prefilling_size=9011834 prefilling_elapsed_millis=4.929s
prefilling_size=9057718 prefilling_elapsed_millis=5.03s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 942076 keys with 190 threads...
tid=0 thread_prefill_amount=49444 percent_done_estimate=997.2 elapsed_s=5 est_remaining_s=-10 / -5
tid=0 thread_prefill_amount=50496 percent_done_estimate=1018.4 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=51548 percent_done_estimate=1039.6 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=52600 percent_done_estimate=1060.8 elapsed_s=5 est_remaining_s=-11 / -5
tid=0 thread_prefill_amount=53652 percent_done_estimate=1082.1 elapsed_s=5 est_remaining_s=-11 / -5
timing_elapsed 0.111098s
prefilling_size=10000000 prefilling_elapsed_millis=0.111s
finished prefilling to size 10000000 for expected size 10000000 keysum=100007406866875, performing 49171215 updates; total_prefilling_elapsed_ms=111 ms)
pref_size=10000000
pref_millis=111
prefill_elapsed_ms=111
main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6983218.901509826
REALTIME_END_PERF_FORMAT=6983228.901617741

###############################################################################
################################## TIME IS UP #################################
###############################################################################

joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################

10.1s
PRODUCING OUTPUT
Open BwTree: createTreeStats iterating over all kv-pairs...
Open BwTree: createTreeStats finished iterating.

tree_stats_computeWalltime=0.178s

tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9997187
tree_stats_avgDegreeAtDepth=9.99719e+06

tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=9997187

tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99719e+06
tree_stats_avgDegree=9.99719e+06
tree_stats_avgKeyDepth=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
    [2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=
first_thread_announced_epoch_by_thread=
sum_num_inserts_by_thread=117696 119530 119363 121789 122827 120285 119265 120108 120189 122227 120590 121242 119999 119703 120520 122708 121017 121114 119160 119880 120534 122299 121270 120807 119030 119053 119488 121589 122432 120161 118859 120333 120656 122146 120993 121330 120377 120147 120615 123309 121623 121494 118921 120034 120546 122328 121287 120601 87794 87761 87424 89693 88412 88251 87994 88483 88169 90475 88463 89300 87875 88078 88118 90426 88132 88414 86498 86583 88153 89351 89022 88327 87190 87379 87769 88797 88408 87616 88302 88389 88153 90214 88656 89317 87988 87766 87818 89926 88266 88403 87460 86446 87493 89048 89000 87906 121569 121668 121801 123206 124850 122464 121781 122854 122683 125199 123859 124230 123070 122671 123026 124710 123435 123222 122066 121346 123058 124846 124267 123368 122194 122128 121731 122986 124214 122503 121776 121949 122342 124809 122573 123836 121700 122595 122753 124391 122783 123141 121691 121782 122036 124392 123790 123169 127521 128323 127293 129978 129272 129863 127210 128057 127444 129844 128916 129488 127604 127903 129337 130377 128074 127976 128422 127722 127655 130043 144734 143272 127095 127683 127106 129829 128235 129420 127527 128035 127276 129952 128993 129248 127448 127855 129423 130065 128119 128053 128128 126967 128147 129789
sum_num_inserts_total=21873614
sum_num_deletes_by_thread=118296 119411 119706 121264 122395 120097 119939 120360 120420 122896 120654 120932 120461 120090 120172 122623 120832 121445 119482 119678 120520 122216 121688 121255 119687 119320 119818 121014 121966 120742 119963 120105 120863 123166 120832 121483 120792 120697 119795 122834 121259 121205 119564 120254 120108 121603 120269 120811 87148 87529 87813 89441 88647 88266 88190 88357 87649 90059 88626 89202 88343 88409 88682 90382 88524 87935 87038 86532 87406 88730 88951 88635 87040 87522 87405 89819 88777 88051 87747 88130 87796 90220 88778 89381 88289 87521 88051 90087 88547 88452 86479 86652 88138 88623 88396 88340 121073 122207 121505 123328 124117 123011 122393 122593 122428 125429 123362 122718 122735 122337 122678 125343 122794 123166 121591 121377 122410 125137 123503 123276 121483 121274 121408 123392 124005 122643 121921 121942 122649 125638 123134 123335 122321 122186 122109 124580 122706 122871 121815 121364 122436 124295 123048 123101 126957 128154 127406 129743 128917 129933 127553 128058 128047 130194 128278 129394 127320 128112 128260 130151 128450 129016 127701 127934 127614 130680 144153 143680 126694 128136 127514 129709 129193 129805 126677 127333 127912 129890 128582 129468 127627 127688 129067 130333 128408 129304 127915 127516 127370 130236
sum_num_deletes_total=21871966
sum_num_searches_by_thread=2132803 2146656 2152062 2186441 2201433 2166877 2147417 2163912 2166680 2207218 2171039 2176665 2159024 2159807 2164991 2204444 2180701 2185645 2147704 2161330 2168206 2197034 2179099 2177769 2138041 2152203 2152767 2187462 2203078 2166837 2147286 2164695 2165892 2203857 2171891 2175795 2159043 2155665 2164909 2204764 2180394 2185056 2148632 2161555 2165411 2197854 2179962 2177941 1576314 1579172 1575741 1608963 1599003 1592060 1588032 1592859 1586341 1626584 1594491 1609615 1585889 1583332 1588820 1632596 1592344 1591671 1559564 1561549 1580687 1598290 1594166 1590389 1573122 1574362 1569090 1603454 1595313 1581107 1581902 1591510 1582354 1622357 1596263 1604824 1584295 1577069 1584721 1623140 1592767 1589267 1562809 1562858 1581296 1596841 1594056 1588479 2189452 2190703 2191650 2216638 2239092 2210037 2192743 2200501 2205972 2260209 2226093 2222361 2211092 2210156 2212348 2247903 2219648 2219501 2190612 2186099 2209793 2241547 2233753 2229154 2188218 2191180 2190508 2219216 2242511 2213718 2196631 2203426 2199445 2249419 2219719 2216189 2202198 2206515 2204526 2240971 2213010 2210489 2182980 2190564 2197968 2239112 2227065 2222105 2285003 2308182 2299336 2335791 2320527 2331444 2291717 2304089 2303460 2338461 2317808 2326432 2298586 2302490 2316612 2338806 2306502 2314756 2293910 2291761 2304125 2341486 2598459 2595168 2294306 2308889 2302228 2336005 2318592 2328731 2291675 2300183 2302619 2337167 2312921 2325692 2300859 2305623 2316280 2337392 2306070 2313084 2292868 2294621 2301550 2343235
sum_num_searches_total=393677916
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2368795 2385597 2391131 2429494 2446655 2407259 2386621 2404380 2407289 2452341 2412283 2418839 2399484 2399600 2405683 2449775 2422550 2428204 2386346 2400888 2409260 2441549 2422057 2419831 2376758 2390576 2392073 2430065 2447476 2407740 2386108 2405133 2407411 2449169 2413716 2418608 2400212 2396509 2405319 2450907 2423276 2427755 2387117 2401843 2406065 2441785 2421518 2419353 1751256 1754462 1750978 1788097 1776062 1768577 1764216 1769699 1762159 1807118 1771580 1788117 1762107 1759819 1765620 1813404 1769000 1768020 1733100 1734664 1756246 1776371 1772139 1767351 1747352 1749263 1744264 1782070 1772498 1756774 1757951 1768029 1758303 1802791 1773697 1783522 1760572 1752356 1760590 1803153 1769580 1766122 1736748 1735956 1756927 1774512 1771452 1764725 2432094 2434578 2434956 2463172 2488059 2455512 2436917 2445948 2451083 2510837 2473314 2469309 2456897 2455164 2458052 2497956 2465877 2465889 2434269 2428822 2455261 2491530 2481523 2475798 2431895 2434582 2433647 2465594 2490730 2458864 2440328 2447317 2444436 2499866 2465426 2463360 2446219 2451296 2449388 2489942 2458499 2456501 2426486 2433710 2442440 2487799 2473903 2468375 2539481 2564659 2554035 2595512 2578716 2591240 2546480 2560204 2558951 2598499 2575002 2585314 2553510 2558505 2574209 2599334 2563026 2571748 2550033 2547417 2559394 2602209 2887346 2882120 2548095 2564708 2556848 2595543 2576020 2587956 2545879 2555551 2557807 2597009 2570496 2584408 2555934 2561166 2574770 2597790 2562597 2570441 2548911 2549104 2557067 2603260
average_num_operations_total=2302228
stdev_num_operations_total=23328
sum_num_operations_total=437423496
min_num_operations_total=1733100
max_num_operations_total=2887346
first_time_thread_terminate_by_thread=10000212 10000107 10000110 10000112 10000107 10000108 10000110 10000114 10000111 10000110 10000112 10000113 10000107 10000108 10000108 10000107 10000114 10000110 10000113 10000110 10000110 10000110 10000110 10000110 10000110 10000107 10000110 10000112 10000107 10000111 10000110 10000114 10000108 10000110 10000112 10000113 10000107 10000108 10000111 10000107 10000114 10000114 10000113 10000110 10000111 10000110 10000110 10000110 10000109 10000112 10000109 10000114 10000115 10000114 10000108 10000109 10000108 10000114 10000114 10000109 10000112 10000109 10000109 10000108 10000112 10000109 10000114 10000114 10000108 10000114 10000114 10000109 10000109 10000112 10000109 10000114 10000114 10000114 10000108 10000109 10000108 10000114 10000109 10000109 10000112 10000108 10000109 10000109 10000114 10000109 10000114 10000114 10000108 10000114 10000114 10000114 10000115 10000108 10000113 10000110 10000113 10000110 10000109 10000109 10000111 10000112 10000109 10000112 10000112 10000109 10000112 10000108 10000112 10000113 10000111 10000113 10000110 10000110 10000115 10000111 10000115 10000108 10000115 10000110 10000113 10000110 10000109 10000109 10000111 10000112 10000109 10000109 10000112 10000112 10000112 10000108 10000112 10000115 10000111 10000113 10000113 10000110 10000113 10000111 10000109 10000113 10000115 10000111 10000109 10000109 10000108 10000108 10000108 10000115 10000115 10000108 10000113 10000115 10000108 10000108 10000113 10000108 10000114 10000111 10000111 10000111 10000109 10000113 10000109 10000113 10000115 10000111 10000109 10000109 10000108 10000108 10000108 10000108 10000115 10000108 10000113 10000115 10000108 10000115 10000115 10000108 10000114 10000111 10000111 10000111
min_time_thread_terminate_total=10000107
max_time_thread_terminate_total=10000212
first_time_thread_start_by_thread=9 5 5 4 5 4 5 5 4 4 5 5 5 4 5 5 4 5 4 4 5 4 4 5 4 5 5 4 5 4 5 5 4 4 5 5 5 4 5 5 4 5 4 4 5 4 4 5 5 6 6 6 5 6 5 6 6 6 5 5 5 5 5 5 6 6 6 5 5 5 5 5 5 6 6 6 5 6 5 6 6 6 5 5 5 5 5 5 6 6 6 5 5 5 5 5 5 6 5 6 5 5 6 6 6 5 5 6 6 6 6 6 5 5 6 5 6 5 6 5 5 6 5 6 5 5 6 6 6 5 5 6 6 6 6 6 5 6 6 5 6 5 6 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99976641134507
threads_final_size=9997187
final_keysum=99976641134507
final_size=9997187
validate_result=success
Validation OK.
Structural validation OK.

total_find=393677916
total_rq=0
total_inserts=21873614
total_deletes=21871966
total_updates=43745580
total_queries=393677916
total_ops=437423496
find_throughput=39367791
rq_throughput=0
update_throughput=4374558
query_throughput=39367791
total_throughput=43742349


total find                    : 393677916
total rq                      : 0
total inserts                 : 21873614
total deletes                 : 21871966
total updates                 : 43745580
total queries                 : 393677916
total ops                     : 437423496
find throughput               : 39367791
rq throughput                 : 0
update throughput             : 4374558
query throughput              : 39367791
total throughput              : 43742349

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=37.7163
PAPI_L3_TCM=16.9503
PAPI_TOT_CYC=12071.2
PAPI_TOT_INS=840.677
garbage=1956870041995623
total_execution_walltime=15.795s
REALTIME_MAIN_END_PERF_FORMAT=6983229.201906850
[time_cmd_output] time_elapsed_sec=16.02, faults_major=0, faults_minor=412073, mem_maxresident_kb=1601976, user_cputime=2892.26, sys_cputime=11.25, percent_cpu=18114%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1