SMTP setup error - "Greeting never recieved"

omega

Trying to use custom service SMTP, pulled this from the log.

2019-05-21T15:39:17.662Z [4567/11350] - error: Greeting never received {"code":"ETIMEDOUT","command":"CONN"}

(Enabled) Use an External Email Server to send emails.

Credentials are correct but I'll triple check - assuming all is correct, what might be the potential problem to look out for?

nBB 1.12.2

scottalanmiller

@omega said in SMTP setup error - "Greeting never recieved":

error: Greeting never received {"code":"ETIMEDOUT","command":"CONN"}

Are you, perhaps, trying to use this with Gmail?

omega

@scottalanmiller

No not G.

An email service provider similar to protonmail but not protonmail and also a paid for service too, full imap and smtp.

scottalanmiller

@omega said in SMTP setup error - "Greeting never recieved":

@scottalanmiller

No not G.

An email service provider similar to protonmail but not protonmail and also a paid for service too, full imap and smtp.

Hmmm... could be similar maybe. I know that people "often" see this issue when using GMail because of a requirement for more security than is standard.

If doing standard SMTP, it would not normally matter. But it could be the same sort of thing.

scottalanmiller

@omega said in SMTP setup error - "Greeting never recieved":

error: Greeting never received {"code":"ETIMEDOUT","command":"CONN"}

XOAuth2 is sometimes the answer. But generally just with Gmail.

https://masashi-k.blogspot.com/2013/06/sending-mail-with-gmail-using-xoauth2.html

julian

We just hook into the nodemailer library to enable SMTP send, and I'm thinking it's likely a configuration issue. However we don't have access to any mail servers like this... Any chance you can set us up with an email address to test this, temporarily?

Feel free to contact me at [email protected] with the authentication details.

omega

@julian said in SMTP setup error - "Greeting never recieved":

We just hook into the nodemailer library to enable SMTP send, and I'm thinking it's likely a configuration issue. However we don't have access to any mail servers like this... Any chance you can set us up with an email address to test this, temporarily?

Feel free to contact me at [email protected] with the authentication details.

Thanks for the offer

Presently I can't grant access, but I might setup test credentials / SMTP for such testing and you can run that if I'm still hitting the wall, but what I've done now is connected with the email/SMTP provider to see if there are any known issues that can advise on.

@julian Finally, it could very well be a very vanilla configuration issue in terms of credentials. I will again run through that setup, is this what you meant by "configuration issue" ?

omega

Also for the record I ran a ./nodebb dev and this was the outpu, I'll post it here if by chance someone might turn up something - this is not the entire output, it was too long to post but I think this is the last spinup, it seemed to run 3/4 times.

[cluster] Spinning up another process...
2019-05-21T15:47:42.097Z [4567/15532] - verbose: * using configuration stored in: /home/nodex/nodebb/config.json
2019-05-21T15:47:42.222Z [4567/15532] - info: Initializing NodeBB v1.12.2 https://article42.education:4567
2019-05-21T15:47:42.225Z [4567/15532] - verbose: * using redis store at 127.0.0.1:6379
2019-05-21T15:47:42.226Z [4567/15532] - verbose: * using themes stored in: /home/nodex/nodebb/node_modules
[benchpressjs] Unable to build or find a suitable native module, falling back to JS version
2019-05-21T15:47:43.810Z [4567/15532] - verbose: [minifier] utilizing a maximum of 0 additional threads
2019-05-21T15:47:43.828Z [4567/15532] - verbose: Checking dependencies for outdated modules
2019-05-21T15:47:44.307Z [4567/15532] - verbose: [notifications.init] Registering jobs.
2019-05-21T15:47:44.308Z [4567/15532] - verbose: [user/jobs] (Re-)starting user jobs...
2019-05-21T15:47:44.309Z [4567/15532] - verbose: [user/jobs] Starting job (digest.daily)
2019-05-21T15:47:44.311Z [4567/15532] - verbose: [user/jobs] Starting job (digest.weekly)
2019-05-21T15:47:44.312Z [4567/15532] - verbose: [user/jobs] Starting job (digest.monthly)
2019-05-21T15:47:44.313Z [4567/15532] - verbose: [user/jobs] Starting job (reset.clean)
2019-05-21T15:47:44.313Z [4567/15532] - verbose: [user/jobs] 4 jobs started
2019-05-21T15:47:44.314Z [4567/15532] - verbose: [emailer] Setting up SMTP fallback transport
hsts deprecated The "includeSubdomains" parameter is deprecated. Use "includeSubDomains" (with a capital D) instead. node_modules/helmet/index.js:33:28
hsts deprecated The "setIf" parameter is deprecated. Refer to the documentation to see how to set the header conditionally. node_modules/helmet/index.js:33:28
2019-05-21T15:47:44.348Z [4567/15532] - verbose: [middleware/autoLocale] Retrieves languages list for middleware
2019-05-21T15:47:44.359Z [4567/15532] - info: [themes] Using theme nodebb-theme-persona
2019-05-21T15:47:44.360Z [4567/15532] - verbose: [plugins] Initializing plugins system
2019-05-21T15:47:44.582Z [4567/15532] - verbose: [emailer] Built custom email templates
2019-05-21T15:47:44.613Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-composer-default
2019-05-21T15:47:44.615Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-theme-persona
2019-05-21T15:47:44.639Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-markdown
2019-05-21T15:47:44.698Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-mentions
2019-05-21T15:47:44.701Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-widget-essentials
2019-05-21T15:47:44.703Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-rewards-essentials
2019-05-21T15:47:44.705Z [4567/15532] - verbose: [plugins] Found 3 sound file(s) for plugin nodebb-plugin-soundpack-default
2019-05-21T15:47:44.705Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-soundpack-default
2019-05-21T15:47:44.759Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-emoji
2019-05-21T15:47:44.772Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-emoji-android
2019-05-21T15:47:44.852Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-dbsearch
2019-05-21T15:47:44.858Z [4567/15532] - warn: [deprecated] requiring core modules with `module.parent.require('./src/emitter')` is deprecated. Please use `require.main.require("./src/<module_name>")` instead.
    at /home/nodex/nodebb/node_modules/nodebb-plugin-ns-embed/plugin/nodebb.js:8:31
2019-05-21T15:47:44.858Z [4567/15532] - error: Error: Cannot find module './src/emitter'
    at Function.Module._resolveFilename (internal/modules/cjs/loader.js:668:15)
    at Function.Module._load (internal/modules/cjs/loader.js:591:27)
    at Module.require (internal/modules/cjs/loader.js:723:19)
    at require (internal/modules/cjs/helpers.js:14:16)
    at Module.require.main.require (/home/nodex/nodebb/require-main.js:8:10)
    at /home/nodex/nodebb/node_modules/nodebb-plugin-ns-embed/plugin/nodebb.js:8:31
    at Object.<anonymous> (/home/nodex/nodebb/node_modules/nodebb-plugin-ns-embed/plugin/nodebb.js:44:3)
    at Module._compile (internal/modules/cjs/loader.js:816:30)
    at Object.Module._extensions..js (internal/modules/cjs/loader.js:827:10)
    at Module.load (internal/modules/cjs/loader.js:685:32)
2019-05-21T15:47:44.859Z [4567/15532] - warn: [plugins] Unable to parse library for: nodebb-plugin-ns-embed
2019-05-21T15:47:44.859Z [4567/15532] - verbose: [plugins] Loaded plugin: nodebb-plugin-ns-embed
2019-05-21T15:47:44.859Z [4567/15532] - info: [plugins] Plugins OK
2019-05-21T15:47:44.860Z [4567/15532] - verbose: [plugins/fireHook] static:assets.prepare
2019-05-21T15:47:44.860Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.860Z [4567/15532] - verbose: [plugins/fireHook] static:app.preload
2019-05-21T15:47:44.860Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.862Z [4567/15532] - verbose: [plugins/fireHook] static:app.load
2019-05-21T15:47:44.897Z [4567/15532] - verbose: [plugins/fireHook] action:markdown.updateParserRules
2019-05-21T15:47:44.897Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.899Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.899Z [4567/15532] - verbose: [plugins] All plugins reloaded and rerouted
2019-05-21T15:47:44.900Z [4567/15532] - verbose: [plugins/fireHook] filter:auth.init
2019-05-21T15:47:44.900Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.930Z [4567/15532] - info: Routes added
2019-05-21T15:47:44.932Z [4567/15532] - verbose: [meta/blacklist] Loading 0 blacklist rule(s)
2019-05-21T15:47:44.932Z [4567/15532] - verbose: [plugins/fireHook] filter:flags.getFilters
2019-05-21T15:47:44.932Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.932Z [4567/15532] - info: NodeBB Ready
2019-05-21T15:47:44.936Z [4567/15532] - verbose: [plugins/fireHook] action:nodebb.ready
2019-05-21T15:47:44.936Z [4567/15532] - verbose: [plugins/fireHook] action:plugins.firehook
2019-05-21T15:47:44.936Z [4567/15532] - info: Enabling 'trust proxy'
2019-05-21T15:47:44.940Z [4567/15532] - error: NodeBB address in use, exiting...listen EADDRINUSE: address already in use 0.0.0.0:4567 {"code":"EADDRINUSE","errno":"EADDRINUSE","syscall":"listen","address":"0.0.0.0","port":4567,"stack":"Error: listen EADDRINUSE: address already in use 0.0.0.0:4567\n    at Server.setupListenHandle [as _listen2] (net.js:1259:14)\n    at listenInCluster (net.js:1307:12)\n    at doListen (net.js:1446:7)\n    at processTicksAndRejections (internal/process/task_queues.js:81:17)"}
2019-05-21T15:47:44.943Z [4567/15532] - error: uncaughtException: listen EADDRINUSE: address already in use 0.0.0.0:4567
Error: listen EADDRINUSE: address already in use 0.0.0.0:4567
    at Server.setupListenHandle [as _listen2] (net.js:1259:14)
    at listenInCluster (net.js:1307:12)
    at doListen (net.js:1446:7)
    at processTicksAndRejections (internal/process/task_queues.js:81:17) {"error":{"code":"EADDRINUSE","errno":"EADDRINUSE","syscall":"listen","address":"0.0.0.0","port":4567},"stack":"Error: listen EADDRINUSE: address already in use 0.0.0.0:4567\n    at Server.setupListenHandle [as _listen2] (net.js:1259:14)\n    at listenInCluster (net.js:1307:12)\n    at doListen (net.js:1446:7)\n    at processTicksAndRejections (internal/process/task_queues.js:81:17)","exception":true,"date":"Tue May 21 2019 15:47:44 GMT+0000 (Coordinated Universal Time)","process":{"pid":15532,"uid":1000,"gid":1000,"cwd":"/home/nodex/nodebb","execPath":"/usr/bin/node","version":"v11.15.0","argv":["/usr/bin/node","/home/nodex/nodebb/app.js"],"memoryUsage":{"rss":147947520,"heapTotal":112553984,"heapUsed":84643528,"external":117056}},"os":{"loadavg":[0.25244140625,0.07177734375,0.01708984375],"uptime":101293},"trace":[{"column":14,"file":"net.js","function":"Server.setupListenHandle [as _listen2]","line":1259,"method":"setupListenHandle [as _listen2]","native":false},{"column":12,"file":"net.js","function":"listenInCluster","line":1307,"method":null,"native":false},{"column":7,"file":"net.js","function":"doListen","line":1446,"method":null,"native":false},{"column":17,"file":"internal/process/task_queues.js","function":"processTicksAndRejections","line":81,"method":null,"native":false}]}
2019-05-21T15:47:44.944Z [4567/15532] - error: listen EADDRINUSE: address already in use 0.0.0.0:4567 {"code":"EADDRINUSE","errno":"EADDRINUSE","syscall":"listen","address":"0.0.0.0","port":4567}
2019-05-21T15:47:44.944Z [4567/15532] - info: [app] Shutdown (SIGTERM/SIGINT) Initialised.
2019-05-21T15:47:44.945Z [4567/15532] - error: Server is not running.
3 restarts in 10 seconds, most likely an error on startup. Halting.

julian

Well, the ns-embed error is a problem with the ns-embed plugin, so that's on @Nicolas to look into.

Otherwise the last error just says you already have NodeBB running so it cannot bind to the same port. You'll want to stop and/or kill the running process first.

omega

@julian Cool thanks, yea poor ns-embed is not happy in 1.12.2 - I and others already flagged in that thread, still, A Great plugin!

Ok SMTP/EMAIL is fixed!

Some deeper DNS/MX work seems to have made the difference and using "encrypted" setting - initially I was using StartTLS as per email provider SMTP guide, which specified TLS - tested it again and StartTLS broke it.

Encrypted works.