andorCCD:dataTask:, Data thread is running but main thread thinks we are not acquiring.

[kematusik]

I'm using Andor master branch with PR45, Andor sdk 2.102.30034.0. Somewhat randomly, my detector stops being able to acquire images, and the IOC outputs:

andorCCD:dataTask:, Data thread is running but main thread thinks we are not acquiring.

Usually a restart to the IOC will fix the issue. I need to test for longer, but am currently suspicious that it has to do with using PR45. I reverted back to only the master branch and will see if the issue still arises.

[eddybl]

I also encountered the error message while working on #61

After a while I realised that it does actually not prevent the camera readout from working, neither in single nor continous acquisition modes. In the latter, the message is shown only once at the beginning, so it only happens in the first cycle.

Looking at the code:

// Sanity check that main thread thinks we are acquiring data
    if (mAcquiringData) {
      // Read some parameters
      getIntegerParam(ADShutterMode, &adShutterMode);
      getIntegerParam(AndorReadOutMode, &readOutMode);
      getIntegerParam(NDDataType, &itemp); dataType = (NDDataType_t)itemp;
      getIntegerParam(NDAutoSave, &autoSave);
      getIntegerParam(NDArrayCallbacks, &arrayCallbacks);
      getIntegerParam(NDArraySizeX, &sizeX);
      getIntegerParam(NDArraySizeY, &sizeY);
      // Set acquiring to 1
      acquiring = 1;
    } else {
      asynPrint(this->pasynUserSelf, ASYN_TRACE_ERROR, 
        "%s:%s:, Data thread is running but main thread thinks we are not acquiring.\n", 
        driverName, functionName);
      // Set acquiring to 0
      acquiring = 0;
    }

so somehow at this point mAcquiringData is already 0. I tried to debug it using asynTraceMask() and asynIOTrace(), but if someone could suggest what the best parameter selection would be... this was the stack trace I was able to produce:

2026/02/13 15:33:34.548 asynManager::portThread port=ANDOR callback
2026/02/13 15:33:34.548 asynNDArrayDriver:writeInt32: function=62, paramName=POOL_POLL_STATS, value=0
2026/02/13 15:33:34.548 ADDriver:writeInt32: function=62, paramName=POOL_POLL_STATS, value=0
2026/02/13 15:33:34.548 andorCCD:writeInt32: function=62, value=0
2026/02/13 15:33:34.548 andorCCD:statusTask: Got status event
2026/02/13 15:33:35.170 ANDOR addr -1 queueRequest priority 0 not lockHolder
2026/02/13 15:33:35.170 asynManager::portThread port=ANDOR callback
2026/02/13 15:33:35.171 andorCCD:setupAcquisition:, SetReadMode(4)
2026/02/13 15:33:35.171 andorCCD:setupAcquisition:, SetTriggerMode(0)
2026/02/13 15:33:35.172 andorCCD:setupAcquisition:, SetADChannel(0)
2026/02/13 15:33:35.172 andorCCD:setupAcquisition:, SetOutputAmplifier(0)
2026/02/13 15:33:35.172 andorCCD:setupAcquisition:, SetHSSpeed(0, 0)
2026/02/13 15:33:35.172 andorCCD:setupAcquisition:, SetPreAmpGain(0)
2026/02/13 15:33:35.173 andorCCD:setupAcquisition:, SetImageFlip(0, 0)
2026/02/13 15:33:35.173 andorCCD:setupAcquisition:, SetImage(1,1,1,512,1,1)
2026/02/13 15:33:35.173 andorCCD:setupAcquisition:, SetExposureTime(1.000000)
2026/02/13 15:33:35.173 andorCCD:setupAcquisition:, SetFrameTransferMode(0)
2026/02/13 15:33:35.174 andorCCD:setupAcquisition:, SetAcquisitionMode(AASingle)
2026/02/13 15:33:35.184 andorCCD:setupAcquisition:, GetAcquisitionTimings(exposure=1.000000, accumulate=1.005163, kinetic=1.005163)
2026/02/13 15:33:35.184 andorCCD:writeInt32:, StartAcquisition()
2026/02/13 15:33:35.547 ANDOR addr -1 queueRequest priority 0 not lockHolder
2026/02/13 15:33:36.200 andorCCD:writeInt32:, Sending dataEvent to dataTask ...
2026/02/13 15:33:36.200 andorCCD:writeInt32: function=8, value=1
2026/02/13 15:33:36.200 asynManager::portThread port=ANDOR callback
2026/02/13 15:33:36.200 andorCCD:dataTask:, got data event
2026/02/13 15:33:36.200 asynNDArrayDriver:writeInt32: function=62, paramName=POOL_POLL_STATS, value=0
2026/02/13 15:33:36.200 ADDriver:writeInt32: function=62, paramName=POOL_POLL_STATS, value=0
2026/02/13 15:33:36.200 andorCCD:writeInt32:, Sending dataEvent to dataTask ...
2026/02/13 15:33:36.200 andorCCD:writeInt32: function=62, value=0
2026/02/13 15:33:36.201 andorCCD:dataTask:, GetStatus returned 20072
2026/02/13 15:33:36.201 andorCCD:dataTask:, WaitForAcquisition().
2026/02/13 15:33:36.201 andorCCD:statusTask: Got status event
2026/02/13 15:33:36.547 ANDOR addr -1 queueRequest priority 0 not lockHolder
2026/02/13 15:33:36.547 asynManager::portThread port=ANDOR callback
2026/02/13 15:33:36.547 asynNDArrayDriver:writeInt32: function=62, paramName=POOL_POLL_STATS, value=0
2026/02/13 15:33:36.547 ADDriver:writeInt32: function=62, paramName=POOL_POLL_STATS, value=0
2026/02/13 15:33:36.547 andorCCD:writeInt32:, Sending dataEvent to dataTask ...
2026/02/13 15:33:36.547 andorCCD:statusTask: Got status event
2026/02/13 15:33:36.547 andorCCD:writeInt32: function=62, value=0
2026/02/13 15:33:37.209 andorCCD:dataTask:, WaitForAcquisition has returned.
2026/02/13 15:33:37.210 andorCCD:dataTask:, firstImage=1, lastImage=1
2026/02/13 15:33:37.210 andorCCD:dataTask:, GetNumberNewImages, status=20002, firstImage=1, lastImage=1
2026/02/13 15:33:37.210 andorCCD:dataTask:, GetImages16(1, 1, 0x76fe2c000e80, 512, 0x76fea8640d6c, 0x76fea8640d70)
2026/02/13 15:33:37.210 andorCCD:dataTask:, calling array callbacks
2026/02/13 15:33:37.210 andorCCD:dataTask:, GetStatus returned 20073
2026/02/13 15:33:37.402 andorCCD:dataTask:, got data event
2026/02/13 15:33:37.402 andorCCD:dataTask:, Data thread is running but main thread thinks we are not acquiring.