__step=000570 __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.debra -nwork 48 -nprefill 48 -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=data000570.txt __path_data=data/data000570.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x5593755b5480 addrof(kcasDescriptors[1])=0x5593755b5c00 addrof(rdcssDescriptors[0])=0x5593756a5480 addrof(rdcssDescriptors[1])=0x5593756a5540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7001680.783263631 binary=./brown_sigouin_abtree_kcas_validate.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 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=48 DESIRED_PREFILL_SIZE=-1 TOTAL_THREADS=48 WORK_THREADS=48 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 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.006s prefilling_size=99827 prefilling_elapsed_millis=1.001s finished prefilling to size 99857 for expected size 100000 keysum=9961949167, performing 76723761 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99857 pref_millis=1102 prefill_elapsed_ms=1120 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7001682.58038783 REALTIME_END_PERF_FORMAT=7001692.58199099 ############################################################################### ################################## 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 3156 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.056s tree_stats_numInternalsAtDepth=1 1 8 55 406 3156 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19493 tree_stats_numNodesAtDepth=1 1 8 55 406 3156 19493 tree_stats_numKeysAtDepth=0 0 0 0 0 0 100330 tree_stats_avgDegreeAtDepth=1 8 6.875 7.38182 7.7734 6.17649 5.14698 tree_stats_height=7 tree_stats_numInternals=3627 tree_stats_numLeaves=19493 tree_stats_numNodes=23120 tree_stats_numKeys=100330 tree_stats_avgDegreeInternal=6.37441 tree_stats_avgDegreeLeaves=5.14698 tree_stats_avgDegree=5.33953 tree_stats_avgKeyDepth=6 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:62463 2:77000 4:10878 8:81 [2^00, 2^01]: 62463 (2^01, 2^02]: 77000 (2^02, 2^03]: 10878 (2^03, 2^04]: 81 sum_limbo_reclamation_event_size_total=268568 count_limbo_reclamation_event_size_by_thread=3162 3184 3076 3032 3228 3222 3088 3130 3012 3186 3126 3080 3160 3240 2996 3188 3216 3072 3226 3132 3168 3086 3064 3188 3036 3068 3210 3292 3166 3110 3172 3110 3128 3068 3222 3104 3068 3074 3286 3056 3198 3154 3126 3076 3056 3144 3122 3114 count_limbo_reclamation_event_size_total=150422 sum_limbo_reclamation_event_count_total=4911548 first_thread_announced_epoch_by_thread=109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 109410 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=6283 sum_abtree_erase_repeat_total=1044 sum_abtree_search_repeat_total=361 sum_abtree_search_complete_total=113446450 sum_abtree_fix_weight_viol_attempt_total=105422 sum_abtree_fix_degree_viol_attempt_total=813260 sum_abtree_rebalancing_kcas_attempt_total=917566 sum_abtree_update_kcas_attempt_total=56264744 sum_abtree_internal_complex_search_while_iters_total=113447367 sum_abtree_internal_basic_search_while_iters_total=1012821777 sum_kcas_desc_new_total= sum_num_inserts_by_thread=1165337 1169590 1176366 1175576 1172874 1164126 1163626 1159057 1187761 1186487 1171584 1167990 1163679 1169121 1173614 1179532 1175376 1175855 1171533 1175529 1180024 1180972 1168506 1161948 1166649 1168908 1178910 1175229 1178654 1160067 1167302 1171846 1181547 1185125 1166349 1164292 1165408 1172950 1178562 1176273 1170192 1163623 1166049 1169245 1179944 1172460 1176079 1166729 sum_num_inserts_total=56258455 sum_num_deletes_by_thread=1167138 1168949 1176956 1175511 1174955 1162014 1165011 1160604 1187053 1185452 1171113 1169439 1162055 1169442 1176507 1177361 1177576 1177004 1169955 1175247 1181045 1182086 1171399 1161451 1166712 1167244 1178809 1175990 1178093 1158549 1164918 1174792 1181655 1185015 1165385 1166707 1165457 1174141 1180897 1176459 1169717 1160901 1162532 1169434 1179527 1173458 1173447 1164525 sum_num_deletes_total=56259687 sum_num_searches_by_thread=21008209 21058813 21212126 21151681 21146116 20927691 20954611 20895689 21336449 21358657 21068222 21010988 20940529 21060867 21158403 21201621 21177301 21166928 21067040 21165126 21268603 21256087 21065773 20921705 21004128 21024523 21200180 21175870 21218483 20865422 20995096 21107381 21287766 21301840 21018180 20965076 20967208 21143000 21226340 21201604 21053571 20935257 20945241 21062891 21245550 21121829 21140842 20996014 sum_num_searches_total=1012782527 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=23340684 23397352 23565448 23502768 23493945 23253831 23283248 23215350 23711263 23730596 23410919 23348417 23266263 23399430 23508524 23558514 23530253 23519787 23408528 23515902 23629672 23619145 23405678 23245104 23337489 23360675 23557899 23527089 23575230 23184038 23327316 23454019 23650968 23671980 23349914 23296075 23298073 23490091 23585799 23554336 23393480 23259781 23273822 23401570 23605021 23467747 23490368 23327268 average_num_operations_total=23443763 stdev_num_operations_total=20360 sum_num_operations_total=1125300669 min_num_operations_total=23184038 max_num_operations_total=23730596 first_time_thread_terminate_by_thread=10000160 10000160 10000160 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000160 10000159 10000160 10000160 10000159 10000160 10000159 10000159 10000160 10000159 10000160 10000159 10000159 10000160 10000160 10000160 10000160 10000159 10000160 10000159 10000159 10000160 10000159 10000159 10000160 10000159 10000160 10000160 10000159 10000160 10000159 10000159 10000160 10000159 10000160 10000159 10000159 10000160 min_time_thread_terminate_total=10000159 max_time_thread_terminate_total=10000160 first_time_thread_start_by_thread=3 3 2 3 3 3 3 3 3 3 3 2 3 2 2 3 3 3 3 3 3 3 2 3 3 3 2 3 3 3 3 3 3 3 3 2 3 2 2 3 3 3 3 3 3 3 2 3 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10001451006 threads_final_size=100330 final_keysum=10001451006 final_size=100330 validate_result=success Validation OK. Structural validation OK. total_find=1012782527 total_rq=0 total_inserts=56258455 total_deletes=56259687 total_updates=112518142 total_queries=1012782527 total_ops=1125300669 find_throughput=101278252 rq_throughput=0 update_throughput=11251814 query_throughput=101278252 total_throughput=112530066 total find : 1012782527 total rq : 0 total inserts : 56258455 total deletes : 56259687 total updates : 112518142 total queries : 1012782527 total ops : 1125300669 find throughput : 101278252 rq throughput : 0 update throughput : 11251814 query throughput : 101278252 total throughput : 112530066 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=5.87554 PAPI_L3_TCM=9.64658e-05 PAPI_TOT_CYC=1134.16 PAPI_TOT_INS=816.89 garbage=49585975245582 total_execution_walltime=11.42s REALTIME_MAIN_END_PERF_FORMAT=7001692.204327049 [time_cmd_output] time_elapsed_sec=11.54, faults_major=0, faults_minor=76278, mem_maxresident_kb=306488, user_cputime=566.53, sys_cputime=1.29, percent_cpu=4917% timeout=false algorithm=brown_sigouin_abtree_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