__step=000578 __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 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])=0x562be127d480 addrof(kcasDescriptors[1])=0x562be127dc00 addrof(rdcssDescriptors[0])=0x562be136d480 addrof(rdcssDescriptors[1])=0x562be136d540 sizeof(validationSet)=1608 REALTIME_MAIN_START_PERF_FORMAT=7001774.676938042 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=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.003s prefilling_size=99980 prefilling_elapsed_millis=1.001s finished prefilling to size 99984 for expected size 100000 keysum=10000004503, performing 86751372 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99984 pref_millis=1102 prefill_elapsed_ms=1120 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7001775.978281356 REALTIME_END_PERF_FORMAT=7001785.978432081 ############################################################################### ################################## 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 3144 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.057s tree_stats_numInternalsAtDepth=1 1 8 52 406 3144 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19575 tree_stats_numNodesAtDepth=1 1 8 52 406 3144 19575 tree_stats_numKeysAtDepth=0 0 0 0 0 0 100393 tree_stats_avgDegreeAtDepth=1 8 6.5 7.80769 7.74384 6.22615 5.12863 tree_stats_height=7 tree_stats_numInternals=3612 tree_stats_numLeaves=19575 tree_stats_numNodes=23187 tree_stats_numKeys=100393 tree_stats_avgDegreeInternal=6.41944 tree_stats_avgDegreeLeaves=5.12863 tree_stats_avgDegree=5.32971 tree_stats_avgKeyDepth=6 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:61964 2:76643 4:11040 8:97 [2^00, 2^01]: 61964 (2^01, 2^02]: 76643 (2^02, 2^03]: 11040 (2^03, 2^04]: 97 sum_limbo_reclamation_event_size_total=268514 count_limbo_reclamation_event_size_by_thread=3152 2960 3414 3264 2936 3136 2980 2972 3176 3138 3084 3008 2968 3072 3290 3018 3332 3256 3094 3220 3360 2876 3008 3258 3046 2952 3286 3020 2962 3014 3074 3082 3210 2960 3046 3056 3008 3302 3238 3380 3072 2974 2972 3250 3166 3288 3310 3104 count_limbo_reclamation_event_size_total=149744 sum_limbo_reclamation_event_count_total=5009664 first_thread_announced_epoch_by_thread=112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 112266 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=5708 sum_abtree_erase_repeat_total=1247 sum_abtree_search_repeat_total=89 sum_abtree_search_complete_total=116598007 sum_abtree_fix_weight_viol_attempt_total=106976 sum_abtree_fix_degree_viol_attempt_total=828229 sum_abtree_rebalancing_kcas_attempt_total=934012 sum_abtree_update_kcas_attempt_total=57832045 sum_abtree_internal_complex_search_while_iters_total=116598466 sum_abtree_internal_basic_search_while_iters_total=1040783734 sum_kcas_desc_new_total= sum_num_inserts_by_thread=1191586 1201360 1210930 1207364 1204029 1196327 1192911 1205926 1210844 1219026 1204466 1202543 1193713 1206860 1210020 1216997 1206060 1200394 1202459 1202855 1211624 1216607 1189779 1196305 1193860 1200305 1204624 1206561 1205437 1198342 1203402 1206028 1213567 1219442 1203689 1203464 1206227 1203333 1202671 1214446 1205857 1195753 1194201 1200203 1209290 1217348 1208267 1208037 sum_num_inserts_total=57825339 sum_num_deletes_by_thread=1194585 1201198 1208675 1208342 1204386 1195988 1194145 1205085 1212487 1217741 1203823 1202070 1194850 1209213 1211481 1216110 1204916 1200353 1199201 1200648 1209343 1218838 1189793 1194515 1196554 1197941 1206518 1207732 1207987 1198375 1203054 1204994 1212533 1219117 1205010 1201771 1204922 1204641 1202387 1212183 1207082 1193300 1196151 1202200 1209114 1218041 1209355 1209676 sum_num_deletes_total=57828424 sum_num_searches_by_thread=21477927 21617042 21778927 21752306 21673599 21532202 21487600 21699215 21805735 21928375 21684102 21643937 21517355 21700065 21813925 21913044 21682835 21619338 21592841 21646037 21790837 21905216 21405947 21505405 21489633 21593905 21703090 21716033 21720326 21544352 21605951 21687676 21806511 21918816 21689534 21674303 21722175 21664039 21645199 21869878 21710590 21509201 21505624 21637731 21768923 21903247 21739080 21748659 sum_num_searches_total=1040748288 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=23864098 24019600 24198532 24168012 24082014 23924517 23874656 24110226 24229066 24365142 24092391 24048550 23905918 24116138 24235426 24346151 24093811 24020085 23994501 24049540 24211804 24340661 23785519 23896225 23880047 23992151 24114232 24130326 24133750 23941069 24012407 24098698 24232611 24357375 24098233 24079538 24133324 24072013 24050257 24296507 24123529 23898254 23895976 24040134 24187327 24338636 24156702 24166372 average_num_operations_total=24091709 stdev_num_operations_total=20995 sum_num_operations_total=1156402051 min_num_operations_total=23785519 max_num_operations_total=24365142 first_time_thread_terminate_by_thread=10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000150 10000151 10000150 10000150 10000150 10000151 10000150 10000150 10000150 10000150 10000150 10000151 10000150 10000151 10000151 10000151 10000150 10000150 10000150 10000150 10000150 10000150 10000150 10000151 10000150 10000151 10000150 10000150 10000150 10000151 10000150 10000150 10000151 10000150 10000150 10000151 10000150 10000151 10000151 10000151 min_time_thread_terminate_total=10000150 max_time_thread_terminate_total=10000151 first_time_thread_start_by_thread=3 3 3 3 2 3 2 3 2 3 3 3 3 3 2 3 3 3 3 2 3 3 3 2 3 3 3 3 2 3 2 3 2 3 3 3 3 3 2 3 3 3 3 2 3 3 3 2 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=10033596398 threads_final_size=100393 final_keysum=10033596398 final_size=100393 validate_result=success Validation OK. Structural validation OK. total_find=1040748288 total_rq=0 total_inserts=57825339 total_deletes=57828424 total_updates=115653763 total_queries=1040748288 total_ops=1156402051 find_throughput=104074828 rq_throughput=0 update_throughput=11565376 query_throughput=104074828 total_throughput=115640205 total find : 1040748288 total rq : 0 total inserts : 57825339 total deletes : 57828424 total updates : 115653763 total queries : 1040748288 total ops : 1156402051 find throughput : 104074828 rq throughput : 0 update throughput : 11565376 query throughput : 104074828 total throughput : 115640205 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=5.90589 PAPI_L3_TCM=0.000125068 PAPI_TOT_CYC=1102.33 PAPI_TOT_INS=800.409 garbage=52045769609872 total_execution_walltime=11.45s REALTIME_MAIN_END_PERF_FORMAT=7001786.128056502 [time_cmd_output] time_elapsed_sec=11.57, faults_major=0, faults_minor=77195, mem_maxresident_kb=309992, user_cputime=567.05, sys_cputime=3.08, percent_cpu=4924% 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=2