Add more debugging output on log level info around Schmutz script.

arangod/Cluster/DBServerAgencySync.cpp

@@ -54,6 +54,7 @@ void DBServerAgencySync::work() {
 DBServerAgencySyncResult DBServerAgencySync::execute() {
   // default to system database
 
+  LOG(INFO) << "DBServerAgencySync::execute starting";
   DatabaseFeature* database = 
     ApplicationServer::getFeature<DatabaseFeature>("Database");
 
@@ -61,6 +62,7 @@ DBServerAgencySyncResult DBServerAgencySync::execute() {
 
   DBServerAgencySyncResult result;
   if (vocbase == nullptr) {
+    LOG(INFO) << "DBServerAgencySync::execute no vocbase";
     return result;
   }
   
@@ -73,6 +75,7 @@ DBServerAgencySyncResult DBServerAgencySync::execute() {
   V8Context* context = V8DealerFeature::DEALER->enterContext(vocbase, true);
 
   if (context == nullptr) {
+    LOG(INFO) << "DBServerAgencySync::execute no V8 context";
     return result;
   }
 
@@ -151,6 +154,7 @@ DBServerAgencySyncResult DBServerAgencySync::execute() {
         << "handlePlanChange returned a non-object";
       return result;
     }
+    LOG(INFO) << "DBServerAgencySync::execute back from JS";
     // invalidate our local cache, even if an error occurred
     clusterInfo->flush();
   } catch (...) {

js/server/modules/@arangodb/cluster.js

@@ -1690,6 +1690,7 @@ var handlePlanChange = function (plan, current) {
     current: current.Version
   };
 
+  console.info('handlePlanChange:', plan.Version, current.Version);
   try {
     versions.success = handleChanges(plan, current);
 
@@ -1700,6 +1701,7 @@ var handlePlanChange = function (plan, current) {
     console.error('plan change handling failed');
     versions.success = false;
   }
+  console.info('handlePlanChange: done');
   return versions;
 };