Dradis-ce.service: Main process exited, code=killed, status=9/KILL

Hi,

After couple of days, Dradis-ce service automatically killed due to web socket upgraded automatically. Can someone from dradis resolve and let us know please?

Environment:

OS: Ubuntu server 16.04
Dradis-ce
Web server : Rails

Please find the attached logs for more information.

{Loaded: loaded (/lib/systemd/system/dradis-ce.service; enabled; vendor preset: enabled)
Active: failed (Result: signal) since Fri 2018-09-14 11:55:11 PDT; 2 days ago
Process: 22387 ExecStart=/usr/local/bin/bundle exec rails server -b 0.0.0.0 (code=killed, signal=KILL)
Main PID: 22387 (code=killed, signal=KILL)

Sep 14 11:35:39 ubuntu bundle[22387]: An unauthorized connection attempt was rejected
Sep 14 11:35:41 ubuntu bundle[22387]: Failed to upgrade to WebSocket (REQUEST_METHOD: GET, HTTP_CONNECTION: Upgrade, HTTP_UPGRADE: websocket)
Sep 14 11:35:55 ubuntu bundle[22387]: Finished “/cable/” [WebSocket] for 172.16.10.17 at 2018-09-14 11:35:55 -0700
Sep 14 11:36:26 ubuntu bundle[22387]: Started GET “/cable/” [WebSocket] for 172.16.10.17 at 2018-09-14 11:35:55 -0700
Sep 14 11:37:05 ubuntu bundle[22387]: Finished “/cable/” [WebSocket] for 172.16.10.17 at 2018-09-14 11:36:49 -0700
Sep 14 11:37:07 ubuntu bundle[22387]: Successfully upgraded to WebSocket (REQUEST_METHOD: GET, HTTP_CONNECTION: Upgrade, HTTP_UPGRADE: websocket)
Sep 14 11:43:17 ubuntu bundle[22387]: User Load (50275.1ms) SELECT “users”.* FROM “users” WHERE “users”.“id” = ? LIMIT ? [[“id”, 1], [“LIMIT”, 1]]
Sep 14 11:55:11 ubuntu systemd[1]: dradis-ce.service: Main process exited, code=killed, status=9/KILL
Sep 14 11:55:11 ubuntu systemd[1]: dradis-ce.service: Unit entered failed state.
Sep 14 11:55:12 ubuntu systemd[1]: dradis-ce.service: Failed with result ‘signal’.
}

Thanks for your time.

Sincerely,
Sasi

Hi Sasi,

What CE version are you using here? Also, did this happen just once or a couple times due to the same log?

Thanks,
Aaron

Hi @aapomm,

That is dradis-ce_v3.0.
The issue has been observed one time till this moment. However, it is very recent deployment.

Thank you,
Sasi

I recommend pulling the latest version from Github which is Dradis CE version 3.10. Also, can you provide more info on how your Dradis CE instance in configured (e.g. Did you install from git? Are you running a packaged instance?) A service can stop for multiple reasons and it looks unlikely that it’s because of WebSockets as there are no errors. Can you inform us if this happening consistently with the same log?

Hi @aapomm,
I installed it from git. from last few days, I haven’t observed any issues. will let you know immediately, if i see any issues.

Thank you for you time.

Hi @aapomm,

The issue is observed again. Requesting you to look in to it. Please find the logs as below.

Started GET “/cable” for 172.16.10.20 at 2018-09-26 05:25:20 -0700
Cannot render console from 172.16.10.20! Allowed networks: 127.0.0.1, ::1, 127.0.0.0/127.255.255.255
Started GET “/cable/” [WebSocket] for 172.16.10.20 at 2018-09-26 05:25:21 -0700
Successfully upgraded to WebSocket (REQUEST_METHOD: GET, HTTP_CONNECTION: Upgrade, HTTP_UPGRADE: websocket)
An unauthorized connection attempt was rejected
Failed to upgrade to WebSocket (REQUEST_METHOD: GET, HTTP_CONNECTION: Upgrade, HTTP_UPGRADE: websocket)
Finished “/cable/” [WebSocket] for 172.16.10.20 at 2018-09-26 05:25:21 -0700
Finished “/cable/” [WebSocket] for 172.16.10.20 at 2018-09-26 05:25:22 -0700

Thank you,
Sasi

Now not able to log-in.

Below are logs for your information.

Started POST “/session” for 172.16.10.17 at 2018-09-26 05:35:47 -0700
Cannot render console from 172.16.10.17! Allowed networks: 127.0.0.1, ::1, 127.0.0.0/127.255.255.255
Processing by SessionsController#create as HTML
Parameters: {“utf8”=>“✓”, “authenticity_token”=>“AqT7F/QSnEFk6jirvyHYUGD9YW3iSGzVbp7GSbcnOnqqQzW6LACovywPSHQi6rz2ciaBwuA4yGDBB/T+xjJkLw==”, “login”=>“admindrod”, “password”=>“[FILTERED]”, “commit”=>“Let me in!”}
Configuration Load (237.2ms) SELECT “configurations”.* FROM “configurations” WHERE “configurations”.“name” = ? LIMIT ? [[“name”, “admin:password”], [“LIMIT”, 1]]
User Load (41301.3ms) SELECT “users”.* FROM “users” WHERE “users”.“email” = ? LIMIT ? [[“email”, “admindrod”], [“LIMIT”, 1]]
Redirected to http://10.250.90.223:3000/
Completed 302 Found in 44557ms (ActiveRecord: 41538.5ms)

Started GET “/” for 172.16.10.17 at 2018-09-26 05:38:32 -0700
Cannot render console from 172.16.10.17! Allowed networks: 127.0.0.1, ::1, 127.0.0.0/127.255.255.255
Processing by ProjectsController#index as HTML
User Load (259.6ms) SELECT “users”.* FROM “users” WHERE “users”.“id” = ? LIMIT ? [[“id”, 1], [“LIMIT”, 1]]
Redirected to http://10.250.90.223:3000/projects/1
Completed 302 Found in 23943ms (ActiveRecord: 259.6ms)

Started GET “/projects/1” for 172.16.10.17 at 2018-09-26 05:40:56 -0700
Cannot render console from 172.16.10.17! Allowed networks: 127.0.0.1, ::1, 127.0.0.0/127.255.255.255
Processing by ProjectsController#show as HTML
Parameters: {“id”=>“1”}
User Load (318.9ms) SELECT “users”.* FROM “users” WHERE “users”.“id” = ? LIMIT ? [[“id”, 1], [“LIMIT”, 1]]
Node Load (333.7ms) SELECT “nodes”.* FROM “nodes” WHERE “nodes”.“label” = ? AND “nodes”.“type_id” = ? LIMIT ? [[“label”, “All issues”], [“type_id”, 3], [“LIMIT”, 1]]
Issue Load (827.6ms) SELECT “notes”.* FROM “notes” WHERE “notes”.“node_id” = ? [[“node_id”, 1]]
Tagging Load (646.3ms) SELECT “taggings”.* FROM “taggings” WHERE “taggings”.“taggable_type” = ? AND “taggings”.“taggable_id” IN (6, 7, 8, 9, 10, 11, 12) [[“taggable_type”, “Note”]]
Tag Load (326.3ms) SELECT “tags”.* FROM “tags” WHERE “tags”.“id” IN (3, 5)
Node Load (1687.8ms) SELECT “nodes”.* FROM “nodes” WHERE “nodes”.“label” = ? AND “nodes”.“type_id” = ? LIMIT ? [[“label”, “Methodologies”], [“type_id”, 2], [“LIMIT”, 1]]
Note Load (147.7ms) SELECT “notes”.* FROM “notes” WHERE “notes”.“node_id” = ? [[“node_id”, 2]]
Tag Load (303.9ms) SELECT “tags”.* FROM “tags”
Rendering projects/show.html.erb within layouts/snowcrash

After restarting the dradis-ce service, it is working as expected.

Thank you,
Sasi