__step=000444
__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_int_bst_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=data000444.txt
__path_data=data/data000444.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=7000148.496825942
binary=./brown_int_bst_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_int_bst_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=32
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.044s
prefilling_size=96389 prefilling_elapsed_millis=1s
prefilling_size=97437 prefilling_elapsed_millis=1.1s
prefilling_size=98270 prefilling_elapsed_millis=1.201s
finished prefilling to size 98280 for expected size 100000 keysum=9833287007, performing 791191 updates; total_prefilling_elapsed_ms=1302 ms)
pref_size=98280
pref_millis=1302
prefill_elapsed_ms=1322
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0
global_epoch_counter=9
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=7000150.48156492
REALTIME_END_PERF_FORMAT=7000160.48259741
###############################################################################
################################## 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 848 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...
tree_stats_computeWalltime=0.032s
tree_stats_numInternalsAtDepth=1 2 4 8 16 32 63 126 239 452 782 1301 2025 2894 3778 4709 5541 6144 6337 6262 5900 5068 4093 3088 2233 1606 1092 716 432 214 125 66 33 22 6 3 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 1 0 10 14 66 145 307 636 1090 1515 2080 2651 3188 3402 3434 3566 3139 2660 2021 1468 1083 774 489 341 153 89 48 17 23 5 2 2
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 126 249 466 848 1446 2332 3530 4868 6224 7621 8795 9525 9664 9334 8634 7232 5748 4254 3074 2175 1490 921 555 278 155 81 39 29 8 4 2
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 126 249 466 848 1446 2332 3530 4868 6224 7621 8795 9525 9664 9334 8634 7232 5748 4254 3074 2175 1490 921 555 278 155 81 39 29 8 4 2
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.97619 1.91165 1.84979 1.78302 1.713 1.64537 1.55921 1.50247 1.46787 1.42698 1.38442 1.34929 1.31788 1.29291 1.25064 1.22884 1.20285 1.1977 1.1851 1.18299 1.13758 1.13355 1.11532 1.10791 1.09677 1.07407 1.17949 1.06897 1.125 1 1
tree_stats_height=38
tree_stats_numInternals=65415
tree_stats_numLeaves=34419
tree_stats_numNodes=99834
tree_stats_numKeys=99834
tree_stats_avgDegreeInternal=1.52616
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.34476
tree_stats_avgKeyDepth=18.9256
4NodeIxPvL9tx_safety0EE_object_size=32
4NodeIxPvL9tx_safety0EE_allocated_count=0
4NodeIxPvL9tx_safety0EE_allocated_size=0MB
4NodeIxPvL9tx_safety0EE_get_from_pool=0
4NodeIxPvL9tx_safety0EE_deallocated=0
4NodeIxPvL9tx_safety0EE_limbo_count=0
4NodeIxPvL9tx_safety0EE_limbo_details=0 0 0
global_epoch_counter=1101
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:0 4:412 8:45800 16:58426 32:2
(2^02, 2^03]: 412
(2^03, 2^04]: 45800
(2^04, 2^05]: 58426
(2^05, 2^06]: 2
sum_limbo_reclamation_event_size_total=1682882
count_limbo_reclamation_event_size_by_thread=1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090 1090
count_limbo_reclamation_event_size_total=104640
sum_limbo_reclamation_event_count_total=104832
first_thread_announced_epoch_by_thread=2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202 2202
sum_num_inserts_by_thread=37275 36059 36238 36149 35246 35711 37101 36335 35741 37016 36443 36176 37355 37005 36664 36153 34616 34524 37540 36143 36081 36464 36372 36398 37242 36393 36014 36283 34893 35927 37173 36354 35831 35399 36139 36302 37242 36110 35662 36136 35116 36227 37358 36480 36309 36363 35682 34778 35376 35157 34752 34041 33769 34310 33757 35381 33945 32715 33311 33825 33693 33517 33958 34385 34389 33044 35299 34010 33734 34170 34101 34442 35157 32937 33634 34724 33545 34771 33559 34667 34515 33063 33671 33668 33820 34288 33918 33629 33844 32868 34827 34199 32652 34787 33991 34796
sum_num_inserts_total=3372829
sum_num_deletes_by_thread=37206 36095 36040 36567 35289 35810 37433 36038 35991 37137 36527 36473 37248 37029 36280 36425 34789 34608 37531 36761 36301 36708 36934 36920 36642 36615 36106 36264 35459 35474 37787 36571 36020 35027 35980 36036 37807 36173 35328 35822 35282 36238 37174 36921 35848 36983 36034 35326 35399 34967 34597 33855 34068 34433 33940 35016 33755 32817 33122 33754 33632 33519 33820 34355 34101 32934 35061 33883 33991 34079 34132 34656 35256 32875 33249 34791 33753 34878 33291 34731 35245 32902 33999 33695 34376 34411 33907 33774 33730 32670 34568 34386 32826 34732 34037 34731
sum_num_deletes_total=3377756
sum_num_searches_by_thread=665807 646246 649795 657486 635727 644468 670733 650648 646586 666065 658218 655854 670084 661448 656573 653796 626128 620810 676406 656163 653399 659634 661168 660664 669613 654310 644594 651119 631399 645061 670951 660112 647661 639237 654677 649987 676773 649492 634097 646916 634917 651604 669257 660620 648567 659112 648962 632008 639999 629368 626575 609566 612706 627131 609711 636551 610069 587255 595330 603834 606563 597248 611298 618227 620016 591292 634693 612496 609625 614894 613799 623902 633910 592756 598692 631588 605563 625556 603519 624755 629275 593836 609106 606244 610311 617257 608119 605424 609797 589750 623164 619176 589421 628475 611202 626745
sum_num_searches_total=60770741
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=740288 718400 722073 730202 706262 715989 745267 723021 718318 740218 731188 728503 744687 735482 729517 726374 695533 689942 751477 729067 725781 732806 734474 733982 743497 727318 716714 723666 701751 716462 745911 733037 719512 709663 726796 722325 751822 721775 705087 718874 705315 724069 743789 734021 720724 732458 720678 702112 710774 699492 695924 677462 680543 695874 677408 706948 677769 652787 661763 671413 673888 664284 679076 686967 688506 657270 705053 680389 677350 683143 682032 693000 704323 658568 665575 701103 672861 695205 670369 694153 699035 659801 676776 673607 678507 685956 675944 672827 677371 655288 692559 687761 654899 697994 679230 696272
average_num_operations_total=703347
stdev_num_operations_total=2714
sum_num_operations_total=67521326
min_num_operations_total=652787
max_num_operations_total=751822
first_time_thread_terminate_by_thread=10000207 10000222 10000242 10000193 10000195 10000103 10000244 10000126 10000247 10000211 10000152 10000118 10000247 10000110 10000222 10000267 10000118 10000261 10000112 10000150 10000252 10000209 10000194 10000200 10000232 10000271 10000188 10000256 10000156 10000248 10000257 10000265 10000264 10000105 10000245 10000201 10000268 10000102 10000122 10000254 10000181 10000260 10000223 10000257 10000240 10000138 10000148 10000107 10000199 10000167 10000132 10000249 10000251 10000134 10000273 10000233 10000186 10000237 10000259 10000272 10000274 10000161 10000102 10000271 10000263 10000204 10000218 10000215 10000225 10000275 10000173 10000102 10000197 10000170 10000165 10000230 10000229 10000141 10000214 10000130 10000145 10000274 10000269 10000272 10000170 10000227 10000266 10000102 10000236 10000238 10000217 10000184 10000178 10000273 10000157 10000205
min_time_thread_terminate_total=10000102
max_time_thread_terminate_total=10000275
first_time_thread_start_by_thread=4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 3 3 4 4 3 4 4 4 4 4 4 3 4 4 4 4 4 4 3 4 4 4 4 4 3 3 4 4 3 4 4 4 4 3 4 3 3 4 4 3 7 3 3 3 3 3 3 3 3 4 3 3 3 4 3 4 3 3 4 3 3 4 4 3 3 3 3 3 3 3 3 3 4 4 3 3 3 4 3 4 3
min_time_thread_start_total=3
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=9992276073
threads_final_size=99834
final_keysum=9992276073
final_size=99834
validate_result=success
Validation OK.
Structural validation OK.
total_find=60770741
total_rq=0
total_inserts=3372829
total_deletes=3377756
total_updates=6750585
total_queries=60770741
total_ops=67521326
find_throughput=6077074
rq_throughput=0
update_throughput=675058
query_throughput=6077074
total_throughput=6752132
total find : 60770741
total rq : 0
total inserts : 3372829
total deletes : 3377756
total updates : 6750585
total queries : 60770741
total ops : 67521326
find throughput : 6077074
rq throughput : 0
update throughput : 675058
query throughput : 6077074
total throughput : 6752132
elapsed milliseconds : 10000
napping milliseconds overtime : 100
PAPI_L2_TCM=15.1714
PAPI_L3_TCM=2.64219
PAPI_TOT_CYC=39408.9
PAPI_TOT_INS=4802.37
garbage=3033546819581
total_execution_walltime=11.716s
REALTIME_MAIN_END_PERF_FORMAT=7000160.213808447
Hybrid noREC system shutdown:
HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit : 65112432
[slow htm]
[fallback]
total fallback commit : 3200086
seconds global lock is held : 0.211377
[time_cmd_output] time_elapsed_sec=11.84, faults_major=0, faults_minor=80957, mem_maxresident_kb=321660, user_cputime=1108.39, sys_cputime=4.22, percent_cpu=9396%
timeout=false
algorithm=brown_int_bst_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