add more logging for sync job

Author: jochenehret

lib/cloud_controller/diego/processes_sync.rb

@@ -21,13 +21,16 @@ def sync
         @bump_freshness = true
         diego_lrps = bbs_apps_client.fetch_scheduling_infos.index_by { |d| d.desired_lrp_key.process_guid }
         logger.info('fetched-scheduling-infos')
+        log_diego_lrps(diego_lrps)
+
         logger.info('waiting 15 seconds...')
         sleep 15
         logger.info('continuing after 15 seconds...')
         to_desire = []
         to_update = {}
         batched_processes_for_sync do |processes|
           processes.each do |process|
+            logger.info('process-sync-candidate', process_guid: process.guid, version_guid: process.version, updated_at: process.updated_at)
             process_guid = ProcessGuid.from_process(process)
             diego_lrp = diego_lrps.delete(process_guid)
 
@@ -39,9 +42,17 @@ def sync
           end
         end
 
+        logger.info('process-sync-action-start', action: 'update_lrps', count: to_update.size)
         update_lrps(to_update)
+        logger.info('process-sync-action-end', action: 'update_lrps', count: to_update.size)
+
+        logger.info('process-sync-action-start', action: 'desire_lrps', count: to_desire.size)
         desire_lrps(to_desire)
+        logger.info('process-sync-action-end', action: 'desire_lrps', count: to_desire.size)
+
+        logger.info('process-sync-action-start', action: 'delete_lrps', count: diego_lrps.size)
         delete_lrps(diego_lrps)
+        logger.info('process-sync-action-end', action: 'delete_lrps', count: diego_lrps.size)
 
         workpool.drain
 
@@ -174,6 +185,21 @@ def bbs_apps_client
         CloudController::DependencyLocator.instance.bbs_apps_client
       end
 
+      def log_diego_lrps(diego_lrps)
+        logger.info('fetched-scheduling-infos-details', count: diego_lrps.size)
+
+        diego_lrps.each do |versioned_process_guid, diego_lrp|
+          logger.info(
+            'fetched-scheduling-info-entry',
+            process_guid: ProcessGuid.cc_process_guid(versioned_process_guid),
+            version_guid: ProcessGuid.cc_process_version(versioned_process_guid),
+            annotation: diego_lrp.annotation,
+            instances: diego_lrp.instances,
+            domain: diego_lrp.desired_lrp_key&.domain
+          )
+        end
+      end
+
       def logger
         @logger ||= Steno.logger('cc.diego.sync.processes')
       end