#3559

Committed 18 Dec 2024 12:59AM UTC coverage: 59.805% (+0.03%) from 59.778%

Build # #3559

Build Type

push

travis-ci

Committed by

web-flow

Commit Message

Merge pull request #29187 from taosdata/merge/mainto3.0

merge: main to 3.0 branch

Run Details

132705 of 287544 branches covered (46.15%)

Branch coverage included in aggregate %.

87 of 95 new or added lines in 19 files covered. (91.58%)

1132 existing lines in 133 files now uncovered.

209591 of 284807 relevant lines covered (73.59%)

8125235.78 hits per line

Source File
Press 'n' to go to next uncovered line, 'b' for previous

79.17

/source/dnode/vnode/src/tq/tqStreamTask.c

/*
 * Copyright (c) 2019 TAOS Data, Inc. <jhtao@taosdata.com>
 *
 * This program is free software: you can use, redistribute, and/or modify
 * it under the terms of the GNU Affero General Public License, version 3
 * or later ("AGPL"), as published by the Free Software Foundation.
 *
 * This program is distributed in the hope that it will be useful, but WITHOUT
 * ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
 * FITNESS FOR A PARTICULAR PURPOSE.
 *
 * You should have received a copy of the GNU Affero General Public License
 * along with this program. If not, see <http://www.gnu.org/licenses/>.
 */

#include "tq.h"
#include "vnd.h"

#define MAX_REPEAT_SCAN_THRESHOLD 3
#define SCAN_WAL_IDLE_DURATION    500    // idle for 500ms to do next wal scan

typedef struct SBuildScanWalMsgParam {
  int64_t metaId;
  int32_t numOfTasks;
} SBuildScanWalMsgParam;

static int32_t doScanWalForAllTasks(SStreamMeta* pStreamMeta);
static int32_t setWalReaderStartOffset(SStreamTask* pTask, int32_t vgId);
static bool    handleFillhistoryScanComplete(SStreamTask* pTask, int64_t ver);
static bool    taskReadyForDataFromWal(SStreamTask* pTask);
static int32_t doPutDataIntoInputQ(SStreamTask* pTask, int64_t maxVer, int32_t* numOfItems, bool* pSucc);
static int32_t tqScanWalInFuture(STQ* pTq, int32_t numOfTasks, int32_t idleDuration);
static int32_t doScanWalAsync(STQ* pTq, bool ckPause);

// extract data blocks(submit/delete) from WAL, and add them into the input queue for all the sources tasks.
int32_t tqScanWal(STQ* pTq) {
  SStreamMeta* pMeta = pTq->pStreamMeta;
  int32_t      vgId = pMeta->vgId;
  int64_t      st = taosGetTimestampMs();
  int32_t      numOfTasks = 0;

  tqDebug("vgId:%d continue to check if data in wal are available, scanCounter:%d", vgId, pMeta->scanInfo.scanCounter);

  // check all tasks
  int32_t code = doScanWalForAllTasks(pMeta);
  if (code) {
    tqError("vgId:%d failed to start all tasks, try next time, code:%s", vgId, tstrerror(code));
    return code;
  }

  streamMetaWLock(pMeta);
  int32_t times = (--pMeta->scanInfo.scanCounter);
  if (times < 0) {
    tqError("vgId:%d invalid scan counter:%d, reset to 0", vgId, times);
    times = 0;
  }

  numOfTasks = taosArrayGetSize(pMeta->pTaskList);
  streamMetaWUnLock(pMeta);

  int64_t el = (taosGetTimestampMs() - st);
  tqDebug("vgId:%d scan wal for stream tasks completed, elapsed time:%" PRId64 " ms", vgId, el);

  if (times > 0) {
    tqDebug("vgId:%d scan wal for stream tasks for %d times in %dms", vgId, times, SCAN_WAL_IDLE_DURATION);
    code = tqScanWalInFuture(pTq, numOfTasks, SCAN_WAL_IDLE_DURATION);
    if (code) {
      tqError("vgId:%d sched scan wal in %dms failed, ignore this failure", vgId, SCAN_WAL_IDLE_DURATION);
    }
  }

  return code;
}

static void doStartScanWal(void* param, void* tmrId) {
  int32_t vgId = 0;
  STQ*    pTq = NULL;
  int32_t code = 0;

  SBuildScanWalMsgParam* pParam = (SBuildScanWalMsgParam*)param;

  SStreamMeta* pMeta = taosAcquireRef(streamMetaRefPool, pParam->metaId);
  if (pMeta == NULL) {
    tqError("metaRid:%" PRId64 " not valid now, stream meta has been freed", pParam->metaId);
    taosMemoryFree(pParam);
    return;
  }

  vgId = pMeta->vgId;
  pTq = pMeta->ahandle;

  tqDebug("vgId:%d create msg to start wal scan, numOfTasks:%d, vnd restored:%d", vgId, pParam->numOfTasks,
          pTq->pVnode->restored);

  code = streamTaskSchedTask(&pTq->pVnode->msgCb, vgId, 0, 0, STREAM_EXEC_T_EXTRACT_WAL_DATA);
  if (code) {
    tqError("vgId:%d failed sched task to scan wal, code:%s", vgId, tstrerror(code));
  }

  code = taosReleaseRef(streamMetaRefPool, pParam->metaId);
  if (code) {
    tqError("vgId:%d failed to release ref for streamMeta, rid:%" PRId64 " code:%s", vgId, pParam->metaId,
            tstrerror(code));
  }

  taosMemoryFree(pParam);
}

int32_t tqScanWalInFuture(STQ* pTq, int32_t numOfTasks, int32_t idleDuration) {
  SStreamMeta*           pMeta = pTq->pStreamMeta;
  int32_t                code = 0;
  int32_t                vgId = TD_VID(pTq->pVnode);
  tmr_h                  pTimer = NULL;
  SBuildScanWalMsgParam* pParam = NULL;

  pParam = taosMemoryMalloc(sizeof(SBuildScanWalMsgParam));
  if (pParam == NULL) {
    return terrno;
  }

  pParam->metaId = pMeta->rid;
  pParam->numOfTasks = numOfTasks;

  code = streamTimerGetInstance(&pTimer);
  if (code) {
    tqError("vgId:%d failed to get tmr ctrl during sched scan wal", vgId);
    taosMemoryFree(pParam);
  } else {
    streamTmrStart(doStartScanWal, idleDuration, pParam, pTimer, &pMeta->scanInfo.scanTimer, vgId, "scan-wal-fut");
  }

  return code;
}

int32_t tqScanWalAsync(STQ* pTq, bool ckPause) {
  SStreamMeta* pMeta = pTq->pStreamMeta;
  bool         alreadyRestored = pTq->pVnode->restored;
  int32_t      code = 0;

  // do not launch the stream tasks, if it is a follower or not restored vnode.
  if (!(vnodeIsRoleLeader(pTq->pVnode) && alreadyRestored)) {
    return TSDB_CODE_SUCCESS;
  }

  streamMetaWLock(pMeta);
  code = doScanWalAsync(pTq, ckPause);
  streamMetaWUnLock(pMeta);
  return code;
}

int32_t tqStopStreamTasksAsync(STQ* pTq) {
  SStreamMeta* pMeta = pTq->pStreamMeta;
  int32_t      vgId = pMeta->vgId;
  return streamTaskSchedTask(&pTq->pVnode->msgCb, vgId, 0, 0, STREAM_EXEC_T_STOP_ALL_TASKS);
}

int32_t setWalReaderStartOffset(SStreamTask* pTask, int32_t vgId) {
  // seek the stored version and extract data from WAL
  int64_t firstVer = walReaderGetValidFirstVer(pTask->exec.pWalReader);
  if (pTask->chkInfo.nextProcessVer < firstVer) {
    tqWarn("vgId:%d s-task:%s ver:%" PRId64 " earlier than the first ver of wal range %" PRId64 ", forward to %" PRId64,
           vgId, pTask->id.idStr, pTask->chkInfo.nextProcessVer, firstVer, firstVer);

    pTask->chkInfo.nextProcessVer = firstVer;

    // todo need retry if failed
    int32_t code = walReaderSeekVer(pTask->exec.pWalReader, pTask->chkInfo.nextProcessVer);
    if (code != TSDB_CODE_SUCCESS) {
      return code;
    }

    // append the data for the stream
    tqDebug("vgId:%d s-task:%s wal reader seek to ver:%" PRId64, vgId, pTask->id.idStr, pTask->chkInfo.nextProcessVer);
  } else {
    int64_t currentVer = walReaderGetCurrentVer(pTask->exec.pWalReader);
    if (currentVer == -1) {  // we only seek the read for the first time
      int32_t code = walReaderSeekVer(pTask->exec.pWalReader, pTask->chkInfo.nextProcessVer);
      if (code != TSDB_CODE_SUCCESS) {  // no data in wal, quit
        return code;
      }

      // append the data for the stream
      tqDebug("vgId:%d s-task:%s wal reader initial seek to ver:%" PRId64, vgId, pTask->id.idStr,
              pTask->chkInfo.nextProcessVer);
    }
  }

  int64_t skipToVer = walReaderGetSkipToVersion(pTask->exec.pWalReader);
  if (skipToVer != 0 && skipToVer > pTask->chkInfo.nextProcessVer) {
    int32_t code = walReaderSeekVer(pTask->exec.pWalReader, skipToVer);
    if (code != TSDB_CODE_SUCCESS) {  // no data in wal, quit
      return code;
    }

    tqDebug("vgId:%d s-task:%s wal reader jump to ver:%" PRId64, vgId, pTask->id.idStr, skipToVer);
  }

  return TSDB_CODE_SUCCESS;
}

// todo handle memory error
bool handleFillhistoryScanComplete(SStreamTask* pTask, int64_t ver) {
  const char* id = pTask->id.idStr;
  int64_t     maxVer = pTask->step2Range.maxVer;

  if ((pTask->info.fillHistory == 1) && ver > maxVer) {
    if (!pTask->status.appendTranstateBlock) {
      qWarn("s-task:%s fill-history scan WAL, nextProcessVer:%" PRId64 " out of the maximum ver:%" PRId64
            ", not scan wal anymore, add transfer-state block into inputQ",
            id, ver, maxVer);

      double el = (taosGetTimestampMs() - pTask->execInfo.step2Start) / 1000.0;
      qDebug("s-task:%s scan-history from WAL stage(step 2) ended, range:%" PRId64 "-%" PRId64 ", elapsed time:%.2fs",
             id, pTask->step2Range.minVer, maxVer, el);
      int32_t code = streamTaskPutTranstateIntoInputQ(pTask);
      if (code) {
        qError("s-task:%s failed to put trans-state into inputQ", id);
      }

      return true;
    } else {
      qWarn("s-task:%s fill-history scan WAL, nextProcessVer:%" PRId64 " out of the ver range:%" PRId64 "-%" PRId64
            ", not scan wal",
            id, ver, pTask->step2Range.minVer, maxVer);
    }
  }

  return false;
}

bool taskReadyForDataFromWal(SStreamTask* pTask) {
  // non-source or fill-history tasks don't need to response the WAL scan action.
  SSTaskBasicInfo* pInfo = &pTask->info;
  if ((pInfo->taskLevel != TASK_LEVEL__SOURCE) || (pTask->status.downstreamReady == 0)) {
    return false;
  }

  if (pInfo->taskLevel == TASK_LEVEL__SOURCE && pInfo->trigger == STREAM_TRIGGER_FORCE_WINDOW_CLOSE) {
    return false;
  }

  // not in ready state, do not handle the data from wal
  SStreamTaskState pState = streamTaskGetStatus(pTask);
  if (pState.state != TASK_STATUS__READY) {
    tqTrace("s-task:%s not ready for submit block in wal, status:%s", pTask->id.idStr, pState.name);
    return false;
  }

  // fill-history task has entered into the last phase, no need to anything
  if ((pInfo->fillHistory == 1) && pTask->status.appendTranstateBlock) {
    // the maximum version of data in the WAL has reached already, the step2 is done
    tqDebug("s-task:%s fill-history reach the maximum ver:%" PRId64 ", not scan wal anymore", pTask->id.idStr,
            pTask->dataRange.range.maxVer);
    return false;
  }

  // check if input queue is full or not
  if (streamQueueIsFull(pTask->inputq.queue)) {
    tqTrace("s-task:%s input queue is full, do nothing", pTask->id.idStr);
    return false;
  }

  // the input queue of downstream task is full, so the output is blocked, stopped for a while
  if (pTask->inputq.status == TASK_INPUT_STATUS__BLOCKED) {
    tqDebug("s-task:%s inputQ is blocked, do nothing", pTask->id.idStr);
    return false;
  }

  return true;
}

int32_t doPutDataIntoInputQ(SStreamTask* pTask, int64_t maxVer, int32_t* numOfItems, bool* pSucc) {
  const char* id = pTask->id.idStr;
  int32_t     numOfNewItems = 0;
  int32_t     code = 0;
  *pSucc = false;

  while (1) {
    if ((pTask->info.fillHistory == 1) && pTask->status.appendTranstateBlock) {
      *numOfItems += numOfNewItems;
      return numOfNewItems > 0;
    }

    SStreamQueueItem* pItem = NULL;
    code = extractMsgFromWal(pTask->exec.pWalReader, (void**)&pItem, maxVer, id);
    if (code != TSDB_CODE_SUCCESS || pItem == NULL) {  // failed, continue
      int64_t currentVer = walReaderGetCurrentVer(pTask->exec.pWalReader);
      bool    itemInFillhistory = handleFillhistoryScanComplete(pTask, currentVer);
      if (itemInFillhistory) {
        numOfNewItems += 1;
      }
      break;
    }

    if (pItem != NULL) {
      code = streamTaskPutDataIntoInputQ(pTask, pItem);
      if (code == TSDB_CODE_SUCCESS) {
        numOfNewItems += 1;
        int64_t ver = walReaderGetCurrentVer(pTask->exec.pWalReader);
        pTask->chkInfo.nextProcessVer = ver;
        tqDebug("s-task:%s set ver:%" PRId64 " for reader after extract data from WAL", id, ver);

        bool itemInFillhistory = handleFillhistoryScanComplete(pTask, ver);
        if (itemInFillhistory) {
          break;
        }
      } else {
        if (code == TSDB_CODE_OUT_OF_MEMORY) {
          tqError("s-task:%s failed to put data into inputQ, since out of memory", id);
        } else {
          tqTrace("s-task:%s append input queue failed, code:inputQ is full, ver:%" PRId64, id,
                  pTask->chkInfo.nextProcessVer);
          code = walReaderSeekVer(pTask->exec.pWalReader, pTask->chkInfo.nextProcessVer);
          if (code) {
            tqError("s-task:%s failed to seek ver to:%" PRId64 " in wal", id, pTask->chkInfo.nextProcessVer);
          }

          code = 0;  // reset the error code
        }

        break;
      }
    }
  }

  *numOfItems += numOfNewItems;
  *pSucc = (numOfNewItems > 0);
  return code;
}

int32_t doScanWalForAllTasks(SStreamMeta* pStreamMeta) {
  int32_t vgId = pStreamMeta->vgId;
  int32_t numOfTasks = taosArrayGetSize(pStreamMeta->pTaskList);
  if (numOfTasks == 0) {
    return TSDB_CODE_SUCCESS;
  }

  // clone the task list, to avoid the task update during scan wal files
  SArray* pTaskList = NULL;
  streamMetaWLock(pStreamMeta);
  pTaskList = taosArrayDup(pStreamMeta->pTaskList, NULL);
  streamMetaWUnLock(pStreamMeta);
  if (pTaskList == NULL) {
    tqError("vgId:%d failed to create task list dup, code:%s", vgId, tstrerror(terrno));
    return terrno;
  }

  tqDebug("vgId:%d start to check wal to extract new submit block for %d tasks", vgId, numOfTasks);

  // update the new task number
  numOfTasks = taosArrayGetSize(pTaskList);

  for (int32_t i = 0; i < numOfTasks; ++i) {
    STaskId* pTaskId = taosArrayGet(pTaskList, i);
    if (pTaskId == NULL) {
      continue;
    }

    SStreamTask* pTask = NULL;
    int32_t      code = streamMetaAcquireTask(pStreamMeta, pTaskId->streamId, pTaskId->taskId, &pTask);
    if (pTask == NULL || code != 0) {
      continue;
    }

    if (!taskReadyForDataFromWal(pTask)) {
      streamMetaReleaseTask(pStreamMeta, pTask);
      continue;
    }

    // seek the stored version and extract data from WAL
    code = setWalReaderStartOffset(pTask, vgId);
    if (code != TSDB_CODE_SUCCESS) {
      streamMetaReleaseTask(pStreamMeta, pTask);
      continue;
    }

    int32_t numOfItems = streamQueueGetNumOfItems(pTask->inputq.queue);
    int64_t maxVer = (pTask->info.fillHistory == 1) ? pTask->step2Range.maxVer : INT64_MAX;

    streamMutexLock(&pTask->lock);

    SStreamTaskState state = streamTaskGetStatus(pTask);
    if (state.state != TASK_STATUS__READY) {
      tqDebug("s-task:%s not ready for submit block from wal, status:%s", pTask->id.idStr, state.name);
      streamMutexUnlock(&pTask->lock);
      streamMetaReleaseTask(pStreamMeta, pTask);
      continue;
    }

    bool hasNewData = false;
    code = doPutDataIntoInputQ(pTask, maxVer, &numOfItems, &hasNewData);
    streamMutexUnlock(&pTask->lock);

    if ((numOfItems > 0) || hasNewData) {
      code = streamTrySchedExec(pTask);
      if (code != TSDB_CODE_SUCCESS) {
        streamMetaReleaseTask(pStreamMeta, pTask);
        taosArrayDestroy(pTaskList);
        return code;
      }
    }

    streamMetaReleaseTask(pStreamMeta, pTask);
  }

  taosArrayDestroy(pTaskList);
  return TSDB_CODE_SUCCESS;
}

int32_t doScanWalAsync(STQ* pTq, bool ckPause) {
  SStreamMeta* pMeta = pTq->pStreamMeta;
  bool         alreadyRestored = pTq->pVnode->restored;
  int32_t      vgId = pMeta->vgId;
  int32_t      numOfTasks = taosArrayGetSize(pMeta->pTaskList);

  if (numOfTasks == 0) {
    tqDebug("vgId:%d no stream tasks existed to run", vgId);
    return 0;
  }

  if (pMeta->startInfo.startAllTasks) {
    tqTrace("vgId:%d in restart procedure, not scan wal", vgId);
    return 0;
  }

  pMeta->scanInfo.scanCounter += 1;
  if (pMeta->scanInfo.scanCounter > MAX_REPEAT_SCAN_THRESHOLD) {
    pMeta->scanInfo.scanCounter = MAX_REPEAT_SCAN_THRESHOLD;
  }

  if (pMeta->scanInfo.scanCounter > 1) {
    tqDebug("vgId:%d wal read task has been launched, remain scan times:%d", vgId, pMeta->scanInfo.scanCounter);
    return 0;
  }

  int32_t numOfPauseTasks = pMeta->numOfPausedTasks;
  if (ckPause && numOfTasks == numOfPauseTasks) {
    tqDebug("vgId:%d ignore all submit, all streams had been paused, reset the walScanCounter", vgId);

    // reset the counter value, since we do not launch the scan wal operation.
    pMeta->scanInfo.scanCounter = 0;
    return 0;
  }

  tqDebug("vgId:%d create msg to start wal scan to launch stream tasks, numOfTasks:%d, vnd restored:%d", vgId,
          numOfTasks, alreadyRestored);

  return streamTaskSchedTask(&pTq->pVnode->msgCb, vgId, 0, 0, STREAM_EXEC_T_EXTRACT_WAL_DATA);
}

1	/*
2	* Copyright (c) 2019 TAOS Data, Inc. <jhtao@taosdata.com>
3	*
4	* This program is free software: you can use, redistribute, and/or modify
5	* it under the terms of the GNU Affero General Public License, version 3
6	* or later ("AGPL"), as published by the Free Software Foundation.
7	*
8	* This program is distributed in the hope that it will be useful, but WITHOUT
9	* ANY WARRANTY; without even the implied warranty of MERCHANTABILITY or
10	* FITNESS FOR A PARTICULAR PURPOSE.
11	*
12	* You should have received a copy of the GNU Affero General Public License
13	* along with this program. If not, see <http://www.gnu.org/licenses/>.
14	*/
15
16	#include "tq.h"
17	#include "vnd.h"
18
19	#define MAX_REPEAT_SCAN_THRESHOLD 3
20	#define SCAN_WAL_IDLE_DURATION 500 // idle for 500ms to do next wal scan
21
22	typedef struct SBuildScanWalMsgParam {
23	int64_t metaId;
24	int32_t numOfTasks;
25	} SBuildScanWalMsgParam;
26
27	static int32_t doScanWalForAllTasks(SStreamMeta* pStreamMeta);
28	static int32_t setWalReaderStartOffset(SStreamTask* pTask, int32_t vgId);
29	static bool handleFillhistoryScanComplete(SStreamTask* pTask, int64_t ver);
30	static bool taskReadyForDataFromWal(SStreamTask* pTask);
31	static int32_t doPutDataIntoInputQ(SStreamTask* pTask, int64_t maxVer, int32_t* numOfItems, bool* pSucc);
32	static int32_t tqScanWalInFuture(STQ* pTq, int32_t numOfTasks, int32_t idleDuration);
33	static int32_t doScanWalAsync(STQ* pTq, bool ckPause);
34
35	// extract data blocks(submit/delete) from WAL, and add them into the input queue for all the sources tasks.
36	int32_t tqScanWal(STQ* pTq) {	52,649✔
37	SStreamMeta* pMeta = pTq->pStreamMeta;	52,649✔
38	int32_t vgId = pMeta->vgId;	52,649✔
39	int64_t st = taosGetTimestampMs();	52,669✔
40	int32_t numOfTasks = 0;	52,669✔
41
42	tqDebug("vgId:%d continue to check if data in wal are available, scanCounter:%d", vgId, pMeta->scanInfo.scanCounter);	52,669✔
43
44	// check all tasks
45	int32_t code = doScanWalForAllTasks(pMeta);	52,669✔
46	if (code) {	52,661!
47	tqError("vgId:%d failed to start all tasks, try next time, code:%s", vgId, tstrerror(code));	×
48	return code;	×
49	}
50
51	streamMetaWLock(pMeta);	52,661✔
52	int32_t times = (--pMeta->scanInfo.scanCounter);	52,669✔
53	if (times < 0) {	52,669!
54	tqError("vgId:%d invalid scan counter:%d, reset to 0", vgId, times);	×
55	times = 0;	×
56	}
57
58	numOfTasks = taosArrayGetSize(pMeta->pTaskList);	52,669✔
59	streamMetaWUnLock(pMeta);	52,661✔
60
61	int64_t el = (taosGetTimestampMs() - st);	52,661✔
62	tqDebug("vgId:%d scan wal for stream tasks completed, elapsed time:%" PRId64 " ms", vgId, el);	52,661✔
63
64	if (times > 0) {	52,661✔
65	tqDebug("vgId:%d scan wal for stream tasks for %d times in %dms", vgId, times, SCAN_WAL_IDLE_DURATION);	22,051✔
66	code = tqScanWalInFuture(pTq, numOfTasks, SCAN_WAL_IDLE_DURATION);	22,051✔
67	if (code) {	22,053!
68	tqError("vgId:%d sched scan wal in %dms failed, ignore this failure", vgId, SCAN_WAL_IDLE_DURATION);	×
69	}
70	}
71
72	return code;	52,664✔
73	}
74
75	static void doStartScanWal(void* param, void* tmrId) {	22,053✔
76	int32_t vgId = 0;	22,053✔
77	STQ* pTq = NULL;	22,053✔
78	int32_t code = 0;	22,053✔
79
80	SBuildScanWalMsgParam* pParam = (SBuildScanWalMsgParam*)param;	22,053✔
81
82	SStreamMeta* pMeta = taosAcquireRef(streamMetaRefPool, pParam->metaId);	22,053✔
83	if (pMeta == NULL) {	22,053✔
84	tqError("metaRid:%" PRId64 " not valid now, stream meta has been freed", pParam->metaId);	204!
85	taosMemoryFree(pParam);	204!
86	return;	204✔
87	}
88
89	vgId = pMeta->vgId;	21,849✔
90	pTq = pMeta->ahandle;	21,849✔
91
92	tqDebug("vgId:%d create msg to start wal scan, numOfTasks:%d, vnd restored:%d", vgId, pParam->numOfTasks,	21,849✔
93	pTq->pVnode->restored);
94
95	code = streamTaskSchedTask(&pTq->pVnode->msgCb, vgId, 0, 0, STREAM_EXEC_T_EXTRACT_WAL_DATA);	21,849✔
96	if (code) {	21,849✔
97	tqError("vgId:%d failed sched task to scan wal, code:%s", vgId, tstrerror(code));	575!
98	}
99
100	code = taosReleaseRef(streamMetaRefPool, pParam->metaId);	21,849✔
101	if (code) {	21,849!
102	tqError("vgId:%d failed to release ref for streamMeta, rid:%" PRId64 " code:%s", vgId, pParam->metaId,	×
103	tstrerror(code));
104	}
105
106	taosMemoryFree(pParam);	21,849!
107	}
108
109	int32_t tqScanWalInFuture(STQ* pTq, int32_t numOfTasks, int32_t idleDuration) {	22,050✔
110	SStreamMeta* pMeta = pTq->pStreamMeta;	22,050✔
111	int32_t code = 0;	22,050✔
112	int32_t vgId = TD_VID(pTq->pVnode);	22,050✔
113	tmr_h pTimer = NULL;	22,050✔
114	SBuildScanWalMsgParam* pParam = NULL;	22,050✔
115
116	pParam = taosMemoryMalloc(sizeof(SBuildScanWalMsgParam));	22,050!
117	if (pParam == NULL) {	22,050!
118	return terrno;	×
119	}
120
121	pParam->metaId = pMeta->rid;	22,050✔
122	pParam->numOfTasks = numOfTasks;	22,050✔
123
124	code = streamTimerGetInstance(&pTimer);	22,050✔
125	if (code) {	22,049!
126	tqError("vgId:%d failed to get tmr ctrl during sched scan wal", vgId);	×
127	taosMemoryFree(pParam);	×
128	} else {
129	streamTmrStart(doStartScanWal, idleDuration, pParam, pTimer, &pMeta->scanInfo.scanTimer, vgId, "scan-wal-fut");	22,049✔
130	}
131
132	return code;	22,053✔
133	}
134
135	int32_t tqScanWalAsync(STQ* pTq, bool ckPause) {	489,716✔
136	SStreamMeta* pMeta = pTq->pStreamMeta;	489,716✔
137	bool alreadyRestored = pTq->pVnode->restored;	489,716✔
138	int32_t code = 0;	489,716✔
139
140	// do not launch the stream tasks, if it is a follower or not restored vnode.
141	if (!(vnodeIsRoleLeader(pTq->pVnode) && alreadyRestored)) {	489,716✔
142	return TSDB_CODE_SUCCESS;	17,176✔
143	}
144
145	streamMetaWLock(pMeta);	472,572✔
146	code = doScanWalAsync(pTq, ckPause);	472,576✔
147	streamMetaWUnLock(pMeta);	472,565✔
148	return code;	472,575✔
149	}
150
151	int32_t tqStopStreamTasksAsync(STQ* pTq) {	3,751✔
152	SStreamMeta* pMeta = pTq->pStreamMeta;	3,751✔
153	int32_t vgId = pMeta->vgId;	3,751✔
154	return streamTaskSchedTask(&pTq->pVnode->msgCb, vgId, 0, 0, STREAM_EXEC_T_STOP_ALL_TASKS);	3,751✔
155	}
156
157	int32_t setWalReaderStartOffset(SStreamTask* pTask, int32_t vgId) {	64,251✔
158	// seek the stored version and extract data from WAL
159	int64_t firstVer = walReaderGetValidFirstVer(pTask->exec.pWalReader);	64,251✔
160	if (pTask->chkInfo.nextProcessVer < firstVer) {	64,265✔
161	tqWarn("vgId:%d s-task:%s ver:%" PRId64 " earlier than the first ver of wal range %" PRId64 ", forward to %" PRId64,	16!
162	vgId, pTask->id.idStr, pTask->chkInfo.nextProcessVer, firstVer, firstVer);
163
164	pTask->chkInfo.nextProcessVer = firstVer;	16✔
165
166	// todo need retry if failed
167	int32_t code = walReaderSeekVer(pTask->exec.pWalReader, pTask->chkInfo.nextProcessVer);	16✔
168	if (code != TSDB_CODE_SUCCESS) {	16!
169	return code;	×
170	}
171
172	// append the data for the stream
173	tqDebug("vgId:%d s-task:%s wal reader seek to ver:%" PRId64, vgId, pTask->id.idStr, pTask->chkInfo.nextProcessVer);	16!
174	} else {
175	int64_t currentVer = walReaderGetCurrentVer(pTask->exec.pWalReader);	64,249✔
176	if (currentVer == -1) { // we only seek the read for the first time	64,239✔
177	int32_t code = walReaderSeekVer(pTask->exec.pWalReader, pTask->chkInfo.nextProcessVer);	4,481✔
178	if (code != TSDB_CODE_SUCCESS) { // no data in wal, quit	4,478!
179	return code;	×
180	}
181
182	// append the data for the stream
183	tqDebug("vgId:%d s-task:%s wal reader initial seek to ver:%" PRId64, vgId, pTask->id.idStr,	4,478✔
184	pTask->chkInfo.nextProcessVer);
185	}
186	}
187
188	int64_t skipToVer = walReaderGetSkipToVersion(pTask->exec.pWalReader);	64,252✔
189	if (skipToVer != 0 && skipToVer > pTask->chkInfo.nextProcessVer) {	64,249✔
190	int32_t code = walReaderSeekVer(pTask->exec.pWalReader, skipToVer);	295✔
191	if (code != TSDB_CODE_SUCCESS) { // no data in wal, quit	295!
192	return code;	×
193	}
194
195	tqDebug("vgId:%d s-task:%s wal reader jump to ver:%" PRId64, vgId, pTask->id.idStr, skipToVer);	295✔
196	}
197
198	return TSDB_CODE_SUCCESS;	64,244✔
199	}
200
201	// todo handle memory error
202	bool handleFillhistoryScanComplete(SStreamTask* pTask, int64_t ver) {	520,702✔
203	const char* id = pTask->id.idStr;	520,702✔
204	int64_t maxVer = pTask->step2Range.maxVer;	520,702✔
205
206	if ((pTask->info.fillHistory == 1) && ver > maxVer) {	520,702✔
207	if (!pTask->status.appendTranstateBlock) {	744!
208	qWarn("s-task:%s fill-history scan WAL, nextProcessVer:%" PRId64 " out of the maximum ver:%" PRId64	744!
209	", not scan wal anymore, add transfer-state block into inputQ",
210	id, ver, maxVer);
211
212	double el = (taosGetTimestampMs() - pTask->execInfo.step2Start) / 1000.0;	744✔
213	qDebug("s-task:%s scan-history from WAL stage(step 2) ended, range:%" PRId64 "-%" PRId64 ", elapsed time:%.2fs",	744✔
214	id, pTask->step2Range.minVer, maxVer, el);
215	int32_t code = streamTaskPutTranstateIntoInputQ(pTask);	744✔
216	if (code) {	744!
217	qError("s-task:%s failed to put trans-state into inputQ", id);	×
218	}
219
220	return true;	744✔
221	} else {
222	qWarn("s-task:%s fill-history scan WAL, nextProcessVer:%" PRId64 " out of the ver range:%" PRId64 "-%" PRId64	×
223	", not scan wal",
224	id, ver, pTask->step2Range.minVer, maxVer);
225	}
226	}
227
228	return false;	519,953✔
229	}
230
231	bool taskReadyForDataFromWal(SStreamTask* pTask) {	214,999✔
232	// non-source or fill-history tasks don't need to response the WAL scan action.
233	SSTaskBasicInfo* pInfo = &pTask->info;	214,999✔
234	if ((pInfo->taskLevel != TASK_LEVEL__SOURCE) \|\| (pTask->status.downstreamReady == 0)) {	214,999✔
235	return false;	112,958✔
236	}
237
238	if (pInfo->taskLevel == TASK_LEVEL__SOURCE && pInfo->trigger == STREAM_TRIGGER_FORCE_WINDOW_CLOSE) {	102,041✔
239	return false;	5,688✔
240	}
241
242	// not in ready state, do not handle the data from wal
243	SStreamTaskState pState = streamTaskGetStatus(pTask);	96,353✔
244	if (pState.state != TASK_STATUS__READY) {	96,333✔
245	tqTrace("s-task:%s not ready for submit block in wal, status:%s", pTask->id.idStr, pState.name);	26,547✔
246	return false;	26,547✔
247	}
248
249	// fill-history task has entered into the last phase, no need to anything
250	if ((pInfo->fillHistory == 1) && pTask->status.appendTranstateBlock) {	69,786✔
251	// the maximum version of data in the WAL has reached already, the step2 is done
252	tqDebug("s-task:%s fill-history reach the maximum ver:%" PRId64 ", not scan wal anymore", pTask->id.idStr,	5,535✔
253	pTask->dataRange.range.maxVer);
254	return false;	5,535✔
255	}
256
257	// check if input queue is full or not
258	if (streamQueueIsFull(pTask->inputq.queue)) {	64,251✔
259	tqTrace("s-task:%s input queue is full, do nothing", pTask->id.idStr);	16!
260	return false;	6✔
261	}
262
263	// the input queue of downstream task is full, so the output is blocked, stopped for a while
264	if (pTask->inputq.status == TASK_INPUT_STATUS__BLOCKED) {	64,260!
265	tqDebug("s-task:%s inputQ is blocked, do nothing", pTask->id.idStr);	×
266	return false;	×
267	}
268
269	return true;	64,260✔
270	}
271
272	int32_t doPutDataIntoInputQ(SStreamTask* pTask, int64_t maxVer, int32_t* numOfItems, bool* pSucc) {	64,248✔
273	const char* id = pTask->id.idStr;	64,248✔
274	int32_t numOfNewItems = 0;	64,248✔
275	int32_t code = 0;	64,248✔
276	*pSucc = false;	64,248✔
277
278	while (1) {	456,462✔
279	if ((pTask->info.fillHistory == 1) && pTask->status.appendTranstateBlock) {	520,710!
280	*numOfItems += numOfNewItems;	×
281	return numOfNewItems > 0;	×
282	}
283
284	SStreamQueueItem* pItem = NULL;	520,710✔
285	code = extractMsgFromWal(pTask->exec.pWalReader, (void**)&pItem, maxVer, id);	520,710✔
286	if (code != TSDB_CODE_SUCCESS \|\| pItem == NULL) { // failed, continue	520,709✔
287	int64_t currentVer = walReaderGetCurrentVer(pTask->exec.pWalReader);	64,082✔
288	bool itemInFillhistory = handleFillhistoryScanComplete(pTask, currentVer);	64,091✔
289	if (itemInFillhistory) {	64,088✔
290	numOfNewItems += 1;	595✔
291	}
292	break;	64,088✔
293	}
294
295	if (pItem != NULL) {	456,627!
296	code = streamTaskPutDataIntoInputQ(pTask, pItem);	456,630✔
297	if (code == TSDB_CODE_SUCCESS) {	456,635✔
298	numOfNewItems += 1;	456,628✔
299	int64_t ver = walReaderGetCurrentVer(pTask->exec.pWalReader);	456,628✔
300	pTask->chkInfo.nextProcessVer = ver;	456,624✔
301	tqDebug("s-task:%s set ver:%" PRId64 " for reader after extract data from WAL", id, ver);	456,624✔
302
303	bool itemInFillhistory = handleFillhistoryScanComplete(pTask, ver);	456,624✔
304	if (itemInFillhistory) {	456,614✔
305	break;	149✔
306	}
307	} else {
308	if (code == TSDB_CODE_OUT_OF_MEMORY) {	7!
309	tqError("s-task:%s failed to put data into inputQ, since out of memory", id);	×
310	} else {
311	tqTrace("s-task:%s append input queue failed, code:inputQ is full, ver:%" PRId64, id,	7!
312	pTask->chkInfo.nextProcessVer);
313	code = walReaderSeekVer(pTask->exec.pWalReader, pTask->chkInfo.nextProcessVer);	7✔
314	if (code) {	7!
315	tqError("s-task:%s failed to seek ver to:%" PRId64 " in wal", id, pTask->chkInfo.nextProcessVer);	×
316	}
317
318	code = 0; // reset the error code	7✔
319	}
320
321	break;	7✔
322	}
323	}
324	}
325
326	*numOfItems += numOfNewItems;	64,244✔
327	*pSucc = (numOfNewItems > 0);	64,244✔
328	return code;	64,244✔
329	}
330
331	int32_t doScanWalForAllTasks(SStreamMeta* pStreamMeta) {	52,659✔
332	int32_t vgId = pStreamMeta->vgId;	52,659✔
333	int32_t numOfTasks = taosArrayGetSize(pStreamMeta->pTaskList);	52,659✔
334	if (numOfTasks == 0) {	52,668✔
335	return TSDB_CODE_SUCCESS;	598✔
336	}
337
338	// clone the task list, to avoid the task update during scan wal files
339	SArray* pTaskList = NULL;	52,070✔
340	streamMetaWLock(pStreamMeta);	52,070✔
341	pTaskList = taosArrayDup(pStreamMeta->pTaskList, NULL);	52,066✔
342	streamMetaWUnLock(pStreamMeta);	52,069✔
343	if (pTaskList == NULL) {	52,061!
344	tqError("vgId:%d failed to create task list dup, code:%s", vgId, tstrerror(terrno));	×
345	return terrno;	×
346	}
347
348	tqDebug("vgId:%d start to check wal to extract new submit block for %d tasks", vgId, numOfTasks);	52,061✔
349
350	// update the new task number
351	numOfTasks = taosArrayGetSize(pTaskList);	52,061✔
352
353	for (int32_t i = 0; i < numOfTasks; ++i) {	267,597✔
354	STaskId* pTaskId = taosArrayGet(pTaskList, i);	215,531✔
355	if (pTaskId == NULL) {	215,516!
356	continue;	151,280✔
357	}
358
359	SStreamTask* pTask = NULL;	215,516✔
360	int32_t code = streamMetaAcquireTask(pStreamMeta, pTaskId->streamId, pTaskId->taskId, &pTask);	215,516✔
361	if (pTask == NULL \|\| code != 0) {	215,523!
362	continue;	497✔
363	}
364
365	if (!taskReadyForDataFromWal(pTask)) {	215,026✔
366	streamMetaReleaseTask(pStreamMeta, pTask);	150,725✔
367	continue;	150,787✔
368	}
369
370	// seek the stored version and extract data from WAL
371	code = setWalReaderStartOffset(pTask, vgId);	64,244✔
372	if (code != TSDB_CODE_SUCCESS) {	64,243!
373	streamMetaReleaseTask(pStreamMeta, pTask);	×
374	continue;	×
375	}
376
377	int32_t numOfItems = streamQueueGetNumOfItems(pTask->inputq.queue);	64,243✔
378	int64_t maxVer = (pTask->info.fillHistory == 1) ? pTask->step2Range.maxVer : INT64_MAX;	64,263✔
379
380	streamMutexLock(&pTask->lock);	64,263✔
381
382	SStreamTaskState state = streamTaskGetStatus(pTask);	64,263✔
383	if (state.state != TASK_STATUS__READY) {	64,257✔
384	tqDebug("s-task:%s not ready for submit block from wal, status:%s", pTask->id.idStr, state.name);	9✔
385	streamMutexUnlock(&pTask->lock);	9✔
386	streamMetaReleaseTask(pStreamMeta, pTask);	9✔
UNCOV 387	continue;	×
388	}
389
390	bool hasNewData = false;	64,248✔
391	code = doPutDataIntoInputQ(pTask, maxVer, &numOfItems, &hasNewData);	64,248✔
392	streamMutexUnlock(&pTask->lock);	64,243✔
393
394	if ((numOfItems > 0) \|\| hasNewData) {	64,259!
395	code = streamTrySchedExec(pTask);	25,038✔
396	if (code != TSDB_CODE_SUCCESS) {	25,036!
397	streamMetaReleaseTask(pStreamMeta, pTask);	×
398	taosArrayDestroy(pTaskList);	×
399	return code;	×
400	}
401	}
402
403	streamMetaReleaseTask(pStreamMeta, pTask);	64,257✔
404	}
405
406	taosArrayDestroy(pTaskList);	52,066✔
407	return TSDB_CODE_SUCCESS;	52,067✔
408	}
409
410	int32_t doScanWalAsync(STQ* pTq, bool ckPause) {	472,556✔
411	SStreamMeta* pMeta = pTq->pStreamMeta;	472,556✔
412	bool alreadyRestored = pTq->pVnode->restored;	472,556✔
413	int32_t vgId = pMeta->vgId;	472,556✔
414	int32_t numOfTasks = taosArrayGetSize(pMeta->pTaskList);	472,556✔
415
416	if (numOfTasks == 0) {	472,559✔
417	tqDebug("vgId:%d no stream tasks existed to run", vgId);	6!
418	return 0;	13✔
419	}
420
421	if (pMeta->startInfo.startAllTasks) {	472,553✔
422	tqTrace("vgId:%d in restart procedure, not scan wal", vgId);	12,062✔
423	return 0;	12,062✔
424	}
425
426	pMeta->scanInfo.scanCounter += 1;	460,491✔
427	if (pMeta->scanInfo.scanCounter > MAX_REPEAT_SCAN_THRESHOLD) {	460,491✔
428	pMeta->scanInfo.scanCounter = MAX_REPEAT_SCAN_THRESHOLD;	405,532✔
429	}
430
431	if (pMeta->scanInfo.scanCounter > 1) {	460,491✔
432	tqDebug("vgId:%d wal read task has been launched, remain scan times:%d", vgId, pMeta->scanInfo.scanCounter);	428,563✔
433	return 0;	428,563✔
434	}
435
436	int32_t numOfPauseTasks = pMeta->numOfPausedTasks;	31,928✔
437	if (ckPause && numOfTasks == numOfPauseTasks) {	31,928✔
438	tqDebug("vgId:%d ignore all submit, all streams had been paused, reset the walScanCounter", vgId);	118✔
439
440	// reset the counter value, since we do not launch the scan wal operation.
441	pMeta->scanInfo.scanCounter = 0;	118✔
442	return 0;	118✔
443	}
444
445	tqDebug("vgId:%d create msg to start wal scan to launch stream tasks, numOfTasks:%d, vnd restored:%d", vgId,	31,810✔
446	numOfTasks, alreadyRestored);
447
448	return streamTaskSchedTask(&pTq->pVnode->msgCb, vgId, 0, 0, STREAM_EXEC_T_EXTRACT_WAL_DATA);	31,815✔
449	}

taosdata / TDengine / #3559

Source File Press 'n' to go to next uncovered line, 'b' for previous

Source File
Press 'n' to go to next uncovered line, 'b' for previous