__step=000596
__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=data000596.txt
__path_data=data/data000596.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6986047.737687610
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.041s
prefilling_size=99755 prefilling_elapsed_millis=1.001s
finished prefilling to size 99715 for expected size 100000 keysum=9968385200, performing 34719632 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99715
pref_millis=1102
prefill_elapsed_ms=1119
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=926
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=6986049.69445190
REALTIME_END_PERF_FORMAT=6986059.69598643
###############################################################################
################################## 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 902 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.035s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 63 124 243 451 807 1328 2086 3053 4305 5661 6936 7950 8576 8879 8709 8423 7761 6727 5532 4228 3075 2116 1375 832 412 192 78 23 3 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 1 2 5 35 95 286 570 1119 1801 2949 4386 5922 7324 8273 9049 8995 9085 8795 7922 6836 5381 4034 2857 1918 1252 632 306 133 43 6
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 126 248 486 902 1614 2656 4172 6106 8610 11322 13872 15900 17152 17758 17418 16846 15522 13454 11064 8456 6150 4232 2750 1664 824 384 156 46 6
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 2 5 35 95 286 570 1119 1801 2949 4386 5922 7324 8273 9049 8995 9085 8795 7922 6836 5381 4034 2857 1918 1252 632 306 133 43 6
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 1.98438 1.98413 1.97984 1.92798 1.89468 1.8228 1.78539 1.73178 1.70504 1.65749 1.61261 1.5731 1.53937 1.51767 1.49043 1.48358 1.4607 1.43338 1.41118 1.38214 1.36365 1.34407 1.32491 1.30255 1.2476 1.23301 1.20312 1.14744 1.06522 1
tree_stats_height=38
tree_stats_numInternals=100013
tree_stats_numLeaves=100014
tree_stats_numNodes=200027
tree_stats_numKeys=100012
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=23.4542
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5040 9920 19440 36080 64560 106240 166880 244240 344400 452880 554880 636000 686080 710320 696720 673840 620880 538160 442560 338240 246000 169280 110000 66560 32960 15360 6240 1840 240
tree_stats_sizeInBytes=8001080
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=18353
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:19 2:16 4:26 8:81 16:4434 32:612963 64:341137 128:0 256:86 512:104 1024:190
[2^00, 2^01]: 19
(2^01, 2^02]: 16
(2^02, 2^03]: 26
(2^03, 2^04]: 81
(2^04, 2^05]: 4434
(2^05, 2^06]: 612963
(2^06, 2^07]: 341137
(2^07, 2^08]: 0
(2^08, 2^09]: 86
(2^09, 2^10]: 104
(2^10, 2^11]: 190
sum_limbo_reclamation_event_size_total=55671079
count_limbo_reclamation_event_size_by_thread=9988 9990 9990 9990 9992 9990 9992 9990 9992 9990 9990 9988 9990 9990 9990 9988 9990 9992 9990 9986 9990 9990 9992 9988 9988 9990 9988 9990 9990 9990 9992 9990 9992 9992 9990 9988 9990 9994 9988 9990 9990 9992 9990 9990 9990 9990 9992 9988 9990 9992 9992 9988 9988 9990 9990 9992 9992 9990 9994 9986 9990 9990 9990 9990 9990 9990 9992 9990 9990 9984 9992 9990 9988 9990 9992 9988 9990 9992 9992 9992 9990 9992 9990 9990 9992 9990 9992 9990 9990 9990 9992 9990 9990 9990 9992 9988
count_limbo_reclamation_event_size_total=959056
sum_limbo_reclamation_event_count_total=3344518
first_thread_announced_epoch_by_thread=36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706 36706
sum_num_inserts_by_thread=798149 806815 815468 816306 810319 794333 805434 809521 809595 817088 809158 802508 803406 806593 816598 811969 807628 803225 800633 806942 811973 816567 802778 795294 791924 801218 809295 810862 808222 799168 806276 808157 818832 816597 807470 802545 802973 806946 814465 814657 808324 801318 794972 801787 807296 810301 802321 795214 795995 799222 807808 808562 798171 797202 801802 802952 810391 811310 805634 800161 797974 802960 811228 810783 806593 799343 801087 806432 816410 814501 806989 802276 789837 797026 806495 808615 801825 795594 794774 798798 807880 811924 806114 801175 800047 802297 809188 811226 799950 791933 795967 804049 818213 818372 812800 805361
sum_num_inserts_total=77324686
sum_num_deletes_by_thread=799293 806619 815342 813909 809227 795451 804657 809116 812002 815690 809063 802300 805444 806198 816566 812211 805628 804024 799983 806890 812986 814868 804701 795766 791728 800846 811315 810138 805300 802858 806447 810086 818654 814559 808340 800794 803322 805142 814036 815263 807916 800389 794876 799904 808975 810326 803835 794311 798046 798718 809549 807850 797661 797603 799617 801806 810705 812218 805148 800495 799917 801841 811274 809693 806205 799242 800340 805156 816608 816064 807697 800370 788946 798921 808685 808469 801470 796851 794875 800733 810657 811023 805576 800893 800848 802406 809601 812185 800542 792731 795432 804290 817919 819112 813645 805530
sum_num_deletes_total=77332457
sum_num_searches_by_thread=14373123 14513921 14660996 14662317 14579376 14334638 14486263 14563924 14613309 14706162 14557847 14459340 14468956 14514404 14690059 14639203 14522868 14470405 14408715 14504609 14629814 14662298 14474747 14328702 14234215 14411818 14576410 14605289 14536025 14412449 14533272 14573394 14708721 14670295 14545043 14412738 14450621 14494610 14653903 14671760 14548742 14405947 14298020 14417248 14547659 14589532 14476266 14304222 14344617 14377568 14567613 14555621 14373547 14352713 14397450 14441431 14605218 14616679 14512589 14405988 14361063 14455892 14588250 14605995 14497588 14380182 14404891 14513188 14681538 14662630 14521376 14432088 14205521 14357095 14522223 14547863 14430084 14329776 14286431 14392852 14570160 14612661 14510323 14423547 14407742 14448196 14591589 14633809 14421838 14274683 14318205 14479905 14719078 14746427 14635182 14491553
sum_num_searches_total=1391916653
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=15970565 16127355 16291806 16292532 16198922 15924422 16096354 16182561 16234906 16338940 16176068 16064148 16077806 16127195 16323223 16263383 16136124 16077654 16009331 16118441 16254773 16293733 16082226 15919762 15817867 16013882 16197020 16226289 16149547 16014475 16145995 16191637 16346207 16301451 16160853 16016077 16056916 16106698 16282404 16301680 16164982 16007654 15887868 16018939 16163930 16210159 16082422 15893747 15938658 15975508 16184970 16172033 15969379 15947518 15998869 16046189 16226314 16240207 16123371 16006644 15958954 16060693 16210752 16226471 16110386 15978767 16006318 16124776 16314556 16293195 16136062 16034734 15784304 15953042 16137403 16164947 16033379 15922221 15876080 15992383 16188697 16235608 16122013 16025615 16008637 16052899 16210378 16257220 16022330 15859347 15909604 16088244 16355210 16383911 16261627 16102444
average_num_operations_total=16110143
stdev_num_operations_total=13841
sum_num_operations_total=1546573796
min_num_operations_total=15784304
max_num_operations_total=16383911
first_time_thread_terminate_by_thread=10000153 10000152 10000154 10000154 10000154 10000153 10000155 10000152 10000153 10000152 10000152 10000152 10000152 10000154 10000155 10000153 10000152 10000155 10000153 10000154 10000153 10000154 10000152 10000153 10000154 10000152 10000152 10000154 10000154 10000153 10000155 10000152 10000153 10000152 10000152 10000152 10000155 10000154 10000155 10000153 10000152 10000155 10000153 10000154 10000153 10000154 10000152 10000153 10000152 10000154 10000154 10000155 10000153 10000152 10000154 10000154 10000153 10000152 10000155 10000152 10000153 10000153 10000154 10000154 10000153 10000153 10000152 10000153 10000153 10000155 10000153 10000152 10000152 10000154 10000154 10000155 10000153 10000152 10000154 10000154 10000153 10000152 10000155 10000152 10000153 10000153 10000154 10000154 10000153 10000153 10000152 10000153 10000153 10000154 10000153 10000152
min_time_thread_terminate_total=10000152
max_time_thread_terminate_total=10000155
first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 4 4 3 3 3 3 3 3 3 3 3 3 4 3 3 3 3 3 3 3 3 3 3 3 4 4 3 3 3 3 3 3 3 3 3 3 4 4 4 3 3 4 3 3 3 3 3 3 3 4 4 3 3 4 4 4 4 3 3 3 3 4 4 3 3 4 3 3 3 3 3 3 3 4 4 3 3 4 4 4 4 3 3 3 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=9987925001
threads_final_size=100012
final_keysum=9987925001
final_size=100012
validate_result=success
Validation OK.
Structural validation OK.
total_find=1391916653
total_rq=0
total_inserts=77324686
total_deletes=77332457
total_updates=154657143
total_queries=1391916653
total_ops=1546573796
find_throughput=139191665
rq_throughput=0
update_throughput=15465714
query_throughput=139191665
total_throughput=154657379
total find : 1391916653
total rq : 0
total inserts : 77324686
total deletes : 77332457
total updates : 154657143
total queries : 1391916653
total ops : 1546573796
find throughput : 139191665
rq throughput : 0
update throughput : 15465714
query throughput : 139191665
total throughput : 154657379
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=10.7407
PAPI_L3_TCM=0.423967
PAPI_TOT_CYC=1730.06
PAPI_TOT_INS=347.946
garbage=69604786744759
total_execution_walltime=11.473s
REALTIME_MAIN_END_PERF_FORMAT=6986059.212071817
[time_cmd_output] time_elapsed_sec=11.61, faults_major=0, faults_minor=85037, mem_maxresident_kb=328056, user_cputime=1082.27, sys_cputime=3.35, percent_cpu=9347%
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=2