__step=000147 __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_abtree_kcas_validate_htm.debra -nwork 96 -nprefill 96 -prefill-hybrid -prefill-hybrid-min-ms 1000 -prefill-hybrid-max-ms 5000 -insdel 5.0 5.0 -k 20000000 -t 10000 -pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 __file_data=data000147.txt __path_data=data/data000147.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x556bcfa8d480 addrof(kcasDescriptors[1])=0x556bcfa8dc00 addrof(rdcssDescriptors[0])=0x556bcfb7d480 addrof(rdcssDescriptors[1])=0x556bcfb7d540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6996146.892025707 binary=./brown_sigouin_abtree_kcas_validate_htm.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_sigouin_abtree_kcas_validate_htm 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=20000000 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=40 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.016s prefilling_size=9832745 prefilling_elapsed_millis=1.001s finished prefilling to size 9832695 for expected size 10000000 keysum=98303490625727, performing 81760621 updates; total_prefilling_elapsed_ms=1103 ms) pref_size=9832695 pref_millis=1103 prefill_elapsed_ms=1123 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6996148.211909310 REALTIME_END_PERF_FORMAT=6996158.212060030 ############################################################################### ################################## 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 3999 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.054s tree_stats_numInternalsAtDepth=1 1 8 71 518 3999 30142 234803 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1837854 tree_stats_numNodesAtDepth=1 1 8 71 518 3999 30142 234803 1837854 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9998866 tree_stats_avgDegreeAtDepth=1 8 8.875 7.29577 7.72008 7.53738 7.78989 7.82722 5.44051 tree_stats_height=9 tree_stats_numInternals=269543 tree_stats_numLeaves=1837854 tree_stats_numNodes=2107397 tree_stats_numKeys=9998866 tree_stats_avgDegreeInternal=7.81841 tree_stats_avgDegreeLeaves=5.44051 tree_stats_avgDegree=5.74465 tree_stats_avgKeyDepth=8 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:154452 2:205911 4:50366 8:2223 16:4 [2^00, 2^01]: 154452 (2^01, 2^02]: 205911 (2^02, 2^03]: 50366 (2^03, 2^04]: 2223 (2^04, 2^05]: 4 sum_limbo_reclamation_event_size_total=852575 count_limbo_reclamation_event_size_by_thread=4114 4186 4222 4266 4248 4310 4206 4362 4376 4358 4260 4378 4256 4358 4372 4366 4240 4222 4246 4328 4316 4290 4260 4204 4240 4248 4280 4248 4204 4274 4244 4434 4284 4406 4228 4288 4376 4416 4274 4290 4298 4182 4318 4374 4222 4348 4234 4300 4204 4434 4346 4346 4380 4356 4222 4262 4468 4344 4392 4386 4280 4364 4344 4422 4314 4204 4158 4304 4318 4306 4154 4230 4188 4270 4352 4426 4200 4326 4442 4298 4402 4308 4236 4188 4306 4110 4346 4266 4322 4256 4292 4342 4442 4370 4504 4472 count_limbo_reclamation_event_size_total=412956 sum_limbo_reclamation_event_count_total=2115648 first_thread_announced_epoch_by_thread=23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 23920 sum_commit_tx_reader_total= sum_commit_tx_reader_by_thread= sum_commit_tx_writer_total= sum_commit_tx_writer_by_thread= sum_abort_tx_total= sum_abort_tx_by_thread= max_ht_capacity_by_thread= linear_histogram_of_none_tx_rdset_size_full_data= linear_histogram_of_none_tx_wrset_size_full_data= sum_fasthtm_commit_total= sum_fasthtm_abort_total= sum_htmpostfix_commit_total= sum_htmpostfix_abort_total= sum_htmprefix_commit_total= sum_htmprefix_abort_total= sum_htmprefix_abort_explicit_total= sum_htmprefix_abort_conflict_total= sum_htmprefix_abort_capacity_total= sum_htmprefix_abort_nesting_total= sum_htmprefix_abort_illegal_total= sum_htmprefix_abort_zero_total= sum_stmprefix_abort_total= sum_stmprefix_commit_total= sum_slow_commit_total= sum_abtree_insert_repeat_total=263 sum_abtree_erase_repeat_total=36 sum_abtree_search_repeat_total= sum_abtree_search_complete_total=98829637 sum_abtree_fix_weight_viol_attempt_total=307758 sum_abtree_fix_degree_viol_attempt_total=327992 sum_abtree_rebalancing_kcas_attempt_total=635744 sum_abtree_update_kcas_attempt_total=49100144 sum_abtree_internal_complex_search_while_iters_total=98829644 sum_abtree_internal_basic_search_while_iters_total=883588368 sum_kcas_desc_new_total= sum_num_inserts_by_thread=503961 507497 514238 511668 508989 505329 503523 506416 513421 516336 506629 504254 506649 513015 513561 512133 511160 510026 500583 508087 511694 516139 506388 502836 505849 509960 512133 512070 508666 505845 506118 508985 512113 515485 506548 504957 505550 510798 512340 512521 509863 508395 502435 506553 510189 514808 507692 503006 512038 514080 515403 515187 513992 510356 512925 512921 521631 521092 513458 511052 511513 513506 519395 515312 517717 509101 507356 509651 518524 515904 510642 509760 512578 513730 512889 515925 510308 509331 509163 511807 519775 520463 512594 509582 515592 516588 517813 518972 517531 511376 506213 508265 520243 518689 515519 513270 sum_num_inserts_total=49098143 sum_num_deletes_by_thread=503111 507189 515888 512349 508908 505501 504362 506015 515026 514535 506200 504311 506872 512399 513457 512528 511711 508438 500250 507191 513002 517942 505078 504032 504630 509273 512125 511774 509184 506523 507176 510625 513549 515775 507330 504619 506380 510853 511620 514494 509861 508429 500793 507304 510974 512710 506379 501563 511292 512756 514398 516766 515737 511761 512224 513121 521033 520473 513511 510406 511216 514087 517957 515386 516992 509723 506617 509683 518781 517622 511031 509585 512035 514220 514081 515323 511973 509146 509692 511634 519668 518101 510192 509023 515262 515024 517088 519311 518269 510686 506679 509698 519021 519523 515931 511361 sum_num_deletes_total=49095337 sum_num_searches_by_thread=9077622 9117421 9254668 9215649 9172125 9102508 9064824 9129745 9238096 9284526 9140769 9078745 9129256 9223711 9238949 9221955 9191901 9151964 9019683 9134806 9229494 9284091 9097068 9063116 9092075 9182648 9191561 9204163 9144012 9114223 9122711 9164271 9237074 9298919 9123993 9084994 9115772 9201866 9221777 9234600 9166264 9143339 9032282 9123206 9177041 9262116 9116043 9031947 9228509 9257452 9272291 9286337 9266118 9202634 9225517 9235665 9384831 9362495 9228952 9225627 9193716 9245817 9324828 9283540 9299957 9179729 9116473 9177894 9324973 9299543 9191844 9175656 9217357 9248836 9240809 9277904 9206020 9158317 9163611 9210546 9350862 9342384 9193442 9169060 9270342 9290947 9304306 9338768 9311873 9195790 9131116 9165087 9336761 9327753 9276859 9217639 sum_num_searches_total=883586376 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=10084694 10132107 10284794 10239666 10190022 10113338 10072709 10142176 10266543 10315397 10153598 10087310 10142777 10249125 10265967 10246616 10214772 10170428 10020516 10150084 10254190 10318172 10108534 10069984 10102554 10201881 10215819 10228007 10161862 10126591 10136005 10183881 10262736 10330179 10137871 10094570 10127702 10223517 10245737 10261615 10185988 10160163 10035510 10137063 10198204 10289634 10130114 10036516 10251839 10284288 10302092 10318290 10295847 10224751 10250666 10261707 10427495 10404060 10255921 10247085 10216445 10273410 10362180 10314238 10334666 10198553 10130446 10197228 10362278 10333069 10213517 10195001 10241970 10276786 10267779 10309152 10228301 10176794 10182466 10233987 10390305 10380948 10216228 10187665 10301196 10322559 10339207 10377051 10347673 10217852 10144008 10183050 10376025 10365965 10308309 10242270 average_num_operations_total=10226873 stdev_num_operations_total=9298 sum_num_operations_total=981779856 min_num_operations_total=10020516 max_num_operations_total=10427495 first_time_thread_terminate_by_thread=10000150 10000152 10000152 10000152 10000151 10000151 10000152 10000150 10000150 10000151 10000150 10000151 10000150 10000151 10000150 10000150 10000151 10000151 10000150 10000151 10000151 10000151 10000150 10000150 10000150 10000151 10000150 10000152 10000151 10000151 10000151 10000150 10000150 10000151 10000150 10000151 10000150 10000151 10000150 10000150 10000150 10000151 10000150 10000151 10000151 10000151 10000150 10000150 10000150 10000151 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000150 10000151 10000151 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000151 10000150 10000151 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000150 10000151 10000151 10000150 10000150 10000151 10000150 10000150 10000150 10000150 10000150 10000151 10000151 min_time_thread_terminate_total=10000150 max_time_thread_terminate_total=10000152 first_time_thread_start_by_thread=3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 3 2 3 3 3 3 3 3 3 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=99988379589812 threads_final_size=9998866 final_keysum=99988379589812 final_size=9998866 validate_result=success Validation OK. Structural validation OK. total_find=883586376 total_rq=0 total_inserts=49098143 total_deletes=49095337 total_updates=98193480 total_queries=883586376 total_ops=981779856 find_throughput=88358637 rq_throughput=0 update_throughput=9819348 query_throughput=88358637 total_throughput=98177985 total find : 883586376 total rq : 0 total inserts : 49098143 total deletes : 49095337 total updates : 98193480 total queries : 883586376 total ops : 981779856 find throughput : 88358637 rq throughput : 0 update throughput : 9819348 query throughput : 88358637 total throughput : 98177985 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=18.8693 PAPI_L3_TCM=6.79539 PAPI_TOT_CYC=2703.43 PAPI_TOT_INS=948.876 garbage=4356477595823421 total_execution_walltime=11.481s REALTIME_MAIN_END_PERF_FORMAT=6996158.374189827 [time_cmd_output] time_elapsed_sec=11.64, faults_major=0, faults_minor=193775, mem_maxresident_kb=770264, user_cputime=1095.41, sys_cputime=3.53, percent_cpu=9433% timeout=false algorithm=brown_sigouin_abtree_kcas_validate_htm.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=1