8000 Error 500: Unable to Verify a user · Issue #720 · girlbossceo/conduwuit · GitHub
[go: up one dir, main page]
More Web Proxy on the site http://driver.im/
Skip to content
This repository was archived by the owner on Apr 11, 2025. It is now read-only.

Error 500: Unable to Verify a user #720

Open
tajinder400 opened this issue Mar 24, 2025 · 8 comments
Open

Error 500: Unable to Verify a user #720

tajinder400 opened this issue Mar 24, 2025 · 8 comments
Labels
bug Something isn't working

Comments

@tajinder400
Copy link

Hi,

When trying to validate a user in a private chat on another server, I'm unable to verify them. We're able to do the emoji verification process, where they eventually end up with me being verified. But they never end being verified for me.

I have tried this both on the Element Desktop app, and Element Web application.

The log output of the system gives:

` 2025-03-24T12:29:25.531038Z ERROR conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(2)

2025-03-24T12:29:25.531067Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 0 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(2)

2025-03-24T12:29:27.581532Z ERROR 8000 conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(4)

2025-03-24T12:29:27.581610Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 0 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(4)

2025-03-24T12:29:31.593249Z ERROR conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(4)

2025-03-24T12:29:31.593444Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 0 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(4)`

I originally tested this on: v0.5.0-rc3-b6e9dc3d98704c56027219d3775336910a0136c6
I have now tested this on: main-7bf92c8a3710eeff229bd86bc81a89daa94b66d5-haswell

Both giving the same result. I am verified on their end, I'm unable to be verified on my end.
My configuration: https://github.com/tajinder400/home-ops/blob/main/kubernetes/apps/communication/conduwuit/app/helmrelease.yaml
@tajinder400
Copy link
Author

To add to this, sending/recieving media works fine. Messages work absolutely fine also

@girlbossceo
Copy link
Owner

Are you able to run a debug build and see if you can find any debug logs related that would help identify the issue more clearly?

@tajinder400
Copy link
Author

Are you able to run a debug build and see if you can find any debug logs related that would help identify the issue more clearly?

Tested again with this image: main-7bf92c8a3710eeff229bd86bc81a89daa94b66d5-debug

Logs:

` 2025-03-24T13:15:55.961403Z ERROR conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(5)
in conduwuit_router::request::request
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:15:55.961483Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=0 ms status=500
2025-03-24T13:15:55.961530Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 0 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(5)
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:15:56.366699Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/rooms/:room_id/receipt/:receipt_type}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:15:56.366701Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/rooms}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:15:56.372946Z DEBUG router{method=POST path=/_matrix/client/v3/rooms/:room_id/receipt/:receipt_type}:request:handle{active=1 handled=171}: conduwuit_api::router::args: POST /_matrix/client/v3/rooms/!lVgvK4FulWsnT96KGa%3Asourcedomain.io/receipt/m.read/%249ktF3s74PX-GnlSgPFKFN6ZZ03IJuGSAfcO1fJJ1WOg {"host": "matrix.sourcedomain.io", "x-request-id": "450bcb1ee55f2c89cd5de3dcd919cc84", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "content-length": "20", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "content-type": "application/json", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:15:56.373100Z DEBUG router{method=POST path=/_matrix/client/v3/rooms}:request:handle{active=2 handled=171}: conduwuit_api::router::args: POST /_matrix/client/v3/rooms/!lVgvK4FulWsnT96KGa%3Asourcedomain.io/read_markers {"host": "matrix.sourcedomain.io", "x-request-id": "295948c259342b6e99a0f7f157ac3354", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "content-length": "63", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "content-type": "application/json", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:15:56.375132Z DEBUG router{method=POST path=/_matrix/client/v3/rooms}: tower_http::trace::on_response: finished processing request latency=2 ms status=200
2025-03-24T13:15:56.377010Z DEBUG router{method=POST path=/_matrix/client/v3/rooms/:room_id/receipt/:receipt_type}: tower_http::trace::on_response: finished processing request latency=5 ms status=200
2025-03-24T13:15:56.387743Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}: conduwuit_service::federation::execute: Sending request method=PUT url=Url { scheme: "https", cannot_be_a_base: false, username: "", password: None, host: Some(Domain("matrix.destination.io")), port: Some(8448), path: "/_matrix/federation/v1/send/KmSDlQbyTOT6WIoCsTzySk9jY5xplWbd6LUgbLUXlyM", query: None, fragment: None }
2025-03-24T13:15:56.388983Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}: hyper_util::client::legacy::pool: reuse idle connection for ("https", matrix.destination.io:8448)
2025-03-24T13:15:56.389833Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::codec::framed_write: send frame=Headers { stream_id: StreamId(35), flags: (0x4: END_HEADERS) }
2025-03-24T13:15:56.390287Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::codec::framed_write: send frame=Data { stream_id: StreamId(35), flags: (0x1: END_STREAM) }
2025-03-24T13:15:56.400682Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::codec::framed_read: received frame=WindowUpdate { stream_id: StreamId(35), size_increment: 2147418111 }
2025-03-24T13:15:56.402591Z DEBUG router{method=GET path=/_matrix/client/v3/sync}: tower_http::trace::on_response: finished processing request latency=448 ms status=200
2025-03-24T13:15:56.411765Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::codec::framed_read: received frame=Headers { stream_id: StreamId(35), flags: (0x4: END_HEADERS) }
2025-03-24T13:15:56.412001Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::codec::framed_read: received frame=Data { stream_id: StreamId(35), flags: (0x1: END_STREAM) }
2025-03-24T13:15:56.412563Z DEBUG sender{id=0}:fed{dest="matrix.destination.io"}: conduwuit_service::federation::execute: Got 200 for PUT https://matrix.destination.io:8448/_matrix/federation/v1/send/KmSDlQbyTOT6WIoCsTzySk9jY5xplWbd6LUgbLUXlyM
2025-03-24T13:15:56.417813Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/sync}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:15:56.423857Z DEBUG router{method=GET path=/_matrix/client/v3/sync}:request:handle{active=0 handled=175}: conduwuit_api::router::args: GET /_matrix/client/v3/sync?filter=xS8v&timeout=30000&org.matrix.msc4222.use_state_after=true&set_presence=online&since=5368 {"host": "matrix.sourcedomain.io", "x-request-id": "682f0b899a29e3b7255e330733fd55c1", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:15:57.975827Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:15:57.983949Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}:request:handle{active=1 handled=176}: conduwuit_api::router::args: POST /_matrix/client/v3/keys/signatures/upload {"host": "matrix.sourcedomain.io", "x-request-id": "3174d49f2d39eed46333ce65f194dae6", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "content-length": "422", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537 8000 .36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "content-type": "application/json", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:15:57.985007Z ERROR conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(3)
in conduwuit_router::request::request
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:15:57.985261Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=2 ms status=500
2025-03-24T13:15:57.985326Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 2 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(3)
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:15:58.427048Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=177}: conduwuit_api::router::args: PUT /_matrix/federation/v1/send/1742818853469 {"host": "matrix.sourcedomain.io", "x-request-id": "9f81264e5446ffa8b06ee163a615e7ac", "x-real-ip": "79.72.84.56", "x-forwarded-for": "79.72.84.56", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "x-original-forwarded-for": "79.72.84.56", "content-length": "303", "user-agent": "Synapse/1.126.0", "accept-encoding": "gzip, br", "authorization": Sensitive, "cdn-loop": "cloudflare; loops=1", "cf-connecting-ip": "79.72.84.56", "cf-ipcountry": "GB", "cf-ray": "925670b9f96d94bb-LHR", "cf-visitor": "{"scheme":"https"}", "cf-warp-tag-id": "272edfe2-5f3d-4067-8ae5-b5e06a6e6c02", "content-type": "application/json"}
2025-03-24T13:15:58.430836Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=177}:txn{client=79.72.84.56 origin="matrix.destination.io"}: conduwuit_api::server::send: Finished txn pdus=0 edus=1 elapsed=3.384061ms id="1742818853469" origin="matrix.destination.io"
2025-03-24T13:15:58.431442Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}: tower_http::trace::on_response: finished processing request latency=17 ms status=200
2025-03-24T13:15:58.450174Z DEBUG router{method=GET path=/_matrix/client/v3/sync}: tower_http::trace::on_response: finished processing request latency=2027 ms status=200
2025-03-24T13:15:58.463845Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/sync}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:15:58.468678Z DEBUG router{method=GET path=/_matrix/client/v3/sync}:request:handle{active=0 handled=180}: conduwuit_api::router::args: GET /_matrix/client/v3/sync?filter=xS8v&timeout=30000&org.matrix.msc4222.use_state_after=true&set_presence=online&since=5369 {"host": "matrix.sourcedomain.io", "x-request-id": "0f8f8a21f86d80fcf1d75e8e648c02f8", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:16:02.209485Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:16:02.219178Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}:request:handle{active=1 handled=181}: conduwuit_api::router::args: POST /_matrix/client/v3/keys/signatures/upload {"host": "matrix.sourcedomain.io", "x-request-id": "bbb4ee56f8957055425c1ce38de05ca0", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "content-length": "422", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "content-type": "application/json", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:16:02.220069Z ERROR conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(6)
in conduwuit_router::request::request
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:16:02.220302Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=2 ms status=500
2025-03-24T13:16:02.220366Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 2 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(6)
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:16:11.205774Z DEBUG router{method=OPTIONS path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=0 ms status=200
2025-03-24T13:16:11.212380Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}:request:handle{active=1 handled=183}: conduwuit_api::router::args: POST /_matrix/client/v3/keys/signatures/upload {"host": "matrix.sourcedomain.io", "x-request-id": "ef485bf3239beddfceb84b326dc255a8", "x-real-ip": "10.0.10.29", "x-forwarded-for": "10.0.10.29", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "content-length": "422", "cache-control": "max-age=0", "sec-ch-ua-platform": ""macOS"", "authorization": Sensitive, "user-agent": "Mozilla/5.0 (Macintosh; Intel Mac OS X 10_15_7) AppleWebKit/537.36 (KHTML, like Gecko) Element/1.11.95 Chrome/132.0.6834.196 Electron/34.2.0 Safari/537.36", "accept": "application/json", "sec-ch-ua": ""Not A(Brand";v="8", "Chromium";v="132"", "content-type": "application/json", "sec-ch-ua-mobile": "?0", "origin": "vector://vector", "sec-fetch-site": "cross-site", "sec-fetch-mode": "cors", "sec-fetch-dest": "empty", "accept-encoding": "gzip, deflate, br, zstd", "accept-language": "en-GB", "priority": "u=1, i"}
2025-03-24T13:16:11.212689Z ERROR conduwuit_router::request: 500 Internal Server Error, method: POST, uri: /_matrix/client/v3/keys/signatures/upload
at src/router/request.rs:105 on conduwuit:worker ThreadId(6)
in conduwuit_router::request::request
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:16:11.212753Z DEBUG router{method=POST path=/_matrix/client/v3/keys/signatures/upload}: tower_http::trace::on_response: finished processing request latency=0 ms status=500
2025-03-24T13:16:11.212819Z ERROR tower_http::trace::on_failure: response failed, classification: Status code: 500 Internal Server Error, latency: 0 ms
at /nix/store/eeeeeeeeeeeeeeeeeeeeeeeeeeeeeeee-vendor-cargo-deps/c19b7c6f923b580ac259164a89f2577984ad5ab09ee9d583b888f934adbbe8d0/tower-http-0.6.2/src/trace/on_failure.rs:93 on conduwuit:worker ThreadId(6)
in conduwuit_router::layers::router with method=POST path=/_matrix/client/v3/keys/signatures/upload

2025-03-24T13:16:12.714414Z DEBUG router{method=POST path=/_matrix/client/v3/keys/query}:request:handle{active=3 handled=73}:request:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::codec::framed_write: send frame=GoAway { error_code: NO_ERROR, last_stream_id: StreamId(0) }
2025-03-24T13:16:12.714576Z DEBUG router{method=POST path=/_matrix/client/v3/keys/query}:request:handle{active=3 handled=73}:request:fed{dest="matrix.destination.io"}:Connection{peer=Client}: h2::proto::connection: Connection::poll; connection error error=GoAway(b"", NO_ERROR, Library)
2025-03-24T13:16:25.148151Z DEBUG router{method=PUT path=/_matrix/federation/v1/send}:request:handle{active=1 handled=184}: conduwuit_api::router::args: PUT /_matrix/federation/v1/send/1742818853470 {"host": "matrix.sourcedomain.io", "x-request-id": "0fd4a1a2f70d1f976e7e32a7d9caba1c", "x-real-ip": "79.72.84.56", "x-forwarded-for": "79.72.84.56", "x-forwarded-host": "matrix.sourcedomain.io", "x-forwarded-port": "443", "x-forwarded-proto": "https", "x-forwarded-scheme": "https", "x-scheme": "https", "x-original-forwarded-for": "79.72.84.56", "content-length": "213", "user-agent": "Synapse/1.126.0", "accept-encoding": "gzip, br", "authorization": Sensitive, "cdn-loop": "cloudflare; loops=1", "cf-connecting-ip": "79.72.84.56", "cf-ipcountry": "GB", "cf-ray": "92567160fd9e94bb-LHR", "cf-visitor": "{"scheme":"https"}", "cf-warp-tag-id": "272edfe2-5f3d-4067-8ae5-b5e06a6e6c02", "content-type": "application/json"}`

Obfsucated source and destination domain. But hopefully this is of some help? I'll keep the container running for now so It keeps generating logs like this.

@girlbossceo
Copy link
Owner

This doesn't show any real error messages. I think I see a few places of where this error is coming from, but this is unfortunately legacy / potentially broken code we still haven't refactored from upstream yet.

Are you able to grep for keyid_key for any entries?
And are you able to provide the request JSON body of the /_matrix/client/v3/keys/signatures/upload request that errors?

@tajinder400
Copy link
Author

conduwuit-logs.log

I can't find the keyid_key in these logs. Nor am I able to descern what exactly you'd be looking for in relation to that path. As far as I can tell, what you're asking for doesn't really exist. Perhaps I need to also change the RUST_LOG env settings to debug also?

@girlbossceo
Copy link
Owner

I added some extended debug logging in this area, are you able to run a debug build and get debug and warn logs if this issue still happens? I also tried adjusting the logic to not fail the request entirely and just skip over malformed keys.

@tajinder400
Copy link
Author

I added some extended debug logging in this area, are you able to run a debug build and get debug and warn logs if this issue still happens? I also tried adjusting the logic to not fail the request entirely and just skip over malformed keys.

Tested again with: main-00f7745ec4ebcea5f892376c5de5db1299f71696-debug

Seem to get the same results. I have attached logs of this. I can at a glance see some warning in here. Hope this if of some help.

conduwuit-logs.log

@girlbossceo
Copy link
Owner

Okay I was able to get the logs of what I want now to know where this specific problem is coming from:

�[2m2025-04-04T15:30:54.695700Z�[0m �[33m WARN�[0m �[1mrouter�[0m�[1m{�[0m�[3mmethod�[0m�[2m=�[0mPOST �[3mpath�[0m�[2m=�[0m/_matrix/client/v3/keys/signatures/upload�[1m}�[0m�[2m:�[0m�[1mrequest�[0m�[2m:�[0m�[1mhandle�[0m�[1m{�[0m�[3mactive�[0m�[2m=�[0m0 �[3mhandled�[0m�[2m=�[0m313�[1m}�[0m�[2m:�[0m �[2mconduwuit_service::users�[0m�[2m:�[0m key in keyid_key has no signatures field
�[2m2025-04-04T15:30:54.695744Z�[0m �[33m WARN�[0m �[1mrouter�[0m�[1m{�[0m�[3mmethod�[0m�[2m=�[0mPOST �[3mpath�[0m�[2m=�[0m/_matrix/client/v3/keys/signatures/upload�[1m}�[0m�[2m:�[0m�[1mrequest�[0m�[2m:�[0m�[1mhandle�[0m�[1m{�[0m�[3mactive�[0m�[2m=�[0m0 �[3mhandled�[0m�[2m=�[0m313�[1m}�[0m�[2m:�[0m �[2mconduwuit_api::client::keys�[0m�[2m:�[0m key in keyid_key has no signatures field

It seems like somehow, possibly because the lack of checks previously that were recently added in the last few weeks, malformed keys were uploaded then stored in the database. I think I can just add some kind of transparent "migration" that will just delete any malformed keys in the database and then the client can just happily re-upload them again. I'll let you know if I have something to test again.

@girlbossceo girlbossceo added the bug Something isn't working label Apr 4, 2025
@OptimoSupreme OptimoSupreme mentioned this issue Apr 7, 2025
Closed
Sign up for free to subscribe to this con 45C0 versation on GitHub. Already have an account? Sign in.
Assignees
No one assigned
Labels
bug Something isn't working
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
2 participants
@tajinder400 @girlbossceo
0