__step=000836
__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" ./natarajan_ext_bst_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=data000836.txt
__path_data=data/data000836.txt
__hostname=jax
REALTIME_MAIN_START_PERF_FORMAT=6989053.916036146
binary=./natarajan_ext_bst_lf.debra
parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191
DS_TYPENAME=natarajan_ext_bst_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=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
Info: prefilling using hybrid approach; mixed then insert-only if needed.
prefilling initialization took 0.037s
prefilling_size=1000567 prefilling_elapsed_millis=1s
finished prefilling to size 1000640 for expected size 1000000 keysum=1001467990233, performing 50043131 updates; total_prefilling_elapsed_ms=1102 ms)
pref_size=1000640
pref_millis=1102
prefill_elapsed_ms=1132
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=774
main thread: starting timer...
###############################################################################
################################ BEGIN RUNNING ################################
###############################################################################
REALTIME_START_PERF_FORMAT=6989055.260583038
REALTIME_END_PERF_FORMAT=6989065.260726287
###############################################################################
################################## TIME IS UP #################################
###############################################################################
joining threads...
###############################################################################
################################# END RUNNING #################################
###############################################################################
10s
PRODUCING OUTPUT
computing tree_stats in PARALLEL...
bounded depth BFS to partition into subtrees for parallel computation (192 threads)...
partitioned into 998 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 255 499 947 1741 3197 5666 9684 15563 23707 33996 46034 58873 71041 80323 86227 88424 85832 80377 71936 61432 50071 39112 28811 20344 13846 8946 5586 3214 1828 895 412 204 94 42 17 7 2 0
tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1 11 51 153 285 728 1648 3805 7419 13418 21958 33195 46705 61759 74419 84030 91016 91287 88818 82440 72793 61030 49413 37278 26842 18746 12306 7958 4600 2761 1378 620 314 146 67 27 12 4
tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 128 256 510 998 1894 3482 6394 11332 19368 31126 47414 67992 92068 117746 142082 160646 172454 176848 171664 160754 143872 122864 100142 78224 57622 40688 27692 17892 11172 6428 3656 1790 824 408 188 84 34 14 4
tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 1 11 51 153 285 728 1648 3805 7419 13418 21958 33195 46705 61759 74419 84030 91016 91287 88818 82440 72793 61030 49413 37278 26842 18746 12306 7958 4600 2761 1378 620 314 146 67 27 12 4
tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 2 2 1.99609 1.97843 1.9489 1.91922 1.91815 1.88614 1.85457 1.80354 1.76165 1.717 1.67705 1.63945 1.60334 1.56533 1.53675 1.51274 1.48534 1.46822 1.44749 1.42699 1.40753 1.39057 1.36831 1.35306 1.3403 1.32305 1.31221 1.28768 1.28438 1.2448 1.23017 1.24757 1.23039 1.2234 1.20238 1.20588 1.14286 1
tree_stats_height=46
tree_stats_numInternals=999440
tree_stats_numLeaves=999441
tree_stats_numNodes=1998881
tree_stats_numKeys=999441
tree_stats_avgDegreeInternal=2
tree_stats_avgDegreeLeaves=1
tree_stats_avgDegree=1.5
tree_stats_avgKeyDepth=25.273
tree_stats_bytesAtDepth=32 64 128 256 512 1024 2048 4096 8192 16320 31936 60608 111424 204608 362624 619776 996032 1517248 2175744 2946176 3767872 4546624 5140672 5518528 5659136 5493248 5144128 4603904 3931648 3204544 2503168 1843904 1302016 886144 572544 357504 205696 116992 57280 26368 13056 6016 2688 1088 448 128
tree_stats_sizeInBytes=63964192
6node_tIxPvE_object_size=32
6node_tIxPvE_allocated_count=0
6node_tIxPvE_allocated_size=0MB
6node_tIxPvE_get_from_pool=0
6node_tIxPvE_deallocated=0
6node_tIxPvE_limbo_count=0
6node_tIxPvE_limbo_details=0 0 0
global_epoch_counter=8431
log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:1115 4:469 8:1056 16:2657 32:8589 64:35546 128:134029 256:543698 512:4505
(2^01, 2^02]: 1115
(2^02, 2^03]: 469
(2^03, 2^04]: 1056
(2^04, 2^05]: 2657
(2^05, 2^06]: 8589
(2^06, 2^07]: 35546
(2^07, 2^08]: 134029
(2^08, 2^09]: 543698
(2^09, 2^10]: 4505
sum_limbo_reclamation_event_size_total=241763148
count_limbo_reclamation_event_size_by_thread=7620 7622 7611 7610 7627 7609 7628 7617 7623 7622 7622 7619 7619 7617 7620 7616 7621 7620 7617 7629 7613 7625 7623 7624 7613 7614 7623 7620 7625 7619 7627 7622 7617 7620 7621 7624 7623 7626 7622 7628 7626 7614 7620 7631 7623 7627 7624 7620 7620 7622 7616 7627 7628 7621 7627 7624 7615 7615 7627 7622 7629 7624 7618 7619 7617 7629 7623 7631 7623 7606 7626 7624 7635 7621 7617 7631 7625 7623 7629 7626 7611 7610 7614 7627 7618 7625 7618 7621 7621 7623 7627 7617 7627 7626 7618 7618
count_limbo_reclamation_event_size_total=731664
sum_limbo_reclamation_event_count_total=734781
first_thread_announced_epoch_by_thread=16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862 16862
sum_num_inserts_by_thread=2496601 2483961 2506678 2502964 2502490 2485776 2474879 2505982 2493194 2513343 2485094 2496966 2492940 2505449 2516777 2516996 2501929 2501865 2493297 2494036 2513635 2510197 2504120 2504209 2499066 2483416 2501166 2496677 2496857 2493326 2493609 2501004 2512457 2500834 2488294 2485053 2508452 2503414 2521625 2521715 2493328 2481309 2472183 2489638 2500132 2498730 2505605 2498965 2526555 2531250 2545681 2544916 2522355 2530522 2526459 2539528 2545278 2547305 2546522 2524165 2539596 2545018 2549133 2546772 2543239 2514109 2520302 2533152 2563788 2542280 2527978 2535770 2531275 2540015 2551371 2546075 2531339 2523897 2533059 2548495 2561442 2553933 2545278 2543915 2549324 2556324 2542712 2552450 2544443 2522898 2529960 2544712 2556533 2554252 2551765 2533633
sum_num_inserts_total=241891006
sum_num_deletes_by_thread=2499445 2486745 2508362 2501256 2498387 2483680 2475112 2508761 2494830 2515595 2485756 2496926 2489161 2504083 2517167 2519875 2501060 2502545 2494895 2496392 2512052 2508780 2504405 2501129 2501906 2480507 2500748 2496384 2498095 2494599 2493874 2503542 2512399 2503597 2489240 2483953 2507603 2502101 2519575 2523152 2492756 2480982 2468493 2482560 2502065 2498849 2503942 2501856 2527762 2535581 2547044 2543052 2519343 2530886 2527005 2540076 2547194 2545047 2545215 2525865 2541157 2546166 2551377 2544605 2541757 2516509 2521862 2535880 2561870 2543448 2528495 2529650 2530627 2542296 2553856 2543675 2537359 2525031 2532984 2546629 2557893 2553298 2546557 2544502 2548052 2554340 2541415 2551622 2543268 2525876 2531280 2543093 2555168 2554596 2548413 2528827
sum_num_deletes_total=241886680
sum_num_searches_by_thread=
sum_num_searches_total=
sum_num_rq_by_thread=
sum_num_rq_total=
sum_num_operations_by_thread=4996046 4970706 5015040 5004220 5000877 4969456 4949991 5014743 4988024 5028938 4970850 4993892 4982101 5009532 5033944 5036871 5002989 5004410 4988192 4990428 5025687 5018977 5008525 5005338 5000972 4963923 5001914 4993061 4994952 4987925 4987483 5004546 5024856 5004431 4977534 4969006 5016055 5005515 5041200 5044867 4986084 4962291 4940676 4972198 5002197 4997579 5009547 5000821 5054317 5066831 5092725 5087968 5041698 5061408 5053464 5079604 5092472 5092352 5091737 5050030 5080753 5091184 5100510 5091377 5084996 5030618 5042164 5069032 5125658 5085728 5056473 5065420 5061902 5082311 5105227 5089750 5068698 5048928 5066043 5095124 5119335 5107231 5091835 5088417 5097376 5110664 5084127 5104072 5087711 5048774 5061240 5087805 5111701 5108848 5100178 5062460
average_num_operations_total=5039350
stdev_num_operations_total=4856
sum_num_operations_total=483777686
min_num_operations_total=4940676
max_num_operations_total=5125658
first_time_thread_terminate_by_thread=10000142 10000144 10000143 10000144 10000142 10000145 10000145 10000142 10000142 10000143 10000145 10000145 10000145 10000142 10000144 10000145 10000142 10000143 10000144 10000145 10000142 10000142 10000143 10000142 10000142 10000144 10000143 10000144 10000144 10000145 10000143 10000142 10000142 10000142 10000145 10000142 10000142 10000142 10000144 10000145 10000144 10000143 10000144 10000145 10000142 10000143 10000143 10000142 10000145 10000142 10000143 10000144 10000146 10000143 10000143 10000145 10000144 10000143 10000143 10000143 10000143 10000143 10000144 10000144 10000143 10000145 10000143 10000147 10000143 10000143 10000144 10000144 10000145 10000145 10000143 10000144 10000146 10000143 10000143 10000142 10000145 10000143 10000143 10000143 10000143 10000144 10000144 10000143 10000143 10000145 10000143 10000144 10000145 10000143 10000142 10000143
min_time_thread_terminate_total=10000142
max_time_thread_terminate_total=10000147
first_time_thread_start_by_thread=6 6 6 6 7 6 6 7 6 6 7 7 6 6 6 7 6 7 6 6 6 6 6 7 6 6 6 6 7 6 6 7 6 6 7 7 6 6 6 7 6 7 6 6 6 6 6 7 6 7 6 6 7 7 7 7 7 7 7 6 6 7 6 6 7 6 6 7 7 6 6 6 6 7 6 6 7 7 7 7 7 7 7 6 6 7 6 6 7 6 6 7 7 6 6 6
min_time_thread_start_total=6
max_time_thread_start_total=7
sum_duration_all_ops_total=
threads_final_keysum=1000069025098
threads_final_size=999441
final_keysum=1000069025098
final_size=999441
validate_result=success
Validation OK.
Structural validation OK.
total_find=0
total_rq=0
total_inserts=241891006
total_deletes=241886680
total_updates=483777686
total_queries=0
total_ops=483777686
find_throughput=0
rq_throughput=0
update_throughput=48377768
query_throughput=0
total_throughput=48377768
total find : 0
total rq : 0
total inserts : 241891006
total deletes : 241886680
total updates : 483777686
total queries : 0
total ops : 483777686
find throughput : 0
rq throughput : 0
update throughput : 48377768
query throughput : 0
total throughput : 48377768
elapsed milliseconds : 10000
napping milliseconds overtime : 0
PAPI_L2_TCM=19.6991
PAPI_L3_TCM=5.33934
PAPI_TOT_CYC=5501.12
PAPI_TOT_INS=1079.76
garbage=0
total_execution_walltime=11.491s
REALTIME_MAIN_END_PERF_FORMAT=6989065.420009142
[time_cmd_output] time_elapsed_sec=11.63, faults_major=0, faults_minor=95231, mem_maxresident_kb=377860, user_cputime=1087.05, sys_cputime=4.67, percent_cpu=9383%
timeout=false
algorithm=natarajan_ext_bst_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