__step=000868
__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 50.0 50.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000868.txt
__path_data=data/data000868.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6989428.862694889
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=50
DEL_FRAC=50
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=50.0 50.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=1001039 prefilling_elapsed_millis=1.001s
finished prefilling to size 1001086 for expected size 1000000 keysum=1001352604620, performing 21857423 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1001086
pref_millis=1102
prefill_elapsed_ms=1123
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=488
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=6989430.160325013
REALTIME_END_PERF_FORMAT=6989440.160454461
###############################################################################
################################## 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 (192 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.036s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16369 32535 62874 112330 171963 206882 185558 119436 53860 16930 3726 653 67 6 1 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 15 203 2196 13418 52697 137044 228206 251680 185012 90790 30134 6799 1239 128 11 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32738 65070 125748 224660 343926 413764 371116 238872 107720 33860 7452 1306 134 12 2
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 15 203 2196 13418 52697 137044 228206 251680 185012 90790 30134 6799 1239 128 11 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99908 1.9938 1.96625 1.89329 1.76544 1.60153 1.44846 1.32183 1.22548 1.15717 1.11004 1.08763 1.0513 1.04478 1.08333 1
tree_stats_height=30
tree_stats_numInternals=999573
tree_stats_numLeaves=999574
tree_stats_numNodes=1999147
tree_stats_numKeys=999574
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=20.7648
tree_stats_bytesAtDepth=56 112 224 448 896 1792 3584 7168 14336 28672 57344 114688 229376 458752 917504 1833328 3643920 7041888 12580960 19259856 23170784 20782496 13376832 6032320 1896160 417312 73136 7504 672 112
tree_stats_sizeInBytes=111952232
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=5379
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:65726 2:43995 4:2490 8:4829 16:10101 32:25574 64:48799 128:86721 256:275755 512:221886 1024:369
[2^00, 2^01]: 65726
(2^01, 2^02]: 43995
(2^02, 2^03]: 2490
(2^03, 2^04]: 4829
(2^04, 2^05]: 10101
(2^05, 2^06]: 25574
(2^06, 2^07]: 48799
(2^07, 2^08]: 86721
(2^08, 2^09]: 275755
(2^09, 2^10]: 221886
(2^10, 2^11]: 369
sum_limbo_reclamation_event_size_total=321253231
count_limbo_reclamation_event_size_by_thread=8194 8280 8252 8239 8302 8289 8210 8207 8294 8086 8311 8280 8263 8234 8237 8208 8325 8250 8274 8261 8177 8162 8391 8148 8253 8231 8253 8359 8227 8273 8237 8235 8243 8265 8221 8342 8265 8303 8182 8213 8151 8163 8239 8178 8225 8144 8359 8327 8253 8195 8074 8059 8216 8210 8136 8157 8094 8093 8060 8129 8095 8150 8152 8040 8183 8144 8119 8062 8134 8166 8073 8173 8166 8189 8055 8125 8108 8151 8233 8106 8117 8102 8115 8131 8223 8208 8086 8180 8037 8210 8164 8170 8040 8139 8115 8146
count_limbo_reclamation_event_size_total=786245
sum_limbo_reclamation_event_count_total=925846
first_thread_announced_epoch_by_thread=10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758 10758
sum_num_inserts_by_thread=1114060 1124521 1136156 1124951 1137410 1123307 1115619 1124607 1134033 1122665 1131443 1117434 1123275 1129167 1132711 1125244 1132292 1111592 1123559 1116289 1116838 1120697 1140420 1100530 1120291 1114789 1131603 1140533 1131963 1126700 1116691 1125723 1135004 1134266 1125125 1125709 1122386 1125807 1128380 1124519 1115116 1120334 1115873 1112945 1133799 1122724 1135236 1121862 1105165 1108613 1108189 1106128 1107986 1105767 1105781 1111540 1115248 1107461 1103192 1105877 1102021 1115497 1112220 1102468 1116518 1099883 1095528 1099567 1107239 1108072 1095652 1102999 1100854 1105193 1107385 1108500 1103673 1102780 1105321 1101253 1116156 1118958 1105564 1102125 1114917 1112610 1101261 1119192 1103342 1099934 1098245 1110686 1100939 1112304 1100126 1105977
sum_num_inserts_total=107092104
sum_num_deletes_by_thread=1114937 1125859 1134452 1124956 1135944 1123293 1115822 1123750 1134469 1121295 1132888 1118266 1122695 1129396 1133900 1124838 1131884 1110727 1122282 1117493 1118041 1123744 1139910 1101500 1120398 1115933 1130426 1141042 1132238 1125578 1115755 1129268 1136344 1135816 1124426 1127390 1124506 1125307 1129689 1125014 1115246 1120106 1114546 1112329 1133862 1121438 1136587 1122697 1105264 1107779 1106700 1108389 1108783 1105260 1104675 1114480 1115048 1108159 1103267 1106188 1101347 1116241 1110396 1103988 1113928 1100195 1095347 1100396 1107317 1109472 1092520 1103062 1100383 1103879 1106904 1108856 1103275 1101360 1108712 1101950 1118944 1116303 1104953 1104889 1113152 1114577 1104316 1120092 1102959 1098617 1097524 1111641 1099135 1112669 1098554 1104639
sum_num_deletes_total=107104766
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=2228997 2250380 2270608 2249907 2273354 2246600 2231441 2248357 2268502 2243960 2264331 2235700 2245970 2258563 2266611 2250082 2264176 2222319 2245841 2233782 2234879 2244441 2280330 2202030 2240689 2230722 2262029 2281575 2264201 2252278 2232446 2254991 2271348 2270082 2249551 2253099 2246892 2251114 2258069 2249533 2230362 2240440 2230419 2225274 2267661 2244162 2271823 2244559 2210429 2216392 2214889 2214517 2216769 2211027 2210456 2226020 2230296 2215620 2206459 2212065 2203368 2231738 2222616 2206456 2230446 2200078 2190875 2199963 2214556 2217544 2188172 2206061 2201237 2209072 2214289 2217356 2206948 2204140 2214033 2203203 2235100 2235261 2210517 2207014 2228069 2227187 2205577 2239284 2206301 2198551 2195769 2222327 2200074 2224973 2198680 2210616
average_num_operations_total=2231217
stdev_num_operations_total=2411
sum_num_operations_total=214196870
min_num_operations_total=2188172
max_num_operations_total=2281575
first_time_thread_terminate_by_thread=10000120 10000119 10000119 10000120 10000121 10000121 10000123 10000118 10000118 10000118 10000118 10000120 10000119 10000499 10000121 10000119 10000432 10000543 10000120 10000593 10000119 10000119 10000119 10000119 10000121 10000119 10000118 10000119 10000121 10000289 10000120 10000121 10000118 10000118 10000535 10000457 10000120 10000120 10000121 10000118 10000118 10000118 10000120 10000120 10000133 10000119 10000119 10000465 10000121 10000121 10000711 10000118 10000121 10000119 10000118 10000137 10000120 10000427 10000120 10000118 10000119 10000188 10000119 10000120 10000119 10000119 10000121 10000119 10000121 10000118 10000121 10000120 10000121 10000121 10000437 10000118 10000118 10000120 10000118 10000118 10000119 10000120 10000120 10000118 10000119 10000120 10000119 10000118 10000119 10000119 10000118 10000119 10000511 10000118 10000119 10000120
min_time_thread_terminate_total=10000118
max_time_thread_terminate_total=10000711
first_time_thread_start_by_thread=4 5 4 4 5 4 4 4 4 5 5 4 5 4 5 5 4 4 4 5 5 5 4 5 4 5 4 4 5 4 4 4 4 5 5 4 5 4 5 5 4 4 4 5 5 5 4 5 5 5 5 4 5 4 4 5 5 5 5 5 5 4 4 5 5 5 5 5 5 5 5 5 5 5 5 4 5 4 4 5 5 5 5 5 5 4 4 5 5 5 5 5 5 5 5 5
min_time_thread_start_total=4
max_time_thread_start_total=5
sum_duration_all_ops_total=
threads_final_keysum=999204835510
threads_final_size=999574
final_keysum=999204835510
final_size=999574
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=107092104
total_deletes=107104766
total_updates=214196870
total_queries=0
total_ops=214196870
find_throughput=0
rq_throughput=0
update_throughput=21419687
query_throughput=0
total_throughput=21419687
total find : 0
total rq : 0
total inserts : 107092104
total deletes : 107104766
total updates : 214196870
total queries : 0
total ops : 214196870
find throughput : 0
rq throughput : 0
update throughput : 21419687
query throughput : 0
total throughput : 21419687
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=53.3107
PAPI_L3_TCM=20.1369
PAPI_TOT_CYC=11727.1
PAPI_TOT_INS=2012.04
garbage=0
total_execution_walltime=11.55s
REALTIME_MAIN_END_PERF_FORMAT=6989440.418640079
[time_cmd_output] time_elapsed_sec=11.69, faults_major=0, faults_minor=141905, mem_maxresident_kb=564204, user_cputime=1028.82, sys_cputime=13.08, percent_cpu=8909%
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