__step=000595
__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 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000595.txt
__path_data=data/data000595.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986036.68227283
binary=./ellen_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=5
DEL_FRAC=5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=96
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=96
WORK_THREADS=96
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
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,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.025s
prefilling_size=100165 prefilling_elapsed_millis=1.001s
finished prefilling to size 100119 for expected size 100000 keysum=10010091776, performing 32348449 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=100119
pref_millis=1103
prefill_elapsed_ms=1124
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=872
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=6986037.389673375
REALTIME_END_PERF_FORMAT=6986047.389814038
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 888 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.032s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 126 247 444 754 1235 1953 3071 4503 5877 7207 8401 9263 9753 9719 9171 7902 6162 4673 3418 2427 1630 970 531 268 119 35 11 3 1 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 2 5 50 134 273 517 835 1639 3129 4547 6013 7539 8773 9787 10267 10440 9642 7651 5928 4409 3224 2290 1409 794 417 203 59 19 5 1 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 252 494 888 1508 2470 3906 6142 9006 11754 14414 16802 18526 19506 19438 18342 15804 12324 9346 6836 4854 3260 1940 1062 536 238 70 22 6 2 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 2 5 50 134 273 517 835 1639 3129 4547 6013 7539 8773 9787 10267 10440 9642 7651 5928 4409 3224 2290 1409 794 417 203 59 19 5 1 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 1.98438 1.98016 1.89879 1.8491 1.81897 1.79069 1.78623 1.73315 1.65256 1.61315 1.58284 1.5513 1.52645 1.49826 1.47181 1.43081 1.3899 1.37918 1.36572 1.35503 1.33581 1.29755 1.27371 1.25235 1.22201 1.14706 1.15714 1.13636 1.16667 1.5 1
tree_stats_height=40
tree_stats_numInternals=100004
tree_stats_numLeaves=100005
tree_stats_numNodes=200009
tree_stats_numKeys=100003
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=23.1649
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10080 19760 35520 60320 98800 156240 245680 360240 470160 576560 672080 741040 780240 777520 733680 632160 492960 373840 273440 194160 130400 77600 42480 21440 9520 2800 880 240 80 80
tree_stats_sizeInBytes=8000360
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=18555
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:9 2:7 4:11 8:68 16:4614 32:613651 64:340911 128:253
[2^00, 2^01]: 9
(2^01, 2^02]: 7
(2^02, 2^03]: 11
(2^03, 2^04]: 68
(2^04, 2^05]: 4614
(2^05, 2^06]: 613651
(2^06, 2^07]: 340911
(2^07, 2^08]: 253
sum_limbo_reclamation_event_size_total=55337721
count_limbo_reclamation_event_size_by_thread=9996 9996 9992 9996 9996 9994 9994 9996 9996 9996 9996 9994 9996 9996 9994 9994 9996 9996 9996 9994 9996 9994 9994 9996 9996 9996 9994 9996 9994 9996 9996 9994 9996 9992 9996 9994 9996 9996 9996 9994 9996 9996 9996 9994 9992 9994 9996 9996 9996 9994 9996 9992 9994 9994 9996 9996 9994 9992 9994 9996 9994 9994 9996 9996 9996 9996 9996 9996 9996 9996 9996 9994 9994 9996 9996 9996 9996 9994 9994 9994 9996 9992 9994 9994 9996 9996 9994 9996 9996 9994 9994 9996 9996 9996 9994 9994
count_limbo_reclamation_event_size_total=959524
sum_limbo_reclamation_event_count_total=3394272
first_thread_announced_epoch_by_thread=37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110 37110
sum_num_inserts_by_thread=806736 811889 821247 819892 816039 802721 811728 814356 822858 827649 813606 811233 812993 816689 817724 820558 819968 814244 808683 817431 822446 822353 808027 801140 806168 814807 821180 821440 818488 808944 813601 817883 824452 827946 817661 813775 812723 816424 823273 824745 813942 808758 803153 814697 817841 822519 811681 802435 806600 813156 820551 819622 805413 813189 815412 821141 824275 828865 816864 813568 811364 824298 831436 829529 822198 809481 809579 814287 824248 825583 816758 812427 805671 814397 821454 825081 814193 803997 807063 811594 829701 828428 821987 814737 815138 818966 823469 821742 814073 812722 810992 818663 831882 829758 823924 811255
sum_num_inserts_total=78401477
sum_num_deletes_by_thread=807520 812689 821356 819716 814444 802397 809952 815918 821420 825979 812320 811281 811775 816994 819440 821237 821664 814453 810477 817209 820917 819958 808000 803495 806307 812966 820764 823210 819498 809664 814093 817868 821930 825858 818733 813411 811753 815334 824632 825291 813007 809238 799649 814148 818818 823280 812497 802291 807020 813863 822295 821005 805133 812541 814862 818274 824561 830281 814957 810714 810548 824788 831175 830201 822452 810934 810733 814470 824247 824395 817202 813404 804646 813245 820767 825273 814987 806467 807101 812197 828085 828947 820265 815476 814832 817626 821968 822365 812101 811526 809838 819221 832464 830472 823705 812022
sum_num_deletes_total=78390502
sum_num_searches_by_thread=14535458 14634817 14795425 14744012 14636402 14452908 14614914 14714190 14796735 14873879 14647663 14612541 14606580 14709206 14748198 14776601 14782230 14666785 14572691 14696123 14787031 14756793 14531267 14431512 14516458 14656174 14762917 14808284 14741446 14577995 14654426 14723908 14827256 14876124 14709210 14648499 14613511 14685752 14839906 14839746 14630266 14564631 14432235 14644106 14723007 14811767 14615490 14435371 14522815 14660434 14783425 14766862 14517453 14647470 14648718 14754812 14831560 14921827 14696657 14617021 14593354 14849811 14944908 14929321 14806092 14587193 14564219 14675000 14840222 14817944 14711134 14641059 14483210 14652296 14784170 14844231 14663898 14525677 14526831 14627068 14937571 14930256 14771043 14673482 14677251 14737198 14830275 14817357 14651576 14620412 14577579 14749477 14992042 14944834 14817381 14607664
sum_num_searches_total=1411234536
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=16149714 16259395 16438028 16383620 16266885 16058026 16236594 16344464 16441013 16527507 16273589 16235055 16231348 16342889 16385362 16418396 16423862 16295482 16191851 16330763 16430394 16399104 16147294 16036147 16128933 16283947 16404861 16452934 16379432 16196603 16282120 16359659 16473638 16529928 16345604 16275685 16237987 16317510 16487811 16489782 16257215 16182627 16035037 16272951 16359666 16457566 16239668 16040097 16136435 16287453 16426271 16407489 16127999 16273200 16278992 16394227 16480396 16580973 16328478 16241303 16215266 16498897 16607519 16589051 16450742 16207608 16184531 16303757 16488717 16467922 16345094 16266890 16093527 16279938 16426391 16494585 16293078 16136141 16140995 16250859 16595357 16587631 16413295 16303695 16307221 16373790 16475712 16461464 16277750 16244660 16198409 16387361 16656388 16605064 16465010 16230941
average_num_operations_total=16333609
stdev_num_operations_total=14540
sum_num_operations_total=1568026515
min_num_operations_total=16035037
max_num_operations_total=16656388
first_time_thread_terminate_by_thread=10000141 10000140 10000139 10000142 10000140 10000141 10000139 10000141 10000141 10000140 10000141 10000140 10000141 10000141 10000142 10000141 10000140 10000140 10000138 10000142 10000140 10000142 10000141 10000140 10000141 10000140 10000139 10000142 10000140 10000140 10000139 10000141 10000141 10000140 10000141 10000141 10000141 10000141 10000142 10000141 10000140 10000141 10000138 10000142 10000140 10000140 10000141 10000140 10000140 10000141 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000139 10000140 10000139 10000139 10000139 10000139 10000141 10000139 10000139 10000140 10000140 10000139 10000140 10000141 10000139 10000140 10000141 10000139 10000140 10000139 10000139 10000139 10000139 10000139 10000139 10000140 10000140 10000139 10000139 10000139 10000139 10000139 10000139 10000140 10000140 10000139 10000140 10000141 10000141
min_time_thread_terminate_total=10000138
max_time_thread_terminate_total=10000142
first_time_thread_start_by_thread=5 5 5 5 5 6 5 5 6 5 6 5 5 5 5 5 5 5 5 5 5 5 5 6 5 5 5 5 5 6 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 5 5 6 6 5 5 5 5 5 5 5 5 5 5 5 5 6 6 5 5 5 5 5 5 5 6 6 6 5 5 5 5 5 5 5 5 5 5 5 5 6 6 5 5 5 5 5 5 5 6 6
min_time_thread_start_total=5
max_time_thread_start_total=6
sum_duration_all_ops_total=
threads_final_keysum=9992225441
threads_final_size=100003
final_keysum=9992225441
final_size=100003
validate_result=success
Validation OK.
Structural validation OK.
total_find=1411234536
total_rq=0
total_inserts=78401477
total_deletes=78390502
total_updates=156791979
total_queries=1411234536
total_ops=1568026515
find_throughput=141123453
rq_throughput=0
update_throughput=15679197
query_throughput=141123453
total_throughput=156802651
total find : 1411234536
total rq : 0
total inserts : 78401477
total deletes : 78390502
total updates : 156791979
total queries : 1411234536
total ops : 1568026515
find throughput : 141123453
rq throughput : 0
update throughput : 15679197
query throughput : 141123453
total throughput : 156802651
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=10.7656
PAPI_L3_TCM=0.422383
PAPI_TOT_CYC=1705.48
PAPI_TOT_INS=346.011
garbage=70562262526061
total_execution_walltime=11.495s
REALTIME_MAIN_END_PERF_FORMAT=6986047.563870024
[time_cmd_output] time_elapsed_sec=11.62, faults_major=0, faults_minor=125424, mem_maxresident_kb=447420, user_cputime=1078.17, sys_cputime=6.52, percent_cpu=9334%
timeout=false
algorithm=ellen_ext_bst_lf.debra
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1