ICL: Execution time, memory peak usage and separator added to the end of each iteration.

Author: dmitry-ivanov

src/Log/ExceptionHandler.php

@@ -7,6 +7,8 @@
 
 class ExceptionHandler extends Handler
 {
+    private $timeStarted;
+    private $timeFinished;
     protected $reservedMemory;
 
     public function __construct()
@@ -28,13 +30,20 @@ public function report(Exception $e)
 
     private function registerShutdownFunction()
     {
+        $this->timeStarted = microtime(true);
         $this->reservedMemory = str_repeat(' ', 20 * 1024);
 
         register_shutdown_function(function () {
             $this->reservedMemory = null;
 
-            $this->log->info('Execution time: trash.');
-            $this->log->info('Memory peak usage: trash.');
+            $this->timeFinished = microtime(true);
+            $executionTime = round($this->timeFinished - $this->timeStarted, 3);
+            $this->log->info("Execution time: {$executionTime} sec.");
+
+            $memoryPeak = round(memory_get_peak_usage(true) / (1024 * 1024));
+            $this->log->info("Memory peak usage: {$memoryPeak}M.");
+
+            $this->log->info('%separator%');
 
             $handlers = $this->log->getHandlers();
             foreach ($handlers as $handler) {

src/Log/Formatter.php

@@ -13,6 +13,10 @@ public function __construct()
 
     public function format(array $record)
     {
+        if ($record['message'] == '%separator%') {
+            return str_repeat("\n", 11);
+        }
+
         $output = parent::format($record);
         return rtrim($output) . "\n";
     }