__step=000532
__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 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=data000532.txt
__path_data=data/data000532.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6985297.772307912
binary=./brown_ext_chromatic_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
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=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=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,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=999171 prefilling_elapsed_millis=1.001s
finished prefilling to size 999135 for expected size 1000000 keysum=998845587219, performing 21867509 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=999135
pref_millis=1102
prefill_elapsed_ms=1124
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=487

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

main thread: starting timer...

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

REALTIME_START_PERF_FORMAT=6985299.117545915
REALTIME_END_PERF_FORMAT=6985309.117673549

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

tree_stats_computeWalltime=0.034s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8191 16370 32468 62463 110502 167349 201510 184350 123081 58762 19890 4881 879 134 13 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 1 12 272 2473 14424 53655 133188 218670 245619 187400 97634 34899 8883 1624 255 26
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16382 32740 64936 124926 221004 334698 403020 368700 246162 117524 39780 9762 1758 268 26
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 1 12 272 2473 14424 53655 133188 218670 245619 187400 97634 34899 8883 1624 255 26
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 1.99988 1.99927 1.99169 1.96192 1.88454 1.75722 1.60207 1.45742 1.33382 1.23871 1.16924 1.1227 1.09004 1.07622 1.04851 1

tree_stats_height=29
tree_stats_numInternals=999034
tree_stats_numLeaves=999035
tree_stats_numNodes=1998069
tree_stats_numKeys=999035

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

tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917392 1833440 3636416 6995856 12376224 18743088 22569120 20647200 13785072 6581344 2227680 546672 98448 15008 1456
tree_stats_sizeInBytes=111891864

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

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:0 2:0 4:0 8:9 16:17394 32:463092 64:475181 128:3940
    (2^03, 2^04]: 9
    (2^04, 2^05]: 17394
    (2^05, 2^06]: 463092
    (2^06, 2^07]: 475181
    (2^07, 2^08]: 3940
sum_limbo_reclamation_event_size_total=65769150
count_limbo_reclamation_event_size_by_thread=9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996 9996
count_limbo_reclamation_event_size_total=959616
sum_limbo_reclamation_event_count_total=1702464
first_thread_announced_epoch_by_thread=18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708 18708
sum_num_inserts_by_thread=400870 403362 407127 406659 404988 400750 402790 404957 409772 409483 404298 401396 402064 404941 407593 408942 406753 402453 400241 401905 405832 407978 402063 400674 401840 404397 406944 406843 406569 401660 402870 404234 409883 409202 405425 402170 402938 404161 408297 408730 405773 402469 400207 402260 406331 407636 402867 398477 400632 403033 407359 407585 404113 402369 401693 405032 409418 410381 406093 402737 404034 406159 408606 410212 405528 400768 398882 402033 406705 406106 402803 400092 399318 403433 405362 408012 404027 401341 400204 402920 408615 408368 405528 403434 403194 405853 408204 409259 405471 401652 399949 402475 409419 408156 405866 401782
sum_num_inserts_total=38844289
sum_num_deletes_by_thread=401235 404301 407432 407404 405408 399959 402299 405083 408855 409472 405956 402390 402112 403383 407805 408405 406322 402418 400788 403830 405640 407765 402672 400537 402146 402939 408228 407712 406459 401240 402725 404954 408682 409411 404523 403480 402440 405056 407992 407041 406777 401835 399645 402036 404499 406103 403621 399399 401620 404416 406631 407198 402085 402893 401575 405261 410354 411389 406823 404307 404186 405047 408725 409788 406559 400795 398913 400675 406569 406700 402426 402243 400310 403300 406242 407040 402350 401415 400630 402959 409519 408639 405152 402074 404050 405550 408743 409169 406350 401217 401792 403239 409564 409811 406124 403463
sum_num_deletes_total=38856294
sum_num_searches_by_thread=7233198 7273922 7324395 7324792 7290094 7203763 7240771 7283961 7359773 7373680 7282751 7235193 7253358 7286031 7351026 7337439 7311833 7246784 7203116 7264090 7305464 7337859 7238792 7212961 7226252 7277530 7344117 7336254 7309604 7218419 7242393 7277007 7360076 7369319 7289510 7240536 7259939 7284320 7342174 7344216 7295102 7237346 7191596 7235814 7287892 7327944 7246251 7178547 7223990 7253363 7330348 7325540 7249623 7243420 7230754 7276985 7372036 7376803 7314436 7260066 7268389 7308089 7362451 7364905 7306662 7201722 7180720 7220248 7311229 7315122 7251382 7217256 7206152 7257072 7323986 7325663 7238859 7214151 7214069 7250424 7356805 7361502 7309907 7254281 7254217 7290502 7340443 7359497 7309612 7226915 7212678 7251177 7354734 7355751 7309723 7256613
sum_num_searches_total=699097476
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=8035303 8081585 8138954 8138855 8100490 8004472 8045860 8094001 8178400 8192635 8093005 8038979 8057534 8094355 8166424 8154786 8124908 8051655 8004145 8069825 8116936 8153602 8043527 8014172 8030238 8084866 8159289 8150809 8122632 8021319 8047988 8086195 8178641 8187932 8099458 8046186 8065317 8093537 8158463 8159987 8107652 8041650 7991448 8040110 8098722 8141683 8052739 7976423 8026242 8060812 8144338 8140323 8055821 8048682 8034022 8087278 8191808 8198573 8127352 8067110 8076609 8119295 8179782 8184905 8118749 8003285 7978515 8022956 8124503 8127928 8056611 8019591 8005780 8063805 8135590 8140715 8045236 8016907 8014903 8056303 8174939 8178509 8120587 8059789 8061461 8101905 8157390 8177925 8121433 8029784 8014419 8056891 8173717 8173718 8121713 8061858
average_num_operations_total=8091646
stdev_num_operations_total=6045
sum_num_operations_total=776798059
min_num_operations_total=7976423
max_num_operations_total=8198573
first_time_thread_terminate_by_thread=10000129 10000128 10000129 10000126 10000128 10000128 10000126 10000126 10000126 10000127 10000126 10000127 10000128 10000129 10000128 10000126 10000127 10000128 10000129 10000126 10000128 10000126 10000127 10000126 10000129 10000128 10000129 10000126 10000128 10000128 10000127 10000126 10000126 10000127 10000126 10000127 10000126 10000129 10000126 10000126 10000127 10000128 10000129 10000126 10000128 10000126 10000129 10000126 10000127 10000128 10000127 10000128 10000126 10000128 10000127 10000126 10000127 10000127 10000126 10000128 10000127 10000128 10000126 10000126 10000126 10000128 10000127 10000127 10000127 10000127 10000127 10000128 10000127 10000128 10000127 10000128 10000126 10000128 10000127 10000126 10000127 10000127 10000126 10000128 10000127 10000126 10000127 10000126 10000126 10000128 10000127 10000127 10000127 10000127 10000128 10000127
min_time_thread_terminate_total=10000126
max_time_thread_terminate_total=10000129
first_time_thread_start_by_thread=4 4 5 5 4 4 5 5 4 5 5 4 4 5 4 4 5 4 4 4 4 4 4 4 4 4 5 5 4 4 5 5 4 4 5 4 4 5 4 4 5 4 4 4 4 4 4 4 4 5 5 5 4 4 5 5 4 5 5 5 4 4 4 5 4 4 5 5 4 4 5 5 4 5 5 5 4 4 5 5 4 5 5 5 4 4 4 5 4 4 5 5 4 4 5 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=

threads_final_keysum=998704331618
threads_final_size=999035
final_keysum=998704331618
final_size=999035
validate_result=success
Validation OK.
Structural validation OK.

total_find=699097476
total_rq=0
total_inserts=38844289
total_deletes=38856294
total_updates=77700583
total_queries=699097476
total_ops=776798059
find_throughput=69909747
rq_throughput=0
update_throughput=7770058
query_throughput=69909747
total_throughput=77679805


total find                    : 699097476
total rq                      : 0
total inserts                 : 38844289
total deletes                 : 38856294
total updates                 : 77700583
total queries                 : 699097476
total ops                     : 776798059
find throughput               : 69909747
rq throughput                 : 0
update throughput             : 7770058
query throughput              : 69909747
total throughput              : 77679805

elapsed milliseconds          : 10000
napping milliseconds overtime : 0

PAPI_L2_TCM=19.8143
PAPI_L3_TCM=5.42976
PAPI_TOT_CYC=3440.74
PAPI_TOT_INS=421.515
garbage=349464790325064
total_execution_walltime=11.509s
REALTIME_MAIN_END_PERF_FORMAT=6985309.282456960
[time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=138805, mem_maxresident_kb=548928, user_cputime=1085.92, sys_cputime=4.30, percent_cpu=9368%
timeout=false
algorithm=brown_ext_chromatic_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