this derivation will be built:
  /nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv
building '/nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv' on 'ssh-ng://nix-remote-build@quine'
building '/nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv'
clave-0.0.0> Running phase: unpackPhase
clave-0.0.0> unpacking source archive /nix/store/nh6wmam985hg9h2v6jfnxxrv0kvb8abk-source
clave-0.0.0> source root is source
clave-0.0.0> Running phase: patchPhase
clave-0.0.0> Running phase: updateAutotoolsGnuConfigScriptsPhase
clave-0.0.0> Running phase: configurePhase
clave-0.0.0> no configure script, doing nothing
clave-0.0.0> Running phase: buildPhase
clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build
clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build
clave-0.0.0> SLF4J(I): Connected with provider of type [org.slf4j.nop.NOPServiceProvider]
clave-0.0.0> Running phase: checkPhase
clave-0.0.0> All source files formatted correctly
clave-0.0.0> linting took 1012ms, errors: 0, warnings: 0
clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build
clave-0.0.0> Picked up JAVA_TOOL_OPTIONS: -Duser.home=/nix/store/v6mpkivxkp6mnp59zh16kr5ys222f5si-clojure-home -Djava.io.tmpdir=/build
clave-0.0.0> [(......)(.........................)(................................................)(...............................)(............)(................)(.........................................)(.........................................................................................................................)(.....................................................................................................................................................................................................................................................................................................................)(.................................)(....)(......................)(...............)(.)(..................................)(..............................................................)(......................................)(..............)(....)(.............................................................)(............................................................................)(..............)(.......)(.......................................................................................)(.................................................)(..............................)(..................................)(..............)(.....)(.......................................................................................................................................................................)(.............................................)(.......)(........................)(........................)][(................)(......)(......)(...........)(..............)(................)(..........)(.........)(.........)(........)(....FFFFF.....E)(...............)(...........)(........)(....)(..........)(........)(........)(....................)(...........................................................)(................)(...........)(...............)(...................)(................)(...................)(......................)(................)(..............................)(..........)(.....)(.....)(....)(..............)(............)(............)(..........)(.......)(.......................)(..............)(......)]
clave-0.0.0> Randomized with --seed 1014508578
clave-0.0.0> 
clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:86)
clave-0.0.0> revoke with remove-from-storage deletes files
clave-0.0.0> expected: (has-event? events :certificate-obtained)
clave-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))
clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????
clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 
clave-0.0.0> ?   data: {:path "/build/clave-test-4044739008456629600"}
clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start
clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ari}
clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ocsp}
clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}
clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}
clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 
clave-0.0.0> ?   data: {:reason :unknown, :message "HTTP request failed"}
clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}
clave-0.0.0> ??????????????????????????????????????????????????????????????????????????
clave-0.0.0> 
clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:91)
clave-0.0.0> revoke with remove-from-storage deletes files
clave-0.0.0> expected: (some? bundle)
clave-0.0.0>   actual: (not (some? nil))
clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????
clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 
clave-0.0.0> ?   data: {:path "/build/clave-test-4044739008456629600"}
clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start
clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ari}
clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ocsp}
clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}
clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}
clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 
clave-0.0.0> ?   data: {:reason :unknown, :message "HTTP request failed"}
clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}
clave-0.0.0> ??????????????????????????????????????????????????????????????????????????
clave-0.0.0> 
clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:92)
clave-0.0.0> revoke with remove-from-storage deletes files
clave-0.0.0> expected: (storage/exists? storage nil cert-path)
clave-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"))
clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????
clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 
clave-0.0.0> ?   data: {:path "/build/clave-test-4044739008456629600"}
clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start
clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ari}
clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ocsp}
clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}
clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}
clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 
clave-0.0.0> ?   data: {:reason :unknown, :message "HTTP request failed"}
clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}
clave-0.0.0> ??????????????????????????????????????????????????????????????????????????
clave-0.0.0> 
clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:93)
clave-0.0.0> revoke with remove-from-storage deletes files
clave-0.0.0> expected: (storage/exists? storage nil key-path)
clave-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"))
clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????
clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 
clave-0.0.0> ?   data: {:path "/build/clave-test-4044739008456629600"}
clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start
clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ari}
clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ocsp}
clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}
clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}
clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 
clave-0.0.0> ?   data: {:reason :unknown, :message "HTTP request failed"}
clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}
clave-0.0.0> ??????????????????????????????????????????????????????????????????????????
clave-0.0.0> 
clave-0.0.0> FAIL in ol.clave.automation.revocation-integration-test/automation-revocation-test (revocation_integration_test.clj:95)
clave-0.0.0> revoke with remove-from-storage deletes files
clave-0.0.0> Expected:
clave-0.0.0>   :success
clave-0.0.0> Actual:
clave-0.0.0>   -:success +:error
clave-0.0.0> ?????? Test output ???????????????????????????????????????????????????????
clave-0.0.0> ? 2026-06-12T09:04:39.003579052Z :debug ol.clave.storage.file [688 8] ::initialized 
clave-0.0.0> ?   data: {:path "/build/clave-test-4044739008456629600"}
clave-0.0.0> ? 2026-06-12T09:04:39.016740324Z :trace ol.clave.automation.impl.system [374 5] ::maintenance-start
clave-0.0.0> ? 2026-06-12T09:04:39.017127566Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017260066Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017316593Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017334036Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:39.017351078Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:39.017362750Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:39.017376486Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:39.017403988Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.020964747Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:39.021128356Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke1.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:39.043623537Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.003743770Z :trace ol.clave.automation.impl.system [645 11] ::acme-obtain-completed 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014495499Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014626166Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke1.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.014655090Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.014735312Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014792881Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014816565Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014842585Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014861681Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014871038Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014885115Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014882440Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.014898019Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ari}
clave-0.0.0> ? 2026-06-12T09:04:44.014901145Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :fetch-ocsp}
clave-0.0.0> ? 2026-06-12T09:04:44.014931994Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ocsp "revoke1.localhost"], :status :error}
clave-0.0.0> ? 2026-06-12T09:04:44.015206913Z :trace ol.clave.automation.impl.system [493 7] ::lookup-cert-cache-hit 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :subjects ["revoke1.localhost"], :managed true, :hash "c9509bf10b2abf8e7e7e6170fa0f3695481c9ceab59d531f532cea0ba5de18b5"}
clave-0.0.0> ? 2026-06-12T09:04:44.022214907Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:fetch-ari "revoke1.localhost"], :status :success}
clave-0.0.0> ? 2026-06-12T09:04:44.024148280Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke1.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:44.225000915Z :trace ol.clave.automation.impl.system [1164 9] ::command-submitting 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225147332Z :trace ol.clave.automation.impl.system [1171 38] ::command-waiting-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225187378Z :trace ol.clave.automation.impl.system [1173 38] ::command-acquired-semaphore 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225200843Z :trace ol.clave.automation.impl.system [1175 40] ::command-executing 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"]}
clave-0.0.0> ? 2026-06-12T09:04:44.225213076Z :trace ol.clave.automation.impl.system [1064 3] ::execute-command 
clave-0.0.0> ?   data: {:command :obtain-certificate}
clave-0.0.0> ? 2026-06-12T09:04:44.225222985Z :trace ol.clave.automation.impl.system [993 3] ::do-with-retry-start
clave-0.0.0> ? 2026-06-12T09:04:44.225233585Z :trace ol.clave.automation.impl.system [1024 13] ::retry-attempt 
clave-0.0.0> ?   data: {:attempt 0}
clave-0.0.0> ? 2026-06-12T09:04:44.225252160Z :trace ol.clave.automation.impl.system [706 5] ::obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237619021Z :trace ol.clave.automation.impl.system [709 5] ::lock-acquired 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:44.237704121Z :trace ol.clave.automation.impl.system [625 3] ::try-obtain-start 
clave-0.0.0> ?   data: {:domain "revoke2.localhost", :issuer "https://localhost:45627/dir"}
clave-0.0.0> ? 2026-06-12T09:04:44.241136227Z :trace ol.clave.automation.impl.system [637 11] ::acme-obtain-starting 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:04:54.226621556Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:04:54.227689935Z :trace ol.clave.automation.impl.system [503 9] ::lookup-cert-miss 
clave-0.0.0> ?   data: {:hostname "revoke2.localhost", :reason :not-in-cache}
clave-0.0.0> ? 2026-06-12T09:06:45.269233611Z :trace ol.clave.automation.impl.system [720 9] ::lock-released 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269361914Z :trace ol.clave.automation.impl.system [722 9] ::obtain-end 
clave-0.0.0> ?   data: {:domain "revoke2.localhost"}
clave-0.0.0> ? 2026-06-12T09:06:45.269388354Z :error ol.clave.automation.impl.system [1039 19] ::non-retryable-error 
clave-0.0.0> ?   data: {:reason :unknown, :message "HTTP request failed"}
clave-0.0.0> ? 2026-06-12T09:06:45.269401689Z :trace ol.clave.automation.impl.system [1177 42] ::command-completed 
clave-0.0.0> ?   data: {:command-key [:obtain-certificate "revoke2.localhost"], :status :error}
clave-0.0.0> ??????????????????????????????????????????????????????????????????????????
clave-0.0.0> 
clave-0.0.0> ERROR in ol.clave.automation.revocation-integration-test/commands-revocation-test (errors.clj:152)
clave-0.0.0> Uncaught exception, not in assertion.
clave-0.0.0> Exception: clojure.lang.ExceptionInfo: Certificate revocation failed
clave-0.0.0> {:url "https://localhost:45627/revoke-cert", :type :ol.clave.errors/revocation-failed}
clave-0.0.0>  at ol.clave.errors$ex.invokeStatic (errors.clj:152)
clave-0.0.0>     ol.clave.errors$ex.invoke (errors.clj:146)
clave-0.0.0>     ol.clave.acme.impl.commands$revoke_certificate.invokeStatic (commands.clj:734)
clave-0.0.0>     ol.clave.acme.impl.commands$revoke_certificate.invoke (commands.clj:691)
clave-0.0.0>     ol.clave.acme.commands$revoke_certificate.invokeStatic (commands.clj:537)
clave-0.0.0>     ol.clave.acme.commands$revoke_certificate.invoke (commands.clj:510)
clave-0.0.0>     ol.clave.automation.revocation_integration_test$fn__22764$fn__22770.invoke (revocation_integration_test.clj:113)
clave-0.0.0>     ol.clave.automation.revocation_integration_test$fn__22764.invokeStatic (revocation_integration_test.clj:110)
clave-0.0.0>     ol.clave.automation.revocation_integration_test/fn (revocation_integration_test.clj:103)
clave-0.0.0>     kaocha.type.var$test_var.invokeStatic (var.clj:24)
clave-0.0.0>     kaocha.type.var$test_var.invoke (var.clj:20)
clave-0.0.0>     kaocha.type.var$eval23691$fn__23693$wrapped_test__23696.invoke (var.clj:36)
clave-0.0.0> (Rest of stacktrace elided)
clave-0.0.0> Caused by: clojure.lang.ExceptionInfo: HTTP request failed
clave-0.0.0> {:attempt 3, :type :ol.clave.errors/server-error}
clave-0.0.0>  at ol.clave.errors$ex.invokeStatic (errors.clj:152)
clave-0.0.0>     ol.clave.errors$ex.invoke (errors.clj:146)
clave-0.0.0>     ol.clave.acme.impl.http$http_req.invokeStatic (http.clj:284)
clave-0.0.0>     ol.clave.acme.impl.http$http_req.invoke (http.clj:255)
clave-0.0.0>     ol.clave.acme.impl.http$http_post_jws$fn__10252.invoke (http.clj:394)
clave-0.0.0>     ol.clave.acme.impl.http$http_post_jws.invokeStatic (http.clj:393)
clave-0.0.0>     ol.clave.acme.impl.http$http_post_jws.invoke (http.clj:358)
clave-0.0.0>     ol.clave.acme.impl.commands$revoke_certificate.invokeStatic (commands.clj:715)
clave-0.0.0>     ol.clave.acme.impl.commands$revoke_certificate.invoke (commands.clj:691)
clave-0.0.0>     ol.clave.acme.commands$revoke_certificate.invokeStatic (commands.clj:537)
clave-0.0.0>     ol.clave.acme.commands$revoke_certificate.invoke (commands.clj:510)
clave-0.0.0>     ol.clave.automation.revocation_integration_test$fn__22764$fn__22770.invoke (revocation_integration_test.clj:113)
clave-0.0.0>     ol.clave.automation.revocation_integration_test$fn__22764.invokeStatic (revocation_integration_test.clj:110)
clave-0.0.0>     ol.clave.automation.revocation_integration_test/fn (revocation_integration_test.clj:103)
clave-0.0.0>     kaocha.type.var$test_var.invokeStatic (var.clj:24)
clave-0.0.0>     kaocha.type.var$test_var.invoke (var.clj:20)
clave-0.0.0>     kaocha.type.var$eval23691$fn__23693$wrapped_test__23696.invoke (var.clj:36)
clave-0.0.0> (Rest of stacktrace elided)
clave-0.0.0> Caused by: java.net.http.HttpTimeoutException: request timed out
clave-0.0.0>  at jdk.internal.net.http.HttpClientImpl.send (HttpClientImpl.java:921)
clave-0.0.0>     jdk.internal.net.http.HttpClientFacade.send (HttpClientFacade.java:133)
clave-0.0.0>     ol.clave.acme.impl.http.impl$request.invokeStatic (impl.clj:340)
clave-0.0.0>     ol.clave.acme.impl.http.impl$request.invoke (impl.clj:301)
clave-0.0.0>     ol.clave.acme.impl.http$do_http_request.invokeStatic (http.clj:233)
clave-0.0.0>     ol.clave.acme.impl.http$do_http_request.invoke (http.clj:219)
clave-0.0.0>     ol.clave.acme.impl.http$http_req.invokeStatic (http.clj:278)
clave-0.0.0>     ol.clave.acme.impl.http$http_req.invoke (http.clj:255)
clave-0.0.0>     ol.clave.acme.impl.http$http_post_jws$fn__10252.invoke (http.clj:394)
clave-0.0.0>     ol.clave.acme.impl.http$http_post_jws.invokeStatic (http.clj:393)
clave-0.0.0>     ol.clave.acme.impl.http$http_post_jws.invoke (http.clj:358)
clave-0.0.0>     ol.clave.acme.impl.commands$revoke_certificate.invokeStatic (commands.clj:715)
clave-0.0.0>     ol.clave.acme.impl.commands$revoke_certificate.invoke (commands.clj:691)
clave-0.0.0>     ol.clave.acme.commands$revoke_certificate.invokeStatic (commands.clj:537)
clave-0.0.0>     ol.clave.acme.commands$revoke_certificate.invoke (commands.clj:510)
clave-0.0.0>     ol.clave.automation.revocation_integration_test$fn__22764$fn__22770.invoke (revocation_integration_test.clj:113)
clave-0.0.0>     ol.clave.automation.revocation_integration_test$fn__22764.invokeStatic (revocation_integration_test.clj:110)
clave-0.0.0>     ol.clave.automation.revocation_integration_test/fn (revocation_integration_test.clj:103)
clave-0.0.0>     kaocha.type.var$test_var.invokeStatic (var.clj:24)
clave-0.0.0>     kaocha.type.var$test_var.invoke (var.clj:20)
clave-0.0.0>     kaocha.type.var$eval23691$fn__23693$wrapped_test__23696.invoke (var.clj:36)
clave-0.0.0> (Rest of stacktrace elided)
clave-0.0.0> 397 tests, 2029 assertions, 1 errors, 5 failures.
clave-0.0.0> 
clave-0.0.0> Top 2 slowest kaocha.type/clojure.test (501.54996 seconds, 100.0% of total time)
clave-0.0.0>   integration
clave-0.0.0>     11.93438 seconds average (489.30957 seconds / 41 tests)
clave-0.0.0>   unit
clave-0.0.0>     0.32212 seconds average (12.24039 seconds / 38 tests)
clave-0.0.0> 
clave-0.0.0> Top 3 slowest kaocha.type/ns (196.88019 seconds, 39.3% of total time)
clave-0.0.0>   ol.clave.automation.revocation-integration-test
clave-0.0.0>     73.69948 seconds average (147.39896 seconds / 2 tests)
clave-0.0.0>   ol.clave.automation.ocsp-integration-test
clave-0.0.0>     6.23184 seconds average (24.92736 seconds / 4 tests)
clave-0.0.0>   ol.clave.automation.private-key-integration-test
clave-0.0.0>     8.18462 seconds average (24.55387 seconds / 3 tests)
clave-0.0.0> 
clave-0.0.0> Top 3 slowest kaocha.type/var (150.37935 seconds, 30.0% of total time)
clave-0.0.0>   ol.clave.automation.revocation-integration-test/commands-revocation-test
clave-0.0.0>     90.51102 seconds ol/clave/automation/revocation_integration_test.clj:103
clave-0.0.0>   ol.clave.automation.revocation-integration-test/automation-revocation-test
clave-0.0.0>     45.22533 seconds ol/clave/automation/revocation_integration_test.clj:61
clave-0.0.0>   ol.clave.automation.ocsp-integration-test/ocsp-revocation-test
clave-0.0.0>     14.64300 seconds ol/clave/automation/ocsp_integration_test.clj:177
clave-0.0.0> 
clave-0.0.0> bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/automation-revocation-test'
clave-0.0.0> bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/commands-revocation-test'
error: 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'.
       Reason: builder failed with exit code 6.
       Output paths:
         /nix/store/s8z4bc39vmmj8n2f7sj9kwwpqba59i4d-clave-0.0.0
       Last 25 log lines:
       >
       > Top 2 slowest kaocha.type/clojure.test (501.54996 seconds, 100.0% of total time)
       >   integration
       >     11.93438 seconds average (489.30957 seconds / 41 tests)
       >   unit
       >     0.32212 seconds average (12.24039 seconds / 38 tests)
       >
       > Top 3 slowest kaocha.type/ns (196.88019 seconds, 39.3% of total time)
       >   ol.clave.automation.revocation-integration-test
       >     73.69948 seconds average (147.39896 seconds / 2 tests)
       >   ol.clave.automation.ocsp-integration-test
       >     6.23184 seconds average (24.92736 seconds / 4 tests)
       >   ol.clave.automation.private-key-integration-test
       >     8.18462 seconds average (24.55387 seconds / 3 tests)
       >
       > Top 3 slowest kaocha.type/var (150.37935 seconds, 30.0% of total time)
       >   ol.clave.automation.revocation-integration-test/commands-revocation-test
       >     90.51102 seconds ol/clave/automation/revocation_integration_test.clj:103
       >   ol.clave.automation.revocation-integration-test/automation-revocation-test
       >     45.22533 seconds ol/clave/automation/revocation_integration_test.clj:61
       >   ol.clave.automation.ocsp-integration-test/ocsp-revocation-test
       >     14.64300 seconds ol/clave/automation/ocsp_integration_test.clj:177
       >
       > bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/automation-revocation-test'
       > bin/kaocha --focus 'ol.clave.automation.revocation-integration-test/commands-revocation-test'
       For full logs, run:
         nix log /nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv
❓ /nix/store/hf78qyr1c9hmn38kqjqsfdbfi5xp455i-clave-0.0.0.drv^* (cancelled)