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

[wekan] MongoDB AuthenticationFailed #20991

Open
2 tasks done
MarvinBeym opened this issue Apr 19, 2024 · 3 comments
Open
2 tasks done

[wekan] MongoDB AuthenticationFailed #20991

MarvinBeym opened this issue Apr 19, 2024 · 3 comments
Labels
bug Something isn't working
Milestone
TrueCharts 2024-Q2

Comments

@MarvinBeym
Copy link

chart Name

wekan

Operating System

TrueNAS SCALE 22.12.4.2 or prior

Deployment Method

TrueNAS SCALE charts

Chart Version

14.19.0

Kubernetes Events

2024-04-19 07:52:27
Back-off restarting failed container wekan in pod wekan-664b9bfc7d-5rpxz_ix-wekan(3dc21a1d-ef2a-43cf-93f7-84dbc846138f)
2024-04-19 07:52:02
Started container wekan
2024-04-19 07:52:01
Created container wekan
2024-04-19 07:51:57
Container image "wekanteam/wekan:v7.43@sha256:9db9f54fa498f5919a309b7d517c3fd18d3fa22c0127c31cbfc1bf48d3697fc6" already present on machine
2024-04-19 07:51:36
Started container wekan-mongodb
2024-04-19 07:51:35
Created container wekan-mongodb
2024-04-19 07:51:34
Container image "bitnami/mongodb:7.0.8@sha256:3163c3842bfd29afdad249416641d7e13fe3801436b5e48756c13ea234d4cd74" already present on machine
2024-04-19 07:51:33
Created container wekan-system-mongodb-wait
2024-04-19 07:51:33
Started container wekan-system-mongodb-wait
2024-04-19 07:51:33
Add eth0 [172.16.0.221/16] from ix-net
2024-04-19 07:51:32
Add eth0 [172.16.0.220/16] from ix-net
2024-04-19 07:51:32
Container image "tccr.io/tccr/db-wait-mongodb:v1.1.0@sha256:9268e23927c4abd9bd031ef62a8a36c58e15361cf3f617906029fa4b6f25c71c" already present on machine
2024-04-19 07:51:32
Scaled up replica set wekan-mongodb-7b595d4c7b to 1
2024-04-19 07:51:32
Created pod: wekan-mongodb-7b595d4c7b-n6vrq
2024-04-19 07:51:32
Successfully assigned ix-wekan/wekan-mongodb-7b595d4c7b-n6vrq to ix-truenas
2024-04-19 07:51:31
Scaled up replica set wekan-664b9bfc7d to 1
2024-04-19 07:51:31
Created pod: wekan-664b9bfc7d-5rpxz
2024-04-19 07:51:31
Successfully assigned ix-wekan/wekan-664b9bfc7d-5rpxz to ix-truenas
2024-04-19 07:51:29
Readiness probe failed: Get "http://172.16.0.219:27017/": dial tcp 172.16.0.219:27017: connect: connection refused
2024-04-19 07:51:28
Scaled down replica set wekan-mongodb-664cc9d475 to 0 from 1
2024-04-19 07:51:28
Deleted pod: wekan-mongodb-664cc9d475-2kk47
2024-04-19 07:51:28
Stopping container wekan-mongodb
2024-04-19 07:51:28
Scaled down replica set wekan-6795d89cc5 to 0 from 1
2024-04-19 07:51:28
Deleted pod: wekan-6795d89cc5-5gdsn
2024-04-19 07:05:57
Back-off restarting failed container wekan in pod wekan-6795d89cc5-5gdsn_ix-wekan(9ff9d764-d8b5-43b8-baaa-34d69b20e182)
2024-04-19 07:05:15
Successfully updated Certificate "wekan-tls-0"

chartlication Logs

024-04-19 08:39:31.017841+02:00/build/programs/server/npm/node_modules/meteor/promise/node_modules/meteor-promise/promise_server.js:218
2024-04-19 08:39:31.017929+02:00throw error;
2024-04-19 08:39:31.017944+02:00^
2024-04-19 08:39:31.017957+02:002024-04-19T08:39:31.017957399+02:00
2024-04-19 08:39:31.017970+02:00MongoServerError: Authentication failed.
2024-04-19 08:39:31.017983+02:00at Connection.onMessage (/build/programs/server/npm/node_modules/meteor/npm-mongo/node_modules/mongodb/lib/cmap/connection.js:231:30)
2024-04-19 08:39:31.018007+02:00at MessageStream.<anonymous> (/build/programs/server/npm/node_modules/meteor/npm-mongo/node_modules/mongodb/lib/cmap/connection.js:61:60)
2024-04-19 08:39:31.018020+02:00at MessageStream.emit (events.js:400:28)
2024-04-19 08:39:31.018033+02:00at processIncomingData (/build/programs/server/npm/node_modules/meteor/npm-mongo/node_modules/mongodb/lib/cmap/message_stream.js:125:16)
2024-04-19 08:39:31.018052+02:00at MessageStream._write (/build/programs/server/npm/node_modules/meteor/npm-mongo/node_modules/mongodb/lib/cmap/message_stream.js:33:9)
2024-04-19 08:39:31.018065+02:00at writeOrBuffer (internal/streams/writable.js:358:12)
2024-04-19 08:39:31.018078+02:00at MessageStream.Writable.write (internal/streams/writable.js:303:10)
2024-04-19 08:39:31.018091+02:00at Socket.ondata (internal/streams/readable.js:731:22)
2024-04-19 08:39:31.018111+02:00at Socket.emit (events.js:400:28)
2024-04-19 08:39:31.018158+02:00at addChunk (internal/streams/readable.js:293:12)
2024-04-19 08:39:31.018171+02:00at readableAddChunk (internal/streams/readable.js:267:9)
2024-04-19 08:39:31.018184+02:00at Socket.Readable.push (internal/streams/readable.js:206:10)
2024-04-19 08:39:31.018197+02:00at TCP.onStreamRead (internal/stream_base_commons.js:188:23)
2024-04-19 08:39:31.018217+02:00=> awaited here:
2024-04-19 08:39:31.018232+02:00at Function.Promise.await (/build/programs/server/npm/node_modules/meteor/promise/node_modules/meteor-promise/promise_server.js:56:12)
2024-04-19 08:39:31.018245+02:00at new MongoConnection (packages/mongo/mongo_driver.js:213:11)
2024-04-19 08:39:31.018257+02:00at new MongoInternals.RemoteCollectionDriver (packages/mongo/remote_collection_driver.js:9:16)
2024-04-19 08:39:31.018276+02:00at Object.<anonymous> (packages/mongo/remote_collection_driver.js:66:18)
2024-04-19 08:39:31.018288+02:00at Object.defaultRemoteCollectionDriver (packages/underscore.js:784:19)
2024-04-19 08:39:31.018300+02:00at new Collection (packages/mongo/collection.js:124:40)
2024-04-19 08:39:31.018312+02:00at packages/idmontie_migrations.js:38:15
2024-04-19 08:39:31.018325+02:00at packages/idmontie_migrations.js:255:4
2024-04-19 08:39:31.018345+02:00at packages/idmontie_migrations.js:263:3
2024-04-19 08:39:31.018360+02:00at /build/programs/server/boot.js:385:38
2024-04-19 08:39:31.018372+02:00at Array.forEach (<anonymous>)
2024-04-19 08:39:31.018385+02:00at /build/programs/server/boot.js:210:21
2024-04-19 08:39:31.018397+02:00at /build/programs/server/boot.js:439:7
2024-04-19 08:39:31.018410+02:00at Function.run (/build/programs/server/profile.js:256:14)
2024-04-19 08:39:31.018431+02:00at /build/programs/server/boot.js:438:13 {
2024-04-19 08:39:31.018444+02:00ok: 0,
2024-04-19 08:39:31.018457+02:00code: 18,
2024-04-19 08:39:31.018470+02:00codeName: 'AuthenticationFailed',
2024-04-19 08:39:31.018483+02:00connectionGeneration: 0,
2024-04-19 08:39:31.018495+02:00[Symbol(errorLabels)]: Set(2) { 'HandshakeError', 'ResetPool' }

---

2024-04-19T08:29:43.816200261+02:00 {"t":{"$date":"2024-04-19T06:29:43.816+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn487","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:55322","connectionId":487}}
2024-04-19T08:29:43.816286343+02:00 {"t":{"$date":"2024-04-19T06:29:43.816+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn487","msg":"Connection ended","attr":{"remote":"172.16.0.1:55322","uuid":{"uuid":{"$uuid":"42c7b7fa-463e-4d80-b647-62fc6da79434"}},"connectionId":487,"connectionCount":1}}
2024-04-19T08:29:43.816312702+02:00 {"t":{"$date":"2024-04-19T06:29:43.816+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn488","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:55324","connectionId":488}}
2024-04-19T08:29:43.816409423+02:00 {"t":{"$date":"2024-04-19T06:29:43.816+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn488","msg":"Connection ended","attr":{"remote":"172.16.0.1:55324","uuid":{"uuid":{"$uuid":"f585b243-710a-4acf-875f-2ca8fbfceafa"}},"connectionId":488,"connectionCount":0}}
2024-04-19T08:29:53.816414227+02:00 {"t":{"$date":"2024-04-19T06:29:53.816+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.16.0.1:54068","uuid":{"uuid":{"$uuid":"eb96efae-d456-44e5-8ef1-84852e1c3a6f"}},"connectionId":489,"connectionCount":1}}
2024-04-19T08:29:53.816533812+02:00 {"t":{"$date":"2024-04-19T06:29:53.816+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.16.0.1:54070","uuid":{"uuid":{"$uuid":"a6eea0aa-49c0-49da-a541-64f33f189510"}},"connectionId":490,"connectionCount":2}}
2024-04-19T08:29:53.816700604+02:00 {"t":{"$date":"2024-04-19T06:29:53.816+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn489","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:54068","connectionId":489}}
2024-04-19T08:29:53.816809508+02:00 {"t":{"$date":"2024-04-19T06:29:53.816+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn489","msg":"Connection ended","attr":{"remote":"172.16.0.1:54068","uuid":{"uuid":{"$uuid":"eb96efae-d456-44e5-8ef1-84852e1c3a6f"}},"connectionId":489,"connectionCount":1}}
2024-04-19T08:29:53.816860594+02:00 {"t":{"$date":"2024-04-19T06:29:53.816+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn490","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:54070","connectionId":490}}
2024-04-19T08:29:53.816922169+02:00 {"t":{"$date":"2024-04-19T06:29:53.816+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn490","msg":"Connection ended","attr":{"remote":"172.16.0.1:54070","uuid":{"uuid":{"$uuid":"a6eea0aa-49c0-49da-a541-64f33f189510"}},"connectionId":490,"connectionCount":0}}
2024-04-19T08:30:03.815492635+02:00 {"t":{"$date":"2024-04-19T06:30:03.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.16.0.1:53180","uuid":{"uuid":{"$uuid":"fb7fdfd2-31c2-42e6-9efb-7d5c48e7d424"}},"connectionId":491,"connectionCount":1}}
2024-04-19T08:30:03.815598764+02:00 {"t":{"$date":"2024-04-19T06:30:03.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.16.0.1:53186","uuid":{"uuid":{"$uuid":"897fdc24-0362-4deb-a245-22d4ef4f3a1e"}},"connectionId":492,"connectionCount":2}}
2024-04-19T08:30:03.815751440+02:00 {"t":{"$date":"2024-04-19T06:30:03.815+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn491","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:53180","connectionId":491}}
2024-04-19T08:30:03.815826561+02:00 {"t":{"$date":"2024-04-19T06:30:03.815+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn492","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:53186","connectionId":492}}
2024-04-19T08:30:03.815856467+02:00 {"t":{"$date":"2024-04-19T06:30:03.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn491","msg":"Connection ended","attr":{"remote":"172.16.0.1:53180","uuid":{"uuid":{"$uuid":"fb7fdfd2-31c2-42e6-9efb-7d5c48e7d424"}},"connectionId":491,"connectionCount":1}}
2024-04-19T08:30:03.815933291+02:00 {"t":{"$date":"2024-04-19T06:30:03.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn492","msg":"Connection ended","attr":{"remote":"172.16.0.1:53186","uuid":{"uuid":{"$uuid":"897fdc24-0362-4deb-a245-22d4ef4f3a1e"}},"connectionId":492,"connectionCount":0}}
2024-04-19T08:30:13.815637348+02:00 {"t":{"$date":"2024-04-19T06:30:13.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.16.0.1:34562","uuid":{"uuid":{"$uuid":"3d56fc1e-e9fd-4052-a4f6-1106c7053542"}},"connectionId":493,"connectionCount":1}}
2024-04-19T08:30:13.815756441+02:00 {"t":{"$date":"2024-04-19T06:30:13.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22943,   "ctx":"listener","msg":"Connection accepted","attr":{"remote":"172.16.0.1:34560","uuid":{"uuid":{"$uuid":"0a15ff94-3f8b-46b6-afb8-17ff0a2674de"}},"connectionId":494,"connectionCount":2}}
2024-04-19T08:30:13.815883820+02:00 {"t":{"$date":"2024-04-19T06:30:13.815+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn493","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:34562","connectionId":493}}
2024-04-19T08:30:13.815984168+02:00 {"t":{"$date":"2024-04-19T06:30:13.815+00:00"},"s":"I",  "c":"NETWORK",  "id":22944,   "ctx":"conn493","msg":"Connection ended","attr":{"remote":"172.16.0.1:34562","uuid":{"uuid":{"$uuid":"3d56fc1e-e9fd-4052-a4f6-1106c7053542"}},"connectionId":493,"connectionCount":1}}
2024-04-19T08:30:13.816059789+02:00 {"t":{"$date":"2024-04-19T06:30:13.815+00:00"},"s":"I",  "c":"EXECUTOR", "id":22988,   "ctx":"conn494","msg":"Error receiving request from client. Ending connection from remote","attr":{"error":{"code":17,"codeName":"ProtocolError","errmsg":"Client sent an HTTP request over a native MongoDB connection"},"remote":"172.16.0.1:34560","connectionId":494}}

Chart Configuration

1
2
3
4
5
6
7
8
9
10

Describe the bug

After updating the wekan app from 14.15.11 to 14.19.0 the app fails to deploy with an error from mongo db "AuthenticationFailed".

Edit & Save without changes does not resolve the issue

To Reproduce

  1. Update wekan app to latest available version (14.19.0)
  2. Wait for update to be finished
  3. App will not come out of deploying
  4. Editing & saving without changes does not resolve the issue
  5. Error can be found in the "main" wekan pod

Expected Behavior

App should deploy without MongoDB auth error and be accessible

Screenshots

Additional Context

I've read and agree with the following

  • I've checked all open and closed issues and my issue is not there.
  • I've prefixed my issue title with [Chart-Name]
@MarvinBeym MarvinBeym added the bug Something isn't working label Apr 19, 2024
@MarvinBeym MarvinBeym changed the title [wekan] - MongoDB AuthenticationFailed [wekan] MongoDB AuthenticationFailed Apr 19, 2024
@Ornias1993
Copy link
Member

Confirmed

@Ornias1993 Ornias1993 added this to the TrueCharts 2024-Q2 milestone Apr 19, 2024
@David-bfg
Copy link

I've experienced what seems to be the same issue with the base Mongodb chart. In general any connection attempt is responded with MongoServerError: Authentication failed. Not sure when this changed but noticed Mongodb is now in stable train instead of dependency.

The logs on a clean install seem to cycle through this on it's own without actually attempting to connect

Connection accepted
Error receiving request from client. Ending connection from remote
Connection ended

Same as is shown in the bottom of the chartlication Logs on the initial bug report.

Possible root cause of this issue being a general broken Mongodb chart.
Appreciate if someone could note if "Yes same bug/root cause" or "Deserves own bug report"
Thanks.

@Ornias1993
Copy link
Member

Appreciate if someone could note if "Yes same bug/root cause" or "Deserves own bug report"

Without spending time on this issue (yet) there is no way to tell.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees
No one assigned
Labels
bug Something isn't working
Projects
None yet
Milestone
TrueCharts 2024-Q2
Development

No branches or pull requests
3 participants
@David-bfg @Ornias1993 @MarvinBeym