Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

SNOW-1787996: Unwanted INFO messages from arrow memory allocation manager [bis] #1956

Open
cnotin opened this issue Nov 5, 2024 · 2 comments
Assignees
Labels
bug status-triage_done Initial triage done, will be further handled by the driver team

Comments

@cnotin
Copy link

cnotin commented Nov 5, 2024

  1. What version of JDBC driver are you using?
    3.20.0

  2. What operating system and processor architecture are you using?
    Windows 11, x64

  3. What version of Java are you using?
    11

  4. What did you do?

Upgraded a Kotlin program from JDBC driver version 3.14.2 to 3.20.0

  1. What did you expect to see?

No superfluous log messages
Instead, I have this:

nov. 05, 2024 12:17:20 PM net.snowflake.client.jdbc.internal.apache.arrow.memory.BaseAllocator <clinit>
INFO: Debug mode disabled. Enable with the VM option -Darrow.memory.debug.allocator=true.
nov. 05, 2024 12:17:20 PM net.snowflake.client.jdbc.internal.apache.arrow.memory.DefaultAllocationManagerOption getDefaultAllocationManagerFactory
INFO: allocation manager type not specified, using netty as the default type
nov. 05, 2024 12:17:20 PM net.snowflake.client.jdbc.internal.apache.arrow.memory.CheckAllocator reportResult
INFO: Using DefaultAllocationManager at memory/unsafe/DefaultAllocationManagerFactory.class

Even though I'm using SLF4J with this JVM arg:

-Dnet.snowflake.jdbc.loggerImpl=net.snowflake.client.log.SLF4JLogger

which is working properly because I have this logger config in logback.xml which has visible effects, except on these arrow messages

<logger name="net.snowflake" level="WARN"/>

Also, I noticed that the arrow messages are printed to stderr, instead of stdout for other messages.
It looks like they don't go through SLF4J.

Is there a regression perhaps? Seems very similar to: #1095

  1. Can you set logging to DEBUG and collect the logs?

Not relevant I think

@cnotin cnotin added the bug label Nov 5, 2024
@github-actions github-actions bot changed the title Unwanted INFO messages from arrow memory allocation manager [bis] SNOW-1787996: Unwanted INFO messages from arrow memory allocation manager [bis] Nov 5, 2024
@cnotin
Copy link
Author

cnotin commented Nov 5, 2024

Initially I found the issue when upgrading to 3.19.0. Then I noticed this fix in 3.19.1 https://docs.snowflake.com/en/release-notes/clients-drivers/jdbc-2024#id2

Fixed issues with Arrow logging.

So I upgraded to 3.20.0 instead and I still have the issue:
image

I suppose this is the fix in 3.19.1: https://github.com/snowflakedb/snowflake-jdbc/pull/1922/files but should it fix it? Or on the contrary seems it mentions the usage of "customer logger instead of slf4j logger"?

@sfc-gh-dszmolka sfc-gh-dszmolka added the status-triage_done Initial triage done, will be further handled by the driver team label Nov 14, 2024
@sfc-gh-dszmolka
Copy link
Contributor

hi - thanks for reporting this, the team will take a look.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug status-triage_done Initial triage done, will be further handled by the driver team
Projects
None yet
Development

No branches or pull requests

3 participants