__step=000108 __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_abtree_tm_auto.debra.tl2 -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=data000108.txt __path_data=data/data000108.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6995500.56602108 binary=./brown_abtree_tm_auto.debra.tl2 parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_abtree_tm_auto 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=200 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 TL2 system ready: GV=GV4 Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.016s prefilling_size=3666049 prefilling_elapsed_millis=1.001s prefilling_size=3970033 prefilling_elapsed_millis=1.101s prefilling_size=4260639 prefilling_elapsed_millis=1.201s prefilling_size=4538086 prefilling_elapsed_millis=1.302s prefilling_size=4802925 prefilling_elapsed_millis=1.402s prefilling_size=5055999 prefilling_elapsed_millis=1.502s prefilling_size=5296695 prefilling_elapsed_millis=1.602s prefilling_size=5526013 prefilling_elapsed_millis=1.702s prefilling_size=5743286 prefilling_elapsed_millis=1.803s prefilling_size=5951603 prefilling_elapsed_millis=1.903s prefilling_size=6150267 prefilling_elapsed_millis=2.003s prefilling_size=6340634 prefilling_elapsed_millis=2.103s prefilling_size=6520710 prefilling_elapsed_millis=2.203s prefilling_size=6692830 prefilling_elapsed_millis=2.304s prefilling_size=6854834 prefilling_elapsed_millis=2.404s prefilling_size=7010461 prefilling_elapsed_millis=2.504s prefilling_size=7157628 prefilling_elapsed_millis=2.604s prefilling_size=7296549 prefilling_elapsed_millis=2.704s prefilling_size=7429983 prefilling_elapsed_millis=2.805s prefilling_size=7557114 prefilling_elapsed_millis=2.905s prefilling_size=7677803 prefilling_elapsed_millis=3.005s prefilling_size=7792608 prefilling_elapsed_millis=3.105s prefilling_size=7903366 prefilling_elapsed_millis=3.205s prefilling_size=8007543 prefilling_elapsed_millis=3.306s prefilling_size=8106950 prefilling_elapsed_millis=3.406s prefilling_size=8200509 prefilling_elapsed_millis=3.506s prefilling_size=8291225 prefilling_elapsed_millis=3.606s prefilling_size=8377608 prefilling_elapsed_millis=3.706s prefilling_size=8459739 prefilling_elapsed_millis=3.807s prefilling_size=8537735 prefilling_elapsed_millis=3.907s prefilling_size=8610999 prefilling_elapsed_millis=4.007s prefilling_size=8681319 prefilling_elapsed_millis=4.107s prefilling_size=8747935 prefilling_elapsed_millis=4.207s prefilling_size=8810160 prefilling_elapsed_millis=4.308s prefilling_size=8871396 prefilling_elapsed_millis=4.408s prefilling_size=8928688 prefilling_elapsed_millis=4.508s prefilling_size=8981269 prefilling_elapsed_millis=4.608s prefilling_size=9033730 prefilling_elapsed_millis=4.708s prefilling_size=9082576 prefilling_elapsed_millis=4.809s prefilling_size=9128113 prefilling_elapsed_millis=4.909s prefilling_size=9172014 prefilling_elapsed_millis=5.009s Info: prefilling requires an additional insert phase to complete. Info: prefilling using INSERTION ONLY. timing_start inserting 827930 keys with 96 threads... tid=0 thread_prefill_amount=106233 percent_done_estimate=1231.8 elapsed_s=5 est_remaining_s=-11 / -5 tid=0 thread_prefill_amount=108316 percent_done_estimate=1255.9 elapsed_s=5 est_remaining_s=-11 / -6 tid=0 thread_prefill_amount=110399 percent_done_estimate=1280.1 elapsed_s=5 est_remaining_s=-11 / -6 tid=0 thread_prefill_amount=112482 percent_done_estimate=1304.2 elapsed_s=5 est_remaining_s=-11 / -6 tid=0 thread_prefill_amount=114565 percent_done_estimate=1328.4 elapsed_s=5 est_remaining_s=-11 / -6 timing_elapsed 0.177402s prefilling_size=10000000 prefilling_elapsed_millis=0.177s finished prefilling to size 10000000 for expected size 10000000 keysum=99998448803164, performing 52233595 updates; total_prefilling_elapsed_ms=177 ms) pref_size=10000000 pref_millis=177 prefill_elapsed_ms=178 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6995505.536162434 REALTIME_END_PERF_FORMAT=6995515.536247327 ############################################################################### ################################## TIME IS UP ################################# ############################################################################### joining threads... ############################################################################### ################################# END RUNNING ################################# ############################################################################### 10.1s PRODUCING OUTPUT computing tree_stats in PARALLEL... bounded depth BFS to partition into subtrees for parallel computation (96 threads)... partitioned into 481 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.012s tree_stats_numInternalsAtDepth=1 1 7 64 481 3562 26873 209125 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 0 0 1650817 tree_stats_numNodesAtDepth=1 1 7 64 481 3562 26873 209125 1650817 tree_stats_numKeysAtDepth=0 0 0 0 0 0 0 0 9991195 tree_stats_avgDegreeAtDepth=1 7 9.14286 7.51562 7.40541 7.54436 7.78197 7.89392 6.05227 tree_stats_height=9 tree_stats_numInternals=240114 tree_stats_numLeaves=1650817 tree_stats_numNodes=1890931 tree_stats_numKeys=9991195 tree_stats_avgDegreeInternal=7.87514 tree_stats_avgDegreeLeaves=6.05227 tree_stats_avgDegree=6.28374 tree_stats_avgKeyDepth=8 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 [2^00, 2^01]: 0 sum_limbo_reclamation_event_size_total= count_limbo_reclamation_event_size_by_thread= count_limbo_reclamation_event_size_total= sum_limbo_reclamation_event_count_total=392927 first_thread_announced_epoch_by_thread=9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 9446 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= sum_abtree_erase_repeat_total= sum_abtree_search_repeat_total= sum_abtree_search_complete_total= sum_abtree_fix_weight_viol_attempt_total= sum_abtree_fix_degree_viol_attempt_total= sum_abtree_rebalancing_kcas_attempt_total= sum_abtree_update_kcas_attempt_total= sum_abtree_internal_complex_search_while_iters_total= sum_abtree_internal_basic_search_while_iters_total= sum_kcas_desc_new_total= sum_num_inserts_by_thread=184691 186450 188159 188995 186774 185917 186275 186484 188854 189786 187645 186732 185860 187617 188123 188949 188031 187569 185588 187381 188291 188737 187263 185955 185303 187167 187792 188530 188319 186480 186296 187356 188887 189711 187702 187071 186518 187491 187979 188901 187254 186569 185357 186259 187014 188089 187746 185956 185652 186989 188275 188733 187391 186515 185579 187522 188615 190231 188390 187155 186482 187417 189162 189238 188552 186816 186781 186595 188656 188863 188452 186731 186313 186677 188031 188799 187965 187333 185970 187272 189277 189363 187588 187574 187325 187875 188851 189852 188219 186833 185788 187561 189040 189968 187899 187196 sum_num_inserts_total=18005234 sum_num_deletes_by_thread=185451 186455 187371 187922 187905 186186 186847 186740 188565 188912 186399 187424 186686 186973 188273 188358 188180 186142 185102 186598 187690 188702 186774 186214 186756 186526 187113 188352 187298 186459 186029 187497 188348 188996 187273 187208 185901 186998 188370 188403 187475 187554 185848 186931 187903 189232 186748 185708 186205 187555 187992 188081 187425 187006 186550 187575 188406 189536 188559 187830 186961 187977 188361 190273 188225 186158 185644 186544 188357 188548 188458 186488 186282 186470 188265 189057 187357 187466 185998 187816 189500 189413 188736 186923 186999 187406 188400 189342 187274 186791 186691 186665 188629 189009 187955 187442 sum_num_deletes_total=17997395 sum_num_searches_by_thread=3335658 3360645 3379463 3396809 3384109 3351347 3353935 3367202 3391296 3409029 3377958 3360002 3351480 3371010 3376883 3398162 3377395 3354414 3331018 3354526 3372048 3391991 3363183 3350257 3344065 3353679 3372857 3395625 3379589 3350296 3358390 3369473 3394891 3403496 3378581 3355724 3351887 3369461 3381794 3395854 3375306 3359050 3335358 3359768 3379843 3393494 3361971 3347969 3348370 3361098 3380464 3398234 3377356 3370819 3355502 3373288 3393904 3412537 3389175 3369908 3362149 3373190 3393440 3408249 3380673 3361755 3353552 3364368 3394448 3406499 3382905 3361903 3347563 3363918 3386657 3391429 3382868 3365378 3351448 3370459 3397589 3404687 3386808 3371094 3363721 3378403 3396005 3404407 3380007 3352093 3346993 3364707 3397639 3410081 3388734 3373090 sum_num_searches_total=323877805 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=3705800 3733550 3754993 3773726 3758788 3723450 3727057 3740426 3768715 3787727 3752002 3734158 3724026 3745600 3753279 3775469 3753606 3728125 3701708 3728505 3748029 3769430 3737220 3722426 3716124 3727372 3747762 3772507 3755206 3723235 3730715 3744326 3772126 3782203 3753556 3730003 3724306 3743950 3758143 3773158 3750035 3733173 3706563 3732958 3754760 3770815 3736465 3719633 3720227 3735642 3756731 3775048 3752172 3744340 3727631 3748385 3770925 3792304 3766124 3744893 3735592 3748584 3770963 3787760 3757450 3734729 3725977 3737507 3771461 3783910 3759815 3735122 3720158 3737065 3762953 3769285 3758190 3740177 3723416 3745547 3776366 3783463 3763132 3745591 3738045 3753684 3773256 3783601 3755500 3725717 3719472 3738933 3775308 3789058 3764588 3747728 average_num_operations_total=3748754 stdev_num_operations_total=2178 sum_num_operations_total=359880434 min_num_operations_total=3701708 max_num_operations_total=3792304 first_time_thread_terminate_by_thread=10000158 10000086 10000088 10000084 10000088 10000084 10000086 10000084 10000085 10000086 10000084 10000087 10000088 10000086 10000087 10000087 10000130 10000084 10000086 10000085 10000084 10000085 10000085 10000085 10000086 10000086 10000084 10000084 10000088 10000086 10000086 10000088 10000087 10000084 10000087 10000084 10000087 10000084 10000084 10000086 10000087 10000085 10000086 10000085 10000085 10000084 10000087 10000085 10000085 10000085 10000085 10000085 10000085 10000085 10000086 10000085 10000085 10000086 10000088 10000085 10000085 10000087 10000086 10000085 10000086 10000087 10000085 10000086 10000085 10000085 10000085 10000085 10000085 10000085 10000087 10000086 10000085 10000088 10000086 10000086 10000085 10000088 10000087 10000085 10000088 10000087 10000086 10000085 10000086 10000087 10000085 10000085 10000085 10000086 10000085 10000087 min_time_thread_terminate_total=10000084 max_time_thread_terminate_total=10000158 first_time_thread_start_by_thread=9 5 5 5 5 5 4 5 5 5 5 5 5 4 5 4 5 4 5 4 5 4 4 5 4 5 5 5 5 5 4 5 5 5 5 5 5 4 5 4 5 4 5 4 5 4 4 5 5 5 5 6 5 5 6 6 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 6 5 5 5 6 5 5 6 6 5 5 5 5 6 5 5 5 5 5 5 5 5 5 5 6 min_time_thread_start_total=4 max_time_thread_start_total=9 sum_duration_all_ops_total= threads_final_keysum=99889862613970 threads_final_size=9991195 final_keysum=99889862613970 final_size=9991195 validate_result=success Validation OK. Structural validation OK. total_find=323877805 total_rq=0 total_inserts=18005234 total_deletes=17997395 total_updates=36002629 total_queries=323877805 total_ops=359880434 find_throughput=32387780 rq_throughput=0 update_throughput=3600262 query_throughput=32387780 total_throughput=35988043 total find : 323877805 total rq : 0 total inserts : 18005234 total deletes : 17997395 total updates : 36002629 total queries : 323877805 total ops : 359880434 find throughput : 32387780 rq throughput : 0 update throughput : 3600262 query throughput : 32387780 total throughput : 35988043 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=33.934 PAPI_L3_TCM=7.08744 PAPI_TOT_CYC=5579.58 PAPI_TOT_INS=2426.06 garbage=1620065494392509 total_execution_walltime=15.608s REALTIME_MAIN_END_PERF_FORMAT=6995515.681557891 TL2 system shutdown: GCLOCK=0x206D64C Starts=417726027 Aborts=7185432 Overflows: R=0 W=8385 L=0 [time_cmd_output] time_elapsed_sec=15.89, faults_major=0, faults_minor=827934, mem_maxresident_kb=2225296, user_cputime=1377.64, sys_cputime=99.73, percent_cpu=9296% timeout=false algorithm=brown_abtree_tm_auto.debra.tl2 thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2