__step=000702
__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 192 -nprefill 192 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000702.txt
__path_data=data/data000702.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=215263.671457560
binary=./wang_openbwtree
parsed custom binding: 0-63,128-191,64-127,192-255
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=50
DEL_FRAC=50
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=192
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=192
WORK_THREADS=192
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
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,128,129,130,131,132,133,134,135,136,137,138,139,140,141,142,143,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189,190,191,64,65,66,67,68,69,70,71,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119,120,121,122,123,124,125,126,127
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.043s
prefilling_size=4682055 prefilling_elapsed_millis=1s
prefilling_size=5003496 prefilling_elapsed_millis=1.101s
prefilling_size=5312356 prefilling_elapsed_millis=1.201s
prefilling_size=5596122 prefilling_elapsed_millis=1.301s
prefilling_size=5865248 prefilling_elapsed_millis=1.401s
prefilling_size=6116141 prefilling_elapsed_millis=1.501s
prefilling_size=6354364 prefilling_elapsed_millis=1.602s
prefilling_size=6574372 prefilling_elapsed_millis=1.702s
prefilling_size=6783337 prefilling_elapsed_millis=1.802s
prefilling_size=6979662 prefilling_elapsed_millis=1.902s
prefilling_size=7161067 prefilling_elapsed_millis=2.002s
prefilling_size=7333154 prefilling_elapsed_millis=2.103s
prefilling_size=7494013 prefilling_elapsed_millis=2.203s
prefilling_size=7643888 prefilling_elapsed_millis=2.303s
prefilling_size=7785192 prefilling_elapsed_millis=2.403s
prefilling_size=7916900 prefilling_elapsed_millis=2.504s
prefilling_size=8042673 prefilling_elapsed_millis=2.604s
prefilling_size=8159587 prefilling_elapsed_millis=2.704s
prefilling_size=8271293 prefilling_elapsed_millis=2.804s
prefilling_size=8374580 prefilling_elapsed_millis=2.904s
prefilling_size=8471554 prefilling_elapsed_millis=3.005s
prefilling_size=8562796 prefilling_elapsed_millis=3.105s
prefilling_size=8649974 prefilling_elapsed_millis=3.206s
prefilling_size=8731434 prefilling_elapsed_millis=3.306s
prefilling_size=8807572 prefilling_elapsed_millis=3.406s
prefilling_size=8879445 prefilling_elapsed_millis=3.506s
prefilling_size=8947145 prefilling_elapsed_millis=3.607s
prefilling_size=9010820 prefilling_elapsed_millis=3.707s
prefilling_size=9068912 prefilling_elapsed_millis=3.807s
prefilling_size=9123719 prefilling_elapsed_millis=3.907s
prefilling_size=9176550 prefilling_elapsed_millis=4.007s
prefilling_size=9226014 prefilling_elapsed_millis=4.108s
prefilling_size=9273155 prefilling_elapsed_millis=4.208s
prefilling_size=9316497 prefilling_elapsed_millis=4.308s
prefilling_size=9358258 prefilling_elapsed_millis=4.408s
prefilling_size=9396996 prefilling_elapsed_millis=4.509s
prefilling_size=9432991 prefilling_elapsed_millis=4.609s
prefilling_size=9468122 prefilling_elapsed_millis=4.709s
prefilling_size=9500161 prefilling_elapsed_millis=4.809s
prefilling_size=9529745 prefilling_elapsed_millis=4.909s
prefilling_size=9556944 prefilling_elapsed_millis=5.01s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 443022 keys with 192 threads...
tid=0 thread_prefill_amount=47886 percent_done_estimate=2075.3 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=48927 percent_done_estimate=2120.4 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=49968 percent_done_estimate=2165.5 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.0451591s
prefilling_size=10000000 prefilling_elapsed_millis=0.047s
finished prefilling to size 10000000 for expected size 10000000 keysum=100001579423840, performing 63382981 updates; total_prefilling_elapsed_ms=47 ms)
pref_size=10000000
pref_millis=47
prefill_elapsed_ms=47
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=215268.906900539
REALTIME_END_PERF_FORMAT=215278.906975991
###############################################################################
################################## 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.309s
tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=9998674
tree_stats_avgDegreeAtDepth=9.99867e+06
tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=9998674
tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=9.99867e+06
tree_stats_avgDegree=9.99868e+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=324616 328012 326222 325824 324764 327040 325620 326996 324850 326763 325844 327532 325523 326562 325485 327593 333326 334816 333650 334537 334368 334873 334458 334970 334100 334132 333514 334056 333140 333587 333129 334972 331416 331623 332026 332399 330922 331263 330232 331857 331924 332158 332110 331735 331081 332171 331310 331639 333056 332724 331747 332231 333275 333322 333511 333933 333598 333721 332931 334215 333878 333521 334044 333970 325157 327067 326035 326691 324325 326444 325900 326475 325132 325908 326096 326039 324884 326401 325234 326776 333834 334275 334738 334413 334740 333976 332466 334468 333681 333521 333015 334123 333949 333647 333709 333907 332137 332124 330464 332740 331407 331446 330666 329942 331827 331457 332049 332278 331919 331680 331604 331234 332362 332646 331976 331707 332645 333670 332640 333652 333090 332824 333293 333653 333082 333968 333157 334252 345150 346025 346012 346272 345574 345846 346212 345382 345097 346252 345379 345018 344845 345678 346232 345589 345115 346033 345550 345469 345367 345152 346005 345679 344664 345475 345257 345545 344842 345656 345332 345653 346427 345640 345988 346334 345681 345853 346020 345903 344935 345839 344798 346513 345728 346411 346153 346550 346105 345645 345497 345473 344909 344975 345788 345416 345774 345263 346348 345705 344317 346091 345558 345736
sum_num_inserts_total=64515764
sum_num_deletes_by_thread=323740 326443 326005 325600 324541 327270 326202 326531 325367 326675 326423 326627 324070 326886 325760 326826 334407 334168 334213 335072 333992 333984 333406 334487 332919 333780 333088 333258 332943 334354 333831 333176 331627 331161 331388 331822 330636 331379 329944 330080 331059 331777 331509 332414 332146 331213 331980 332080 331745 332401 331111 332039 332627 333325 333027 333513 333069 333971 333769 333251 333560 334227 333071 333918 324850 327169 325831 327105 325062 327045 325754 327021 324869 327884 326166 326500 324836 326196 325581 326182 333338 334309 333105 334201 333505 334457 334693 334303 333969 334171 333309 332900 334334 334859 333230 334476 331209 331864 332331 331210 330774 331504 329722 332017 331330 332767 331414 331453 331349 332132 331482 332304 331856 333240 331133 332032 331940 332949 333366 333408 333223 334400 333974 334128 334422 333800 333561 333200 345253 345898 346143 345636 345798 345692 345400 346122 345814 345361 345963 345998 346405 345904 345185 345284 344735 344398 345417 345230 345071 345930 344910 344786 345665 345406 345812 345201 345536 344930 345158 344892 345891 346477 346289 345941 346172 346220 346159 345976 346370 346053 347304 345353 346395 345429 346425 345371 345178 345271 345845 345308 345696 346313 345514 345506 344763 345401 344879 345396 346059 344807 345565 344914
sum_num_deletes_total=64502760
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=648356 654455 652227 651424 649305 654310 651822 653527 650217 653438 652267 654159 649593 653448 651245 654419 667733 668984 667863 669609 668360 668857 667864 669457 667019 667912 666602 667314 666083 667941 666960 668148 663043 662784 663414 664221 661558 662642 660176 661937 662983 663935 663619 664149 663227 663384 663290 663719 664801 665125 662858 664270 665902 666647 666538 667446 666667 667692 666700 667466 667438 667748 667115 667888 650007 654236 651866 653796 649387 653489 651654 653496 650001 653792 652262 652539 649720 652597 650815 652958 667172 668584 667843 668614 668245 668433 667159 668771 667650 667692 666324 667023 668283 668506 666939 668383 663346 663988 662795 663950 662181 662950 660388 661959 663157 664224 663463 663731 663268 663812 663086 663538 664218 665886 663109 663739 664585 666619 666006 667060 666313 667224 667267 667781 667504 667768 666718 667452 690403 691923 692155 691908 691372 691538 691612 691504 690911 691613 691342 691016 691250 691582 691417 690873 689850 690431 690967 690699 690438 691082 690915 690465 690329 690881 691069 690746 690378 690586 690490 690545 692318 692117 692277 692275 691853 692073 692179 691879 691305 691892 692102 691866 692123 691840 692578 691921 691283 690916 691342 690781 690605 691288 691302 690922 690537 690664 691227 691101 690376 690898 691123 690650
average_num_operations_total=671971
stdev_num_operations_total=1057
sum_num_operations_total=129018524
min_num_operations_total=648356
max_num_operations_total=692578
first_time_thread_terminate_by_thread=10000118 10000092 10000093 10000093 10000090 10000103 10000089 10000089 10000083 10000078 10000089 10000078 10000086 10000086 10000077 10000086 10000097 10000085 10000085 10000097 10000090 10000087 10000081 10000098 10000092 10000092 10000092 10000092 10000100 10000100 10000077 10000100 10000085 10000085 10000096 10000096 10000077 10000078 10000077 10000094 10000085 10000096 10000085 10000096 10000087 10000087 10000087 10000087 10000087 10000085 10000085 10000096 10000091 10000091 10000080 10001125 10000094 10000094 10001319 10000094 10000093 10000093 10000082 10000093 10000093 10000092 10000093 10000093 10000090 10000089 10000079 10000103 10000089 10000089 10000089 10000078 10001497 10000077 10000086 10000077 10000097 10000085 10000085 10000085 10000098 10000087 10000087 10000081 10000092 10000092 10000092 10000076 10000077 10000089 10000077 10000100 10000085 10000085 10000085 10000084 10000077 10000078 10000077 10000077 10000096 10000085 10000085 10000085 10000100 10000100 10000087 10000087 10000087 10000085 10000085 10000096 10000091 10000080 10000080 10000080 10000094 10000094 10000094 10000094 10000082 10000093 10000082 10000093 10000099 10000084 10000084 10000084 10000092 10000082 10000091 10000092 10000093 10000079 10000079 10000079 10000084 10000093 10000093 10000093 10000086 10000087 10000097 10000087 10000083 10000083 10000083 10000083 10000092 10000076 10000092 10000076 10000102 10000089 10000089 10000089 10000086 10000097 10000097 10000086 10000076 10000089 10000076 10000089 10000095 10000095 10000095 10000095 10000091 10000091 10000091 10000091 10000078 10000078 10000078 10000090 10000090 10000090 10000090 10000090 10000088 10000088 10000077 10000088 10000088 10000088 10000088 10000088
min_time_thread_terminate_total=10000076
max_time_thread_terminate_total=10001497
first_time_thread_start_by_thread=10 5 5 5 9 9 9 9 11 11 11 11 8 8 8 8 9 9 9 9 13 13 13 13 10 10 10 10 11 11 11 11 7 7 7 7 8 8 8 8 8 8 8 8 7 7 7 7 13 13 13 13 9 9 9 9 12 12 12 12 9 9 9 9 5 5 5 5 9 9 9 9 11 11 11 11 8 8 8 8 9 9 9 9 13 13 13 13 10 10 10 10 11 11 11 11 7 7 7 7 8 8 8 8 8 8 8 8 7 7 7 7 13 13 13 13 9 9 9 9 12 12 12 12 9 9 9 9 6 6 6 6 6 6 6 6 10 10 10 10 13 13 13 13 12 12 12 12 11 11 11 11 7 7 6 7 12 12 12 12 7 7 7 7 10 10 10 10 10 10 11 10 7 7 7 7 6 6 6 6 11 11 11 11 10 11 10 11 8 8 8 8
min_time_thread_start_total=5
max_time_thread_start_total=13
sum_duration_all_ops_total=
threads_final_keysum=99984659028479
threads_final_size=9998674
final_keysum=99984659028479
final_size=9998674
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=64515764
total_deletes=64502760
total_updates=129018524
total_queries=0
total_ops=129018524
find_throughput=0
rq_throughput=0
update_throughput=12901852
query_throughput=0
total_throughput=12901852
total find : 0
total rq : 0
total inserts : 64515764
total deletes : 64502760
total updates : 129018524
total queries : 0
total ops : 129018524
find throughput : 0
rq throughput : 0
update throughput : 12901852
query throughput : 0
total throughput : 12901852
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=0
total_execution_walltime=15.648s
REALTIME_MAIN_END_PERF_FORMAT=215279.320260818
[time_cmd_output] time_elapsed_sec=15.84, faults_major=0, faults_minor=418168, mem_maxresident_kb=1622940, user_cputime=2899.16, sys_cputime=6.37, percent_cpu=18337%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2