__step=000081
__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=data000081.txt
__path_data=data/data000081.txt
__hostname=nasus
REALTIME_MAIN_START_PERF_FORMAT=207818.832414122
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.021s
prefilling_size=5514443 prefilling_elapsed_millis=1s
prefilling_size=5819035 prefilling_elapsed_millis=1.1s
prefilling_size=6100132 prefilling_elapsed_millis=1.201s
prefilling_size=6358358 prefilling_elapsed_millis=1.301s
prefilling_size=6600717 prefilling_elapsed_millis=1.401s
prefilling_size=6822770 prefilling_elapsed_millis=1.501s
prefilling_size=7029237 prefilling_elapsed_millis=1.601s
prefilling_size=7221349 prefilling_elapsed_millis=1.701s
prefilling_size=7397893 prefilling_elapsed_millis=1.801s
prefilling_size=7563296 prefilling_elapsed_millis=1.901s
prefilling_size=7719360 prefilling_elapsed_millis=2.002s
prefilling_size=7863366 prefilling_elapsed_millis=2.102s
prefilling_size=7999184 prefilling_elapsed_millis=2.202s
prefilling_size=8125066 prefilling_elapsed_millis=2.302s
prefilling_size=8242363 prefilling_elapsed_millis=2.402s
prefilling_size=8350862 prefilling_elapsed_millis=2.502s
prefilling_size=8453960 prefilling_elapsed_millis=2.602s
prefilling_size=8549681 prefilling_elapsed_millis=2.702s
prefilling_size=8639082 prefilling_elapsed_millis=2.802s
prefilling_size=8720321 prefilling_elapsed_millis=2.903s
prefilling_size=8797625 prefilling_elapsed_millis=3.003s
prefilling_size=8869812 prefilling_elapsed_millis=3.103s
prefilling_size=8937605 prefilling_elapsed_millis=3.203s
prefilling_size=9001436 prefilling_elapsed_millis=3.304s
prefilling_size=9059838 prefilling_elapsed_millis=3.404s
prefilling_size=9115505 prefilling_elapsed_millis=3.504s
prefilling_size=9168147 prefilling_elapsed_millis=3.604s
prefilling_size=9217896 prefilling_elapsed_millis=3.704s
prefilling_size=9264800 prefilling_elapsed_millis=3.804s
prefilling_size=9308043 prefilling_elapsed_millis=3.904s
prefilling_size=9347896 prefilling_elapsed_millis=4.004s
prefilling_size=9385234 prefilling_elapsed_millis=4.105s
prefilling_size=9422579 prefilling_elapsed_millis=4.205s
prefilling_size=9455489 prefilling_elapsed_millis=4.305s
prefilling_size=9487615 prefilling_elapsed_millis=4.405s
prefilling_size=9516578 prefilling_elapsed_millis=4.505s
prefilling_size=9544746 prefilling_elapsed_millis=4.605s
prefilling_size=9571160 prefilling_elapsed_millis=4.705s
prefilling_size=9595458 prefilling_elapsed_millis=4.805s
prefilling_size=9618204 prefilling_elapsed_millis=4.906s
prefilling_size=9639986 prefilling_elapsed_millis=5.006s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 360011 keys with 64 threads...
tid=0 thread_prefill_amount=153125 percent_done_estimate=2722.1 elapsed_s=5 est_remaining_s=-11 / -6
tid=0 thread_prefill_amount=156250 percent_done_estimate=2777.7 elapsed_s=5 est_remaining_s=-11 / -6
timing_elapsed 0.055532s
prefilling_size=10000000 prefilling_elapsed_millis=0.058s
finished prefilling to size 10000000 for expected size 10000000 keysum=99973186252827, performing 67532801 updates; total_prefilling_elapsed_ms=58 ms)
pref_size=10000000
pref_millis=58
prefill_elapsed_ms=58
4NodeIxPvE_object_size=56
4NodeIxPvE_allocated_count=0
4NodeIxPvE_allocated_size=0MB
4NodeIxPvE_get_from_pool=0
4NodeIxPvE_deallocated=0
4NodeIxPvE_limbo_count=46865
4NodeIxPvE_limbo_details=15223 15638 16004 

global_epoch_counter=2392

9SCXRecordIxPvE_object_size=128
9SCXRecordIxPvE_allocated_count=0
9SCXRecordIxPvE_allocated_size=0MB
9SCXRecordIxPvE_get_from_pool=0
9SCXRecordIxPvE_deallocated=0
9SCXRecordIxPvE_limbo_count=22383
9SCXRecordIxPvE_limbo_details=7256 7539 7588 

global_epoch_counter=0

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=207824.46879142
REALTIME_END_PERF_FORMAT=207834.46951468

###############################################################################
################################## 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.049s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65511 130584 256256 479555 817582 1220189 1555830 1672597 1500398 1108683 663647 313609 113154 29485 5150 547 40 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 25 438 4912 32957 141528 414975 884548 1439063 1844796 1892113 1553719 1013685 514064 196823 53820 9753 1054 80
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65536 131022 261168 512512 959110 1635164 2440378 3111660 3345194 3000796 2217366 1327294 627218 226308 58970 10300 1094 80
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 25 438 4912 32957 141528 414975 884548 1439063 1844796 1892113 1553719 1013685 514064 196823 53820 9753 1054 80
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99962 1.99666 1.98119 1.9357 1.85244 1.74622 1.63754 1.53753 1.44852 1.36946 1.2993 1.23628 1.18041 1.13029 1.08733 1.05311 1.03656 1

tree_stats_height=34
tree_stats_numInternals=9998352
tree_stats_numLeaves=9998353
tree_stats_numNodes=19996705
tree_stats_numKeys=9998353

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

tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1835008 3670016 7337232 14625408 28700672 53710160 91569184 136661168 174252960 187330864 168044576 124172496 74328464 35124208 12673248 3302320 576800 61264 4480
tree_stats_sizeInBytes=1119815480

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

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:77117 2:161954 4:231159 8:113264 16:8101 32:42 64:73 128:147 256:125
    [2^00, 2^01]: 77117
    (2^01, 2^02]: 161954
    (2^02, 2^03]: 231159
    (2^03, 2^04]: 113264
    (2^04, 2^05]: 8101
    (2^05, 2^06]: 42
    (2^06, 2^07]: 73
    (2^07, 2^08]: 147
    (2^08, 2^09]: 125
sum_limbo_reclamation_event_size_total=3062204
count_limbo_reclamation_event_size_by_thread=9224 9282 9257 9291 9331 9268 9270 9318 9283 9247 9269 9243 9270 9272 9178 9238 9184 9223 9244 9164 9199 9292 9322 9266 9252 9251 9245 9244 9243 9283 9241 9197 9164 9244 9321 9304 9216 9278 9241 9318 9232 9275 9221 9273 9243 9262 9241 9204 9243 9272 9227 9266 9258 9296 9221 9212 9269 9220 9254 9226 9192 9174 9274 9250
count_limbo_reclamation_event_size_total=591982
sum_limbo_reclamation_event_count_total=770940
first_thread_announced_epoch_by_thread=16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828 16828
sum_num_inserts_by_thread=18640 18743 18617 18779 18526 18884 18586 18834 18584 18907 18664 18809 18590 18728 18479 18484 18495 18655 18759 18471 18557 18734 18892 18711 18520 18596 18491 18534 18895 18410 18374 18562 18608 18480 18902 18718 18729 18902 18792 18602 18506 18790 18465 18648 18337 18439 18378 18371 18630 18667 18552 18503 18507 18732 18491 18602 18442 18599 18465 18257 18536 18207 18537 18835
sum_num_inserts_total=1190739
sum_num_deletes_by_thread=18801 18671 18586 18819 18774 18924 18957 18699 18901 18819 18632 18738 18581 18668 18297 18330 18826 18524 18627 18418 18891 18628 18618 18555 18964 18615 18491 18544 18576 18681 18474 18434 18718 18684 18950 18797 18690 18754 18823 18846 18601 18863 18408 18978 18433 18708 18553 18596 18807 18686 18365 18610 18587 18497 18472 18562 18802 18570 18551 18479 18619 18473 18395 18702
sum_num_deletes_total=1193642
sum_num_searches_by_thread=3715734 3714418 3695106 3675068 3699555 3721020 3707921 3704949 3710051 3705999 3693940 3692551 3699293 3690653 3671945 3665963 3680373 3676397 3668219 3664556 3715782 3710735 3697349 3696690 3697154 3697458 3686786 3677053 3676060 3669492 3657999 3654816 3688318 3685052 3723795 3717623 3719164 3720055 3707980 3707368 3708055 3696994 3677560 3669265 3676315 3672015 3663445 3660493 3698584 3693836 3682449 3679981 3688998 3688116 3678295 3665496 3664670 3659391 3649897 3644558 3658211 3664507 3701555 3698530
sum_num_searches_total=236001656
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=3753175 3751832 3732309 3712666 3736855 3758828 3745464 3742482 3747536 3743725 3731236 3730098 3736464 3728049 3708721 3702777 3717694 3713576 3705605 3701445 3753230 3748097 3734859 3733956 3734638 3734669 3723768 3714131 3713531 3706583 3694847 3691812 3725644 3722216 3761647 3755138 3756583 3757711 3745595 3744816 3745162 3734647 3714433 3706891 3713085 3709162 3700376 3697460 3736021 3731189 3719366 3717094 3726092 3725345 3715258 3702660 3701914 3696560 3686913 3681294 3695366 3701187 3738487 3736067
average_num_operations_total=3724781
stdev_num_operations_total=2564
sum_num_operations_total=238386037
min_num_operations_total=3681294
max_num_operations_total=3761647
first_time_thread_terminate_by_thread=10000109 10000073 10000070 10000070 10000073 10000073 10000073 10000073 10000071 10000071 10000072 10000072 10000074 10000074 10000074 10000074 10000072 10000072 10000072 10000072 10000077 10000077 10000077 10000077 10000075 10000075 10000075 10000075 10000077 10000077 10000077 10000077 10000074 10000074 10000074 10000074 10000075 10000075 10000075 10000075 10000072 10000072 10000073 10000072 10000076 10000076 10000076 10000076 10000074 10000074 10000074 10000074 10000077 10000077 10000077 10000077 10000077 10000078 10000077 10000077 10000076 10000076 10000076 10000076
min_time_thread_terminate_total=10000070
max_time_thread_terminate_total=10000109
first_time_thread_start_by_thread=9 4 3 3 8 8 8 8 6 6 6 6 9 9 9 9 10 11 10 10 6 7 7 7 7 7 7 7 10 10 10 10 5 5 5 5 5 5 4 5 9 9 9 9 8 8 8 8 6 6 6 6 5 5 5 5 5 5 5 5 9 9 9 9
min_time_thread_start_total=3
max_time_thread_start_total=11
sum_duration_all_ops_total=

threads_final_keysum=99962964934509
threads_final_size=9998353
final_keysum=99962964934509
final_size=9998353
validate_result=success
Validation OK.
Structural validation OK.

total_find=236001656
total_rq=0
total_inserts=1190739
total_deletes=1193642
total_updates=2384381
total_queries=236001656
total_ops=238386037
find_throughput=23600165
rq_throughput=0
update_throughput=238438
query_throughput=23600165
total_throughput=23838603


total find                    : 236001656
total rq                      : 0
total inserts                 : 1190739
total deletes                 : 1193642
total updates                 : 2384381
total queries                 : 236001656
total ops                     : 238386037
find throughput               : 23600165
rq throughput                 : 0
update throughput             : 238438
query throughput              : 23600165
total throughput              : 23838603

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

garbage=1105607075963283
total_execution_walltime=15.437s
REALTIME_MAIN_END_PERF_FORMAT=207834.270006714
[time_cmd_output] time_elapsed_sec=15.69, faults_major=1, faults_minor=590912, mem_maxresident_kb=2362520, user_cputime=959.74, sys_cputime=7.38, percent_cpu=6163%
timeout=false
algorithm=brown_ext_chromatic_lf.debra
thread_pinning=-pin 0-63,128-191,64-127,192-255
millis=10000
__trials=1