Skip to content
New issue

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

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

Already on GitHub? Sign in to your account

🐛 [immich] <99-run.sh error, followed by Redis client error> #1775

Closed
chaples55 opened this issue Feb 16, 2025 · 22 comments
Closed

🐛 [immich] <99-run.sh error, followed by Redis client error> #1775

chaples55 opened this issue Feb 16, 2025 · 22 comments
Labels
bug Something isn't working

Comments

@chaples55
Copy link

chaples55 commented Feb 16, 2025

Description

When I start Immich I get the following error in the log:

[14:22:50] WARNING: DB_ROOT_PASSWORD not set. Generating a random 12-character alphanumeric password and storing it in the addon options.
Error : /etc/cont-init.d/99-run.sh exiting 1

The addon continues trying to start, but it gets stuck in the Redis client error loop:

missing 'error' handler on this Redis client
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16)
    at TCPConnectWrap.callbackTrampoline (node:internal/async_hooks:130:17) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}

Reproduction steps

I do not know if all of these steps are relevant but I'm including everything for context.

1. HAOS vm in proxmox via community script, but use q35
2. Restore HA + Immich from backup from old bare metal machine
3. Copy files to new data location manually (a truenas smb share bound to HA /share directory)
4. Update postgres db paths manually: 
UPDATE asset_files
SET "path" = REPLACE("path", 'old path', 'new path')
WHERE "path" LIKE 'old path/%';
5. Immich is working for a while!

I don't know exactly at which point the problem started after this unfortunately, but it was either:

6. Update to 1.126.1 (from 1.125.7)
7. Edit the DOCKER_MODS env var in Portainer to: imagegenius/mods:universal-redis|linuxserver/mods:jellyfin-amd (experimenting with amd iGPU passthrough, no idea what I'm doing lol)

Since then I have had these errors. I have undone my Portainer changes, tried setting the DOCKER_MODS via your addon_config, tried unsetting it, and even restored the Immich addon from HA backup (1.126.1 backup made prior to messing with Portainer). Unfortunately the errors persist.

Addon Logs

Starting...
/etc/cont-init.d/00-banner.sh: executing
-----------------------------------------------------------
 Add-on: Immich
 Self-hosted photo and video backup solution directly from your mobile phone
-----------------------------------------------------------
 Add-on version: 1.126.1
 There is an update available for this add-on!
 Latest add-on version: 1.126.1-7
 Please consider upgrading as soon as possible.
 System: Home Assistant OS 14.2
 Architecture: amd64 / qemux86-64
 Home Assistant Core: 2025.2.4
 Home Assistant Supervisor: 2025.02.1
-----------------------------------------------------------
 Please, share the above information when looking for help
 or support in, e.g., GitHub, forums
-----------------------------------------------------------
 Provided by: https://github.com/alexbelgium/hassio-addons 
-----------------------------------------------------------
/etc/cont-init.d/00-global_var.sh: executing
DB_DATABASE_NAME='postgres'
DB_HOSTNAME='192.168.1.242'
DB_PASSWORD=******
DB_PORT='5432'
DB_USERNAME='postgres'
DISABLE_MACHINE_LEARNING='false'
JWT_SECRET='removed'
TZ='America/New_York'
data_location='/share/truenas12/APPS/IMMICH'
/etc/cont-init.d/00-local_mounts.sh: executing
/etc/cont-init.d/00-smb_mounts.sh: executing
/etc/cont-init.d/01-config_yaml.sh: executing
Setting permissions for the config.yaml directory
Load environment variables from /config/addons_config/immich/config.yaml if existing
If accessing the file with filebrowser it should be mapped to /homeassistant/addons_config/immich/config.yaml
---------------------------------------------------------
Wiki here on how to use : github.com/alexbelgium/hassio-addons/wiki/Add‐ons-feature-:-add-env-variables
... no env variables found, exiting
/etc/cont-init.d/01-custom_script.sh: executing
Execute /homeassistant/addons_autoscripts/immich.sh if existing
Wiki here : github.com/alexbelgium/hassio-addons/wiki/Add-ons-feature-:-customisation
/etc/cont-init.d/20-folders.sh: executing
[14:21:59] INFO: Setting data location
... check /share/truenas12/APPS/IMMICH folder exists
... setting permissions
... correcting official script
/etc/cont-init.d/99-run.sh: executing
[14:22:50] INFO: Exporting addon options from /data/options.json
DB_DATABASE_NAME='postgres'
DB_HOSTNAME='192.168.1.242'
DB_PASSWORD=******
DB_PORT='5432'
DB_USERNAME='postgres'
DISABLE_MACHINE_LEARNING='false'
JWT_SECRET='removed'
TZ='America/New_York'
data_location='/share/truenas12/APPS/IMMICH'
192.168.1.242 is reachable.
[14:22:50] WARNING: DB_ROOT_PASSWORD not set. Generating a random 12-character alphanumeric password and storing it in the addon options.
Error : /etc/cont-init.d/99-run.sh exiting 1
[migrations] started
[migrations] no migrations found
[14:22:50] INFO: Exporting addon options from /data/options.json
DB_DATABASE_NAME='postgres'
DB_HOSTNAME='192.168.1.242'
DB_PASSWORD=******
DB_PORT='5432'
DB_USERNAME='postgres'
DISABLE_MACHINE_LEARNING='false'
JWT_SECRET='removed'
TZ='America/New_York'
╔═══════════════════════════════╗
       __  _____ _____       __
      / / |_   _/ ____|     / /
     / /    | || |  __     / /
    / /     | || | |_ |   / /
   / /     _| || |__| |  / /
  /_/     |_____\_____| /_/
  Baseimage from linuxserver.io
╠═══════════════════════════════╣
  User/Group ID:
  User UID: 0
  User GID: 0
╚═══════════════════════════════╝
data_location='/share/truenas12/APPS/IMMICH'
192.168.1.242 is reachable.
[14:22:50] WARNING: DB_ROOT_PASSWORD not set. Generating a random 12-character alphanumeric password and storing it in the addon options.
**** permissions for /dev/dri/card0 are good ****
[custom-init] No custom files found, skipping...
Starting api worker
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
[Nest] 888  - 02/16/2025, 2:22:53 PM     LOG [Api:EventRepository] Initialized websocket server
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:ServerService] Feature Flags: {
  "smartSearch": true,
  "facialRecognition": true,
  "duplicateDetection": true,
  "map": true,
  "reverseGeocoding": true,
  "importFaces": false,
  "sidecar": true,
  "search": true,
  "trash": true,
  "oauth": false,
  "oauthAutoLaunch": false,
  "passwordLogin": true,
  "configFile": false,
  "email": false
}
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:StorageService] Verifying system mount folder checks, current state: {"mountFiles":true,"mountChecks":{"thumbs":true,"upload":true,"backups":true,"library":true,"profile":true,"encoded-video":true}}
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:StorageService] Successfully verified system mount folder checks
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:SystemConfigService] LogLevel=log (set via system config)
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:NestFactory] Starting Nest application...
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] BullModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] OpenTelemetryModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] TypeOrmModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] KyselyModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] KyselyCoreModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] OpenTelemetryCoreModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] DiscoveryModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] ClsModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] ScheduleModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] BullModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] BullModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] TypeOrmCoreModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] TypeOrmModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:InstanceLoader] ApiModule dependencies initialized
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] APIKeyController {/api/api-keys}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/api-keys, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/api-keys, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/api-keys/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/api-keys/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/api-keys/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] ActivityController {/api/activities}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/activities, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/activities, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/activities/statistics, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/activities/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] AlbumController {/api/albums}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/statistics, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id, PATCH} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id/assets, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id/assets, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id/users, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id/user/:userId, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/albums/:id/user/:userId, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] AppController {/api}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/.well-known/immich, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/custom.css, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] AssetController {/api/assets}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/memory-lane, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/random, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/device/:deviceId, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/statistics, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/jobs, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] AssetMediaController {/api/assets}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/:id/original, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/:id/original, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/:id/thumbnail, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/:id/video/playback, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/exist, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/assets/bulk-upload-check, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] AuditController {/api/audit}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/audit/deletes, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] AuthController {/api/auth}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/auth/login, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/auth/admin-sign-up, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/auth/validateToken, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/auth/change-password, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/auth/logout, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] DownloadController {/api/download}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/download/info, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/download/archive, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] DuplicateController {/api/duplicates}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/duplicates, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] FaceController {/api/faces}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/faces, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/faces/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] JobController {/api/jobs}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/jobs, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/jobs, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/jobs/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] LibraryController {/api/libraries}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries/:id/validate, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries/:id/statistics, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/libraries/:id/scan, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] MapController {/api/map}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/map/markers, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/map/reverse-geocode, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] MemoryController {/api/memories}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories/:id/assets, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/memories/:id/assets, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] NotificationController {/api/notifications}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/notifications/test-email, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/notifications/templates/:name, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] OAuthController {/api/oauth}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/oauth/mobile-redirect, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/oauth/authorize, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/oauth/callback, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/oauth/link, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/oauth/unlink, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] PartnerController {/api/partners}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/partners, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/partners/:id, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/partners/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/partners/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] PersonController {/api/people}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people/:id/statistics, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people/:id/thumbnail, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people/:id/reassign, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/people/:id/merge, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] ReportController {/api/reports}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/reports, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/reports/checksum, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/reports/fix, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] SearchController {/api/search}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/metadata, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/random, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/smart, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/explore, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/person, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/places, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/cities, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/search/suggestions, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] ServerController {/api/server}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/about, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/storage, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/ping, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/version, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/version-history, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/features, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/theme, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/config, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/statistics, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/media-types, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/license, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/license, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/server/license, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] SessionController {/api/sessions}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/sessions, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/sessions, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/sessions/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] SharedLinkController {/api/shared-links}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links/me, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links/:id, PATCH} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links/:id/assets, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/shared-links/:id/assets, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] StackController {/api/stacks}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/stacks, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/stacks, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/stacks, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/stacks/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/stacks/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/stacks/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] SyncController {/api/sync}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/sync/full-sync, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/sync/delta-sync, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] SystemConfigController {/api/system-config}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-config, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-config/defaults, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-config, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-config/storage-template-options, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] SystemMetadataController {/api/system-metadata}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-metadata/admin-onboarding, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-metadata/admin-onboarding, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/system-metadata/reverse-geocoding-state, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] TagController {/api/tags}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags/assets, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags/:id/assets, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/tags/:id/assets, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] TimelineController {/api/timeline}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/timeline/buckets, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/timeline/bucket, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] TrashController {/api/trash}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/trash/empty, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/trash/restore, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/trash/restore/assets, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] UserAdminController {/api/admin/users}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users/:id, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users/:id, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users/:id/preferences, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users/:id/preferences, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/admin/users/:id/restore, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] UserController {/api/users}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me/preferences, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me/preferences, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me/license, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me/license, PUT} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/me/license, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/:id, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/profile-image, POST} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/profile-image, DELETE} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/users/:id/profile-image, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RoutesResolver] ViewController {/api/view}:
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/view/folder/unique-paths, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:RouterExplorer] Mapped {/api/view/folder, GET} route
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:NestApplication] Nest application successfully started
[Nest] 888  - 02/16/2025, 2:22:54 PM     LOG [Api:Bootstrap] Immich Server is listening on http://[::1]:8080 [v1.126.1] [production] 
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
missing 'error' handler on this Redis client
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16)
    at TCPConnectWrap.callbackTrampoline (node:internal/async_hooks:130:17) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}
Error: connect ECONNREFUSED 127.0.0.1:6379
    at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1611:16)
    at TCPConnectWrap.callbackTrampoline (node:internal/async_hooks:130:17) {
  errno: -111,
  code: 'ECONNREFUSED',
  syscall: 'connect',
  address: '127.0.0.1',
  port: 6379
}

Architecture

amd64

OS

HAos

@chaples55 chaples55 added the bug Something isn't working label Feb 16, 2025
@alexbelgium
Copy link
Owner

Hi, please update to latest your log mentions there is an update available

@chaples55
Copy link
Author

Interesting, the problem appears to be resolved in 1.126.1-7. I had previously tried updating to the 1.126.1-4 version but the error still occurred there so I reverted to 1.126.1. Thanks!

I will note that while the redis error is gone and Immich is working, I still see this in the logs:

[23:05:03] WARNING: DB_ROOT_PASSWORD not set. Generating a random 12-character alphanumeric password and storing it in the addon options.
psql: error: could not translate host name "[email protected]" to address: Name or service not known
[23:05:03] INFO: Root user does not exist. Creating root user with DB_ROOT_PASSWORD...
psql: error: could not translate host name "[email protected]" to address: Name or service not known
Error : /etc/cont-init.d/99-run.sh exiting 2

Is this safe to ignore?

@alexbelgium
Copy link
Owner

Yes it's a script to check if your psql has a normal address. It fetches the ip give by homeassistant supervisor, but it seems in your case there is more info than the ip. I'm still adapt my code

BTW I've pushed 2 new versions lf the addon supporting cuda and openvino if you are interested

@alexbelgium
Copy link
Owner

Actually, here is the code part generating the error :

bashio::log.info "Root user does not exist. Creating root user with DB_ROOT_PASSWORD..."
            psql "postgres://${DB_USERNAME}:${DB_PASSWORD}@${DB_HOSTNAME}:${DB_PORT}" 

I don't understand where the rter is coming from, is it your DB_USERNAME ? and is your DB_PASSWORD and DB_PORT correctly set too ?

@chaples55
Copy link
Author

chaples55 commented Feb 18, 2025

Honestly I don't know where that is coming from either. It's not something I would ever have entered intentionally. My config has:
DB_DATABASE_NAME='postgres'
DB_HOSTNAME='192.168.1.242'
DB_PASSWORD='<my password>'
DB_PORT='5432'
DB_ROOT_PASSWORD='<auto generated>'
DB_USERNAME='postgres'

I'll do some digging tomorrow if I have time. Is there any other info that would be helpful?

@chaples55
Copy link
Author

Oh and I may try out the openvino version soon. I just got a great deal on an ARC A770

@alexbelgium
Copy link
Owner

Watch-out openvino takes a lot of RAM - 9Go on my system in average :-)

@alexbelgium
Copy link
Owner

Honestly I don't know where that is coming from either. It's not something I would ever have entered intentionally. My config has: DB_DATABASE_NAME='postgres' DB_HOSTNAME='192.168.1.242' DB_PASSWORD='' DB_PORT='5432' DB_ROOT_PASSWORD='' DB_USERNAME='postgres'

I'll do some digging tomorrow if I have time. Is there any other info that would be helpful?

is "rter" part of your DB_ROOT_PASSWORD, or a " " ? perhaps it could mis-interpret this as a host ?

@chaples55
Copy link
Author

chaples55 commented Feb 19, 2025

OHHHH that's probably it! My DB_PASSWORD contains the '@' symbol like so: ************@rter

@chaples55
Copy link
Author

Can I change my password in the postgres addon config or will that cause problems?

@alexbelgium
Copy link
Owner

Uh... Not sure I think it must be done manually. Don't do anything yet I'll try to sanitize it some way

alexbelgium added a commit that referenced this issue Feb 19, 2025
@alexbelgium
Copy link
Owner

I've put a potential solutions, which flavor of immich should I build for you to test? openvino or classical?

@chaples55
Copy link
Author

Classical, please :)

@alexbelgium
Copy link
Owner

Pushed !

@chaples55
Copy link
Author

Ok I updated to immich 1.126.1-11 and postgres 15.7-29. The 'rter' part is gone from the logs but now there is a password auth error. Immich does still start and work.

/etc/cont-init.d/99-run.sh: executing
[17:12:20] INFO: Exporting addon options from /data/options.json
DB_DATABASE_NAME='postgres'
DB_HOSTNAME='192.168.1.242'
DB_PASSWORD=******
DB_PORT='5432'
DB_ROOT_PASSWORD=******
DB_USERNAME='postgres'
DISABLE_MACHINE_LEARNING='false'
JWT_SECRET='foo'
TZ='America/New_York'
data_location='/share/truenas12/APPS/IMMICH'
192.168.1.242 is reachable.
psql: error: connection to server at "192.168.1.242", port 5432 failed: FATAL:  password authentication failed for user "postgres"
[17:12:20] INFO: Root user does not exist. Creating root user with DB_ROOT_PASSWORD...
psql: error: connection to server at "192.168.1.242", port 5432 failed: FATAL:  password authentication failed for user "postgres"
Error : /etc/cont-init.d/99-run.sh exiting 2
Starting the upstream container

@josiah-eichelman
Copy link

I'm also getting this error when updating - my postgres password does not contain '@' but it does contain '<' char

@alexbelgium
Copy link
Owner

Thanks I've pushed a new code for URI encoding in version 12 could you please let me know how that goes

@chaples55
Copy link
Author

Updated to -13, will need to revert to -11

192.168.1.242 is reachable.
psql: error: connection to server at "192.168.1.242", port 5432 failed: FATAL:  password authentication failed for user "postgres"
[23:45:54] INFO: Root user does not exist. Creating root user with DB_ROOT_PASSWORD...
psql: error: connection to server at "192.168.1.242", port 5432 failed: FATAL:  password authentication failed for user "postgres"
Error : /etc/cont-init.d/99-run.sh exiting 2
Starting the upstream container

........

[Nest] 1998  - 02/19/2025, 11:48:35 PM   ERROR [ExceptionHandler] error: password authentication failed for user "postgres"
    at Parser.parseErrorMessage (/app/immich/server/node_modules/pg-protocol/dist/parser.js:283:98)
    at Parser.handlePacket (/app/immich/server/node_modules/pg-protocol/dist/parser.js:122:29)
    at Parser.parse (/app/immich/server/node_modules/pg-protocol/dist/parser.js:35:38)
    at Socket.<anonymous> (/app/immich/server/node_modules/pg-protocol/dist/index.js:11:42)
    at Socket.emit (node:events:518:28)
    at addChunk (node:internal/streams/readable:561:12)
    at readableAddChunkPushByteMode (node:internal/streams/readable:512:3)
    at Readable.push (node:internal/streams/readable:392:5)
    at TCP.onStreamRead (node:internal/stream_base_commons:191:23) {
  length: 104,
  severity: 'FATAL',
  code: '28P01',
  detail: undefined,
  hint: undefined,
  position: undefined,
  internalPosition: undefined,
  internalQuery: undefined,
  where: undefined,
  schema: undefined,
  table: undefined,
  column: undefined,
  dataType: undefined,
  constraint: undefined,
  file: 'auth.c',
  line: '326',
  routine: 'auth_failed'
}
api worker exited with code 1

@alexbelgium
Copy link
Owner

Mmh I'll revert the code but it's a bit strange. What is your log when starting the postgres addon ? It uses the same psql logic.

I'm wondering if the issue is with the code itself, or that due to the @ your password is not set to what you expected in postgres itself

alexbelgium added a commit that referenced this issue Feb 20, 2025
alexbelgium added a commit that referenced this issue Feb 20, 2025
@josiah-eichelman
Copy link

I think the postgres password was not set to what was expected - I tried to use pgadmin to login with the postgres user and failed.

The root user/pwd did work though - so I logged in there and reset the postgres pwd
ALTER USER postgres WITH PASSWORD 'yourpwd'; --make sure whatever you set this to matches your addon config

@chaples55
Copy link
Author

Can confirm the latest updates along with @josiah-eichelman's solution works!

@alexbelgium
Copy link
Owner

Thanks! I'll have to implement password change in postgres I think it only takes into account password at first start but not when it is changed in the options afterwards

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
None yet
Development

No branches or pull requests

3 participants