__step=000474
__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 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=data000474.txt
__path_data=data/data000474.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=212587.983738360
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=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
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.018s
prefilling_size=997695 prefilling_elapsed_millis=1s
finished prefilling to size 997699 for expected size 1000000 keysum=997357536434, performing 13281003 updates; total_prefilling_elapsed_ms=1101 ms)
pref_size=997699
pref_millis=1101
prefill_elapsed_ms=1114
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=212589.135839506
REALTIME_END_PERF_FORMAT=212599.135917348
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
Open BwTree: createTreeStats iterating over all kv-pairs...
Open BwTree: createTreeStats finished iterating.
tree_stats_computeWalltime=0.023s
tree_stats_numInternalsAtDepth=0
tree_stats_numLeavesAtDepth=1
tree_stats_numNodesAtDepth=1
tree_stats_numKeysAtDepth=1000813
tree_stats_avgDegreeAtDepth=1.00081e+06
tree_stats_height=1
tree_stats_numInternals=0
tree_stats_numLeaves=1
tree_stats_numNodes=1
tree_stats_numKeys=1000813
tree_stats_avgDegreeInternal=0
tree_stats_avgDegreeLeaves=1.00081e+06
tree_stats_avgDegree=1.00081e+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=455869 457461 456296 455716 458475 456829 457044 457099 455960 457118 456314 456368 458621 456540 456771 456180 459438 457225 458820 458369 458974 460286 457948 458979 458404 458748 457919 457661 459097 458939 457999 457537 466478 463021 462626 463816 464760 465091 462344 463955 463574 463709 462302 463368 464450 463102 463874 462970 469110 469284 465927 468076 468914 468648 467681 467791 468555 468349 467178 468842 468984 468834 468081 467933
sum_num_inserts_total=29556631
sum_num_deletes_by_thread=455640 456585 456060 454879 457097 458088 457086 456934 459397 456497 456231 457288 458626 457619 455817 455658 460455 457039 457199 457913 460098 459142 457844 458731 458434 458955 457586 457224 457526 458200 457016 458607 466130 463625 463568 464304 463940 464868 463494 464110 464264 463277 463189 463507 465523 463521 462379 462093 469355 467828 467952 468370 470686 468293 467793 467989 467989 468260 466609 466454 469425 467865 467280 467906
sum_num_deletes_total=29553317
sum_num_searches_by_thread=8219473 8223373 8210098 8193079 8241573 8227277 8218580 8229060 8237413 8230446 8210525 8221536 8231324 8228403 8215880 8218164 8267187 8242372 8245048 8251355 8273156 8271146 8249214 8258724 8258279 8253251 8233286 8242801 8263168 8253887 8230238 8237820 8377094 8346155 8348925 8356744 8378516 8362794 8348461 8357161 8357944 8351770 8331355 8338118 8356190 8346457 8329565 8331464 8449505 8431338 8418869 8430909 8451401 8437547 8419206 8431157 8445637 8433587 8419509 8426949 8446680 8441147 8413158 8423156
sum_num_searches_total=532125604
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=9130982 9137419 9122454 9103674 9157145 9142194 9132710 9143093 9152770 9144061 9123070 9135192 9148571 9142562 9128468 9130002 9187080 9156636 9161067 9167637 9192228 9190574 9165006 9176434 9175117 9170954 9148791 9157686 9179791 9171026 9145253 9153964 9309702 9272801 9275119 9284864 9307216 9292753 9274299 9285226 9285782 9278756 9256846 9264993 9286163 9273080 9255818 9256527 9387970 9368450 9352748 9367355 9391001 9374488 9354680 9366937 9382181 9370196 9353296 9362245 9385089 9377846 9348519 9358995
average_num_operations_total=9238055
stdev_num_operations_total=11841
sum_num_operations_total=591235552
min_num_operations_total=9103674
max_num_operations_total=9391001
first_time_thread_terminate_by_thread=10000078 10000078 10000078 10000078 10000078 10000078 10000079 10000078 10000077 10000077 10000077 10000078 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000078 10000078 10000078 10000078 10000080 10000080 10000080 10000080 10000076 10000076 10000076 10000076 10000079 10000079 10000079 10000079 10000080 10000080 10000080 10000080 10000077 10000077 10000078 10000077 10000081 10000081 10000081 10000081 10000079 10000079 10000079 10000079 10000080 10000080 10000080 10000080 10000079 10000079 10000079 10000079 10000077 10000078 10000078 10000078
min_time_thread_terminate_total=10000076
max_time_thread_terminate_total=10000081
first_time_thread_start_by_thread=3 3 3 3 2 2 2 2 2 2 2 2 3 3 3 3 4 4 4 4 5 5 5 5 4 4 4 4 3 3 3 3 2 2 2 2 4 4 4 4 6 6 6 6 5 5 5 5 6 6 6 6 6 6 6 6 5 5 5 5 5 5 5 5
min_time_thread_start_total=2
max_time_thread_start_total=6
sum_duration_all_ops_total=
threads_final_keysum=1000339590945
threads_final_size=1000813
final_keysum=1000339590945
final_size=1000813
validate_result=success
Validation OK.
Structural validation OK.
total_find=532125604
total_rq=0
total_inserts=29556631
total_deletes=29553317
total_updates=59109948
total_queries=532125604
total_ops=591235552
find_throughput=53212560
rq_throughput=0
update_throughput=5910994
query_throughput=53212560
total_throughput=59123555
total find : 532125604
total rq : 0
total inserts : 29556631
total deletes : 29553317
total updates : 59109948
total queries : 532125604
total ops : 591235552
find throughput : 53212560
rq throughput : 0
update throughput : 5910994
query throughput : 53212560
total throughput : 59123555
elapsed milliseconds : 10000
napping milliseconds overtime : 0
garbage=58794106079729
total_execution_walltime=11.192s
REALTIME_MAIN_END_PERF_FORMAT=212599.176645961
[time_cmd_output] time_elapsed_sec=11.30, faults_major=0, faults_minor=126684, mem_maxresident_kb=490696, user_cputime=713.87, sys_cputime=5.31, percent_cpu=6362%
timeout=false
algorithm=wang_openbwtree
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2