__step=000529 __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=data000529.txt __path_data=data/data000529.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=7001185.524130497 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=94188 prefilling_elapsed_millis=1.001s prefilling_size=95968 prefilling_elapsed_millis=1.101s prefilling_size=97188 prefilling_elapsed_millis=1.201s prefilling_size=98144 prefilling_elapsed_millis=1.301s finished prefilling to size 98161 for expected size 100000 keysum=9796421279, performing 806721 updates; total_prefilling_elapsed_ms=1402 ms) pref_size=98161 pref_millis=1402 prefill_elapsed_ms=1426 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=7001187.150374289 REALTIME_END_PERF_FORMAT=7001197.150508255 ############################################################################### ################################## 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 2714 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.051s tree_stats_numInternalsAtDepth=1 1 5 44 344 2714 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19606 tree_stats_numNodesAtDepth=1 1 5 44 344 2714 19606 tree_stats_numKeysAtDepth=0 0 0 0 0 0 99858 tree_stats_avgDegreeAtDepth=1 5 8.8 7.81818 7.88953 7.22402 5.09324 tree_stats_height=7 tree_stats_numInternals=3109 tree_stats_numLeaves=19606 tree_stats_numNodes=22715 tree_stats_numKeys=99858 tree_stats_avgDegreeInternal=7.30621 tree_stats_avgDegreeLeaves=5.09324 tree_stats_avgDegree=5.39613 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=127727 first_thread_announced_epoch_by_thread=5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5410 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 5412 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=65822506 sum_fasthtm_abort_total=139320141 sum_htmpostfix_commit_total=3399130 sum_htmpostfix_abort_total=12187310 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=71419658 sum_stmprefix_commit_total=583 sum_slow_commit_total=53967 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=73208 73752 63617 72678 72245 71820 74209 75356 64895 74317 74358 73962 73915 72238 64822 73739 73591 73398 73860 75214 65381 73435 73008 74376 74027 73232 64086 73316 71930 71785 75205 75184 65479 73336 74004 73087 74204 73431 64382 73372 72922 73059 75287 74622 65581 73602 73379 73327 sum_num_inserts_total=3463233 sum_num_deletes_by_thread=73232 73617 63542 72717 72346 71827 74141 75172 64783 73890 74456 74377 74411 72531 64593 74098 73226 73092 74248 74953 65193 72860 72835 74131 74178 73387 64089 73049 72146 71635 74496 75068 65249 74184 74240 73023 74155 73300 64804 73787 73000 73082 74801 75267 65655 73876 73102 73434 sum_num_deletes_total=3463278 sum_num_searches_by_thread=1321031 1327845 1143199 1306110 1305367 1296795 1336793 1353594 1169680 1330992 1342417 1330251 1336756 1300692 1166276 1326428 1323065 1312406 1332880 1354554 1178415 1319075 1313325 1339719 1332945 1318777 1148959 1318078 1294475 1294686 1348809 1352290 1174396 1323016 1330803 1315973 1337679 1322215 1159050 1322333 1312261 1315318 1352409 1347555 1183518 1332062 1319698 1324705 sum_num_searches_total=62349675 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=1467471 1475214 1270358 1451505 1449958 1440442 1485143 1504122 1299358 1479199 1491231 1478590 1485082 1445461 1295691 1474265 1469882 1458896 1480988 1504721 1308989 1465370 1459168 1488226 1481150 1465396 1277134 1464443 1438551 1438106 1498510 1502542 1305124 1470536 1479047 1462083 1486038 1468946 1288236 1469492 1458183 1461459 1502497 1497444 1314754 1479540 1466179 1471466 average_num_operations_total=1443253 stdev_num_operations_total=10103 sum_num_operations_total=69276186 min_num_operations_total=1270358 max_num_operations_total=1504721 first_time_thread_terminate_by_thread=10000148 10000190 10000202 10000200 10000192 10000156 10000151 10000178 10000165 10000151 10000182 10000173 10000135 10000164 10000180 10000164 10000137 10000174 10000134 10000135 10000181 10000203 10000185 10000139 10000189 10000180 10000202 10000200 10000204 10000169 10000194 10000213 10000155 10000173 10000188 10000195 10000187 10000189 10000186 10000198 10000166 10000199 10000176 10000194 10000176 10000197 10000134 10000160 min_time_thread_terminate_total=10000134 max_time_thread_terminate_total=10000213 first_time_thread_start_by_thread=2 2 3 3 3 3 3 3 2 3 2 2 3 3 3 2 3 3 3 3 2 3 3 2 2 2 3 3 3 3 3 3 2 3 2 2 3 3 3 2 3 3 3 3 2 3 3 2 min_time_thread_start_total=2 max_time_thread_start_total=3 sum_duration_all_ops_total= threads_final_keysum=9973179247 threads_final_size=99858 final_keysum=9973179247 final_size=99858 validate_result=success Validation OK. Structural validation OK. total_find=62349675 total_rq=0 total_inserts=3463233 total_deletes=3463278 total_updates=6926511 total_queries=62349675 total_ops=69276186 find_throughput=6234967 rq_throughput=0 update_throughput=692651 query_throughput=6234967 total_throughput=6927618 total find : 62349675 total rq : 0 total inserts : 3463233 total deletes : 3463278 total updates : 6926511 total queries : 62349675 total ops : 69276186 find throughput : 6234967 rq throughput : 0 update throughput : 692651 query throughput : 6234967 total throughput : 6927618 elapsed milliseconds : 10000 napping milliseconds overtime : 100 PAPI_L2_TCM=22.9101 PAPI_L3_TCM=0.0322127 PAPI_TOT_CYC=16622.3 PAPI_TOT_INS=3102.68 garbage=3046312599796 total_execution_walltime=11.844s REALTIME_MAIN_END_PERF_FORMAT=7001197.369648904 RH noREC w/postfix htm system shutdown: HTM_ATTEMPT_THRESH=40 [time_cmd_output] time_elapsed_sec=11.98, faults_major=0, faults_minor=119246, mem_maxresident_kb=478712, user_cputime=560.74, sys_cputime=20.04, percent_cpu=4845% 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=1