__step=000578 __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" ./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=data000578.txt __path_data=data/data000578.txt __hostname=jax sizeof(kcasdesc_t)=1920 sizeof(rdcssdesc_t)=192 addrof(kcasDescriptors[0])=0x55dc474bd480 addrof(kcasDescriptors[1])=0x55dc474bdc00 addrof(rdcssDescriptors[0])=0x55dc475ad480 addrof(rdcssDescriptors[1])=0x55dc475ad540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=6985837.684462294 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.005s prefilling_size=100114 prefilling_elapsed_millis=1.001s finished prefilling to size 100014 for expected size 100000 keysum=10002838880, performing 76339163 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=100014 pref_millis=1102 prefill_elapsed_ms=1138 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985838.985921460 REALTIME_END_PERF_FORMAT=6985848.986070069 ############################################################################### ################################## 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 3133 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.055s tree_stats_numInternalsAtDepth=1 1 7 51 404 3133 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19453 tree_stats_numNodesAtDepth=1 1 7 51 404 3133 19453 tree_stats_numKeysAtDepth=0 0 0 0 0 0 99926 tree_stats_avgDegreeAtDepth=1 7 7.28571 7.92157 7.75495 6.20906 5.13679 tree_stats_height=7 tree_stats_numInternals=3597 tree_stats_numLeaves=19453 tree_stats_numNodes=23050 tree_stats_numKeys=99926 tree_stats_avgDegreeInternal=6.40812 tree_stats_avgDegreeLeaves=5.13679 tree_stats_avgDegree=5.33518 tree_stats_avgKeyDepth=6 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:62070 2:76504 4:11006 8:70 [2^00, 2^01]: 62070 (2^01, 2^02]: 76504 (2^02, 2^03]: 11006 (2^03, 2^04]: 70 sum_limbo_reclamation_event_size_total=267594 count_limbo_reclamation_event_size_by_thread=3252 3014 3090 3088 3072 3040 3110 3112 3210 3060 3018 3016 3120 3138 3084 3292 3092 3068 2970 3186 3254 3246 3116 3252 3208 3180 3128 3206 3170 3102 3248 3220 2992 3088 2940 3114 3038 3076 3006 3078 3020 3142 3052 2928 3190 3192 3228 3204 count_limbo_reclamation_event_size_total=149650 sum_limbo_reclamation_event_count_total=4937368 first_thread_announced_epoch_by_thread=109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 109926 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=6578 sum_abtree_erase_repeat_total=1017 sum_abtree_search_repeat_total=327 sum_abtree_search_complete_total=114273715 sum_abtree_fix_weight_viol_attempt_total=105993 sum_abtree_fix_degree_viol_attempt_total=819123 sum_abtree_rebalancing_kcas_attempt_total=923966 sum_abtree_update_kcas_attempt_total=56678159 sum_abtree_internal_complex_search_while_iters_total=114274654 sum_abtree_internal_basic_search_while_iters_total=1020222640 sum_kcas_desc_new_total= sum_num_inserts_by_thread=1176960 1180951 1180134 1187599 1179666 1172400 1177503 1183168 1195871 1195629 1177606 1177397 1177220 1185449 1190538 1195108 1181450 1183630 1170359 1179853 1187212 1190834 1171251 1167130 1174148 1176163 1181381 1187015 1183643 1170465 1168214 1178751 1192270 1186161 1170522 1172054 1176997 1176170 1184459 1187369 1177262 1175200 1170959 1177335 1186282 1192024 1183836 1170917 sum_num_inserts_total=56664515 sum_num_deletes_by_thread=1176711 1181328 1181926 1189068 1179305 1173767 1174097 1181315 1197656 1194917 1178185 1178618 1177592 1185135 1188887 1195488 1181976 1182801 1171691 1182479 1185768 1191616 1171916 1167992 1175755 1176543 1183498 1187917 1183319 1171842 1170522 1176772 1193965 1185909 1170963 1175729 1177410 1174863 1185518 1187103 1178336 1173943 1170845 1176268 1183576 1191838 1181567 1169881 sum_num_deletes_total=56674116 sum_num_searches_by_thread=21180429 21244866 21271945 21385016 21226362 21126217 21147345 21268017 21545748 21515365 21208814 21186413 21228089 21322505 21415915 21496770 21271375 21297496 21087346 21304676 21386364 21447789 21096394 20997955 21140194 21179894 21333240 21376859 21341783 21065891 21046844 21184500 21510100 21355342 21070862 21102244 21220437 21174513 21330859 21377138 21214987 21115545 21081414 21184504 21337717 21443290 21267980 21067852 sum_num_searches_total=1020183200 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=23534100 23607145 23634005 23761683 23585333 23472384 23498945 23632500 23939275 23905911 23564605 23542428 23582901 23693089 23795340 23887366 23634801 23663927 23429396 23667008 23759344 23830239 23439561 23333077 23490097 23532600 23698119 23751791 23708745 23408198 23385580 23540023 23896335 23727412 23412347 23450027 23574844 23525546 23700836 23751610 23570585 23464688 23423218 23538107 23707575 23827152 23633383 23408650 average_num_operations_total=23615038 stdev_num_operations_total=22411 sum_num_operations_total=1133521831 min_num_operations_total=23333077 max_num_operations_total=23939275 first_time_thread_terminate_by_thread=10000148 10000148 10000148 10000148 10000147 10000148 10000148 10000148 10000148 10000148 10000147 10000147 10000148 10000148 10000148 10000147 10000148 10000147 10000148 10000148 10000148 10000147 10000148 10000148 10000148 10000148 10000148 10000148 10000147 10000148 10000148 10000148 10000148 10000148 10000147 10000147 10000148 10000148 10000148 10000147 10000148 10000147 10000148 10000148 10000148 10000147 10000148 10000148 min_time_thread_terminate_total=10000147 max_time_thread_terminate_total=10000148 first_time_thread_start_by_thread=5 5 5 5 5 5 5 5 5 5 5 4 5 5 4 5 5 5 5 5 4 4 5 5 5 5 5 5 5 5 5 5 5 5 5 4 5 5 4 5 5 5 5 5 4 4 5 5 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=10000716352 threads_final_size=99926 final_keysum=10000716352 final_size=99926 validate_result=success Validation OK. Structural validation OK. total_find=1020183200 total_rq=0 total_inserts=56664515 total_deletes=56674116 total_updates=113338631 total_queries=1020183200 total_ops=1133521831 find_throughput=102018320 rq_throughput=0 update_throughput=11333863 query_throughput=102018320 total_throughput=113352183 total find : 1020183200 total rq : 0 total inserts : 56664515 total deletes : 56674116 total updates : 113338631 total queries : 1020183200 total ops : 1133521831 find throughput : 102018320 rq throughput : 0 update throughput : 11333863 query throughput : 102018320 total throughput : 113352183 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=5.8693 PAPI_L3_TCM=9.74556e-05 PAPI_TOT_CYC=1125.52 PAPI_TOT_INS=819.119 garbage=49935684013160 total_execution_walltime=11.449s REALTIME_MAIN_END_PERF_FORMAT=6985849.134567754 [time_cmd_output] time_elapsed_sec=11.56, faults_major=0, faults_minor=76250, mem_maxresident_kb=306324, user_cputime=565.22, sys_cputime=2.49, percent_cpu=4911% 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