hasura / hasura/graphql-engine
Hangs on Already at the latest catalog version (40); nothing to do.
- Dominant language
- TypeScript
- Stars
- 32.1k
- Forks
- 3k
- PR merge metrics
- PR metrics pending
Description
When I'm trying to run Hasura (ie after a restart or failed migration) it often hangs on ```Already at the latest catalog version (40); nothing to do.``` Even though the postgres database still seems to be untouched.
When I throw out all images containers and volumes I still get this error. Only once I factory reset docker desktop it manages to run the migrations again and start.
I'm using Docker desktop 3.2.2 (Mac)
Dockerfile
```
FROM hasura/graphql-engine:v1.3.3.cli-migrations
COPY ./migrations /hasura-migrations
```
hasura logs
```
{"timestamp":"2021-04-02T08:16:31.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"database url for migrations is set by HASURA_GRAPHQL_DATABASE_URL"}}
{"timestamp":"2021-04-02T08:16:31.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"migrations server port env var is not set, defaulting to 9691"}}
{"timestamp":"2021-04-02T08:16:31.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"server timeout is not set, defaulting to 30 seconds"}}
{"timestamp":"2021-04-02T08:16:31.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"starting graphql engine temporarily on port 9691"}}
{"timestamp":"2021-04-02T08:16:31.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"waiting 30 for 9691 to be ready"}}
{"type":"startup","timestamp":"2021-04-02T08:16:31.753+0000","level":"info","detail":{"kind":"server_configuration","info":{"live_query_options":{"batch_size":100,"refetch_delay":1},"transaction_isolation":"ISOLATION LEVEL READ COMMITTED","plan_cache_options":{"plan_cache_size":4000},"enabled_log_types":["http-log","websocket-log","startup","webhook-log","query-log"],"server_host":"HostAny","enable_allowlist":false,"log_level":"info","auth_hook_mode":null,"use_prepared_statements":true,"unauth_role":null,"stringify_numeric_types":false,"enabled_apis":["metadata"],"enable_telemetry":true,"enable_console":true,"auth_hook":null,"jwt_secret":{"audience":null,"claims_format":"json","claims_namespace":"https://hasura.io/jwt/claims","jwk_url":"xxxx/auth/jwks","issuer":null},"cors_config":{"allowed_origins":"*","disabled":false,"ws_read_cookie":null},"console_assets_dir":null,"admin_secret_set":true,"port":9691}}}
{"type":"startup","timestamp":"2021-04-02T08:16:31.753+0000","level":"info","detail":{"kind":"postgres_connection","info":{"retries":1,"database_url":"xxxxxx"}}}
Error fetching JWK: ConnectionFailure Network.Socket.connect: : does not exist (Connection refused)
{"timestamp":"2021-04-02T08:17:01.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"failed waiting for 9691, try increasing HASURA_GRAPHQL_MIGRATIONS_SERVER_TIMEOUT (default: 30)"}}
{"timestamp":"2021-04-02T08:17:02.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"database url for migrations is set by HASURA_GRAPHQL_DATABASE_URL"}}
{"timestamp":"2021-04-02T08:17:02.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"migrations server port env var is not set, defaulting to 9691"}}
{"timestamp":"2021-04-02T08:17:02.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"server timeout is not set, defaulting to 30 seconds"}}
{"timestamp":"2021-04-02T08:17:02.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"starting graphql engine temporarily on port 9691"}}
{"timestamp":"2021-04-02T08:17:02.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"waiting 30 for 9691 to be ready"}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"server_configuration","info":{"live_query_options":{"batch_size":100,"refetch_delay":1},"transaction_isolation":"ISOLATION LEVEL READ COMMITTED","plan_cache_options":{"plan_cache_size":4000},"enabled_log_types":["http-log","websocket-log","startup","webhook-log","query-log"],"server_host":"HostAny","enable_allowlist":false,"log_level":"info","auth_hook_mode":null,"use_prepared_statements":true,"unauth_role":null,"stringify_numeric_types":false,"enabled_apis":["metadata"],"enable_telemetry":true,"enable_console":true,"auth_hook":null,"jwt_secret":{"audience":null,"claims_format":"json","claims_namespace":"https://hasura.io/jwt/claims","jwk_url":"http://xxxxx/auth/jwks","issuer":null},"cors_config":{"allowed_origins":"*","disabled":false,"ws_read_cookie":null},"console_assets_dir":null,"admin_secret_set":true,"port":9691}}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"postgres_connection","info":{"retries":1,"database_url":"xxxxx"}}}
{"timestamp":"2021-04-02T08:17:03.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"port 9691 is ready"}}
{"timestamp":"2021-04-02T08:17:03.000+0000","level":"info","type":"startup","detail":{"kind":"checking for migrations directory","info":""}}
{"timestamp":"2021-04-02T08:17:03.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-startup","info":"env var HASURA_GRAPHQL_MIGRATIONS_DIR is not set, defaulting to /hasura-migrations"}}
{"timestamp":"2021-04-02T08:17:03.000+0000","level":"info","type":"startup","detail":{"kind":"migrations-apply","info":"applying migrations from /hasura-migrations"}}
{"type":"jwk-refresh-log","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"error":{"error":"could not find max-age/s-maxage","message":"Failed parsing Cache-Control header from JWK response. Could not find max-age or s-maxage"},"message":null}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"schema-sync","info":{"thread_id":"ThreadId 28","instance_id":"d4e6c955-ef00-4f5e-8d24-3ccaa64d529b","message":"listener thread started"}}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"schema-sync","info":{"thread_id":"ThreadId 29","instance_id":"d4e6c955-ef00-4f5e-8d24-3ccaa64d529b","message":"processor thread started"}}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"event_triggers","info":"preparing data"}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"event_triggers","info":"starting workers"}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"scheduled_triggers","info":"preparing data"}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"telemetry","info":"Help us improve Hasura! The graphql-engine server collects anonymized usage stats which allows us to keep improving Hasura at warp speed. To read more or opt-out, visit https://hasura.io/docs/1.0/graphql/manual/guides/telemetry.html"}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"server","info":{"time_taken":0.358736765,"message":"starting API server"}}}
{"type":"startup","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"kind":"catalog_migrate","info":"Already at the latest catalog version (40); nothing to do."}}
{"type":"jwk-refresh-log","timestamp":"2021-04-02T08:17:02.336+0000","level":"info","detail":{"error":null,"message":"refreshing JWK from endpoint: http://sd-backend-plus:3020/auth/jwks"}}
```
Contributor guide
Assessment
This issue has not been assessed yet.