__step=000082
__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" ./brown_ext_chromatic_lf.debra -nwork 64 -nprefill 64 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 20000000 -t 10000 -pin 0-63,128-191,64-127,192-255
__file_data=data000082.txt
__path_data=data/data000082.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207834.583149140
binary=./brown_ext_chromatic_lf.debra
parsed custom binding: 0-63,128-191,64-127,192-255
DS_TYPENAME=brown_ext_chromatic_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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=20000000
PREFILL_THREADS=64
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=64
WORK_THREADS=64
RQ_THREADS=0
distribution=0
INS_DEL_FRAC=0.5 0.5
PREFILL_TYPE=PREFILL_HYBRID
PREFILL_HYBRID_MIN_MS=1000
PREFILL_HYBRID_MAX_MS=5000
sizes: node=56 descriptor=128
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


Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.034s
prefilling_size=5699111 prefilling_elapsed_millis=1s
prefilling_size=6001594 prefilling_elapsed_millis=1.101s
prefilling_size=6278358 prefilling_elapsed_millis=1.201s
prefilling_size=6533241 prefilling_elapsed_millis=1.301s
prefilling_size=6765934 prefilling_elapsed_millis=1.401s
prefilling_size=6982876 prefilling_elapsed_millis=1.501s
prefilling_size=7181606 prefilling_elapsed_millis=1.601s
prefilling_size=7365400 prefilling_elapsed_millis=1.701s
prefilling_size=7539294 prefilling_elapsed_millis=1.801s
prefilling_size=7698112 prefilling_elapsed_millis=1.901s
prefilling_size=7847226 prefilling_elapsed_millis=2.002s
prefilling_size=7984785 prefilling_elapsed_millis=2.102s
prefilling_size=8111446 prefilling_elapsed_millis=2.202s
prefilling_size=8232026 prefilling_elapsed_millis=2.302s
prefilling_size=8343153 prefilling_elapsed_millis=2.402s
prefilling_size=8446118 prefilling_elapsed_millis=2.502s
prefilling_size=8544458 prefilling_elapsed_millis=2.602s
prefilling_size=8634823 prefilling_elapsed_millis=2.702s
prefilling_size=8718984 prefilling_elapsed_millis=2.802s
prefilling_size=8799164 prefilling_elapsed_millis=2.903s
prefilling_size=8873279 prefilling_elapsed_millis=3.003s
prefilling_size=8943062 prefilling_elapsed_millis=3.103s
prefilling_size=9007960 prefilling_elapsed_millis=3.203s
prefilling_size=9067881 prefilling_elapsed_millis=3.304s
prefilling_size=9123634 prefilling_elapsed_millis=3.404s
prefilling_size=9177039 prefilling_elapsed_millis=3.504s
prefilling_size=9226243 prefilling_elapsed_millis=3.604s
prefilling_size=9272433 prefilling_elapsed_millis=3.704s
prefilling_size=9315989 prefilling_elapsed_millis=3.804s
prefilling_size=9357451 prefilling_elapsed_millis=3.904s
prefilling_size=9396958 prefilling_elapsed_millis=4.004s
prefilling_size=9434264 prefilling_elapsed_millis=4.105s
prefilling_size=9468286 prefilling_elapsed_millis=4.205s
prefilling_size=9498957 prefilling_elapsed_millis=4.305s
prefilling_size=9527514 prefilling_elapsed_millis=4.405s
prefilling_size=9555534 prefilling_elapsed_millis=4.505s
prefilling_size=9580471 prefilling_elapsed_millis=4.605s
prefilling_size=9606102 prefilling_elapsed_millis=4.705s
prefilling_size=9630094 prefilling_elapsed_millis=4.805s
prefilling_size=9652839 prefilling_elapsed_millis=4.906s
prefilling_size=9673799 prefilling_elapsed_millis=5.006s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 326201 keys with 64 threads...
tid=0 thread_prefill_amount=150000 percent_done_estimate=2943.0 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.051955s
prefilling_size=10000000 prefilling_elapsed_millis=0.054s
finished prefilling to size 10000000 for expected size 10000000 keysum=100001104486074, performing 69267691 updates; total_prefilling_elapsed_ms=54 ms)
pref_size=10000000
pref_millis=54
prefill_elapsed_ms=54
4NodeIxPvE_object_size=56
4NodeIxPvE_allocated_count=0
4NodeIxPvE_allocated_size=0MB
4NodeIxPvE_get_from_pool=0
4NodeIxPvE_deallocated=0
4NodeIxPvE_limbo_count=46414
4NodeIxPvE_limbo_details=12222 16598 17594 

global_epoch_counter=2336

9SCXRecordIxPvE_object_size=128
9SCXRecordIxPvE_allocated_count=0
9SCXRecordIxPvE_allocated_size=0MB
9SCXRecordIxPvE_get_from_pool=0
9SCXRecordIxPvE_deallocated=0
9SCXRecordIxPvE_limbo_count=22596
9SCXRecordIxPvE_limbo_details=5924 8132 8540 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=207839.814875618
REALTIME_END_PERF_FORMAT=207849.814947030

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

tree_stats_computeWalltime=0.053s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65524 130692 256875 481935 823895 1233091 1570327 1681865 1499517 1098735 649467 301758 106940 27539 4791 524 45 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 12 356 4509 31815 139975 414699 895855 1458789 1864213 1900299 1548003 997176 496576 186341 50287 9058 1003 90
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131048 261384 513750 963870 1647790 2466182 3140654 3363730 2999034 2197470 1298934 603516 213880 55078 9582 1048 90
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 12 356 4509 31815 139975 414699 895855 1458789 1864213 1900299 1548003 997176 496576 186341 50287 9058 1003 90
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99982 1.99728 1.98275 1.93807 1.85478 1.74833 1.63674 1.53551 1.44579 1.36636 1.29555 1.23231 1.17719 1.12876 1.08699 1.05469 1.04294 1

tree_stats_height=34
tree_stats_numInternals=9999055
tree_stats_numLeaves=9999056
tree_stats_numNodes=19998111
tree_stats_numKeys=9999056

tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=24.6037

tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7338688 14637504 28770000 53976720 92276240 138106192 175876624 188368880 167945904 123058320 72740304 33796896 11977280 3084368 536592 58688 5040
tree_stats_sizeInBytes=1119894216

4NodeIxPvE_object_size=56
4NodeIxPvE_allocated_count=0
4NodeIxPvE_allocated_size=0MB
4NodeIxPvE_get_from_pool=0
4NodeIxPvE_deallocated=0
4NodeIxPvE_limbo_count=0
4NodeIxPvE_limbo_details=0 0 0 

global_epoch_counter=8384

9SCXRecordIxPvE_object_size=128
9SCXRecordIxPvE_allocated_count=0
9SCXRecordIxPvE_allocated_size=0MB
9SCXRecordIxPvE_get_from_pool=0
9SCXRecordIxPvE_deallocated=0
9SCXRecordIxPvE_limbo_count=0
9SCXRecordIxPvE_limbo_details=0 0 0 

global_epoch_counter=0


log_histogram_of_none_limbo_reclamation_event_size_full_data=1:77136 2:161133 4:232130 8:113479 16:8059 32:46 64:57 128:145 256:132
    [2^00, 2^01]: 77136
    (2^01, 2^02]: 161133
    (2^02, 2^03]: 232130
    (2^03, 2^04]: 113479
    (2^04, 2^05]: 8059
    (2^05, 2^06]: 46
    (2^06, 2^07]: 57
    (2^07, 2^08]: 145
    (2^08, 2^09]: 132
sum_limbo_reclamation_event_size_total=3067747
count_limbo_reclamation_event_size_by_thread=9229 9305 9238 9315 9268 9235 9291 9323 9277 9217 9213 9281 9253 9199 9284 9243 9187 9284 9211 9244 9227 9263 9318 9223 9263 9254 9240 9271 9292 9277 9289 9289 9249 9235 9276 9267 9229 9236 9252 9208 9203 9202 9186 9321 9273 9259 9254 9242 9229 9248 9257 9217 9220 9233 9221 9282 9308 9292 9312 9249 9274 9261 9282 9237
count_limbo_reclamation_event_size_total=592317
sum_limbo_reclamation_event_count_total=774220
first_thread_announced_epoch_by_thread=16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768 16768
sum_num_inserts_by_thread=19123 18800 18779 18770 19118 19075 18779 18726 18921 18649 18670 18888 18644 18576 18585 18745 18718 18778 18583 18721 18663 18555 18681 18546 18787 18858 18478 18563 18428 18770 19098 18765 18985 18806 18616 18714 18626 18427 18681 18602 18589 18806 18645 18852 18733 18573 18811 18546 18632 18822 18786 18604 18707 18586 18343 18441 18851 18724 18780 18850 18692 18603 18873 18865
sum_num_inserts_total=1198011
sum_num_deletes_by_thread=18887 18797 18695 18724 18871 18940 18923 18882 18624 18753 18794 18612 18648 18821 18901 18675 18890 18717 18778 18810 18764 18928 18832 18405 18418 18528 18617 18779 18952 18746 18713 18842 18781 18761 18779 18792 18558 18618 18542 18672 18621 18854 18865 19043 18796 18665 18710 18531 18848 18874 18787 18512 18483 18523 18598 18641 18677 18969 19025 18334 18856 18996 18670 18740
sum_num_deletes_total=1199387
sum_num_searches_by_thread=3749093 3747752 3734616 3717186 3733771 3733838 3711314 3708538 3711277 3706690 3687511 3688888 3686466 3725066 3710232 3706910 3725286 3722107 3713469 3712183 3711995 3701134 3685992 3685011 3686005 3685532 3673774 3715393 3718655 3716472 3707151 3702333 3729403 3730990 3710350 3699543 3698612 3697574 3682863 3683557 3685922 3735071 3720241 3714818 3721609 3721272 3709339 3708504 3707606 3695385 3675803 3668626 3675788 3673647 3664267 3660567 3714119 3710442 3698167 3697590 3708317 3713106 3706287 3709657
sum_num_searches_total=237150682
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3787103 3785349 3772090 3754680 3771760 3771853 3749016 3746146 3748822 3744092 3724975 3726388 3723758 3762463 3747718 3744330 3762894 3759602 3750830 3749714 3749422 3738617 3723505 3721962 3723210 3722918 3710869 3752735 3756035 3753988 3744962 3739940 3767169 3768557 3747745 3737049 3735796 3734619 3720086 3720831 3723132 3772731 3757751 3752713 3759138 3758510 3746860 3745581 3745086 3733081 3713376 3705742 3712978 3710756 3701208 3697649 3751647 3748135 3735972 3734774 3745865 3750705 3743830 3747262
average_num_operations_total=3742938
stdev_num_operations_total=2493
sum_num_operations_total=239548080
min_num_operations_total=3697649
max_num_operations_total=3787103
first_time_thread_terminate_by_thread=10000114 10000070 10000070 10000070 10000072 10000072 10000072 10000072 10000075 10000075 10000075 10000075 10000076 10000076 10000076 10000076 10000075 10000075 10000075 10000075 10000074 10000074 10000074 10000074 10000073 10000073 10000073 10000073 10000073 10000073 10000073 10000073 10000073 10000072 10000072 10000072 10000076 10000076 10000076 10000076 10000073 10000073 10000073 10000073 10000076 10000076 10000076 10000076 10000072 10000072 10000073 10000072 10000072 10000073 10000072 10000072 10000074 10000074 10000074 10000074 10000072 10000071 10000072 10000071
min_time_thread_terminate_total=10000070
max_time_thread_terminate_total=10000114
first_time_thread_start_by_thread=8 3 3 3 5 5 5 5 4 4 4 4 5 5 5 5 6 6 6 6 4 4 4 4 8 8 8 8 6 6 6 6 7 7 7 7 5 5 6 5 6 6 6 6 7 7 7 7 8 8 8 8 7 7 7 7 6 6 6 6 9 9 9 9
min_time_thread_start_total=3
max_time_thread_start_total=9
sum_duration_all_ops_total=

threads_final_keysum=99984411154267
threads_final_size=9999056
final_keysum=99984411154267
final_size=9999056
validate_result=success
Validation OK.
Structural validation OK.

total_find=237150682
total_rq=0
total_inserts=1198011
total_deletes=1199387
total_updates=2397398
total_queries=237150682
total_ops=239548080
find_throughput=23715068
rq_throughput=0
update_throughput=239739
query_throughput=23715068
total_throughput=23954808


total find                    : 237150682
total rq                      : 0
total inserts                 : 1198011
total deletes                 : 1199387
total updates                 : 2397398
total queries                 : 237150682
total ops                     : 239548080
find throughput               : 23715068
rq throughput                 : 0
update throughput             : 239739
query throughput              : 23715068
total throughput              : 23954808

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=1092830485351980
total_execution_walltime=15.47s
REALTIME_MAIN_END_PERF_FORMAT=207850.53701580
[time_cmd_output] time_elapsed_sec=15.72, faults_major=0, faults_minor=591290, mem_maxresident_kb=2364212, user_cputime=963.24, sys_cputime=8.07, percent_cpu=6178%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=2