Docker-compose, postgresql database files are incompatible with server #2

Continuing the discussion from Docker-compose, postgresql database files are incompatible with server:

Sorry for that duplicate post to github, I was not sure if docker-compose is actually on-topic here or if it is a separate project. Being a beginner and for questions I’m going to focus to the community now.

I’m doing a fresh install via docker-compose and I expected to get a default ready installation from that. Is this expected that the postgresql requires a 9.6.24 to 15.0.0 migration first?
Then Install with Docker Compose — Zammad documentation should mention that step.

I started with Release v6.0.0 · zammad/zammad-docker-compose · GitHub now and did this so far:

git checkout cd424e98689b8dc49878a37b9aab67192c36fd24
docker-compose stop
docker-compose up

Now it seems I’m in an infinite loop:

...
ammad-init_1           | /usr/local/bundle/gems/activesupport-6.1.7/lib/active_support/dependencies.rb:299:in `load_dependency'
zammad-init_1           | /usr/local/bundle/gems/activesupport-6.1.7/lib/active_support/dependencies.rb:332:in `require'
zammad-init_1           | /usr/local/bundle/gems/railties-6.1.7/lib/rails/application.rb:367:in `require_environment!'
zammad-init_1           | /usr/local/bundle/gems/railties-6.1.7/lib/rails/application.rb:533:in `block in run_tasks_blocks'
zammad-init_1           | /usr/local/bundle/gems/rake-13.0.6/exe/rake:27:in `<top (required)>'
zammad-init_1           | /usr/local/bin/bundle:23:in `load'
zammad-init_1           | /usr/local/bin/bundle:23:in `<main>'
zammad-init_1           | Tasks: TOP => db:create => db:load_config => environment
zammad-init_1           | (See full trace by running task with --trace)
zammad-docker-compose_zammad-init_1 exited with code 1
zammad-postgresql_1     | LOG:  incomplete startup packet
zammad-init_1           | initialising / updating database...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-docker-compose_zammad-redis_1 exited with code 1
zammad-redis_1          | 1:C 01 Dec 2022 07:18:57.615 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
zammad-redis_1          | 1:C 01 Dec 2022 07:18:57.615 # Redis version=6.2.5, bits=64, commit=00000000, modified=0, pid=1, just started
zammad-redis_1          | 1:C 01 Dec 2022 07:18:57.615 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
zammad-redis_1          | 1:M 01 Dec 2022 07:18:57.616 * monotonic clock: POSIX clock_gettime
zammad-redis_1          | 1:M 01 Dec 2022 07:18:57.617 * Running mode=standalone, port=6379.
zammad-redis_1          | 1:M 01 Dec 2022 07:18:57.617 # Server initialized
zammad-redis_1          | 1:M 01 Dec 2022 07:18:57.617 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
zammad-redis_1          | 1:M 01 Dec 2022 07:18:57.617 # Can't handle RDB format version 10
zammad-redis_1          | 1:M 01 Dec 2022 07:18:57.617 # Fatal error loading the DB: Invalid argument. Exiting.
zammad-redis_1          | 1:C 01 Dec 2022 07:18:59.050 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
zammad-redis_1          | 1:C 01 Dec 2022 07:18:59.050 # Redis version=6.2.5, bits=64, commit=00000000, modified=0, pid=1, just started
zammad-redis_1          | 1:C 01 Dec 2022 07:18:59.050 # Warning: no config file specified, using the default config. In order to specify a config file use redis-server /path/to/redis.conf
zammad-redis_1          | 1:M 01 Dec 2022 07:18:59.050 * monotonic clock: POSIX clock_gettime
zammad-redis_1          | 1:M 01 Dec 2022 07:18:59.050 * Running mode=standalone, port=6379.
zammad-redis_1          | 1:M 01 Dec 2022 07:18:59.051 # Server initialized
...

I did
sysctl vm.overcommit_memory=1
but still getting the same loop. I guess it’s something about the invalid RDB format on Redis?

I start the installation from scratch:

# zammad-docker-compose_zammad-elasticsearch_1
# docker ps -a
CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
# docker image rm 93cd63370bda fb873e3c2a61 e4c9576cbbba 96a149ad0157 c4236d458daa c86da9a6f92a 9a203e1912df 4d8bbf1731ab cc994726847f f6f2296798e9 ec2009291176
# docker images
REPOSITORY   TAG       IMAGE ID   CREATED   SIZE
# git clone https://github.com/zammad/zammad-docker-compose.git
# cd zammad-docker-compose/
# docker-compose up
...
zammad-postgresql_1     | 2022-12-06 08:03:58.725 UTC [1] FATAL:  database files are incompatible with server
zammad-postgresql_1     | 2022-12-06 08:03:58.725 UTC [1] DETAIL:  The data directory was initialized by PostgreSQL version 9.6, which is not compatible with this version 15.1.
zammad-docker-compose_zammad-postgresql_1 exited with code 1
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-backup_1         | waiting for railsserver to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-postgresql_1     | 
zammad-postgresql_1     | PostgreSQL Database directory appears to contain a database; Skipping initialization
zammad-postgresql_1     | 
zammad-postgresql_1     | 2022-12-06 08:04:59.134 UTC [1] FATAL:  database files are incompatible with server
zammad-postgresql_1     | 2022-12-06 08:04:59.134 UTC [1] DETAIL:  The data directory was initialized by PostgreSQL version 9.6, which is not compatible with this version 15.1.
zammad-docker-compose_zammad-postgresql_1 exited with code 1
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-backup_1         | waiting for railsserver to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-init_1           | zammad railsserver waiting for postgresql server to be ready...
...

There the infinite loop happens again.

I wasn’t aware of volumes. So to start from scratch I need

# docker container rm <all containers>
# docker image rm <all images>
# docker volume prune

Now the installation finished.

Weird, starting from scratch again, I’m again in an infinite loop. What I’m doing wrong here?

# docker-compose down
Removing zammad-docker-compose_zammad-scheduler_1     ... done
Removing zammad-docker-compose_zammad-websocket_1     ... done
Removing zammad-docker-compose_zammad-backup_1        ... done
Removing zammad-docker-compose_zammad-nginx_1         ... done
Removing zammad-docker-compose_zammad-railsserver_1   ... done
Removing zammad-docker-compose_zammad-init_1          ... done
Removing zammad-docker-compose_zammad-postgresql_1    ... done
Removing zammad-docker-compose_zammad-memcached_1     ... done
Removing zammad-docker-compose_zammad-elasticsearch_1 ... done
Removing zammad-docker-compose_zammad-redis_1         ... done
Removing network zammad-docker-compose_default

# docker ps -a
CONTAINER ID   IMAGE     COMMAND   CREATED   STATUS    PORTS     NAMES
 
# docker volume prune
WARNING! This will remove all local volumes not used by at least one container.
Are you sure you want to continue? [y/N] y
Deleted Volumes:
zammad-docker-compose_postgresql-data
zammad-docker-compose_zammad-backup
zammad-docker-compose_elasticsearch-data
zammad-docker-compose_zammad-data
ece39544abd03f53dd25fe54516aedfb159a3f9011afca6912aeff1adde5c4cd
b81d293743484fa15d2ab54601898df9a465dbe687aa00c7ae585d96458b91d0

Total reclaimed space: 747.3MB

# docker volume ls
DRIVER    VOLUME NAME

# docker image ls
REPOSITORY                     TAG             IMAGE ID       CREATED        SIZE
postgres                       15.1-alpine     ac95006e92d1   7 days ago     243MB
zammad/zammad-docker-compose   5.3.0-9         f3e2e8cfe803   2 weeks ago    1.69GB
redis                          7.0.5-alpine    ffd287e43d20   2 weeks ago    29.9MB
memcached                      1.6.17-alpine   18cfb332778c   2 weeks ago    9.42MB
bitnami/elasticsearch          8.5.1           fb873e3c2a61   4 weeks ago    711MB
postgres                       15.0-alpine     cc994726847f   2 months ago   218MB

# docker image rm ac95006e92d1 f3e2e8cfe803 ffd287e43d20 18cfb332778c fb873e3c2a61 cc994726847f
Untagged: postgres:15.1-alpine
Untagged: postgres@sha256:e5a7d01f4fa15440f5828265cf24005fc2364c4c42c3ba8a2884dbdeb88526ee
Deleted: sha256:ac95006e92d16b385d703415bc3bfcecba08dcb35d5ab7c45c143c8421c84592
Deleted: sha256:c1fe0d4717e726c2adfe448da5148a8bba31b3426df1cd212b8cf951e7974d34
Deleted: sha256:5d0b1e6d33bd9439c452fe02db04fb9cd73c73365fb61f969a8d7efc1493f6dd
Deleted: sha256:15a0df2dc1e16a91ac6f2831be8abd1bf84c087215d376e4c719f25e3a6ea4f5
Deleted: sha256:dc7a6a550fd55b13652d899eeadb501d90846aa9412f062c2c1f80ac33fea623
Deleted: sha256:08a9e34f0e7c79b919bfc02121493500062920a5a1370c64311299ecd46cbdc3
Deleted: sha256:560c785751903ea3e551e25c7f73ca529dc670cfd031af64bfcb295f3109f19a
Deleted: sha256:ff4e1dae3f433d58596ea035de337c01a4e0a249fb6700b798cb227ac6014be2
Untagged: zammad/zammad-docker-compose:5.3.0-9
Untagged: zammad/zammad-docker-compose@sha256:e40941c3950c90496303c6ffc412695433613cdc0f5f791714203411e51104a4
Deleted: sha256:f3e2e8cfe803669e5a9def96387835aa911c491ca8da7c906d90368769639e7f
Deleted: sha256:e55e329f7faa57ec82648661918f022db1b5072e359bb0324063afbec9b98d85
Deleted: sha256:0f90bf954e984594dac44e05962aa9211fb4152ee921e2a83909fd06454cc1cc
Deleted: sha256:e45994d662b26b6f9b6606475d2e84d78f8862aff20837166ee0fcce8606773c
Deleted: sha256:33fb224b394f83414379b13331edb6209388b63c82898d94a0f696d608c65cec
Deleted: sha256:25f93a3687228caff55afaf1b282f0d282f3f9f0e2a26033b3ff79bc4d616668
Deleted: sha256:a664aca8bac5309ee43cdcb1ece07a0abd8872aa6d5ed78539ada471e0d05e17
Deleted: sha256:56842a943d8d3af29ada55d31295c9ee61b5a462ebb22151d152d7d8b0f02d20
Deleted: sha256:1dff36fa23efe1c1c9d3b6e1ca3c90057f5145ed57c463edd2c5e84e9ae6213e
Deleted: sha256:397a7762520be27809757c92b1d3692dc3618160417c3dc6d18f2623c7f7ae9e
Deleted: sha256:a0fed84badc33ed3da279839dd2a67e82687fbe3c6a5c8bba4ac3ff814ee6396
Deleted: sha256:ec4a38999118b78eab6899b913a548cb0b2c9b68fd05aff846a56b628b597f38
Untagged: redis:7.0.5-alpine
Untagged: redis@sha256:518c024ec78b3074917bad2d40863e882e5297d65587e6d7c6e0b7281d9b8270
Deleted: sha256:ffd287e43d20012b1d4848bea92beab5064edd133b93970c6e665abbdf9824eb
Deleted: sha256:a02094b78986035df8925b2df5efef6a83e7daedf3a6ce8113bd1521217abec2
Deleted: sha256:479341f46034daf038b2aa6a883ec1cd871e58f96fe2872a059bb42b2d106560
Deleted: sha256:f3d834aa346273141f187ea5f9d4f2a8b3148ef35196873185c66ca8c9497ada
Deleted: sha256:2be9af83a20dd32a586181e7812c052dccd241221307e8b973d18edd652034b6
Deleted: sha256:3b4e6842445154483a97b7dd1be34847a9813e95c68fddd2cbb8a23e2196d573
Untagged: memcached:1.6.17-alpine
Untagged: memcached@sha256:49ff44c78c8ad56e8f2d15e787fd8956f2ae70896ef9560bb42669bb34e93ff1
Deleted: sha256:18cfb332778cbd146e9d62d2e4f18bf2e369d4eb028a3d04b2c1d88ab73721fd
Deleted: sha256:e7e77c0be78c2c54655f66d31289c7804474774086460348b23e62be42c09e69
Deleted: sha256:5b364eecca607d75fa56704c84cf8a4c3032d5932c93cf9b282bf8e3a66fb74e
Deleted: sha256:5440f4340006c136550864d466572e7d17274a74a3902b379501e9034dae8086
Deleted: sha256:5c7f20325af37b65237568cee987ac977ca1dc3ec8005c5891861d7d2f2cb895
Deleted: sha256:bd9eb2326e2319ca9331e0f6dd945522adb3325b0f2fee46aaff0443bacc22dd
Deleted: sha256:ded7a220bb058e28ee3254fbba04ca90b679070424424761a53a043b93b612bf
Untagged: bitnami/elasticsearch:8.5.1
Untagged: bitnami/elasticsearch@sha256:26369945bfa3274d7da81a5f91bd3ff3cabfa8ece969493222f54fb227776bb1
Deleted: sha256:fb873e3c2a614e324830e81f67293a26cc496c6f92f78768995b1b8e5415c6d8
Deleted: sha256:470d708ce204703b64cee1fbf41eb9d9e537ae90bb6688e0225d9d55346de23f
Deleted: sha256:58861e9c7a9b85fcb52553413d8725a7ae8d215349b6325cfdb9d0c38b7f5583
Untagged: postgres:15.0-alpine
Untagged: postgres@sha256:09d57b502063c77d8896683ff5126187025d7b2e2b4378a896b90dced36bc083
Deleted: sha256:cc994726847f9000a5bb5c7896887ecf1d77b524239f00cd3e19675e0cba2b6f
Deleted: sha256:066c0418aba9322fed46ba00dfb2c3853364967018133d51ddde13ee5836e2a9
Deleted: sha256:e3bcb2c0799278cddb4c63cdb79218da081178ffe4842f06ce40a95733257ec8
Deleted: sha256:e22c6d786c2facad21e96bff3a69b4e4fe9e8b8e511b9180f8924e5282e2f817
Deleted: sha256:060bb2d4aa1d1cf3d2a23b14f6f30771bc9f5a15d4a55d91e36655682ee9131d
Deleted: sha256:cb9fc97762360b8319925f9ee63fced0687e9d82cff1e395bfee2cd050df2a3a
Deleted: sha256:934d24deeb153a2ca4f24035b3b9aeb42b265108a35ca74d52782fe84ff031d1
Deleted: sha256:88af384590de04a47b9b659583ea4852f8a6cfae0660b2985f64fa3296b4c400
Deleted: sha256:994393dc58e7931862558d06e46aa2bb17487044f670f310dffe1d24e4d1eec7

#  docker image ls
REPOSITORY   TAG       IMAGE ID   CREATED   SIZE

# cd ..; rm -rf zammad-docker-compose

Cleaned, starting from scratch:

# git clone https://github.com/zammad/zammad-docker-compose.git

# cd zammad-docker-compose

# git pull
Already up to date.

# git status
On branch master
Your branch is up to date with 'origin/master'.

nothing to commit, working tree clean

# docker-compose up
Creating network "zammad-docker-compose_default" with the default driver
Creating volume "zammad-docker-compose_elasticsearch-data" with local driver
Creating volume "zammad-docker-compose_postgresql-data" with local driver
Creating volume "zammad-docker-compose_zammad-backup" with local driver
Creating volume "zammad-docker-compose_zammad-data" with local driver
Pulling zammad-postgresql (postgres:15.1-alpine)...
15.1-alpine: Pulling from library/postgres
c158987b0551: Pull complete
534a27978278: Pull complete
f9d52041f541: Pull complete
2bf42692bedd: Pull complete
4f54ae369e8f: Pull complete
dad124809424: Pull complete
765558788e59: Pull complete
2eb9784aa7b0: Pull complete
Digest: sha256:e5a7d01f4fa15440f5828265cf24005fc2364c4c42c3ba8a2884dbdeb88526ee
Status: Downloaded newer image for postgres:15.1-alpine
Pulling zammad-elasticsearch (bitnami/elasticsearch:8.5.1)...
8.5.1: Pulling from bitnami/elasticsearch
9dce2fae8330: Pull complete
581f25042c1f: Pull complete
# .........
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-init_1           | I, [2022-12-21T13:16:22.304232 #25-8280]  INFO -- : Using memcached as Rails cache store.
zammad-init_1           | I, [2022-12-21T13:16:22.304425 #25-8280]  INFO -- : Using Redis as web socket session store.
zammad-elasticsearch_1  | [2022-12-21T13:16:22,667][ERROR][o.e.i.g.GeoIpDownloader  ] [294b2c5e4186] exception during geoip databases update java.net.UnknownHostException: geoip.elastic.co
zammad-elasticsearch_1  | 	at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:567)
zammad-elasticsearch_1  | 	at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327)
zammad-elasticsearch_1  | 	at java.base/java.net.Socket.connect(Socket.java:633)
zammad-elasticsearch_1  | 	at java.base/sun.security.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:304)
zammad-elasticsearch_1  | 	at java.base/sun.net.NetworkClient.doConnect(NetworkClient.java:178)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:531)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:636)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.https.HttpsClient.<init>(HttpsClient.java:266)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:380)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:193)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1242)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1128)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:179)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1665)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1589)
zammad-elasticsearch_1  | 	at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:529)
zammad-elasticsearch_1  | 	at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:308)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.lambda$get$0(HttpClient.java:46)
zammad-elasticsearch_1  | 	at java.base/java.security.AccessController.doPrivileged(AccessController.java:569)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.doPrivileged(HttpClient.java:88)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.get(HttpClient.java:40)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.getBytes(HttpClient.java:36)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloader.fetchDatabasesOverview(GeoIpDownloader.java:155)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloader.updateDatabases(GeoIpDownloader.java:143)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloader.runDownloader(GeoIpDownloader.java:274)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloaderTaskExecutor.nodeOperation(GeoIpDownloaderTaskExecutor.java:102)
zammad-elasticsearch_1  | 	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloaderTaskExecutor.nodeOperation(GeoIpDownloaderTaskExecutor.java:48)
zammad-elasticsearch_1  | 	at org.elasticsearch.server@8.5.1/org.elasticsearch.persistent.NodePersistentTasksExecutor$1.doRun(NodePersistentTasksExecutor.java:42)
zammad-elasticsearch_1  | 	at org.elasticsearch.server@8.5.1/org.elasticsearch.common.util.concurrent.ThreadContext$ContextPreservingAbstractRunnable.doRun(ThreadContext.java:892)
zammad-elasticsearch_1  | 	at org.elasticsearch.server@8.5.1/org.elasticsearch.common.util.concurrent.AbstractRunnable.run(AbstractRunnable.java:26)
zammad-elasticsearch_1  | 	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
zammad-elasticsearch_1  | 	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
zammad-elasticsearch_1  | 	at java.base/java.lang.Thread.run(Thread.java:833)
zammad-elasticsearch_1  | 
zammad-init_1           | W, [2022-12-21T13:16:23.134559 #25-8280]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
zammad-init_1           | W, [2022-12-21T13:16:23.145114 #25-8280]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
zammad-init_1           | I, [2022-12-21T13:16:23.655608 #25-8280]  INFO -- : Setting.set('app_version', "20221221131623:true")
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-backup_1         | waiting for railsserver to be ready...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
zammad-railsserver_1    | waiting for init container to finish install or update...
zammad-websocket_1      | waiting for init container to finish install or update...
zammad-nginx_1          | waiting for init container to finish install or update...
zammad-scheduler_1      | waiting for init container to finish install or update...
^CGracefully stopping... (press Ctrl+C again to force)
Stopping zammad-docker-compose_zammad-backup_1        ... done
Stopping zammad-docker-compose_zammad-scheduler_1     ... done
Stopping zammad-docker-compose_zammad-websocket_1     ... done
Stopping zammad-docker-compose_zammad-nginx_1         ... done
Stopping zammad-docker-compose_zammad-railsserver_1   ... done
Stopping zammad-docker-compose_zammad-init_1          ... done
Stopping zammad-docker-compose_zammad-postgresql_1    ... done
Stopping zammad-docker-compose_zammad-memcached_1     ... done
Stopping zammad-docker-compose_zammad-elasticsearch_1 ... done
Stopping zammad-docker-compose_zammad-redis_1         ... done

Checking the container logs I found:

# docker logs -f zammad-docker-compose_zammad-init_1
Payload size: 0M
/opt/zammad/lib/search_index_backend.rb:36:in `info'
/opt/zammad/lib/tasks/zammad/search_index_es.rake:76:in `block (3 levels) in <main>'
/usr/local/bundle/gems/rake-13.0.6/exe/rake:27:in `<top (required)>'
/usr/local/bin/bundle:23:in `load'
/usr/local/bin/bundle:23:in `<main>'
Tasks: TOP => zammad:searchindex:rebuild => zammad:searchindex:version_supported
(See full trace by running task with --trace)
initialising / updating database...
I, [2022-12-22T12:11:19.575102 #24-7380]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:11:19.575249 #24-7380]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:11:21.335417 #24-7380]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:11:21.485959 #24-7380]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
I, [2022-12-22T12:11:24.011477 #26-8280]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:11:24.011654 #26-8280]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:11:25.819096 #26-8280]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:11:25.986280 #26-8280]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
changing settings...
I, [2022-12-22T12:11:28.746123 #28-7380]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:11:28.746300 #28-7380]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:11:30.463246 #28-7380]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:11:30.614175 #28-7380]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
I, [2022-12-22T12:11:31.398368 #28-7380]  INFO -- : Setting.set('es_url', "http://zammad-elasticsearch:9200")
I, [2022-12-22T12:11:33.657264 #30-7380]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:11:33.657344 #30-7380]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:11:35.459170 #30-7380]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:11:35.615629 #30-7380]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
I, [2022-12-22T12:11:36.397897 #30-7380]  INFO -- : Setting.set('es_index', "zammad")
rebuilding es searchindex...
I, [2022-12-22T12:13:48.135644 #35-8280]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:13:48.135737 #35-8280]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:13:49.953426 #35-8280]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:13:50.111511 #35-8280]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
E, [2022-12-22T12:14:14.417374 #35-8280] ERROR -- : Unable to process GET request to elasticsearch URL 'http://zammad-elasticsearch:9200'. Check the response and payload for detailed information:

Response:
#<UserAgent::Result:0x0000559a77b32a88 @success=false, @body=nil, @data=nil, @code=0, @content_type=nil, @error="#<Net::OpenTimeout: execution expired>", @header=nil>

Payload:
null

Payload size: 0M
rake aborted!
Unable to process GET request to elasticsearch URL 'http://zammad-elasticsearch:9200'. Check the response and payload for detailed information:

Response:
#<UserAgent::Result:0x0000559a77b32a88 @success=false, @body=nil, @data=nil, @code=0, @content_type=nil, @error="#<Net::OpenTimeout: execution expired>", @header=nil>

Payload:
null

Payload size: 0M
/opt/zammad/lib/search_index_backend.rb:36:in `info'
/opt/zammad/lib/tasks/zammad/search_index_es.rake:76:in `block (3 levels) in <main>'
/usr/local/bundle/gems/rake-13.0.6/exe/rake:27:in `<top (required)>'
/usr/local/bin/bundle:23:in `load'
/usr/local/bin/bundle:23:in `<main>'
Tasks: TOP => zammad:searchindex:rebuild => zammad:searchindex:version_supported
(See full trace by running task with --trace)
initialising / updating database...
I, [2022-12-22T12:14:25.950004 #23-7380]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:14:25.950086 #23-7380]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:14:27.788252 #23-7380]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:14:27.943367 #23-7380]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
I, [2022-12-22T12:14:30.624945 #25-8280]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:14:30.625188 #25-8280]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:14:32.371594 #25-8280]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:14:32.642758 #25-8280]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
changing settings...
I, [2022-12-22T12:14:35.129010 #27-7380]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:14:35.129089 #27-7380]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:14:36.863023 #27-7380]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:14:37.029417 #27-7380]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
I, [2022-12-22T12:14:37.814779 #27-7380]  INFO -- : Setting.set('es_url', "http://zammad-elasticsearch:9200")
I, [2022-12-22T12:14:40.101266 #29-7380]  INFO -- : Using memcached as Rails cache store.
I, [2022-12-22T12:14:40.101354 #29-7380]  INFO -- : Using Redis as web socket session store.
W, [2022-12-22T12:14:41.836719 #29-7380]  WARN -- : Setting "timezone_default" is empty. Using UTC instead. Please set system timezone.
I, [2022-12-22T12:14:41.992771 #29-7380]  INFO -- : Setting.set('models_searchable', ["Chat::Session", "KnowledgeBase::Answer::Translation", "Organization", "Ticket", "User"])
I, [2022-12-22T12:14:42.787438 #29-7380]  INFO -- : Setting.set('es_index', "zammad")
# docker logs -f zammad-docker-compose_zammad-postgresql_1
PostgreSQL init process complete; ready for start up.

2022-12-21 13:15:45.777 UTC [1] LOG:  starting PostgreSQL 15.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 12.2.1_git20220924-r4) 12.2.1 20220924, 64-bit
2022-12-21 13:15:45.777 UTC [1] LOG:  listening on IPv4 address "0.0.0.0", port 5432
2022-12-21 13:15:45.777 UTC [1] LOG:  listening on IPv6 address "::", port 5432
2022-12-21 13:15:45.787 UTC [1] LOG:  listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432"
2022-12-21 13:15:45.803 UTC [51] LOG:  database system was shut down at 2022-12-21 13:15:45 UTC
2022-12-21 13:15:46.095 UTC [1] LOG:  database system is ready to accept connections
2022-12-21 13:15:57.663 UTC [55] LOG:  incomplete startup packet
2022-12-21 13:16:05.847 UTC [56] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:05.997 UTC [58] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:06.039 UTC [59] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:08.074 UTC [60] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:11.095 UTC [61] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:11.167 UTC [63] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:11.240 UTC [64] FATAL:  database "zammad_production" does not exist
2022-12-21 13:16:13.455 UTC [67] ERROR:  relation "settings" does not exist at character 454
2022-12-21 13:16:13.455 UTC [67] STATEMENT:  SELECT a.attname, format_type(a.atttypid, a.atttypmod),
	       pg_get_expr(d.adbin, d.adrelid), a.attnotnull, a.atttypid, a.atttypmod,
	       c.collname, col_description(a.attrelid, a.attnum) AS comment
	  FROM pg_attribute a
	  LEFT JOIN pg_attrdef d ON a.attrelid = d.adrelid AND a.attnum = d.adnum
	  LEFT JOIN pg_type t ON a.atttypid = t.oid
	  LEFT JOIN pg_collation c ON a.attcollation = c.oid AND a.attcollation <> t.typcollation
	 WHERE a.attrelid = '"settings"'::regclass
	   AND a.attnum > 0 AND NOT a.attisdropped
	 ORDER BY a.attnum
	
2022-12-21 13:17:20.017 UTC [74] LOG:  unexpected EOF on client connection with an open transaction
2022-12-21 13:17:30.932 UTC [1] LOG:  received fast shutdown request
2022-12-21 13:17:30.949 UTC [1] LOG:  aborting any active transactions
2022-12-21 13:17:30.956 UTC [1] LOG:  background worker "logical replication launcher" (PID 54) exited with exit code 1
2022-12-21 13:17:30.957 UTC [49] LOG:  shutting down
2022-12-21 13:17:30.958 UTC [49] LOG:  checkpoint starting: shutdown immediate
2022-12-21 13:17:32.106 UTC [49] LOG:  checkpoint complete: wrote 3771 buffers (23.0%); 0 WAL file(s) added, 0 removed, 3 recycled; write=0.293 s, sync=0.840 s, total=1.149 s; sync files=567, longest=0.025 s, average=0.002 s; distance=43695 kB, estimate=43695 kB
2022-12-21 13:17:32.129 UTC [1] LOG:  database system is shut down

PostgreSQL Database directory appears to contain a database; Skipping initialization

2022-12-22 12:08:00.796 UTC [1] LOG:  starting PostgreSQL 15.1 on x86_64-pc-linux-musl, compiled by gcc (Alpine 12.2.1_git20220924-r4) 12.2.1 20220924, 64-bit
2022-12-22 12:08:00.796 UTC [1] LOG:  listening on IPv4 address "0.0.0.0", port 5432
2022-12-22 12:08:00.796 UTC [1] LOG:  listening on IPv6 address "::", port 5432
2022-12-22 12:08:00.800 UTC [1] LOG:  listening on Unix socket "/var/run/postgresql/.s.PGSQL.5432"
2022-12-22 12:08:00.869 UTC [23] LOG:  database system was shut down at 2022-12-21 13:17:32 UTC
2022-12-22 12:08:00.887 UTC [1] LOG:  database system is ready to accept connections
2022-12-22 12:08:02.485 UTC [27] LOG:  incomplete startup packet
2022-12-22 12:11:09.538 UTC [54] LOG:  incomplete startup packet
2022-12-22 12:13:00.968 UTC [21] LOG:  checkpoint starting: time
2022-12-22 12:13:05.104 UTC [21] LOG:  checkpoint complete: wrote 44 buffers (0.3%); 0 WAL file(s) added, 0 removed, 0 recycled; write=4.118 s, sync=0.012 s, total=4.136 s; sync files=13, longest=0.002 s, average=0.001 s; distance=91 kB, estimate=91 kB
2022-12-22 12:14:15.906 UTC [81] LOG:  incomplete startup packet
# docker logs -f zammad-docker-compose_zammad-elasticsearch_1
[2022-12-22T12:08:16,771][INFO ][o.e.h.n.s.HealthNodeTaskExecutor] [294b2c5e4186] Node [{294b2c5e4186}{TkKuKEhtT0q0PNEDAZsvpg}] is selected as the current health node.
[2022-12-22T12:08:36,808][ERROR][o.e.i.g.GeoIpDownloader  ] [294b2c5e4186] exception during geoip databases update java.net.UnknownHostException: geoip.elastic.co
	at java.base/sun.nio.ch.NioSocketImpl.connect(NioSocketImpl.java:567)
	at java.base/java.net.SocksSocketImpl.connect(SocksSocketImpl.java:327)
	at java.base/java.net.Socket.connect(Socket.java:633)
	at java.base/sun.security.ssl.SSLSocketImpl.connect(SSLSocketImpl.java:304)
	at java.base/sun.net.NetworkClient.doConnect(NetworkClient.java:178)
	at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:531)
	at java.base/sun.net.www.http.HttpClient.openServer(HttpClient.java:636)
	at java.base/sun.net.www.protocol.https.HttpsClient.<init>(HttpsClient.java:266)
	at java.base/sun.net.www.protocol.https.HttpsClient.New(HttpsClient.java:380)
	at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.getNewHttpClient(AbstractDelegateHttpsURLConnection.java:193)
	at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect0(HttpURLConnection.java:1242)
	at java.base/sun.net.www.protocol.http.HttpURLConnection.plainConnect(HttpURLConnection.java:1128)
	at java.base/sun.net.www.protocol.https.AbstractDelegateHttpsURLConnection.connect(AbstractDelegateHttpsURLConnection.java:179)
	at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream0(HttpURLConnection.java:1665)
	at java.base/sun.net.www.protocol.http.HttpURLConnection.getInputStream(HttpURLConnection.java:1589)
	at java.base/java.net.HttpURLConnection.getResponseCode(HttpURLConnection.java:529)
	at java.base/sun.net.www.protocol.https.HttpsURLConnectionImpl.getResponseCode(HttpsURLConnectionImpl.java:308)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.lambda$get$0(HttpClient.java:46)
	at java.base/java.security.AccessController.doPrivileged(AccessController.java:569)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.doPrivileged(HttpClient.java:88)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.get(HttpClient.java:40)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.HttpClient.getBytes(HttpClient.java:36)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloader.fetchDatabasesOverview(GeoIpDownloader.java:155)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloader.updateDatabases(GeoIpDownloader.java:143)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloader.runDownloader(GeoIpDownloader.java:274)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloaderTaskExecutor.nodeOperation(GeoIpDownloaderTaskExecutor.java:102)
	at org.elasticsearch.ingest.geoip@8.5.1/org.elasticsearch.ingest.geoip.GeoIpDownloaderTaskExecutor.nodeOperation(GeoIpDownloaderTaskExecutor.java:48)
	at org.elasticsearch.server@8.5.1/org.elasticsearch.persistent.NodePersistentTasksExecutor$1.doRun(NodePersistentTasksExecutor.java:42)
	at org.elasticsearch.server@8.5.1/org.elasticsearch.common.util.concurrent.ThreadContext$ContextPreservingAbstractRunnable.doRun(ThreadContext.java:892)
	at org.elasticsearch.server@8.5.1/org.elasticsearch.common.util.concurrent.AbstractRunnable.run(AbstractRunnable.java:26)
	at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136)
	at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635)
	at java.base/java.lang.Thread.run(Thread.java:833)

I tried the whole procedure again on a fresh installation of OpenSuse TW (before it was OpenSuse LEAP 15.4). Now it worked. I don’t understand if there was some residual left or if it was caused by the different package versions.

TW has:
docker 20.10.21
docker-compose 2.15.0-1.1

LEAP has:
docker 20.10.17
python-docker-compose 1.25.1

1 Like

This topic was automatically closed 120 days after the last reply. New replies are no longer allowed.