Listen for test event fails 9/10 tries

I have a workflow that starts with listening for a webhook from a form submission.

I click ‘listen for webhook’, then I replay my webhook action from my form provider and I get a ‘200’ response. Usually this works without issue, but for the last few hours it has been showing the error:
“Workflow execution process did crash for an unknown reason!”

One out of every 10 or so attemps will work fine. Coupled with my ongoing issue not being able to use pinned data, this is becoming a very frustrating issue.

Not sure if related, but my variable selector also doesn’t show any variables.

I am using a self-hosted version of n8n running version 0.190.0

Hi @Greg_Hadley, I am sorry to hear you’re having trouble. Could you check your server logs for any clue as to what might be happening here?

It looks like its saying that the webhook is not registered

Does it say anything else before that? Seems like an odd one. How do you have n8n setup are you using docker, pm2 or something else?

1 Like

It’s using docker. After resetting the server it seems to be working more reliably, and the variables came back. Will report back.

1 Like

Here is what my server logs are giving:

2022-08-16T22:38:03.998410357Z 2022-08-16T22:38:03.989Z | verbose | Started execution of workflow “LevelUp New Accounts” from webhook with execution ID 1148 “{\n executionId: ‘1148’,\n file: ‘WebhookHelpers.js’,\n function: ‘executeWebhook’\n}”
2022-08-16T22:38:04.008150717Z 2022-08-16T22:38:04.004Z | debug | Send data of type “testWebhookReceived” to editor-UI “{\n dataType: ‘testWebhookReceived’,\n sessionId: ‘wd2admdrhm’,\n file: ‘Push.js’,\n function: ‘send’\n}”
2022-08-16T22:38:05.873726343Z 2022-08-16T22:38:05.866Z | debug | Wait tracker querying database for waiting executions “{ file: ‘WaitTracker.js’, function: ‘getwaitingExecutions’ }”
2022-08-16T22:38:09.273887265Z 2022-08-16T22:38:09.116Z | debug | Received child process message of type start for execution ID 1148. “{ executionId: ‘1148’, file: ‘WorkflowRunner.js’ }”
2022-08-16T22:38:09.525060873Z 2022-08-16T22:38:09.481Z | verbose | Initializing n8n sub-process “{\n pid: 52,\n workflowId: ‘4’,\n file: ‘WorkflowRunnerProcess.js’,\n function: ‘runWorkflow’\n}”
2022-08-16T22:39:06.867364792Z 2022-08-16T22:39:06.729Z | debug | Wait tracker querying database for waiting executions “{ file: ‘WaitTracker.js’, function: ‘getwaitingExecutions’ }”
2022-08-16T22:39:06.869213637Z 2022-08-16T22:39:06.775Z | debug | Subprocess for execution ID 1148 finished with error code null. “{ executionId: ‘1148’, file: ‘WorkflowRunner.js’ }”
2022-08-16T22:39:06.869225069Z 2022-08-16T22:39:06.777Z | debug | Executing hook (hookFunctionsSave) “{\n executionId: ‘1148’,\n workflowId: ‘4’,\n file: ‘WorkflowExecuteAdditionalData.js’,\n function: ‘workflowExecuteAfter’\n}”
2022-08-16T22:39:06.869236420Z 2022-08-16T22:39:06.777Z | debug | Save execution data to database for execution ID 1148 “{\n executionId: ‘1148’,\n workflowId: ‘4’,\n finished: false,\n stoppedAt: 2022-08-16T22:39:06.776Z,\n file: ‘WorkflowExecuteAdditionalData.js’,\n function: ‘workflowExecuteAfter’\n}”
2022-08-16T22:39:06.902167376Z 2022-08-16T22:39:06.900Z | debug | Executing hook (hookFunctionsPush) “{\n executionId: ‘1148’,\n sessionId: ‘wd2admdrhm’,\n workflowId: ‘4’,\n file: ‘WorkflowExecuteAdditionalData.js’,\n function: ‘workflowExecuteAfter’\n}”
2022-08-16T22:39:06.869241790Z 2022-08-16T22:39:06.811Z [Rudder] debug: no existing flush timer, creating new one
2022-08-16T22:39:06.902224363Z 2022-08-16T22:39:06.900Z | debug | Save execution progress to database for execution ID 1148 “{\n executionId: ‘1148’,\n workflowId: ‘4’,\n file: ‘WorkflowExecuteAdditionalData.js’,\n function: ‘workflowExecuteAfter’\n}”
2022-08-16T22:39:06.902230945Z 2022-08-16T22:39:06.901Z | debug | Send data of type “executionFinished” to editor-UI “{\n dataType: ‘executionFinished’,\n sessionId: ‘wd2admdrhm’,\n file: ‘Push.js’,\n function: ‘send’\n}”
2022-08-16T22:39:26.820421341Z 2022-08-16T22:39:26.816Z [Rudder] debug: in flush
2022-08-16T22:39:26.820468579Z 2022-08-16T22:39:26.816Z [Rudder] debug: cancelling existing flushTimer…
2022-08-16T22:39:26.820473278Z 2022-08-16T22:39:26.816Z [Rudder] debug: batch size is 1
2022-08-16T22:39:47.282576401Z 2022-08-16T22:39:47.280Z [Rudder] debug: in flush
2022-08-16T22:39:47.282613019Z 2022-08-16T22:39:47.281Z [Rudder] debug: cancelling existing timer…
2022-08-16T22:39:47.282616886Z 2022-08-16T22:39:47.281Z [Rudder] debug: queue is empty, nothing to flush

Are you getting the webhook not registered message again?

Now it seems the error I’m getting is “The session “1sqq74z94cc” is not registred”.

I don’t know what happened, things were working fine the other day. Now I can’t run anything.

Still getting the message " “Workflow execution process did crash for an unknown reason!”", and now my logs aren’t even updating.

Edit: I just duplicated my webhook node to test it on a different string, and all of my connectors were deleted. Very strange behavior…

Edit 2: I upgraded my hosting and immediately it started behaving better lol. Hopefully this was the issue

1 Like

Well that is strange, but it is good news that it has started working again.

With the connectors being deleted that is a bug that we are aware of with 0.191.0 which should be fixed soon.

1 Like