__step=000306
__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 48 -nprefill 48 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 0.5 0.5 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000306.txt
__path_data=data/data000306.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6982459.236359242
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=0.5
DEL_FRAC=0.5
RQ=0
RQSIZE=0
MAXKEY=200000
PREFILL_THREADS=48
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=48
WORK_THREADS=48
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,96,97,98,99,100,101,102,103,104,105,106,107,108,109,110,111,112,113,114,115,116,117,118,119
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.007s
prefilling_size=100238 prefilling_elapsed_millis=1.001s
finished prefilling to size 100249 for expected size 100000 keysum=10031070828, performing 28550663 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=100249
pref_millis=1102
prefill_elapsed_ms=1125
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=2120
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=6982460.534246476
REALTIME_END_PERF_FORMAT=6982470.534402534
###############################################################################
################################## 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.055s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2047 4067 7843 13675 19560 21170 16507 8781 3173 810 142 16 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 1 27 291 2011 7790 17950 25833 24233 14389 5536 1478 268 31 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4094 8134 15686 27350 39120 42340 33014 17562 6346 1620 284 32 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 1 27 291 2011 7790 17950 25833 24233 14389 5536 1478 268 31 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 1.99951 1.9934 1.96422 1.8718 1.71517 1.54116 1.38987 1.26598 1.18067 1.12764 1.08765 1.05634 1.03125 1
tree_stats_height=25
tree_stats_numInternals=99839
tree_stats_numLeaves=99840
tree_stats_numNodes=199679
tree_stats_numKeys=99840
tree_stats_avgDegreeInternal=2.00001
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=17.3626
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229264 455504 878416 1531600 2190720 2371040 1848784 983472 355376 90720 15904 1792 112
tree_stats_sizeInBytes=11182024
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=46093
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:81392 2:136949 4:149098 8:45587 16:1304
[2^00, 2^01]: 81392
(2^01, 2^02]: 136949
(2^02, 2^03]: 149098
(2^03, 2^04]: 45587
(2^04, 2^05]: 1304
sum_limbo_reclamation_event_size_total=1663787
count_limbo_reclamation_event_size_by_thread=8571 8556 8662 8657 8716 8599 8575 8586 8693 8670 8623 8668 8646 8550 8698 8641 8611 8609 8617 8668 8683 8636 8616 8617 8577 8689 8576 8553 8679 8622 8652 8662 8673 8677 8579 8581 8686 8702 8585 8634 8681 8656 8541 8573 8657 8611 8651 8665
count_limbo_reclamation_event_size_total=414330
sum_limbo_reclamation_event_count_total=4221406
first_thread_announced_epoch_by_thread=92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186 92186
sum_num_inserts_by_thread=101231 101548 102611 102294 101365 100440 100750 101593 102827 102970 101712 101191 101140 101982 102518 102366 102792 100363 100825 101753 102611 103067 102487 100474 100545 101174 102421 102795 102016 100615 100925 101892 102750 103535 101854 101466 101308 101604 102925 102462 103023 100475 100671 101345 101819 102540 101143 101611
sum_num_inserts_total=4885824
sum_num_deletes_by_thread=100330 101497 103013 102040 102454 100154 101279 101173 103665 103608 101973 101045 101341 101656 103341 102733 102003 101983 100588 101819 103121 102767 102186 100792 100726 101645 102647 103323 101938 100873 101274 101474 102934 103443 100894 100817 101171 102138 102893 102316 102753 101588 99975 101287 101746 102641 101987 100798
sum_num_deletes_total=4889842
sum_num_searches_by_thread=19962416 20044590 20273554 20271114 20184760 19820453 20005576 20069207 20378201 20423097 20114979 20085184 20033054 20142103 20282929 20363955 20247112 20115612 19972862 20162203 20331383 20365870 20203842 19896212 19918603 20015266 20342484 20391795 20163149 19896279 19998494 20080819 20379631 20391416 20120071 20073598 20061732 20171826 20312939 20338146 20279860 20083849 19884676 19956217 20200083 20323129 20081327 19982828
sum_num_searches_total=967198485
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=20163977 20247635 20479178 20475448 20388579 20021047 20207605 20271973 20584693 20629675 20318664 20287420 20235535 20345741 20488788 20569054 20451907 20317958 20174275 20365775 20537115 20571704 20408515 20097478 20119874 20218085 20547552 20597913 20367103 20097767 20200693 20284185 20585315 20598394 20322819 20275881 20264211 20375568 20518757 20542924 20485636 20285912 20085322 20158849 20403648 20528310 20284457 20185237
average_num_operations_total=20353628
stdev_num_operations_total=24062
sum_num_operations_total=976974151
min_num_operations_total=20021047
max_num_operations_total=20629675
first_time_thread_terminate_by_thread=10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000156 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000156 10000155 10000155 10000155 10000155 10000155 10000155 10000155 10000156 10000155 10000156 10000155 10000155 10000155 10000155 10000156 10000155 10000155 10000155 10000155 10000155
min_time_thread_terminate_total=10000155
max_time_thread_terminate_total=10000156
first_time_thread_start_by_thread=2 2 2 3 3 3 3 2 2 3 3 2 2 3 3 3 2 2 2 3 3 3 2 2 2 2 2 3 3 3 3 2 2 3 3 2 2 3 3 3 2 2 2 3 3 3 2 2
min_time_thread_start_total=2
max_time_thread_start_total=3
sum_duration_all_ops_total=
threads_final_keysum=9973406653
threads_final_size=99840
final_keysum=9973406653
final_size=99840
validate_result=success
Validation OK.
Structural validation OK.
total_find=967198485
total_rq=0
total_inserts=4885824
total_deletes=4889842
total_updates=9775666
total_queries=967198485
total_ops=976974151
find_throughput=96719848
rq_throughput=0
update_throughput=977566
query_throughput=96719848
total_throughput=97697415
total find : 967198485
total rq : 0
total inserts : 4885824
total deletes : 4889842
total updates : 9775666
total queries : 967198485
total ops : 976974151
find throughput : 96719848
rq throughput : 0
update throughput : 977566
query throughput : 96719848
total throughput : 97697415
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=7.45589
PAPI_L3_TCM=0.00557069
PAPI_TOT_CYC=1365.26
PAPI_TOT_INS=309.953
garbage=47327383318411
total_execution_walltime=11.428s
REALTIME_MAIN_END_PERF_FORMAT=6982470.674682705
[time_cmd_output] time_elapsed_sec=11.55, faults_major=0, faults_minor=82272, mem_maxresident_kb=330060, user_cputime=561.18, sys_cputime=2.98, percent_cpu=4881%
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