__step=000956
__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" ./drachsler_pext_bst_lock.debra -nwork 128 -nprefill 128 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 50.0 50.0 -k 200000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000956.txt
__path_data=data/data000956.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=218347.451293150
binary=./drachsler_pext_bst_lock.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=drachsler_pext_bst_lock
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=128
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=128
WORK_THREADS=128
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=192
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.026s
prefilling_size=99651 prefilling_elapsed_millis=1s
finished prefilling to size 99637 for expected size 100000 keysum=9961971836, performing 58579093 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=99637
pref_millis=1102
prefill_elapsed_ms=1112
6node_tIxPvE_object_size=192
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=425

main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=218348.625449654
REALTIME_END_PERF_FORMAT=218358.625541206

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

tree_stats_computeWalltime=0.129s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 127 246 476 876 1462 2278 3331 4471 5682 6607 7309 7451 6834 5687 4398 3131 2077 1262 675 334 147 84 59 51 41 31 35 32 21 18 18 11 7 6 6 6 3 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 5 10 38 166 374 659 1202 1780 2558 3192 3831 4296 4148 3634 3007 2135 1492 983 512 271 113 65 32 31 31 11 17 24 12 10 14 11 5 3 3 6 2 1
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 251 486 914 1628 2652 3990 5673 7462 9165 10501 11282 11130 9835 8032 6138 4212 2754 1658 846 418 197 124 83 72 62 46 49 45 30 28 25 18 11 9 9 9 3 1
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 251 486 914 1628 2652 3990 5673 7462 9165 10501 11282 11130 9835 8032 6138 4212 2754 1658 846 418 197 124 83 72 62 46 49 45 30 28 25 18 11 9 9 9 3 1
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.97638 1.95618 1.90123 1.82276 1.73096 1.64555 1.58697 1.52723 1.46676 1.42488 1.37834 1.32609 1.26963 1.23843 1.21663 1.17612 1.16073 1.14379 1.10314 1.09929 1.11962 1.20305 1.19355 1.25301 1.29167 1.24194 1.30435 1.26531 1.2 1.33333 1.25 1.28 1.22222 1.27273 1.33333 1.33333 1 1 1

tree_stats_height=46
tree_stats_numInternals=65418
tree_stats_numLeaves=34684
tree_stats_numNodes=100102
tree_stats_numKeys=100102

tree_stats_avgDegreeInternal=1.53019
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34649
tree_stats_avgKeyDepth=18.1207

tree_stats_bytesAtDepth=192 384 768 1536 3072 6144 12288 24384 48192 93312 175488 312576 509184 766080 1089216 1432704 1759680 2016192 2166144 2136960 1888320 1542144 1178496 808704 528768 318336 162432 80256 37824 23808 15936 13824 11904 8832 9408 8640 5760 5376 4800 3456 2112 1728 1728 1728 576 192
tree_stats_sizeInBytes=19219584

6node_tIxPvE_object_size=192
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=4621


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:18 2:1 4:2 8:4 16:9 32:11 64:88 128:168365 256:367676 512:473 1024:127
    [2^00, 2^01]: 18
    (2^01, 2^02]: 1
    (2^02, 2^03]: 2
    (2^03, 2^04]: 4
    (2^04, 2^05]: 9
    (2^05, 2^06]: 11
    (2^06, 2^07]: 88
    (2^07, 2^08]: 168365
    (2^08, 2^09]: 367676
    (2^09, 2^10]: 473
    (2^10, 2^11]: 127
sum_limbo_reclamation_event_size_total=144603838
count_limbo_reclamation_event_size_by_thread=4194 4193 4193 4193 4193 4193 4194 4193 4193 4194 4194 4194 4193 4193 4194 4194 4193 4194 4194 4194 4193 4193 4193 4193 4193 4194 4193 4193 4193 4194 4194 4193 4194 4193 4194 4194 4194 4194 4193 4194 4194 4194 4194 4193 4194 4194 4194 4194 4194 4194 4194 4193 4193 4194 4194 4194 4193 4193 4193 4193 4194 4194 4194 4193 4193 4194 4193 4193 4194 4194 4194 4194 4194 4194 4194 4194 4193 4194 4193 4194 4193 4193 4193 4194 4193 4193 4193 4193 4193 4193 4194 4194 4194 4194 4194 4193 4194 4193 4194 4193 4193 4193 4193 4193 4194 4194 4194 4193 4194 4194 4194 4193 4194 4193 4194 4194 4193 4194 4194 4194 4193 4194 4193 4193 4194 4193 4194 4194
count_limbo_reclamation_event_size_total=536774
sum_limbo_reclamation_event_count_total=537088
first_thread_announced_epoch_by_thread=9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242 9242
sum_num_inserts_by_thread=2296093 2236885 2239715 2227955 2253992 2247764 2302998 2305750 2261519 2247215 2235121 2221780 2249319 2246006 2244389 2242409 2218347 2241765 2228634 2236948 2250673 2284985 2249860 2282645 2280244 2257360 2229690 2223620 2329753 2181745 2326625 2313681 2306805 2250453 2303966 2242888 2323379 2326324 2221749 2206400 2292481 2195017 2201330 2289357 2273117 2268498 2239767 2227596 2324002 2325982 2327575 2200337 2311703 2199130 2189394 2190392 2281838 2283725 2279075 2279913 2232679 2317960 2315865 2216885 2232422 2299212 2238279 2272522 2216738 2275910 2204816 2205020 2219766 2259885 2242643 2270839 2256215 2268023 2265675 2258033 2243081 2270050 2272639 2274278 2226781 2214818 2221246 2212394 2208529 2239071 2246259 2251230 2357552 2348663 2355545 2202384 2285626 2226415 2211627 2231474 2308009 2213299 2305095 2240266 2229278 2328818 2240783 2329460 2244659 2247842 2241894 2302885 2213451 2213522 2339236 2332526 2327473 2240019 2328614 2329109 2236743 2241121 2233953 2233062 2249746 2238986 2339915 2333174
sum_num_inserts_total=289389665
sum_num_deletes_by_thread=2296797 2234610 2241641 2227756 2255356 2245797 2305569 2304479 2262032 2246851 2237037 2220227 2246122 2248921 2245646 2245085 2220523 2239756 2228694 2235184 2245953 2283084 2249542 2280408 2280515 2259430 2230234 2223078 2328124 2182748 2328445 2317049 2311364 2249667 2301671 2246057 2327192 2327621 2221281 2205580 2288343 2193267 2199489 2290921 2271531 2270680 2236618 2228819 2327232 2325206 2328738 2199283 2316529 2200728 2191463 2188921 2277598 2287060 2277415 2283637 2232318 2315045 2316786 2219581 2231814 2302258 2238348 2272302 2219703 2276556 2206619 2205976 2221649 2257990 2243579 2275002 2259888 2268746 2267674 2256657 2239602 2273329 2270976 2270277 2227128 2218260 2223963 2214846 2208876 2239891 2248795 2250189 2359095 2351065 2354405 2197880 2286760 2228791 2211916 2227015 2310929 2216069 2304215 2241622 2230830 2326858 2241472 2329497 2246036 2246566 2244271 2303547 2211361 2211580 2339118 2335357 2326127 2241661 2329404 2328904 2239226 2238699 2235594 2236685 2249017 2239474 2335813 2333470
sum_num_deletes_total=289435556
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4592890 4471495 4481356 4455711 4509348 4493561 4608567 4610229 4523551 4494066 4472158 4442007 4495441 4494927 4490035 4487494 4438870 4481521 4457328 4472132 4496626 4568069 4499402 4563053 4560759 4516790 4459924 4446698 4657877 4364493 4655070 4630730 4618169 4500120 4605637 4488945 4650571 4653945 4443030 4411980 4580824 4388284 4400819 4580278 4544648 4539178 4476385 4456415 4651234 4651188 4656313 4399620 4628232 4399858 4380857 4379313 4559436 4570785 4556490 4563550 4464997 4633005 4632651 4436466 4464236 4601470 4476627 4544824 4436441 4552466 4411435 4410996 4441415 4517875 4486222 4545841 4516103 4536769 4533349 4514690 4482683 4543379 4543615 4544555 4453909 4433078 4445209 4427240 4417405 4478962 4495054 4501419 4716647 4699728 4709950 4400264 4572386 4455206 4423543 4458489 4618938 4429368 4609310 4481888 4460108 4655676 4482255 4658957 4490695 4494408 4486165 4606432 4424812 4425102 4678354 4667883 4653600 4481680 4658018 4658013 4475969 4479820 4469547 4469747 4498763 4478460 4675728 4666644
average_num_operations_total=4522072
stdev_num_operations_total=7607
sum_num_operations_total=578825221
min_num_operations_total=4364493
max_num_operations_total=4716647
first_time_thread_terminate_by_thread=10000087 10000087 10000087 10000089 10000090 10000087 10000090 10000087 10000088 10000088 10000088 10000088 10000090 10000087 10000090 10000087 10000087 10000087 10000087 10000089 10000089 10000089 10000089 10000089 10000087 10000087 10000087 10000087 10000089 10000089 10000089 10000089 10000088 10000088 10000088 10000088 10000087 10000087 10000087 10000087 10000088 10000088 10000088 10000088 10000089 10000091 10000089 10000089 10000091 10000091 10000087 10000087 10000089 10000089 10000089 10000089 10000088 10000089 10000089 10000089 10000089 10000089 10000088 10000088 10000086 10000087 10000089 10000089 10000090 10000087 10000090 10000087 10000088 10000088 10000088 10000088 10000090 10000090 10000090 10000090 10000089 10000089 10000089 10000089 10000089 10000089 10000089 10000089 10000087 10000087 10000089 10000087 10000089 10000089 10000089 10000089 10000088 10000087 10000087 10000088 10000092 10000092 10000087 10000089 10000088 10000088 10000088 10000088 10000089 10000089 10000089 10000089 10000087 10000088 10000087 10000087 10000089 10000089 10000088 10000088 10000088 10000089 10000089 10000089 10000089 10000088 10000088 10000089
min_time_thread_terminate_total=10000086
max_time_thread_terminate_total=10000092
first_time_thread_start_by_thread=3 3 3 3 4 4 4 4 7 7 7 7 5 5 5 5 4 4 4 4 5 5 5 5 4 4 4 4 6 6 6 6 4 4 4 4 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7 5 5 5 5 7 7 7 7 5 5 5 5 3 3 3 3 4 4 4 4 7 7 7 7 5 5 5 5 4 4 4 4 5 5 5 5 4 4 4 4 6 6 6 6 4 4 4 4 6 6 6 6 6 6 6 6 6 6 6 6 7 7 7 7 5 5 5 5 7 7 7 7 5 5 5 5
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=

threads_final_keysum=10008455721
threads_final_size=100102
final_keysum=10008455721
final_size=100102
validate_result=success
Validation OK.
Structural validation OK.

total_find=0
total_rq=0
total_inserts=289389665
total_deletes=289435556
total_updates=578825221
total_queries=0
total_ops=578825221
find_throughput=0
rq_throughput=0
update_throughput=57882522
query_throughput=0
total_throughput=57882522


total find                    : 0
total rq                      : 0
total inserts                 : 289389665
total deletes                 : 289435556
total updates                 : 578825221
total queries                 : 0
total ops                     : 578825221
find throughput               : 0
rq throughput                 : 0
update throughput             : 57882522
query throughput              : 0
total throughput              : 57882522

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

garbage=0
total_execution_walltime=11.353s
REALTIME_MAIN_END_PERF_FORMAT=218358.805563052
[time_cmd_output] time_elapsed_sec=11.45, faults_major=0, faults_minor=92292, mem_maxresident_kb=366248, user_cputime=1382.87, sys_cputime=28.01, percent_cpu=12314%
timeout=false
algorithm=drachsler_pext_bst_lock.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2