Move data col reconstruction log to after reconstruction / save complete (#15475)

* Move data col reconstruction / save log to after they are done

* Rename to reconstructionDuration

* Rename to reconstructionAndSaveDuration

beacon-chain/sync/data_columns_reconstruct.go

@@ -83,6 +83,15 @@ func (s *Service) reconstructSaveBroadcastDataColumnSidecars(
 		return errors.Wrap(err, "save data column sidecars")
 	}
 
+	slotStartTime := slots.StartTime(uint64(s.cfg.clock.GenesisTime().Unix()), slot)
+	log.WithFields(logrus.Fields{
+		"root":                          fmt.Sprintf("%#x", root),
+		"slot":                          slot,
+		"fromColumnsCount":              storedColumnsCount,
+		"sinceSlotStartTime":            time.Since(slotStartTime),
+		"reconstructionAndSaveDuration": time.Since(startTime),
+	}).Debug("Data columns reconstructed and saved")
+
 	// Update reconstruction metrics
 	dataColumnReconstructionHistogram.Observe(float64(time.Since(startTime).Milliseconds()))
 	dataColumnReconstructionCounter.Add(float64(len(reconstructedSidecars) - len(verifiedSidecars)))
@@ -92,12 +101,6 @@ func (s *Service) reconstructSaveBroadcastDataColumnSidecars(
 		return errors.Wrap(err, "schedule reconstructed data columns broadcast")
 	}
 
-	log.WithFields(logrus.Fields{
-		"root":             fmt.Sprintf("%#x", root),
-		"slot":             slot,
-		"fromColumnsCount": storedColumnsCount,
-	}).Debug("Data columns reconstructed and saved")
-
 	return nil
 }
 

changelog/tt_onion.md

@@ -0,0 +1,3 @@
+### Changed
+
+- Move data col reconstruction log to a more accurate place in the code.