__step=000820
__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 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000820.txt
__path_data=data/data000820.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6988866.43140079
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=2000000
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.011s
prefilling_size=1000100 prefilling_elapsed_millis=1.001s
finished prefilling to size 1000149 for expected size 1000000 keysum=1001065470786, performing 32675028 updates; total_prefilling_elapsed_ms=1103 ms)
pref_size=1000149
pref_millis=1103
prefill_elapsed_ms=1127
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=555
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=6988867.388488944
REALTIME_END_PERF_FORMAT=6988877.388638527
###############################################################################
################################## 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 978 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.041s
tree_stats_numInternalsAtDepth=1 1 1 2 4 8 16 32 64 126 247 489 952 1754 3174 5498 9100 14338 21665 30962 41775 53743 65624 76381 84823 88986 88002 82571 73849 63588 52418 41363 31326 22509 15713 10437 6858 4377 2787 1619 950 533 240 101 31 9 2 0
tree_stats_numLeavesAtDepth=0 1 1 0 0 0 0 0 0 2 5 5 26 150 334 850 1896 3862 7011 12368 20149 29807 41862 54867 67939 80660 89970 93433 91293 84110 74758 63473 51400 40143 29305 20989 14016 9339 5967 3955 2288 1367 826 379 171 53 16 4
tree_stats_numNodesAtDepth=1 2 2 2 4 8 16 32 64 128 252 494 978 1904 3508 6348 10996 18200 28676 43330 61924 83550 107486 131248 152762 169646 177972 176004 165142 147698 127176 104836 82726 62652 45018 31426 20874 13716 8754 5574 3238 1900 1066 480 202 62 18 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 2 5 5 26 150 334 850 1896 3862 7011 12368 20149 29807 41862 54867 67939 80660 89970 93433 91293 84110 74758 63473 51400 40143 29305 20989 14016 9339 5967 3955 2288 1367 826 379 171 53 16 4
tree_stats_avgDegreeAtDepth=2 1 1 2 2 2 2 2 2 1.98438 1.98016 1.98988 1.97342 1.92122 1.90479 1.8661 1.82757 1.7878 1.75551 1.71456 1.67462 1.64324 1.61054 1.58196 1.55526 1.52454 1.49447 1.46914 1.44718 1.43053 1.41217 1.39455 1.37867 1.35927 1.34904 1.33211 1.32854 1.31912 1.31837 1.29046 1.29339 1.28053 1.22514 1.21042 1.15347 1.14516 1.11111 1
tree_stats_height=48
tree_stats_numInternals=999049
tree_stats_numLeaves=999050
tree_stats_numNodes=1998099
tree_stats_numKeys=999048
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=0.999998
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=27.5708
tree_stats_bytesAtDepth=40 80 80 80 160 320 640 1280 2560 5120 10080 19760 39120 76160 140320 253920 439840 728000 1147040 1733200 2476960 3342000 4299440 5249920 6110480 6785840 7118880 7040160 6605680 5907920 5087040 4193440 3309040 2506080 1800720 1257040 834960 548640 350160 222960 129520 76000 42640 19200 8080 2480 720 160
tree_stats_sizeInBytes=79923960
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=6037
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:2147 2:905 4:517 8:1213 16:2906 32:9741 64:44852 128:180093 256:503679 512:210210 1024:528 2048:79
[2^00, 2^01]: 2147
(2^01, 2^02]: 905
(2^02, 2^03]: 517
(2^03, 2^04]: 1213
(2^04, 2^05]: 2906
(2^05, 2^06]: 9741
(2^06, 2^07]: 44852
(2^07, 2^08]: 180093
(2^08, 2^09]: 503679
(2^09, 2^10]: 210210
(2^10, 2^11]: 528
(2^11, 2^12]: 79
sum_limbo_reclamation_event_size_total=364155411
count_limbo_reclamation_event_size_by_thread=9966 9960 9956 9978 9962 9956 9976 9968 9966 9976 9968 9970 9968 9972 9950 9966 9948 9968 9952 9958 9944 9976 9972 9972 9964 9974 9966 9948 9972 9956 9958 9972 9968 9968 9976 9974 9980 9966 9960 9976 9974 9972 9962 9972 9972 9978 9964 9972 9968 9970 9974 9964 9968 9948 9964 9956 9972 9972 9960 9966 9970 9972 9966 9974 9972 9968 9970 9966 9954 9972 9960 9970 9968 9974 9964 9964 9978 9976 9964 9966 9964 9966 9988 9974 9970 9964 9968 9972 9964 9976 9970 9964 9964 9972 9976 9976
count_limbo_reclamation_event_size_total=956870
sum_limbo_reclamation_event_count_total=1051662
first_thread_announced_epoch_by_thread=12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074 12074
sum_num_inserts_by_thread=1635451 1638691 1649632 1653159 1641879 1632060 1640141 1643147 1653342 1665519 1642212 1641695 1642611 1648711 1659658 1654705 1653004 1648213 1633482 1645748 1645823 1648127 1644150 1636630 1641540 1644983 1647926 1652923 1644570 1637789 1641391 1642384 1658791 1653898 1642782 1639250 1648951 1642144 1657316 1660770 1652371 1641996 1638725 1639808 1653469 1658206 1644687 1644637 1671634 1678777 1687757 1683935 1670942 1664448 1672844 1681501 1683644 1676970 1672257 1666395 1668290 1682426 1691067 1689213 1682706 1672759 1665277 1676352 1679071 1689363 1679120 1670271 1673746 1675499 1688403 1680736 1682518 1672456 1676686 1687737 1686280 1692292 1682385 1675854 1674891 1686305 1699863 1695939 1679922 1670322 1673454 1683166 1689770 1689940 1682149 1668562
sum_num_inserts_total=159654991
sum_num_deletes_by_thread=1636752 1639177 1649142 1652339 1642050 1629148 1642944 1643313 1651615 1661002 1640839 1642454 1640255 1649182 1658410 1657136 1655370 1647594 1632468 1646974 1648556 1647963 1644755 1633489 1638966 1645106 1647385 1655653 1641807 1638542 1642062 1644061 1658200 1655091 1642595 1639135 1650263 1645239 1653606 1660946 1652224 1644108 1640857 1636722 1652549 1658786 1646740 1643619 1670044 1679377 1688936 1684330 1671543 1662223 1675961 1678846 1684480 1677993 1671546 1664574 1665640 1682004 1691674 1690296 1681630 1674278 1669991 1672568 1681425 1689297 1675862 1669375 1671207 1674332 1685500 1681816 1682051 1671595 1677843 1687926 1685612 1694024 1683899 1675154 1677005 1686033 1698224 1693827 1679720 1669546 1671136 1681163 1689139 1690175 1684539 1667687
sum_num_deletes_total=159640235
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3272203 3277868 3298774 3305498 3283929 3261208 3283085 3286460 3304957 3326521 3283051 3284149 3282866 3297893 3318068 3311841 3308374 3295807 3265950 3292722 3294379 3296090 3288905 3270119 3280506 3290089 3295311 3308576 3286377 3276331 3283453 3286445 3316991 3308989 3285377 3278385 3299214 3287383 3310922 3321716 3304595 3286104 3279582 3276530 3306018 3316992 3291427 3288256 3341678 3358154 3376693 3368265 3342485 3326671 3348805 3360347 3368124 3354963 3343803 3330969 3333930 3364430 3382741 3379509 3364336 3347037 3335268 3348920 3360496 3378660 3354982 3339646 3344953 3349831 3373903 3362552 3364569 3344051 3354529 3375663 3371892 3386316 3366284 3351008 3351896 3372338 3398087 3389766 3359642 3339868 3344590 3364329 3378909 3380115 3366688 3336249
average_num_operations_total=3325991
stdev_num_operations_total=3789
sum_num_operations_total=319295226
min_num_operations_total=3261208
max_num_operations_total=3398087
first_time_thread_terminate_by_thread=10000149 10000149 10000334 10000151 10000151 10000296 10000150 10000149 10000151 10000185 10000158 10000399 10000437 10000149 10000332 10000307 10000150 10000183 10000149 10000382 10000192 10000363 10000294 10000323 10000149 10000311 10000148 10000149 10000150 10000339 10000367 10000149 10000151 10000297 10000409 10000402 10000376 10000149 10000242 10000150 10000200 10000149 10000151 10000280 10000289 10000151 10000431 10000351 10000151 10000149 10000345 10000150 10000252 10000151 10000149 10000402 10000151 10000149 10000149 10000151 10000151 10000153 10000311 10000150 10000149 10000150 10000150 10000180 10000149 10000150 10000149 10000149 10000151 10000168 10000356 10000149 10000149 10000151 10000352 10000150 10000150 10000149 10000151 10000151 10000151 10000151 10000150 10000330 10000150 10000150 10000149 10000222 10000149 10000150 10000149 10000149
min_time_thread_terminate_total=10000148
max_time_thread_terminate_total=10000437
first_time_thread_start_by_thread=9 8 8 8 8 8 8 8 9 8 9 8 9 9 8 8 9 8 8 8 9 9 8 8 9 8 8 8 8 8 8 8 9 8 9 8 9 9 8 8 9 8 8 8 9 9 8 8 8 9 8 8 9 8 8 8 8 9 8 9 8 8 9 8 8 8 9 8 9 8 8 8 8 9 8 8 9 8 8 8 8 9 8 9 8 8 9 8 8 8 9 8 9 8 8 8
min_time_thread_start_total=8
max_time_thread_start_total=9
sum_duration_all_ops_total=
threads_final_keysum=998753244339
threads_final_size=999048
final_keysum=998753244339
final_size=999048
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=159654991
total_deletes=159640235
total_updates=319295226
total_queries=0
total_ops=319295226
find_throughput=0
rq_throughput=0
update_throughput=31929522
query_throughput=0
total_throughput=31929522
total find : 0
total rq : 0
total inserts : 159654991
total deletes : 159640235
total updates : 319295226
total queries : 0
total ops : 319295226
find throughput : 0
rq throughput : 0
update throughput : 31929522
query throughput : 0
total throughput : 31929522
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=39.6639
PAPI_L3_TCM=11.9187
PAPI_TOT_CYC=8241.85
PAPI_TOT_INS=1169.8
garbage=0
total_execution_walltime=11.58s
REALTIME_MAIN_END_PERF_FORMAT=6988877.641176450
[time_cmd_output] time_elapsed_sec=11.72, faults_major=0, faults_minor=108933, mem_maxresident_kb=432928, user_cputime=1076.67, sys_cputime=7.04, percent_cpu=9244%
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