goauthentik / authentik

The authentication glue you need.
https://goauthentik.io
Other
13.03k stars 866 forks source link

initial-setup flow broken #3224

Closed sevmonster closed 2 years ago

sevmonster commented 2 years ago

Describe the bug I somehow managed to bust my installation and am getting lots of flow-related errors, so I thought it would be good to just start fresh and rebuild my flows to get rid of the accumulated cruft in my policies. However, it appears the initial-setup flow does not work:

{"event": "/api/v3/flows/executor/initial-setup/?query=", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "POST", "pid": 32, "remote": "127.0.0.1", "request_id": "370480f8cac048d1bc2af346ad29f54a", "runtime": 182, "scheme": "http", "status": 302, "timestamp": "2022-07-06T04:11:21.441677", "user": "", "user_agent": "..."}
{"event": "Aborting write to empty username", "host": "0.0.0.0:9001", "level": "warning", "logger": "authentik.flows.stage", "pid": 32, "request_id": "3a4c11734a5b40e68f10f522fea552cf", "stage": "default-password-change-write", "stage_view": "authentik.stages.user_write.stage.UserWriteStageView", "timestamp": "2022-07-06T04:11:21.849778", "user": "<User: >"}

To Reproduce Steps to reproduce the behavior:

  1. Set up new authentik container
  2. Try to fill out the initial-setup prompt stage
  3. Get the above error in the logs and "Unknown error" in the flow

Logs

server
{"event": "Loaded config", "level": "debug", "logger": "authentik.lib.config", "timestamp": 1657081660.625314, "file": "/authentik/lib/default.yml"}
{"event": "Loaded environment variables", "level": "debug", "logger": "authentik.lib.config", "timestamp": 1657081660.6258194, "count": 19}
{"event": "Starting authentik bootstrap", "level": "info", "logger": "__main__", "timestamp": 1657081660.6260169}
{"event": "Finished authentik bootstrap", "level": "info", "logger": "__main__", "timestamp": 1657081660.6441388}
{"event": "Bootstrap completed", "level": "info", "logger": "bootstrap"}
{"event": "Loaded config", "level": "debug", "logger": "authentik.lib.config", "timestamp": 1657081660.897339, "file": "/authentik/lib/default.yml"}
{"event": "Loaded environment variables", "level": "debug", "logger": "authentik.lib.config", "timestamp": 1657081660.8977575, "count": 19}
2022-07-06 04:27.40 [info
] applying django migrations
2022-07-06 04:27.40 [info
] waiting to acquire database lock
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081661.7808766, "version": "2022.7.1"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 8, "timestamp": "2022-07-06T04:27:42.304728"}
{"event": "prefilled task", "level": "debug", "logger": "authentik.events.monitored_tasks", "pid": 8, "task_name": "certificate_discovery", "timestamp": "2022-07-06T04:27:42.597181"}
{"event": "prefilled task", "level": "debug", "logger": "authentik.events.monitored_tasks", "pid": 8, "task_name": "notification_cleanup", "timestamp": "2022-07-06T04:27:42.600467"}
{"event": "prefilled task", "level": "debug", "logger": "authentik.events.monitored_tasks", "pid": 8, "task_name": "outpost_service_connection_monitor", "timestamp": "2022-07-06T04:27:42.672812"}
{"event": "prefilled task", "level": "debug", "logger": "authentik.events.monitored_tasks", "pid": 8, "task_name": "outpost_token_ensurer", "timestamp": "2022-07-06T04:27:42.673659"}
{"event": "prefilled task", "level": "debug", "logger": "authentik.events.monitored_tasks", "pid": 8, "task_name": "save_reputation", "timestamp": "2022-07-06T04:27:42.675714"}
{"event": "prefilled task", "level": "debug", "logger": "authentik.events.monitored_tasks", "pid": 8, "task_name": "update_latest_version", "timestamp": "2022-07-06T04:27:43.151556"}
{"app_mountpoint": "api/", "app_name": "authentik.api", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_api", "pid": 8, "timestamp": "2022-07-06T04:27:43.526272"}
{"app_mountpoint": "flows/", "app_name": "authentik.flows", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_flows", "pid": 8, "timestamp": "2022-07-06T04:27:43.527111"}
{"app_mountpoint": "", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2_github", "pid": 8, "timestamp": "2022-07-06T04:27:43.539725"}
{"app_mountpoint": "application/o/", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2", "pid": 8, "timestamp": "2022-07-06T04:27:43.543609"}
{"app_mountpoint": "application/saml/", "app_name": "authentik.providers.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_saml", "pid": 8, "timestamp": "2022-07-06T04:27:43.551928"}
{"app_mountpoint": "recovery/", "app_name": "authentik.recovery", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_recovery", "pid": 8, "timestamp": "2022-07-06T04:27:43.553573"}
{"app_mountpoint": "source/oauth/", "app_name": "authentik.sources.oauth", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_oauth", "pid": 8, "timestamp": "2022-07-06T04:27:43.554664"}
{"app_mountpoint": "source/saml/", "app_name": "authentik.sources.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_saml", "pid": 8, "timestamp": "2022-07-06T04:27:43.559541"}
{"app_mountpoint": "", "app_name": "authentik.core", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_core", "pid": 8, "timestamp": "2022-07-06T04:27:43.563188"}
Operations to perform:
Apply all migrations: auth, authentik_core, authentik_crypto, authentik_events, authentik_flows, authentik_outposts, authentik_policies, authentik_policies_dummy, authentik_policies_event_matcher, authentik_policies_expiry, authentik_policies_expression, authentik_policies_hibp, authentik_policies_password, authentik_policies_reputation, authentik_providers_ldap, authentik_providers_oauth2, authentik_providers_proxy, authentik_providers_saml, authentik_sources_ldap, authentik_sources_oauth, authentik_sources_plex, authentik_sources_saml, authentik_stages_authenticator_duo, authentik_stages_authenticator_sms, authentik_stages_authenticator_static, authentik_stages_authenticator_totp, authentik_stages_authenticator_validate, authentik_stages_authenticator_webauthn, authentik_stages_captcha, authentik_stages_consent, authentik_stages_deny, authentik_stages_dummy, authentik_stages_email, authentik_stages_identification, authentik_stages_invitation, authentik_stages_password, authentik_stages_prompt, authentik_stages_user_delete, authentik_stages_user_login, authentik_stages_user_logout, authentik_stages_user_write, authentik_tenants, contenttypes, guardian, otp_static, otp_totp, sessions
Running migrations:
No migrations to apply.
{"event":"Loaded config","level":"debug","path":"./authentik/lib/default.yml","timestamp":"2022-07-06T04:27:44Z"}
{"error":"Failed to load config file: open ./local.env.yml: no such file or directory","event":"no local config to load","level":"debug","logger":"authentik.root","timestamp":"2022-07-06T04:27:44Z"}
{"event":"not enabling debug server, set `AUTHENTIK_DEBUG` to `true` to enable it.","level":"info","logger":"authentik.go_debugger","timestamp":"2022-07-06T04:27:44Z"}
{"event":"Loaded config from environment","level":"debug","timestamp":"2022-07-06T04:27:44Z"}
{"args":["-c","./lifecycle/gunicorn.conf.py","authentik.root.asgi:application"],"cmd":"gunicorn","event":"Starting gunicorn","level":"debug","logger":"authentik.router.unicorn","timestamp":"2022-07-06T04:27:44Z"}
{"event":"Starting Metrics server","level":"info","listen":"0.0.0.0:9300","logger":"authentik.router.metrics","timestamp":"2022-07-06T04:27:44Z"}
{"event":"starting healthcheck","level":"debug","logger":"authentik.router.unicorn","timestamp":"2022-07-06T04:27:44Z"}
{"event":"Starting HTTP server","level":"info","listen":"0.0.0.0:9000","logger":"authentik.router","timestamp":"2022-07-06T04:27:44Z"}
{"event":"Starting HTTPS server","level":"info","listen":"0.0.0.0:9443","logger":"authentik.router","timestamp":"2022-07-06T04:27:44Z"}
{"event": "Loaded config", "level": "debug", "logger": "authentik.lib.config", "timestamp": 1657081665.367266, "file": "/authentik/lib/default.yml"}
{"event": "Loaded environment variables", "level": "debug", "logger": "authentik.lib.config", "timestamp": 1657081665.3676744, "count": 19}
1657081665.5011394 [info
] Starting gunicorn 20.1.0
[gunicorn.error]
1657081665.501773 [info
] Listening at: http://127.0.0.1:8000 (22) [gunicorn.error]
1657081665.5018651 [info
] Using worker: lifecycle.worker.DjangoUvicornWorker [gunicorn.error]
1657081665.5067632 [info
] Booting worker with pid: 23
[gunicorn.error]
1657081665.603859 [info
] Booting worker with pid: 24
[gunicorn.error]
1657081665.65604 [info
] Booting worker with pid: 25
[gunicorn.error]
1657081665.6975775 [info
] Booting worker with pid: 28
[gunicorn.error]
1657081665.7385845 [info
] Booting worker with pid: 29
[gunicorn.error]
1657081665.7737684 [info
] Booting worker with pid: 30
[gunicorn.error]
1657081665.8419914 [info
] Booting worker with pid: 31
[gunicorn.error]
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081665.884522, "version": "2022.7.1"}
1657081665.929171 [info
] Booting worker with pid: 32
[gunicorn.error]
1657081665.964813 [info
] Booting worker with pid: 33
[gunicorn.error]
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081665.9718137, "version": "2022.7.1"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.0561566, "version": "2022.7.1"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.0979495, "version": "2022.7.1"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.119814, "version": "2022.7.1"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.1730957, "version": "2022.7.1"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.2321653, "version": "2022.7.1"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 23, "timestamp": "2022-07-06T04:27:46.297122"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.3244772, "version": "2022.7.1"}
{"event": "Booting authentik", "level": "info", "logger": "authentik.root.settings", "timestamp": 1657081666.3592777, "version": "2022.7.1"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 24, "timestamp": "2022-07-06T04:27:46.374898"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 25, "timestamp": "2022-07-06T04:27:46.456848"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 28, "timestamp": "2022-07-06T04:27:46.499083"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 29, "timestamp": "2022-07-06T04:27:46.537363"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 30, "timestamp": "2022-07-06T04:27:46.575592"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 31, "timestamp": "2022-07-06T04:27:46.631240"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 32, "timestamp": "2022-07-06T04:27:46.719014"}
{"event": "Failed to load GeoIP database", "exc": "FileNotFoundError(2, 'No such file or directory')", "level": "warning", "logger": "authentik.events.geo", "pid": 33, "timestamp": "2022-07-06T04:27:46.752564"}
{"app_mountpoint": "api/", "app_name": "authentik.api", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_api", "pid": 23, "timestamp": "2022-07-06T04:27:47.651053"}
{"app_mountpoint": "flows/", "app_name": "authentik.flows", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_flows", "pid": 23, "timestamp": "2022-07-06T04:27:47.651840"}
{"app_mountpoint": "", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2_github", "pid": 23, "timestamp": "2022-07-06T04:27:47.664138"}
{"app_mountpoint": "application/o/", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2", "pid": 23, "timestamp": "2022-07-06T04:27:47.667746"}
{"app_mountpoint": "application/saml/", "app_name": "authentik.providers.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_saml", "pid": 23, "timestamp": "2022-07-06T04:27:47.675232"}
{"app_mountpoint": "recovery/", "app_name": "authentik.recovery", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_recovery", "pid": 23, "timestamp": "2022-07-06T04:27:47.676145"}
{"app_mountpoint": "source/oauth/", "app_name": "authentik.sources.oauth", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_oauth", "pid": 23, "timestamp": "2022-07-06T04:27:47.677236"}
{"app_mountpoint": "source/saml/", "app_name": "authentik.sources.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_saml", "pid": 23, "timestamp": "2022-07-06T04:27:47.681725"}
{"app_mountpoint": "", "app_name": "authentik.core", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_core", "pid": 23, "timestamp": "2022-07-06T04:27:47.685064"}
{"event": "/-/health/live/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 23, "remote": "127.0.0.1", "request_id": "db0be9b33ad24616a11884ec44ff8169", "runtime": 513, "scheme": "http", "status": 204, "timestamp": "2022-07-06T04:27:47.693148", "user": "", "user_agent": "goauthentik.io/proxy/healthcheck"}
{"event":"backend is alive, backing off with healthchecks","level":"info","logger":"authentik.router.unicorn","timestamp":"2022-07-06T04:27:47Z"}
{"event":"attempting to init outpost","level":"debug","logger":"authentik.server","timestamp":"2022-07-06T04:27:47Z"}
{"app_mountpoint": "api/", "app_name": "authentik.api", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_api", "pid": 32, "timestamp": "2022-07-06T04:27:48.153727"}
{"app_mountpoint": "flows/", "app_name": "authentik.flows", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_flows", "pid": 32, "timestamp": "2022-07-06T04:27:48.154480"}
{"app_mountpoint": "", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2_github", "pid": 32, "timestamp": "2022-07-06T04:27:48.166755"}
{"app_mountpoint": "application/o/", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2", "pid": 32, "timestamp": "2022-07-06T04:27:48.170320"}
{"app_mountpoint": "application/saml/", "app_name": "authentik.providers.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_saml", "pid": 32, "timestamp": "2022-07-06T04:27:48.177944"}
{"app_mountpoint": "recovery/", "app_name": "authentik.recovery", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_recovery", "pid": 32, "timestamp": "2022-07-06T04:27:48.178872"}
{"app_mountpoint": "source/oauth/", "app_name": "authentik.sources.oauth", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_oauth", "pid": 32, "timestamp": "2022-07-06T04:27:48.179979"}
{"app_mountpoint": "source/saml/", "app_name": "authentik.sources.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_saml", "pid": 32, "timestamp": "2022-07-06T04:27:48.184485"}
{"app_mountpoint": "", "app_name": "authentik.core", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_core", "pid": 32, "timestamp": "2022-07-06T04:27:48.187775"}
{"auth_via": "secret_key", "event": "/api/v3/outposts/instances/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "649a9c809a664440baad5d97a68f374a", "runtime": 609, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:27:48.310346", "user": "ak-outpost-0e751a4cc7734ea0b190ee069b9ebc7e", "user_agent": "goauthentik.io/outpost/2022.7.1"}
{"event":"Fetched outpost configuration","level":"debug","logger":"authentik.outpost.ak-api-controller","name":"authentik Embedded Outpost","timestamp":"2022-07-06T04:27:48Z"}
{"auth_via": "secret_key", "event": "/api/v3/root/config/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "effe0b42e1d647b6aeee5a76473d663f", "runtime": 101, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:27:48.419200", "user": "ak-outpost-0e751a4cc7734ea0b190ee069b9ebc7e", "user_agent": "goauthentik.io/outpost/2022.7.1"}
{"event":"Fetched global configuration","level":"debug","logger":"authentik.outpost.ak-api-controller","timestamp":"2022-07-06T04:27:48Z"}
{"event":"HA Reload offset","level":"debug","logger":"authentik.outpost.ak-api-controller","offset":"7s","timestamp":"2022-07-06T04:27:48Z"}
{"event":"Successfully connected websocket","level":"debug","logger":"authentik.outpost.ak-ws","outpost":"0e751a4c-c773-4ea0-b190-ee069b9ebc7e","timestamp":"2022-07-06T04:27:48Z"}{"event":"Enabled USR1 hook to reload","level":"debug","logger":"authentik.outpost.ak-api-controller","timestamp":"2022-07-06T04:27:48Z"}
{"auth_via": "secret_key", "event": "added outpost instance to cache", "instance_uuid": "a0a41671-9baf-4a65-a0b5-8d49a084f8f6", "level": "debug", "logger": "authentik.outposts.channels", "outpost": "<Outpost: Outpost authentik Embedded Outpost>", "pid": 32, "timestamp": "2022-07-06T04:27:48.496388"}
{"event":"Starting Tenant TLS Checker","level":"info","logger":"authentik.router.tenant_tls","timestamp":"2022-07-06T04:27:48Z"}
{"event":"updating tenant certificates","level":"info","logger":"authentik.router.tenant_tls","timestamp":"2022-07-06T04:27:48Z"}
{"auth_via": "secret_key", "event": "/api/v3/core/tenants/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "0ef2acdf68154663a7e85ba109485d7b", "runtime": 61, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:27:48.721022", "user": "ak-outpost-0e751a4cc7734ea0b190ee069b9ebc7e", "user_agent": "goauthentik.io/outpost/2022.7.1"}
{"event":"attempting to start outpost","level":"debug","logger":"authentik.server","timestamp":"2022-07-06T04:27:48Z"}
{"event":"Starting periodical timer...","level":"debug","logger":"authentik.outpost.ak-api-controller","timestamp":"2022-07-06T04:27:48Z"}
{"event":"Starting WS Handler...","level":"debug","logger":"authentik.outpost.ak-api-controller","timestamp":"2022-07-06T04:27:48Z"}
{"event":"Starting WS Health notifier...","level":"debug","logger":"authentik.outpost.ak-api-controller","timestamp":"2022-07-06T04:27:48Z"}
{"event":"Starting Interval updater...","level":"debug","logger":"authentik.outpost.ak-api-controller","timestamp":"2022-07-06T04:27:48Z"}
{"event":"Running interval update","level":"debug","logger":"authentik.outpost.ak-api-controller","loop":"interval-updater","timestamp":"2022-07-06T04:27:48Z"}
{"event":"hello'd","level":"trace","logger":"authentik.outpost.ak-api-controller","loop":"ws-health","timestamp":"2022-07-06T04:27:48Z"}
{"auth_via": "secret_key", "event": "/api/v3/outposts/instances/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "53807d4971634b6d88c6b9f207dc1769", "runtime": 93, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:27:49.010975", "user": "ak-outpost-0e751a4cc7734ea0b190ee069b9ebc7e", "user_agent": "goauthentik.io/outpost/2022.7.1"}
{"event":"Fetched outpost configuration","level":"debug","logger":"authentik.outpost.ak-api-controller","name":"authentik Embedded Outpost","timestamp":"2022-07-06T04:27:49Z"}
{"event":"Managed outpost, not setting global log level","level":"debug","logger":"authentik.outpost","timestamp":"2022-07-06T04:27:49Z"}
{"event":"Starting authentik outpost","hash":"tagged","level":"info","logger":"authentik.outpost","timestamp":"2022-07-06T04:27:49Z","version":"2022.7.1"}
{"auth_via": "secret_key", "event": "/api/v3/outposts/proxy/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "7bb02e4403f0489b89934c6b24bbeebd", "runtime": 79, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:27:49.095465", "user": "ak-outpost-0e751a4cc7734ea0b190ee069b9ebc7e", "user_agent": "goauthentik.io/outpost/2022.7.1"}
{"event":"Swapped maps","level":"debug","logger":"authentik.outpost.proxyv2","timestamp":"2022-07-06T04:27:49Z"}
{"event":"updating tenant certificates","level":"info","logger":"authentik.router.tenant_tls","timestamp":"2022-07-06T04:27:49Z"}
{"auth_via": "secret_key", "event": "/api/v3/core/tenants/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "05cc2a04a2484da992f4cad92de5e0ed", "runtime": 73, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:27:49.173243", "user": "ak-outpost-0e751a4cc7734ea0b190ee069b9ebc7e", "user_agent": "goauthentik.io/outpost/2022.7.1"}
{"event":"hello'd","level":"trace","logger":"authentik.outpost.ak-api-controller","loop":"ws-health","timestamp":"2022-07-06T04:27:58Z"}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:05Z"}
{"event":"tracing request to backend","headers":{"Accept":["text/html,application/xhtml+xml,application/xml;q=0.9,image/avif,image/webp,image/apng,*/*;q=0.8,application/signed-exchange;v=b3;q=0.9"],"Accept-Language":["en-US,en;q=0.9"],"Cache-Control":["max-age=0"],"Connection":["keep-alive"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9; authentik_session=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzaWQiOiJ6dmo4eGM0d3h6aGZyZTBiZncxaHpseWdzaHlycGw2MSIsImlzcyI6ImF1dGhlbnRpayIsInN1YiI6ImFub255bW91cyIsImF1dGhlbnRpY2F0ZWQiOmZhbHNlLCJhY3IiOiJnb2F1dGhlbnRpay5pby9jb3JlL2RlZmF1bHQifQ.uo_cB4nstwPyF1j4ejMzisdQg3HLkS-5Mz0j7fbo3wI"],"Dnt":["1"],"Upgrade-Insecure-Requests":["1"],"User-Agent":["..."]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:05Z","url":"http://localhost:8000/if/flow/initial-setup/"}
{"event": "/if/flow/initial-setup/", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "25bdcadb4b3e48738c268fbeb0df4354", "runtime": 72, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:28:05.550791", "user": "", "user_agent": "..."}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z"}
{"event":"tracing request to backend","headers":{"Accept-Encoding":["gzip, deflate"],"Accept-Language":["en-US,en;q=0.9"],"Cache-Control":["no-cache"],"Connection":["Upgrade"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"],"Origin":["http://0.0.0.0:9001"],"Pragma":["no-cache"],"Sec-Websocket-Extensions":["permessage-deflate; client_max_window_bits"],"Sec-Websocket-Key":["rh1yV+SIuKME1IRXPEmzRw=="],"Sec-Websocket-Version":["13"],"Upgrade":["websocket"],"User-Agent":["..."]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z","url":"http://localhost:8000/ws/client/"}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z"}
{"event":"tracing request to backend","headers":{"Accept":["*/*"],"Accept-Language":["en-US,en;q=0.9"],"Connection":["keep-alive"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"],"Dnt":["1"],"Referer":["http://0.0.0.0:9001/if/flow/initial-setup/"],"Sentry-Trace":["4d990a46b9e54d7f9c4867c3688033d0-90f5ed8b455c0a38-0"],"User-Agent":["..."],"X-Authentik-Csrf":["r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z","url":"http://localhost:8000/api/v3/core/tenants/current/"}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z"}
{"event":"tracing request to backend","headers":{"Accept":["*/*"],"Accept-Language":["en-US,en;q=0.9"],"Connection":["keep-alive"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"],"Dnt":["1"],"Referer":["http://0.0.0.0:9001/if/flow/initial-setup/"],"Sentry-Trace":["4d990a46b9e54d7f9c4867c3688033d0-90f5ed8b455c0a38-0"],"User-Agent":["..."],"X-Authentik-Csrf":["r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z","url":"http://localhost:8000/api/v3/root/config/"}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z"}
{"event":"tracing request to backend","headers":{"Accept":["*/*"],"Accept-Language":["en-US,en;q=0.9"],"Connection":["keep-alive"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"],"Dnt":["1"],"Referer":["http://0.0.0.0:9001/if/flow/initial-setup/"],"Sentry-Trace":["4d990a46b9e54d7f9c4867c3688033d0-90f5ed8b455c0a38-0"],"User-Agent":["..."],"X-Authentik-Csrf":["r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:06Z","url":"http://localhost:8000/api/v3/flows/executor/initial-setup/?query="}
{"event": "/api/v3/core/tenants/current/", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "acc8ac931e6d419ebe4937d023db213b", "runtime": 38, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:28:07.011146", "user": "", "user_agent": "..."}
{"event": "/api/v3/root/config/", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 32, "remote": "127.0.0.1", "request_id": "e6bc98c97a7d4bc2b606b465b587980f", "runtime": 24, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:28:07.025439", "user": "", "user_agent": "..."}
{"app_mountpoint": "api/", "app_name": "authentik.api", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_api", "pid": 31, "timestamp": "2022-07-06T04:28:07.557823"}
{"app_mountpoint": "flows/", "app_name": "authentik.flows", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_flows", "pid": 31, "timestamp": "2022-07-06T04:28:07.558671"}
{"app_mountpoint": "", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2_github", "pid": 31, "timestamp": "2022-07-06T04:28:07.571132"}
{"app_mountpoint": "application/o/", "app_name": "authentik.providers.oauth2", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_oauth2", "pid": 31, "timestamp": "2022-07-06T04:28:07.574719"}
{"app_mountpoint": "application/saml/", "app_name": "authentik.providers.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_providers_saml", "pid": 31, "timestamp": "2022-07-06T04:28:07.582252"}
{"app_mountpoint": "recovery/", "app_name": "authentik.recovery", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_recovery", "pid": 31, "timestamp": "2022-07-06T04:28:07.583202"}
{"app_mountpoint": "source/oauth/", "app_name": "authentik.sources.oauth", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_oauth", "pid": 31, "timestamp": "2022-07-06T04:28:07.584278"}
{"app_mountpoint": "source/saml/", "app_name": "authentik.sources.saml", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_sources_saml", "pid": 31, "timestamp": "2022-07-06T04:28:07.588815"}
{"app_mountpoint": "", "app_name": "authentik.core", "event": "Mounted URLs", "level": "debug", "logger": "authentik.root.urls", "namespace": "authentik_core", "pid": 31, "timestamp": "2022-07-06T04:28:07.592127"}
{"event": "f(exec): No active Plan found, initiating planner", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.638291"}
{"event": "f(plan): starting planning process", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.638743"}
{"binding": "<PolicyBinding: Binding from Flow default-oobe-setup (initial-setup) #0 to Policy default-oobe-password-usable>", "event": "P_ENG: Evaluating policy", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.engine", "pid": 31, "request": "<PolicyRequest user=AnonymousUser obj=Flow default-oobe-setup (initial-setup) http_request=<ASGIRequest: GET '/api/v3/flows/executor/initial-setup/?query='>>", "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.666138"}
{"binding": "<PolicyBinding: Binding from Flow default-oobe-setup (initial-setup) #0 to Policy default-oobe-password-usable>", "event": "P_ENG: Starting Process", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.engine", "pid": 31, "request": "<PolicyRequest user=AnonymousUser obj=Flow default-oobe-setup (initial-setup) http_request=<ASGIRequest: GET '/api/v3/flows/executor/initial-setup/?query='>>", "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.702750"}
{"event": "P_ENG(proc): Running policy", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.process", "pid": 31, "policy": "<ExpressionPolicy: default-oobe-password-usable>", "process": "PolicyProcess", "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.705277", "user": ""}
{"event": "P_ENG(proc): finished and cached ", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.process", "passing": true, "pid": 31, "policy": "<ExpressionPolicy: default-oobe-password-usable>", "process": "PolicyProcess", "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "result": "<PolicyResult passing=True>", "timestamp": "2022-07-06T04:28:07.716356", "user": ""}
{"event": "f(plan): building plan", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.720082"}
{"event": "f(plan): evaluating on plan", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<PromptStage: Stage default-oobe-password>", "timestamp": "2022-07-06T04:28:07.777490"}
{"event": "f(plan): stage passing", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<PromptStage: Stage default-oobe-password>", "timestamp": "2022-07-06T04:28:07.783220"}
{"event": "f(plan): not evaluating on plan", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<UserWriteStage: Stage default-password-change-write>", "timestamp": "2022-07-06T04:28:07.804927"}
{"event": "f(plan): stage has re-evaluate marker", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<UserWriteStage: Stage default-password-change-write>", "timestamp": "2022-07-06T04:28:07.805417"}
{"event": "f(plan): evaluating on plan", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<UserLoginStage: Stage default-authentication-login>", "timestamp": "2022-07-06T04:28:07.828823"}
{"event": "f(plan): stage passing", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<UserLoginStage: Stage default-authentication-login>", "timestamp": "2022-07-06T04:28:07.834804"}
{"event": "f(plan): finished building", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.835384"}
{"current_stage": "<PromptStage: Stage default-oobe-password>", "event": "f(exec): Current stage", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "timestamp": "2022-07-06T04:28:07.837469"}
{"event": "f(exec): Passing GET", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "stage": "<PromptStage: Stage default-oobe-password>", "timestamp": "2022-07-06T04:28:07.838774", "view_class": "authentik.stages.prompt.stage.PromptStageView"}
{"event": "/api/v3/flows/executor/initial-setup/?query=", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 31, "remote": "127.0.0.1", "request_id": "8009fc5f5e3d486a9c470d13c4362e1a", "runtime": 952, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:28:07.952799", "user": "", "user_agent": "..."} {"event":"hello'd","level":"trace","logger":"authentik.outpost.ak-api-controller","loop":"ws-health","timestamp":"2022-07-06T04:28:08Z"}
{"event":"routing to application server","host":"localhost:9000","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:10Z"}
{"event":"tracing request to backend","headers":{"Accept":["*/*"],"User-Agent":["goauthentik.io lifecycle Healthcheck"]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:10Z","url":"http://localhost:8000/-/health/ready/"}
{"event": "/-/health/ready/", "host": "localhost:9000", "level": "info", "logger": "authentik.asgi", "method": "HEAD", "pid": 31, "remote": "127.0.0.1", "request_id": "27e161ad5ee745ec95a77f9b5aacda20", "runtime": 22, "scheme": "http", "status": 204, "timestamp": "2022-07-06T04:28:10.526425", "user": "", "user_agent": "goauthentik.io lifecycle Healthcheck"}
{"event": "/-/health/live/", "host": "localhost:8000", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 31, "remote": "127.0.0.1", "request_id": "ec1d00cbf36b48d790e1c717437ebf5b", "runtime": 26, "scheme": "http", "status": 204, "timestamp": "2022-07-06T04:28:17.726347", "user": "", "user_agent": "goauthentik.io/proxy/healthcheck"}
{"event":"hello'd","level":"trace","logger":"authentik.outpost.ak-api-controller","loop":"ws-health","timestamp":"2022-07-06T04:28:18Z"}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:20Z"}
{"event":"tracing request to backend","headers":{"Accept":["*/*"],"Accept-Language":["en-US,en;q=0.9"],"Connection":["keep-alive"],"Content-Length":["109"],"Content-Type":["application/json"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9; authentik_session=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzaWQiOiJzdHU0dGo5N2puMGx1NzVlN2MybzU5bzdya2cxYzR1cCIsImlzcyI6ImF1dGhlbnRpayIsInN1YiI6ImFub255bW91cyIsImF1dGhlbnRpY2F0ZWQiOmZhbHNlLCJhY3IiOiJnb2F1dGhlbnRpay5pby9jb3JlL2RlZmF1bHQifQ.sOFjF4o2ZDbQtlRFXLzsoI5PFfxE1Py5JXFXEVUPY88"],"Dnt":["1"],"Origin":["http://0.0.0.0:9001"],"Referer":["http://0.0.0.0:9001/if/flow/initial-setup/"],"Sentry-Trace":["4d990a46b9e54d7f9c4867c3688033d0-90f5ed8b455c0a38-0"],"User-Agent":["..."],"X-Authentik-Csrf":["r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:20Z","url":"http://localhost:8000/api/v3/flows/executor/initial-setup/?query="}
{"event": "f(exec): Continuing existing plan", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "243c622ce5844cc1a9eccc7ad8fe31d9", "timestamp": "2022-07-06T04:28:20.817910"}
{"current_stage": "<PromptStage: Stage default-oobe-password>", "event": "f(exec): Current stage", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "243c622ce5844cc1a9eccc7ad8fe31d9", "timestamp": "2022-07-06T04:28:20.818232"}
{"event": "f(exec): Passing POST", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "243c622ce5844cc1a9eccc7ad8fe31d9", "stage": "<PromptStage: Stage default-oobe-password>", "timestamp": "2022-07-06T04:28:20.818749", "view_class": "authentik.stages.prompt.stage.PromptStageView"}
{"event": "f(exec): Stage ok", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "243c622ce5844cc1a9eccc7ad8fe31d9", "stage_class": "authentik.stages.prompt.stage.PromptStageView", "timestamp": "2022-07-06T04:28:20.858218"}
{"event": "f(exec): Continuing with next stage", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "remaining": 2, "request_id": "243c622ce5844cc1a9eccc7ad8fe31d9", "timestamp": "2022-07-06T04:28:20.860042"}
{"event": "/api/v3/flows/executor/initial-setup/?query=", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "POST", "pid": 31, "remote": "127.0.0.1", "request_id": "243c622ce5844cc1a9eccc7ad8fe31d9", "runtime": 179, "scheme": "http", "status": 302, "timestamp": "2022-07-06T04:28:20.964780", "user": "", "user_agent": "..."}
{"event":"routing to application server","host":"0.0.0.0:9001","level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:21Z"}
{"event":"tracing request to backend","headers":{"Accept":["*/*"],"Accept-Language":["en-US,en;q=0.9"],"Connection":["keep-alive"],"Cookie":["authentik_csrf=r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9; authentik_session=eyJ0eXAiOiJKV1QiLCJhbGciOiJIUzI1NiJ9.eyJzaWQiOiJzdHU0dGo5N2puMGx1NzVlN2MybzU5bzdya2cxYzR1cCIsImlzcyI6ImF1dGhlbnRpayIsInN1YiI6ImFub255bW91cyIsImF1dGhlbnRpY2F0ZWQiOmZhbHNlLCJhY3IiOiJnb2F1dGhlbnRpay5pby9jb3JlL2RlZmF1bHQifQ.sOFjF4o2ZDbQtlRFXLzsoI5PFfxE1Py5JXFXEVUPY88"],"Dnt":["1"],"Referer":["http://0.0.0.0:9001/if/flow/initial-setup/"],"Sentry-Trace":["4d990a46b9e54d7f9c4867c3688033d0-90f5ed8b455c0a38-0"],"User-Agent":["..."],"X-Authentik-Csrf":["r7VZPDqPk0zZtfdY70ex1OXpc6AdljwbUCRUDOzXMgfrdBzjxRtpzzCe9xPU8yl9"]},"level":"trace","logger":"authentik.router","timestamp":"2022-07-06T04:28:21Z","url":"http://localhost:8000/api/v3/flows/executor/initial-setup/?query="}
{"event": "f(exec): Continuing existing plan", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.061293"}
{"binding": "<FlowStageBinding: Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33>", "event": "f(plan_inst): stage has marker", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.planner", "marker": "ReevaluateMarker(binding=<FlowStageBinding: Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33>)", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.061585"}
{"binding": "<FlowStageBinding: Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33>", "event": "f(plan_inst): running re-evaluation", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.markers", "marker": "ReevaluateMarker", "pid": 31, "policy_binding": "<FlowStageBinding: Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33>", "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.061898"}
{"binding": "<PolicyBinding: Binding from Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33 #0 to Policy default-oobe-prefill-user>", "event": "P_ENG: Evaluating policy", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.engine", "pid": 31, "request": "<PolicyRequest user=AnonymousUser obj=Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33 http_request=<ASGIRequest: GET '/api/v3/flows/executor/initial-setup/?query='>>", "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.077460"}
{"binding": "<PolicyBinding: Binding from Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33 #0 to Policy default-oobe-prefill-user>", "event": "P_ENG: Starting Process", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.engine", "pid": 31, "request": "<PolicyRequest user=AnonymousUser obj=Flow-stage binding #20 to 39f38529-3375-47db-a6d7-2edcf3608f33 http_request=<ASGIRequest: GET '/api/v3/flows/executor/initial-setup/?query='>>", "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.095738"}
{"event": "P_ENG(proc): Running policy", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.process", "pid": 31, "policy": "<ExpressionPolicy: default-oobe-prefill-user>", "process": "PolicyProcess", "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.097485", "user": ""}
{"event": "P_ENG(proc): finished and cached ", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.policies.process", "passing": true, "pid": 31, "policy": "<ExpressionPolicy: default-oobe-prefill-user>", "process": "PolicyProcess", "request_id": "96a30e4a035344d4830799361c500aa1", "result": "<PolicyResult passing=True>", "timestamp": "2022-07-06T04:28:21.103935", "user": ""}
{"current_stage": "<UserWriteStage: Stage default-password-change-write>", "event": "f(exec): Current stage", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.105824"}
{"event": "f(exec): Passing GET", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "stage": "<UserWriteStage: Stage default-password-change-write>", "timestamp": "2022-07-06T04:28:21.106658", "view_class": "authentik.stages.user_write.stage.UserWriteStageView"}
{"event": "Created new user", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.stage", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "stage": "default-password-change-write", "stage_view": "authentik.stages.user_write.stage.UserWriteStageView", "timestamp": "2022-07-06T04:28:21.107238"}
{"event": "discarding key", "host": "0.0.0.0:9001", "key": "component", "level": "debug", "logger": "authentik.flows.stage", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "stage": "default-password-change-write", "stage_view": "authentik.stages.user_write.stage.UserWriteStageView", "timestamp": "2022-07-06T04:28:21.107583"}
{"event": "discarding key", "host": "0.0.0.0:9001", "key": "password_repeat", "level": "debug", "logger": "authentik.flows.stage", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "stage": "default-password-change-write", "stage_view": "authentik.stages.user_write.stage.UserWriteStageView", "timestamp": "2022-07-06T04:28:21.391347"}
{"event": "discarding key", "host": "0.0.0.0:9001", "key": "oobe-header-text", "level": "debug", "logger": "authentik.flows.stage", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "stage": "default-password-change-write", "stage_view": "authentik.stages.user_write.stage.UserWriteStageView", "timestamp": "2022-07-06T04:28:21.391531"}
{"event": "Aborting write to empty username", "host": "0.0.0.0:9001", "level": "warning", "logger": "authentik.flows.stage", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "stage": "default-password-change-write", "stage_view": "authentik.stages.user_write.stage.UserWriteStageView", "timestamp": "2022-07-06T04:28:21.391696", "user": "<User: >"}
{"event": "f(exec): Stage invalid", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.391876"}
{"event": "f(exec): cleaning up", "flow_slug": "initial-setup", "host": "0.0.0.0:9001", "level": "debug", "logger": "authentik.flows.views.executor", "pid": 31, "request_id": "96a30e4a035344d4830799361c500aa1", "timestamp": "2022-07-06T04:28:21.392025"}
{"event": "/api/v3/flows/executor/initial-setup/?query=", "host": "0.0.0.0:9001", "level": "info", "logger": "authentik.asgi", "method": "GET", "pid": 31, "remote": "127.0.0.1", "request_id": "96a30e4a035344d4830799361c500aa1", "runtime": 368, "scheme": "http", "status": 200, "timestamp": "2022-07-06T04:28:21.397325", "user": "", "user_agent": "..."}
config
{"event": "Loaded config", "level": "debug", "logger": "__main__", "timestamp": 1657082619.2931974, "file": "/authentik/lib/default.yml"}
{"event": "Loaded environment variables", "level": "debug", "logger": "__main__", "timestamp": 1657082619.2937086, "count": 19}
{
    "postgresql": {
        "host": "host.docker.internal",
        "name": "authentik",
        "user": "authentik",
        "port": 5432,
        "password": "moocow"
    },
    "web": {
        "listen": "0.0.0.0:9000",
        "listen_tls": "0.0.0.0:9443",
        "listen_metrics": "0.0.0.0:9300",
        "outpost_port_offset": 0
    },
    "redis": {
        "host": "redis",
        "port": 6379,
        "password": "",
        "tls": false,
        "tls_reqs": "none",
        "cache_db": 0,
        "message_queue_db": 1,
        "ws_db": 2,
        "outpost_session_db": 3,
        "cache_timeout": 300,
        "cache_timeout_flows": 300,
        "cache_timeout_policies": 300,
        "cache_timeout_reputation": 300
    },
    "debug": false,
    "log_level": "trace",
    "error_reporting": {
        "enabled": false,
        "environment": "customer",
        "send_pii": false,
        "sample_rate": 0.3
    },
    "email": {
        "host": "host.docker.internal",
        "port": 25,
        "username": "",
        "password": "",
        "use_tls": true,
        "use_ssl": false,
        "timeout": 10,
        "from": "notspam@veryrealemail.com"
    },
    "outposts": {
        "container_image_base": "ghcr.io/goauthentik/%(type)s:%(version)s",
        "discover": true
    },
    "ldap": {
        "tls": {
            "ciphers": null
        }
    },
    "cookie_domain": null,
    "disable_update_check": true,
    "disable_startup_analytics": true,
    "avatars": "https://milk.town/%(username).png",
    "geoip": "/geoip/GeoLite2-City.mmdb",
    "footer_links": [],
    "default_user_change_name": true,
    "default_user_change_email": true,
    "default_user_change_username": false,
    "gdpr_compliance": true,
    "cert_discovery_dir": "/certs",
    "default_token_length": 128,
    "impersonation": true,
    "secret_key": "moocow",
    "tag": "latest",
    "image": "ghcr.io/goauthentik/server"
}

Version and Deployment (please complete the following information):

Additional context I also noticed the workers will hang seemingly indefinitely because they try to use the database before the migrations are applied and the schema set up. This goes away with a restart though so I don't know if it is worthy for a separate issue.

morganmattr commented 2 years ago

As a new user, I was stumbling into this for the last 2 hours on 2022.7.1 and couldn't figure out what I was doing wrong. Once I switched to the build from 2022.6.3, it was resolved! Thank you for posting this.

BeryJu commented 2 years ago

d'oh, my bad for not testing that, this was caused by the 3rd breaking change here https://goauthentik.io/docs/releases/2022.7