1this derivation will be built:2 /nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv3building '/nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv' on 'ssh-ng://nix-remote-build@quine'4building '/nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv'5clave-0.0.0> Running phase: unpackPhase6clave-0.0.0> unpacking source archive /nix/store/nh6wmam985hg9h2v6jfnxxrv0kvb8abk-source7clave-0.0.0> source root is source8clave-0.0.0> Running phase: patchPhase9clave-0.0.0> Running phase: updateAutotoolsGnuConfigScriptsPhase10clave-0.0.0> Running phase: configurePhase11clave-0.0.0> no configure script, doing nothing12clave-0.0.0> Running phase: buildPhase13clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build14clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build15clave-0.0.0> SLF4J(I): Connected with provider of type [org.slf4j.nop.NOPServiceProvider]16clave-0.0.0> Running phase: checkPhase17clave-0.0.0> All source files formatted correctly18clave-0.0.0> linting took 1012ms, errors: 0, warnings: 019clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build20clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build21clave-0.0.0> [(......)(.........................)(................................................)(...............................)(............)(................)(.........................................)(.........................................................................................................................)(.....................................................................................................................................................................................................................................................................................................................)(.................................)(....)(......................)(...............)(.)(..................................)(..............................................................)(......................................)(..............)(....)(.............................................................)(............................................................................)(..............)(.......)(.......................................................................................)(.................................................)(..............................)(..................................)(..............)(.....)(.......................................................................................................................................................................)(.............................................)(.......)(........................)(........................)][(................)(......)(......)(...........)(..............)(................)(..........)(.........)(.........)(........)(....FFFFF.....E)(...............)(...........)(........)(....)(..........)(........)(........)(....................)(...........................................................)(................)(...........)(...............)(...................)(................)(...................)(......................)(................)(..............................)(..........)(.....)(.....)(....)(..............)(............)(............)(..........)(.......)(.......................)(..............)(......)]22clave-0.0.0> Randomized with --seed 101450857823clave-0.0.0> 24clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:86)25clave-0.0.0> revoke with remove-from-storage deletes files26clave-0.0.0> expected: (has-event? events :certificate-obtained)27clave-0.0.0> actual: (not (has-event? [{:type :domain-added, :timestamp #object[java.time.Instant 0x730b7e7e "2026-06-12T09:04:44.224774578Z"], :data {:domain "revoke2.localhost"}}] :certificate-obtained))28clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????29clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 30clave-0.0.0> ? data: {:path "/build/clave-test-4044739008456629600"}31clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start32clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 33clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}34clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 35clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}36clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 37clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}38clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 39clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}40clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 41clave-0.0.0> ? data: {:command :obtain-certificate}42clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start43clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 44clave-0.0.0> ? data: {:attempt 0}45clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 46clave-0.0.0> ? data: {:domain "revoke1.localhost"}47clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 48clave-0.0.0> ? data: {:domain "revoke1.localhost"}49clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 50clave-0.0.0> ? data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}51clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 52clave-0.0.0> ? data: {:domain "revoke1.localhost"}53clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 54clave-0.0.0> ? data: {:domain "revoke1.localhost"}55clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 56clave-0.0.0> ? data: {:domain "revoke1.localhost"}57clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 58clave-0.0.0> ? data: {:domain "revoke1.localhost"}59clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 60clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}61clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 62clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}63clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 64clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}65clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 66clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}67clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 68clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}69clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 70clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}71clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 72clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}73clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 74clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}75clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 76clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}77clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 78clave-0.0.0> ? data: {:command :fetch-ari}79clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 80clave-0.0.0> ? data: {:command :fetch-ocsp}81clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 82clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}83clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 84clave-0.0.0> ? data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}85clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 86clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}87clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 88clave-0.0.0> ? data: {:hostname "revoke1.localhost", :reason :not-in-cache}89clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 90clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}91clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 92clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}93clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 94clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}95clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 96clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}97clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 98clave-0.0.0> ? data: {:command :obtain-certificate}99clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start100clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 101clave-0.0.0> ? data: {:attempt 0}102clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 103clave-0.0.0> ? data: {:domain "revoke2.localhost"}104clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 105clave-0.0.0> ? data: {:domain "revoke2.localhost"}106clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 107clave-0.0.0> ? data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}108clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 109clave-0.0.0> ? data: {:domain "revoke2.localhost"}110clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 111clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}112clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 113clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}114clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 115clave-0.0.0> ? data: {:domain "revoke2.localhost"}116clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 117clave-0.0.0> ? data: {:domain "revoke2.localhost"}118clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 119clave-0.0.0> ? data: {:reason :unknown, :message "HTTP request failed"}120clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 121clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}122clave-0.0.0> ??????????????????????????????????????????????????????????????????????????123clave-0.0.0> 124clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:91)125clave-0.0.0> revoke with remove-from-storage deletes files126clave-0.0.0> expected: (some? bundle)127clave-0.0.0> actual: (not (some? nil))128clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????129clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 130clave-0.0.0> ? data: {:path "/build/clave-test-4044739008456629600"}131clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start132clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 133clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}134clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 135clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}136clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 137clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}138clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 139clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}140clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 141clave-0.0.0> ? data: {:command :obtain-certificate}142clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start143clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 144clave-0.0.0> ? data: {:attempt 0}145clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 146clave-0.0.0> ? data: {:domain "revoke1.localhost"}147clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 148clave-0.0.0> ? data: {:domain "revoke1.localhost"}149clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 150clave-0.0.0> ? data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}151clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 152clave-0.0.0> ? data: {:domain "revoke1.localhost"}153clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 154clave-0.0.0> ? data: {:domain "revoke1.localhost"}155clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 156clave-0.0.0> ? data: {:domain "revoke1.localhost"}157clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 158clave-0.0.0> ? data: {:domain "revoke1.localhost"}159clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 160clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}161clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 162clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}163clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 164clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}165clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 166clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}167clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 168clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}169clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 170clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}171clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 172clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}173clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 174clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}175clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 176clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}177clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 178clave-0.0.0> ? data: {:command :fetch-ari}179clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 180clave-0.0.0> ? data: {:command :fetch-ocsp}181clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 182clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}183clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 184clave-0.0.0> ? data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}185clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 186clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}187clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 188clave-0.0.0> ? data: {:hostname "revoke1.localhost", :reason :not-in-cache}189clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 190clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}191clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 192clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}193clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 194clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}195clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 196clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}197clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 198clave-0.0.0> ? data: {:command :obtain-certificate}199clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start200clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 201clave-0.0.0> ? data: {:attempt 0}202clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 203clave-0.0.0> ? data: {:domain "revoke2.localhost"}204clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 205clave-0.0.0> ? data: {:domain "revoke2.localhost"}206clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 207clave-0.0.0> ? data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}208clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 209clave-0.0.0> ? data: {:domain "revoke2.localhost"}210clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 211clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}212clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 213clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}214clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 215clave-0.0.0> ? data: {:domain "revoke2.localhost"}216clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 217clave-0.0.0> ? data: {:domain "revoke2.localhost"}218clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 219clave-0.0.0> ? data: {:reason :unknown, :message "HTTP request failed"}220clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 221clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}222clave-0.0.0> ??????????????????????????????????????????????????????????????????????????223clave-0.0.0> 224clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:92)225clave-0.0.0> revoke with remove-from-storage deletes files226clave-0.0.0> expected: (storage/exists? storage nil cert-path)227clave-0.0.0> actual: (not (storage/exists? #ol.clave.storage.file.FileStorage{:root #object[sun.nio.fs.UnixPath 0x7cbeeca7 "/build/clave-test-4044739008456629600"]} nil "certificates//revoke2.localhost/revoke2.localhost.crt"))228clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????229clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 230clave-0.0.0> ? data: {:path "/build/clave-test-4044739008456629600"}231clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start232clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 233clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}234clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 235clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}236clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 237clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}238clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 239clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}240clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 241clave-0.0.0> ? data: {:command :obtain-certificate}242clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start243clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 244clave-0.0.0> ? data: {:attempt 0}245clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 246clave-0.0.0> ? data: {:domain "revoke1.localhost"}247clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 248clave-0.0.0> ? data: {:domain "revoke1.localhost"}249clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 250clave-0.0.0> ? data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}251clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 252clave-0.0.0> ? data: {:domain "revoke1.localhost"}253clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 254clave-0.0.0> ? data: {:domain "revoke1.localhost"}255clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 256clave-0.0.0> ? data: {:domain "revoke1.localhost"}257clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 258clave-0.0.0> ? data: {:domain "revoke1.localhost"}259clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 260clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}261clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 262clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}263clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 264clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}265clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 266clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}267clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 268clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}269clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 270clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}271clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 272clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}273clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 274clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}275clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 276clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}277clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 278clave-0.0.0> ? data: {:command :fetch-ari}279clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 280clave-0.0.0> ? data: {:command :fetch-ocsp}281clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 282clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}283clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 284clave-0.0.0> ? data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}285clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 286clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}287clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 288clave-0.0.0> ? data: {:hostname "revoke1.localhost", :reason :not-in-cache}289clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 290clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}291clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 292clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}293clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 294clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}295clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 296clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}297clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 298clave-0.0.0> ? data: {:command :obtain-certificate}299clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start300clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 301clave-0.0.0> ? data: {:attempt 0}302clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 303clave-0.0.0> ? data: {:domain "revoke2.localhost"}304clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 305clave-0.0.0> ? data: {:domain "revoke2.localhost"}306clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 307clave-0.0.0> ? data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}308clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 309clave-0.0.0> ? data: {:domain "revoke2.localhost"}310clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 311clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}312clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 313clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}314clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 315clave-0.0.0> ? data: {:domain "revoke2.localhost"}316clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 317clave-0.0.0> ? data: {:domain "revoke2.localhost"}318clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 319clave-0.0.0> ? data: {:reason :unknown, :message "HTTP request failed"}320clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 321clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}322clave-0.0.0> ??????????????????????????????????????????????????????????????????????????323clave-0.0.0> 324clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:93)325clave-0.0.0> revoke with remove-from-storage deletes files326clave-0.0.0> expected: (storage/exists? storage nil key-path)327clave-0.0.0> actual: (not (storage/exists? #ol.clave.storage.file.FileStorage{:root #object[sun.nio.fs.UnixPath 0x7cbeeca7 "/build/clave-test-4044739008456629600"]} nil "certificates//revoke2.localhost/revoke2.localhost.key"))328clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????329clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 330clave-0.0.0> ? data: {:path "/build/clave-test-4044739008456629600"}331clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start332clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 333clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}334clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 335clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}336clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 337clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}338clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 339clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}340clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 341clave-0.0.0> ? data: {:command :obtain-certificate}342clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start343clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 344clave-0.0.0> ? data: {:attempt 0}345clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 346clave-0.0.0> ? data: {:domain "revoke1.localhost"}347clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 348clave-0.0.0> ? data: {:domain "revoke1.localhost"}349clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 350clave-0.0.0> ? data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}351clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 352clave-0.0.0> ? data: {:domain "revoke1.localhost"}353clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 354clave-0.0.0> ? data: {:domain "revoke1.localhost"}355clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 356clave-0.0.0> ? data: {:domain "revoke1.localhost"}357clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 358clave-0.0.0> ? data: {:domain "revoke1.localhost"}359clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 360clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}361clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 362clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}363clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 364clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}365clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 366clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}367clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 368clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}369clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 370clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}371clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 372clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}373clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 374clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}375clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 376clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}377clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 378clave-0.0.0> ? data: {:command :fetch-ari}379clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 380clave-0.0.0> ? data: {:command :fetch-ocsp}381clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 382clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}383clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 384clave-0.0.0> ? data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}385clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 386clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}387clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 388clave-0.0.0> ? data: {:hostname "revoke1.localhost", :reason :not-in-cache}389clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 390clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}391clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 392clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}393clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 394clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}395clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 396clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}397clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 398clave-0.0.0> ? data: {:command :obtain-certificate}399clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start400clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 401clave-0.0.0> ? data: {:attempt 0}402clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 403clave-0.0.0> ? data: {:domain "revoke2.localhost"}404clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 405clave-0.0.0> ? data: {:domain "revoke2.localhost"}406clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 407clave-0.0.0> ? data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}408clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 409clave-0.0.0> ? data: {:domain "revoke2.localhost"}410clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 411clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}412clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 413clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}414clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 415clave-0.0.0> ? data: {:domain "revoke2.localhost"}416clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 417clave-0.0.0> ? data: {:domain "revoke2.localhost"}418clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 419clave-0.0.0> ? data: {:reason :unknown, :message "HTTP request failed"}420clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 421clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}422clave-0.0.0> ??????????????????????????????????????????????????????????????????????????423clave-0.0.0> 424clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:95)425clave-0.0.0> revoke with remove-from-storage deletes files426clave-0.0.0> Expected:427clave-0.0.0> :success428clave-0.0.0> Actual:429clave-0.0.0> -:success +:error430clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????431clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 432clave-0.0.0> ? data: {:path "/build/clave-test-4044739008456629600"}433clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start434clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 435clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}436clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 437clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}438clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 439clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}440clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 441clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"]}442clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 443clave-0.0.0> ? data: {:command :obtain-certificate}444clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start445clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 446clave-0.0.0> ? data: {:attempt 0}447clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 448clave-0.0.0> ? data: {:domain "revoke1.localhost"}449clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 450clave-0.0.0> ? data: {:domain "revoke1.localhost"}451clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 452clave-0.0.0> ? data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}453clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 454clave-0.0.0> ? data: {:domain "revoke1.localhost"}455clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 456clave-0.0.0> ? data: {:domain "revoke1.localhost"}457clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 458clave-0.0.0> ? data: {:domain "revoke1.localhost"}459clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 460clave-0.0.0> ? data: {:domain "revoke1.localhost"}461clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 462clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}463clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 464clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}465clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 466clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}467clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 468clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}469clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 470clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}471clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 472clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}473clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 474clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}475clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 476clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"]}477clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 478clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"]}479clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 480clave-0.0.0> ? data: {:command :fetch-ari}481clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 482clave-0.0.0> ? data: {:command :fetch-ocsp}483clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 484clave-0.0.0> ? data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}485clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 486clave-0.0.0> ? data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}487clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 488clave-0.0.0> ? data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}489clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 490clave-0.0.0> ? data: {:hostname "revoke1.localhost", :reason :not-in-cache}491clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 492clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}493clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 494clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}495clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 496clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}497clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 498clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"]}499clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 500clave-0.0.0> ? data: {:command :obtain-certificate}501clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start502clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 503clave-0.0.0> ? data: {:attempt 0}504clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 505clave-0.0.0> ? data: {:domain "revoke2.localhost"}506clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 507clave-0.0.0> ? data: {:domain "revoke2.localhost"}508clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 509clave-0.0.0> ? data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}510clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 511clave-0.0.0> ? data: {:domain "revoke2.localhost"}512clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 513clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}514clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 515clave-0.0.0> ? data: {:hostname "revoke2.localhost", :reason :not-in-cache}516clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 517clave-0.0.0> ? data: {:domain "revoke2.localhost"}518clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 519clave-0.0.0> ? data: {:domain "revoke2.localhost"}520clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 521clave-0.0.0> ? data: {:reason :unknown, :message "HTTP request failed"}522clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 523clave-0.0.0> ? data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}524clave-0.0.0> ??????????????????????????????????????????????????????????????????????????525clave-0.0.0> 526clave-0.0.0> ERROR in ol.clave.automation.revocation-integration-test/commands-revocation-test (errors.clj:152)527clave-0.0.0> Uncaught exception, not in assertion.528clave-0.0.0> Exception: clojure.lang.ExceptionInfo: Certificate revocation failed529clave-0.0.0> {:url "https://localhost:45627/revoke-cert", :type :ol.clave.errors/revocation-failed}530clave-0.0.0> at ol.clave.errors$ex.invokeStatic (errors.clj:152)531clave-0.0.0> ol.clave.errors$ex.invoke (errors.clj:146)532clave-0.0.0> ol.clave.acme.impl.commands$revoke_certificate.invokeStatic (commands.clj:734)533clave-0.0.0> ol.clave.acme.impl.commands$revoke_certificate.invoke (commands.clj:691)534clave-0.0.0> ol.clave.acme.commands$revoke_certificate.invokeStatic (commands.clj:537)535clave-0.0.0> ol.clave.acme.commands$revoke_certificate.invoke (commands.clj:510)536clave-0.0.0> ol.clave.automation.revocation_integration_test$fn__22764$fn__22770.invoke (revocation_integration_test.clj:113)537clave-0.0.0> ol.clave.automation.revocation_integration_test$fn__22764.invokeStatic (revocation_integration_test.clj:110)538clave-0.0.0> ol.clave.automation.revocation_integration_test/fn (revocation_integration_test.clj:103)539clave-0.0.0> kaocha.type.var$test_var.invokeStatic (var.clj:24)540clave-0.0.0> kaocha.type.var$test_var.invoke (var.clj:20)541clave-0.0.0> kaocha.type.var$eval23691$fn__23693$wrapped_test__23696.invoke (var.clj:36)542clave-0.0.0> (Rest of stacktrace elided)543clave-0.0.0> Caused by: clojure.lang.ExceptionInfo: HTTP request failed544clave-0.0.0> {:attempt 3, :type :ol.clave.errors/server-error}545clave-0.0.0> at ol.clave.errors$ex.invokeStatic (errors.clj:152)546clave-0.0.0> ol.clave.errors$ex.invoke (errors.clj:146)547clave-0.0.0> ol.clave.acme.impl.http$http_req.invokeStatic (http.clj:284)548clave-0.0.0> ol.clave.acme.impl.http$http_req.invoke (http.clj:255)549clave-0.0.0> ol.clave.acme.impl.http$http_post_jws$fn__10252.invoke (http.clj:394)550clave-0.0.0> ol.clave.acme.impl.http$http_post_jws.invokeStatic (http.clj:393)551clave-0.0.0> ol.clave.acme.impl.http$http_post_jws.invoke (http.clj:358)552clave-0.0.0> ol.clave.acme.impl.commands$revoke_certificate.invokeStatic (commands.clj:715)553clave-0.0.0> ol.clave.acme.impl.commands$revoke_certificate.invoke (commands.clj:691)554clave-0.0.0> ol.clave.acme.commands$revoke_certificate.invokeStatic (commands.clj:537)555clave-0.0.0> ol.clave.acme.commands$revoke_certificate.invoke (commands.clj:510)556clave-0.0.0> ol.clave.automation.revocation_integration_test$fn__22764$fn__22770.invoke (revocation_integration_test.clj:113)557clave-0.0.0> ol.clave.automation.revocation_integration_test$fn__22764.invokeStatic (revocation_integration_test.clj:110)558clave-0.0.0> ol.clave.automation.revocation_integration_test/fn (revocation_integration_test.clj:103)559clave-0.0.0> kaocha.type.var$test_var.invokeStatic (var.clj:24)560clave-0.0.0> kaocha.type.var$test_var.invoke (var.clj:20)561clave-0.0.0> kaocha.type.var$eval23691$fn__23693$wrapped_test__23696.invoke (var.clj:36)562clave-0.0.0> (Rest of stacktrace elided)563clave-0.0.0> Caused by: java.net.http.HttpTimeoutException: request timed out564clave-0.0.0> at jdk.internal.net.http.HttpClientImpl.send (HttpClientImpl.java:921)565clave-0.0.0> jdk.internal.net.http.HttpClientFacade.send (HttpClientFacade.java:133)566clave-0.0.0> ol.clave.acme.impl.http.impl$request.invokeStatic (impl.clj:340)567clave-0.0.0> ol.clave.acme.impl.http.impl$request.invoke (impl.clj:301)568clave-0.0.0> ol.clave.acme.impl.http$do_http_request.invokeStatic (http.clj:233)569clave-0.0.0> ol.clave.acme.impl.http$do_http_request.invoke (http.clj:219)570clave-0.0.0> ol.clave.acme.impl.http$http_req.invokeStatic (http.clj:278)571clave-0.0.0> ol.clave.acme.impl.http$http_req.invoke (http.clj:255)572clave-0.0.0> ol.clave.acme.impl.http$http_post_jws$fn__10252.invoke (http.clj:394)573clave-0.0.0> ol.clave.acme.impl.http$http_post_jws.invokeStatic (http.clj:393)574clave-0.0.0> ol.clave.acme.impl.http$http_post_jws.invoke (http.clj:358)575clave-0.0.0> ol.clave.acme.impl.commands$revoke_certificate.invokeStatic (commands.clj:715)576clave-0.0.0> ol.clave.acme.impl.commands$revoke_certificate.invoke (commands.clj:691)577clave-0.0.0> ol.clave.acme.commands$revoke_certificate.invokeStatic (commands.clj:537)578clave-0.0.0> ol.clave.acme.commands$revoke_certificate.invoke (commands.clj:510)579clave-0.0.0> ol.clave.automation.revocation_integration_test$fn__22764$fn__22770.invoke (revocation_integration_test.clj:113)580clave-0.0.0> ol.clave.automation.revocation_integration_test$fn__22764.invokeStatic (revocation_integration_test.clj:110)581clave-0.0.0> ol.clave.automation.revocation_integration_test/fn (revocation_integration_test.clj:103)582clave-0.0.0> kaocha.type.var$test_var.invokeStatic (var.clj:24)583clave-0.0.0> kaocha.type.var$test_var.invoke (var.clj:20)584clave-0.0.0> kaocha.type.var$eval23691$fn__23693$wrapped_test__23696.invoke (var.clj:36)585clave-0.0.0> (Rest of stacktrace elided)586clave-0.0.0> 397 tests, 2029 assertions, 1 errors, 5 failures.587clave-0.0.0> 588clave-0.0.0> Top 2 slowest kaocha.type/clojure.test (501.54996 seconds, 100.0% of total time)589clave-0.0.0> integration590clave-0.0.0> 11.93438 seconds average (489.30957 seconds / 41 tests)591clave-0.0.0> unit592clave-0.0.0> 0.32212 seconds average (12.24039 seconds / 38 tests)593clave-0.0.0> 594clave-0.0.0> Top 3 slowest kaocha.type/ns (196.88019 seconds, 39.3% of total time)595clave-0.0.0> ol.clave.automation.revocation-integration-test596clave-0.0.0> 73.69948 seconds average (147.39896 seconds / 2 tests)597clave-0.0.0> ol.clave.automation.ocsp-integration-test598clave-0.0.0> 6.23184 seconds average (24.92736 seconds / 4 tests)599clave-0.0.0> ol.clave.automation.private-key-integration-test600clave-0.0.0> 8.18462 seconds average (24.55387 seconds / 3 tests)601clave-0.0.0> 602clave-0.0.0> Top 3 slowest kaocha.type/var (150.37935 seconds, 30.0% of total time)603clave-0.0.0> ol.clave.automation.revocation-integration-test/commands-revocation-test604clave-0.0.0> 90.51102 seconds ol/clave/automation/revocation_integration_test.clj:103605clave-0.0.0> ol.clave.automation.revocation-integration-test/automation-revocation-test606clave-0.0.0> 45.22533 seconds ol/clave/automation/revocation_integration_test.clj:61607clave-0.0.0> ol.clave.automation.ocsp-integration-test/ocsp-revocation-test608clave-0.0.0> 14.64300 seconds ol/clave/automation/ocsp_integration_test.clj:177609clave-0.0.0> 610clave-0.0.0> bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/automation-revocation-test'611clave-0.0.0> bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/commands-revocation-test'612error: build of '/nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv' on 'ssh-ng://nix-remote-build@quine' failed: Cannot build '/nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv'.613 Reason: builder failed with exit code 6.614 Output paths:615 /nix/store/s8z4bc39vmmj8n2f7sj9kwwpqba59i4d-clave-0.0.0616 Last 25 log lines:617 >618 > Top 2 slowest kaocha.type/clojure.test (501.54996 seconds, 100.0% of total time)619 > integration620 > 11.93438 seconds average (489.30957 seconds / 41 tests)621 > unit622 > 0.32212 seconds average (12.24039 seconds / 38 tests)623 >624 > Top 3 slowest kaocha.type/ns (196.88019 seconds, 39.3% of total time)625 > ol.clave.automation.revocation-integration-test626 > 73.69948 seconds average (147.39896 seconds / 2 tests)627 > ol.clave.automation.ocsp-integration-test628 > 6.23184 seconds average (24.92736 seconds / 4 tests)629 > ol.clave.automation.private-key-integration-test630 > 8.18462 seconds average (24.55387 seconds / 3 tests)631 >632 > Top 3 slowest kaocha.type/var (150.37935 seconds, 30.0% of total time)633 > ol.clave.automation.revocation-integration-test/commands-revocation-test634 > 90.51102 seconds ol/clave/automation/revocation_integration_test.clj:103635 > ol.clave.automation.revocation-integration-test/automation-revocation-test636 > 45.22533 seconds ol/clave/automation/revocation_integration_test.clj:61637 > ol.clave.automation.ocsp-integration-test/ocsp-revocation-test638 > 14.64300 seconds ol/clave/automation/ocsp_integration_test.clj:177639 >640 > bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/automation-revocation-test'641 > bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/commands-revocation-test'642 For full logs, run:643 nix log /nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv644❓ /nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv^* (cancelled)