__step=000932
__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 50.0 50.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000932.txt
__path_data=data/data000932.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6990178.358950123
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=50
DEL_FRAC=50
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=50.0 50.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.01s
prefilling_size=99768 prefilling_elapsed_millis=1.001s
finished prefilling to size 99771 for expected size 100000 keysum=9987106242, performing 31457582 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99771
pref_millis=1102
prefill_elapsed_ms=1126
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=826

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=6990179.673182528
REALTIME_END_PERF_FORMAT=6990189.673318498

###############################################################################
################################## 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 (192 threads)...
partitioned into 954 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.052s

tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 128 252 477 882 1562 2604 4158 6018 7897 9448 10427 10483 9787 8532 6710 5215 4022 3021 2348 1744 1258 970 712 519 349 228 135 71 34 10 2 1 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 0 4 27 72 202 520 1050 2298 4139 6346 8469 10371 11179 11042 10354 8205 6408 5023 3694 2952 2230 1546 1228 905 689 470 321 199 108 58 18 3 2
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 256 504 954 1764 3124 5208 8316 12036 15794 18896 20854 20966 19574 17064 13420 10430 8044 6042 4696 3488 2516 1940 1424 1038 698 456 270 142 68 20 4 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 4 27 72 202 520 1050 2298 4139 6346 8469 10371 11179 11042 10354 8205 6408 5023 3694 2952 2230 1546 1228 905 689 470 321 199 108 58 18 3 2
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 2 1.98438 1.94643 1.92453 1.88549 1.83355 1.79839 1.72367 1.65611 1.5982 1.55181 1.50269 1.4668 1.43588 1.39323 1.3886 1.38562 1.37556 1.38861 1.37138 1.36067 1.38553 1.36701 1.36447 1.33622 1.32665 1.29605 1.26296 1.23944 1.14706 1.1 1.25 1

tree_stats_height=42
tree_stats_numInternals=100133
tree_stats_numLeaves=100134
tree_stats_numNodes=200267
tree_stats_numKeys=100132

tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=0.99998
tree_stats_avgDegree=1.49999
tree_stats_avgKeyDepth=22.4182

tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10240 20160 38160 70560 124960 208320 332640 481440 631760 755840 834160 838640 782960 682560 536800 417200 321760 241680 187840 139520 100640 77600 56960 41520 27920 18240 10800 5680 2720 800 160 80
tree_stats_sizeInBytes=8010680

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=10333

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:103309 2:36000 4:2453 8:4954 16:9547 32:18874 64:38820 128:100930 256:322385 512:183550 1024:790
    [2^00, 2^01]: 103309
    (2^01, 2^02]: 36000
    (2^02, 2^03]: 2453
    (2^03, 2^04]: 4954
    (2^04, 2^05]: 9547
    (2^05, 2^06]: 18874
    (2^06, 2^07]: 38820
    (2^07, 2^08]: 100930
    (2^08, 2^09]: 322385
    (2^09, 2^10]: 183550
    (2^10, 2^11]: 790
sum_limbo_reclamation_event_size_total=276382795
count_limbo_reclamation_event_size_by_thread=8624 8530 8574 8700 8578 8594 8500 8630 8576 8520 8584 8506 8528 8620 8484 8558 8488 8588 8590 8574 8592 8523 8542 8508 8576 8510 8506 8630 8546 8558 8512 8620 8518 8590 8564 8544 8590 8570 8560 8650 8512 8606 8574 8636 8502 8540 8498 8508 8541 8496 8460 8552 8616 8552 8560 8564 8536 8452 8506 8644 8498 8508 8512 8620 8584 8488 8596 8658 8498 8516 8530 8562 8634 8614 8508 8550 8544 8588 8616 8640 8546 8516 8550 8674 8528 8526 8472 8502 8562 8636 8532 8632 8578 8566 8626 8492
count_limbo_reclamation_event_size_total=821612
sum_limbo_reclamation_event_count_total=1531386
first_thread_announced_epoch_by_thread=20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666 20666
sum_num_inserts_by_thread=1831563 1824820 1864804 1858805 1835248 1828806 1829594 1841347 1847548 1840978 1839003 1834240 1841246 1833979 1849001 1844007 1832109 1846284 1833628 1840539 1836949 1838564 1848724 1829342 1827158 1834157 1845501 1845820 1818690 1857123 1812980 1844532 1835752 1853282 1837191 1834206 1839657 1836473 1853053 1865317 1832360 1848108 1846331 1844447 1811537 1842362 1855662 1852462 1839459 1815566 1824511 1805787 1839747 1825674 1836586 1835202 1810805 1826016 1837270 1822851 1799420 1828603 1836182 1839564 1811105 1834178 1840514 1862329 1822351 1830563 1835060 1815574 1836614 1850604 1835996 1807627 1857369 1847083 1837882 1861679 1830389 1847005 1845390 1850352 1839616 1843153 1846689 1832776 1810495 1860442 1828915 1863072 1825343 1866261 1836369 1835183
sum_num_inserts_total=176396510
sum_num_deletes_by_thread=1832596 1824915 1863202 1857040 1834828 1826404 1831914 1840663 1847367 1838515 1837446 1832984 1841506 1833893 1848310 1844114 1829744 1849661 1834074 1841937 1836592 1838097 1847652 1828496 1828051 1833493 1844283 1845016 1816983 1853971 1815035 1844974 1837261 1854528 1836886 1835384 1840295 1841353 1849094 1863624 1836084 1848290 1846085 1844380 1811650 1839993 1856491 1854100 1837779 1815792 1826235 1808573 1841440 1821396 1836012 1833298 1809118 1827526 1835537 1824450 1799202 1827401 1834837 1841100 1809908 1832379 1840095 1861990 1824555 1832340 1834957 1813040 1838102 1849265 1837667 1808716 1855363 1846571 1840704 1861094 1830308 1846629 1844376 1849931 1837931 1841402 1843563 1832084 1811900 1860095 1826845 1858861 1821218 1865714 1832934 1834923
sum_num_deletes_total=176364410
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3664159 3649735 3728006 3715845 3670076 3655210 3661508 3682010 3694915 3679493 3676449 3667224 3682752 3667872 3697311 3688121 3661853 3695945 3667702 3682476 3673541 3676661 3696376 3657838 3655209 3667650 3689784 3690836 3635673 3711094 3628015 3689506 3673013 3707810 3674077 3669590 3679952 3677826 3702147 3728941 3668444 3696398 3692416 3688827 3623187 3682355 3712153 3706562 3677238 3631358 3650746 3614360 3681187 3647070 3672598 3668500 3619923 3653542 3672807 3647301 3598622 3656004 3671019 3680664 3621013 3666557 3680609 3724319 3646906 3662903 3670017 3628614 3674716 3699869 3673663 3616343 3712732 3693654 3678586 3722773 3660697 3693634 3689766 3700283 3677547 3684555 3690252 3664860 3622395 3720537 3655760 3721933 3646561 3731975 3669303 3670106
average_num_operations_total=3674592
stdev_num_operations_total=2849
sum_num_operations_total=352760920
min_num_operations_total=3598622
max_num_operations_total=3731975
first_time_thread_terminate_by_thread=10000716 10000134 10000135 10000359 10000986 10000771 10000134 10000136 10000134 10000134 10000519 10000598 10000134 10000632 10001003 10000722 10000251 10000686 10000134 10000869 10000712 10000868 10000919 10000688 10000855 10001015 10000135 10000477 10000543 10000934 10000134 10000855 10001000 10000134 10000134 10000465 10000134 10000630 10000362 10000530 10000153 10000828 10000134 10000135 10000735 10000135 10000134 10000659 10000804 10000865 10000135 10000135 10000707 10000135 10000135 10000136 10000826 10000134 10000220 10000709 10000876 10000918 10000219 10001034 10000864 10000178 10000141 10000892 10000138 10000915 10000134 10000929 10000918 10000834 10000135 10000136 10000367 10000137 10000135 10001014 10000796 10000679 10000923 10000790 10000703 10000867 10000134 10000924 10000819 10000137 10000659 10000829 10000817 10000790 10000135 10000882
min_time_thread_terminate_total=10000134
max_time_thread_terminate_total=10001034
first_time_thread_start_by_thread=3 3 4 3 4 4 3 3 3 4 3 4 4 3 4 4 3 3 4 4 4 3 3 4 4 3 4 3 4 4 3 3 3 4 3 4 4 3 4 4 3 3 4 4 4 3 3 4 4 4 3 3 3 3 4 4 4 4 4 3 3 3 4 3 4 3 3 3 4 3 4 3 4 4 3 3 3 3 4 4 4 4 4 3 3 3 4 3 4 3 3 3 4 3 4 3
min_time_thread_start_total=3
max_time_thread_start_total=4
sum_duration_all_ops_total=

threads_final_keysum=10003316628
threads_final_size=100132
final_keysum=10003316628
final_size=100132
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=176396510
total_deletes=176364410
total_updates=352760920
total_queries=0
total_ops=352760920
find_throughput=0
rq_throughput=0
update_throughput=35276092
query_throughput=0
total_throughput=35276092


total find                    : 0
total rq                      : 0
total inserts                 : 176396510
total deletes                 : 176364410
total updates                 : 352760920
total queries                 : 0
total ops                     : 352760920
find throughput               : 0
rq throughput                 : 0
update throughput             : 35276092
query throughput              : 0
total throughput              : 35276092

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=24.9731
PAPI_L3_TCM=6.03807
PAPI_TOT_CYC=6692.3
PAPI_TOT_INS=1146.26
garbage=0
total_execution_walltime=11.574s
REALTIME_MAIN_END_PERF_FORMAT=6990189.934252591
[time_cmd_output] time_elapsed_sec=11.70, faults_major=0, faults_minor=126252, mem_maxresident_kb=450772, user_cputime=963.57, sys_cputime=20.48, percent_cpu=8408%
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