Debug and improvement of timing

lib/Helpers/Duration.php

@@ -44,17 +44,26 @@ public function stop(string $name)
   }
 
   // get array of all duration times
-  public function timeLen(): array
+  public function timing(): array
   {
     $this->times['run']['duration'] = microtime(true) - $this->times['run']['start'];
 
     $len = [];
     if ($this->times) {
       foreach ($this->times as $name => $frame) {
-        $len[] = $name .':' .round(1000 * $frame['duration']);
+        $len[$name] = $this->msToTime($frame['duration']);
       }
     }
     return $len;
   }
 
+  // Time distance given in a user-friendly form
+  private static function msToTime($delta)
+	{
+		$lo = ($delta > 10)? 1 : (($delta > 1)? 2 : 3);
+		$answer = ($delta > 0.8)? round($delta, $lo) .' s' : 1000*round($delta, 3) .' ms';
+		$info = ($delta > 90)? round($delta/60, 1) .' min' : $answer;
+		return $info;
+	}
+
 }

lib/Log.php

@@ -69,7 +69,7 @@ public static function __callStatic(string $level, array $args)
   public static function close()
   {
     if (self::$logger) {
-      self::$logger->debug('Duration', self::$duration->timeLen());
+      self::$logger->debug('Duration', self::$duration->timing());
       self::$logger->flush();
     }
   }
@@ -93,7 +93,7 @@ public static function done(string $name)
     if ($name == $lastName) {
       self::$duration->stop($name);
     } else {
-      self::$logger->log('warning', "Job $name is interlacing with $lastName which should be ended first using Log::done.");
+      self::$logger->log('warning', "Job $name is interlacing with $lastName which should be ended first using Log::done('$lastName')");
     }
   }
 
@@ -126,9 +126,9 @@ public static function enable(string $name)
   }
 
   // measured time lengths
-  public static function times()
+  public static function timing()
   {
-    self::$duration->timeLen();
+    return self::$duration->timing();
   }
 
   // prevented instantiating