__step=000243
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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" ./brown_int_bst_tm_auto.debra.tl2 -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000243.txt
__path_data=data/data000243.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997482.549780992
binary=./brown_int_bst_tm_auto.debra.tl2
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_int_bst_tm_auto
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=2000000
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=32
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


TL2 system ready: GV=GV4
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.014s
prefilling_size=996032 prefilling_elapsed_millis=1.001s
finished prefilling to size 996108 for expected size 1000000 keysum=995685696594, performing 10903093 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=996108
pref_millis=1102
prefill_elapsed_ms=1136
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=128

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6997483.864009769
REALTIME_END_PERF_FORMAT=6997493.864150507

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

tree_stats_computeWalltime=0.035s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 123 232 425 741 1280 2110 3451 5395 8117 11929 16671 22462 29242 36791 43765 49630 53697 55380 54444 51112 46007 39818 32858 26187 19973 14834 10524 7058 4516 2733 1568 864 464 256 131 65 28 9 3 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 3 8 19 60 118 254 429 852 1478 2304 3970 5915 8400 11607 15919 20253 24239 27804 29665 30494 29533 27349 24432 20704 16976 13159 9914 7301 4967 3241 2031 1165 633 342 192 91 55 25 7 3
tree_stats_numNodesAtDepth=1 2 4 8 16 32 63 126 240 444 801 1398 2364 3880 6247 9595 14233 20641 28377 37642 48398 59684 69883 77936 83184 84109 81606 75540 67167 57290 46891 36949 27993 20438 14359 9483 5974 3599 2029 1097 598 323 156 83 34 10 3
tree_stats_numKeysAtDepth=1 2 4 8 16 32 63 126 240 444 801 1398 2364 3880 6247 9595 14233 20641 28377 37642 48398 59684 69883 77936 83184 84109 81606 75540 67167 57290 46891 36949 27993 20438 14359 9483 5974 3599 2029 1097 598 323 156 83 34 10 3
tree_stats_avgDegreeAtDepth=2 2 2 2 2 1.96875 2 1.92857 1.88333 1.84685 1.82022 1.77539 1.74873 1.72062 1.67232 1.63742 1.6121 1.56712 1.53494 1.5089 1.47302 1.4376 1.40505 1.37835 1.34537 1.32294 1.29934 1.28012 1.26013 1.24495 1.22951 1.21706 1.20019 1.18764 1.16888 1.15375 1.14496 1.12809 1.11483 1.12215 1.11204 1.0774 1.11538 1.07229 1.02941 1 1

tree_stats_height=47
tree_stats_numInternals=655019
tree_stats_numLeaves=345911
tree_stats_numNodes=1000930
tree_stats_numKeys=1000930

tree_stats_avgDegreeInternal=1.52809
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34559
tree_stats_avgKeyDepth=24.9362

4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0 

global_epoch_counter=4426


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:47 8:22269 16:376042 32:14058
    (2^02, 2^03]: 47
    (2^03, 2^04]: 22269
    (2^04, 2^05]: 376042
    (2^05, 2^06]: 14058
sum_limbo_reclamation_event_size_total=9363500
count_limbo_reclamation_event_size_by_thread=4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296 4296
count_limbo_reclamation_event_size_total=412416
sum_limbo_reclamation_event_count_total=412608
first_thread_announced_epoch_by_thread=8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852 8852
sum_num_inserts_by_thread=188585 190351 191793 192304 192634 189959 190346 191069 193073 193132 191456 190949 190534 191131 191604 192422 192725 191519 189190 190956 192435 191605 191659 190157 189106 190648 192088 191993 192264 190258 189666 190578 193028 193578 191340 191708 190771 191059 192002 192699 192332 191229 188873 190498 191416 192875 192022 190310 196729 197886 199553 199363 199535 199964 197794 198691 200591 201405 199314 198370 197952 199230 199655 200012 199148 196973 197120 197340 200373 201051 199525 199165 196927 198076 200066 200708 199866 198660 196774 198207 199671 200683 199935 199269 198093 198528 200413 199986 200698 198314 197822 197702 200476 201705 200112 199828
sum_num_inserts_total=18743187
sum_num_deletes_by_thread=188410 190769 191116 192109 191694 190326 191068 191508 192359 193211 193137 190645 189934 191423 192287 192172 192306 191926 189358 191155 192092 192626 190790 189695 189188 190091 191308 192591 192073 189469 190179 190839 192128 192887 191281 190733 190024 191216 191565 192611 192752 190009 189456 191454 192185 192289 191889 190768 197748 197986 198756 199610 199477 199108 198077 198551 200959 200869 200496 198886 198405 198334 200251 201072 199778 197414 197670 198103 199504 201287 199380 199074 197469 199601 200500 201116 199976 199249 196694 198272 200205 200607 200531 198730 197095 198890 199350 199712 200265 197592 197156 198053 200828 201367 200652 198908
sum_num_deletes_total=18744714
sum_num_searches_by_thread=3394140 3435950 3452367 3461692 3454655 3429460 3430012 3444274 3474074 3482026 3464938 3435159 3421952 3436069 3455940 3465374 3467156 3443359 3409802 3432049 3455966 3459539 3447738 3424149 3405972 3424573 3442949 3455374 3457137 3416135 3420973 3438557 3464201 3478950 3445190 3442513 3425013 3441235 3454001 3472066 3465526 3435340 3411781 3424226 3450146 3465506 3456919 3428596 3550790 3556603 3590857 3595926 3583420 3581391 3552763 3575383 3610569 3625489 3601420 3574392 3570203 3586282 3594658 3617845 3596327 3559151 3544776 3557746 3599145 3613765 3596084 3582833 3551945 3573710 3604691 3615987 3601623 3592796 3548675 3571679 3612220 3620075 3606902 3583012 3554133 3580452 3599907 3608312 3601092 3566308 3556243 3574016 3607942 3625841 3603907 3590016
sum_num_searches_total=337470021
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3771135 3817070 3835276 3846105 3838983 3809745 3811426 3826851 3859506 3868369 3849531 3816753 3802420 3818623 3839831 3849968 3852187 3826804 3788350 3814160 3840493 3843770 3830187 3804001 3784266 3805312 3826345 3839958 3841474 3795862 3800818 3819974 3849357 3865415 3827811 3824954 3805808 3823510 3837568 3857376 3850610 3816578 3790110 3806178 3833747 3850670 3840830 3809674 3945267 3952475 3989166 3994899 3982432 3980463 3948634 3972625 4012119 4027763 4001230 3971648 3966560 3983846 3994564 4018929 3995253 3953538 3939566 3953189 3999022 4016103 3994989 3981072 3946341 3971387 4005257 4017811 4001465 3990705 3942143 3968158 4012096 4021365 4007368 3981011 3949321 3977870 3999670 4008010 4002055 3962214 3951221 3969771 4009246 4028913 4004671 3988752
average_num_operations_total=3905811
stdev_num_operations_total=8546
sum_num_operations_total=374957922
min_num_operations_total=3771135
max_num_operations_total=4028913
first_time_thread_terminate_by_thread=10000140 10000142 10000141 10000141 10000140 10000141 10000142 10000140 10000142 10000142 10000142 10000141 10000142 10000140 10000142 10000140 10000141 10000140 10000141 10000142 10000141 10000142 10000142 10000141 10000140 10000140 10000141 10000141 10000141 10000140 10000139 10000140 10000142 10000142 10000143 10000141 10000142 10000141 10000142 10000140 10000141 10000142 10000141 10000142 10000141 10000142 10000140 10000142 10000140 10000140 10000142 10000143 10000141 10000140 10000140 10000142 10000141 10000140 10000142 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000142 10000141 10000141 10000140 10000140 10000142 10000141 10000140 10000142 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000140 10000141
min_time_thread_terminate_total=10000139
max_time_thread_terminate_total=10000143
first_time_thread_start_by_thread=5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 4 4 4 5 4 4 5 4 4 5 4 5 4 5 4 5 4 4 4 4 5 4 5 4 4 4 4 5 4 4 5 4 4 5 4 5 4 5 4 5 4 4 4 4
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=1001122255420
threads_final_size=1000930
final_keysum=1001122255420
final_size=1000930
validate_result=success
Validation OK.
Structural validation OK.

total_find=337470021
total_rq=0
total_inserts=18743187
total_deletes=18744714
total_updates=37487901
total_queries=337470021
total_ops=374957922
find_throughput=33747002
rq_throughput=0
update_throughput=3748790
query_throughput=33747002
total_throughput=37495792


total find                    : 337470021
total rq                      : 0
total inserts                 : 18743187
total deletes                 : 18744714
total updates                 : 37487901
total queries                 : 337470021
total ops                     : 374957922
find throughput               : 33747002
rq throughput                 : 0
update throughput             : 3748790
query throughput              : 33747002
total throughput              : 37495792

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=22.2473
PAPI_L3_TCM=0.914201
PAPI_TOT_CYC=5165.98
PAPI_TOT_INS=2468.77
garbage=166859782864935
total_execution_walltime=11.418s
REALTIME_MAIN_END_PERF_FORMAT=6997493.969254467
TL2 system shutdown:
  GCLOCK=0x160840E Starts=387420754 Aborts=1559738
  Overflows: R=0 W=0 L=0
[time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=99119, mem_maxresident_kb=356640, user_cputime=1013.98, sys_cputime=78.36, percent_cpu=9450%
timeout=false
algorithm=brown_int_bst_tm_auto.debra.tl2
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=1