SamPaul Isaac's questions

Tenho uma configuração AspectJ com um advice @Around que mede o tempo de execução de um método alvo. No entanto, o tempo de execução está sendo registrado após o advice @AfterReturning, que não é a ordem desejada.

@Aspect
@Component
public class LoggingAspectUsingPointcut {

    @Pointcut("execution(* com.sam.aspect.pointcut.controller.UsingPointcutController.*(..))")
    public void controllerMethods() {}

    @Before("controllerMethods()")
    public void logBefore() {
        System.out.println("Method is about to be called");
    }

    @Around("controllerMethods()")
    public Object logExecutionTime(ProceedingJoinPoint joinPoint) throws Throwable {
        System.out.println("Around advice start");
        long start = System.currentTimeMillis();
        Object proceed = joinPoint.proceed(); // Proceed with the method execution
        long executionTime = System.currentTimeMillis() - start;
        System.out.println(joinPoint.getSignature() + " executed in " + executionTime + "ms");
        System.out.println("Around Advice End");
        return proceed;
    }

    @After("controllerMethods()")
    public void logAfter() {
        System.out.println("Method has been called");
    }

    @AfterReturning(pointcut = "execution(* com.sam.aspect.pointcut.controller.UsingPointcutController  .*(..))", returning = "result")
    public void logAfterReturning(Object result) {
        System.out.println("Method executed successfully." + result);
    }
}

Eu esperava que a ordem fosse:

1. @Around pré-método (antes da execução de proceed())
2. @Antes
3. Execução do método de destino (proceed())
4. @Around post-method (resposta de tempo de execução)
5. @DepoisDeVoltar
6. @Depois

Em vez disso, estou recebendo:

1. @Around - executado
2. @Antes - executado
3. Método de destino - executado
4. @AfterReturning - executado
5. @After - executado
6. @Around post-method - executado, mas não na ordem desejada

Saída:

Around advice start
Method is about to be called
Method executed successfully.[Record 1, Record 2, Record 3, Record 4, Record 5, Record 6, Record 7, Record 8, Record 9, Record 10]
Method has been called
List com.sam.aspect.pointcut.controller.UsingPointcutController.getData() executed in 13ms
Around Advice End

O que estou esquecendo aqui? Como posso garantir que o tempo de execução seja registrado antes do aviso @AfterReturning e @After?

Spring Boot 3.3.3. A classe está anotada corretamente com @Aspect e @Component. Além disso, garantiu que @EnableAspectJAutoProxy esteja configurado no aplicativo.