__step=000562 __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_ext_abtree_lf.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=data000562.txt __path_data=data/data000562.txt __hostname=jax REALTIME_MAIN_START_PERF_FORMAT=6985649.819753975 binary=./brown_ext_abtree_lf.debra parsed custom binding: 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 DS_TYPENAME=brown_ext_abtree_lf 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 size_node=208 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.006s prefilling_size=99488 prefilling_elapsed_millis=1.001s finished prefilling to size 99512 for expected size 100000 keysum=9952462764, performing 77175872 updates; total_prefilling_elapsed_ms=1102 ms) pref_size=99512 pref_millis=1102 prefill_elapsed_ms=1129 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=4052 main thread: starting timer... ############################################################################### ################################ BEGIN RUNNING ################################ ############################################################################### REALTIME_START_PERF_FORMAT=6985651.148334653 REALTIME_END_PERF_FORMAT=6985661.148474570 ############################################################################### ################################## 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 3174 subtrees; running parallel for... computing stats for the top of the tree (above the partitions)... tree_stats_computeWalltime=0.066s tree_stats_numInternalsAtDepth=1 1 7 54 406 3174 0 tree_stats_numLeavesAtDepth=0 0 0 0 0 0 19454 tree_stats_numNodesAtDepth=1 1 7 54 406 3174 19454 tree_stats_numKeysAtDepth=0 0 0 0 0 0 99807 tree_stats_avgDegreeAtDepth=1 7 7.71429 7.51852 7.81773 6.12917 5.13041 tree_stats_height=7 tree_stats_numInternals=3643 tree_stats_numLeaves=19454 tree_stats_numNodes=23097 tree_stats_numKeys=99807 tree_stats_avgDegreeInternal=6.3401 tree_stats_avgDegreeLeaves=5.13041 tree_stats_avgDegree=5.32121 tree_stats_avgKeyDepth=6 tree_stats_bytesAtDepth=208 208 1456 11232 84448 660192 4046432 tree_stats_sizeInBytes=4804176 N9abtree_ns4NodeILi11ExEE_object_size=208 N9abtree_ns4NodeILi11ExEE_allocated_count=0 N9abtree_ns4NodeILi11ExEE_allocated_size=0MB N9abtree_ns4NodeILi11ExEE_get_from_pool=0 N9abtree_ns4NodeILi11ExEE_deallocated=0 N9abtree_ns4NodeILi11ExEE_limbo_count=0 N9abtree_ns4NodeILi11ExEE_limbo_details=0 0 0 global_epoch_counter=67959 log_histogram_of_none_limbo_reclamation_event_size_full_data=1:0 2:12 4:163 8:16142 16:429802 32:33763 64:22 (2^01, 2^02]: 12 (2^02, 2^03]: 163 (2^03, 2^04]: 16142 (2^04, 2^05]: 429802 (2^05, 2^06]: 33763 (2^06, 2^07]: 22 sum_limbo_reclamation_event_size_total=11531847 count_limbo_reclamation_event_size_by_thread=9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 9998 count_limbo_reclamation_event_size_total=479904 sum_limbo_reclamation_event_count_total=3067535 first_thread_announced_epoch_by_thread=135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 135918 sum_num_inserts_by_thread=1463822 1473009 1479556 1467097 1464532 1460460 1468851 1470866 1484852 1494054 1480236 1466829 1464129 1467527 1474113 1479559 1471885 1464863 1462526 1466314 1482369 1471076 1465712 1464323 1469943 1467917 1474785 1462956 1472067 1454666 1460119 1468560 1475763 1484091 1473123 1458855 1467285 1461040 1474614 1472527 1464044 1462425 1449876 1471917 1469234 1473753 1469818 1462536 sum_num_inserts_total=70530474 sum_num_deletes_by_thread=1464856 1470327 1478991 1465383 1465493 1459825 1470953 1473274 1484185 1494141 1477241 1464390 1464357 1469511 1475386 1480534 1473524 1465570 1461159 1466271 1483206 1472856 1468884 1464897 1472677 1469516 1474923 1463633 1470539 1452725 1457612 1471897 1471896 1484282 1473191 1458055 1467462 1460897 1473440 1472016 1462686 1462506 1448908 1471269 1471285 1470965 1469857 1463642 sum_num_deletes_total=70531093 sum_num_searches_by_thread=26349273 26504980 26636326 26389439 26368416 26282801 26480056 26501495 26744507 26902943 26610084 26388468 26358282 26436963 26546910 26616667 26509704 26379209 26328734 26373026 26691070 26505340 26417716 26343181 26486065 26429628 26566838 26344337 26486365 26129371 26241012 26448984 26534801 26709246 26542116 26258426 26415357 26291027 26541027 26499926 26336814 26338043 26073599 26487447 26462844 26522273 26465494 26312400 sum_num_searches_total=1269589030 sum_num_rq_by_thread= sum_num_rq_total= sum_num_operations_by_thread=29277951 29448316 29594873 29321919 29298441 29203086 29419860 29445635 29713544 29891138 29567561 29319687 29286768 29374001 29496409 29576760 29455113 29309642 29252419 29305611 29656645 29449272 29352312 29272401 29428685 29367061 29516546 29270926 29428971 29036762 29158743 29389441 29482460 29677619 29488430 29175336 29350104 29212964 29489081 29444469 29263544 29262974 28972383 29430633 29403363 29466991 29405169 29238578 average_num_operations_total=29388554 stdev_num_operations_total=24518 sum_num_operations_total=1410650597 min_num_operations_total=28972383 max_num_operations_total=29891138 first_time_thread_terminate_by_thread=10000136 10000137 10000136 10000137 10000137 10000137 10000137 10000136 10000138 10000137 10000138 10000138 10000137 10000137 10000136 10000137 10000137 10000137 10000137 10000136 10000138 10000137 10000136 10000137 10000136 10000137 10000136 10000137 10000137 10000137 10000137 10000136 10000138 10000137 10000138 10000138 10000137 10000137 10000137 10000137 10000137 10000137 10000137 10000136 10000138 10000137 10000136 10000137 min_time_thread_terminate_total=10000136 max_time_thread_terminate_total=10000138 first_time_thread_start_by_thread=6 6 6 7 6 6 6 6 6 6 6 7 7 7 6 6 6 6 6 7 7 6 6 7 6 6 6 7 6 6 6 6 6 6 6 7 7 7 6 6 6 6 6 7 7 6 6 7 min_time_thread_start_total=6 max_time_thread_start_total=7 sum_duration_all_ops_total= threads_final_keysum=9979800577 threads_final_size=99807 final_keysum=9979800577 final_size=99807 validate_result=success Validation OK. Structural validation OK. total_find=1269589030 total_rq=0 total_inserts=70530474 total_deletes=70531093 total_updates=141061567 total_queries=1269589030 total_ops=1410650597 find_throughput=126958903 rq_throughput=0 update_throughput=14106156 query_throughput=126958903 total_throughput=141065059 total find : 1269589030 total rq : 0 total inserts : 70530474 total deletes : 70531093 total updates : 141061567 total queries : 1269589030 total ops : 1410650597 find throughput : 126958903 rq throughput : 0 update throughput : 14106156 query throughput : 126958903 total throughput : 141065059 elapsed milliseconds : 10000 napping milliseconds overtime : 0 PAPI_L2_TCM=5.45391 PAPI_L3_TCM=0.000161349 PAPI_TOT_CYC=892.233 PAPI_TOT_INS=344.312 garbage=63489016742202 total_execution_walltime=11.49s REALTIME_MAIN_END_PERF_FORMAT=6985661.311560186 [time_cmd_output] time_elapsed_sec=11.61, faults_major=0, faults_minor=78389, mem_maxresident_kb=314344, user_cputime=563.72, sys_cputime=2.21, percent_cpu=4873% timeout=false algorithm=brown_ext_abtree_lf.debra thread_pinning=-pin 0-23,96-119,24-47,120-143,48-71,144-167,72-95,168-191 millis=10000 __trials=2