From 596f43d728ce254fb1436dc83b0eeb87865b075a Mon Sep 17 00:00:00 2001
From: Jonathan Cobb <jonathan@kyuss.org>
Date: Sat, 20 Jun 2020 10:36:19 -0400
Subject: [PATCH] log packer image creation duration

---
 .../src/main/java/bubble/service/packer/PackerJob.java        | 4 +++-
 1 file changed, 3 insertions(+), 1 deletion(-)

diff --git a/bubble-server/src/main/java/bubble/service/packer/PackerJob.java b/bubble-server/src/main/java/bubble/service/packer/PackerJob.java
index 745e739d..0c8ca841 100644
--- a/bubble-server/src/main/java/bubble/service/packer/PackerJob.java
+++ b/bubble-server/src/main/java/bubble/service/packer/PackerJob.java
@@ -47,6 +47,7 @@ import static org.cobbzilla.util.network.NetworkUtil.getExternalIp;
 import static org.cobbzilla.util.string.StringUtil.truncate;
 import static org.cobbzilla.util.system.CommandShell.hostname;
 import static org.cobbzilla.util.time.TimeUtil.DATE_FORMAT_YYYYMMDDHHMMSS;
+import static org.cobbzilla.util.time.TimeUtil.formatDuration;
 
 @Slf4j
 public class PackerJob implements Callable<List<PackerImage>> {
@@ -223,6 +224,7 @@ public class PackerJob implements Callable<List<PackerImage>> {
         toFileOrDie(abs(tempDir) + "/packer.json", packerJson);
 
         // run packer, return handle to running packer
+        final long start = now();
         log.info("running packer for " + installType + "...");
         final int packerParallelBuilds = computeDriver.getPackerParallelBuilds();
         final CommandResult commandResult = CommandShell.exec(new Command(new CommandLine(PACKER_BINARY)
@@ -256,7 +258,7 @@ public class PackerJob implements Callable<List<PackerImage>> {
         }
 
         if (imagesRef != null) imagesRef.set(images);
-        log.info("packer images created: "+images);
+        log.info("packer images created in "+formatDuration(now() - start)+": "+images);
         return images;
     }