__step=000388 __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" ./sigouin_int_bst_kcas_validate.debra -nwork 96 -nprefill 96 -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=data000388.txt __path_data=data/data000388.txt __hostname=jax sizeof(kcasdesc_t)=2304 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x556778d30400 addrof(kcasDescriptors[1])=0x556778d30d00 addrof(rdcssDescriptors[0])=0x556778e50400 addrof(rdcssDescriptors[1])=0x556778e504c0 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6999486.800757864 binary=./sigouin_int_bst_kcas_validate.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=sigouin_int_bst_kcas_validate 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=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=56 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.011s prefilling_size=999212 prefilling_elapsed_millis=1.001s finished prefilling to size 999176 for expected size 1000000 keysum=999518059393, performing 56009132 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=999176 pref_millis=1102 prefill_elapsed_ms=1126 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6999488.120097376 REALTIME_END_PERF_FORMAT=6999498.120243621 ############################################################################### ################################## 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 933 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 126 247 475 912 1656 2880 4757 7657 11920 17831 24992 33268 41835 49366 55116 57870 57723 54716 49609 42479 35111 27917 21499 15987 11632 8395 5965 4191 2927 1955 1256 777 508 325 197 112 65 51 24 13 5 2 1 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 1 3 11 21 102 245 545 1018 1876 3253 5844 9061 13290 18366 23379 27658 30779 31911 31576 29672 26021 22171 17858 14174 10577 7753 5635 4030 2844 2039 1387 897 548 351 231 143 85 36 38 17 10 4 1 1 tree_stats_numNodesAtDepth=1 2 4 8 16 32 64 127 250 486 933 1758 3125 5302 8675 13796 21084 30836 42329 55125 67732 78495 85528 88502 86627 81185 72151 61132 50088 39357 30161 22209 16148 11600 8221 5771 3994 2643 1674 1056 676 428 255 150 87 62 30 15 6 2 1 tree_stats_numKeysAtDepth=1 2 4 8 16 32 64 127 250 486 933 1758 3125 5302 8675 13796 21084 30836 42329 55125 67732 78495 85528 88502 86627 81185 72151 61132 50088 39357 30161 22209 16148 11600 8221 5771 3994 2643 1674 1056 676 428 255 150 87 62 30 15 6 2 1 tree_stats_avgDegreeAtDepth=2 2 2 2 2 2 1.98438 1.97638 1.956 1.94239 1.90675 1.83561 1.77504 1.73897 1.70767 1.66425 1.61682 1.56223 1.51636 1.46979 1.43006 1.38744 1.35815 1.32659 1.30555 1.27766 1.25853 1.24499 1.2284 1.22009 1.20629 1.20334 1.19848 1.19448 1.19219 1.18489 1.17226 1.15815 1.16667 1.15909 1.15237 1.13551 1.14902 1.14667 1.12644 1.09677 1.06667 1.06667 1 1 1 tree_stats_height=51 tree_stats_numInternals=654477 tree_stats_numLeaves=345462 tree_stats_numNodes=999939 tree_stats_numKeys=999939 tree_stats_avgDegreeInternal=1.52784 tree_stats_avgDegreeLeaves=1 tree_stats_avgDegree=1.34548 tree_stats_avgKeyDepth=23.6345 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:4 2:11 4:111 8:44627 16:878171 32:36739 64:0 128:0 256:95 [2^00, 2^01]: 4 (2^01, 2^02]: 11 (2^02, 2^03]: 111 (2^03, 2^04]: 44627 (2^04, 2^05]: 878171 (2^05, 2^06]: 36739 (2^06, 2^07]: 0 (2^07, 2^08]: 0 (2^08, 2^09]: 95 sum_limbo_reclamation_event_size_total=22110469 count_limbo_reclamation_event_size_by_thread=9998 9998 9997 9998 9997 9997 9997 9997 9998 9997 9998 9997 9997 9998 9997 9998 9998 9998 9998 9998 9998 9997 9998 9997 9998 9997 9998 9997 9997 9997 9997 9998 9997 9997 9997 9997 9997 9998 9997 9998 9998 9997 9998 9997 9997 9998 9997 9998 9998 9997 9998 9998 9997 9998 9998 9997 9998 9997 9998 9997 9998 9997 9998 9998 9998 9997 9998 9997 9997 9998 9997 9998 9998 9998 9997 9997 9997 9998 9998 9997 9997 9997 9997 9998 9997 9997 9997 9997 9998 9998 9998 9997 9998 9998 9997 9997 count_limbo_reclamation_event_size_total=959758 sum_limbo_reclamation_event_count_total=1018656 first_thread_announced_epoch_by_thread=22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 22622 sum_num_inserts_by_thread=481260 482868 489539 489419 487629 480383 482481 485124 490850 492283 486154 481571 484540 487824 491013 491284 487626 485014 481010 483609 488157 489594 486685 480557 479257 481235 487761 487117 485771 479287 483634 487615 491821 491536 487267 482684 484695 487687 490889 492816 487562 483517 479212 481457 488597 489450 485378 480538 488384 489944 492558 494490 489823 490152 489972 491141 496483 498203 492580 491060 488408 492269 495628 495795 490248 487299 486027 489756 496700 497710 492498 488890 486207 488825 492139 496313 489826 489250 488302 490283 497310 496289 493511 487857 489297 492706 495413 496916 490545 484324 484909 489992 497863 496914 495098 490999 sum_num_inserts_total=46930363 sum_num_deletes_by_thread=480456 482246 490011 491129 486719 482455 483196 485503 490995 492694 484412 482792 483586 488450 491952 490799 487921 484023 481072 483934 489605 490679 483916 478200 479260 482187 487739 488615 488147 479607 484476 486895 492022 492767 486732 485297 485494 487987 489831 490113 486834 482228 477909 481887 487819 488819 485877 480192 487342 489146 492764 495271 489720 487973 489141 491371 497948 498325 494115 490615 489171 492813 496646 494693 490745 486904 486815 488927 497812 496753 492269 489353 487618 489475 493088 495640 490265 488694 487614 489215 496504 496036 491989 489269 489504 492787 495862 495610 490303 484693 483311 489792 497689 499240 494124 490321 sum_num_deletes_total=46930754 sum_num_searches_by_thread=8658374 8681207 8816279 8826389 8769661 8664135 8691824 8742122 8850290 8865123 8725504 8681820 8718335 8775681 8838487 8819373 8759598 8718709 8636856 8709170 8809065 8824117 8724986 8639199 8620280 8685492 8780094 8794218 8755967 8620975 8721764 8786689 8851058 8867641 8755799 8698029 8726891 8773969 8825182 8839236 8774408 8704871 8614433 8688257 8780909 8813369 8734500 8637457 8778380 8821708 8866927 8907610 8817891 8796737 8792606 8839223 8961704 8956050 8869049 8823295 8806471 8866013 8924565 8913850 8835774 8766963 8742084 8823961 8945074 8943149 8854073 8808574 8775066 8807835 8867414 8924470 8843887 8790649 8774003 8803354 8941906 8937629 8856372 8792301 8799248 8874158 8912107 8937287 8836728 8707153 8700472 8820692 8959505 8958327 8904019 8832148 sum_num_searches_total=844616253 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=9620090 9646321 9795829 9806937 9744009 9626973 9657501 9712749 9832135 9850100 9696070 9646183 9686461 9751955 9821452 9801456 9735145 9687746 9598938 9676713 9786827 9804390 9695587 9597956 9578797 9648914 9755594 9769950 9729885 9579869 9689874 9761199 9834901 9851944 9729798 9666010 9697080 9749643 9805902 9822165 9748804 9670616 9571554 9651601 9757325 9791638 9705755 9598187 9754106 9800798 9852249 9897371 9797434 9774862 9771719 9821735 9956135 9952578 9855744 9804970 9784050 9851095 9916839 9904338 9816767 9741166 9714926 9802644 9939586 9937612 9838840 9786817 9748891 9786135 9852641 9916423 9823978 9768593 9749919 9782852 9935720 9929954 9841872 9769427 9778049 9859651 9903382 9929813 9817576 9676170 9668692 9800476 9955057 9954481 9893241 9813468 average_num_operations_total=9775805 stdev_num_operations_total=9954 sum_num_operations_total=938477370 min_num_operations_total=9571554 max_num_operations_total=9956135 first_time_thread_terminate_by_thread=10000149 10000148 10000149 10000147 10000149 10000148 10000149 10000146 10000148 10000146 10000148 10000146 10000145 10000148 10000146 10000147 10000145 10000148 10000148 10000148 10000145 10000146 10000146 10000148 10000149 10000148 10000149 10000147 10000149 10000146 10000149 10000146 10000148 10000146 10000148 10000146 10000146 10000148 10000146 10000147 10000145 10000148 10000146 10000148 10000145 10000146 10000146 10000148 10000146 10000147 10000146 10000145 10000145 10000146 10000145 10000145 10000146 10000145 10000146 10000147 10000147 10000147 10000145 10000145 10000148 10000148 10000146 10000145 10000147 10000145 10000146 10000145 10000145 10000147 10000146 10000145 10000145 10000146 10000145 10000145 10000145 10000145 10000146 10000147 10000147 10000145 10000145 10000145 10000148 10000148 10000146 10000145 10000147 10000145 10000149 10000145 min_time_thread_terminate_total=10000145 max_time_thread_terminate_total=10000149 first_time_thread_start_by_thread=5 5 4 4 5 5 4 4 5 4 4 4 4 5 4 5 5 5 5 4 4 4 5 5 5 5 4 4 5 5 4 4 5 4 4 4 4 5 4 5 5 5 5 4 4 4 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 4 4 4 5 5 5 5 5 4 5 5 5 5 5 5 5 5 4 5 5 5 5 5 5 4 4 4 5 5 5 5 5 4 5 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=1000274218693 threads_final_size=999939 final_keysum=1000274218693 final_size=999939 validate_result=success Validation OK. Structural validation OK. total_find=844616253 total_rq=0 total_inserts=46930363 total_deletes=46930754 total_updates=93861117 total_queries=844616253 total_ops=938477370 find_throughput=84461625 rq_throughput=0 update_throughput=9386111 query_throughput=84461625 total_throughput=93847737 total find : 844616253 total rq : 0 total inserts : 46930363 total deletes : 46930754 total updates : 93861117 total queries : 844616253 total ops : 938477370 find throughput : 84461625 rq throughput : 0 update throughput : 9386111 query throughput : 84461625 total throughput : 93847737 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=16.414 PAPI_L3_TCM=2.51303 PAPI_TOT_CYC=2819.27 PAPI_TOT_INS=1327.31 garbage=417927374041810 total_execution_walltime=11.51s REALTIME_MAIN_END_PERF_FORMAT=6999498.311833243 [time_cmd_output] time_elapsed_sec=11.64, faults_major=0, faults_minor=95103, mem_maxresident_kb=378260, user_cputime=1093.87, sys_cputime=3.16, percent_cpu=9420% timeout=false algorithm=sigouin_int_bst_kcas_validate.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2