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

🐛 Bug Report: Upload fails with ZIP or bulk files #750

Closed
sfreek76 opened this issue Jan 16, 2025 · 7 comments
Closed

🐛 Bug Report: Upload fails with ZIP or bulk files #750

sfreek76 opened this issue Jan 16, 2025 · 7 comments
Labels
bug Something isn't working

Comments

@sfreek76
Copy link

sfreek76 commented Jan 16, 2025 •
edited
Loading

👟 Reproduction steps

I'm on MacOS Monterey with latest Docker Desktop.

When I try to upload multiple large files (e.g. biggest around 400MB) or a ZIP, Pingvin throws an error. If I upload 1 large file it usually works.

👍 Expected behavior

It should upload multiple large files and ZIP-Files without error.

👎 Actual Behavior

Pingvin throws an error and gets unresponsive, if I try to refresh the page I get an "internal Server error" and I have to restart the Docker Container with Pingvin.

📜 Logs

level=errorts=1737043143.8860402logger=http.log.errormsg=dial tcp [::1]:8080: connect: connection refusedrequest.client_ip=172.22.0.1request.headers.Accept=["application/json, text/plain, /"]request.headers.Accept-Encoding=["gzip, deflate, br, zstd"]request.headers.Accept-Language=["de,en-US;q=0.7,en;q=0.3"]request.headers.Connection=["close"]request.headers.Content-Length=["454674112"]request.headers.Content-Type=["application/octet-stream"]request.headers.Cookie=["REDACTED"]request.headers.Dnt=["1"]request.headers.Origin=["https://mydomain.com"]request.headers.Referer=["https://mydomain.com/upload"]request.headers.Sec-Fetch-Dest=["empty"]request.headers.Sec-Fetch-Mode=["cors"]request.headers.Sec-Fetch-Site=["same-origin"]request.headers.Sec-Gpc=["1"]request.headers.User-Agent=["Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:134.0) Gecko/20100101 Firefox/134.0"]request.headers.X-Forwarded-For=["myIP"]request.headers.X-Forwarded-Proto=["https"]request.headers.X-Real-Ip=["myIP"]request.host=mydomain.comrequest.method=POSTrequest.proto=HTTP/1.1request.remote_ip=172.22.0.1request.remote_port=64610request.uri=/api/shares/sr0vOnzu/files?name=Extraordinary+-+S02E01+-+The+Void.mkv&chunkIndex=0&totalChunks=1duration=0.002192416status=502err_id=5eir3ge5eerr_trace=reverseproxy.statusError (reverseproxy.go:1269)
@sfreek76 sfreek76 added the bug Something isn't working label Jan 16, 2025
@stonith404
Copy link
Owner

Could you share the full logs please?

@sfreek76
Copy link
Author

Hello @stonith404 Many thanks for your fast response!

I'm not sure what you mean exactly, this is all the log I got from the Pingvin-Container in Docker (sorry, log was to big to paste here:

pingvin-logs.pdf

Many thanks for your efforts!

@stonith404
Copy link
Owner

Thanks for providing the logs. It's a bit hard to find the error in this lengthy log file.

Could you remove the container, start it again, trigger the error and then share the full logs?
You can remove and start the container with

docker compose down && docker compose up -d

@sfreek76
Copy link
Author

sfreek76 commented Jan 16, 2025 •
edited
Loading

Sorry for the long logs, here's the fresh one with the error:

2025-01-16 19:05:10 pingvin-share-1  | Creating user and group...
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6676586,"msg":"using config from file","file":"/opt/app/reverse-proxy/Caddyfile.trust-proxy"}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6683013,"msg":"adapted config to JSON","adapter":"caddyfile"}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6687074,"logger":"admin","msg":"admin endpoint started","address":"localhost:2019","enforce_origin":false,"origins":["//localhost:2019","//[::1]:2019","//127.0.0.1:2019"]}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6689565,"logger":"tls.cache.maintenance","msg":"started background certificate maintenance","cache":"0x400004f400"}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6690419,"logger":"http.log","msg":"server running","name":"srv0","protocols":["h1","h2","h3"]}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.669124,"msg":"autosaved config (load with --resume flag)","file":"/home/pingvin-share/.config/caddy/autosave.json"}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6691275,"msg":"serving initial configuration"}
2025-01-16 19:05:10 pingvin-share-1  | Successfully started Caddy (pid=42) - Caddy is running in the background
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6701741,"logger":"tls","msg":"cleaning storage unit","storage":"FileStorage:/home/pingvin-share/.local/share/caddy"}
2025-01-16 19:05:10 pingvin-share-1  | {"level":"info","ts":1737050710.6702867,"logger":"tls","msg":"finished cleaning storage units"}
2025-01-16 19:05:10 pingvin-share-1  |   ▲ Next.js 14.2.20
2025-01-16 19:05:10 pingvin-share-1  |   - Local:        http://localhost:3333
2025-01-16 19:05:10 pingvin-share-1  |   - Network:      http://0.0.0.0:3333
2025-01-16 19:05:10 pingvin-share-1  | 
2025-01-16 19:05:10 pingvin-share-1  |  ✓ Starting...
2025-01-16 19:05:10 pingvin-share-1  | 
2025-01-16 19:05:10 pingvin-share-1  | > [email protected] prod
2025-01-16 19:05:10 pingvin-share-1  | > prisma migrate deploy && prisma db seed && node dist/src/main
2025-01-16 19:05:10 pingvin-share-1  | 
2025-01-16 19:05:11 pingvin-share-1  |  ✓ Ready in 368ms
2025-01-16 19:05:11 pingvin-share-1  | Environment variables loaded from prisma/.env
2025-01-16 19:05:11 pingvin-share-1  | Prisma schema loaded from prisma/schema.prisma
2025-01-16 19:05:11 pingvin-share-1  | Datasource "db": SQLite database "pingvin-share.db" at "file:../data/pingvin-share.db"
2025-01-16 19:05:11 pingvin-share-1  | 
2025-01-16 19:05:11 pingvin-share-1  | 24 migrations found in prisma/migrations
2025-01-16 19:05:11 pingvin-share-1  | 
2025-01-16 19:05:11 pingvin-share-1  | 
2025-01-16 19:05:11 pingvin-share-1  | No pending migrations to apply.
2025-01-16 19:05:11 pingvin-share-1  | Environment variables loaded from prisma/.env
2025-01-16 19:05:11 pingvin-share-1  | Running seed command `ts-node prisma/seed/config.seed.ts` ...
2025-01-16 19:05:12 pingvin-share-1  | 
2025-01-16 19:05:12 pingvin-share-1  | 🌱  The seed command has been executed.
2025-01-16 19:05:12 pingvin-share-1  | ┌─────────────────────────────────────────────────────────┐
2025-01-16 19:05:12 pingvin-share-1  | │  Update available 5.19.1 -> 6.2.1                       │
2025-01-16 19:05:12 pingvin-share-1  | │                                                         │
2025-01-16 19:05:12 pingvin-share-1  | │  This is a major update - please follow the guide at    │
2025-01-16 19:05:12 pingvin-share-1  | │  https://pris.ly/d/major-version-upgrade                │
2025-01-16 19:05:12 pingvin-share-1  | │                                                         │
2025-01-16 19:05:12 pingvin-share-1  | │  Run the following to update                            │
2025-01-16 19:05:12 pingvin-share-1  | │    npm i --save-dev prisma@latest                       │
2025-01-16 19:05:12 pingvin-share-1  | │    npm i @prisma/client@latest                          │
2025-01-16 19:05:12 pingvin-share-1  | └─────────────────────────────────────────────────────────┘
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG Showing log, warn, error, fatal messages
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [NestFactory] Starting Nest application... +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] PrismaModule dependencies initialized +25ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] JwtModule dependencies initialized +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] JwtModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] ThrottlerModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] DiscoveryModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] CacheModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] ScheduleModule dependencies initialized +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] AppModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [PrismaService] Connected to the database
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] EmailModule dependencies initialized +3ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] ClamScanModule dependencies initialized +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] ConfigModule dependencies initialized +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] JobsModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] ReverseShareModule dependencies initialized +2ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] FileModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] UserModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] OAuthModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] AuthModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [InstanceLoader] ShareModule dependencies initialized +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] AppController {/api}: +9ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/health, GET} route +3ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] AuthController {/api/auth}: +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/signUp, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/signIn, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/signIn/totp, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/resetPassword/:email, POST} route +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/resetPassword, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/password, PATCH} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/token, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/signOut, POST} route +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/totp/enable, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/totp/verify, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/auth/totp/disable, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] OAuthController {/api/oauth}: +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/oauth/available, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/oauth/status, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/oauth/auth/:provider, GET} route +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/oauth/callback/:provider, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/oauth/unlink/:provider, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] UserController {/api/users}: +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users/me, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users/me, PATCH} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users/me, DELETE} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users/:id, PATCH} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/users/:id, DELETE} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] FileController {/api/shares/:shareId/files}: +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:shareId/files, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:shareId/files/zip, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:shareId/files/:fileId, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:shareId/files/:fileId, DELETE} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] ReverseShareController {/api/reverseShares}: +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/reverseShares, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/reverseShares/:reverseShareToken, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/reverseShares, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/reverseShares/:reverseShareId, DELETE} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] ShareController {/api/shares}: +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/all, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares, GET} route +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id/from-owner, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id/metaData, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id/complete, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id/complete, DELETE} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id, DELETE} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/isShareIdAvailable/:id, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/shares/:id/token, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RoutesResolver] ConfigController {/api/configs}: +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/configs, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/configs/admin/:category, GET} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/configs/admin, PATCH} route +1ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/configs/admin/testEmail, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [RouterExplorer] Mapped {/api/configs/admin/logo, POST} route +0ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [NestApplication] Nest application successfully started +15ms
2025-01-16 19:05:13 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:05:13 PM     LOG [ClamScanService] ClamAV is not active
2025-01-16 19:07:04 pingvin-share-1  | [Nest] 59  - 01/16/2025, 6:07:04 PM     LOG [AuthService] Successful password login for user [email protected] from IP myIP
2025-01-16 19:08:24 pingvin-share-1  | {"level":"error","ts":1737050904.6645186,"logger":"http.log.error","msg":"EOF","request":{"remote_ip":"::1","remote_port":"42888","client_ip":"::1","proto":"HTTP/1.1","method":"GET","host":"localhost:3000","uri":"/api/health","headers":{"User-Agent":["curl/8.11.1"],"Accept":["*/*"]}},"duration":3.017320335,"status":502,"err_id":"dfcfy3uuq","err_trace":"reverseproxy.statusError (reverseproxy.go:1269)"}
2025-01-16 19:08:24 pingvin-share-1  | {"level":"error","ts":1737050904.6645212,"logger":"http.log.error","msg":"EOF","request":{"remote_ip":"172.22.0.1","remote_port":"62014","client_ip":"172.22.0.1","proto":"HTTP/1.1","method":"POST","host":"myDomain.com","uri":"/api/shares/AGCyw3z5/files?name=Archiv.zip&chunkIndex=0&totalChunks=3","headers":{"Dnt":["1"],"Sec-Gpc":["1"],"Sec-Fetch-Site":["same-origin"],"X-Forwarded-Proto":["https"],"Content-Length":["1000000000"],"Referer":["https://myDomain.com/upload"],"X-Forwarded-For":["myIP"],"User-Agent":["Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:134.0) Gecko/20100101 Firefox/134.0"],"Sec-Fetch-Dest":["empty"],"Connection":["close"],"Sec-Fetch-Mode":["cors"],"Content-Type":["application/octet-stream"],"Origin":["https://myDomain.com"],"Cookie":["REDACTED"],"X-Real-Ip":["myIP"],"Accept":["application/json, text/plain, */*"],"Accept-Language":["de,en-US;q=0.7,en;q=0.3"],"Accept-Encoding":["gzip, deflate, br, zstd"]}},"duration":26.138219762,"status":502,"err_id":"667ztd8fy","err_trace":"reverseproxy.statusError (reverseproxy.go:1269)"}
2025-01-16 19:08:24 pingvin-share-1  | Killed
2025-01-16 19:08:29 pingvin-share-1  | {"level":"error","ts":1737050909.801721,"logger":"http.log.error","msg":"dial tcp [::1]:8080: connect: connection refused","request":{"remote_ip":"172.22.0.1","remote_port":"60688","client_ip":"172.22.0.1","proto":"HTTP/1.1","method":"POST","host":"myDomain.com","uri":"/api/shares/AGCyw3z5/files?name=Archiv.zip&chunkIndex=0&totalChunks=3","headers":{"X-Forwarded-For":["myIP"],"X-Forwarded-Proto":["https"],"User-Agent":["Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:134.0) Gecko/20100101 Firefox/134.0"],"Accept-Encoding":["gzip, deflate, br, zstd"],"Sec-Gpc":["1"],"Dnt":["1"],"Sec-Fetch-Mode":["cors"],"Sec-Fetch-Site":["same-origin"],"Cookie":["REDACTED"],"Connection":["close"],"Accept-Language":["de,en-US;q=0.7,en;q=0.3"],"Origin":["https://myDomain.com"],"Sec-Fetch-Dest":["empty"],"X-Real-Ip":["myIP"],"Content-Length":["1000000000"],"Accept":["application/json, text/plain, */*"],"Content-Type":["application/octet-stream"],"Referer":["https://myDomain.com/upload"]}},"duration":0.0128205,"status":502,"err_id":"rx5jru80w","err_trace":"reverseproxy.statusError (reverseproxy.go:1269)"}
2025-01-16 19:08:34 pingvin-share-1  | {"level":"error","ts":1737050914.7600138,"logger":"http.log.error","msg":"dial tcp [::1]:8080: connect: connection refused","request":{"remote_ip":"::1","remote_port":"49754","client_ip":"::1","proto":"HTTP/1.1","method":"GET","host":"localhost:3000","uri":"/api/health","headers":{"User-Agent":["curl/8.11.1"],"Accept":["*/*"]}},"duration":0.001477458,"status":502,"err_id":"qkt84t4ua","err_trace":"reverseproxy.statusError (reverseproxy.go:1269)"}
2025-01-16 19:08:34 pingvin-share-1  | {"level":"error","ts":1737050914.9039373,"logger":"http.log.error","msg":"dial tcp [::1]:8080: connect: connection refused","request":{"remote_ip":"172.22.0.1","remote_port":"60690","client_ip":"172.22.0.1","proto":"HTTP/1.1","method":"POST","host":"myDomain.com","uri":"/api/shares/AGCyw3z5/files?name=Archiv.zip&chunkIndex=0&totalChunks=3","headers":{"Dnt":["1"],"Sec-Fetch-Dest":["empty"],"Cookie":["REDACTED"],"X-Forwarded-For":["myIP"],"User-Agent":["Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:134.0) Gecko/20100101 Firefox/134.0"],"Accept-Encoding":["gzip, deflate, br, zstd"],"Referer":["https://myDomain.com/upload"],"X-Forwarded-Proto":["https"],"Content-Length":["1000000000"],"Accept":["application/json, text/plain, */*"],"Sec-Fetch-Mode":["cors"],"X-Real-Ip":["myIP"],"Connection":["close"],"Accept-Language":["de,en-US;q=0.7,en;q=0.3"],"Content-Type":["application/octet-stream"],"Origin":["https://myDomain.com"],"Sec-Gpc":["1"],"Sec-Fetch-Site":["same-origin"]}},"duration":0.004170083,"status":502,"err_id":"2q2w1vgxh","err_trace":"reverseproxy.statusError (reverseproxy.go:1269)"}

@stonith404
Copy link
Owner

Great thanks. It seems like the backend gets killed. I have no clue why.

Can you inspect the memory usage while uploading? with docker ocmpose stats? Also, how much RAM did you assign to Docker?

@sfreek76
Copy link
Author

sfreek76 commented Jan 17, 2025 •
edited
Loading

Hello again, sorry for the delay of my answer! I did as you said, here's my docker container mem usage:

Image

And here's the output of docker stats, there's significant jump in used resources while try to upload a big file (around 2GB):

Image

Image

Image

Image

BTW: It seem that there are sllightly different logs? The log from yesterday was directly from Docker Desktop, now I've seen that "Dozzle" gives me another error when trying to upload a big file. Maybe this helps? Could my reverse Proxy (Synology NAS) be an issue? On second thought it did not work either locally without the reverse proxy... Odd...

level=errorts=1737099576.565858logger=http.log.errormsg=dial tcp [::1]:8080: connect: connection refusedrequest.client_ip=172.22.0.1request.headers.Accept=["application/json, text/plain, */*"]request.headers.Accept-Encoding=["gzip, deflate, br, zstd"]request.headers.Accept-Language=["de,en-US;q=0.7,en;q=0.3"]request.headers.Connection=["close"]request.headers.Content-Length=["1000000000"]request.headers.Content-Type=["application/octet-stream"]request.headers.Cookie=["REDACTED"]request.headers.Dnt=["1"]request.headers.Origin=["https://myDomain"]request.headers.Referer=["https://myDomain.com/upload"]request.headers.Sec-Fetch-Dest=["empty"]request.headers.Sec-Fetch-Mode=["cors"]request.headers.Sec-Fetch-Site=["same-origin"]request.headers.Sec-Gpc=["1"]request.headers.User-Agent=["Mozilla/5.0 (Macintosh; Intel Mac OS X 10.15; rv:134.0) Gecko/20100101 Firefox/134.0"]request.headers.X-Forwarded-For=["myIP"]request.headers.X-Forwarded-Proto=["https"]request.headers.X-Real-Ip=["myIP"]request.host=myDomain.comrequest.method=POSTrequest.proto=HTTP/1.1request.remote_ip=172.22.0.1request.remote_port=55092request.uri=/api/shares/HNV0q3kw/files?name=Archiv.zip&chunkIndex=0&totalChunks=3duration=0.000409status=502err_id=ws8c2p11perr_trace=reverseproxy.statusError (reverseproxy.go:1269)

EDIT: I had to change the "outside" port because I have many containers and your standard port was used from another container. I left the "inside" port as is but there are other containers which use the same port (8080) internally, could this be an issue and the reason for the error above?

Image

EDIT 2: Changed back to standard ports 3000:3000 now, unfortunately the issue stays the same but I think there's a new error (i tried to upload something over my internal network now instead of the ddns-domain...)

[Nest] 53 - 01/17/2025, 1:32:45 PM ERROR [ExceptionsHandler] request aborted
BadRequestError: request aborted
at IncomingMessage.onAborted (/opt/app/backend/node_modules/raw-body/index.js:245:10)
at IncomingMessage.emit (node:events:518:28)
at IncomingMessage._destroy (node:_http_incoming:221:10)
at _destroy (node:internal/streams/destroy:121:10)
at IncomingMessage.destroy (node:internal/streams/destroy:83:5)
at abortIncoming (node:_http_server:796:9)
at socketOnClose (node:_http_server:790:3)
at Socket.emit (node:events:530:35)
at TCP. (node:net:343:12)

Sorry for that many information and many thanks again for your efforts and for looking into this!

@sfreek76
Copy link
Author

sfreek76 commented Jan 18, 2025 •
edited
Loading

It all works now! Chunk Size in Settings was set to GB instead of MB. I must have set this wrong somehow during setup...

I'm sorry for all the trouble and many thanks for your efforts!

Image

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
No milestone
Development

No branches or pull requests
2 participants
@stonith404 @sfreek76