__step=000486
__cmd_run=LD_PRELOAD=../../setbench/lib/libjemalloc.so timeout 180 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_sigouin_int_avl_tm_auto.debra.hybridnorec -nwork 144 -nprefill 144 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 200000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000486.txt
__path_data=data/data000486.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000656.485577596
binary=./brown_sigouin_int_avl_tm_auto.debra.hybridnorec
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=brown_sigouin_int_avl_tm_auto
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=200000
PREFILL_THREADS=144
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=144
WORK_THREADS=144
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=48
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,48,49,50,51,52,53,54,55,56,57,58,59,60,61,62,63,64,65,66,67,68,69,70,71,144,145,146,147,148,149,150,151,152,153,154,155,156,157,158,159,160,161,162,163,164,165,166,167
Hybrid noREC system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.063s
prefilling_size=92305 prefilling_elapsed_millis=1s
prefilling_size=94381 prefilling_elapsed_millis=1.1s
prefilling_size=95519 prefilling_elapsed_millis=1.201s
prefilling_size=96515 prefilling_elapsed_millis=1.301s
prefilling_size=97531 prefilling_elapsed_millis=1.401s
prefilling_size=98285 prefilling_elapsed_millis=1.501s
finished prefilling to size 98294 for expected size 100000 keysum=9832082000, performing 775008 updates; total_prefilling_elapsed_ms=1603 ms)
pref_size=98294
pref_millis=1603
prefill_elapsed_ms=1629
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000658.416169204
REALTIME_END_PERF_FORMAT=7000668.416287862
###############################################################################
################################## 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.035s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8103 14220 16201 8739 1814 124 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 81 1739 9788 17621 10815 2292 152
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 15959 25989 26360 12629 2416 152
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8184 15959 25989 26360 12629 2416 152
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99805 1.95992 1.73745 1.3909 1.14757 1.04767 1.01159 1
tree_stats_height=20
tree_stats_numInternals=57392
tree_stats_numLeaves=42488
tree_stats_numNodes=99880
tree_stats_numKeys=99880
tree_stats_avgDegreeInternal=1.74031
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42539
tree_stats_avgKeyDepth=14.9439
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0
[2^00, 2^01]: 0
sum_limbo_reclamation_event_size_total=
count_limbo_reclamation_event_size_by_thread=
count_limbo_reclamation_event_size_total=
sum_limbo_reclamation_event_count_total=63792
first_thread_announced_epoch_by_thread=896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896 896
sum_num_inserts_by_thread=11826 12259 12365 12254 12095 12435 11683 12231 11820 12668 11852 12267 11812 12181 12199 12263 12160 12322 11733 11855 11876 11742 11507 11767 11974 12211 12252 12778 11822 12657 11987 12076 12345 12253 12063 11941 12045 11867 12392 12368 11747 11994 12011 11992 11954 12207 11369 11840 17152 17381 17328 18325 17835 17078 17389 17552 17229 17960 17519 18271 17893 16862 17483 18112 18218 18356 17495 17467 17911 17959 17808 17582 17356 17519 17676 18259 17719 17014 17472 17800 17389 18114 17828 17910 17667 17279 17771 17903 18037 18406 17139 17741 17410 17668 17424 17560 23340 23587 23726 24658 24029 23513 24118 23898 24037 25118 24392 24874 23726 24497 24974 25403 24482 24860 23697 24251 23961 24781 24625 24433 23012 23952 23800 25199 23824 23185 23101 24023 23886 25087 24109 24759 23342 23827 24143 24854 24911 25058 24091 24395 24156 24712 24942 24114
sum_num_inserts_total=2591005
sum_num_deletes_by_thread=11788 12018 12112 12343 11933 12423 11445 12215 12169 12451 11836 12382 12148 12255 12242 12226 11983 12433 11950 12129 12016 11828 11595 11844 11817 12150 12248 12516 11883 12485 11829 12172 12332 12364 12148 12171 11917 12100 12147 12355 12206 11922 12180 12012 11987 12320 11443 11922 17032 17195 17559 18476 18026 17060 17649 17917 17411 18399 17575 18163 17817 17045 17705 18259 18083 18558 17495 17653 17747 17954 17810 17599 17482 17447 17450 18166 17598 17084 17369 17811 17271 18343 17850 18051 17689 17632 17829 18270 18293 18391 17348 17999 17164 17789 17346 17912 23586 23585 23700 24825 23773 23115 23857 23989 23837 24896 24257 24892 23716 24042 24829 25528 24574 24811 23572 24185 24224 24774 24711 24036 23303 23856 24196 25229 23806 23318 23050 24189 23864 25015 24117 24449 23502 24153 24527 24996 24880 24641 23926 24091 24281 24837 24684 24170
sum_num_deletes_total=2594555
sum_num_searches_by_thread=210808 219959 222038 221245 214998 224109 207348 219194 211940 223382 214204 220580 218296 217611 220898 218802 217749 221300 213024 214547 216833 212860 209631 211649 213822 221679 218838 226457 215190 224566 213390 221236 224227 220317 218303 220701 216513 215184 219794 223120 214293 215099 220209 214945 215650 221379 206724 214879 309954 311208 315356 329133 321995 306981 314460 320817 311919 329938 316592 328629 321682 304907 315180 328819 327443 335427 314376 315188 320536 326614 321314 312866 312183 317048 317830 326698 316825 308059 312627 318731 311416 325407 320874 324479 317401 314037 320905 328993 324277 333573 309699 321408 312689 319664 312326 320133 422360 425118 427522 447328 432252 418216 433299 430778 431176 446686 437362 448769 424880 438127 445378 455026 444660 444888 424229 433056 431654 439659 441597 434409 418538 427374 432582 452754 429414 414901 418273 431589 430283 452015 435022 444169 418441 432876 436931 445696 447686 446729 434337 436361 436454 444871 447213 433672
sum_num_searches_total=46654746
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=234422 244236 246515 245842 239026 248967 230476 243640 235929 248501 237892 245229 242256 242047 245339 243291 241892 246055 236707 238531 240725 236430 232733 235260 237613 246040 243338 251751 238895 249708 237206 245484 248904 244934 242514 244813 240475 239151 244333 247843 238246 239015 244400 238949 239591 245906 229536 238641 344138 345784 350243 365934 357856 341119 349498 356286 346559 366297 351686 365063 357392 338814 350368 365190 363744 372341 349366 350308 356194 362527 356932 348047 347021 352014 352956 363123 352142 342157 347468 354342 346076 361864 356552 360440 352757 348948 356505 365166 360607 370370 344186 357148 347263 355121 347096 355605 469286 472290 474948 496811 480054 464844 481274 478665 479050 496700 486011 498535 472322 486666 495181 505957 493716 494559 471498 481492 479839 489214 490933 482878 464853 475182 480578 503182 477044 461404 464424 479801 478033 502117 483248 493377 465285 480856 485601 495546 497477 496428 482354 484847 484891 494420 496839 481956
average_num_operations_total=360002
stdev_num_operations_total=8339
sum_num_operations_total=51840306
min_num_operations_total=229536
max_num_operations_total=505957
first_time_thread_terminate_by_thread=10000312 10000246 10000365 10000374 10000367 10000286 10000418 10000384 10000409 10000276 10000392 10000187 10000228 10000289 10000368 10000210 10000379 10000310 10000254 10000364 10000376 10000249 10000119 10000387 10000404 10000393 10000408 10000345 10000423 10000192 10000258 10000371 10000430 10000355 10000280 10000189 10000383 10000290 10000408 10000208 10000347 10000377 10000292 10000198 10000252 10000380 10000243 10000405 10000395 10000398 10000403 10000356 10000350 10000118 10000300 10000139 10000431 10000129 10000427 10000132 10000419 10000412 10000119 10000315 10000226 10000381 10000417 10000413 10000400 10000261 10000429 10000216 10000213 10000425 10000424 10000360 10000271 10000314 10000391 10000319 10000422 10000426 10000322 10000263 10000421 10000344 10000432 10000118 10000427 10000268 10000323 10000358 10000390 10000420 10000428 10000415 10000241 10000201 10000328 10000171 10000177 10000234 10000233 10000150 10000333 10000166 10000174 10000337 10000340 10000195 10000331 10000158 10000329 10000217 10000303 10000341 10000296 10000236 10000160 10000205 10000306 10000308 10000181 10000122 10000175 10000146 10000154 10000119 10000126 10000221 10000330 10000122 10000295 10000224 10000332 10000302 10000353 10000152 10000339 10000336 10000237 10000326 10000338 10000119
min_time_thread_terminate_total=10000118
max_time_thread_terminate_total=10000432
first_time_thread_start_by_thread=6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 5 6 5 6 5 6 6 6 5 5 6 6 5 6 6 6 6 6 5 5 6 6 5 6 5 6 5 6 10 6 6 6 5 5 6 6 5 6 6 6 6 6 5 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 6 5 6 6 6 6 5 6 6
min_time_thread_start_total=5
max_time_thread_start_total=10
sum_duration_all_ops_total=
threads_final_keysum=10004669323
threads_final_size=99880
final_keysum=10004669323
final_size=99880
validate_result=success
Validation OK.
Structural validation OK.
total_find=46654746
total_rq=0
total_inserts=2591005
total_deletes=2594555
total_updates=5185560
total_queries=46654746
total_ops=51840306
find_throughput=4665474
rq_throughput=0
update_throughput=518556
query_throughput=4665474
total_throughput=5184030
total find : 46654746
total rq : 0
total inserts : 2591005
total deletes : 2594555
total updates : 5185560
total queries : 46654746
total ops : 51840306
find throughput : 4665474
rq throughput : 0
update throughput : 518556
query throughput : 4665474
total throughput : 5184030
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=22.3867
PAPI_L3_TCM=4.74907
PAPI_TOT_CYC=77129.3
PAPI_TOT_INS=8153.84
garbage=2294910506195
total_execution_walltime=12.109s
REALTIME_MAIN_END_PERF_FORMAT=7000668.595185326
Hybrid noREC system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 50038076
[slow htm]
[fallback]
total fallback commit : 2577239
seconds global lock is held : 0.4399
[time_cmd_output] time_elapsed_sec=12.23, faults_major=0, faults_minor=102055, mem_maxresident_kb=401108, user_cputime=1697.66, sys_cputime=6.19, percent_cpu=13926%
timeout=false
algorithm=brown_sigouin_int_avl_tm_auto.debra.hybridnorec
thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
millis=10000
__trials=2