Node-RED Won't Start - ERR_INVALID_CALLBACK

This started happening yesterday, I think, but Node-RED won't start up anymore. It will start in safe mode, but I'm not even sure how to trace this error back to a particular node. I haven't added any new nodes in weeks, and the server has been restarted multiple times since then. Any pointers would be greatly appreciated!

Running in docker, FWIW.

Welcome to Node-RED
===================

12 May 16:05:52 - [info] Node-RED version: v3.1.9
12 May 16:05:52 - [info] Node.js  version: v16.20.2
12 May 16:05:52 - [info] Linux 5.15.0-105-generic x64 LE
12 May 16:05:53 - [info] Loading palette nodes
spawnSync locale ENOENT
12 May 16:05:54 - [info] Settings file  : /data/settings.js
12 May 16:05:54 - [info] Context store  : 'default' [module=memory]
12 May 16:05:54 - [info] User directory : /data
12 May 16:05:54 - [warn] Projects disabled : editorTheme.projects.enabled=false
12 May 16:05:54 - [info] Flows file     : /data/flows.json
12 May 16:05:54 - [info] Server now running at http://127.0.0.1:1880/
12 May 16:05:54 - [warn]

---------------------------------------------------------------------
Your flow credentials file is encrypted using a system-generated key.

If the system-generated key is lost for any reason, your credentials
file will not be recoverable, you will have to delete it and re-enter
your credentials.

You should set your own key using the 'credentialSecret' option in
your settings file. Node-RED will then re-encrypt your credentials
file using your chosen key the next time you deploy a change.
---------------------------------------------------------------------

12 May 16:05:54 - [info] Starting flows
12 May 16:05:54 - [info] [hubitat config:d8fb523f.8f557] Starting endpoint for /hubitat/webhook
12 May 16:05:54 - [info] [hubitat config:378eb964.a79576] Starting endpoint for /hubitat/webhook_
12 May 16:05:54 - [info] [hue-bridge:Hue Bridge v2] Initializing the bridge (10.13.13.46)…
12 May 16:05:54 - [error] [mysql:MySQL DB] MySQL database not configured
12 May 16:05:54 - [error] [mysql:Logging DB] MySQL database not configured
12 May 16:05:54 - [info] BooleanLogicUltimate: Will create 2 dummy (false) values
12 May 16:05:54 - [info] Started flows
(node:7) Warning: Accessing non-existent property 'padLevels' of module exports inside circular dependency
(Use `node --trace-warnings ...` to show where the warning was created)
(node:7) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 uncaughtException listeners added to [process]. Use emitter.setMaxListeners() to increase limit
(node:7) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 opened listeners added to [WebSocketListenerNode]. Use emitter.setMaxListeners() to increase limit
(node:7) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 erro listeners added to [WebSocketListenerNode]. Use emitter.setMaxListeners() to increase limit
(node:7) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 closed listeners added to [WebSocketListenerNode]. Use emitter.setMaxListeners() to increase limit
12 May 16:05:54 - [info] [alexa-remote-account:477f784d.7be1a] intialising with the PROXY method and saved data...
12 May 16:05:54 - [info] [hubitat mode:Mode] Initialized. mode: Day
12 May 16:05:54 - [info] [hubitat mode:Current Mode] Initialized. mode: Day
12 May 16:05:54 - [info] [hubitat mode:Mode] Initialized. mode: Day
12 May 16:05:54 - [info] [hubitat device:Input AppleTV] Initialized. switch: off
12 May 16:05:54 - [info] [hue-bridge:Hue Bridge v2] Connected to bridge
12 May 16:05:54 - [red] Uncaught Exception:
12 May 16:05:54 - [error] TypeError [ERR_INVALID_CALLBACK]: Callback must be a function. Received undefined
    at makeCallback (node:fs:190:3)
    at Object.unlink (node:fs:1751:14)
    at compressFile (/data/node_modules/winston/lib/winston/transports/file.js:533:12)
    at createAndFlush (/data/node_modules/winston/lib/winston/transports/file.js:521:7)
    at /data/node_modules/winston/lib/winston/transports/file.js:543:16
    at FSReqCallback.oncomplete (node:fs:202:21)

Hi

If it starts in safe mode, it should be because of some module that is installed that is giving problems.

From the Log file, it seems to be complaining from something called winston. There isn't a module with that name in the library, but a couple of them show up if searching for that therm.

If you have any of them installed, try uninstall or disable the nodes using it in the flows and check if you can start normally.

Thanks! It was that node-red-contrib-advance-logger module.

Odd that it's chugged along fine for this many years and suddenly started causing a problem, though.

This topic was automatically closed 90 days after the last reply. New replies are no longer allowed.