chore(release): 0.3.1

feat: adjust config to prod environment
chore(release): 0.3.0
2026-08-19 08:30:05 +02:00 · 2026-08-19 08:28:18 +02:00 · 2026-08-14 08:44:02 +02:00 · 2026-08-14 08:16:54 +02:00 · 2026-08-13 11:01:18 +02:00
11 changed files with 557 additions and 146 deletions
@@ -26,5 +26,5 @@ BACKEND_BASE_URL=https://backend.corp.internal/api
 ###> appsmith apps ###
 # One line per Appsmith app you register — add more as you build more apps,
 # and add a matching line in config/services.yaml under appsmith.apps.
-APP_SANDBOX_LOGIN_URL=https://appsmith.corp.internal/app/sandbox/login-abc123
+APP_SANDBOX_URL=https://appsmith.corp.internal/app/app-sandbox/login-1234567890abcdef
 ###< appsmith apps ###
@@ -4,6 +4,25 @@
 All notable changes to this project will be documented in this file.
 <!--- END HEADER -->

+## [0.3.1](https://git.fromme.dev/ep/appsmith-bff/compare/v0.3.0...v0.3.1) (2026-08-19)
+
+### Features
+
+* Adjust config to prod environment ([0335f4](https://git.fromme.dev/ep/appsmith-bff/commit/0335f48c485b48ada293a4824163e0580dd7a3f8))
+
+
+---
+
+## [0.3.0](https://git.fromme.dev/ep/appsmith-bff/compare/v0.2.0...v0.3.0) (2026-08-14)
+
+### Features
+
+* Auth verification endpoint ([cc46d8](https://git.fromme.dev/ep/appsmith-bff/commit/cc46d8c812abaf2fce879fc5d0a8d8f39a3d2043))
+* Dedicated logging for auth and api calls ([e28b78](https://git.fromme.dev/ep/appsmith-bff/commit/e28b789af200d2b4cf368db4626cb25735e70206))
+
+
+---
+
 ## [0.2.0](https://git.fromme.dev/ep/appsmith-bff/compare/v0.1.0...v0.2.0) (2026-08-12)

 ### Features
@@ -68,11 +68,11 @@ Setup in Keycloak:
 3. Put users in whichever groups they need.
 4. Client → **Client scopes** → `<client>-dedicated` → **Mappers** → confirm a "client roles" mapper exists with **Add to access token** enabled (default for new clients).

-Where this is enforced: the access role is checked once, in `AuthController::callback`, against `resource_access.<client_id>.roles` on the access token right after login. The `/api/*` proxy does not re-check anything per request.
+Where this is enforced: the access role is checked in `AuthController::callback` against `resource_access.<client_id>.roles` on the access token right after login, and re-checked on every `/auth/verify` and `/auth/me` call against the role list held on the session. Without it those two answer `403 {"error":"access_denied"}` — this is what stops one app's `sid` from being a skeleton key to another app's UI, since one session is shared by every app the user opens. The `/api/*` proxy still does not re-check anything per request (it has no way to know which app is calling).

-Permissions are **not** enforced by the BFF at all. `/auth/me` reports them so an app can hide or disable widgets, but anyone holding a `sid` can call the API directly. The backend is the authorization boundary and must check the roles claim on the access token the proxy injects.
+Permissions are **not** enforced by the BFF at all. `/auth/me` and `/auth/verify` report them so an app can hide or disable widgets, but anyone holding a `sid` can call the API directly. The backend is the authorization boundary and must check the roles claim on the access token the proxy injects.

-Roles are re-read from Keycloak whenever the BFF refreshes the access token (roughly once per token lifetime), so granting or revoking a permission takes effect without a re-login. The access role is deliberately *not* re-checked there — revoking it takes effect at the next login, or immediately if you kill the Keycloak session.
+Roles are re-read from Keycloak whenever the BFF refreshes the access token (roughly once per token lifetime), so granting or revoking a permission takes effect without a re-login. Revoking the *access* role likewise bounces the user from the app's guard within one token lifetime — or immediately, if you kill the Keycloak session.

 ### Backends (`config/services.yaml` → `backends`)

@@ -99,102 +99,53 @@ Production: point your webserver at `public/` as document root, `APP_ENV=prod`,

 Sessions are stored via Symfony's filesystem cache by default (`config/packages/cache.yaml`) — fine for one instance. For multiple instances behind a load balancer, switch the `bff.session_cache` pool to `cache.adapter.redis` and add `REDIS_DSN`.

+## Logging
+
+Two dedicated Monolog channels write to their own rotating files in `var/log`, in every environment:
+
+| File | Channel | Kept | Records |
+| --- | --- | --- | --- |
+| `auth.<env>.log` | `auth` | 30 days | The login/logout/authorization trail |
+| `api.<env>.log` | `api` | 14 days | One record per `/api/*` call |
+
+**`auth`** — `auth.login.start` and `auth.login.unknown_app` (login redirect), `auth.callback.state_mismatch` and `auth.callback.failed` (a failed code exchange or token decode, previously an anonymous 500), `auth.login.denied` (missing access role), `auth.login.success`, `auth.logout`, and the per-call rejections from `/auth/verify` and `/auth/me`: `auth.session.unauthenticated`, `auth.session.unknown_app`, `auth.session.expired`, `auth.session.access_denied`. Server-side token refreshes add `auth.session.refreshed`, `auth.session.missing`, `auth.session.refresh_failed` and `auth.token.decode_failed`. Successful `verify`/`me` calls are deliberately *not* logged — they run on every page load and would bury the rest.
+
+**`api`** — `api.request` for every completed proxy call (`info` below status 400, `warning` from 400 up) with method, path, backend, upstream status and `duration_ms`, plus `api.request.unauthenticated`, `api.request.session_expired`, `api.request.unknown_backend` and `api.request.upstream_unreachable`.
+
+Both channels are excluded from the `main` handler, so records are never duplicated and — importantly in prod, where `main` is `fingers_crossed` — never buffered away just because the request succeeded.
+
+Two things to know about the content:
+
+- **It contains PII.** Records carry `user_id` (Keycloak `sub`), `email`, `preferred_username` and the user's role list. Treat `var/log` accordingly: it is a personal-data store, not just diagnostics.
+- **It never contains credentials.** Sessions appear only as `sid_hash`, a 12-character SHA-256 prefix of the `sid` — enough to follow one session across both files, useless as a bearer token. Access, refresh and ID tokens, request/response bodies, query strings and forwarded headers are never logged.
+
 ## Appsmith app integration

-Create a shared module with this js. It stays generic — every app key and page name is passed in by the caller, so the same code can be dropped into every app unchanged:
+### Queries to set up

-```js
-export default {
-    isLoggedIn() {
-        return !!appsmith.store.sid;
-    },
-    login({ app }) {
-        navigateTo(`https://bff.ep-reisen.net/auth/login?app=${app}`, {}, 'SAME_WINDOW');
-    },
-    async checkReturningFromLogin({ loginPage, protectedPage }) {
-        const sid = appsmith.URL.queryParams.sid;
-        const error = appsmith.URL.queryParams.error;
-        if (error === 'access_denied') {
-            showAlert('You do not have access to this app.', 'error');
-            navigateTo(loginPage, {}, 'SAME_WINDOW');
-            return;
-        }
-        if (sid) {
-            await storeValue('sid', sid);
-            navigateTo(protectedPage, {}, 'SAME_WINDOW');
-        }
-        if (appsmith.store.sid && !appsmith.store.user) {
-            const profile = await Bff_Me.run();
-            await storeValue('user', profile);
-        }
-    },
-    guardPage({ loginPage }) {
-        if (!this.isLoggedIn()) {
-            navigateTo(loginPage, {}, 'SAME_WINDOW');
-        }
-    },
-    async logout() {
-        const res = await Bff_Logout.run();
-        await storeValue('sid', null);
-        await storeValue('user', null);
-        navigateTo(res.logout_url, {}, 'SAME_WINDOW');
-    }
-}
+Each app needs three queries against the BFF. Create them once per app (skip any that already exist); the shared module below calls them **by these exact names**, so don't rename them. All three are plain REST API queries — no datasource — and all three send the same auth header:
+
+```
+Authorization: Bearer {{appsmith.store.sid}}
 ```

-The per-page objects below are where an app's own configuration lives — page names and the app key. They can't be folded into the shared module: JS Objects are page-scoped and "Run on page load" applies to the page the object belongs to, so each page needs its own.
+| Name | Request | Called by |
+|---|---|---|
+| `Bff_Verify` | `GET https://<bff-host>/auth/verify?app=<key>` | `Bff.guardPage` |
+| `Bff_Me` | `GET https://<bff-host>/auth/me?app=<key>` | `Bff.checkReturningFromLogin` |
+| `Bff_Logout` | `POST https://<bff-host>/auth/logout` | `Bff.logout` |

-On the login page add this js to be executed onLoad:
+`<key>` is the app's own key from `appsmith.apps`, hardcoded in the query URL — the same value the app passes to `Bff.login`. One session is shared across every app the user has open, so the BFF can only scope its answer if the caller says which app is asking. `Bff_Logout` needs no key: it kills the session for *all* apps.

-```js
-export default {
-  onLoad() {
-    return Bff.checkReturningFromLogin({
-      loginPage: 'Login',
-      protectedPage: 'ProtectedPage',
-    });
-  }
-}
+**`Bff_Verify`** — the page guard. Carries no profile data, so it stays cheap enough to run on every page load. Returns
+
+```json
+{ "valid": true, "app": "crm", "permissions": ["access", "view", "write"] }
 ```

-Bind the login button's onClick to `{{ Bff.login({ app: 'app-sandbox' }) }}` — the same app key the `Bff_Me` query sends as `?app=`.
+or `401 {"error":"unauthenticated"}` / `401 {"error":"session expired"}` for a missing, forged or dead `sid`, `403 {"error":"access_denied"}` for a live session whose user lacks `crm-access`, and `400 {"error":"unknown or missing app key"}` for a bad `?app=`. `guardPage` treats every non-2xx the same way — clear the stored session, go to the login page.

-On the protected page add this js to be execute onLoad:
-
-```js
-export default {
-  onLoad() {
-    return Bff.guardPage({ loginPage: 'Login' });
-  }
-}
-```
-
-Note `guardPage` only checks that a `sid` exists, not that it's still valid — an expired session surfaces on the first API call's 401 handler.
-
-Login state can be used to toggle visibility of UI elements in Appsmith with
-
-```js
-// No sid? Not logged-in
-{{ !appsmith.store.sid }}
-// Sid? Logged-in
-{{ !!appsmith.store.sid }}
-```
-
-and user info is accessible via
-
-```js
-// Full user object
-{{ appsmith.store.user }}
-```
-
-**API queries** — every protected query sets header `Authorization: Bearer {{appsmith.store.sid}}`, targeting `https://<bff-host>/api/<path>`. Add `X-Backend: <key>` to route a specific query to a non-default backend. Add a 401 handler (`onError`) on each:
-
-```js
-storeValue('sid', null);
-navigateTo('LoginPage', {}, 'REPLACE');
-```
-
-**User profile and permissions** — one query `Bff_Me`: `GET /auth/me?app=crm`, header `Authorization: Bearer {{appsmith.store.sid}}`. The `app` key is required (hardcode the app's own key, same value it passes to `Bff.login`); one session is shared across every app the user has open, so the BFF needs to know who's asking to scope the permissions. Returns:
+**`Bff_Me`** — profile plus this app's permissions, from the tokens the BFF already holds (no backend call). Applies the same checks as `Bff_Verify`, so it can answer `401`/`403` too. On success:

 ```json
 {
@@ -209,12 +160,139 @@ navigateTo('LoginPage', {}, 'REPLACE');
 }
 ```

-Reference via `{{appsmith.store.user.email}}` etc. Gate UI on permissions with
+**`Bff_Logout`** — returns `{"logout_url": "…"}`. The BFF drops the session immediately; the app must then navigate the browser to that URL, since only the browser can clear Keycloak's own SSO cookie. `Bff.logout` does both.
+
+**The app's own data queries** — every protected query targets `https://<bff-host>/api/<path>` and sets the same `Authorization` header. Add `X-Backend: <key>` to route a query to a non-default backend. Give each one an `onError` handler:

 ```js
-{{ appsmith.store.user.permissions.includes('write') }}
+{{ Bff.clearSession().then(() => navigateTo('Login', {}, 'REPLACE')) }}
 ```

+### Shared module
+
+Create a shared module with this js. It stays generic — the app key and the page names it needs are supplied by the caller, so the same code can be dropped into every app unchanged:
+
+```js
+export default {
+    isLoggedIn() {
+        return !!appsmith.store.sid;
+    },
+    login(app) {
+        if (!app) {
+            // Almost always a binding that isn't a call — see below.
+            showAlert('Bff.login was called without an app key.', 'error');
+            return;
+        }
+        navigateTo(
+            `https://bff.ep-reisen.net/auth/login?app=${encodeURIComponent(app)}`,
+            {},
+            'SAME_WINDOW',
+        );
+    },
+    async clearSession() {
+        await storeValue('sid', null);
+        await storeValue('user', null);
+        await storeValue('permissions', null);
+    },
+    async checkReturningFromLogin(protectedPage) {
+        if (appsmith.URL.queryParams.error === 'access_denied') {
+            await this.clearSession();
+            showAlert('You do not have access to this app.', 'error');
+            return;
+        }
+        const sid = appsmith.URL.queryParams.sid;
+        if (sid) {
+            await storeValue('sid', sid);
+        }
+        if (!this.isLoggedIn()) {
+            return;
+        }
+        // Profile and permissions land in the store before the protected
+        // page renders, so its widgets never read an empty user object.
+        try {
+            const me = await Bff_Me.run();
+            await storeValue('user', me);
+            await storeValue('permissions', me.permissions);
+        } catch (e) {
+            await this.clearSession();
+            return;
+        }
+        if (sid) {
+            navigateTo(protectedPage, {}, 'SAME_WINDOW');
+        }
+    },
+    async guardPage(loginPage) {
+        if (!loginPage) {
+            showAlert('Bff.guardPage was called without a login page name.', 'error');
+            return;
+        }
+        if (!this.isLoggedIn()) {
+            navigateTo(loginPage, {}, 'SAME_WINDOW');
+            return;
+        }
+        try {
+            const res = await Bff_Verify.run();
+            await storeValue('permissions', res.permissions);
+        } catch (e) {
+            await this.clearSession();
+            navigateTo(loginPage, {}, 'SAME_WINDOW');
+        }
+    },
+    async logout() {
+        const res = await Bff_Logout.run();
+        await this.clearSession();
+        navigateTo(res.logout_url, {}, 'SAME_WINDOW');
+    }
+}
+```
+
+No per-page JS objects are needed. Add the module to each page, then open it from the **JS** tab in the editor: each of its methods is listed there with its own argument fields and a **Run on page load** toggle. (Not the run behavior modal — the argument values are edited per method on the module itself.) Enable page load on the one method that page needs and fill in its argument — this is where the app's own page names live:
+
+| Page | Function to run on page load | Argument |
+|---|---|---|
+| Login | `checkReturningFromLogin` | `protectedPage` — the page to land on after a successful login |
+| Every protected page | `guardPage` | `loginPage` — the page to bounce to when the session doesn't check out |
+
+Note `checkReturningFromLogin` takes no login page name — it only ever runs *on* the login page, so there is nowhere to send the user on failure; it clears the session and stays put. `guardPage` is the one that needs a page name, since it runs on a protected page and has to send the user away.
+
+Bind the login button's onClick to
+
+```js
+{{ Bff.login('app-sandbox') }}
+```
+
+using the same app key the `Bff_Me` and `Bff_Verify` queries send as `?app=`.
+
+Write that binding by hand in the onClick field. Do **not** use the event dropdown's "Execute a JS function" option to select `Bff.login` — that invokes it with no arguments, so the app key arrives `undefined`, the BFF gets `/auth/login?app=undefined` and answers `404 Unknown or missing app key`. Unlike `guardPage` and `checkReturningFromLogin`, `login` is triggered by a widget event rather than page load, so there is no settings field to put the app key in — it has to be in the binding.
+
+`guardPage` asks the BFF (via `Bff_Verify`) whether the stored `sid` is a live session that may enter *this* app, and bounces to the login page if not — a forged or expired `sid`, or one belonging to a user without the app's access role, never gets past it. Two caveats: Appsmith renders the page before the page-load function resolves, so the page shell can flash briefly before the redirect; and this is UI gating only. Anyone holding a real `sid` can still call `/api/*` with curl, so the backend remains the authorization boundary.
+
+Login state can be used to toggle visibility of UI elements in Appsmith with
+
+```js
+// No sid? Not logged-in
+{{ !appsmith.store.sid }}
+// Sid? Logged-in
+{{ !!appsmith.store.sid }}
+```
+
+and user info — whatever `Bff_Me` returned — is accessible via
+
+```js
+// Full user object
+{{ appsmith.store.user }}
+// Individual fields
+{{ appsmith.store.user.email }}
+```
+
+Gate UI on permissions with
+
+```js
+{{ (appsmith.store.permissions || []).includes('write') }}
+```
+
+`appsmith.store.permissions` is the one to bind against: `checkReturningFromLogin` seeds it at login and `guardPage` refreshes it from `Bff_Verify` on every protected page load, so a permission granted or revoked in Keycloak shows up without a re-login. (`appsmith.store.user.permissions` holds the same list as of login time only — bind to the store key, not the nested one.)
+
 This is client-visible display data, not an authorization signal — the backend must still authorize off the real access token the BFF injects.

 ## Known limitation
@@ -66,5 +66,5 @@
            "require": "7.*"
        }
    },
-    "version": "0.2.0"
+    "version": "0.3.1"
 }
@@ -4,7 +4,7 @@
        "Read more about it at https://getcomposer.org/doc/01-basic-usage.md#installing-dependencies",
        "This file is @generated automatically"
    ],
-    "content-hash": "b64b308ac18c4c43f9465c097be4d120",
+    "content-hash": "8f9bd431bb2f21dfa749f7b5f375b818",
    "packages": [
        {
            "name": "firebase/php-jwt",
@@ -1,6 +1,13 @@
 monolog:
    channels:
        - deprecation # Deprecations are logged in the dedicated "deprecation" channel when it exists
+        # Audit channels, each with its own file in every env (see below).
+        # "auth" is the login/logout/authorization trail, "api" one record per
+        # proxied backend call. Both are excluded from "main" everywhere, so
+        # they never get duplicated — and, in prod, never get swallowed by the
+        # fingers_crossed buffer that only flushes on an error.
+        - auth
+        - api

 when@dev:
    monolog:
@@ -9,11 +16,23 @@ when@dev:
                type: stream
                path: "%kernel.logs_dir%/%kernel.environment%.log"
                level: debug
-                channels: ["!event"]
+                channels: ["!event", "!auth", "!api"]
            console:
                type: console
                process_psr_3_messages: false
                channels: ["!event", "!doctrine", "!console"]
+            auth:
+                type: rotating_file
+                channels: [auth]
+                path: "%kernel.logs_dir%/auth.%kernel.environment%.log"
+                max_files: 30
+                level: info
+            api:
+                type: rotating_file
+                channels: [api]
+                path: "%kernel.logs_dir%/api.%kernel.environment%.log"
+                max_files: 14
+                level: info

 when@test:
    monolog:
@@ -23,11 +42,23 @@ when@test:
                action_level: error
                handler: nested
                excluded_http_codes: [404, 405]
-                channels: ["!event"]
+                channels: ["!event", "!auth", "!api"]
            nested:
                type: stream
                path: "%kernel.logs_dir%/%kernel.environment%.log"
                level: debug
+            auth:
+                type: rotating_file
+                channels: [auth]
+                path: "%kernel.logs_dir%/auth.%kernel.environment%.log"
+                max_files: 30
+                level: info
+            api:
+                type: rotating_file
+                channels: [api]
+                path: "%kernel.logs_dir%/api.%kernel.environment%.log"
+                max_files: 14
+                level: info

 when@prod:
    monolog:
@@ -37,7 +68,7 @@ when@prod:
                action_level: error
                handler: nested
                excluded_http_codes: [404, 405]
-                channels: ["!deprecation"]
+                channels: ["!deprecation", "!auth", "!api"]
                buffer_size: 50 # How many messages should be saved? Prevent memory leaks
            nested:
                # Plain rsync/Deployer shared hosting (see deploy.php), not a
@@ -56,3 +87,18 @@ when@prod:
                channels: [deprecation]
                path: "%kernel.logs_dir%/%kernel.environment%.deprecation.log"
                max_files: 14
+            auth:
+                # The audit trail: kept longer than everything else, and never
+                # routed through fingers_crossed — these info records must land
+                # even on a request where nothing went wrong.
+                type: rotating_file
+                channels: [auth]
+                path: "%kernel.logs_dir%/auth.%kernel.environment%.log"
+                max_files: 30
+                level: info
+            api:
+                type: rotating_file
+                channels: [api]
+                path: "%kernel.logs_dir%/api.%kernel.environment%.log"
+                max_files: 14
+                level: info
@@ -17,10 +17,10 @@ parameters:
    # Add one entry per app you build. Never accept a return URL from the
    # request itself — always resolve through this map.
    appsmith.apps:
-        app-sandbox:
-            url: '%env(APP_SANDBOX_LOGIN_URL)%'
-            role_prefix: 'app-sandbox-'
-            access_role: 'app-sandbox-access'
+        app-hub:
+            url: '%env(APP_HUB_URL)%'
+            role_prefix: 'app-hub-'
+            access_role: 'app-hub-access'

    # Named backends the proxy can forward to. A request picks one via the
    # X-Backend header; omitting it uses "default". Add BACKEND_<KEY>_URL to
@@ -6,6 +6,9 @@ use App\Security\AccessTokenRoles;
 use App\Security\AppRegistry;
 use App\Security\IdTokenDecoder;
 use App\Session\BffSessionStore;
+use App\Session\TokenRefresher;
+use Monolog\Attribute\WithMonologChannel;
+use Psr\Log\LoggerInterface;
 use Symfony\Bundle\FrameworkBundle\Controller\AbstractController;
 use Symfony\Component\HttpFoundation\JsonResponse;
 use Symfony\Component\HttpFoundation\RedirectResponse;
@@ -14,14 +17,17 @@ use Symfony\Component\HttpFoundation\Response;
 use Symfony\Component\Routing\Attribute\Route;
 use Symfony\Contracts\HttpClient\HttpClientInterface;

+#[WithMonologChannel('auth')]
 class AuthController extends AbstractController
 {
    public function __construct(
        private readonly HttpClientInterface $client,
        private readonly BffSessionStore $store,
+        private readonly TokenRefresher $refresher,
        private readonly IdTokenDecoder $idTokenDecoder,
        private readonly AppRegistry $apps,
        private readonly AccessTokenRoles $tokenRoles,
+        private readonly LoggerInterface $logger,
        private readonly string $kcBaseUrl,
        private readonly string $kcRealm,
        private readonly string $kcClientId,
@@ -41,6 +47,11 @@ class AuthController extends AbstractController
    {
        $appKey = (string) $request->query->get('app', '');
        if (!$this->apps->isValidApp($appKey)) {
+            $this->logger->warning('auth.login.unknown_app', [
+                'app' => $appKey,
+                'ip' => $request->getClientIp(),
+            ]);
+
            throw $this->createNotFoundException('Unknown or missing app key');
        }

@@ -65,6 +76,11 @@ class AuthController extends AbstractController
            'code_challenge_method' => 'S256',
        ]);

+        $this->logger->info('auth.login.start', [
+            'app' => $appKey,
+            'ip' => $request->getClientIp(),
+        ]);
+
        return new RedirectResponse(
            "{$this->kcBaseUrl}/realms/{$this->kcRealm}/protocol/openid-connect/auth?{$params}"
        );
@@ -78,32 +94,54 @@ class AuthController extends AbstractController
        $expectedState = (string) $session->get('oauth_state', '');
        $givenState = (string) $request->query->get('state', '');
        if ($expectedState === '' || !hash_equals($expectedState, $givenState)) {
+            $this->logger->warning('auth.callback.state_mismatch', [
+                'ip' => $request->getClientIp(),
+                'had_expected_state' => $expectedState !== '',
+            ]);
+
            return new Response('Invalid or missing state', 401);
        }

        $appKey = (string) $session->get('oauth_app');
        $returnUrl = $this->apps->resolveReturnUrl($appKey);

-        $response = $this->client->request(
-            'POST',
-            "{$this->kcBaseUrl}/realms/{$this->kcRealm}/protocol/openid-connect/token",
-            [
-                'body' => [
-                    'grant_type' => 'authorization_code',
-                    'client_id' => $this->kcClientId,
-                    'client_secret' => $this->kcClientSecret,
-                    'code' => $request->query->get('code'),
-                    'redirect_uri' => $this->kcRedirectUri,
-                    'code_verifier' => $session->get('pkce_verifier'),
-                ],
-            ]
-        );
-        $tokens = $response->toArray();
+        // Everything from here to the role check either succeeds or throws
+        // (Keycloak unreachable, code rejected, bad signature, expired token,
+        // no sid claim) and ends as an anonymous 500. Log the cause, then let
+        // it through untouched — the response behaviour is deliberately
+        // unchanged.
+        try {
+            $response = $this->client->request(
+                'POST',
+                "{$this->kcBaseUrl}/realms/{$this->kcRealm}/protocol/openid-connect/token",
+                [
+                    'body' => [
+                        'grant_type' => 'authorization_code',
+                        'client_id' => $this->kcClientId,
+                        'client_secret' => $this->kcClientSecret,
+                        'code' => $request->query->get('code'),
+                        'redirect_uri' => $this->kcRedirectUri,
+                        'code_verifier' => $session->get('pkce_verifier'),
+                    ],
+                ]
+            );
+            $tokens = $response->toArray();

-        $idClaims = $this->idTokenDecoder->decode($tokens['id_token']);
-        $kcSid = $idClaims['sid'] ?? null;
-        if (!$kcSid) {
-            throw new \RuntimeException('Keycloak did not issue a "sid" claim on the ID token');
+            $idClaims = $this->idTokenDecoder->decode($tokens['id_token']);
+            $kcSid = $idClaims['sid'] ?? null;
+            if (!$kcSid) {
+                throw new \RuntimeException('Keycloak did not issue a "sid" claim on the ID token');
+            }
+
+            $accessClaims = $this->idTokenDecoder->decode($tokens['access_token']);
+        } catch (\Throwable $e) {
+            $this->logger->error('auth.callback.failed', [
+                'app' => $appKey,
+                'ip' => $request->getClientIp(),
+                'exception' => $e,
+            ]);
+
+            throw $e;
        }

        // Authorization gate: does this user hold the role required for
@@ -117,9 +155,16 @@ class AuthController extends AbstractController
        // the app's finer-grained permissions. Those are display data for
        // the app's UI only; they are never re-checked per request here —
        // the backend authorizes off the forwarded access token.
-        $accessClaims = $this->idTokenDecoder->decode($tokens['access_token']);
        $roles = $this->tokenRoles->extract($accessClaims);
        if (!in_array($this->apps->accessRole($appKey), $roles, true)) {
+            $this->logger->warning('auth.login.denied', [
+                'app' => $appKey,
+                'required_role' => $this->apps->accessRole($appKey),
+                'roles' => $roles,
+                'user_id' => $idClaims['sub'] ?? null,
+                'email' => $idClaims['email'] ?? null,
+            ]);
+
            $session->remove('pkce_verifier');
            $session->remove('oauth_state');
            $session->remove('oauth_app');
@@ -152,11 +197,48 @@ class AuthController extends AbstractController
            ],
        ]);

+        $this->logger->info('auth.login.success', [
+            'app' => $appKey,
+            'user_id' => $idClaims['sub'],
+            'email' => $idClaims['email'] ?? null,
+            'preferred_username' => $idClaims['preferred_username'] ?? null,
+            'roles' => $roles,
+            'sid_hash' => $this->sidHash($kcSid),
+            'expires_at' => time() + (int) $tokens['expires_in'],
+        ]);
+
        $separator = str_contains($returnUrl, '?') ? '&' : '?';

        return new RedirectResponse($returnUrl . $separator . http_build_query(['sid' => $kcSid]));
    }

+    /**
+     * Guard endpoint apps call on page load: is this sid a live session, and
+     * may it enter *this* app? Deliberately returns no profile data, so it
+     * stays cheap enough to run on every page load.
+     *
+     * This exists because an app's own login state (a `sid` in client-side
+     * storage) is trivially forgeable — checking it client-side proves
+     * nothing. It is still UI gating, not an authorization boundary: the
+     * backend authorizes off the access token the proxy injects.
+     */
+    #[Route('/auth/verify', methods: ['GET'])]
+    public function verify(Request $request): JsonResponse
+    {
+        $appKey = (string) $request->query->get('app', '');
+
+        $session = $this->resolveAppSession($request, $appKey);
+        if ($session instanceof JsonResponse) {
+            return $session;
+        }
+
+        return new JsonResponse([
+            'valid' => true,
+            'app' => $appKey,
+            'permissions' => $this->apps->permissions($appKey, $session['roles'] ?? []),
+        ]);
+    }
+
    /**
     * Returns the logged-in user's profile (email, name, etc) plus the
     * permissions they hold for the calling app. Called by an app as a
@@ -166,7 +248,8 @@ class AuthController extends AbstractController
     *
     * The `app` query parameter is required: one session is shared by every
     * app the user opens, so the BFF can only scope permissions if the
-     * caller says which app is asking.
+     * caller says which app is asking — and so it can check the caller may
+     * enter that app at all (same gate as /auth/verify).
     *
     * Permissions here are for the app's own UI gating. They are not an
     * authorization boundary — anything that matters must be enforced by
@@ -175,19 +258,11 @@ class AuthController extends AbstractController
    #[Route('/auth/me', methods: ['GET'])]
    public function me(Request $request): JsonResponse
    {
-        $kcSid = $this->extractBearer($request);
-        if (!$kcSid) {
-            return new JsonResponse(['error' => 'unauthenticated'], 401);
-        }
-
        $appKey = (string) $request->query->get('app', '');
-        if (!$this->apps->isValidApp($appKey)) {
-            return new JsonResponse(['error' => 'unknown or missing app key'], 400);
-        }

-        $session = $this->store->get($kcSid);
-        if ($session === null) {
-            return new JsonResponse(['error' => 'session expired'], 401);
+        $session = $this->resolveAppSession($request, $appKey);
+        if ($session instanceof JsonResponse) {
+            return $session;
        }

        return new JsonResponse(($session['profile'] ?? []) + [
@@ -207,6 +282,8 @@ class AuthController extends AbstractController
    {
        $kcSid = $this->extractBearer($request);
        if (!$kcSid) {
+            $this->logger->info('auth.logout.no_session');
+
            return new JsonResponse(['error' => 'missing session'], 401);
        }

@@ -216,6 +293,15 @@ class AuthController extends AbstractController
        // One delete kills the session for every app that shared it.
        $this->store->revoke($kcSid);

+        $this->logger->info('auth.logout', [
+            'sid_hash' => $this->sidHash($kcSid),
+            'user_id' => $data['user_id'] ?? null,
+            'email' => $data['profile']['email'] ?? null,
+            // false when the sid was already dead (expired, or a second
+            // logout from another tab) — the response is the same either way.
+            'was_live' => $data !== null,
+        ]);
+
        $params = http_build_query(array_filter([
            'id_token_hint' => $idToken,
            'post_logout_redirect_uri' => $this->postLogoutRedirect,
@@ -226,6 +312,81 @@ class AuthController extends AbstractController
        ]);
    }

+    /**
+     * Bearer sid -> a session that is live *and* authorized for $appKey.
+     *
+     * Returns the session array, or the JsonResponse the caller should
+     * return instead of a payload. Liveness goes through TokenRefresher
+     * rather than a bare store lookup, so a session killed on the Keycloak
+     * side (admin logout, revoked refresh token) fails here immediately
+     * instead of lingering until the cache TTL — and so the roles checked
+     * below are the ones the refresh just re-read.
+     *
+     * @return array<string,mixed>|JsonResponse
+     */
+    private function resolveAppSession(Request $request, string $appKey): array|JsonResponse
+    {
+        $kcSid = $this->extractBearer($request);
+        if (!$kcSid) {
+            // Routine on first page load, before an app has a sid to send.
+            $this->logger->info('auth.session.unauthenticated', [
+                'app' => $appKey,
+                'endpoint' => $request->getPathInfo(),
+            ]);
+
+            return new JsonResponse(['error' => 'unauthenticated'], 401);
+        }
+
+        if (!$this->apps->isValidApp($appKey)) {
+            $this->logger->warning('auth.session.unknown_app', [
+                'app' => $appKey,
+                'endpoint' => $request->getPathInfo(),
+            ]);
+
+            return new JsonResponse(['error' => 'unknown or missing app key'], 400);
+        }
+
+        if ($this->refresher->ensureFresh($kcSid) === null) {
+            $this->logger->info('auth.session.expired', [
+                'app' => $appKey,
+                'endpoint' => $request->getPathInfo(),
+                'sid_hash' => $this->sidHash($kcSid),
+            ]);
+
+            return new JsonResponse(['error' => 'session expired'], 401);
+        }
+
+        $session = $this->store->get($kcSid);
+        if ($session === null) {
+            $this->logger->info('auth.session.expired', [
+                'app' => $appKey,
+                'endpoint' => $request->getPathInfo(),
+                'sid_hash' => $this->sidHash($kcSid),
+            ]);
+
+            return new JsonResponse(['error' => 'session expired'], 401);
+        }
+
+        // Same gate as callback(), re-run per call: one session is shared by
+        // every app the user opens, so a sid on its own says nothing about
+        // which app its holder may enter.
+        if (!in_array($this->apps->accessRole($appKey), $session['roles'] ?? [], true)) {
+            $this->logger->warning('auth.session.access_denied', [
+                'app' => $appKey,
+                'endpoint' => $request->getPathInfo(),
+                'required_role' => $this->apps->accessRole($appKey),
+                'roles' => $session['roles'] ?? [],
+                'user_id' => $session['user_id'] ?? null,
+                'email' => $session['profile']['email'] ?? null,
+                'sid_hash' => $this->sidHash($kcSid),
+            ]);
+
+            return new JsonResponse(['error' => 'access_denied'], 403);
+        }
+
+        return $session;
+    }
+
    private function extractBearer(Request $request): ?string
    {
        $header = $request->headers->get('Authorization', '');
@@ -233,6 +394,16 @@ class AuthController extends AbstractController
        return str_starts_with($header, 'Bearer ') ? substr($header, 7) : null;
    }

+    /**
+     * A sid is a live bearer credential, so it never goes into a log file.
+     * This short digest is enough to correlate records of one session
+     * without being replayable if the logs leak.
+     */
+    private function sidHash(string $kcSid): string
+    {
+        return substr(hash('sha256', $kcSid), 0, 12);
+    }
+
    private function base64UrlEncode(string $bytes): string
    {
        return rtrim(strtr(base64_encode($bytes), '+/', '-_'), '=');
@@ -3,7 +3,9 @@
 namespace App\Controller;

 use App\Security\BackendRegistry;
+use App\Session\BffSessionStore;
 use App\Session\TokenRefresher;
+use Monolog\Attribute\WithMonologChannel;
 use Psr\Log\LoggerInterface;
 use Symfony\Bundle\FrameworkBundle\Controller\AbstractController;
 use Symfony\Component\HttpFoundation\Request;
@@ -11,6 +13,7 @@ use Symfony\Component\HttpFoundation\Response;
 use Symfony\Component\Routing\Attribute\Route;
 use Symfony\Contracts\HttpClient\HttpClientInterface;

+#[WithMonologChannel('api')]
 class ProxyController extends AbstractController
 {
    private const string DEFAULT_BACKEND_KEY = 'default';
@@ -25,6 +28,7 @@ class ProxyController extends AbstractController
        private readonly HttpClientInterface $client,
        private readonly TokenRefresher $refresher,
        private readonly BackendRegistry $backends,
+        private readonly BffSessionStore $store,
        private readonly LoggerInterface $logger,
    ) {
    }
@@ -37,22 +41,51 @@ class ProxyController extends AbstractController
    #[Route('/api/{path}', requirements: ['path' => '.+'], methods: ['GET', 'POST', 'PUT', 'PATCH', 'DELETE'])]
    public function proxy(Request $request, string $path): Response
    {
+        $start = microtime(true);
+
        $kcSid = $this->extractBearer($request);
        if (!$kcSid) {
+            $this->logger->info('api.request.unauthenticated', [
+                'method' => $request->getMethod(),
+                'path' => $path,
+            ]);
+
            return $this->jsonError('unauthenticated', 401);
        }

        $accessToken = $this->refresher->ensureFresh($kcSid);
        if (!$accessToken) {
+            $this->logger->info('api.request.session_expired', [
+                'method' => $request->getMethod(),
+                'path' => $path,
+                'sid_hash' => $this->sidHash($kcSid),
+            ]);
+
            return $this->jsonError('session expired', 401);
        }

        $backendKey = $request->headers->get('X-Backend', self::DEFAULT_BACKEND_KEY);
        if (!$this->backends->isValidBackend($backendKey)) {
+            $this->logger->warning('api.request.unknown_backend', [
+                'backend' => $backendKey,
+                'method' => $request->getMethod(),
+                'path' => $path,
+                'sid_hash' => $this->sidHash($kcSid),
+            ]);
+
            return $this->jsonError('unknown backend', 400);
        }
        $backendBaseUrl = $this->backends->resolveBaseUrl($backendKey);

+        // ensureFresh() has just read (and possibly rewritten) this entry, so
+        // this is a cache hit — it costs nothing and gives the log an identity.
+        $session = $this->store->get($kcSid);
+        $caller = [
+            'user_id' => $session['user_id'] ?? null,
+            'email' => $session['profile']['email'] ?? null,
+            'sid_hash' => $this->sidHash($kcSid),
+        ];
+
        $forwardHeaders = [];
        foreach ($request->headers->all() as $name => $values) {
            $lower = strtolower($name);
@@ -72,18 +105,42 @@ class ProxyController extends AbstractController
            $body = $upstream->getContent(false);
            $contentType = $upstream->getHeaders(false)['content-type'][0] ?? 'application/json';
        } catch (\Throwable $e) {
-            $this->logger->error('Proxy request to backend failed', [
+            $this->logger->error('api.request.upstream_unreachable', $caller + [
                'backend' => $backendKey,
+                'method' => $request->getMethod(),
                'path' => $path,
+                'duration_ms' => $this->elapsedMs($start),
                'exception' => $e,
            ]);

            return $this->jsonError('upstream unreachable', 502);
        }

+        // Never log bodies, query strings or headers: the forwarded headers
+        // carry the real Keycloak access token, and both bodies and query
+        // strings can carry anything the backend deals in.
+        $this->logger->log($status >= 400 ? 'warning' : 'info', 'api.request', $caller + [
+            'backend' => $backendKey,
+            'method' => $request->getMethod(),
+            'path' => $path,
+            'status' => $status,
+            'duration_ms' => $this->elapsedMs($start),
+        ]);
+
        return new Response($body, $status, ['Content-Type' => $contentType]);
    }

+    private function elapsedMs(float $start): float
+    {
+        return round((microtime(true) - $start) * 1000, 1);
+    }
+
+    /** Never log a raw sid — see AuthController::sidHash(). */
+    private function sidHash(string $kcSid): string
+    {
+        return substr(hash('sha256', $kcSid), 0, 12);
+    }
+
    private function extractBearer(Request $request): ?string
    {
        $header = $request->headers->get('Authorization', '');
@@ -4,7 +4,9 @@ namespace App\Security;

 use Firebase\JWT\JWK;
 use Firebase\JWT\JWT;
+use Monolog\Attribute\WithMonologChannel;
 use Psr\Cache\InvalidArgumentException;
+use Psr\Log\LoggerInterface;
 use Symfony\Contracts\Cache\CacheInterface;
 use Symfony\Contracts\Cache\ItemInterface;
 use Symfony\Contracts\HttpClient\HttpClientInterface;
@@ -14,11 +16,13 @@ use Symfony\Contracts\HttpClient\HttpClientInterface;
 * trusting any claims from it (in particular the "sid" and "sub" claims we
 * key sessions on). Requires firebase/php-jwt.
 */
+#[WithMonologChannel('auth')]
 class IdTokenDecoder
 {
    public function __construct(
        private readonly HttpClientInterface $client,
        private readonly CacheInterface $cache,
+        private readonly LoggerInterface $logger,
        private readonly string $kcBaseUrl,
        private readonly string $kcRealm,
    ) {
@@ -29,18 +33,29 @@ class IdTokenDecoder
     */
    public function decode(string $idToken): array
    {
-        $jwks = $this->cache->get('keycloak_jwks_' . $this->kcRealm, function (ItemInterface $item) {
-            $item->expiresAfter(3600);
-            $response = $this->client->request(
-                'GET',
-                "{$this->kcBaseUrl}/realms/{$this->kcRealm}/protocol/openid-connect/certs"
-            );
+        // A bad signature, an expired token or an unreachable JWKS endpoint all
+        // surface to the caller as a 500. Record why, then rethrow unchanged.
+        try {
+            $jwks = $this->cache->get('keycloak_jwks_' . $this->kcRealm, function (ItemInterface $item) {
+                $item->expiresAfter(3600);
+                $response = $this->client->request(
+                    'GET',
+                    "{$this->kcBaseUrl}/realms/{$this->kcRealm}/protocol/openid-connect/certs"
+                );

-            return $response->toArray();
-        });
+                return $response->toArray();
+            });

-        $keys = JWK::parseKeySet($jwks);
-        $claims = JWT::decode($idToken, $keys);
+            $keys = JWK::parseKeySet($jwks);
+            $claims = JWT::decode($idToken, $keys);
+        } catch (\Throwable $e) {
+            $this->logger->error('auth.token.decode_failed', [
+                'realm' => $this->kcRealm,
+                'exception' => $e,
+            ]);
+
+            throw $e;
+        }

        /** @var array<string,mixed> $decoded */
        $decoded = json_decode((string) json_encode($claims), true);
@@ -4,9 +4,11 @@ namespace App\Session;

 use App\Security\AccessTokenRoles;
 use App\Security\IdTokenDecoder;
+use Monolog\Attribute\WithMonologChannel;
 use Psr\Log\LoggerInterface;
 use Symfony\Contracts\HttpClient\HttpClientInterface;

+#[WithMonologChannel('auth')]
 class TokenRefresher
 {
    private const int EXPIRY_LEEWAY_SECONDS = 30;
@@ -34,6 +36,12 @@ class TokenRefresher
    {
        $session = $this->store->get($kcSid);
        if ($session === null) {
+            // Expired out of the cache, revoked by a logout, or simply never
+            // existed (a forged sid) — indistinguishable from here.
+            $this->logger->info('auth.session.missing', [
+                'sid_hash' => $this->sidHash($kcSid),
+            ]);
+
            return null;
        }

@@ -57,7 +65,9 @@ class TokenRefresher
            $tokens = $response->toArray();
        } catch (\Throwable $e) {
            // Refresh token expired/revoked (e.g. Keycloak-side admin logout) — kill the session.
-            $this->logger->warning('Keycloak token refresh failed, revoking session', [
+            $this->logger->warning('auth.session.refresh_failed', [
+                'sid_hash' => $this->sidHash($kcSid),
+                'user_id' => $session['user_id'] ?? null,
                'exception' => $e,
            ]);
            $this->store->revoke($kcSid);
@@ -78,13 +88,28 @@ class TokenRefresher
            );
        } catch (\Throwable $e) {
            // Keep the previous list — a decode hiccup must not drop the session.
-            $this->logger->warning('Could not re-read roles from refreshed access token', [
+            $this->logger->warning('auth.session.role_reread_failed', [
+                'sid_hash' => $this->sidHash($kcSid),
+                'user_id' => $session['user_id'] ?? null,
                'exception' => $e,
            ]);
        }

        $this->store->put($kcSid, $session);

+        $this->logger->info('auth.session.refreshed', [
+            'sid_hash' => $this->sidHash($kcSid),
+            'user_id' => $session['user_id'] ?? null,
+            'roles' => $session['roles'] ?? [],
+            'expires_at' => $session['expires_at'],
+        ]);
+
        return $session['access_token'];
    }
+
+    /** Never log a raw sid — see AuthController::sidHash(). */
+    private function sidHash(string $kcSid): string
+    {
+        return substr(hash('sha256', $kcSid), 0, 12);
+    }
 }
Author	SHA1	Message	Date
Björn Fromme	5a6e751673	chore(release): 0.3.1	2026-08-19 08:30:05 +02:00
Björn Fromme	0335f48c48	feat: adjust config to prod environment	2026-08-19 08:28:18 +02:00
Björn Fromme	e2f2ba7d1b	chore(release): 0.3.0	2026-08-14 08:44:02 +02:00
Björn Fromme	e28b789af2	feat: dedicated logging for auth and api calls	2026-08-14 08:16:54 +02:00
Björn Fromme	cc46d8c812	feat: auth verification endpoint	2026-08-13 11:01:18 +02:00