From fdeb09bf9a706092833d7ad42544fe51c8abb42d Mon Sep 17 00:00:00 2001 From: "slav.babanin" Date: Fri, 2 Feb 2024 09:00:26 -0800 Subject: [PATCH] Fix repeating logs. --- .../src/main/java/com/mongodb/Main.java | 95 +++++++++++-------- 1 file changed, 56 insertions(+), 39 deletions(-) diff --git a/instrumentation-agent/src/main/java/com/mongodb/Main.java b/instrumentation-agent/src/main/java/com/mongodb/Main.java index 9c76bd0..6b6b04a 100644 --- a/instrumentation-agent/src/main/java/com/mongodb/Main.java +++ b/instrumentation-agent/src/main/java/com/mongodb/Main.java @@ -19,8 +19,6 @@ import java.util.Collection; import java.util.Iterator; import java.util.List; -import java.util.Map; -import java.util.concurrent.ConcurrentHashMap; import java.util.concurrent.TimeUnit; import static net.bytebuddy.matcher.ElementMatchers.named; @@ -81,51 +79,70 @@ public static void onExit(@Advice.Return(readOnly = false) Collection public static class GetCommandListenersAdvice { - public static final Map COMMAND_LISTENER_CACHE = new ConcurrentHashMap<>(); + //public static final Map COMMAND_LISTENER_CACHE = new ConcurrentHashMap<>(); @Advice.OnMethodExit public static void onExit(@Advice.This Object settings, @Advice.Return(readOnly = false, typing = Assigner.Typing.DYNAMIC) List listeners) { LOGGER.info("Agent intercepted com.mongodb.MongoClientSettings.getCommandListeners(). Injecting command listener."); - List newListeners = new ArrayList<>(listeners); MongoClientSettings mongoClientSettings = (MongoClientSettings) settings; - if (!COMMAND_LISTENER_CACHE.containsKey(settings)) { - CommandListener loggingListener = new CommandListener() { - @Override - public void commandStarted(final CommandStartedEvent event) { - LOGGER.info("Client id: {}\nCommand Started:\n Command Name: {}\n Command Body: {}\n Connection Description: {}", - mongoClientSettings.getApplicationName(), - event.getCommandName(), - event.getCommand(), - event.getConnectionDescription()); - } - - @Override - public void commandSucceeded(final CommandSucceededEvent event) { - LOGGER.info( - "Client id:{}\nCommand Succeeded:\n Command Name: {}\n Response Body: {}\n Connection Description: {}\n Connection elapsed ms: {}", - mongoClientSettings.getApplicationName(), - event.getCommandName(), - event.getResponse(), - event.getConnectionDescription(), - event.getElapsedTime(TimeUnit.MILLISECONDS)); - } - - @Override - public void commandFailed(final CommandFailedEvent event) { - LOGGER.info("Client id:{}\nCommand Failed:\n Command Name: {}\n Exception: {}\n Connection Description: {}\n Connection elapsed ms: {}", - mongoClientSettings.getApplicationName(), - event.getCommandName(), - event.getThrowable().getMessage(), - event.getConnectionDescription(), - event.getElapsedTime(TimeUnit.MILLISECONDS)); - } - }; - COMMAND_LISTENER_CACHE.put(settings, loggingListener); + boolean containsAdvice = hasLoggingListener(listeners); + if (containsAdvice) { + return; + } + + //TODO when two MongoClients are merged, only one listener should be at listeners collection to avoid logs duplications. (which is done) + // However, applicationName might be different.... + // so we have to log correct app names for those merged settings. + List newListeners = new ArrayList<>(listeners); + CommandListener loggingListener = new LoggingCommandListener(mongoClientSettings); + newListeners.add(loggingListener); + listeners = newListeners; //that is how return value is reassigned in bytebuddy. + } + + public static boolean hasLoggingListener(final List listeners) { + return listeners.stream() + .anyMatch(LoggingCommandListener.class::isInstance); + } + + public static class LoggingCommandListener implements CommandListener { + private final MongoClientSettings mongoClientSettings; + + public LoggingCommandListener(final MongoClientSettings mongoClientSettings) { + this.mongoClientSettings = mongoClientSettings; + } + + @Override + public void commandStarted(final CommandStartedEvent event) { + LOGGER.info("Client id: {}\nCommand Started:\n Command Name: {}\n Command Body: {}\n Connection Description: {}", + mongoClientSettings.getApplicationName(), + event.getCommandName(), + event.getCommand(), + event.getConnectionDescription()); + } + + @Override + public void commandSucceeded(final CommandSucceededEvent event) { + LOGGER.info( + "Client id: {}\nCommand Succeeded:\n Command Name: {}\n Response Body: {}\n Connection Description: {}\n Connection elapsed ms: {}", + mongoClientSettings.getApplicationName(), + event.getCommandName(), + event.getResponse(), + event.getConnectionDescription(), + event.getElapsedTime(TimeUnit.MILLISECONDS)); + } + + @Override + public void commandFailed(final CommandFailedEvent event) { + LOGGER.info( + "Client id: {}\nCommand Failed:\n Command Name: {}\n Exception: {}\n Connection Description: {}\n Connection elapsed ms: {}", + mongoClientSettings.getApplicationName(), + event.getCommandName(), + event.getThrowable().getMessage(), + event.getConnectionDescription(), + event.getElapsedTime(TimeUnit.MILLISECONDS)); } - newListeners.add(COMMAND_LISTENER_CACHE.get(settings)); - listeners = newListeners; } }