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.

Sign up for GitHub

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

Jump to bottom

Brute force not behave correctly #3045

Open
boonhanchng opened this issue Nov 5, 2024 · 8 comments
Open

Brute force not behave correctly #3045

boonhanchng opened this issue Nov 5, 2024 · 8 comments
Assignees
@DenisSinelnikov
Labels
bug Something isn't working wait for review xf:authentication xf:local config

Comments

@boonhanchng
Copy link

Describe the bug
I had configured my cloudbeaver with the env variable in docker

         - name: CLOUDBEAVER_BRUTE_FORCE_PROTECTION_ENABLED
           value: "true"
        - name: CLOUDBEAVER_MAX_FAILED_LOGINS
          value: "3"
        - name: CLOUDBEAVER_MINIMUM_LOGIN_TIMEOUT
          value: "1"
        - name: CLOUDBEAVER_BLOCK_PERIOD
          value: "30"

With CLOUDBEAVER_MINIMUM_LOGIN_TIMEOUT = 1, according to the code in repo, this should be last login attempt within 1second.
Once I logout, try to login again i will hit the exception

org.jkiss.dbeaver.DBException: Too frequent authentication requests
	at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
	at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
	at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1620)
	at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1541)
	at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:569)

To Reproduce
Steps to reproduce the behavior:

  1. Login to CloudBeaver
  2. Logout
  3. Try to login again
  4. See error

Screenshots
If applicable, add screenshots to help explain your problem.
image
@boonhanchng boonhanchng added bug Something isn't working wait for review labels Nov 5, 2024
@EvgeniaBzzz
Copy link
Contributor

Hi @boonhanchng
Just to be clear: did you press 'Login' only once when you try to login again? (step 3)
I can't reproduce it so far

@boonhanchng
Copy link
Author

Hi @EvgeniaBzzz
Yes, i just press 'Login' once after logout.
is my config correct?

@EvgeniaBzzz
Copy link
Contributor

Your config is correct.
Could you provide us with your cloudbeaver.conf and server log on the error, please.
Does this happen every time or sometimes?

@boonhanchng
Copy link
Author

It happen every time, once logout not able to login.
I did not configure cloudbeaver.conf, i use env variables

- name: CLOUDBEAVER_SERVICE_PORT
  value: "80"
- name: CLOUDBEAVER_DB_DRIVER
  value: mysql8
- name: CLOUDBEAVER_DB_URL
  value: jdbc:mysql://mysql:3306/cloudbeaver
- name: CLOUDBEAVER_DB_USER
  value: cloudbeaver
- name: CLOUDBEAVER_DB_PASSWORD
  value: mypassword
- name: CLOUDBEAVER_DB_SCHEMA
  value: cloudbeaver
- name: CLOUDBEAVER_QM_DB_DRIVER
  value: mysql8
- name: CLOUDBEAVER_QM_DB_URL
  value: jdbc:mysql://mysql:3306/cloudbeaver
- name: CLOUDBEAVER_QM_DB_USER
  value: cloudbeaver
- name: CLOUDBEAVER_QM_DB_PASSWORD
  value: mypassword
- name: CLOUDBEAVER_QM_DB_SCHEMA
  value: cloudbeaver
- name: CLOUDBEAVER_BRUTE_FORCE_PROTECTION_ENABLED
  value: "true"
- name: CLOUDBEAVER_MAX_FAILED_LOGINS
  value: "3"
- name: CLOUDBEAVER_MINIMUM_LOGIN_TIMEOUT
  value: "1"
- name: CLOUDBEAVER_BLOCK_PERIOD
  value: "30"

Here is the .cloudbeaver.runtime.conf generated by docker

{
    "server": {
      "serverName": "CloudBeaver CE Server",
      "serverURL": "https://example.com",
      "expireSessionAfterPeriod": "${CLOUDBEAVER_EXPIRE_SESSION_AFTER_PERIOD:86400000}",
      "productSettings": {
        "core.localization.localization": "en",
        "core.theming.theme": "light",
        "plugin.connection-search.disabled": true,
        "plugin.log-viewer.disabled": false,
        "plugin.log-viewer.logBatchSize": 1000,
        "plugin.log-viewer.maxLogRecords": 2000,
        "plugin.sql-editor.autoSave": true,
        "plugin.sql-editor.disabled": false,
        "plugin.sql-editor.maxFileSize": 10240,
        "sql.proposals.insert.table.alias": "PLAIN"
      },
      "database": {
        "driver": "${CLOUDBEAVER_DB_DRIVER:mysql8}",
        "url": "${CLOUDBEAVER_DB_URL:jdbc:mysql://mysql:3306/cloudbeaver}",
        "user": "${CLOUDBEAVER_DB_USER:cloudbeaver}",
        "password": "${CLOUDBEAVER_DB_PASSWORD:mypassword}",
        "schema": "${CLOUDBEAVER_DB_SCHEMA:cloudbeaver}",
        "initialDataConfiguration": "${CLOUDBEAVER_DB_INITIAL_DATA:conf/initial-data.conf}",
        "backupEnabled": "${CLOUDBEAVER_DB_BACKUP_ENABLED:true}",
        "pool": {
          "minIdleConnections": "${CLOUDBEAVER_DB_MIN_IDLE_CONNECTIONS:4}",
          "validationQuery": "${CLOUDBEAVER_DB_VALIDATION_QUERY:SELECT 1}",
          "maxIdleConnections": "${CLOUDBEAVER_DB_MAX_IDLE_CONNECTIONS:10}",
          "maxConnections": "${CLOUDBEAVER_DB_MAX_CONNECTIONS:100}"
        }
      },
      "sm": {
        "passwordPolicy": {
          "minLength": "${CLOUDBEAVER_POLICY_MIN_LENGTH:8}",
          "minNumberCount": "${CLOUDBEAVER_POLICY_MIN_NUMBER_COUNT:1}",
          "minSymbolCount": "${CLOUDBEAVER_POLICY_MIN_SYMBOL_COUNT:0}",
          "requireMixedCase": "${CLOUDBEAVER_POLICY_REQUIRE_MIXED_CASE:true}"
        }
      }
    },
    "app": {
      "anonymousAccessEnabled": "${CLOUDBEAVER_APP_ANONYMOUS_ACCESS_ENABLED:false}",
      "supportsCustomConnections": "${CLOUDBEAVER_APP_SUPPORTS_CUSTOM_CONNECTIONS:false}",
      "publicCredentialsSaveEnabled": "${CLOUDBEAVER_APP_PUBLIC_CREDENTIALS_SAVE_ENABLED:true}",
      "adminCredentialsSaveEnabled": "${CLOUDBEAVER_APP_ADMIN_CREDENTIALS_SAVE_ENABLED:true}",
      "enableReverseProxyAuth": false,
      "forwardProxy": "${CLOUDBEAVER_APP_FORWARD_PROXY:false}",
      "linkExternalCredentialsWithUser": true,
      "redirectOnFederatedAuth": false,
      "resourceManagerEnabled": "${CLOUDBEAVER_APP_RESOURCE_MANAGER_ENABLED:true}",
      "showReadOnlyConnectionInfo": "${CLOUDBEAVER_APP_READ_ONLY_CONNECTION_INFO:false}",
      "grantConnectionsAccessToAnonymousTeam": "${CLOUDBEAVER_APP_GRANT_CONNECTIONS_ACCESS_TO_ANONYMOUS_TEAM:false}",
      "systemVariablesResolvingEnabled": "${CLOUDBEAVER_SYSTEM_VARIABLES_RESOLVING_ENABLED:false}",
      "resourceQuotas": {
        "dataExportFileSizeLimit": "${CLOUDBEAVER_RESOURCE_QUOTA_DATA_EXPORT_FILE_SIZE_LIMIT:10000000}",
        "resourceManagerFileSizeLimit": "${CLOUDBEAVER_RESOURCE_QUOTA_RESOURCE_MANAGER_FILE_SIZE_LIMIT:500000}",
        "sqlMaxRunningQueries": "${CLOUDBEAVER_RESOURCE_QUOTA_SQL_MAX_RUNNING_QUERIES:100}",
        "sqlResultSetRowsLimit": "${CLOUDBEAVER_RESOURCE_QUOTA_SQL_RESULT_SET_ROWS_LIMIT:100000}",
        "sqlTextPreviewMaxLength": "${CLOUDBEAVER_RESOURCE_QUOTA_SQL_TEXT_PREVIEW_MAX_LENGTH:4096}",
        "sqlBinaryPreviewMaxLength": "${CLOUDBEAVER_RESOURCE_QUOTA_SQL_BINARY_PREVIEW_MAX_LENGTH:261120}"
      },
      "defaultNavigatorSettings": {},
      "enabledFeatures": [],
      "enabledAuthProviders": [
        "local"
      ],
      "enabledDrivers": [],
      "disabledDrivers": [
        "sqlite:sqlite_jdbc",
        "h2:h2_embedded",
        "h2:h2_embedded_v2",
        "clickhouse:yandex_clickhouse",
        "generic:duckdb_jdbc"
      ]
    }
  }

Logs from my containers

06-11-2024 12:11:34.761 [qtp404994500-31] ERROR i.c.service.WebServiceBindingBase - Unexpected error during gql request
io.cloudbeaver.DBWebException: User authentication failed:
Too frequent authentication requests
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:115)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:569)
        at io.cloudbeaver.service.WebServiceBindingBase$ServiceInvocationHandler.invoke(WebServiceBindingBase.java:170)
        at jdk.proxy7/jdk.proxy7.$Proxy13.authLogin(Unknown Source)
        at io.cloudbeaver.service.auth.WebServiceBindingAuth.lambda$0(WebServiceBindingAuth.java:39)
        at graphql.execution.ExecutionStrategy.invokeDataFetcher(ExecutionStrategy.java:533)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:497)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:438)
        at graphql.execution.ExecutionStrategy.resolveFieldWithInfo(ExecutionStrategy.java:397)
        at graphql.execution.ExecutionStrategy.getAsyncFieldValueInfo(ExecutionStrategy.java:335)
        at graphql.execution.AsyncExecutionStrategy.execute(AsyncExecutionStrategy.java:57)
        at graphql.execution.Execution.executeOperation(Execution.java:180)
        at graphql.execution.Execution.execute(Execution.java:116)
        at graphql.GraphQL.execute(GraphQL.java:546)
        at graphql.GraphQL.lambda$parseValidateAndExecute$13(GraphQL.java:476)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.parseValidateAndExecute(GraphQL.java:471)
        at graphql.GraphQL.lambda$executeAsync$9(GraphQL.java:429)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.executeAsync(GraphQL.java:418)
        at graphql.GraphQL.execute(GraphQL.java:359)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeQuery(GraphQLEndpoint.java:263)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeSingleQuery(GraphQLEndpoint.java:207)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.doPost(GraphQLEndpoint.java:190)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:653)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.eclipse.jetty.ee10.servlet.ServletHolder.handle(ServletHolder.java:736)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1614)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$MappedServlet.handle(ServletHandler.java:1547)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.dispatch(ServletChannel.java:824)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.handle(ServletChannel.java:436)
        at org.eclipse.jetty.ee10.servlet.ServletHandler.handle(ServletHandler.java:464)
        at org.eclipse.jetty.ee10.servlet.SessionHandler.handle(SessionHandler.java:703)
        at org.eclipse.jetty.server.Handler$Wrapper.handle(Handler.java:740)
        at org.eclipse.jetty.websocket.server.WebSocketUpgradeHandler.handle(WebSocketUpgradeHandler.java:227)
        at org.eclipse.jetty.server.handler.ContextHandler.handle(ContextHandler.java:1060)
        at org.eclipse.jetty.server.Server.handle(Server.java:181)
        at org.eclipse.jetty.server.internal.HttpChannelState$HandlerInvoker.run(HttpChannelState.java:648)
        at org.eclipse.jetty.server.internal.HttpConnection.onFillable(HttpConnection.java:403)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: org.jkiss.dbeaver.DBException: Too frequent authentication requests
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1620)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1541)
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
        ... 55 common frames omitted
06-11-2024 12:11:34.763 [qtp404994500-31] DEBUG i.c.server.graphql.GraphQLEndpoint - GraphQL call failed at '/authInfo'
io.cloudbeaver.DBWebException: User authentication failed:
Too frequent authentication requests
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:115)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:569)
        at io.cloudbeaver.service.WebServiceBindingBase$ServiceInvocationHandler.invoke(WebServiceBindingBase.java:170)
        at jdk.proxy7/jdk.proxy7.$Proxy13.authLogin(Unknown Source)
        at io.cloudbeaver.service.auth.WebServiceBindingAuth.lambda$0(WebServiceBindingAuth.java:39)
        at graphql.execution.ExecutionStrategy.invokeDataFetcher(ExecutionStrategy.java:533)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:497)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:438)
        at graphql.execution.ExecutionStrategy.resolveFieldWithInfo(ExecutionStrategy.java:397)
        at graphql.execution.ExecutionStrategy.getAsyncFieldValueInfo(ExecutionStrategy.java:335)
        at graphql.execution.AsyncExecutionStrategy.execute(AsyncExecutionStrategy.java:57)
        at graphql.execution.Execution.executeOperation(Execution.java:180)
        at graphql.execution.Execution.execute(Execution.java:116)
        at graphql.GraphQL.execute(GraphQL.java:546)
        at graphql.GraphQL.lambda$parseValidateAndExecute$13(GraphQL.java:476)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.parseValidateAndExecute(GraphQL.java:471)
        at graphql.GraphQL.lambda$executeAsync$9(GraphQL.java:429)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.executeAsync(GraphQL.java:418)
        at graphql.GraphQL.execute(GraphQL.java:359)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeQuery(GraphQLEndpoint.java:263)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeSingleQuery(GraphQLEndpoint.java:207)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.doPost(GraphQLEndpoint.java:190)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:653)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.eclipse.jetty.ee10.servlet.ServletHolder.handle(ServletHolder.java:736)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1614)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$MappedServlet.handle(ServletHandler.java:1547)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.dispatch(ServletChannel.java:824)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.handle(ServletChannel.java:436)
        at org.eclipse.jetty.ee10.servlet.ServletHandler.handle(ServletHandler.java:464)
        at org.eclipse.jetty.ee10.servlet.SessionHandler.handle(SessionHandler.java:703)
        at org.eclipse.jetty.server.Handler$Wrapper.handle(Handler.java:740)
        at org.eclipse.jetty.websocket.server.WebSocketUpgradeHandler.handle(WebSocketUpgradeHandler.java:227)
        at org.eclipse.jetty.server.handler.ContextHandler.handle(ContextHandler.java:1060)
        at org.eclipse.jetty.server.Server.handle(Server.java:181)
        at org.eclipse.jetty.server.internal.HttpChannelState$HandlerInvoker.run(HttpChannelState.java:648)
        at org.eclipse.jetty.server.internal.HttpConnection.onFillable(HttpConnection.java:403)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: org.jkiss.dbeaver.DBException: Too frequent authentication requests
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1620)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1541)
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
        ... 55 common frames omitted
06-11-2024 12:12:58.406 [qtp404994500-29] ERROR i.c.s.websockets.CBEventsWebSocket - null
java.nio.channels.ClosedChannelException: null
        at org.eclipse.jetty.websocket.core.internal.WebSocketSessionState.onEof(WebSocketSessionState.java:168)
        at org.eclipse.jetty.websocket.core.WebSocketCoreSession.onEof(WebSocketCoreSession.java:229)
        at org.eclipse.jetty.websocket.core.WebSocketConnection.fillAndParse(WebSocketConnection.java:474)
        at org.eclipse.jetty.websocket.core.WebSocketConnection.onFillable(WebSocketConnection.java:332)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
06-11-2024 12:12:58.407 [qtp404994500-29] DEBUG i.c.s.websockets.CBEventsWebSocket - Socket Closed: [1006] Session Closed
06-11-2024 12:13:29.374 [qtp404994500-31] INFO  i.c.s.w.CBJettyWebSocketManager - Websocket created for session: aakdegmmpfrs1hayzat3robbk0
06-11-2024 12:13:29.375 [qtp404994500-31] DEBUG i.c.s.websockets.CBEventsWebSocket - EventWebSocket connected to the aakdegmmpfrs1hayzat3robbk0 session

@DenisSinelnikov
Copy link
Contributor

Hi @boonhanchng
I want to clarify:

  1. Does this behavior work with any user or the one that was created recently, and this is his first/second login attempt? (Maybe the time in the database is different with the server.).
  2. Сould you provide a log from the start of the application until the error is reproduced?

@boonhanchng
Copy link
Author

Hi @DenisSinelnikov
Sorry for late reply.

  1. any user created recently or created previously having same behavior.
Starting Cloudbeaver Server
WARNING: Using incubator modules: jdk.incubator.vector, jdk.incubator.foreign
SLF4J(I): Logback configuration is used: conf/logback.xml
20-11-2024 02:02:22.674 [main] DEBUG i.c.model.app.BaseWebApplication - Loading configuration from /opt/cloudbeaver/conf/cloudbeaver.conf
20-11-2024 02:02:22.675 [main] DEBUG i.c.s.CBServerConfigurationController - Using configuration [/opt/cloudbeaver/conf/cloudbeaver.conf]
20-11-2024 02:02:22.675 [main] DEBUG i.c.s.CBServerConfigurationController - Read configuration [/opt/cloudbeaver/conf/cloudbeaver.conf]
20-11-2024 02:02:22.702 [main] INFO  io.cloudbeaver.server.CBPlatform - Initialize web platform...:
20-11-2024 02:02:22.760 [main] DEBUG o.j.d.runtime.SecurityProviderUtils - BounceCastle bundle found. Use JCE provider BC
20-11-2024 02:02:22.779 [main] DEBUG o.j.d.registry.BasePlatformImpl - Initialize base platform...
20-11-2024 02:02:22.932 [main] DEBUG o.j.d.r.DataSourceProviderRegistry - Total database drivers: 119 (119)
20-11-2024 02:02:22.935 [main] ERROR io.cloudbeaver.server.CBPlatform -         Driver 'yandex_clickhouse' is missing library 'ru.yandex.clickhouse:clickhouse-jdbc:RELEASE'
20-11-2024 02:02:22.937 [main] INFO  io.cloudbeaver.server.CBPlatform - Available drivers: ClickHouse,Db2 for LUW,Db2 for IBM i,Firebird,DuckDB,Hadoop / Apache Kyuubi,Trino,H2 Embedded,H2 Embedded V.2,MS SQL Server / SQL Server,MySQL,MariaDB,Oracle,PostgreSQL,SQLite,LibSQL
20-11-2024 02:02:22.939 [main] INFO  io.cloudbeaver.server.CBPlatform - Web platform initialized (237ms)
20-11-2024 02:02:22.955 [main] INFO  i.c.m.a.BaseServerConfigurationController - Workspace path initialized: /opt/cloudbeaver/workspace
20-11-2024 02:02:22.955 [main] DEBUG i.c.s.CBServerConfigurationController - Runtime configuration [/opt/cloudbeaver/workspace/.data/.cloudbeaver.runtime.conf]
20-11-2024 02:02:22.955 [main] DEBUG i.c.s.CBServerConfigurationController - Read configuration [/opt/cloudbeaver/workspace/.data/.cloudbeaver.runtime.conf]
20-11-2024 02:02:22.960 [main] DEBUG io.cloudbeaver.server.CBApplication - CloudBeaver CE Server 24.2.5.202411181000 is starting
20-11-2024 02:02:22.960 [main] DEBUG io.cloudbeaver.server.CBApplication -      OS: Linux 6.8.0-45-generic (amd64)
20-11-2024 02:02:22.960 [main] DEBUG io.cloudbeaver.server.CBApplication -      Java version: 17.0.12 by Eclipse Adoptium (64bit)
20-11-2024 02:02:22.961 [main] DEBUG io.cloudbeaver.server.CBApplication -      Install path: '/opt/cloudbeaver/server'
20-11-2024 02:02:22.961 [main] DEBUG io.cloudbeaver.server.CBApplication -      Global workspace: 'file:/opt/cloudbeaver/workspace/'
20-11-2024 02:02:22.962 [main] DEBUG io.cloudbeaver.server.CBApplication -      Memory available 84Mb/1024Mb
20-11-2024 02:02:22.962 [main] DEBUG io.cloudbeaver.server.CBApplication -      Content root: /opt/cloudbeaver/web
20-11-2024 02:02:22.962 [main] DEBUG io.cloudbeaver.server.CBApplication -      Drivers storage: /opt/cloudbeaver/drivers
20-11-2024 02:02:22.963 [main] DEBUG io.cloudbeaver.server.CBApplication -      Listen port: 8978 on all interfaces
20-11-2024 02:02:22.963 [main] DEBUG io.cloudbeaver.server.CBApplication -      Base URI: /api/
20-11-2024 02:02:22.964 [main] DEBUG io.cloudbeaver.server.CBApplication -      Production mode
20-11-2024 02:02:22.974 [main] DEBUG io.cloudbeaver.server.CBApplication -      Local host addresses:
20-11-2024 02:02:22.974 [main] DEBUG io.cloudbeaver.server.CBApplication -              10.1.136.180 (cloudbeaver-0.cloudbeaver.elkenvn-environment.svc.cluster.local)
20-11-2024 02:02:22.974 [main] DEBUG io.cloudbeaver.server.CBApplication -              0:0:0:0:0:0:0:1%lo (localhost)
20-11-2024 02:02:23.030 [main] DEBUG i.c.s.auth.ReverseProxyConfigurator - Reverse proxy provider disabled, migration not needed
20-11-2024 02:02:23.040 [main] DEBUG i.c.service.security.db.CBDatabase - Initiate management database
20-11-2024 02:02:23.048 [main] DEBUG i.c.service.security.db.CBDatabase -       Initiate connection pool with management database (MySQL; jdbc:mysql://mysql:3306/cloudbeaver)
20-11-2024 02:02:23.336 [main] DEBUG i.c.service.security.db.CBDatabase -       Connected to MySQL 8.0.39
20-11-2024 02:02:23.455 [main] DEBUG i.c.service.security.db.CBDatabase -       Management database connection established
20-11-2024 02:02:23.470 [main] DEBUG io.cloudbeaver.server.CBApplication - Starting Jetty server (8978 on all interfaces)
20-11-2024 02:02:23.735 [main] DEBUG i.c.server.graphql.GraphQLEndpoint - Schema extensions loaded: WebServiceBindingCore,WebServiceBindingNavigator,WebServiceBindingSQL,WebServiceBindingAdmin,WebServiceBindingAuth,WebServiceBindingDataTransfer,WebServiceBindingFS,WebServiceBindingMetadata,WebServiceBindingRM
20-11-2024 02:02:24.021 [main] DEBUG i.c.server.jetty.CBJettyServer - Max http session idle time: 86400s
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer - Active servlets:
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   static: [/]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   images: [/api/images/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   status: [/status]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   graphql: [/api/gql/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   sqlResultValueViewer: [/api/sql-result-value/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   sqlUploadFile: [/api/resultset/blob/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   adminLogs: [/api/logs/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   dataTransfer: [/api/data/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   dataTransferImport: [/api/data/import/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer -   fileSystems: [/api/fs-data/*]
20-11-2024 02:02:24.024 [main] DEBUG i.c.server.jetty.CBJettyServer - Active websocket mappings:
20-11-2024 02:02:24.024 [main] INFO  i.c.server.jetty.CBJettyServer - Refreshing Jetty configuration
20-11-2024 02:02:24.026 [main] INFO  org.eclipse.jetty.server.Server - jetty-12.0.12; built: 2024-07-25T21:58:37.668Z; git: cc6f1b74db755fed228b50701ad967aeaa68e83f; jvm 17.0.12+7
20-11-2024 02:02:24.032 [main] INFO  o.e.j.s.DefaultSessionIdManager - Session workerName=
20-11-2024 02:02:24.040 [main] INFO  o.e.j.server.handler.ContextHandler - Started oeje10s.ServletContextHandler@4ec427{ROOT,/,b=file:///opt/cloudbeaver/web/,a=AVAILABLE,h=oejws.WebSocketUpgradeHandler@4c8d45cf{STARTED}}
20-11-2024 02:02:24.047 [main] INFO  o.e.j.e.s.ServletContextHandler - Started oeje10s.ServletContextHandler@4ec427{ROOT,/,b=file:///opt/cloudbeaver/web/,a=AVAILABLE,h=oejws.WebSocketUpgradeHandler@4c8d45cf{STARTED}}
20-11-2024 02:02:24.052 [main] INFO  o.e.jetty.server.AbstractConnector - Started ServerConnector@11015ca0{HTTP/1.1, (http/1.1)}{0.0.0.0:8978}
20-11-2024 02:02:24.053 [main] INFO  org.eclipse.jetty.server.Server - Started oejs.Server@6630dd28{STARTING}[12.0.12,sto=0] @2730ms
20-11-2024 02:06:39.092 [qtp1005928818-31] DEBUG i.c.s.session.WebSessionManager - New web session '1iwphnlcvnuhiu0b85jaccztt0'
20-11-2024 02:06:41.236 [qtp1005928818-33] INFO  i.c.s.w.CBJettyWebSocketManager - Websocket created for session: 1iwphnlcvnuhiu0b85jaccztt0
20-11-2024 02:06:41.249 [qtp1005928818-31] DEBUG i.c.server.graphql.GraphQLEndpoint - API > serverConfig
20-11-2024 02:06:41.259 [qtp1005928818-33] DEBUG i.c.s.websockets.CBEventsWebSocket - EventWebSocket connected to the 1iwphnlcvnuhiu0b85jaccztt0 session
20-11-2024 02:06:41.337 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > openSession
20-11-2024 02:06:41.365 [qtp1005928818-36] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser
20-11-2024 02:06:41.432 [qtp1005928818-33] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getProductInfo
20-11-2024 02:06:41.482 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getAuthProviders
20-11-2024 02:06:41.565 [qtp1005928818-33] DEBUG i.c.server.graphql.GraphQLEndpoint - API > sessionPermissions
20-11-2024 02:06:41.586 [qtp1005928818-29] DEBUG i.c.model.session.WebSession - Update session lifetime 1iwphnlcvnuhiu0b85jaccztt0 for user null
20-11-2024 02:06:52.288 [qtp1005928818-29] DEBUG i.c.s.session.WebSessionManager - Couldn't restore previous user session 'lmvtgcgbapxye31m09l0n5dt169'
20-11-2024 02:06:52.288 [qtp1005928818-29] DEBUG i.c.s.w.CBJettyWebSocketManager - CloudBeaver web session not exist, try to create headless session
20-11-2024 02:06:52.288 [qtp1005928818-29] DEBUG i.c.s.w.CBJettyWebSocketManager - Couldn't create headless session
20-11-2024 02:06:52.514 [qtp1005928818-31] DEBUG i.c.server.graphql.GraphQLEndpoint - API > authLogin
20-11-2024 02:06:52.591 [qtp1005928818-31] DEBUG i.c.model.session.WebUserContext - refresh permissions bhchng f108e9e6-5b86-4154-a3d1-aa53753a28ad
20-11-2024 02:06:52.594 [qtp1005928818-31] DEBUG i.c.model.session.WebUserContext - refresh permissions bhchng f108e9e6-5b86-4154-a3d1-aa53753a28ad
20-11-2024 02:06:52.624 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser
20-11-2024 02:06:52.686 [qtp1005928818-33] DEBUG i.c.server.graphql.GraphQLEndpoint - API > openSession
20-11-2024 02:06:52.729 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser
20-11-2024 02:06:52.737 [qtp1005928818-35] DEBUG i.c.server.graphql.GraphQLEndpoint - API > sessionPermissions
20-11-2024 02:06:52.774 [qtp1005928818-36] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getServerLicenseStatus
20-11-2024 02:06:52.795 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getProjectList
20-11-2024 02:06:52.833 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getTemplateConnections
20-11-2024 02:06:52.833 [qtp1005928818-35] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getUserConnections
20-11-2024 02:06:52.892 [qtp1005928818-36] DEBUG i.c.server.graphql.GraphQLEndpoint - API > executionContextList
20-11-2024 02:06:52.895 [qtp1005928818-35] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navNodeChildren
20-11-2024 02:06:52.898 [qtp1005928818-42] DEBUG i.c.server.graphql.GraphQLEndpoint - API > driverList
20-11-2024 02:06:53.006 [qtp1005928818-36] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getNodeParents
20-11-2024 02:06:53.010 [qtp1005928818-43] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navNodeChildren
20-11-2024 02:06:54.838 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > executionContextList
20-11-2024 02:06:54.863 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getUserConnections
20-11-2024 02:06:54.909 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navNodeChildren
20-11-2024 02:06:54.909 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > initConnection
20-11-2024 02:06:54.915 [qtp1005928818-41] DEBUG o.j.d.registry.DataSourceDescriptor - Connect with 'elkenvn' (mysql8-192dbee4138-3babcde487179433)
20-11-2024 02:06:54.933 [qtp1005928818-41] DEBUG o.j.d.m.i.AbstractExecutionContext - Execution context opened (elkenvn; Main; 0)
20-11-2024 02:06:54.937 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set autoDeserialize:false
20-11-2024 02:06:54.937 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set allowUrlInLocalInfile:false
20-11-2024 02:06:54.937 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set allowLocalInfile:false
20-11-2024 02:06:54.937 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set allowLoadLocalInfile:false
20-11-2024 02:06:54.952 [qtp1005928818-41] DEBUG o.j.d.m.i.AbstractExecutionContext - Execution context opened (elkenvn; Metadata; 1)
20-11-2024 02:06:54.952 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set autoDeserialize:false
20-11-2024 02:06:54.952 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set allowUrlInLocalInfile:false
20-11-2024 02:06:54.952 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set allowLocalInfile:false
20-11-2024 02:06:54.952 [qtp1005928818-41] DEBUG o.j.d.e.mysql.model.MySQLDataSource - Set allowLoadLocalInfile:false
20-11-2024 02:06:54.985 [qtp1005928818-41] DEBUG o.j.d.registry.DataSourceDescriptor - Connected (mysql8-192dbee4138-3babcde487179433, MySQL Connector/J [mysql-connector-j-8.2.0 (Revision: 06a1f724497fd81c6a659131fda822c9e5085b6c)])
20-11-2024 02:06:55.024 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > executionContextCreate
20-11-2024 02:06:55.024 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navNodeChildren
20-11-2024 02:06:55.055 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navNodeChildren
20-11-2024 02:06:55.083 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > querySqlDialectInfo
20-11-2024 02:06:55.086 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > executionContextList
20-11-2024 02:06:55.113 [qtp1005928818-34] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navGetStructContainers
20-11-2024 02:06:55.173 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > navGetStructContainers
20-11-2024 02:06:56.895 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getUserProfileProperties
20-11-2024 02:06:56.951 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getPasswordPolicy
20-11-2024 02:06:56.951 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUserMetaParameters
20-11-2024 02:06:57.147 [qtp1005928818-34] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.150 [qtp1005928818-33] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.150 [qtp1005928818-41] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.157 [qtp1005928818-29] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.160 [qtp1005928818-35] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.160 [qtp1005928818-45] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.161 [qtp1005928818-42] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.161 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.161 [qtp1005928818-46] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:06:57.163 [qtp1005928818-36] DEBUG i.c.server.graphql.GraphQLEndpoint - API > parseSQLScript
20-11-2024 02:07:00.071 [qtp1005928818-43] DEBUG i.c.server.graphql.GraphQLEndpoint - API > authLogout
20-11-2024 02:07:00.094 [DBeaver: Disconnect from data sources] DEBUG o.j.d.m.i.AbstractExecutionContext - Execution context closed (elkenvn, 0)
20-11-2024 02:07:00.105 [DBeaver: Disconnect from data sources] DEBUG o.j.d.m.i.AbstractExecutionContext - Execution context closed (elkenvn, 1)
20-11-2024 02:07:00.105 [DBeaver: Disconnect from data sources] DEBUG o.j.d.registry.DataSourceDescriptor - Disconnected (mysql8-192dbee4138-3babcde487179433)
20-11-2024 02:07:00.178 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser
20-11-2024 02:07:00.225 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > openSession
20-11-2024 02:07:00.248 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser
20-11-2024 02:07:00.258 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > sessionPermissions
20-11-2024 02:07:02.096 [qtp1005928818-32] DEBUG i.c.s.websockets.CBEventsWebSocket - Socket Closed: [1001] null
20-11-2024 02:07:02.236 [qtp1005928818-32] INFO  i.c.s.w.CBJettyWebSocketManager - Websocket created for session: 1iwphnlcvnuhiu0b85jaccztt0
20-11-2024 02:07:02.237 [qtp1005928818-32] DEBUG i.c.s.websockets.CBEventsWebSocket - EventWebSocket connected to the 1iwphnlcvnuhiu0b85jaccztt0 session
20-11-2024 02:07:02.266 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > serverConfig
20-11-2024 02:07:02.290 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - API > openSession
20-11-2024 02:07:02.315 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser
20-11-2024 02:07:02.361 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getProductInfo
20-11-2024 02:07:02.370 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getAuthProviders
20-11-2024 02:07:02.431 [qtp1005928818-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > sessionPermissions
20-11-2024 02:07:02.431 [qtp1005928818-44] DEBUG i.c.model.session.WebSession - Update session lifetime 1iwphnlcvnuhiu0b85jaccztt0 for user null
20-11-2024 02:07:23.306 [qtp1005928818-44] DEBUG i.c.s.session.WebSessionManager - Couldn't restore previous user session 'lmvtgcgbapxye31m09l0n5dt169'
20-11-2024 02:07:23.306 [qtp1005928818-44] DEBUG i.c.s.w.CBJettyWebSocketManager - CloudBeaver web session not exist, try to create headless session
20-11-2024 02:07:23.306 [qtp1005928818-44] DEBUG i.c.s.w.CBJettyWebSocketManager - Couldn't create headless session
20-11-2024 02:07:25.464 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - API > authLogin
20-11-2024 02:07:25.470 [qtp1005928818-44] ERROR i.c.service.WebServiceBindingBase - Unexpected error during gql request
io.cloudbeaver.DBWebException: User authentication failed:
Too frequent authentication requests
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:115)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:569)
        at io.cloudbeaver.service.WebServiceBindingBase$ServiceInvocationHandler.invoke(WebServiceBindingBase.java:170)
        at jdk.proxy8/jdk.proxy8.$Proxy14.authLogin(Unknown Source)
        at io.cloudbeaver.service.auth.WebServiceBindingAuth.lambda$0(WebServiceBindingAuth.java:39)
        at graphql.execution.ExecutionStrategy.invokeDataFetcher(ExecutionStrategy.java:533)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:497)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:438)
        at graphql.execution.ExecutionStrategy.resolveFieldWithInfo(ExecutionStrategy.java:397)
        at graphql.execution.ExecutionStrategy.getAsyncFieldValueInfo(ExecutionStrategy.java:335)
        at graphql.execution.AsyncExecutionStrategy.execute(AsyncExecutionStrategy.java:57)
        at graphql.execution.Execution.executeOperation(Execution.java:180)
        at graphql.execution.Execution.execute(Execution.java:116)
        at graphql.GraphQL.execute(GraphQL.java:546)
        at graphql.GraphQL.lambda$parseValidateAndExecute$13(GraphQL.java:476)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.parseValidateAndExecute(GraphQL.java:471)
        at graphql.GraphQL.lambda$executeAsync$9(GraphQL.java:429)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.executeAsync(GraphQL.java:418)
        at graphql.GraphQL.execute(GraphQL.java:359)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeQuery(GraphQLEndpoint.java:263)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeSingleQuery(GraphQLEndpoint.java:207)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.doPost(GraphQLEndpoint.java:190)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:653)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.eclipse.jetty.ee10.servlet.ServletHolder.handle(ServletHolder.java:736)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1614)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$MappedServlet.handle(ServletHandler.java:1547)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.dispatch(ServletChannel.java:824)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.handle(ServletChannel.java:436)
        at org.eclipse.jetty.ee10.servlet.ServletHandler.handle(ServletHandler.java:464)
        at org.eclipse.jetty.ee10.servlet.SessionHandler.handle(SessionHandler.java:703)
        at org.eclipse.jetty.server.Handler$Wrapper.handle(Handler.java:740)
        at org.eclipse.jetty.websocket.server.WebSocketUpgradeHandler.handle(WebSocketUpgradeHandler.java:227)
        at org.eclipse.jetty.server.handler.ContextHandler.handle(ContextHandler.java:1060)
        at org.eclipse.jetty.server.Server.handle(Server.java:181)
        at org.eclipse.jetty.server.internal.HttpChannelState$HandlerInvoker.run(HttpChannelState.java:648)
        at org.eclipse.jetty.server.internal.HttpConnection.onFillable(HttpConnection.java:403)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: org.jkiss.dbeaver.DBException: Too frequent authentication requests
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1659)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1580)
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
        ... 55 common frames omitted
20-11-2024 02:07:25.472 [qtp1005928818-44] DEBUG i.c.server.graphql.GraphQLEndpoint - GraphQL call failed at '/authInfo'
io.cloudbeaver.DBWebException: User authentication failed:
Too frequent authentication requests
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:115)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:569)
        at io.cloudbeaver.service.WebServiceBindingBase$ServiceInvocationHandler.invoke(WebServiceBindingBase.java:170)
        at jdk.proxy8/jdk.proxy8.$Proxy14.authLogin(Unknown Source)
        at io.cloudbeaver.service.auth.WebServiceBindingAuth.lambda$0(WebServiceBindingAuth.java:39)
        at graphql.execution.ExecutionStrategy.invokeDataFetcher(ExecutionStrategy.java:533)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:497)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:438)
        at graphql.execution.ExecutionStrategy.resolveFieldWithInfo(ExecutionStrategy.java:397)
        at graphql.execution.ExecutionStrategy.getAsyncFieldValueInfo(ExecutionStrategy.java:335)
        at graphql.execution.AsyncExecutionStrategy.execute(AsyncExecutionStrategy.java:57)
        at graphql.execution.Execution.executeOperation(Execution.java:180)
        at graphql.execution.Execution.execute(Execution.java:116)
        at graphql.GraphQL.execute(GraphQL.java:546)
        at graphql.GraphQL.lambda$parseValidateAndExecute$13(GraphQL.java:476)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.parseValidateAndExecute(GraphQL.java:471)
        at graphql.GraphQL.lambda$executeAsync$9(GraphQL.java:429)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.executeAsync(GraphQL.java:418)
        at graphql.GraphQL.execute(GraphQL.java:359)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeQuery(GraphQLEndpoint.java:263)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeSingleQuery(GraphQLEndpoint.java:207)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.doPost(GraphQLEndpoint.java:190)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:653)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.eclipse.jetty.ee10.servlet.ServletHolder.handle(ServletHolder.java:736)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1614)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$MappedServlet.handle(ServletHandler.java:1547)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.dispatch(ServletChannel.java:824)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.handle(ServletChannel.java:436)
        at org.eclipse.jetty.ee10.servlet.ServletHandler.handle(ServletHandler.java:464)
        at org.eclipse.jetty.ee10.servlet.SessionHandler.handle(SessionHandler.java:703)
        at org.eclipse.jetty.server.Handler$Wrapper.handle(Handler.java:740)
        at org.eclipse.jetty.websocket.server.WebSocketUpgradeHandler.handle(WebSocketUpgradeHandler.java:227)
        at org.eclipse.jetty.server.handler.ContextHandler.handle(ContextHandler.java:1060)
        at org.eclipse.jetty.server.Server.handle(Server.java:181)
        at org.eclipse.jetty.server.internal.HttpChannelState$HandlerInvoker.run(HttpChannelState.java:648)
        at org.eclipse.jetty.server.internal.HttpConnection.onFillable(HttpConnection.java:403)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: org.jkiss.dbeaver.DBException: Too frequent authentication requests
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1659)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1580)
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
        ... 55 common frames omitted

@LonwoLonwo
Copy link
Member

Hello @boonhanchng

What CloudBeaver version do you use?
Is this issue reproducible on the latest 24.3.0 version?

@boonhanchng
Copy link
Author

Hi @LonwoLonwo
The issue still persisted in 24.3

Starting Cloudbeaver Server
WARNING: Using incubator modules: jdk.incubator.vector, jdk.incubator.foreign
SLF4J(I): Logback configuration is used: conf/logback.xml
19-12-2024 07:11:16.616 [main] DEBUG i.c.model.app.BaseWebApplication - Loading configuration from /opt/cloudbeaver/conf/cloudbeaver.conf
19-12-2024 07:11:16.617 [main] DEBUG i.c.s.CBServerConfigurationController - Using configuration [/opt/cloudbeaver/conf/cloudbeaver.conf]
19-12-2024 07:11:16.617 [main] DEBUG i.c.s.CBServerConfigurationController - Read configuration [/opt/cloudbeaver/conf/cloudbeaver.conf]
19-12-2024 07:11:16.652 [main] INFO  i.c.m.a.BaseServerConfigurationController - Workspace path initialized: /opt/cloudbeaver/workspace
19-12-2024 07:11:16.653 [main] DEBUG i.c.s.CBServerConfigurationController - Runtime configuration [/opt/cloudbeaver/workspace/.data/.cloudbeaver.runtime.conf]
19-12-2024 07:11:16.653 [main] DEBUG i.c.s.CBServerConfigurationController - Read configuration [/opt/cloudbeaver/workspace/.data/.cloudbeaver.runtime.conf]
19-12-2024 07:11:16.659 [main] INFO  io.cloudbeaver.server.CBPlatform - Initialize web platform...:
19-12-2024 07:11:16.752 [main] DEBUG o.j.d.runtime.SecurityProviderUtils - BounceCastle bundle found. Use JCE provider BC
19-12-2024 07:11:16.765 [main] DEBUG o.j.d.registry.BasePlatformImpl - Initialize base platform...
19-12-2024 07:11:16.858 [main] DEBUG o.j.d.r.DataSourceProviderDescriptor - Script dialect 'gbase8s' not found in registry (for data source provider gbase8s). Use default.
19-12-2024 07:11:16.921 [main] DEBUG o.j.d.r.DataSourceProviderRegistry - Total database drivers: 120 (120)
19-12-2024 07:11:16.925 [main] ERROR io.cloudbeaver.server.CBPlatform -         Driver 'yandex_clickhouse' is missing library 'ru.yandex.clickhouse:clickhouse-jdbc:RELEASE'
19-12-2024 07:11:16.927 [main] INFO  io.cloudbeaver.server.CBPlatform - Available drivers: ClickHouse,Db2 for LUW,Db2 for IBM i,Firebird,DuckDB,Hadoop / Apache Kyuubi,Trino,H2 Embedded,H2 Embedded V.2,MS SQL Server / SQL Server,MySQL,MariaDB,Oracle,PostgreSQL,SQLite,LibSQL
19-12-2024 07:11:16.929 [main] INFO  io.cloudbeaver.server.CBPlatform - Web platform initialized (270ms)
19-12-2024 07:11:16.941 [main] DEBUG io.cloudbeaver.server.CBApplication - CloudBeaver CE Server 24.3.0.202412031444 is starting
19-12-2024 07:11:16.941 [main] DEBUG io.cloudbeaver.server.CBApplication -      OS: Linux 6.8.0-45-generic (amd64)
19-12-2024 07:11:16.941 [main] DEBUG io.cloudbeaver.server.CBApplication -      Java version: 17.0.13 by Eclipse Adoptium (64bit)
19-12-2024 07:11:16.941 [main] DEBUG io.cloudbeaver.server.CBApplication -      Install path: '/opt/cloudbeaver/server'
19-12-2024 07:11:16.942 [main] DEBUG io.cloudbeaver.server.CBApplication -      Global workspace: 'file:/opt/cloudbeaver/workspace/'
19-12-2024 07:11:16.943 [main] DEBUG io.cloudbeaver.server.CBApplication -      Memory available 101Mb/1024Mb
19-12-2024 07:11:16.943 [main] DEBUG io.cloudbeaver.server.CBApplication -      Content root: /opt/cloudbeaver/web
19-12-2024 07:11:16.943 [main] DEBUG io.cloudbeaver.server.CBApplication -      Drivers storage: /opt/cloudbeaver/drivers
19-12-2024 07:11:16.945 [main] DEBUG io.cloudbeaver.server.CBApplication -      Listen port: 8978 on all interfaces
19-12-2024 07:11:16.945 [main] DEBUG io.cloudbeaver.server.CBApplication -      Base URI: /api/
19-12-2024 07:11:16.945 [main] DEBUG io.cloudbeaver.server.CBApplication -      Production mode
19-12-2024 07:11:16.956 [main] DEBUG io.cloudbeaver.server.CBApplication -      Local host addresses:
19-12-2024 07:11:16.956 [main] DEBUG io.cloudbeaver.server.CBApplication -              10.1.136.182 (cloudbeaver-0.cloudbeaver.elkenvn-environment.svc.cluster.local)
19-12-2024 07:11:16.957 [main] DEBUG io.cloudbeaver.server.CBApplication -              0:0:0:0:0:0:0:1%lo (localhost)
19-12-2024 07:11:16.999 [main] DEBUG i.c.s.auth.ReverseProxyConfigurator - Reverse proxy provider disabled, migration not needed
19-12-2024 07:11:17.017 [main] DEBUG i.c.service.security.db.CBDatabase - Initiate management database
19-12-2024 07:11:17.025 [main] DEBUG i.c.service.security.db.CBDatabase -       Initiate connection pool with management database (MySQL; jdbc:mysql://mysql:3306/cloudbeaver)
19-12-2024 07:11:17.284 [main] DEBUG i.c.service.security.db.CBDatabase -       Connected to MySQL 8.0.39
19-12-2024 07:11:17.398 [main] DEBUG i.c.service.security.db.CBDatabase -       Management database connection established
19-12-2024 07:11:17.413 [main] DEBUG io.cloudbeaver.server.CBApplication - Starting Jetty server (8978 on all interfaces)
19-12-2024 07:11:17.722 [main] DEBUG i.c.server.graphql.GraphQLEndpoint - Schema extensions loaded: WebServiceBindingCore,WebServiceBindingNavigator,WebServiceBindingSQL,WebServiceBindingAdmin,WebServiceBindingAuth,WebServiceBindingDataTransfer,WebServiceBindingFS,WebServiceBindingMetadata,WebServiceBindingRM
19-12-2024 07:11:17.988 [main] DEBUG i.c.server.jetty.CBJettyServer - Max http session idle time: 86400s
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer - Active servlets:
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   static: [/]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   images: [/api/images/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   status: [/status]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   graphql: [/api/gql/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   sqlResultValueViewer: [/api/sql-result-value/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   sqlUploadFile: [/api/resultset/blob/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   adminLogs: [/api/logs/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   dataTransfer: [/api/data/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   dataTransferImport: [/api/data/import/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer -   fileSystems: [/api/fs-data/*]
19-12-2024 07:11:17.991 [main] DEBUG i.c.server.jetty.CBJettyServer - Active websocket mappings:
19-12-2024 07:11:17.991 [main] INFO  i.c.server.jetty.CBJettyServer - Refreshing Jetty configuration
19-12-2024 07:11:17.993 [main] INFO  org.eclipse.jetty.server.Server - jetty-12.0.12; built: 2024-07-25T21:58:37.668Z; git: cc6f1b74db755fed228b50701ad967aeaa68e83f; jvm 17.0.13+11
19-12-2024 07:11:18.016 [main] INFO  o.e.j.s.DefaultSessionIdManager - Session workerName=
19-12-2024 07:11:18.029 [main] INFO  o.e.j.server.handler.ContextHandler - Started oeje10s.ServletContextHandler@6480a063{ROOT,/,b=file:///opt/cloudbeaver/web/,a=AVAILABLE,h=oejws.WebSocketUpgradeHandler@2f6f4ac4{STARTED}}
19-12-2024 07:11:18.035 [main] INFO  o.e.j.e.s.ServletContextHandler - Started oeje10s.ServletContextHandler@6480a063{ROOT,/,b=file:///opt/cloudbeaver/web/,a=AVAILABLE,h=oejws.WebSocketUpgradeHandler@2f6f4ac4{STARTED}}
19-12-2024 07:11:18.039 [main] INFO  o.e.jetty.server.AbstractConnector - Started ServerConnector@714bffd5{HTTP/1.1, (http/1.1)}{0.0.0.0:8978}
19-12-2024 07:11:18.041 [main] INFO  org.eclipse.jetty.server.Server - Started oejs.Server@27e21083{STARTING}[12.0.12,sto=0] @2930ms
19-12-2024 07:11:35.754 [qtp2107105388-33] DEBUG i.c.s.session.WebSessionManager - New web session '1xnh1ayaz8grq1w9pc4f6cbk1m0'
19-12-2024 07:11:35.887 [qtp2107105388-36] INFO  i.c.s.w.CBJettyWebSocketManager - Websocket created for session: 1xnh1ayaz8grq1w9pc4f6cbk1m0
19-12-2024 07:11:35.904 [qtp2107105388-36] DEBUG i.c.s.websockets.CBEventsWebSocket - EventWebSocket connected to the 1xnh1ayaz8grq1w9pc4f6cbk1m0 session
19-12-2024 07:11:35.907 [qtp2107105388-32] DEBUG i.c.server.graphql.GraphQLEndpoint - API > serverConfig [user: null, sessionId: null]
19-12-2024 07:11:35.988 [qtp2107105388-35] DEBUG i.c.server.graphql.GraphQLEndpoint - API > openSession [user: null, sessionId: null]
19-12-2024 07:11:36.014 [qtp2107105388-31] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getActiveUser [user: null, sessionId: null]
19-12-2024 07:11:36.058 [qtp2107105388-35] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getProductInfo [user: null, sessionId: null]
19-12-2024 07:11:36.071 [qtp2107105388-31] DEBUG i.c.server.graphql.GraphQLEndpoint - API > getAuthProviders [user: null, sessionId: null]
19-12-2024 07:11:36.133 [qtp2107105388-31] DEBUG i.c.server.graphql.GraphQLEndpoint - API > sessionPermissions [user: null, sessionId: null]
19-12-2024 07:11:36.139 [qtp2107105388-35] DEBUG i.c.model.session.WebSession - Update session lifetime 1xnh1ayaz8grq1w9pc4f6cbk1m0 for user null
19-12-2024 07:11:37.581 [qtp2107105388-31] DEBUG i.c.server.graphql.GraphQLEndpoint - API > authLogin [user: null, sessionId: null]
19-12-2024 07:11:37.595 [qtp2107105388-31] ERROR i.c.service.WebServiceBindingBase - Unexpected error during gql request
io.cloudbeaver.DBWebException: User authentication failed:
Too frequent authentication requests
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:115)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:569)
        at io.cloudbeaver.service.WebServiceBindingBase$ServiceInvocationHandler.invoke(WebServiceBindingBase.java:170)
        at jdk.proxy8/jdk.proxy8.$Proxy14.authLogin(Unknown Source)
        at io.cloudbeaver.service.auth.WebServiceBindingAuth.lambda$0(WebServiceBindingAuth.java:39)
        at graphql.execution.ExecutionStrategy.invokeDataFetcher(ExecutionStrategy.java:533)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:497)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:438)
        at graphql.execution.ExecutionStrategy.resolveFieldWithInfo(ExecutionStrategy.java:397)
        at graphql.execution.ExecutionStrategy.getAsyncFieldValueInfo(ExecutionStrategy.java:335)
        at graphql.execution.AsyncExecutionStrategy.execute(AsyncExecutionStrategy.java:57)
        at graphql.execution.Execution.executeOperation(Execution.java:180)
        at graphql.execution.Execution.execute(Execution.java:116)
        at graphql.GraphQL.execute(GraphQL.java:546)
        at graphql.GraphQL.lambda$parseValidateAndExecute$13(GraphQL.java:476)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.parseValidateAndExecute(GraphQL.java:471)
        at graphql.GraphQL.lambda$executeAsync$9(GraphQL.java:429)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.executeAsync(GraphQL.java:418)
        at graphql.GraphQL.execute(GraphQL.java:359)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeQuery(GraphQLEndpoint.java:262)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeSingleQuery(GraphQLEndpoint.java:203)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.doPost(GraphQLEndpoint.java:186)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:653)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.eclipse.jetty.ee10.servlet.ServletHolder.handle(ServletHolder.java:736)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1614)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$MappedServlet.handle(ServletHandler.java:1547)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.dispatch(ServletChannel.java:824)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.handle(ServletChannel.java:436)
        at org.eclipse.jetty.ee10.servlet.ServletHandler.handle(ServletHandler.java:464)
        at org.eclipse.jetty.ee10.servlet.SessionHandler.handle(SessionHandler.java:703)
        at org.eclipse.jetty.server.Handler$Wrapper.handle(Handler.java:740)
        at org.eclipse.jetty.websocket.server.WebSocketUpgradeHandler.handle(WebSocketUpgradeHandler.java:227)
        at org.eclipse.jetty.server.handler.ContextHandler.handle(ContextHandler.java:1060)
        at org.eclipse.jetty.server.Server.handle(Server.java:181)
        at org.eclipse.jetty.server.internal.HttpChannelState$HandlerInvoker.run(HttpChannelState.java:648)
        at org.eclipse.jetty.server.internal.HttpConnection.onFillable(HttpConnection.java:403)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: org.jkiss.dbeaver.DBException: Too frequent authentication requests
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1659)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1580)
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
        ... 55 common frames omitted
19-12-2024 07:11:37.597 [qtp2107105388-31] DEBUG i.c.server.graphql.GraphQLEndpoint - GraphQL call failed at '/authInfo'
io.cloudbeaver.DBWebException: User authentication failed:
Too frequent authentication requests
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:115)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:569)
        at io.cloudbeaver.service.WebServiceBindingBase$ServiceInvocationHandler.invoke(WebServiceBindingBase.java:170)
        at jdk.proxy8/jdk.proxy8.$Proxy14.authLogin(Unknown Source)
        at io.cloudbeaver.service.auth.WebServiceBindingAuth.lambda$0(WebServiceBindingAuth.java:39)
        at graphql.execution.ExecutionStrategy.invokeDataFetcher(ExecutionStrategy.java:533)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:497)
        at graphql.execution.ExecutionStrategy.fetchField(ExecutionStrategy.java:438)
        at graphql.execution.ExecutionStrategy.resolveFieldWithInfo(ExecutionStrategy.java:397)
        at graphql.execution.ExecutionStrategy.getAsyncFieldValueInfo(ExecutionStrategy.java:335)
        at graphql.execution.AsyncExecutionStrategy.execute(AsyncExecutionStrategy.java:57)
        at graphql.execution.Execution.executeOperation(Execution.java:180)
        at graphql.execution.Execution.execute(Execution.java:116)
        at graphql.GraphQL.execute(GraphQL.java:546)
        at graphql.GraphQL.lambda$parseValidateAndExecute$13(GraphQL.java:476)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.parseValidateAndExecute(GraphQL.java:471)
        at graphql.GraphQL.lambda$executeAsync$9(GraphQL.java:429)
        at java.base/java.util.concurrent.CompletableFuture.uniComposeStage(CompletableFuture.java:1187)
        at java.base/java.util.concurrent.CompletableFuture.thenCompose(CompletableFuture.java:2309)
        at graphql.GraphQL.executeAsync(GraphQL.java:418)
        at graphql.GraphQL.execute(GraphQL.java:359)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeQuery(GraphQLEndpoint.java:262)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.executeSingleQuery(GraphQLEndpoint.java:203)
        at io.cloudbeaver.server.graphql.GraphQLEndpoint.doPost(GraphQLEndpoint.java:186)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:653)
        at jakarta.servlet.http.HttpServlet.service(HttpServlet.java:723)
        at org.eclipse.jetty.ee10.servlet.ServletHolder.handle(ServletHolder.java:736)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$ChainEnd.doFilter(ServletHandler.java:1614)
        at org.eclipse.jetty.ee10.servlet.ServletHandler$MappedServlet.handle(ServletHandler.java:1547)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.dispatch(ServletChannel.java:824)
        at org.eclipse.jetty.ee10.servlet.ServletChannel.handle(ServletChannel.java:436)
        at org.eclipse.jetty.ee10.servlet.ServletHandler.handle(ServletHandler.java:464)
        at org.eclipse.jetty.ee10.servlet.SessionHandler.handle(SessionHandler.java:703)
        at org.eclipse.jetty.server.Handler$Wrapper.handle(Handler.java:740)
        at org.eclipse.jetty.websocket.server.WebSocketUpgradeHandler.handle(WebSocketUpgradeHandler.java:227)
        at org.eclipse.jetty.server.handler.ContextHandler.handle(ContextHandler.java:1060)
        at org.eclipse.jetty.server.Server.handle(Server.java:181)
        at org.eclipse.jetty.server.internal.HttpChannelState$HandlerInvoker.run(HttpChannelState.java:648)
        at org.eclipse.jetty.server.internal.HttpConnection.onFillable(HttpConnection.java:403)
        at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:322)
        at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:99)
        at org.eclipse.jetty.io.SelectableChannelEndPoint$1.run(SelectableChannelEndPoint.java:53)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.runTask(AdaptiveExecutionStrategy.java:478)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.consumeTask(AdaptiveExecutionStrategy.java:441)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.tryProduce(AdaptiveExecutionStrategy.java:293)
        at org.eclipse.jetty.util.thread.strategy.AdaptiveExecutionStrategy.run(AdaptiveExecutionStrategy.java:201)
        at org.eclipse.jetty.util.thread.ReservedThreadExecutor$ReservedThread.run(ReservedThreadExecutor.java:311)
        at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:979)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.doRunJob(QueuedThreadPool.java:1209)
        at org.eclipse.jetty.util.thread.QueuedThreadPool$Runner.run(QueuedThreadPool.java:1164)
        at java.base/java.lang.Thread.run(Thread.java:840)
Caused by: org.jkiss.dbeaver.DBException: Too frequent authentication requests
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkLoginInterval(BruteForceUtils.java:65)
        at io.cloudbeaver.service.security.bruteforce.BruteForceUtils.checkBruteforce(BruteForceUtils.java:40)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.createNewAuthAttempt(CBEmbeddedSecurityController.java:1659)
        at io.cloudbeaver.service.security.CBEmbeddedSecurityController.authenticate(CBEmbeddedSecurityController.java:1580)
        at io.cloudbeaver.service.auth.impl.WebServiceAuthImpl.authLogin(WebServiceAuthImpl.java:92)
        ... 55 common frames omitted

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@DenisSinelnikov DenisSinelnikov

Labels
bug Something isn't working wait for review xf:authentication xf:local config
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
4 participants
@LonwoLonwo @boonhanchng @EvgeniaBzzz @DenisSinelnikov