__step=000272
__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 190 -nprefill 190 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 2000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
__file_data=data000272.txt
__path_data=data/data000272.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6997892.633697869
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=2000000
PREFILL_THREADS=190
DESIRED_PREFILL_SIZE=-1
TOTAL_THREADS=190
WORK_THREADS=190
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,72,73,74,75,76,77,78,79,80,81,82,83,84,85,86,87,88,89,90,91,92,93,94,95,168,169,170,171,172,173,174,175,176,177,178,179,180,181,182,183,184,185,186,187,188,189


Hybrid noREC system ready

Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.057s
prefilling_size=186255 prefilling_elapsed_millis=1.001s
prefilling_size=202807 prefilling_elapsed_millis=1.101s
prefilling_size=219022 prefilling_elapsed_millis=1.201s
prefilling_size=234956 prefilling_elapsed_millis=1.302s
prefilling_size=250394 prefilling_elapsed_millis=1.402s
prefilling_size=265604 prefilling_elapsed_millis=1.502s
prefilling_size=280459 prefilling_elapsed_millis=1.603s
prefilling_size=294908 prefilling_elapsed_millis=1.703s
prefilling_size=309461 prefilling_elapsed_millis=1.803s
prefilling_size=323529 prefilling_elapsed_millis=1.904s
prefilling_size=337081 prefilling_elapsed_millis=2.004s
prefilling_size=350717 prefilling_elapsed_millis=2.104s
prefilling_size=363890 prefilling_elapsed_millis=2.205s
prefilling_size=376682 prefilling_elapsed_millis=2.305s
prefilling_size=389180 prefilling_elapsed_millis=2.405s
prefilling_size=401438 prefilling_elapsed_millis=2.505s
prefilling_size=413644 prefilling_elapsed_millis=2.606s
prefilling_size=425350 prefilling_elapsed_millis=2.706s
prefilling_size=436862 prefilling_elapsed_millis=2.806s
prefilling_size=448388 prefilling_elapsed_millis=2.907s
prefilling_size=459822 prefilling_elapsed_millis=3.007s
prefilling_size=470829 prefilling_elapsed_millis=3.107s
prefilling_size=481695 prefilling_elapsed_millis=3.208s
prefilling_size=492318 prefilling_elapsed_millis=3.308s
prefilling_size=502700 prefilling_elapsed_millis=3.408s
prefilling_size=512847 prefilling_elapsed_millis=3.508s
prefilling_size=522856 prefilling_elapsed_millis=3.609s
prefilling_size=532544 prefilling_elapsed_millis=3.709s
prefilling_size=541909 prefilling_elapsed_millis=3.809s
prefilling_size=551173 prefilling_elapsed_millis=3.91s
prefilling_size=560313 prefilling_elapsed_millis=4.01s
prefilling_size=569214 prefilling_elapsed_millis=4.11s
prefilling_size=578221 prefilling_elapsed_millis=4.211s
prefilling_size=586921 prefilling_elapsed_millis=4.311s
prefilling_size=595322 prefilling_elapsed_millis=4.411s
prefilling_size=603306 prefilling_elapsed_millis=4.512s
prefilling_size=611376 prefilling_elapsed_millis=4.612s
prefilling_size=619197 prefilling_elapsed_millis=4.712s
prefilling_size=626973 prefilling_elapsed_millis=4.813s
prefilling_size=634606 prefilling_elapsed_millis=4.913s
prefilling_size=641939 prefilling_elapsed_millis=5.013s
Info: prefilling requires an additional insert phase to complete.
Info: prefilling using INSERTION ONLY.
timing_start inserting 357986 keys with 190 threads...
tid=0 thread_prefill_amount=4208 percent_done_estimate=223.3 elapsed_s=6 est_remaining_s=-7 / -1
tid=0 thread_prefill_amount=5260 percent_done_estimate=279.2 elapsed_s=6 est_remaining_s=-9 / -3
timing_elapsed 1.59864s
prefilling_size=1000000 prefilling_elapsed_millis=1.602s
finished prefilling to size 1000000 for expected size 1000000 keysum=999764601521, performing 2662076 updates; total_prefilling_elapsed_ms=1602 ms)
pref_size=1000000
pref_millis=1602
prefill_elapsed_ms=1602
main thread: starting timer...

###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################

REALTIME_START_PERF_FORMAT=6997899.652881101
REALTIME_END_PERF_FORMAT=6997909.652987680

###############################################################################
################################## 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 (190 threads)...
partitioned into 1024 subtrees; running parallel for...
computing stats for the top of the tree (above the partitions)...

tree_stats_computeWalltime=0.015s

tree_stats_numInternalsAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32760 64902 117514 157338 121559 42682 5124 123 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 0 0 0 0 0 0 0 8 558 10620 63196 147501 143631 53909 6479 150
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65460 128134 220534 269060 186313 59033 6602 150
tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 128 256 512 1024 2048 4096 8192 16384 32768 65460 128134 220534 269060 186313 59033 6602 150
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 2 2 2 2 2 2 2 1.99792 1.96596 1.804 1.5066 1.24067 1.08776 1.02504 1.00409 1

tree_stats_height=24
tree_stats_numInternals=574769
tree_stats_numLeaves=426052
tree_stats_numNodes=1000821
tree_stats_numKeys=1000821

tree_stats_avgDegreeInternal=1.74126
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.4257
tree_stats_avgKeyDepth=18.3245


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=42382
first_thread_announced_epoch_by_thread=468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468 468
sum_num_inserts_by_thread=13385 13257 13664 13488 13754 14208 13317 13384 13595 13791 14110 14213 13555 13329 13269 13241 13367 14384 13106 13160 13372 13533 13016 14052 13770 13434 13463 13395 13608 13959 13602 13419 13025 13440 13934 14126 13209 13029 13866 13517 13138 14153 13222 13010 13542 13834 13472 13702 6581 6732 7057 6716 6941 6272 6405 6525 6869 7032 6478 6855 6792 6782 6783 7056 6508 7055 6484 6468 6911 6901 6572 6897 6768 6623 6886 6794 6845 6289 6603 6506 6686 6880 6726 6811 6726 6572 6661 6678 6497 6914 6493 6615 6671 6626 6638 6756 11337 11830 11821 11553 11493 10936 11778 11263 11744 11467 11957 11660 11558 11693 11887 11820 11669 11754 11380 11234 10994 11870 11685 11815 11694 11607 12200 11732 11256 11374 11618 11193 11510 11725 11813 11553 11574 11747 11834 12035 11854 11667 11218 11184 11373 11633 11440 11800 10885 11181 10746 11184 10849 11073 10429 10909 10588 10838 11223 11284 10107 10876 10644 10720 11162 11448 11031 10421 10836 10729 19830 19656 10816 11306 11217 11066 10763 10796 10254 10749 10574 11025 11339 11020 10378 10505 10910 11217 11306 11506 11150 10284 10640 10796
sum_num_inserts_total=2047453
sum_num_deletes_by_thread=13389 13032 13556 13454 13981 14223 13160 13292 13520 13606 13859 14234 13435 13344 13180 13361 13335 14455 13279 12785 13651 13534 13141 14100 13573 13342 13483 13470 13619 14083 13540 13242 13030 13400 13931 13908 13305 13057 13961 13718 13206 14001 13056 12777 13473 13762 13460 13915 6720 6704 6883 6910 6865 6276 6627 6679 6838 6973 6508 6770 6763 6839 6673 6961 6515 6999 6568 6518 6742 6867 6779 6801 6827 6802 6765 6679 6807 6186 6512 6477 6835 6861 6670 6795 6901 6398 6873 6630 6320 7069 6548 6535 6867 6741 6606 6884 11410 11913 11778 11780 11831 11038 11859 11387 11776 11614 11696 11800 11677 11615 11928 11923 11863 11748 11347 11320 11128 11895 11511 11531 11612 11594 12099 11816 11289 11347 11766 11372 11480 11615 11905 11721 11741 11616 11812 12103 11732 11766 11297 11208 11490 11639 11119 12050 10851 11051 10644 11124 10780 11133 10597 10812 10536 10816 11077 11108 10271 10769 10811 10712 11166 11601 11102 10526 10916 10849 20041 19328 10973 11166 10873 10984 10609 10725 10267 10862 10725 11230 11118 11092 10272 10712 10707 11023 11459 11356 10998 10244 10784 10938
sum_num_deletes_total=2047879
sum_num_searches_by_thread=240241 235398 245676 242181 248197 256399 236589 242195 243022 246501 251963 258321 240458 239560 236329 242590 240903 261595 235254 232543 241899 243391 234206 253744 245576 243063 243893 242315 245442 252277 240899 239397 235273 242964 249429 252220 235081 233850 251774 242977 237478 253410 235268 230670 243004 249258 240212 246596 119597 119011 124085 122307 124513 112516 118475 119580 120425 125300 116531 122674 120864 122383 121476 126003 116541 128792 117574 117794 119972 124406 120325 123094 123011 120696 121825 122972 121890 110732 116100 116157 119721 123404 119723 122080 123692 117185 121713 118708 115410 124120 116657 118140 121978 120994 119639 124017 204923 217281 214861 210266 210967 199670 210961 203568 214325 208067 210596 212501 210922 209580 214631 211124 209857 211669 203722 203142 200567 212076 210847 211263 210109 210047 220414 209952 200932 204617 210459 203945 206255 210058 215164 210398 210445 208576 211418 219888 212366 211388 201315 199591 203688 208462 202454 214308 194210 198914 191038 199632 192923 199200 189138 196224 190437 195467 202205 202371 181554 196802 191946 193952 201295 207822 200487 190591 195883 195610 358542 350648 195962 201037 200946 199950 194370 193314 185320 193943 192708 196727 200641 197823 183543 188950 195136 198763 206341 202990 198193 185398 194022 194653
sum_num_searches_total=36827539
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=267015 261687 272896 269123 275932 284830 263066 268871 270137 273898 279932 286768 267448 266233 262778 269192 267605 290434 261639 258488 268922 270458 260363 281896 272919 269839 270839 269180 272669 280319 268041 266058 261328 269804 277294 280254 261595 259936 279601 270212 263822 281564 261546 256457 270019 276854 267144 274213 132898 132447 138025 135933 138319 125064 131507 132784 134132 139305 129517 136299 134419 136004 134932 140020 129564 142846 130626 130780 133625 138174 133676 136792 136606 134121 135476 136445 135542 123207 129215 129140 133242 137145 133119 135686 137319 130155 135247 132016 128227 138103 129698 131290 135516 134361 132883 137657 227670 241024 238460 233599 234291 221644 234598 226218 237845 231148 234249 235961 234157 232888 238446 234867 233389 235171 226449 225696 222689 235841 234043 234609 233415 233248 244713 233500 223477 227338 233843 226510 229245 233398 238882 233672 233760 231939 235064 244026 235952 234821 223830 221983 226551 231734 225013 238158 215946 221146 212428 221940 214552 221406 210164 217945 211561 217121 224505 224763 201932 218447 213401 215384 223623 230871 222620 211538 217635 217188 398413 389632 217751 223509 223036 222000 215742 214835 205841 215554 214007 218982 223098 219935 204193 210167 216753 221003 229106 225852 220341 205926 215446 216387
average_num_operations_total=215383
stdev_num_operations_total=3918
sum_num_operations_total=40922871
min_num_operations_total=123207
max_num_operations_total=398413
first_time_thread_terminate_by_thread=10000642 10000233 10000106 10000392 10000568 10000206 10000345 10000124 10000442 10000645 10000299 10000108 10000624 10000187 10000236 10000292 10000600 10000644 10000640 10000297 10000606 10000652 10000643 10000596 10000649 10000555 10000538 10000574 10000650 10000424 10000134 10000129 10000565 10000646 10000143 10000651 10000641 10000580 10000306 10000583 10000621 10000622 10000567 10000302 10000561 10000557 10000481 10000605 10000524 10000647 10000174 10000609 10000107 10000360 10000454 10000416 10000226 10000190 10000613 10000620 10000615 10000464 10000319 10000199 10000650 10000366 10000626 10000627 10000434 10000419 10000356 10000638 10000637 10000628 10000612 10000545 10000617 10000372 10000588 10000586 10000462 10000351 10000511 10000610 10000377 10000639 10000323 10000491 10000648 10000109 10000111 10000578 10000590 10000218 10000351 10000153 10000265 10000507 10000147 10000550 10000485 10000512 10000286 10000432 10000183 10000178 10000279 10000592 10000426 10000382 10000546 10000261 10000387 10000499 10000505 10000518 10000250 10000397 10000245 10000533 10000270 10000390 10000493 10000602 10000478 10000515 10000264 10000111 10000521 10000275 10000531 10000594 10000528 10000487 10000525 10000502 10000181 10000429 10000547 10000551 10000111 10000248 10000282 10000118 10000476 10000472 10000571 10000168 10000635 10000339 10000163 10000156 10000598 10000451 10000408 10000256 10000618 10000411 10000228 10000161 10000405 10000636 10000496 10000630 10000309 10000421 10000475 10000204 10000211 10000632 10000106 10000402 10000633 10000340 10000394 10000472 10000409 10000314 10000467 10000445 10000288 10000439 10000536 10000327 10000342 10000334 10000541 10000312 10000106 10000215
min_time_thread_terminate_total=10000106
max_time_thread_terminate_total=10000652
first_time_thread_start_by_thread=8 3 3 4 3 3 4 4 4 3 3 4 4 3 3 3 3 3 4 4 4 3 3 3 3 3 3 4 3 3 4 4 4 3 3 4 4 3 3 3 3 3 4 4 4 3 3 3 4 4 4 4 3 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 3 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4
min_time_thread_start_total=3
max_time_thread_start_total=8
sum_duration_all_ops_total=

threads_final_keysum=1001848750495
threads_final_size=1000821
final_keysum=1001848750495
final_size=1000821
validate_result=success
Validation OK.
Structural validation OK.

total_find=36827539
total_rq=0
total_inserts=2047453
total_deletes=2047879
total_updates=4095332
total_queries=36827539
total_ops=40922871
find_throughput=3682753
rq_throughput=0
update_throughput=409533
query_throughput=3682753
total_throughput=4092287


total find                    : 36827539
total rq                      : 0
total inserts                 : 2047453
total deletes                 : 2047879
total updates                 : 4095332
total queries                 : 36827539
total ops                     : 40922871
find throughput               : 3682753
rq throughput                 : 0
update throughput             : 409533
query throughput              : 3682753
total throughput              : 4092287

elapsed milliseconds          : 10000
napping milliseconds overtime : 100

PAPI_L2_TCM=32.6658
PAPI_L3_TCM=7.36289
PAPI_TOT_CYC=129022
PAPI_TOT_INS=10984.5
garbage=18333294905815
total_execution_walltime=17.158s
REALTIME_MAIN_END_PERF_FORMAT=6997909.810291288
Hybrid noREC system shutdown:
    HTM_ATTEMPT_THRESH=40
[fast htm]
total fast htm commit         : 40485822
[slow htm]
[fallback]
total fallback commit         : 3099126
seconds global lock is held   : 0.630855
[time_cmd_output] time_elapsed_sec=17.31, faults_major=0, faults_minor=124426, mem_maxresident_kb=490592, user_cputime=3170.52, sys_cputime=7.39, percent_cpu=18357%
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