__step=000530 __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.rhnorec_post -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=data000530.txt __path_data=data/data000530.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7001197.577019573 binary=./brown_abtree_tm_auto.debra.rhnorec_post 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=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=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 RH noREC w/postfix htm system ready Info: prefilling using hybrid approach; mixed then insert-only if needed. prefilling initialization took 0.005s prefilling_size=94178 prefilling_elapsed_millis=1.001s prefilling_size=95623 prefilling_elapsed_millis=1.101s prefilling_size=96857 prefilling_elapsed_millis=1.201s prefilling_size=97760 prefilling_elapsed_millis=1.301s prefilling_size=98514 prefilling_elapsed_millis=1.401s finished prefilling to size 98518 for expected size 100000 keysum=9860173211, performing 932615 updates; total_prefilling_elapsed_ms=1502 ms) pref_size=98518 pref_millis=1502 prefill_elapsed_ms=1526 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7001199.262754160 REALTIME_END_PERF_FORMAT=7001209.262897686 ############################################################################### ################################## 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 (192 threads)... partitioned into 2752 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.062s tree_stats_numInternalsAtDepth=1 1 6 44 357 2752 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19623 tree_stats_numNodesAtDepth=1 1 6 44 357 2752 19623 tree_stats_numKeysAtDepth=0 0 0 0 0 0 100057 tree_stats_avgDegreeAtDepth=1 6 7.33333 8.11364 7.70868 7.13045 5.09897 tree_stats_height=7 tree_stats_numInternals=3161 tree_stats_numLeaves=19623 tree_stats_numNodes=22784 tree_stats_numKeys=100057 tree_stats_avgDegreeInternal=7.20785 tree_stats_avgDegreeLeaves=5.09897 tree_stats_avgDegree=5.39155 tree_stats_avgKeyDepth=6 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=134830 first_thread_announced_epoch_by_thread=5722 5722 5722 5722 5722 5720 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5720 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 5722 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=69713614 sum_fasthtm_abort_total=147626506 sum_htmpostfix_commit_total=3597757 sum_htmpostfix_abort_total=14110386 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=72697796 sum_stmprefix_commit_total=563 sum_slow_commit_total=59594 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=73920 74288 73937 76416 76356 78386 75565 75616 76356 77488 77717 79893 74776 74525 75935 76306 76412 80182 75210 75971 75976 77127 76499 80648 72506 74575 74480 77158 76504 78733 75935 75545 75598 77019 77422 80662 74856 74892 76043 75788 76419 79977 75471 74741 76048 76500 77268 80124 sum_num_inserts_total=3669769 sum_num_deletes_by_thread=73640 74382 73940 76210 76268 78806 75525 76019 75953 77516 78103 79842 75145 74708 75688 76082 76232 79655 76178 75631 76334 77277 76669 79972 73198 74641 74715 76365 75883 78396 75210 76240 75934 76285 77499 81070 74662 74381 76455 75549 76395 80423 75258 74638 76277 76629 76956 79930 sum_num_deletes_total=3668764 sum_num_searches_by_thread=1332427 1339348 1330601 1377407 1371993 1415294 1352965 1364615 1369315 1398613 1398855 1432223 1352260 1338311 1368794 1372490 1377931 1440383 1363750 1359025 1368866 1396433 1376543 1445373 1315849 1346704 1343353 1377723 1370250 1416716 1358469 1363466 1361347 1381483 1395422 1454955 1345457 1343422 1372438 1359662 1377633 1443969 1352523 1344368 1366299 1378401 1386872 1432399 sum_num_searches_total=66032995 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=1479987 1488018 1478478 1530033 1524617 1572486 1504055 1516250 1521624 1553617 1554675 1591958 1502181 1487544 1520417 1524878 1530575 1600220 1515138 1510627 1521176 1550837 1529711 1605993 1461553 1495920 1492548 1531246 1522637 1573845 1509614 1515251 1512879 1534787 1550343 1616687 1494975 1492695 1524936 1510999 1530447 1604369 1503252 1493747 1518624 1531530 1541096 1592453 average_num_operations_total=1528573 stdev_num_operations_total=5294 sum_num_operations_total=73371528 min_num_operations_total=1461553 max_num_operations_total=1616687 first_time_thread_terminate_by_thread=10000205 10000202 10000179 10000191 10000147 10000218 10000150 10000195 10000213 10000207 10000189 10000143 10000154 10000143 10000197 10000158 10000208 10000180 10000192 10000143 10000168 10000209 10000143 10000184 10000208 10000201 10000149 10000186 10000143 10000220 10000166 10000157 10000166 10000193 10000159 10000171 10000199 10000162 10000174 10000187 10000142 10000202 10000198 10000205 10000203 10000165 10000206 10000193 min_time_thread_terminate_total=10000142 max_time_thread_terminate_total=10000220 first_time_thread_start_by_thread=4 5 5 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 4 5 5 5 5 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 4 5 4 4 min_time_thread_start_total=4 max_time_thread_start_total=5 sum_duration_all_ops_total= threads_final_keysum=10020995991 threads_final_size=100057 final_keysum=10020995991 final_size=100057 validate_result=success Validation OK. Structural validation OK. total_find=66032995 total_rq=0 total_inserts=3669769 total_deletes=3668764 total_updates=7338533 total_queries=66032995 total_ops=73371528 find_throughput=6603299 rq_throughput=0 update_throughput=733853 query_throughput=6603299 total_throughput=7337152 total find : 66032995 total rq : 0 total inserts : 3669769 total deletes : 3668764 total updates : 7338533 total queries : 66032995 total ops : 73371528 find throughput : 6603299 rq throughput : 0 update throughput : 733853 query throughput : 6603299 total throughput : 7337152 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=22.6755 PAPI_L3_TCM=0.0318853 PAPI_TOT_CYC=15954.5 PAPI_TOT_INS=3106.73 garbage=3300450038872 total_execution_walltime=11.971s REALTIME_MAIN_END_PERF_FORMAT=7001209.549437147 RH noREC w/postfix htm system shutdown: HTM_ATTEMPT_THRESH=40 [time_cmd_output] time_elapsed_sec=12.11, faults_major=0, faults_minor=120933, mem_maxresident_kb=485476, user_cputime=572.60, sys_cputime=18.61, percent_cpu=4882% timeout=false algorithm=brown_abtree_tm_auto.debra.rhnorec_post thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2