SSL3_GET_RECORD:wrong version number sending any emails since upgrading past 0.37 #5182

vrooze · 2016-12-12T15:11:49Z

Your Rocket.Chat version: 0.47

We've had this issue for a while and I've done a lot of searching.
Since we upgraded past 0.37 we get the error sending any email. Registration, notification and the admin "test" button all produce the error.

We're inside of a corporate LAN with an SMTP relay that requires no authentication.

I experimented with changing the user and password which only produced an invalid login error.

Below is the log file from the most recent upgrade till now.

[34mI20161208-17:02:12.089(0) Updating process.env.MAIL_URL 
[34mI20161208-17:02:22.158(0) ufs: store created at  
[34mI20161208-17:02:23.300(0) ufs: store created at  
[34mI20161208-17:02:37.260(0) (rocketchat_migrations.js:160) Migrations: Migrating from version 64 -> 68
[34mI20161208-17:02:37.277(0) (rocketchat_migrations.js:160) Migrations: Running up() on version 65
[34mI20161208-17:02:39.243(0) (rocketchat_migrations.js:160) Migrations: Running up() on version 66
[34mI20161208-17:02:39.306(0) (rocketchat_migrations.js:160) Migrations: Running up() on version 67
[34mI20161208-17:02:39.327(0) (rocketchat_migrations.js:160) Migrations: Running up() on version 68
[34mI20161208-17:02:39.386(0) (rocketchat_migrations.js:160) Migrations: Finished migrating.
[34mI20161208-17:02:49.389(0) [33mNot migrating, control is locked. Attempt 1/30. Trying again in 10 seconds. 
[34mI20161208-17:02:49.398(0) (rocketchat_migrations.js:160) Migrations: Not migrating, already at version 68
[34mI20161208-17:02:49.933(0) Updating process.env.MAIL_URL 
[34mI20161208-17:02:51.898(0) [32mUsing GridFS for custom emoji storage 
[34mI20161208-17:02:52.321(0) [Thu Dec 08 2016 17:02:52 GMT+0000 (GMT)] WARNING A script has tried registering a HTTP route while the HTTP server is disabled with --disabled-httpd. 
[34mI20161208-17:02:52.323(0) [32mLoaded hubot-help/src/help.coffee 
[34mI20161208-17:02:52.350(0) [32mLoaded hello.coffee 
[34mI20161208-17:02:52.368(0) [32mLoaded zen.coffee 
[34mI20161208-17:02:56.739(0) [32mUsing GridFS for Avatar storage 
[34mI20161208-17:02:57.358(0) [32m➔ app.js:3990 [32mSystem ➔ startup 
[34mI20161208-17:02:57.359(0) [32m➔ [32m+------------------------------------+ 
[34mI20161208-17:02:57.359(0) [32m➔ [32m|           SERVER RUNNING           | 
[34mI20161208-17:02:57.361(0) [32m➔ [32m+------------------------------------+ 
[34mI20161208-17:02:57.362(0) [32m➔ [32m|                                    | 
[34mI20161208-17:02:57.362(0) [32m➔ [32m|       Version: 0.47.0              | 
[34mI20161208-17:02:57.363(0) [32m➔ [32m|  Process Port: 3000                | 
[34mI20161208-17:02:57.363(0) [32m➔ [32m|      Site URL: http://server:3000  | 
[34mI20161208-17:02:57.363(0) [32m➔ [32m|         OpLog: Disabled            | 
[34mI20161208-17:02:57.363(0) [32m➔ [32m|                                    | 
[34mI20161208-17:02:57.364(0) [32m➔ [32m+------------------------------------+ 
[34mI20161209-06:19:18.868(0) Exception in defer callback: Error: 140142710757184:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:   at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)   at smtpSend (packages/email.js:108:37)   at Object.Email.send (packages/email.js:211:5)   at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1434:14   at [object Object]._.extend.withValue (packages/meteor.js:1122:17)   at packages/meteor.js:445:45   at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -    at Error (native)  
[34mI20161209-06:19:21.803(0) Exception in defer callback: Error: 140142710757184:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:   at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)   at smtpSend (packages/email.js:108:37)   at Object.Email.send (packages/email.js:211:5)   at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1434:14   at [object Object]._.extend.withValue (packages/meteor.js:1122:17)   at packages/meteor.js:445:45   at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -    at Error (native)  
[34mI20161209-08:11:15.506(0) Exception in defer callback: Error: 140142710757184:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:   at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)   at smtpSend (packages/email.js:108:37)   at Object.Email.send (packages/email.js:211:5)   at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1434:14   at [object Object]._.extend.withValue (packages/meteor.js:1122:17)   at packages/meteor.js:445:45   at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -    at Error (native)  
[34mI20161209-09:20:14.421(0) Sending test email to my@email.address 
[34mI20161209-16:32:07.776(0) Exception in defer callback: Error: 140142710757184:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:   at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)   at smtpSend (packages/email.js:108:37)   at Object.Email.send (packages/email.js:211:5)   at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1434:14   at [object Object]._.extend.withValue (packages/meteor.js:1122:17)   at packages/meteor.js:445:45   at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -    at Error (native)  
[34mI20161212-09:37:57.953(0) Sending test email to my@email.address 
[34mI20161212-09:38:32.224(0) rocketchat_lib rocketchat_lib.js:1011 [34mMeteor ➔ method sendSMTPTestEmail -> userId: 5aBdc5Mq2XHXS54bJ , arguments:  {} 
[34mI20161212-09:38:32.229(0) Sending test email to my@email.address 
[34mI20161212-09:38:37.999(0) rocketchat_lib rocketchat_lib.js:1011 [34mMeteor ➔ method saveSetting -> userId: 5aBdc5Mq2XHXS54bJ , arguments:  { '0': 'Log_Level', '1': '0', '2': null } 
[34mI20161212-09:47:30.270(0) Updating process.env.MAIL_URL 
[34mI20161212-09:47:33.191(0) Sending test email to my@email.address 
[34mI20161212-09:47:39.675(0) Updating process.env.MAIL_URL 
[34mI20161212-09:47:42.069(0) Sending test email to my@email.address 
[34mI20161212-09:48:00.839(0) Updating process.env.MAIL_URL 
[34mI20161212-09:48:02.969(0) Sending test email to my@email.address 
[34mI20161212-09:48:14.852(0) Updating process.env.MAIL_URL 
[34mI20161212-09:48:15.775(0) Sending test email to my@email.address 
[34mI20161212-09:48:21.540(0) Updating process.env.MAIL_URL 
[34mI20161212-10:01:31.769(0) Exception in defer callback: Error: 140142710757184:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:   at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)   at smtpSend (packages/email.js:108:37)   at Object.Email.send (packages/email.js:211:5)   at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1434:14   at [object Object]._.extend.withValue (packages/meteor.js:1122:17)   at packages/meteor.js:445:45   at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -    at Error (native)  
[34mI20161212-10:21:49.058(0) Sending test email to my@email.address

The text was updated successfully, but these errors were encountered:

graywolf336 · 2016-12-12T16:16:06Z

Does your server have a valid SSL certificate chain?

vrooze · 2016-12-12T16:33:38Z

It's an internal server running rocket without SSL. Also the SMTP relay is running none SSL/TLS on port 25

vrooze · 2016-12-15T09:43:46Z

Just to update.

I have upgraded the server to 0.48.1 to fix the integration/webhook issue. problem still persists.

Exception in defer callback: Error: 139962357983040:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:   
at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)   
at smtpSend (packages/email.js:108:37)   
at Object.Email.send (packages/email.js:211:5)   
at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1438:14   
at [object Object]._.extend.withValue (packages/meteor.js:1122:17)   
at packages/meteor.js:445:45  
at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -    
at Error (native)

vrooze · 2017-01-30T14:04:38Z

Just to update with a fresh screenshot of the actual error (which doesn't appear in the log, even with debug level logging)
(had to censor domain/email for company policy as it's internal)

The only thing shown in the log with debug level is:

[34mI20170130-09:47:22.887(0) rocketchat_lib rocketchat_lib.js:1062 �[34mMeteor ➔ method sendSMTPTestEmail -> userId: 5aBdc5Mq2XHXS54bJ , arguments:  {} 
�[34mI20170130-09:47:22.890(0) Sending test email to user@domain.tld

The same error posted originally crops up every now and then. I'm unable to trigger it at will so I'm assuming it's someones channel subscription:

[I20170130-13:49:27.542(0) Exception in defer callback: Error: 139667687495488:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:  
at Object.Future.wait (/opt/Rocket.Chat/programs/server/node_modules/fibers/future.js:449:15)  
at smtpSend (packages/email.js:108:37)  
at Object.Email.send (packages/email.js:211:5)  
at /opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:1577:14  
at [object Object]._.extend.withValue (packages/meteor.js:1122:17)  
at packages/meteor.js:445:45  
at runWithEnvironment (packages/meteor.js:1176:24)      - - - - -   
at Error (native)

Running version 0.50.1

Zegorax · 2017-02-18T11:42:09Z

Hello there,

I'm experiencing the same error, 1408F10B:SSL.

Is there any news regarding this problem ?

vrooze · 2017-03-29T08:34:25Z

new error I just spotted registering a new user:

�[34mI20170329-09:14:05.312(1) Exception in defer callback: Error: Error trying to send email: 140348096288576:error:1408F10B:SSL routines:SSL3_GET_RECORD:wrong version number:../deps/openssl/openssl/ssl/s3_pkt.c:362:  [error-email-send-failed]   
at/opt/Rocket.Chat/programs/server/packages/rocketchat_lib.js:2955:13   
at[object Object]._.extend.withValue (packages/meteor.js:1122:17)   
atpackages/meteor.js:445:45   
atrunWithEnvironment (packages/meteor.js:1176:24)

sscholl · 2017-05-17T11:46:23Z

this issue was closed via #6940 in 0.56.0 FOR ME

Go to Administation->E-Mail->SMTP->Protocol (smtps)

vrooze · 2017-05-17T12:12:23Z

There is not Protocol option for me in the admin.
Host
Port
Username
Password
From Email
Test
Reset

Edit.
Ignore me I just spotted I still have RC1. I'll install 0.56 first

vrooze · 2017-05-17T12:44:41Z

Update, still not working whatever I set.

It's an internal smtp relay with no credential.

I'm at a loss of why this doesn't work

vrooze · 2017-05-17T13:14:37Z

Had a chat with my server admin colleague and he had the awesome idea to setup postfix to relay to the relay. Sending the rocket to localhost works fine now.

Don't know what the issue is but I have worked around it.

Feel free to close this if I am the only person with the issue remaining.

MartinSchoeler added feat: email type: support labels Dec 14, 2016

engelgabriel added this to the 0.50.0 milestone Dec 30, 2016

engelgabriel modified the milestones: 0.50.0, Short-term Jan 24, 2017

Provide feedback

Saved searches

Use saved searches to filter your results more quickly

SSL3_GET_RECORD:wrong version number sending any emails since upgrading past 0.37 #5182

SSL3_GET_RECORD:wrong version number sending any emails since upgrading past 0.37 #5182

vrooze commented Dec 12, 2016 •

edited

Loading

graywolf336 commented Dec 12, 2016

vrooze commented Dec 12, 2016

vrooze commented Dec 15, 2016 •

edited

Loading

vrooze commented Jan 30, 2017

Zegorax commented Feb 18, 2017

vrooze commented Mar 29, 2017

sscholl commented May 17, 2017

vrooze commented May 17, 2017 •

edited

Loading

vrooze commented May 17, 2017

vrooze commented May 17, 2017

SSL3_GET_RECORD:wrong version number sending any emails since upgrading past 0.37 #5182

SSL3_GET_RECORD:wrong version number sending any emails since upgrading past 0.37 #5182

Comments

vrooze commented Dec 12, 2016 • edited Loading

graywolf336 commented Dec 12, 2016

vrooze commented Dec 12, 2016

vrooze commented Dec 15, 2016 • edited Loading

vrooze commented Jan 30, 2017

Zegorax commented Feb 18, 2017

vrooze commented Mar 29, 2017

sscholl commented May 17, 2017

vrooze commented May 17, 2017 • edited Loading

vrooze commented May 17, 2017

vrooze commented May 17, 2017

vrooze commented Dec 12, 2016 •

edited

Loading

vrooze commented Dec 15, 2016 •

edited

Loading

vrooze commented May 17, 2017 •

edited

Loading