__step=000259
__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" ./ellen_ext_bst_lf.debra -nwork 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000259.txt
__path_data=data/data000259.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=209930.775180970
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=ellen_ext_bst_lf
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=40 descriptor=64
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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.028s
prefilling_size=100077 prefilling_elapsed_millis=1s
finished prefilling to size 100106 for expected size 100000 keysum=10014693432, performing 48054540 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100106
pref_millis=1102
prefill_elapsed_ms=1115
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=541
6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0
global_epoch_counter=0
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=209931.955355017
REALTIME_END_PERF_FORMAT=209941.955432228
###############################################################################
################################## 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 (256 threads)...
partitioned into 1420 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.084s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 127 241 432 710 1153 1709 2415 3207 4070 4728 5300 5795 6494 7084 7654 7852 7535 6798 5903 4998 4213 3440 2715 2023 1389 903 491 227 118 58 31 9 2 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 1 13 50 154 267 597 1003 1623 2344 3412 4156 4805 5096 5904 6514 7456 8169 8272 7693 6808 5783 4986 4165 3407 2657 1875 1315 755 336 178 85 53 16 2 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 254 482 864 1420 2306 3418 4830 6414 8140 9456 10600 11590 12988 14168 15308 15704 15070 13596 11806 9996 8426 6880 5430 4046 2778 1806 982 454 236 116 62 18 4 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 1 13 50 154 267 597 1003 1623 2344 3412 4156 4805 5096 5904 6514 7456 8169 8272 7693 6808 5783 4986 4165 3407 2657 1875 1315 755 336 178 85 53 16 2 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 1.99219 1.94882 1.89627 1.82176 1.81197 1.74111 1.70655 1.66398 1.63455 1.58084 1.56049 1.5467 1.56031 1.54543 1.54023 1.51293 1.47981 1.45109 1.43417 1.42334 1.42147 1.40826 1.39462 1.37256 1.3433 1.32505 1.27187 1.23116 1.25991 1.24576 1.26724 1.14516 1.11111 1.5 1
tree_stats_height=44
tree_stats_numInternals=99955
tree_stats_numLeaves=99956
tree_stats_numNodes=199911
tree_stats_numKeys=99954
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=25.2177
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10160 19280 34560 56800 92240 136720 193200 256560 325600 378240 424000 463600 519520 566720 612320 628160 602800 543840 472240 399840 337040 275200 217200 161840 111120 72240 39280 18160 9440 4640 2480 720 160 160
tree_stats_sizeInBytes=7996440
6node_tIxPvE_object_size=40
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=14118
6info_tIxPvE_object_size=64
6info_tIxPvE_allocated_count=0
6info_tIxPvE_allocated_size=0MB
6info_tIxPvE_get_from_pool=0
6info_tIxPvE_deallocated=0
6info_tIxPvE_limbo_count=0
6info_tIxPvE_limbo_details=0 0 0
global_epoch_counter=0
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:13541 2:116321 4:578804 8:529459 16:37417 32:346 64:582 128:36
[2^00, 2^01]: 13541
(2^01, 2^02]: 116321
(2^02, 2^03]: 578804
(2^03, 2^04]: 529459
(2^04, 2^05]: 37417
(2^05, 2^06]: 346
(2^06, 2^07]: 582
(2^07, 2^08]: 36
sum_limbo_reclamation_event_size_total=9698027
count_limbo_reclamation_event_size_by_thread=9978 9986 9972 9980 9976 9976 9986 9986 9978 9968 9974 9988 9974 9976 9974 9966 9980 9984 9970 9982 9980 9972 9980 9970 9968 9972 9968 9966 9976 9968 9966 9966 9984 9980 9970 9968 9980 9964 9970 9960 9972 9976 9976 9960 9970 9974 9972 9980 9980 9978 9976 9966 9970 9978 9974 9974 9974 9980 9968 9982 9964 9972 9964 9972 9972 9978 9968 9972 9964 9964 9968 9966 9968 9940 9962 9962 9972 9982 9984 9966 9982 9972 9962 9974 9960 9974 9976 9984 9982 9968 9974 9970 9974 9964 9980 9960 9970 9970 9970 9970 9976 9966 9966 9974 9966 9972 9978 9972 9986 9964 9976 9968 9970 9968 9952 9978 9964 9972 9980 9972 9978 9972 9980 9982 9982 9968 9988 9978
count_limbo_reclamation_event_size_total=1276506
sum_limbo_reclamation_event_count_total=3475694
first_thread_announced_epoch_by_thread=28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236 28236
sum_num_inserts_by_thread=85093 85095 85432 83727 85383 86226 86119 86085 85887 85138 84289 84099 84207 84027 83425 83602 83103 82309 84571 85074 84872 85353 85249 85202 84257 83246 82623 82349 83091 81919 82695 83208 84533 83721 84052 83286 83927 83613 82166 81914 82259 81583 81590 82029 81695 81477 83165 83126 82810 83488 83267 83305 82749 81764 81656 79764 80332 81070 80146 80268 79404 83216 82497 82002 80959 81506 81069 80779 79758 79879 80247 80162 80083 79691 79229 82343 80929 82232 82784 82029 81082 81430 80149 80209 79268 80028 80395 79978 79185 81400 81204 81522 82027 81723 80912 81956 80604 79521 79759 79275 79364 79707 78847 82914 82318 81983 82374 81590 82085 82386 80848 79819 79075 79613 79697 79964 80037 79424 83244 82258 82990 83620 83584 84394 83537 84155 84462 84935
sum_num_inserts_total=10523359
sum_num_deletes_by_thread=84422 85662 85924 83659 85430 85916 86117 85951 85986 85431 85268 84092 83309 84023 83575 83898 83338 82637 84799 84530 84590 85240 85382 84247 84151 83494 82464 82296 82722 82134 81863 83398 83906 83690 83752 83165 83542 83422 82406 82009 82704 81900 81806 81590 81745 81742 82810 83393 82626 83662 82920 83033 83228 81670 81668 80744 80287 81127 80552 80463 79073 82552 82194 82016 81365 81004 80952 80109 80471 80323 79759 80084 79974 79445 79333 82560 81360 82490 82557 82294 81562 81396 79836 79652 78904 80419 80520 79743 78753 82233 81837 81055 81917 81706 81714 82147 80435 79662 79724 79110 79648 79361 79137 82747 82578 82117 82269 81796 81975 82378 80669 79232 79630 79233 80016 79908 80410 79499 82771 82539 82998 83747 83860 83809 83386 84522 84952 84144
sum_num_deletes_total=10523081
sum_num_searches_by_thread=16861067 16945096 16874880 16617670 16829738 17008836 17076061 17023315 16992955 16949416 16835430 16698536 16630373 16626939 16575204 16603120 16411701 16434221 16665479 16733377 16804829 16815797 16852691 16794721 16663181 16472295 16338851 16283257 16410432 16290120 16339201 16405570 16640429 16584930 16593938 16467711 16547378 16555915 16388874 16233423 16321361 16204143 16241624 16194749 16172359 16154262 16461768 16552797 16472344 16504852 16471067 16374857 16396447 16204558 16066623 15876134 15953830 15974911 15912009 15923389 15677595 16410929 16306619 16315413 16109575 16106921 16082192 15972310 15927797 15799530 15865343 15856324 15788612 15794731 15704213 16310294 16054924 16292539 16255276 16287226 16122987 16112884 15806042 15847319 15668267 15895109 15884903 15854709 15706423 16240600 16122477 16117675 16239225 16231913 16045493 16267510 15926781 15849403 15817983 15713351 15769616 15779781 15697124 16343943 16323002 16218287 16275047 16215106 16282955 16294839 15967818 15800830 15741866 15792132 15810887 15819494 15837487 15730726 16492140 16343522 16414385 16561703 16554211 16667358 16460029 16724253 16708628 16730023
sum_num_searches_total=2084057650
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=17030582 17115853 17046236 16785056 17000551 17180978 17248297 17195351 17164828 17119985 17004987 16866727 16797889 16794989 16742204 16770620 16578142 16599167 16834849 16902981 16974291 16986390 17023322 16964170 16831589 16639035 16503938 16447902 16576245 16454173 16503759 16572176 16808868 16752341 16761742 16634162 16714847 16722950 16553446 16397346 16486324 16367626 16405020 16358368 16335799 16317481 16627743 16719316 16637780 16672002 16637254 16541195 16562424 16367992 16229947 16036642 16114449 16137108 16072707 16084120 15836072 16576697 16471310 16479431 16271899 16269431 16244213 16133198 16088026 15959732 16025349 16016570 15948669 15953867 15862775 16475197 16217213 16457261 16420617 16451549 16285631 16275710 15966027 16007180 15826439 16055556 16045818 16014430 15864361 16404233 16285518 16280252 16403169 16395342 16208119 16431613 16087820 16008586 15977466 15871736 15928628 15938849 15855108 16509604 16487898 16382387 16439690 16378492 16447015 16459603 16129335 15959881 15900571 15950978 15970600 15979366 15997934 15889649 16658155 16508319 16580373 16729070 16721655 16835561 16626952 16892930 16878042 16899102
average_num_operations_total=16446125
stdev_num_operations_total=32601
sum_num_operations_total=2105104090
min_num_operations_total=15826439
max_num_operations_total=17248297
first_time_thread_terminate_by_thread=10000079 10000078 10000079 10000079 10000076 10000076 10000076 10000076 10000080 10000080 10000080 10000080 10000078 10000078 10000078 10000078 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000079 10000079 10000079 10000079 10000078 10000078 10000078 10000078 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000077 10000077 10000077 10000080 10000080 10000080 10000080 10000080 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000077 10000077 10000077 10000077 10000078 10000078 10000078 10000078 10000079 10000078 10000079 10000079 10000076 10000076 10000118 10000076 10000080 10000080 10000080 10000080 10000078 10000078 10000078 10000078 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000081 10000079 10000079 10000079 10000079 10000078 10000078 10000078 10000078 10000080 10000080 10000080 10000080 10000081 10000081 10000081 10000081 10000077 10000077 10000077 10000077 10000080 10000080 10000080 10000080 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000079 10000077 10000077 10000077 10000077 10000078 10000078 10000078 10000078
min_time_thread_terminate_total=10000076
max_time_thread_terminate_total=10000118
first_time_thread_start_by_thread=8 8 8 8 7 7 7 7 10 10 10 10 11 11 11 11 9 9 9 9 9 9 9 9 10 10 10 10 8 8 8 8 9 9 9 9 8 8 8 8 9 9 9 9 9 9 9 9 8 8 8 8 10 10 10 10 10 10 10 10 11 11 11 11 8 8 8 8 7 7 15 7 10 10 10 10 11 11 11 11 9 9 9 9 9 9 9 9 10 10 10 10 8 8 8 8 9 9 9 9 8 8 8 8 9 9 9 9 9 9 9 9 8 8 8 8 10 10 10 10 10 10 10 10 11 11 11 11
min_time_thread_start_total=7
max_time_thread_start_total=15
sum_duration_all_ops_total=
threads_final_keysum=9999795105
threads_final_size=99954
final_keysum=9999795105
final_size=99954
validate_result=success
Validation OK.
Structural validation OK.
total_find=2084057650
total_rq=0
total_inserts=10523359
total_deletes=10523081
total_updates=21046440
total_queries=2084057650
total_ops=2105104090
find_throughput=208405765
rq_throughput=0
update_throughput=2104644
query_throughput=208405765
total_throughput=210510409
total find : 2084057650
total rq : 0
total inserts : 10523359
total deletes : 10523081
total updates : 21046440
total queries : 2084057650
total ops : 2105104090
find throughput : 208405765
rq throughput : 0
update throughput : 2104644
query throughput : 208405765
total throughput : 210510409
elapsed milliseconds : 10000
napping milliseconds overtime : 100
garbage=6620979500986
total_execution_walltime=11.477s
REALTIME_MAIN_END_PERF_FORMAT=209942.252867987
[time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=86716, mem_maxresident_kb=339752, user_cputime=1423.78, sys_cputime=9.84, percent_cpu=12381%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1