__step=000483
__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 96 -nprefill 96 -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=data000483.txt
__path_data=data/data000483.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000620.92336049
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=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=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
Hybrid noREC system ready
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.014s
prefilling_size=95160 prefilling_elapsed_millis=1.001s
prefilling_size=96379 prefilling_elapsed_millis=1.101s
prefilling_size=97255 prefilling_elapsed_millis=1.201s
prefilling_size=97904 prefilling_elapsed_millis=1.301s
prefilling_size=98219 prefilling_elapsed_millis=1.402s
finished prefilling to size 98232 for expected size 100000 keysum=9832532403, performing 886013 updates; total_prefilling_elapsed_ms=1503 ms)
pref_size=98232
pref_millis=1503
prefill_elapsed_ms=1527
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000621.803764441
REALTIME_END_PERF_FORMAT=7000631.803898553
###############################################################################
################################## 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.054s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8120 14470 16851 8740 1160 12 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 69 1525 9803 18617 11093 1464 15
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8189 15995 26654 27357 12253 1476 15
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8189 15995 26654 27357 12253 1476 15
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 1.99927 1.96166 1.76174 1.39416 1.12841 1.02579 1.00203 1
tree_stats_height=20
tree_stats_numInternals=57544
tree_stats_numLeaves=42586
tree_stats_numNodes=100130
tree_stats_numKeys=100130
tree_stats_avgDegreeInternal=1.74006
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.42531
tree_stats_avgKeyDepth=14.9124
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=98592
first_thread_announced_epoch_by_thread=2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076 2076
sum_num_inserts_by_thread=35646 34584 34135 33961 34429 34303 35548 35273 35125 35398 34753 34231 35186 35237 34328 34474 34586 34744 35412 36126 34644 35011 34823 35249 36158 33883 34094 34590 34464 34107 36063 35537 34920 35184 34042 34254 35869 35102 35002 34341 34682 33918 35195 35394 35486 34970 34811 34676 28922 28137 27995 27844 27140 28876 28725 28459 28892 28592 27254 28460 28488 28644 28644 28559 28202 28170 28732 28720 28619 28970 28455 28647 28825 28519 28321 27688 27033 28981 29034 28605 28852 28928 27812 28295 29173 28137 28513 28413 27610 28389 28378 29206 28801 28271 28294 28512
sum_num_inserts_total=3038684
sum_num_deletes_by_thread=35608 34340 33830 34525 34664 34238 35870 35602 34840 35454 34900 34425 35163 35742 34551 34970 34150 34489 35535 36607 34974 35112 34635 35351 35760 33869 34141 34453 34356 34074 36060 35489 34861 34766 34368 33946 36067 34773 35463 34594 34465 34437 34969 35755 35213 35238 34900 34931 29457 27885 27934 27744 27149 28605 28680 28569 28455 28586 27606 28615 28615 28820 28585 28430 28058 28238 29090 29218 28565 28575 28180 28775 29078 28003 28153 28087 27007 28611 28846 28920 28334 28974 27525 28409 29123 28079 28512 28435 28018 28587 28422 29273 28662 28365 28355 28396
sum_num_deletes_total=3041131
sum_num_searches_by_thread=645212 619350 616937 617980 622334 615648 644098 640844 628873 634352 627357 617995 636250 634117 616608 625205 615067 618275 639304 653703 626301 629832 623841 637422 648623 608711 611150 625138 620704 613186 654853 642996 626999 633493 618890 615804 643658 632219 632883 622257 619861 613614 633183 641233 635183 633667 629678 625194 525245 504106 501571 498779 490027 514249 515147 513911 516114 513335 491030 511428 513403 518265 512278 512084 507360 504066 520647 524370 520325 516906 512080 514023 518089 510864 509238 503355 484993 518837 521477 516155 512582 518526 498971 508318 524170 504818 511442 510745 502373 516068 513529 523710 517577 512506 510115 516633
sum_num_searches_total=54725922
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=716466 688274 684902 686466 691427 684189 715516 711719 698838 705204 697010 686651 706599 705096 685487 694649 683803 687508 710251 726436 695919 699955 693299 708022 720541 676463 679385 694181 689524 681367 726976 714022 696780 703443 687300 684004 715594 702094 703348 691192 689008 681969 703347 712382 705882 703875 699389 694801 583624 560128 557500 554367 544316 571730 572552 570939 573461 570513 545890 568503 570506 575729 569507 569073 563620 560474 578469 582308 577509 574451 568715 571445 575992 567386 565712 559130 539033 576429 579357 573680 569768 576428 554308 565022 582466 561034 568467 567593 558001 573044 570329 582189 575040 569142 566764 573541
average_num_operations_total=633393
stdev_num_operations_total=6797
sum_num_operations_total=60805737
min_num_operations_total=539033
max_num_operations_total=726976
first_time_thread_terminate_by_thread=10000134 10000206 10000309 10000305 10000238 10000181 10000237 10000163 10000270 10000302 10000150 10000301 10000239 10000297 10000161 10000178 10000306 10000308 10000311 10000273 10000155 10000134 10000202 10000170 10000263 10000159 10000157 10000184 10000303 10000183 10000286 10000142 10000264 10000261 10000271 10000307 10000140 10000138 10000133 10000298 10000299 10000166 10000235 10000208 10000209 10000282 10000285 10000171 10000280 10000212 10000214 10000200 10000275 10000267 10000199 10000294 10000194 10000230 10000254 10000142 10000223 10000287 10000288 10000291 10000250 10000227 10000279 10000277 10000246 10000293 10000187 10000149 10000229 10000190 10000258 10000221 10000295 10000278 10000225 10000133 10000248 10000289 10000133 10000193 10000176 10000134 10000145 10000257 10000133 10000243 10000197 10000218 10000312 10000311 10000233 10000260
min_time_thread_terminate_total=10000133
max_time_thread_terminate_total=10000312
first_time_thread_start_by_thread=4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 4 3 3 3 3 3 4 4 3 3 3 3 3 3 3 3 3 3 3 3 3 3 4 3 4 3 3 3 3 3 4 3 3 2 3 3 2 2 3 2 3 2 3 3 3 2 3 2 3 3 3 3 3 3 3 3 3 2 3 3 2 2 3 2 3 2 3 3 3 2 3 2 3 3 3 3 3 3 3
min_time_thread_start_total=2
max_time_thread_start_total=4
sum_duration_all_ops_total=
threads_final_keysum=10007964965
threads_final_size=100130
final_keysum=10007964965
final_size=100130
validate_result=success
Validation OK.
Structural validation OK.
total_find=54725922
total_rq=0
total_inserts=3038684
total_deletes=3041131
total_updates=6079815
total_queries=54725922
total_ops=60805737
find_throughput=5472592
rq_throughput=0
update_throughput=607981
query_throughput=5472592
total_throughput=6080573
total find : 54725922
total rq : 0
total inserts : 3038684
total deletes : 3041131
total updates : 6079815
total queries : 54725922
total ops : 60805737
find throughput : 5472592
rq throughput : 0
update throughput : 607981
query throughput : 5472592
total throughput : 6080573
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=18.6261
PAPI_L3_TCM=3.36866
PAPI_TOT_CYC=43765.2
PAPI_TOT_INS=5780.31
garbage=2709728185693
total_execution_walltime=11.901s
REALTIME_MAIN_END_PERF_FORMAT=7000631.995512198
Hybrid noREC system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 58798602
[slow htm]
[fallback]
total fallback commit : 2893149
seconds global lock is held : 0.461732
[time_cmd_output] time_elapsed_sec=12.03, faults_major=0, faults_minor=100823, mem_maxresident_kb=400488, user_cputime=1124.62, sys_cputime=6.19, percent_cpu=9397%
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=1