host: request records e2e asserts the client hash and the /24, and that no whole address is stored
Co-Authored-By: Claude Sonnet 5.5 <noreply@anthropic.com>
1 file changed,
+43
−10
internal/host/reqrec_e2e_test.go+43 −10
CI failed — run details
CI log
=== gate ===
.amadan/test-gate.sh
=== launchctx (0 s)
ok amadan.net/carlos/platform.git/launchctx 0.012s
? amadan.net/carlos/platform.git/launchctx/controlname [no test files]
? amadan.net/carlos/platform.git/launchctx/wireid [no test files]
=== vet (4 s)
=== gofmt (0 s)
gofmt -l .: clean
=== rest (160 s)
? github.com/carlosframework/platform/cmd/changelog [no test files]
ok github.com/carlosframework/platform/cmd/console 3.401s
ok github.com/carlosframework/platform/cmd/moveprobe 12.117s
ok github.com/carlosframework/platform/cmd/zddprobe 0.766s
ok github.com/carlosframework/platform/internal/activator 57.557s
ok github.com/carlosframework/platform/internal/agentsock 0.038s
ok github.com/carlosframework/platform/internal/alerting 0.004s
ok github.com/carlosframework/platform/internal/analytics 0.043s
ok github.com/carlosframework/platform/internal/appconfig 2.766s
ok github.com/carlosframework/platform/internal/apperr 0.112s
ok github.com/carlosframework/platform/internal/applog 0.276s
ok github.com/carlosframework/platform/internal/awsinv 0.005s
ok github.com/carlosframework/platform/internal/boxchoice 0.004s
ok github.com/carlosframework/platform/internal/boxid 0.816s
? github.com/carlosframework/platform/internal/boxid/boxidtest [no test files]
? github.com/carlosframework/platform/internal/boxid/internal/signtest [no test files]
ok github.com/carlosframework/platform/internal/boxvolumes 0.010s
ok github.com/carlosframework/platform/internal/caps 0.027s
ok github.com/carlosframework/platform/internal/certwarm 0.005s
ok github.com/carlosframework/platform/internal/cgroup 0.802s
ok github.com/carlosframework/platform/internal/changelog 0.534s
ok github.com/carlosframework/platform/internal/claimactivation 1.199s
ok github.com/carlosframework/platform/internal/clamd 0.060s
? github.com/carlosframework/platform/internal/cliflag [no test files]
? github.com/carlosframework/platform/internal/controlname [no test files]
? github.com/carlosframework/platform/internal/controlsock [no test files]
ok github.com/carlosframework/platform/internal/dbdoor 8.424s
ok github.com/carlosframework/platform/internal/dbdoor/dbdoortest 0.010s
ok github.com/carlosframework/platform/internal/dbquery 0.006s
ok github.com/carlosframework/platform/internal/dbreads 2.156s
? github.com/carlosframework/platform/internal/dbreads/dbreadstest [no test files]
ok github.com/carlosframework/platform/internal/dbverify 0.005s
ok github.com/carlosframework/platform/internal/dnsrec 0.003s
ok github.com/carlosframework/platform/internal/docsite 0.013s
ok github.com/carlosframework/platform/internal/domains 2.636s
ok github.com/carlosframework/platform/internal/doorkey 0.007s
ok github.com/carlosframework/platform/internal/economics 0.007s
ok github.com/carlosframework/platform/internal/edge 45.502s
? github.com/carlosframework/platform/internal/edgeproof [no test files]
ok github.com/carlosframework/platform/internal/edgesfile 0.008s
ok github.com/carlosframework/platform/internal/fleetapi 0.224s
ok github.com/carlosframework/platform/internal/gate 1.752s
ok github.com/carlosframework/platform/internal/genselect 0.048s
ok github.com/carlosframework/platform/internal/geo 0.022s
ok github.com/carlosframework/platform/internal/geoip 0.047s
ok github.com/carlosframework/platform/internal/historyreadback 0.294s
ok github.com/carlosframework/platform/internal/host 142.955s
ok github.com/carlosframework/platform/internal/hostactors 6.012s
ok github.com/carlosframework/platform/internal/hostactors/awsmembership 0.005s
ok github.com/carlosframework/platform/internal/hostbox 2.994s
ok github.com/carlosframework/platform/internal/hostclaim 0.720s
ok github.com/carlosframework/platform/internal/hostenv 0.005s
ok github.com/carlosframework/platform/internal/hostevidence 0.007s
ok github.com/carlosframework/platform/internal/hostexec 4.970s
ok github.com/carlosframework/platform/internal/hostfence 0.049s
ok github.com/carlosframework/platform/internal/hostfiles 10.357s
ok github.com/carlosframework/platform/internal/hostfloor 0.020s
ok github.com/carlosframework/platform/internal/hostguard 1.058s
ok github.com/carlosframework/platform/internal/hostops 1.824s
? github.com/carlosframework/platform/internal/hostops/fencerelease [no test files]
ok github.com/carlosframework/platform/internal/hostops/internal/fencerelease 0.005s
ok github.com/carlosframework/platform/internal/hostquarantine 0.003s
ok github.com/carlosframework/platform/internal/hostrelocate 0.597s
ok github.com/carlosframework/platform/internal/hostresolve 0.207s
ok github.com/carlosframework/platform/internal/hostwrite 0.002s
ok github.com/carlosframework/platform/internal/infraview 0.002s
ok github.com/carlosframework/platform/internal/instancectl 5.233s
ok github.com/carlosframework/platform/internal/instanceexec 2.773s
ok github.com/carlosframework/platform/internal/instancefs 0.010s
ok github.com/carlosframework/platform/internal/instancekey 0.002s
ok github.com/carlosframework/platform/internal/instanceupdates 0.008s
ok github.com/carlosframework/platform/internal/layout 1.704s
ok github.com/carlosframework/platform/internal/lbhealth 0.004s
ok github.com/carlosframework/platform/internal/lease 10.119s
ok github.com/carlosframework/platform/internal/lease/leasetest 0.490s
ok github.com/carlosframework/platform/internal/ledger 0.014s
ok github.com/carlosframework/platform/internal/mail 0.215s
ok github.com/carlosframework/platform/internal/maintenance 0.097s
ok github.com/carlosframework/platform/internal/maintenanceexec 5.553s
ok github.com/carlosframework/platform/internal/maintenanceguard 0.090s
ok github.com/carlosframework/platform/internal/metrics 0.009s
ok github.com/carlosframework/platform/internal/moves 21.090s
ok github.com/carlosframework/platform/internal/moves/archive 0.923s
ok github.com/carlosframework/platform/internal/objstore 0.270s
ok github.com/carlosframework/platform/internal/ops 0.292s
ok github.com/carlosframework/platform/internal/park 0.281s
ok github.com/carlosframework/platform/internal/plans 0.008s
ok github.com/carlosframework/platform/internal/privatefile 0.011s
2026/10/25 00:02:51 provision: listing apps/bab/blog/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:51 provision: listing apps/bab/: listdirs refused — its records are unseen this pass
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: listing apps/bac/tito/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:51 provision: listing apps/bac/tito/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:51 provision: skipping record apps/bac/tito/instances/one.example.com.json: unreadable: read refused
2026/10/25 00:02:51 provision: listing apps/bac/tito/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:51 provision: an app's records could not be listed: they are skipped
2026/10/25 00:02:51 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:51 provision: remove retired instance route shop.example: provision: claim admission unavailable
2026/10/25 00:02:51 provision: remove retired instance route shop.example: provision: claim admission unavailable
2026/10/25 00:02:51 provision: remove retired sidecar route worker.sidecar.internal: provision: claim admission unavailable
2026/10/25 00:02:51 provision: remove retired sidecar route worker.sidecar.internal: provision: claim admission unavailable
2026/10/25 00:02:51 provision: claim install acme.go.tito.io: provision: claim admission unavailable
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: claim install acme.go.tito.io: registry: claim row ownership changed or unknown
2026/10/25 00:02:51 provision: claim install bot.eleven.bac.sidecar.internal: provision: claim admission unavailable
2026/10/25 00:02:51 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["run"])
2026/10/25 00:02:51 provision: claim install bot.eleven.bac.sidecar.internal: registry: claim row ownership changed or unknown
2026/10/25 00:02:51 provision: refusing to mint route acme.go.tito.io (app "tito" acct "bac"): this box declares CARLOS_INBOUND=none (no-inbound) and cannot serve routed instance traffic
2026/10/25 00:02:51 provision: acme.go.tito.io: not minting this pass: the box's layout intent could not be read: no sealed config
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: REFUSING to mint sidecar bot.eleven.bac.sidecar.internal: bot.eleven.bac.sidecar.internal-sidecar.env is staged on this box — the legacy file co-spawn and a native sidecar row are two mechanisms for one host; remove the file to migrate this host onto sidecar records
2026/10/25 00:02:51 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["run"])
2026/10/25 00:02:51 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["run"])
2026/10/25 00:02:51 provision: refusing to mint route acme.go.tito.io (app "tito" acct "bac"): this box declares CARLOS_INBOUND=none (no-inbound) and cannot serve routed instance traffic
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: REFUSING to mint sidecar bot.eleven.bac.sidecar.internal: bot.eleven.bac.sidecar.internal-sidecar.env is staged on this box — the legacy file co-spawn and a native sidecar row are two mechanisms for one host; remove the file to migrate this host onto sidecar records
2026/10/25 00:02:51 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["run"])
2026/10/25 00:02:51 provision: acme.go.tito.io exists but is not the route this record describes (app "other"/"tito") — leaving it alone
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: claim install acme.go.tito.io: registry: claim row ownership changed or unknown
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: claim install acme.go.tito.io: registry: claim row ownership changed or unknown
2026/10/25 00:02:51 provision: bot.eleven.bac.sidecar.internal exists but is not a sidecar row this pass owns (kind "sidecar" provisioned false app "eleven" acct "bac") — leaving it alone
2026/10/25 00:02:51 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["run"])
2026/10/25 00:02:51 provision: claim install bot.eleven.bac.sidecar.internal: registry: claim row ownership changed or unknown
2026/10/25 00:02:51 provision: acme.go.tito.io exists but is not the route this record describes (app "other"/"tito") — leaving it alone
2026/10/25 00:02:51 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:51 provision: adopted existing route acme.go.tito.io (app "tito" acct "bac") — this record now owns its channel and environment
2026/10/25 00:02:52 provision: bot.eleven.bac.sidecar.internal exists but is not a sidecar row this pass owns (kind "sidecar" provisioned false app "eleven" acct "bac") — leaving it alone
2026/10/25 00:02:52 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:52 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: skipping record apps/bac/tito/instances/acme.go.tito.io.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:52 provision: skipping record apps/bac/tito/instances/new.go.tito.io.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:52 provision: not removing acme.go.tito.io: its record exists but could not be read cleanly this pass
2026/10/25 00:02:52 provision: skipping record apps/bac/tito/instances/acme.go.tito.io.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:52 provision: skipping record apps/bac/tito/instances/new.go.tito.io.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:52 provision: minted instance route rl.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rb.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rd.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route re.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rf.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rg.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rh.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route ri.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rj.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route ra.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rc.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rk.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route ra.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rb.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rc.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route rd.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: skipping record apps/bac/tito/instances/rb.go.tito.io.json: read failed: read refused
2026/10/25 00:02:52 provision: skipping record apps/bac/tito/instances/rb.go.tito.io.json: read failed: read refused
2026/10/25 00:02:52 provision: minted instance route re.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appa.example (app "appa" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appf.example (app "appf" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appj.example (app "appj" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appb.example (app "appb" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appc.example (app "appc" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appd.example (app "appd" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appe.example (app "appe" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appg.example (app "appg" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.apph.example (app "apph" acct "bac")
2026/10/25 00:02:52 provision: minted instance route x.appi.example (app "appi" acct "bac")
2026/10/25 00:02:52 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:52 provision: minted instance route r0003.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0085.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0092.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0111.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0114.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0008.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0016.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0034.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0090.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0004.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0009.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0062.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0013.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0071.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0100.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0102.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0123.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0127.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0076.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0087.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0089.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0095.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0098.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0020.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0021.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0045.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0056.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0104.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0121.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0017.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0024.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0048.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0088.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0069.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0035.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0046.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0054.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0094.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0108.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0055.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0041.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0060.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0077.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0116.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0038.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0099.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0118.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0012.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0039.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0083.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0105.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0096.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0002.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0015.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0031.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0033.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0067.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0073.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0109.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0019.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0044.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0051.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0011.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0018.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0026.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0032.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0063.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0120.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0053.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0068.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0128.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0091.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0006.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0028.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0050.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0057.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0082.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0113.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0115.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0081.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0084.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0101.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0030.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0058.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0072.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0064.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0107.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0001.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0025.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0059.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0079.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0014.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0066.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0110.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0122.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0125.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0106.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0010.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0027.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0043.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0078.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0000.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0023.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0075.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0086.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0097.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0065.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0103.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0036.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0040.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0047.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0049.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0061.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0080.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0029.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0093.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0124.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0022.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0037.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0052.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0074.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0117.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0119.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0126.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0129.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0005.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0007.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0042.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0070.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:52 provision: minted instance route r0112.go.tito.io (app "tito" acct "bac")
--- FAIL: TestPlan9B8RecordWriteCensus (0.67s)
plan9_b8_census_test.go:372: record-write census rejected 1 site(s); update the explicit inventory only after reviewing the source:
changed site internal/console/authcli.go:Server.registerCLIRoutes: source differs from the reviewed digest
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: refusing to mint route acme.go.tito.io (app "tito" acct "bac"): this box declares CARLOS_INBOUND=none (no-inbound) and cannot serve routed instance traffic
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route console.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted service route ha.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted static route site.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted service route svc.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route whole.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route shared.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged acme.go.tito.io channel stable -> edge
2026/10/25 00:02:53 provision: converged acme.go.tito.io channel edge -> canary/rehearsal
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: skipping record apps/bac/tito/instances/acme.go.tito.io.json: empty channel
2026/10/25 00:02:53 provision: not removing acme.go.tito.io: its record exists but could not be read cleanly this pass
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged acme.go.tito.io environment "" -> "staging"
2026/10/25 00:02:53 provision: converged acme.go.tito.io environment "staging" -> ""
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged acme.go.tito.io steering "" -> "latency"
2026/10/25 00:02:53 provision: converged acme.go.tito.io steering "latency" -> ""
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged acme.go.tito.io hibernate false -> true
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged acme.go.tito.io hibernate true -> false (replication "daily" cleared: only a hibernating route's rung is read)
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged acme.go.tito.io status-named false -> true
2026/10/25 00:02:53 provision: converged acme.go.tito.io status-named true -> false
2026/10/25 00:02:53 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: minted service route ha.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:53 provision: converged ha.go.tito.io upstreams addr "" -> "", addrs "127.0.0.1:7001,127.0.0.1:7002" -> "127.0.0.1:7001,127.0.0.1:7003" (probe "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}" -> "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}")
2026/10/25 00:02:53 provision: converged ha.go.tito.io upstreams addr "" -> "", addrs "127.0.0.1:7001,127.0.0.1:7003" -> "127.0.0.1:7003,127.0.0.1:7001" (probe "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}" -> "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}")
2026/10/25 00:02:53 provision: converged ha.go.tito.io upstreams addr "" -> "", addrs "127.0.0.1:7003,127.0.0.1:7001" -> "127.0.0.1:7003,127.0.0.1:7001" (probe "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}" -> "{\"path\":\"/healthz\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}")
2026/10/25 00:02:54 provision: minted service route whole.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: converged whole.go.tito.io upstreams addr "127.0.0.1:9443" -> "", addrs "" -> "127.0.0.1:9443,127.0.0.1:9444" (probe "" -> "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}")
2026/10/25 00:02:54 provision: converged whole.go.tito.io upstreams addr "" -> "", addrs "127.0.0.1:9443,127.0.0.1:9444" -> "" (probe "{\"path\":\"/\",\"status\":200,\"interval_ms\":2000,\"fail_after\":3,\"rise_after\":2}" -> "")
2026/10/25 00:02:54 provision: whole.go.tito.io: record describes a different route SHAPE than the row (kind "instance"/"service" unit ""/"" socket "/run/carlos/whole.go.tito.io.sock"/"" db "/data/whole.go.tito.io.db"/"") — not converged in place; `carlos remove whole.go.tito.io` purges this route's capability grants (registry.Delete's contract, not a bug) before the next pass re-mints it, so treat that as a last resort, not a routine fix
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted service route whole.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (app "other"/"tito") — leaving it alone
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: removed retired instance route acme.go.tito.io (record gone)
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: skipping accounts/bac/account.json: malformed account manifest: invalid character 'o' in literal null (expecting 'u')
2026/10/25 00:02:54 provision: removed retired instance route acme.go.tito.io (record gone)
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: manifest bac/tito: read failed: provision: manifest bac/tito: invalid character 'o' in literal null (expecting 'u')
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/acme.go.tito.io.json: disagrees with its own path (host="wrong-host.go.tito.io" account="bac" app="tito")
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/acme$evil.go.tito.io.json: host "acme$evil.go.tito.io" is not a hostname
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/acme$evil.go.tito.io.json: host "acme$evil.go.tito.io" is not a hostname
2026/10/25 00:02:54 provision: not removing acme$evil.go.tito.io: its record exists but could not be read cleanly this pass
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/bad-service.go.tito.io.json: invalid shape: kind service with no addr: the platform only proxies to a service, so the record must name the upstream it proxies to
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/bad-service.go.tito.io.json: invalid shape: kind service with no addr: the platform only proxies to a service, so the record must name the upstream it proxies to
2026/10/25 00:02:54 provision: not removing bad-service.go.tito.io: its record exists but could not be read cleanly this pass
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/no-channel.go.tito.io.json: empty channel
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/no-channel.go.tito.io.json: empty channel
2026/10/25 00:02:54 provision: not removing no-channel.go.tito.io: its record exists but could not be read cleanly this pass
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: skipping record apps/bac/tito/instances/acme.go.tito.io.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:54 provision: not removing acme.go.tito.io: its record exists but could not be read cleanly this pass
2026/10/25 00:02:54 provision: removed retired instance route ghost.go.tito.io (record gone)
2026/10/25 00:02:54 provision: duplicate host dup.go.tito.io: keeping apps/bac/tito/instances/dup.go.tito.io.json, skipping apps/bad/tito/instances/dup.go.tito.io.json
2026/10/25 00:02:54 provision: minted instance route dup.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:54 provision: removed retired instance route acme.go.tito.io (app in the trash)
2026/10/25 00:02:54 provision: minted static route site.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:54 provision: removed retired static route site.go.tito.io (app in the trash)
2026/10/25 00:02:54 provision: trash marker for bac/tito unreadable: release: malformed trash marker for bac/tito: invalid character 'n' looking for beginning of object key string — not minting for this app
2026/10/25 00:02:54 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:54 provision: removed retired instance route acme.go.tito.io (app in the trash)
2026/10/25 00:02:54 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:54 provision: trash marker for bac/tito unreadable: release: malformed trash marker for bac/tito: invalid character 'n' looking for beginning of object key string — not minting for this app
2026/10/25 00:02:54 provision: adopted existing route acme.go.tito.io (app "tito" acct "bac") — this record now owns its channel and environment
2026/10/25 00:02:54 provision: converged acme.go.tito.io channel stable -> edge
2026/10/25 00:02:54 provision: adopted existing route acme.go.tito.io (app "tito" acct "bac") — this record now owns its channel and environment
2026/10/25 00:02:54 provision: converged acme.go.tito.io channel canary/rehearsal -> edge
2026/10/25 00:02:54 provision: converged acme.go.tito.io environment "staging" -> ""
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (app "other"/"tito") — leaving it alone
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (backing "unit" (box-scoped, not expressible in a record)) — leaving it alone
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (tunnel "pi-fleet" (box-scoped, not expressible in a record)) — leaving it alone
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (caps "port:25" (box-scoped, not expressible in a record)) — leaving it alone
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (platform (owned by the domains reconcile pass)) — leaving it alone
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (canary (owned by the domains reconcile pass)) — leaving it alone
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (db "/data/other.db"/"/data/acme.go.tito.io.db") — leaving it alone
2026/10/25 00:02:54 provision: adopted existing route acme.go.tito.io (app "tito" acct "bac") — this record now owns its channel and environment
2026/10/25 00:02:54 provision: removed retired instance route acme.go.tito.io (record gone)
2026/10/25 00:02:54 provision: dry-run: would mint instance route acme.go.tito.io (app "tito" acct "bac" channel "stable")
2026/10/25 00:02:54 provision: dry-run: would adopt existing route adopt.go.tito.io (app "tito" acct "bac") — this record would own its channel and environment
2026/10/25 00:02:54 provision: dry-run: would converge adopt.go.tito.io channel stable -> edge
2026/10/25 00:02:54 provision: dry-run: would converge adopt.go.tito.io environment "" -> "staging"
2026/10/25 00:02:54 provision: dry-run: would converge owned.go.tito.io channel stable -> edge
2026/10/25 00:02:54 provision: dry-run: would converge owned.go.tito.io environment "" -> "staging"
2026/10/25 00:02:54 provision: dry-run: would converge owned.go.tito.io hibernate false -> true
2026/10/25 00:02:54 provision: dry-run: would converge owned.go.tito.io seed
2026/10/25 00:02:54 provision: dry-run: would remove retired instance route gone.go.tito.io (record gone)
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: adopted existing route adopt.go.tito.io (app "tito" acct "bac") — this record now owns its channel and environment
2026/10/25 00:02:54 provision: converged adopt.go.tito.io channel stable -> edge
2026/10/25 00:02:54 provision: converged adopt.go.tito.io environment "" -> "staging"
2026/10/25 00:02:54 provision: converged owned.go.tito.io channel stable -> edge
2026/10/25 00:02:54 provision: converged owned.go.tito.io environment "" -> "staging"
2026/10/25 00:02:54 provision: converged owned.go.tito.io hibernate false -> true
2026/10/25 00:02:54 provision: removed retired instance route gone.go.tito.io (record gone)
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: adopted existing route story.carlosframework.com (app "story" acct "bad") — this record now owns its channel and environment
2026/10/25 00:02:54 provision: story.carlosframework.com exists but is not the route this record describes (kind "instance"/"static") — leaving it alone
2026/10/25 00:02:54 provision: minted static route site.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted service route pub.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted service route pubs.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route exec.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted service route loop.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted service route named.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted service route priv.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route unit.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted static route site.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted static route pisite.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted static route site.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: removed retired static route site.go.tito.io (record gone)
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme-uk.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: converged acme.go.tito.io replicas "ie,uk" -> "uk"
2026/10/25 00:02:54 provision: converged acme.go.tito.io replicas "uk" -> ""
2026/10/25 00:02:54 provision: minted instance route acme-uk.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: converged acme-uk.go.tito.io replica mark true -> false
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route router.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: acme.go.tito.io: row is on the nested layout (db "/data/instances/acme.go.tito.io/acme.go.tito.io.db" socket "/run/carlos/instances/acme.go.tito.io/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route router.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route router.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: minted instance route router.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:54 provision: acme.go.tito.io: not minting this pass: the box's layout intent could not be read: store down
2026/10/25 00:02:54 provision: router.go.tito.io: not minting this pass: the box's layout intent could not be read: store down
2026/10/25 00:02:54 provision: adopted existing route acme.go.tito.io (app "tito" acct "bac") — this record now owns its channel and environment
2026/10/25 00:02:54 provision: converged acme.go.tito.io channel stable -> edge
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io held landing by mv_acme (app "tito" acct "bac")
2026/10/25 00:02:54 provision: not removing acme.go.tito.io (record gone): participant of a running operation
2026/10/25 00:02:54 provision: removed retired instance route acme.go.tito.io (record gone)
2026/10/25 00:02:54 provision: minted instance route acme.go.tito.io held landing by mv_acme (app "tito" acct "bac")
2026/10/25 00:02:54 provision: refusing to mint held route acme.go.tito.io (app "tito" acct "bac"): this box declares CARLOS_INBOUND=none (no-inbound) and cannot serve routed instance traffic
2026/10/25 00:02:54 provision: held acme.go.tito.io landing by mv_acme (was ready)
2026/10/25 00:02:54 provision: acme.go.tito.io: held restoring by rb_other, not by mv_acme; leaving it
2026/10/25 00:02:54 provision: acme.go.tito.io: the row is not this pass's (app "other" acct ""); not holding it for mv_acme
2026/10/25 00:02:54 provision: acme.go.tito.io exists but is not the route this record describes (app "other"/"tito") — leaving it alone
2026/10/25 00:02:55 provision: dry-run: would mint instance route acme.go.tito.io held landing by mv_acme (app "tito" acct "bac" channel "stable")
2026/10/25 00:02:55 provision: acme.go.tito.io: not held landing by mv_acme: the row's hold changed under this pass; the next pass judges it afresh
2026/10/25 00:02:55 provision: held acme.go.tito.io landing by mv_acme (was ready)
2026/10/25 00:02:55 provision: minted instance route acme.example.com (app "shop" acct "bac")
2026/10/25 00:02:55 provision: minted instance route plain.example.com (app "shop" acct "bac")
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/garbled.shop.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/liar.shop.example.com.json: disagrees with its own path (host="other.shop.example.com" account="bac" app="shop")
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/garbled.shop.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/liar.shop.example.com.json: disagrees with its own path (host="other.shop.example.com" account="bac" app="shop")
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/garbled.shop.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/liar.shop.example.com.json: disagrees with its own path (host="other.shop.example.com" account="bac" app="shop")
2026/10/25 00:02:55 provision: skipping record apps/bac/shop/instances/garbled.shop.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:55 provision: listing apps/bac/shop/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:55 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:55 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:55 provision: removed retired instance route acme.go.tito.io (record gone)
2026/10/25 00:02:55 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:55 provision: bac/tito is in the trash — not minting instance routes for it
2026/10/25 00:02:55 provision: minted sidecar route bot.shop.bac.sidecar.internal (app "shop" acct "bac" args ["run"])
2026/10/25 00:02:55 provision: removed retired sidecar route bot.shop.bac.sidecar.internal (record gone)
2026/10/25 00:02:56 provision: minted sidecar route bot.shop.bum.sidecar.internal (app "shop" acct "bum" args ["run"])
2026/10/25 00:02:56 provision: sidecar bot.shop.bum.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:56 provision: minted sidecar route bot.shop.bum.sidecar.internal (app "shop" acct "bum" args ["run"])
2026/10/25 00:02:56 provision: sidecar bot.shop.bum.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:56 provision: removed retired sidecar route bot.shop.bum.sidecar.internal (record gone)
2026/10/25 00:02:56 provision: sidecar bot.shop.bum.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:56 provision: sidecar bot.shop.bum.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:56 provision: removed retired sidecar route bot.shop.bum.sidecar.internal (record gone)
2026/10/25 00:02:56 provision: a.shop.example.com: swapped for import sd_fup3appxmbimevh5jptsvs47vm (the original route is journaled)
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_fup3appxmbimevh5jptsvs47vm committed: its gate is cleared and its journal row dropped
2026/10/25 00:02:56 provision: a.shop.example.com: row is on the nested layout (db "/data/instances/a.shop.example.com/a.shop.example.com.db" socket "/run/carlos/instances/a.shop.example.com/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_biarfln3t2gwcp5nfw3aauzsq4 rolled back to its original route
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_biarfln3t2gwcp5nfw3aauzsq4: the host's replica is left alone: the record apps/bac/shop/instances/a.shop.example.com.json holds the host
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_biarfln3t2gwcp5nfw3aauzsq4 is cleaned up and its journal row retired
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_mffesojpqzgai4ckrzusnsxbv4 rolled back to its original route
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_mffesojpqzgai4ckrzusnsxbv4: the host's replica is left alone: the record apps/bac/shop/instances/a.shop.example.com.json holds the host
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_mffesojpqzgai4ckrzusnsxbv4 is cleaned up and its journal row retired
2026/10/25 00:02:56 provision: dry-run: would redo a.shop.example.com's swap record CAS for import sd_dgch7xl6dqshemgrp3cxpko7f4
2026/10/25 00:02:56 provision: dry-run: would clear a.shop.example.com's import gate
2026/10/25 00:02:56 provision: dry-run: would converge a.shop.example.com seed source
2026/10/25 00:02:56 provision: a.shop.example.com: row is on the nested layout (db "/data/instances/a.shop.example.com/a.shop.example.com.db" socket "/run/carlos/instances/a.shop.example.com/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:56 provision: a.shop.example.com: the import's record apps/bac/shop/instances/a.shop.example.com.json is not one this pass can use (connection reset)
2026/10/25 00:02:56 provision: a.shop.example.com: the import's record apps/bac/shop/instances/a.shop.example.com.json is not one this pass can use (provision: invalid maintenance projection or protected fields)
2026/10/25 00:02:56 provision: a.shop.example.com: the import's record apps/bac/shop/instances/a.shop.example.com.json is not one this pass can use (the record under apps/bac/shop/instances/a.shop.example.com.json is apps/bac/shop/instances/b.shop.example.com.json's)
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_ldq65enbpgi534b7gsza4mzhwi cannot roll back on this box: the activator is not wired; it stays journaled and gated
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_nvkepenfal73yubr4dhpeawctu cannot roll back on this box: the activator is not wired; it stays journaled and gated
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_alfsbv4qwreujnowdlhlc7i32q is journaled, but this box cannot act on imports; its row is left alone
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_q6pxvh5vhdqyfuoqjf5av7x2le is journaled, but this box cannot act on imports; its row is left alone
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_wtrrf4dln2wg5gdm26szxv4xau is journaled, but this box cannot act on imports; its row is left alone
2026/10/25 00:02:56 provision: the import journal could not be read: registry: import journal a.shop.example.com: original row: unexpected end of JSON input (no import is acted on and no route is removed this pass)
2026/10/25 00:02:56 provision: b.shop.example.com: import sd_ijjczxtnv2cunx6zydm2nfvy4y left alone this pass: the import journal could not be read
2026/10/25 00:02:56 provision: c.shop.example.com: import sd_l5vjlongpc4t46fzf2pablripm left alone this pass: the import journal could not be read
2026/10/25 00:02:56 provision: a.shop.example.com: import sd_5dotpodglyzw4eijpe7ddwovze committed: its gate is cleared and its journal row dropped
2026/10/25 00:02:56 provision: a.shop.example.com: not converging import sd_nhu3hvwqgr64ckpow3ru2c55ha: it is swapped but not committed, and the row on this box has no import gate
2026/10/25 00:02:56 provision: a.shop.example.com: not converging import sd_bkp7tv6srey6v7su7crk3c2mza: it is swapped but not committed, and the row on this box has no import gate
2026/10/25 00:02:56 provision: a.shop.example.com: not converging import sd_dim6ruiqjqumheyiybrn36sdlu: it is placed but not committed, and the row on this box has no import gate
2026/10/25 00:02:56 provision: a.shop.example.com: not converging import sd_bhcrusksk6zbsxlvmils2uqbra: it is placed but not committed, and the row on this box has no import gate
2026/10/25 00:02:56 provision: a.shop.example.com: row is on the nested layout (db "/data/instances/a.shop.example.com/a.shop.example.com.db" socket "/run/carlos/instances/a.shop.example.com/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:56 provision: converge seed source on a.shop.example.com: constraint failed: seed_source is read-only here (1811)
2026/10/25 00:02:56 provision: a.shop.example.com: row is on the nested layout (db "/data/instances/a.shop.example.com/a.shop.example.com.db" socket "/run/carlos/instances/a.shop.example.com/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3j37d6y7szkrwkvs3flo3g6kcu committed: its gate is cleared and its journal row dropped
2026/10/25 00:02:57 provision: a.shop.example.com: row is on the nested layout (db "/data/instances/a.shop.example.com/a.shop.example.com.db" socket "/run/carlos/instances/a.shop.example.com/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:57 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:57 provision: acme.go.tito.io: row is on the nested layout (db "/data/instances/acme.go.tito.io/acme.go.tito.io.db" socket "/run/carlos/instances/acme.go.tito.io/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:57 provision: acme.go.tito.io: not minting a seeded instance: this box does not mint nested (<nil>)
2026/10/25 00:02:57 provision: acme.go.tito.io: not minting a seeded instance: claim control is on for this box
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_3ejkvs7n4zn4ztzyf3nd5m7kyy: this box cannot read seed markers, and places no seed; nothing local is removed
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_3ejkvs7n4zn4ztzyf3nd5m7kyy rolled back (no box had swapped it)
2026/10/25 00:02:57 provision: acme.go.tito.io: not minting a seeded instance: its record does not describe a hibernating instance
2026/10/25 00:02:57 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:57 provision: removed instance route acme.go.tito.io (its seed sd_bkfjdffs723zlzwf2giijv2hfy was aborted); the next pass rolls it back
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_bkfjdffs723zlzwf2giijv2hfy: this box cannot read seed markers, and places no seed; nothing local is removed
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_bkfjdffs723zlzwf2giijv2hfy rolled back (no box had swapped it)
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_7hy6fipgfcwxormrvj4reka7eq has a row this pass may not remove; leaving the seed aborted
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_b4zrmtzr4xw3bvpgc6nrterwiq rolled back (no box had swapped it)
2026/10/25 00:02:57 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:57 provision: removed instance route acme.go.tito.io (its seed sd_vva4re5uhkfaoycg2rufqs3je4 was aborted); the next pass rolls it back
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_vva4re5uhkfaoycg2rufqs3je4 has no route on this box: its local data is removed
2026/10/25 00:02:57 provision: acme.go.tito.io: aborted seed sd_vva4re5uhkfaoycg2rufqs3je4 rolled back (no box had swapped it)
2026/10/25 00:02:57 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_37tqectkktrf7ho7gf3al6hhai (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_37tqectkktrf7ho7gf3al6hhai rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_37tqectkktrf7ho7gf3al6hhai is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_5rndg6xzzj32bk3iypgwykc7tm (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_5rndg6xzzj32bk3iypgwykc7tm rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_5rndg6xzzj32bk3iypgwykc7tm is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_km6ofikafqr4epezeqrlgsn5bi (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_km6ofikafqr4epezeqrlgsn5bi rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_km6ofikafqr4epezeqrlgsn5bi: the host's replica is left alone: its record no longer names this seed
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_km6ofikafqr4epezeqrlgsn5bi is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_3m5lkc5giwkysfmpmeiy6bgjaa (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3m5lkc5giwkysfmpmeiy6bgjaa rollback deferred: the host is not fenced and stopped yet (<nil>)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3m5lkc5giwkysfmpmeiy6bgjaa rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3m5lkc5giwkysfmpmeiy6bgjaa is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_6njb6lbuoiltttidnetptenfe4 (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6njb6lbuoiltttidnetptenfe4 rollback deferred: the host is not fenced and stopped yet (stop unproven)
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_u6n66ytph65vx33vxwlhf2ra3i (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_u6n66ytph65vx33vxwlhf2ra3i is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_i3mbumfdh6m3czazj3fzpmlgpi (the original route is journaled)
2026/10/25 00:02:57 provision: skipping record apps/bac/shop/instances/a.shop.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_i3mbumfdh6m3czazj3fzpmlgpi left alone this pass: its record could not be read
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_beyitqy4r5ulisz2cpg4krso5y (the original route is journaled)
2026/10/25 00:02:57 provision: skipping record apps/bac/shop/instances/a.shop.example.com.json: read failed: connection reset
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_beyitqy4r5ulisz2cpg4krso5y left alone this pass: its record could not be read
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_k6rpvi2pmowqs7abpuex6agwoq (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_k6rpvi2pmowqs7abpuex6agwoq: close the import gate: constraint failed: injected (1811)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_k6rpvi2pmowqs7abpuex6agwoq rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_k6rpvi2pmowqs7abpuex6agwoq is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_a5oukpvpseo4mmopnomuislhzu (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_a5oukpvpseo4mmopnomuislhzu: close the import gate: constraint failed: injected (1811)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_a5oukpvpseo4mmopnomuislhzu rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_a5oukpvpseo4mmopnomuislhzu is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_wlf72ttujozcphp7dviuaxg64a (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_wlf72ttujozcphp7dviuaxg64a rollback deferred: the host is not fenced and stopped yet (injected failure at fence)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_wlf72ttujozcphp7dviuaxg64a rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_wlf72ttujozcphp7dviuaxg64a is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_gayeac5qqlsjebcpnavnbowfie (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_gayeac5qqlsjebcpnavnbowfie rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_gayeac5qqlsjebcpnavnbowfie is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_6bufpf5rviv7jkqd2qcqqkchly (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6bufpf5rviv7jkqd2qcqqkchly: retire its instance key: injected failure at retire-key
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6bufpf5rviv7jkqd2qcqqkchly rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6bufpf5rviv7jkqd2qcqqkchly is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_4ajsor373xpthehfk2qcx6d4ri (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_4ajsor373xpthehfk2qcx6d4ri rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_4ajsor373xpthehfk2qcx6d4ri is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_gcrgljnwrwguqtdsfueh34yji4 (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_gcrgljnwrwguqtdsfueh34yji4: remove its local data: injected failure at remove-local
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_gcrgljnwrwguqtdsfueh34yji4 rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_gcrgljnwrwguqtdsfueh34yji4 is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_k73r6sg4wxybtm4qrq2sdtaice (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_k73r6sg4wxybtm4qrq2sdtaice rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_k73r6sg4wxybtm4qrq2sdtaice is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_s3tqxwj5b6e5ucwuk5iwcgqy44 (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_s3tqxwj5b6e5ucwuk5iwcgqy44: remove its local data: injected failure at remove-local-done
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_s3tqxwj5b6e5ucwuk5iwcgqy44 rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_s3tqxwj5b6e5ucwuk5iwcgqy44 is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_zpz7uwonprszhl2277nqkvhwjq (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_zpz7uwonprszhl2277nqkvhwjq rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_zpz7uwonprszhl2277nqkvhwjq is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_3wv2z5ugjyv2k3wocooc4vd2cm (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3wv2z5ugjyv2k3wocooc4vd2cm: restore the original route: constraint failed: injected (1811)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3wv2z5ugjyv2k3wocooc4vd2cm rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_3wv2z5ugjyv2k3wocooc4vd2cm is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_o6onnjnxtzgjesp3uut6cxmbpy (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_o6onnjnxtzgjesp3uut6cxmbpy: restore the original route: constraint failed: injected (1811)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_o6onnjnxtzgjesp3uut6cxmbpy rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_o6onnjnxtzgjesp3uut6cxmbpy is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_af25jd6uvrcbi32fxm4u5mxtwa (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_af25jd6uvrcbi32fxm4u5mxtwa is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_hwxorsse42vrk625r5573h6paa (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_hwxorsse42vrk625r5573h6paa rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_hwxorsse42vrk625r5573h6paa: delete its snapshot: injected failure at delete-snapshot
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_hwxorsse42vrk625r5573h6paa is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_s76zqwhobibrmbcztohtfx3biu (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_s76zqwhobibrmbcztohtfx3biu rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_s76zqwhobibrmbcztohtfx3biu is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_43mtmapdgyrrje3qw5ltnnxjqy (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_43mtmapdgyrrje3qw5ltnnxjqy rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_43mtmapdgyrrje3qw5ltnnxjqy: delete the host's replica: injected failure at delete-replica
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_43mtmapdgyrrje3qw5ltnnxjqy is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_ujh7ts74ii4mybqr2cxp5dfi3a (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_ujh7ts74ii4mybqr2cxp5dfi3a rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_ujh7ts74ii4mybqr2cxp5dfi3a is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_ynufkkrvvanvzkspcxxzmtexlq (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_ynufkkrvvanvzkspcxxzmtexlq rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_ynufkkrvvanvzkspcxxzmtexlq: retire its journal row: constraint failed: injected (1811)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_ynufkkrvvanvzkspcxxzmtexlq is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_6rl35nu3zd22ujona2ttouwfxa (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6rl35nu3zd22ujona2ttouwfxa rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6rl35nu3zd22ujona2ttouwfxa: retire its journal row: constraint failed: injected (1811)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_6rl35nu3zd22ujona2ttouwfxa is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_65g47g43fn452cceqmrus53rha (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_65g47g43fn452cceqmrus53rha rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_65g47g43fn452cceqmrus53rha is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: mark import sd_65g47g43fn452cceqmrus53rha rolled back: injected failure at cas
2026/10/25 00:02:57 provision: a.shop.example.com: aborted seed sd_65g47g43fn452cceqmrus53rha rolled back (no box had swapped it)
2026/10/25 00:02:57 provision: a.shop.example.com: swapped for import sd_4thxdn64nhzuq2ljq4v2kua7q4 (the original route is journaled)
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_4thxdn64nhzuq2ljq4v2kua7q4 rolled back to its original route
2026/10/25 00:02:57 provision: a.shop.example.com: import sd_4thxdn64nhzuq2ljq4v2kua7q4 is cleaned up and its journal row retired
2026/10/25 00:02:57 provision: a.shop.example.com: aborted seed sd_4thxdn64nhzuq2ljq4v2kua7q4 rolled back (no box had swapped it)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_fbmv3bpvln7emn7oy6fqboq5we (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_fbmv3bpvln7emn7oy6fqboq5we rollback deferred: the host is not fenced and stopped yet (<nil>)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_fbmv3bpvln7emn7oy6fqboq5we rollback deferred: the host is not fenced and stopped yet (<nil>)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_fbmv3bpvln7emn7oy6fqboq5we rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_fbmv3bpvln7emn7oy6fqboq5we is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_ab4jl4bphelzza3vdwg7gebx6y (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_ab4jl4bphelzza3vdwg7gebx6y rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_ab4jl4bphelzza3vdwg7gebx6y is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_3jeu3oopiojnp7bb2xpguc7ccq (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_3jeu3oopiojnp7bb2xpguc7ccq rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_3jeu3oopiojnp7bb2xpguc7ccq is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "shop" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_x7dywzvrhwfjfcyx3igcawamka (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_x7dywzvrhwfjfcyx3igcawamka rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_x7dywzvrhwfjfcyx3igcawamka is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "shop" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_w3fq6hw6mrn4vpdag2tb6zp4oy (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_w3fq6hw6mrn4vpdag2tb6zp4oy rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_w3fq6hw6mrn4vpdag2tb6zp4oy is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "shop" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_djjq3gykyzztqvopzzva6luium (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_djjq3gykyzztqvopzzva6luium rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_djjq3gykyzztqvopzzva6luium is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "other" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_xrs6htwtg5a4w2fhek45ozhb5q (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_xrs6htwtg5a4w2fhek45ozhb5q rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_xrs6htwtg5a4w2fhek45ozhb5q is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "other" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_w57gf43tfbzyhve7elp56zgp6e (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_w57gf43tfbzyhve7elp56zgp6e rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_w57gf43tfbzyhve7elp56zgp6e is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "other" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_gdx36wgnzui5p76dl3rdbtciji (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_gdx36wgnzui5p76dl3rdbtciji has no route on this box: its local data is removed and no route is put back
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_gdx36wgnzui5p76dl3rdbtciji is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_papnodanq5olk2lab7uufnxoji (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_adtkaai5f6ktfkckxelcjbba3y (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_ogddgduzxhhkhv6cqd3xqcpzia (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_ogddgduzxhhkhv6cqd3xqcpzia cannot roll back on this box: the activator is not wired; it stays journaled and gated
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_nhqaihdmg2l5mvtc4ke2rh53ia (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_nhqaihdmg2l5mvtc4ke2rh53ia is not rolled back: the route changed under the fence, so nothing there is touched
2026/10/25 00:02:58 provision: a.shop.example.com: import "../not-a-seed" names no snapshot and no replica; only its journal row is cleaned up
2026/10/25 00:02:58 provision: a.shop.example.com: import ../not-a-seed is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_qolm5hsh3vwjuwa2gwyxcmyvem (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_c5nu2nznmdolxuwuk4vowe2i2u (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_lftzwqd5x37qgzkeiakgww6v44 (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_xikvsukrcvzirdc3brwoklv7zq (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_66rzsk6r3fe4322emlixapf5ba (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_66rzsk6r3fe4322emlixapf5ba rollback deferred: the host is not fenced and stopped yet (stop evidence unreadable)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_n3qces3mf5r3d5odgjjcqhkngq (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_n3qces3mf5r3d5odgjjcqhkngq has no route on this box: its local data is removed and no route is put back
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_n3qces3mf5r3d5odgjjcqhkngq is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: minted instance route a.shop.example.com (app "shop" acct "bac")
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_jxtw73zo2dcftidtbl5335sk7u (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_jxtw73zo2dcftidtbl5335sk7u: remove its local data: injected failure at remove-local
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_jxtw73zo2dcftidtbl5335sk7u is not rolled back: the route at the host is not the import's, so nothing there is touched
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_kucw3ji4ciktv4nr2fj4dekwka (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_kucw3ji4ciktv4nr2fj4dekwka: a route appeared at the host, so its local database is left and the rollback waits
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_zmfpij2irueqxyumv5a4ecrqzy (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_zmfpij2irueqxyumv5a4ecrqzy rollback deferred: no fence generation: registry busy
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_nkwgsizauorh242cvemqrgpmwi (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_nkwgsizauorh242cvemqrgpmwi rollback deferred: no fence generation: the generation source answered 0
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_zifraiz2aapsf74vzj3tikde7a (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_wkq6gam5smkhaycp446notrqmy (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_vmpsh7kgejngaln4gcxeuyw26i (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import deferred: this box cannot read the instance's env file
2026/10/25 00:02:58 provision: a.shop.example.com: import deferred: the instance's env file could not be read: a symlink
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_p7jbinvk2n22suzqgxvxdy4cua (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_p7jbinvk2n22suzqgxvxdy4cua rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_p7jbinvk2n22suzqgxvxdy4cua is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_zrgpicwk7uzquxngdwyiospod4 (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_zrgpicwk7uzquxngdwyiospod4 rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_zrgpicwk7uzquxngdwyiospod4 is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_gmullogju6phoadj67wzgubjva (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_gmullogju6phoadj67wzgubjva rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_gmullogju6phoadj67wzgubjva is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_bsyzpcypo3fgq3bbyaiycusfye (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_bsyzpcypo3fgq3bbyaiycusfye: retire its instance key: the env file is a symlink
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_bsyzpcypo3fgq3bbyaiycusfye rolled back to its original route
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_bsyzpcypo3fgq3bbyaiycusfye is cleaned up and its journal row retired
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_ualhrjsumv5nnvm2qbgqrwl67u (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: row is on the nested layout (db "/data/instances/a.shop.example.com/a.shop.example.com.db" socket "/run/carlos/instances/a.shop.example.com/app.sock"); the record's shared paths are not drift
2026/10/25 00:02:58 provision: a.shop.example.com: swapped for import sd_cevqifjt5o6pjju6qbpfckpudm (the original route is journaled)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_fjzhtsvqzff7t5mm3w55bmtn3u refused: there is no route at a.shop.example.com to replace
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_pk2hczhmfet64ckuiv7n55cf7a refused: the route's address is 127.0.0.1:9, not 127.0.0.1:8401
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_nekjkc6g5bo7mpg7ci2m66jc7e refused: the route's address is 127.0.0.1:8401,127.0.0.1:8402, not 127.0.0.1:8401
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_7tztgr3i2it4njg47mjatwzmx4 refused: the route's address is 127.0.0.1:9, not 127.0.0.1:8401
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_kfwudc2jrnewebdpo3ffll7kx4 refused: the route belongs to app other
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_e663egp4iiqlxk2cdnfdw7fpcq refused: the route is filed under another account
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_dl6ndpx54xslpnfhrttrlhmlri refused: the route is filed under the operator account, and no assignment maps shop to this app
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_sdmf7hbekdcfj2k53oi2k4vuaq refused: the route is filed under the operator account, and no assignment maps shop to this app
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_pacztnqgl6xpjbrjmxswocskly refused: the route is filed under the operator account, and no assignment maps shop to this app
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_2krrxxytpzmknfrnl3uk65ztze refused: the route is filed under the operator account, and no assignment maps shop to this app
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_f6nyvajqqngszkfhxs6gy76pju refused: the route is not an address route this import can take over (socket)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_3ej3vucoq7nbrw5dhxwedvibg4 refused: the route is not an address route this import can take over (no address)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_5r52cixxuwia57dh6mxgy6cvtq refused: the route is not an address route this import can take over (provisioned)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_sb2vmsoxy3nu3mb6nstqlpzufa refused: the route is not an address route this import can take over (kind static)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_brfgm5icov2hhli5imgczydo2y refused: the route is not an address route this import can take over (backing)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_ggp2g2flvnnasm24jpgbybmfpm refused: the route is not an address route this import can take over (tunnel)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_womu3rclqnjgcb66c4fgpc2qfu refused: the route is not an address route this import can take over (caps)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_nwdqgh2vv4hdcmzeaqkjqdfkk4 refused: the route is not an address route this import can take over (platform)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_mg7rmkoz3wxuezjamycgyzokva refused: the route is not an address route this import can take over (canary)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_igocj6gfqlmseu3fehvk3cc2ka refused: the route is not an address route this import can take over (kind sidecar)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_ytf5w2jc2777fjdooal2cmdfwi refused: the route is not an address route this import can take over (region)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_eittf6uzgha5kqsyjgtjgtwhaq refused: the route is not an address route this import can take over (fleet_box)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_ixaw5jcrmedibc3jx2wazeizfu refused: the route is not an address route this import can take over (hibernate)
2026/10/25 00:02:58 provision: a.shop.example.com: import sd_xulxq35a3ijkt5vwyitx2gzw4q refused: the route is not an address route this import can take over (claim_owner)
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_o6ywlayks5tnt4mxrkady7fwnq refused: this box does not run instances nested
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_vq7q3tzv32knvw5oar4xow3jx4 refused: this box does not run instances nested
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_dagzntlsqmfqinhydip6buiina refused: claim control is on for this box
2026/10/25 00:02:59 provision: a.shop.example.com: swapped for import sd_btbov4wmlief2owzmedacflpfe (the original route is journaled)
2026/10/25 00:02:59 provision: a.shop.example.com: swapped for import sd_xgl36ebrrjmqaoc6e7diqumxhe (the original route is journaled)
2026/10/25 00:02:59 provision: a.shop.example.com: import deferred: this box cannot read the legacy route assignments
2026/10/25 00:02:59 provision: a.shop.example.com: import deferred: the legacy route assignments could not be read: store down
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_2zj747is2wkuu2jh4nq6x5tnye: its verify hash is not a sha256
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_g6jer2pxwupnipbi3euaxzlkru: its verify hash is not a sha256
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_wu3y35ucv2iklsve3pbnwz7k7q: its verify hash is not a sha256
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_../../x: its host or seed id is malformed (seeds: not a seed id)
2026/10/25 00:02:59 provision: A.shop.example.com/..: not swapping for import sd_qhsjewsmuugaegtyptx26f5c7y: its host or seed id is malformed (seeds: not a host)
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_y5cxn26ljyf2qruaqjxrax45eu: its record does not describe a nested, hibernating instance
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_ag44hvmmrdted2wdzkncpcgca4: its record does not describe a nested, hibernating instance
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_dwmjlijmcecn33qy6qz4koqpzy: its record does not describe a nested, hibernating instance
2026/10/25 00:02:59 provision: a.shop.example.com: not swapping for import sd_bke5ufvodllhrt5eebb6oa7eni: its record does not describe a nested, hibernating instance
2026/10/25 00:02:59 provision: a.shop.example.com: import deferred: the box's layout intent could not be read: store down
2026/10/25 00:02:59 provision: a.shop.example.com: swapped for import sd_f3cals7spfqe6qo7xov2qigwne (the original route is journaled)
2026/10/25 00:02:59 provision: a.shop.example.com: import deferred: the box's nested probe did not answer: ready probe timed out
2026/10/25 00:02:59 provision: a.shop.example.com: swapped for import sd_gypfy4opf4o5vkwaj65bpi5pjy (the original route is journaled)
2026/10/25 00:02:59 provision: a.shop.example.com: swapped for import sd_o7vqabkkmusod4srdt3v7fxqhu (the original route is journaled)
2026/10/25 00:02:59 provision: a.shop.example.com: import deferred: the route is held by operation op_1
2026/10/25 00:02:59 provision: dry-run: would consider swapping a.shop.example.com for import sd_kwsepaphvbku4p3ig3ifptmcma
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_dora3yuffsa76zqf4rfubyj44e rolled back to its original route
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_dora3yuffsa76zqf4rfubyj44e: the host's replica is left alone: the record apps/bac/shop/instances/a.shop.example.com.json holds the host
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_dora3yuffsa76zqf4rfubyj44e is cleaned up and its journal row retired
2026/10/25 00:02:59 provision: a.shop.example.com: import sd_hr2okm5z474ooailnqeqmyc2n4 left alone: the import journal holds seed sd_ibdedqganknrryh4vzvaq6cvwq at swapped
2026/10/25 00:02:59 provision: a.shop.example.com: not minting import sd_mpm3rwdyx3ky4b2sf3pm3hbiga: it is swapped but not committed, and only its swap makes its row
2026/10/25 00:02:59 provision: a.shop.example.com: not minting import sd_3m7umvy2ote6a5cs2kznp7bmeu: it is placed but not committed, and only its swap makes its row
2026/10/25 00:02:59 provision: a.shop.example.com: swapped for import sd_sqmmmbv7z2rvhxj5l635q3z7va (the original route is journaled)
2026/10/25 00:02:59 provision: a.shop.example.com: not minting import sd_sqmmmbv7z2rvhxj5l635q3z7va: it is swapped but not committed, and only its swap makes its row
2026/10/25 00:02:59 provision: a.shop.example.com: not minting import sd_sqmmmbv7z2rvhxj5l635q3z7va: it is placed but not committed, and only its swap makes its row
2026/10/25 00:02:59 provision: minted instance route a.shop.example.com (app "shop" acct "bac")
2026/10/25 00:02:59 provision: removed retired sidecar route gone.eleven.bac.sidecar.internal (record gone)
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: converged sidecar bot.eleven.bac.sidecar.internal args ["sidecar","run"] -> ["worker","run"]
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: converged sidecar bot.eleven.bac.sidecar.internal ceilings 300/3600 -> 60/120
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: converged sidecar bot.eleven.bac.sidecar.internal channel stable -> canary/eleven
2026/10/25 00:02:59 provision: converged sidecar bot.eleven.bac.sidecar.internal environment "other" -> "relay"
2026/10/25 00:02:59 provision: converged sidecar bot.eleven.bac.sidecar.internal hibernate true -> false
2026/10/25 00:02:59 provision: skipping sidecar record apps/bac/eleven/sidecars/bot.json: read failed: failStore: reads disabled under apps/bac/eleven/sidecars/
2026/10/25 00:02:59 provision: skipping sidecar record apps/bac/eleven/sidecars/bot.json: malformed: invalid character 'n' looking for beginning of object key string
2026/10/25 00:02:59 provision: not removing sidecar bot.eleven.bac.sidecar.internal: its record exists but could not be read cleanly this pass
2026/10/25 00:02:59 provision: skipping sidecar record apps/bac/eleven/sidecars/bot.json: empty channel
2026/10/25 00:02:59 provision: skipping sidecar record apps/bac/eleven/sidecars/held.json: empty channel
2026/10/25 00:02:59 provision: not removing sidecar held.eleven.bac.sidecar.internal: its record exists but could not be read cleanly this pass
2026/10/25 00:02:59 provision: removed retired sidecar route old.eleven.bac.sidecar.internal (record gone)
2026/10/25 00:02:59 provision: bac/eleven has sidecar records but no sidecars manifest — not minting
2026/10/25 00:02:59 provision: bac/eleven is in the trash — not minting sidecar routes for it
2026/10/25 00:02:59 provision: sidecar bot.eleven.bac.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:59 provision: sidecar hub.relay.bac.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: minted sidecar route hub.relay.bac.sidecar.internal (app "relay" acct "bac" args ["relay"])
2026/10/25 00:02:59 provision: sidecar bot.eleven.bac.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: sidecar bot.eleven.bac.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: sidecar bot.eleven.bac.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:59 provision: removed retired sidecar route bot.eleven.bac.sidecar.internal (record gone)
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: sidecar bot.eleven.bac.sidecar.internal is not placeable here: it asks for "no-inbound" placement and this box accepts inbound work (CARLOS_INBOUND="")
2026/10/25 00:02:59 provision: skipping sidecar record apps/bac/relay/sidecars/hub.json: read failed: failStore: reads disabled under apps/bac/relay/sidecars/
2026/10/25 00:02:59 provision: REFUSING to mint sidecar bot.eleven.bac.sidecar.internal: bot.eleven.bac.sidecar.internal-sidecar.env is staged on this box — the legacy file co-spawn and a native sidecar row are two mechanisms for one host; remove the file to migrate this host onto sidecar records
2026/10/25 00:02:59 provision: minted sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" args ["sidecar","run"])
2026/10/25 00:02:59 provision: dry-run: would mint sidecar route bot.eleven.bac.sidecar.internal (app "eleven" acct "bac" channel "stable" args ["sidecar","run"])
2026/10/25 00:02:59 provision: dry-run: would remove retired sidecar route gone.eleven.bac.sidecar.internal (record gone)
2026/10/25 00:02:59 provision: bot.eleven.bac.sidecar.internal exists but is not a sidecar row this pass owns (kind "sidecar" provisioned false app "eleven" acct "bac") — leaving it alone
2026/10/25 00:02:59 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:59 provision: converged acme.go.tito.io update settings "{\"updates\":\"manual\",\"channel\":\"stable\"}" -> ""
2026/10/25 00:02:59 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:59 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:59 provision: manifest bac/tito: read failed: provision: manifest bac/tito: unexpected end of JSON input
2026/10/25 00:02:59 provision: manifest bac/tito: read failed: provision: manifest bac/tito: unexpected end of JSON input
2026/10/25 00:02:59 provision: acme.go.tito.io: not minted this pass: the app's update policy could not be read
2026/10/25 00:02:59 provision: minted instance route acme.go.tito.io (app "tito" acct "bac")
2026/10/25 00:02:59 provision: manifest bac/tito: read failed: provision: manifest bac/tito: unexpected end of JSON input
2026/10/25 00:02:59 provision: acme.go.tito.io: not minted this pass: the app's update policy could not be read
2026/10/25 00:02:59 provision: minted instance route acme.go.tito.io held landing by mv_acme (app "tito" acct "bac")
2026/10/25 00:02:59 provision: listing apps/bqd/: listdirs refused — its records are unseen this pass
2026/10/25 00:02:59 provision: listing apps/bqd/: listdirs refused — its records are unseen this pass
2026/10/25 00:02:59 provision: record view: change index unusable (release: change index unreadable: store has no conditional read: unsupported operation): the walk records no generations
2026/10/25 00:02:59 provision: listing apps/bqd/: listdirs refused — its records are unseen this pass
2026/10/25 00:02:59 provision: listing apps/bqd/: listdirs refused — its records are unseen this pass
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: listing apps/bqd/: listdirs refused — its records are unseen this pass
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: record view: re-reading apps/bqc/shop failed: retrying on the next refresh
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: listing apps/bqc/shop/instances/: context canceled — its records are unseen this pass
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: record view: re-reading apps/bqc/shop failed: retrying on the next refresh
2026/10/25 00:02:59 provision: listing apps/bqc/shop/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:59 provision: listing apps/bqc/shop/instances/: list refused — its records are unseen this pass
2026/10/25 00:02:59 provision: an app's records could not be listed: they are skipped
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: record view: change index unusable (release: change index malformed: invalid character 'n' looking for beginning of object key string): walking
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: record view: change index unusable (get refused): walking
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping accounts/bqd/account.json: malformed account manifest: invalid character 'n' looking for beginning of object key string
2026/10/25 00:02:59 provision: skipping accounts/bqd/account.json: malformed account manifest: invalid character 'n' looking for beginning of object key string
2026/10/25 00:02:59 provision: skipping accounts/bqd/account.json: malformed account manifest: invalid character 'n' looking for beginning of object key string
2026/10/25 00:02:59 provision: record view: re-reading accounts/bqd failed: retrying on the next refresh
2026/10/25 00:02:59 provision: skipping accounts/bqd/account.json: read failed: list refused
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: minted instance route one.example.com (app "shop" acct "bum")
2026/10/25 00:02:59 provision: minted instance route one.example.com (app "shop" acct "bum")
2026/10/25 00:02:59 provision: minted instance route one.example.com (app "shop" acct "bum")
2026/10/25 00:02:59 provision: removed retired instance route one.example.com (record gone)
2026/10/25 00:02:59 provision: skipping record apps/bum/shop/instances/one.example.com.json: empty channel
2026/10/25 00:02:59 provision: not removing one.example.com: its record exists but could not be read cleanly this pass
2026/10/25 00:02:59 provision: removed retired instance route one.example.com (record gone)
2026/10/25 00:02:59 provision: skipping record apps/bum/shop/instances/one.example.com.json: empty channel
2026/10/25 00:02:59 provision: not removing one.example.com: its record exists but could not be read cleanly this pass
2026/10/25 00:02:59 provision: record view: change index unusable (context deadline exceeded): walking
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
2026/10/25 00:02:59 provision: record view: change index unusable (context deadline exceeded): the walk records no generations
2026/10/25 00:02:59 provision: skipping record apps/bqe/store/instances/bad.store.example.com.json: malformed: provision: invalid maintenance projection or protected fields
--- FAIL: TestPlan14RootReadCensus (5.25s)
plan14_root_reads_test.go:600: root read census: 21 discrepancies
changed root read internal/activator/activator.go:Service.begin; review class, task, sites and digest
changed root read internal/activator/activator.go:Service.beginRequest; review class, task, sites and digest
changed root read internal/activator/activator.go:Service.serve; review class, task, sites and digest
changed root read internal/activator/cmd.go:Service.RunCmd; review class, task, sites and digest
changed root read internal/edge/edge.go:Edge.ServeHTTP; review class, task, sites and digest
changed root read internal/host/agent.go:runAgent; review class, task, sites and digest
changed root source envelope internal/activator
changed root source envelope internal/applog
changed root source envelope internal/console
changed root source envelope internal/edge
changed root source envelope internal/host
changed root source envelope internal/reqrec
unclassified root read internal/edge/reqrecords.go:Edge.observeRecords whole:Route@491
unclassified root read internal/edge/reqrecords.go:Edge.recordMatch whole:Route@327
unclassified root read internal/edge/reqrecords.go:requestResponse registry:App@192,registry:Host@206,whole:Route@182
unclassified root read internal/reqrec/ref.go:NewRef file:Read@484
changed legacy declaration internal/activator/activator.go:Service.begin
changed legacy declaration internal/activator/activator.go:Service.beginRequest
changed legacy declaration internal/activator/activator.go:Service.serve
changed legacy declaration internal/activator/cmd.go:Service.RunCmd
changed legacy declaration internal/edge/edge.go:Edge.ServeHTTP
make census-card shows what changed; make census-propose NAME=<branch> CLAIMS=<file> writes the overlay and its approval card (AGENTS.md, The census)
FAIL
FAIL github.com/carlosframework/platform/internal/provision 13.621s
ok github.com/carlosframework/platform/internal/publicrelease 0.007s
? github.com/carlosframework/platform/internal/regionname [no test files]
ok github.com/carlosframework/platform/internal/registry 5.509s
ok github.com/carlosframework/platform/internal/relay 7.230s
ok github.com/carlosframework/platform/internal/release 24.800s
ok github.com/carlosframework/platform/internal/reqrec 0.021s
ok github.com/carlosframework/platform/internal/rollout 3.667s
ok github.com/carlosframework/platform/internal/rolloutwords 0.004s
ok github.com/carlosframework/platform/internal/rootaws 0.010s
ok github.com/carlosframework/platform/internal/rootparticipation 0.060s
ok github.com/carlosframework/platform/internal/rootstate 0.028s
ok github.com/carlosframework/platform/internal/runs 0.600s
ok github.com/carlosframework/platform/internal/s3compat 0.007s
ok github.com/carlosframework/platform/internal/safefile 0.009s
ok github.com/carlosframework/platform/internal/schedule 2.620s
ok github.com/carlosframework/platform/internal/seeds 0.012s
ok github.com/carlosframework/platform/internal/sim/engines 2.237s
ok github.com/carlosframework/platform/internal/sim/hostlife 8.969s
ok github.com/carlosframework/platform/internal/sim/litestreamfacts 4.530s
ok github.com/carlosframework/platform/internal/status 0.076s
ok github.com/carlosframework/platform/internal/steering 0.006s
ok github.com/carlosframework/platform/internal/stopevidence 0.445s
ok github.com/carlosframework/platform/internal/svcrole 0.002s
ok github.com/carlosframework/platform/internal/telemetry 0.004s
ok github.com/carlosframework/platform/internal/termfence 0.005s
ok github.com/carlosframework/platform/internal/tunnelclient 0.004s
ok github.com/carlosframework/platform/internal/unixdial 0.003s
ok github.com/carlosframework/platform/internal/updatewords 0.004s
ok github.com/carlosframework/platform/internal/usage 0.006s
ok github.com/carlosframework/platform/internal/version 0.003s
ok github.com/carlosframework/platform/internal/vet 1.609s
FAIL
=== internal_console@0 (82 s)
ok github.com/carlosframework/platform/internal/console 79.925s
=== internal_console@1 (38 s)
ok github.com/carlosframework/platform/internal/console 36.724s
=== internal_console@2 (37 s)
ok github.com/carlosframework/platform/internal/console 35.724s
=== internal_console@3 (43 s)
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: alert watch: no keymail grant for ops-b@keymail.dev — not notified (they must sign in to the console once)
2026/10/25 00:02:39 console: alert watch: no keymail grant for ops-b@keymail.dev — not notified (they must sign in to the console once)
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: alert watch: keymail box-a/disk to ops-b@keymail.dev: context deadline exceeded
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:39 console: could not notify paul@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:39 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: trashed bab/titogo: settle: release: read trash marker for bab/titogo: AccessDenied: s3://carlos-prod-secret/deleted.json request id ABC123
2026/10/25 00:02:40 console: bab/titogo is in the trash in the bucket; marking it trashed here
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: app region bab/titogo: (default)
2026/10/25 00:02:40 console: claim bab/titogo: set placement fleet/pi: SQL logic error: no such column: placement (1)
2026/10/25 00:02:40 console: backfilled account manifest for bab ()
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:40 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:41 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:41 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:41 console: could not notify bob@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:41 console: api db bab/titogo/acme.go.tito.io: stream level 0 1-1: context canceled
2026/10/25 00:02:41 console: api db bab/titogo/acme.go.tito.io: stream level 0 1-1: context canceled
2026/10/25 00:02:41 console: api db bab/titogo/acme.go.tito.io: stream level 0 1-1: context canceled
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:41 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:41 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:41 console: api db bab/titogo/acme.go.tito.io: stream level 0 1-1: write tcp 127.0.0.1:33809->127.0.0.1:55178: i/o timeout
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:41 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:41 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A44963: could not determine target mailbox
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A41707: could not determine target mailbox
2026/10/25 00:02:41 console: db read dbr_vxyddlzrvxnpv3j7ba2rsuuipy: relayed 0 chunks (0 bytes) in 0s, ended not-picked
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A45389: could not determine target mailbox
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A37545: could not determine target mailbox
2026/10/25 00:02:41 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:41 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A44115: could not determine target mailbox
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A45951: could not determine target mailbox
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A37781: could not determine target mailbox
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: could not notify member@example.com of a CLI token issue: keymail: lookup member@example.com: keymail: GET /api/federation/lookup?addr=member%40example.com&from=console%40127.0.0.1%3A37459: could not determine target mailbox
2026/10/25 00:02:42 console: db read dbr_mqw4xcrdsemmbmd7evjbvsaa4m: relayed 0 chunks (0 bytes) in 501ms, ended no-result
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: CARLOS_ACME_DELEGATION_ZONE "*.bad zone" is not a valid domain — delegation off, wildcard-enable requests refuse with "no delegation zone configured" until it's fixed
2026/10/25 00:02:42 console: CARLOS_ACME_DELEGATION_ZONE "-leading-hyphen.example.com" is not a valid domain — delegation off, wildcard-enable requests refuse with "no delegation zone configured" until it's fixed
2026/10/25 00:02:42 console: CARLOS_ACME_DELEGATION_ZONE "has a space.example.com" is not a valid domain — delegation off, wildcard-enable requests refuse with "no delegation zone configured" until it's fixed
2026/10/25 00:02:42 console: CARLOS_ACME_DELEGATION_ZONE "*.bad zone" is not a valid domain — delegation off, wildcard-enable requests refuse with "no delegation zone configured" until it's fixed
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:42 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:43 console: instance store provision bab/shop/old: objstore: bucket or IAM user name belongs to another store: carlos-bab-shop-old
2026/10/25 00:02:43 console: finished seed sd_6ev6rx3attfrblsyu7opjboq4m of bab/shop/old.shop.example.com
2026/10/25 00:02:43 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: import bad.shop.example.com: seed "not-a-seed-id": seeds: not a seed id
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:44 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: api instance move bab/titogo/acme.go.tito.io: termination fence of uk-box: hostactors: roster authority refused
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: api instance move bab/titogo/acme.go.tito.io: begin move mv_tp7vyzjxm4ji23bksk7acjpbha: hostops: identity mismatch
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: api instance move bab/titogo/acme.go.tito.io: typed move write refused: hostops: identity mismatch
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:45 console: api instance move bab/titogo/acme.go.tito.io: typed move write refused: hostops: identity mismatch
2026/10/25 00:02:45 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: api instance move bab/titogo/acme.go.tito.io: typed move write refused: hostops: identity mismatch
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 edges: box "se-box" has an edges file under control/edges/ but no status snapshot at all, so no region outside the home is automatically eligible until it reports; said once
2026/10/25 00:02:46 edges: 2 edges file(s) under control/edges/ but no fresh box snapshot matched any of them, so automatic region placement sees the home alone (are edges and status in different buckets? see CARLOS_STATUS_BUCKET/CARLOS_STATUS_PREFIX)
2026/10/25 00:02:46 console: an incomplete read of the edges files or box snapshots (edges complete true, snapshots complete false), so no region outside the home is automatically eligible this request; said once
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:46 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: api instance move bab/titogo/acme.go.tito.io: the claim is moving under mv_74ql7tx22ij56slbbosevxehly but the record write failed: write timeout
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: api instance move bab/titogo/acme.go.tito.io: the claim is moving under mv_wuisaisapaptlict4pi7y3fatu but the record write failed: write timeout
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: api instance move bab/titogo/acme.go.tito.io: the claim is moving under mv_kkgqypddhqmrirnti4dprmvvvm but the record write failed: write timeout
2026/10/25 00:02:47 console: api instance move bab/titogo/acme.go.tito.io: move mv_kkgqypddhqmrirnti4dprmvvvm: record reread: read timeout; the claim is left moving
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: api instances create bab/titogo/acme.go.tito.io: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:47 console: api instances manifest bab/titogo: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:47 console: api instances delete bab/titogo/acme.go.tito.io: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000004
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000004 maxTXID=0000000000000004 size=537
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000004 txid.db=0000000000000004
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000004 txid.db=0000000000000005
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000005 maxTXID=0000000000000005 size=621
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000005 txid.db=0000000000000005
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000005 txid.db=0000000000000006
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000006 maxTXID=0000000000000006 size=704
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000006 txid.db=0000000000000006
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000006 txid.db=0000000000000007
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000007 maxTXID=0000000000000007 size=788
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000007 txid.db=0000000000000007
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000007 txid.db=0000000000000008
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000008 maxTXID=0000000000000008 size=871
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000008 txid.db=0000000000000008
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000008 txid.db=0000000000000009
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000009 maxTXID=0000000000000009 size=955
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000009 txid.db=0000000000000009
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000009 txid.db=000000000000000a
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000a maxTXID=000000000000000a size=1038
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000a txid.db=000000000000000a
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000a txid.db=000000000000000b
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000b maxTXID=000000000000000b size=1124
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000b txid.db=000000000000000b
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000b txid.db=000000000000000c
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000c maxTXID=000000000000000c size=1208
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000c txid.db=000000000000000c
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000c txid.db=000000000000000d
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000d maxTXID=000000000000000d size=1294
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000d txid.db=000000000000000d
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000d txid.db=000000000000000e
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000e maxTXID=000000000000000e size=1387
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000e txid.db=000000000000000e
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000e txid.db=000000000000000f
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000f maxTXID=000000000000000f size=1481
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000f txid.db=000000000000000f
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000f txid.db=0000000000000010
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000010 maxTXID=0000000000000010 size=1569
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000010 txid.db=0000000000000010
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000010 txid.db=0000000000000011
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000011 maxTXID=0000000000000011 size=1661
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000011 txid.db=0000000000000011
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000011 txid.db=0000000000000012
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000012 maxTXID=0000000000000012 size=1755
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000012 txid.db=0000000000000012
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000012 txid.db=0000000000000013
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000013 maxTXID=0000000000000013 size=1843
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000013 txid.db=0000000000000013
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000013 txid.db=0000000000000014
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000014 maxTXID=0000000000000014 size=1935
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000014 txid.db=0000000000000014
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000014 txid.db=0000000000000015
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000015 maxTXID=0000000000000015 size=2031
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000015 txid.db=0000000000000015
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000015 txid.db=0000000000000016
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000016 maxTXID=0000000000000016 size=2119
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000016 txid.db=0000000000000016
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000016 txid.db=0000000000000017
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000017 maxTXID=0000000000000017 size=2216
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000017 txid.db=0000000000000017
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000017 txid.db=0000000000000018
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000018 maxTXID=0000000000000018 size=2309
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000018 txid.db=0000000000000018
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000018 txid.db=0000000000000019
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000019 maxTXID=0000000000000019 size=2403
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000019 txid.db=0000000000000019
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000019 txid.db=000000000000001a
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001a maxTXID=000000000000001a size=2498
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001a txid.db=000000000000001a
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001a txid.db=000000000000001b
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001b maxTXID=000000000000001b size=5397
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001b txid.db=000000000000001b
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001b txid.db=000000000000001c
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001c maxTXID=000000000000001c size=312
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001c txid.db=000000000000001c
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001c txid.db=000000000000001d
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001d maxTXID=000000000000001d size=403
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001d txid.db=000000000000001d
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001d txid.db=000000000000001e
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001e maxTXID=000000000000001e size=495
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001e txid.db=000000000000001e
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000004
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000004 maxTXID=0000000000000004 size=537
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000004 txid.db=0000000000000004
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000004 txid.db=0000000000000005
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000005 maxTXID=0000000000000005 size=621
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000005 txid.db=0000000000000005
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000005 txid.db=0000000000000006
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000006 maxTXID=0000000000000006 size=704
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000006 txid.db=0000000000000006
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000006 txid.db=0000000000000007
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000007 maxTXID=0000000000000007 size=788
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000007 txid.db=0000000000000007
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000007 txid.db=0000000000000008
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000008 maxTXID=0000000000000008 size=871
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000008 txid.db=0000000000000008
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000008 txid.db=0000000000000009
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000009 maxTXID=0000000000000009 size=955
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000009 txid.db=0000000000000009
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000009 txid.db=000000000000000a
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000a maxTXID=000000000000000a size=1038
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000a txid.db=000000000000000a
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000a txid.db=000000000000000b
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000b maxTXID=000000000000000b size=1124
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000b txid.db=000000000000000b
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000b txid.db=000000000000000c
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000c maxTXID=000000000000000c size=1208
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000c txid.db=000000000000000c
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000c txid.db=000000000000000d
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000d maxTXID=000000000000000d size=1294
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000d txid.db=000000000000000d
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000d txid.db=000000000000000e
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000e maxTXID=000000000000000e size=1387
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000e txid.db=000000000000000e
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000e txid.db=000000000000000f
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000000f maxTXID=000000000000000f size=1481
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000f txid.db=000000000000000f
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000000f txid.db=0000000000000010
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000010 maxTXID=0000000000000010 size=1569
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000010 txid.db=0000000000000010
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000010 txid.db=0000000000000011
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000011 maxTXID=0000000000000011 size=1661
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000011 txid.db=0000000000000011
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000011 txid.db=0000000000000012
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000012 maxTXID=0000000000000012 size=1755
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000012 txid.db=0000000000000012
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000012 txid.db=0000000000000013
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000013 maxTXID=0000000000000013 size=1843
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000013 txid.db=0000000000000013
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000013 txid.db=0000000000000014
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000014 maxTXID=0000000000000014 size=1935
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000014 txid.db=0000000000000014
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000014 txid.db=0000000000000015
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000015 maxTXID=0000000000000015 size=2031
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000015 txid.db=0000000000000015
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000015 txid.db=0000000000000016
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000016 maxTXID=0000000000000016 size=2119
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000016 txid.db=0000000000000016
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000016 txid.db=0000000000000017
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000017 maxTXID=0000000000000017 size=2216
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000017 txid.db=0000000000000017
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000017 txid.db=0000000000000018
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000018 maxTXID=0000000000000018 size=2309
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000018 txid.db=0000000000000018
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000018 txid.db=0000000000000019
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000019 maxTXID=0000000000000019 size=2403
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000019 txid.db=0000000000000019
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000019 txid.db=000000000000001a
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001a maxTXID=000000000000001a size=2498
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001a txid.db=000000000000001a
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001a txid.db=000000000000001b
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001b maxTXID=000000000000001b size=5397
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001b txid.db=000000000000001b
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001b txid.db=000000000000001c
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001c maxTXID=000000000000001c size=312
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001c txid.db=000000000000001c
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001c txid.db=000000000000001d
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001d maxTXID=000000000000001d size=403
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001d txid.db=000000000000001d
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001d txid.db=000000000000001e
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=000000000000001e maxTXID=000000000000001e size=495
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=000000000000001e txid.db=000000000000001e
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:47 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:47 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:47 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:47 console: from main.shop.example.com: restore: dbdoor: history before the target is no longer kept
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:48 console: from main.shop.example.com: restore: bucket read failed
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000002
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000002 maxTXID=0000000000000002 size=370
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000002
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000002 txid.db=0000000000000003
2026/10/25 00:02:48 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000003 maxTXID=0000000000000003 size=454
2026/10/25 00:02:48 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000003 txid.db=0000000000000003
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: could not notify paul@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:48 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: relay enabled bab/titogo in eu-west-1 by alice@keymail.dev (incarnation 0ef00f13d956f7d9, op 1)
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: relay enabled bab/titogo in eu-west-1 by alice@keymail.dev (incarnation 00b849bd3b2cdc4b, op 1)
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:49 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: api schedule status bab/titogo: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: api sidecars create bab/titogo/bot: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:50 console: api sidecars manifest bab/titogo: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:50 console: api sidecars list bab/titogo: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:50 console: api sidecars delete bab/titogo/bot: AccessDenied: s3://carlos-prod-secret-bucket/ledgers request id ABC123
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:50 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: could not notify paul@keymail.dev of a CLI token issue: Post "http://127.0.0.1:39493/api/app/send": dial tcp 127.0.0.1:39493: connect: connection refused
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: could not notify alice@keymail.dev of a CLI token issue: Post "http://127.0.0.1:46531/api/app/send": dial tcp 127.0.0.1:46531: connect: connection refused
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: geoip published ed972738 (GeoIP2-City, manual)
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:51 console: api system: list fleets: unable to open database file (14) — reporting the platform's own boxes only
2026/10/25 00:02:51 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: could not notify paul@keymail.dev of a CLI token issue: Post "http://127.0.0.1:37593/api/app/send": dial tcp 127.0.0.1:37593: connect: connection refused
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: app region bab/tmp-ci: (default)
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: could not notify alice@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: app region bab/console: (default)
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: settings mail read bab/kass: AccessDenied: s3://carlos-releases/apps/.../email.json request id XYZ
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: app region bab/person-a0: (default)
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: app region bab/person-a1: (default)
2026/10/25 00:02:54 console: app region bab/person-a2: (default)
2026/10/25 00:02:54 console: app region bab/person-a3: (default)
2026/10/25 00:02:54 console: app region bab/person-a4: (default)
2026/10/25 00:02:54 console: app region bab/person-a5: (default)
2026/10/25 00:02:54 console: app region bab/person-a6: (default)
2026/10/25 00:02:54 console: app region bab/person-a7: (default)
2026/10/25 00:02:54 console: app region bab/person-a8: (default)
2026/10/25 00:02:54 console: app region bab/person-a9: (default)
2026/10/25 00:02:54 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:54 console: app region bab/hub-a-0: (default)
2026/10/25 00:02:54 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:54 console: app region bab/hub-a-1: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-2: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-3: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-4: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-5: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-6: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-7: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-8: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-9: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-10: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-11: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-12: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-13: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-14: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-15: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-16: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-17: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-18: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-19: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-20: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-21: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-22: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-23: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-24: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-25: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-26: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-27: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-28: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-29: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-30: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-31: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-32: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-33: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-34: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-35: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-36: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-37: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-38: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-39: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-40: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-41: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-42: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-43: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-44: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-45: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-46: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-47: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-48: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-49: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-50: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-51: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-52: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-53: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-54: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-55: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-56: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-57: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-58: (default)
2026/10/25 00:02:54 console: app region bab/hub-a-59: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-60: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-61: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-62: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-63: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-64: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-65: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-66: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-67: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-68: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-69: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-70: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-71: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-72: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-73: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-74: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-75: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-76: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-77: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-78: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-79: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-80: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-81: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-82: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-83: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-84: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-85: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-86: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-87: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-88: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-89: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-90: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-91: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-92: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-93: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-94: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-95: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-96: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-97: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-98: (default)
2026/10/25 00:02:55 console: app region bab/hub-a-99: (default)
2026/10/25 00:02:55 console: app region bab/hub-b-fresh: (default)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:55 console: backfilled account manifest for bab (ops)
2026/10/25 00:02:55 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:56 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:56 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:58 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:58 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:59 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:02:59 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
--- FAIL: TestClaimConsoleRouteCensus (0.26s)
claim_routes_test.go:39: new: route GET /api/cli/apps/{account}/{app}/edge-refs/{code}
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: could not notify paul@keymail.dev of a CLI token issue: keymail: grant revoked or invalid
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: control-plane check console in account bab: SQL logic error: no such column: control_plane (1)
2026/10/25 00:03:02 console: control-plane check console in account bab: SQL logic error: no such column: control_plane (1)
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:03:02 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:03:02 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000000 txid.db=0000000000000001
2026/10/25 00:03:02 INFO ltx file uploaded system=store db=source.db replica=file level=0 minTXID=0000000000000001 maxTXID=0000000000000001 size=720
2026/10/25 00:03:02 INFO replica sync system=store db=source.db replica=file txid.replica=0000000000000001 txid.db=0000000000000001
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:02 console: api instances create bab/titogo: read existing record for acme.go.tito.io: get secret-bucket: connection reset
2026/10/25 00:03:03 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:03 console: api sidecars create bab/titogo: read existing record for bot.titogo.bab.sidecar.internal: get secret-bucket: connection reset
2026/10/25 00:03:03 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:03 console: purge preflight bab/kass: release: bab/kass is flagged production — a trashed production app should be impossible; refusing to purge
2026/10/25 00:03:03 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: delivery to x@example.com: keymail lookup unreachable, trying email: keymail: lookup unreachable: Get "http://127.0.0.1:36381/api/federation/lookup?addr=x%40example.com&from=console%40127.0.0.1%3A44171": context deadline exceeded
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: account telemetry bab: dirstore: invalid key "apps/bab//telemetry.json"
2026/10/25 00:03:04 console: account telemetry bab: dirstore: invalid key "apps/bab//telemetry.json"
2026/10/25 00:03:04 console: account telemetry bab: dirstore: invalid key "apps/bab//telemetry.json"
2026/10/25 00:03:04 console: account telemetry bab: dirstore: invalid key "apps/bab//telemetry.json"
2026/10/25 00:03:04 console: account telemetry bab: dirstore: invalid key "apps/bab//telemetry.json"
2026/10/25 00:03:04 console: account telemetry bab: dirstore: invalid key "apps/bab//telemetry.json"
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:04 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: sign-in email to bob@example.com from 127.0.0.1 refused by its limits; not sent
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: sign-in email to bob@example.com from 127.0.0.1 refused by its limits; not sent
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: sign-in email to bob@example.com from 127.0.0.1 refused by its limits; not sent
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: expiry pass: early purge bab/tmp-a: release: purge apps/bab/tmp-a/releases/v1/site.tar.gz: hookStore: delete refused
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: geoip published ed972738 (GeoIP2-City, feed:test-feed)
2026/10/25 00:03:05 console: geoip published b3760190 (GeoIP2-Country, manual)
2026/10/25 00:03:05 console: geoip published b3760190 (GeoIP2-Country, manual)
2026/10/25 00:03:05 console: geoip published ed972738 (GeoIP2-City, manual)
2026/10/25 00:03:05 console: geoip published ed972738 (GeoIP2-City, manual)
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: infra pass: console: infra inventory not granted (disabled for this process): awsinv: every read was denied — this deployment has no inventory grant
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:05 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: promote kass v3 -> stable: promote kass v3 -> stable: stable is entered from beta only, and this build is on edge — use --hotfix to bypass the ladder
2026/10/25 00:03:06 console: backfilled account manifest for bab (ops)
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: backfilled account manifest for bab (ops)
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: materialized account bac (Kass) from the bucket
2026/10/25 00:03:06 console: materialized account bac (Testco) from the bucket
2026/10/25 00:03:06 console: reaped account bac (Testco) — its manifest is tombstoned
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:06 console: moves: acme.go.tito.io: the start of move mv_xv2a4a6hyd7qjh6qpg2dlxf7ui settled not-applied
2026/10/25 00:03:06 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:07 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:08 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:09 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:10 console: api instance move bab/titogo/acme.go.tito.io: declared loss refused: hostresolve: evidence or operation does not authorize resolution
2026/10/25 00:03:10 console: moves: warning: acme.go.tito.io: the log of move mv_cca7re5e2weyy4xi3vbieao3d4 at rolling_back-target-lost has been unwritten for over an hour: unconfirmed: no loss of the move's target has committed, and the move can still be declared lost
2026/10/25 00:03:10 console: moves: acme.go.tito.io: the log of move mv_cca7re5e2weyy4xi3vbieao3d4 at rolling_back-target-lost was never confirmed and the claim no longer holds the instance it was queued for; dropped
2026/10/25 00:03:10 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:12 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:13 console: api instance move bab/titogo/acme.go.tito.io: typed move write: moves: the declared loss cannot be queued in the move log: SQL logic error: no such table: move_log_outbox (1)
2026/10/25 00:03:13 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:14 console: claim request refused: moves: the declared loss cannot be queued in the move log: SQL logic error: no such table: move_log_outbox (1)
2026/10/25 00:03:14 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:14 console: backfilled account manifest for bab (ops)
2026/10/25 00:03:14 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:14 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:14 console: api promote widget abc1234 -> production: promote widget abc1234 -> production: production is entered from beta only, and this build is on edge — use --hotfix to bypass the order
2026/10/25 00:03:14 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:14 console: app region bab/solocan: (default)
2026/10/25 00:03:14 console: backfilled account manifest for bab (ops)
2026/10/25 00:03:14 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
2026/10/25 00:03:15 console: CARLOS_SECRETS_PUBKEY is unset, so no region outside the home can be chosen automatically
FAIL
FAIL github.com/carlosframework/platform/internal/console 41.370s
FAIL
=== internal_console@4 (43 s)
ok github.com/carlosframework/platform/internal/console 41.703s
=== internal_console@5 (42 s)
ok github.com/carlosframework/platform/internal/console 39.957s
=== internal_console@6 (37 s)
ok github.com/carlosframework/platform/internal/console 35.600s
=== internal_console@7 (47 s)
ok github.com/carlosframework/platform/internal/console 45.881s
=== root@0 (109 s)
ok github.com/carlosframework/platform 107.558s
=== root@1 (84 s)
ok github.com/carlosframework/platform 82.950s
=== root@2 (91 s)
ok github.com/carlosframework/platform 89.530s
FAILED: rest internal_console@3
make: *** [Makefile:19: test] Error 1
amadan: step gate failed: exit status 2
amadan: job failed at step gate — its output is above, not at the tail of this log
diff --git a/internal/host/reqrec_e2e_test.go b/internal/host/reqrec_e2e_test.go| index 1c5e04b59..22a015bc5 100644 |
| --- a/internal/host/reqrec_e2e_test.go |
| +++ b/internal/host/reqrec_e2e_test.go |
| @@ -17,13 +17,17 @@ import ( |
| // TestRequestRecordsEndToEnd drives the production wiring end to end: a real |
| // registry and edge, the recorder newRequestRecorder builds against a real |
| // applog.Sink, and reqrecLoop closing the minute. Nothing here is a fixture |
| -// of the recorder's inputs, so a seam that drops a field, a stream or the |
| -// salt shows up as a failed assertion. |
| +// of the recorder's inputs, so a seam that sends records to the wrong stream, |
| +// loses the salt (no client hash) or stores a whole client address shows up |
| +// as a failed assertion. |
| // |
| // The traffic is the shape the feature exists for: one password-reset link |
| // with its secret in the path, then a scanner hammering a missing page. |
| func TestRequestRecordsEndToEnd(t *testing.T) { |
| - const token = "3f9a0c1d2e4b5a6978877665544332211" |
| + const ( |
| + token = "3f9a0c1d2e4b5a6978877665544332211" |
| + clientAddr = "203.0.113.7" |
| + ) |
| backend := httptest.NewServer(http.NotFoundHandler()) |
| t.Cleanup(backend.Close) |
| @@ -54,7 +58,7 @@ func TestRequestRecordsEndToEnd(t *testing.T) { |
| t.Helper() |
| w := httptest.NewRecorder() |
| r := httptest.NewRequest("GET", "http://shop.example.com"+path, nil) |
| - r.RemoteAddr = "203.0.113.7:51234" |
| + r.RemoteAddr = clientAddr + ":4321" |
| e.ServeHTTP(w, r) |
| if w.Code != http.StatusNotFound { |
| t.Fatalf("GET %s = %d, want 404 from the backend", path, w.Code) |
| @@ -98,16 +102,30 @@ func TestRequestRecordsEndToEnd(t *testing.T) { |
| t.Errorf("minute dropped_notfound = %q, want 11", got) |
| } |
| + // Every not-found record carries the salted client hash (12 hex chars, |
| + // which a nil salt would leave out) and the client as a /24, never the |
| + // address itself. |
| + for _, r := range notFound { |
| + if !isHex12(r.Fields["cid"]) { |
| + t.Errorf("cid = %q, want 12 hex characters: %v", r.Fields["cid"], r.Fields) |
| + } |
| + if got := r.Fields["client"]; got != "203.0.113.0/24" { |
| + t.Errorf("client = %q, want 203.0.113.0/24: %v", got, r.Fields) |
| + } |
| + } |
| + |
| // The secret must not appear in any field, key or message. |
| leaks := func(recs []applog.Record, where string) { |
| t.Helper() |
| for _, r := range recs { |
| - if strings.Contains(r.Msg, token) { |
| - t.Errorf("%s: raw token in message %q", where, r.Msg) |
| + if strings.Contains(r.Msg, token) || strings.Contains(r.Msg, clientAddr) { |
| + t.Errorf("%s: token or client address in message %q", where, r.Msg) |
| } |
| for k, v := range r.Fields { |
| - if strings.Contains(k, token) || strings.Contains(v, token) { |
| - t.Errorf("%s: raw token in field %s=%q", where, k, v) |
| + for _, secret := range []string{token, clientAddr} { |
| + if strings.Contains(k, secret) || strings.Contains(v, secret) { |
| + t.Errorf("%s: %q in field %s=%q", where, secret, k, v) |
| + } |
| } |
| } |
| } |
| @@ -131,8 +149,10 @@ func TestRequestRecordsEndToEnd(t *testing.T) { |
| if err != nil { |
| t.Fatalf("EncodeChunk: %v", err) |
| } |
| - if strings.Contains(string(b), token) { |
| - t.Error("raw token in the encoded chunk") |
| + for _, secret := range []string{token, clientAddr} { |
| + if strings.Contains(string(b), secret) { |
| + t.Errorf("%q in the encoded chunk", secret) |
| + } |
| } |
| back, err := applog.DecodeChunk(b) |
| if err != nil { |
| @@ -143,3 +163,16 @@ func TestRequestRecordsEndToEnd(t *testing.T) { |
| } |
| leaks(back, "decoded") |
| } |
| + |
| +// isHex12 reports whether s is exactly 12 lowercase hex characters. |
| +func isHex12(s string) bool { |
| + if len(s) != 12 { |
| + return false |
| + } |
| + for _, c := range s { |
| + if !strings.ContainsRune("0123456789abcdef", c) { |
| + return false |
| + } |
| + } |
| + return true |
| +} |