SVN: can't move a file (HTTP 502 bad gateway)

Support
1

Hi there,

After having imported my repositories from an other Subversion server, I tried to make a Tag on one of them but it failed with Unexpected HTTP status 502 'Bad Gateway'.

Steps to reproduce:

  1. On a brand new Ubuntu 22.04 server, make a fresh install of RhodeCode Community beta through rcstack. When prompted, enable HTTPS/SSL.
  2. As a super-admin, create a new SVN repository named hello, then make a checkout on your computer.
  3. Create a blank text file called log.txt, then commit it as super-admin. This is revision 1.
  4. Write some text in the file, then commit it as super-admin. This is revision 2.
  5. Create a new directory called trunk, then commit it as super-admin. This is revision 3.
  6. SVN move the text file to the trunk folder, then commit it as super-admin. You may obtain the following result:
Commit to https://my.domain.net/hello
Unexpected HTTP status 502 'Bad Gateway' on '/hello/!svn/rvr/3/log.txt'

What’s expected:
Moving or copying (tagging, branching) should work without any issue as soon as you have write permissions.

Any idea of why this is happening?
Thanks.

2

Any idea? This issue is blocking for me…
Where does this !svn/rvr/ path come from?

3

Hi,

can you clarify if version of RhodeCOde you’re using is 5.0.0 (beta tag) or 4.X ?

4

Thanks for your answer.

RC_VERSION=beta set in file .runtime.env

./rcstack --version => 5.3.0

The footer of the web view states: 5.0.0.

The Admin > Settings > System info states:
RhodeCode Version: RhodeCode Community Edition, version 5.0.0

5

can you do the following:

./rcstack stack upgrade rhodecode

it should pull in latest beta image, i believe we fixed it few days ago for svn 1.14 on beta which had broken the DEL operation, efectively what svn move does is add/delete

6

Thanks for the info.

I did a fresh install (RHODECODE_VERSION = 5.0.0.beta22), repeated the exact same operations and got the exact same error:

Unexpected HTTP status 502 'Bad Gateway' on '/hello/!svn/rvr/3/log.txt'

For information, I have an other install with RHODECODE_VERSION = 5.0.0.beta21 and it behaves the same.

7

we tried to reproduce this but this workflow works…

can you run

./rcstack stack rhodecode logs -f

During the operation ? and maybe see if some error is printed out to the system ?

8

Bad news.

Here is the log output (part 1):

rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.777805+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 108] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0008442401885986328, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.778" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001418" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.790721+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 109] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006973743438720703, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.791" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001116" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.806806+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "255a82fb-2ad5-4078-b466-efc975a302c0"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.816214+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "pull action on svn repo \"hello\" by \"default\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "255a82fb-2ad5-4078-b466-efc975a302c0"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:41.819Z", "process":"237", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello", "query":"", "method":"OPTIONS", "status":"401", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.822950+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 197] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> OPTIONS Request to /hello time: 0.0519s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "255a82fb-2ad5-4078-b466-efc975a302c0", "time": 0.05192255973815918, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello", "view_name": "NOT_FOUND", "code": 401}
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:41.830" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.059313" response_code="401" response_bytes="381   " uri="OPTIONS:/hello " user=":-" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.859215+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 156] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007927417755126953, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.859" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001268" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.869546+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 130] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007812976837158203, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.869" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001186" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.875899+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "f425d270-496e-41f9-b27b-79f81f3b7d97"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.884658+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "pull action on svn repo \"hello\" by \"default\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "f425d270-496e-41f9-b27b-79f81f3b7d97"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:41.887Z", "process":"547", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello", "query":"", "method":"OPTIONS", "status":"200", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.889987+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 198] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> OPTIONS Request to /hello time: 0.0375s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "f425d270-496e-41f9-b27b-79f81f3b7d97", "time": 0.03749442100524902, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello", "view_name": "NOT_FOUND", "code": 200}
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:41.892" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.039501" response_code="200" response_bytes="185   " uri="OPTIONS:/hello " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.922290+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 110] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007331371307373047, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.922" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001266" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.941507+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 157] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0009s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0008509159088134766, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.941" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001269" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.957609+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "7a000e07-4122-4146-b0f5-750df5275043"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.966549+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "pull action on svn repo \"hello\" by \"default\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "7a000e07-4122-4146-b0f5-750df5275043"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:41.970Z", "process":"981", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello", "query":"", "method":"OPTIONS", "status":"200", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:41.973033+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 199] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> OPTIONS Request to /hello time: 0.0585s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "7a000e07-4122-4146-b0f5-750df5275043", "time": 0.05849003791809082, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello", "view_name": "NOT_FOUND", "code": 200}
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:41.973" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.059578" response_code="200" response_bytes="97    " uri="OPTIONS:/hello " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:41.997480+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 131] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007011890411376953, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:41.998" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001320" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.008123+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 158] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0008370876312255859, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.008" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001312" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.013848+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "baebcefb-31a1-41e1-b721-c87c496b3811"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.021551+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "pull action on svn repo \"hello\" by \"default\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "baebcefb-31a1-41e1-b721-c87c496b3811"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:42.024Z", "process":"492", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello", "query":"", "method":"OPTIONS", "status":"200", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.026931+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 200] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> OPTIONS Request to /hello time: 0.0366s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "baebcefb-31a1-41e1-b721-c87c496b3811", "time": 0.03656721115112305, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello", "view_name": "NOT_FOUND", "code": 200}
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:42.028" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.038118" response_code="200" response_bytes="185   " uri="OPTIONS:/hello " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
9

Here is the log output (part 2):

rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.049434+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 132] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007698535919189453, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.049" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001346" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.062067+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 159] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006618499755859375, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.062" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001145" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.069803+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.084920+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#token plugin", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.097267+00:00", "levelname": "WARNING", "name": "rhodecode.authentication.plugins.auth_token", "message": "user `justin.massiot` failed to authenticate via authtoken, reason: bad or inactive token.", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.102247+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#rhodecode plugin", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.170874+00:00", "levelname": "INFO", "name": "rhodecode.authentication.plugins.auth_rhodecode", "message": "user `justin.massiot` authenticated correctly", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb", "action": "user_auth_ok", "auth_module": "auth_rhodecode", "username": "justin.massiot"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.174394+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "MAIN-AUTH successful for user `justin.massiot` from rhodecode plugin", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.181005+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.191370+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "push action on svn repo \"hello\" by \"justin.massiot\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:42.196Z", "process":"4780", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello/!svn/me", "query":"", "method":"POST", "status":"201", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.203305+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 201] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> POST Request to /hello/!svn/me time: 0.1599s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "7d2d03e0-4246-4ea5-886b-b8680c5d63bb", "time": 0.1598823070526123, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello/!svn/me", "view_name": "NOT_FOUND", "code": 201}
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.217698+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 133] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007307529449462891, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.218" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001179" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.220067+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 160] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0005s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0005345344543457031, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.220" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.000847" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.221725+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 161] IP: 127.0.0.1 POST Request to hello@/svn/is_empty time: 0.0005s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0004513263702392578, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_empty", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.221" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.000710" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.224165+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 162] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0005s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0004892349243164062, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.224" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.000789" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.226763+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 163] IP: 127.0.0.1 POST Request to hello@/svn/revision_properties time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007410049438476562, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "revision_properties", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.227" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001114" response_code="200" response_bytes="123   " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:42.236" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.193665" response_code="201" response_bytes="0     " uri="POST:/hello/!svn/me " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.273077+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 111] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0006s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0005681514739990234, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.273" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001084" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.283628+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 112] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0006s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0005919933319091797, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.283" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001024" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.288700+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.294132+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#token plugin", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.299362+00:00", "levelname": "WARNING", "name": "rhodecode.authentication.plugins.auth_token", "message": "user `justin.massiot` failed to authenticate via authtoken, reason: bad or inactive token.", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.303705+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#rhodecode plugin", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.367088+00:00", "levelname": "INFO", "name": "rhodecode.authentication.plugins.auth_rhodecode", "message": "user `justin.massiot` authenticated correctly", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c", "action": "user_auth_ok", "auth_module": "auth_rhodecode", "username": "justin.massiot"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.368166+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "MAIN-AUTH successful for user `justin.massiot` from rhodecode plugin", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.372093+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.381979+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "push action on svn repo \"hello\" by \"justin.massiot\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:42.384Z", "process":"835", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello/log.txt", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello/!svn/txr/3-6/log.txt", "query":"", "method":"DELETE", "status":"204", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
10

Here is the log output (part 3):

rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.387269+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 202] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> DELETE Request to /hello/!svn/txr/3-6/log.txt time: 0.1196s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "090c817e-e989-4a31-928a-788e9d83ed4c", "time": 0.11956501007080078, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello/!svn/txr/3-6/log.txt", "view_name": "NOT_FOUND", "code": 204}
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.399550+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 164] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007297992706298828, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.399" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001119" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.401889+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 113] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006780624389648438, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.402" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001519" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.404383+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 134] IP: 127.0.0.1 POST Request to hello@/svn/is_empty time: 0.0006s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006246566772460938, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_empty", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.404" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001107" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.406686+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 135] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007567405700683594, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.407" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001641" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.409607+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 136] IP: 127.0.0.1 POST Request to hello@/svn/revision_properties time: 0.0010s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.001018524169921875, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "revision_properties", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.410" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001817" response_code="200" response_bytes="123   " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:42.418" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.150613" response_code="204" response_bytes="0     " uri="DELETE:/hello/!svn/txr/3-6/log.txt " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.454792+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 165] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007252693176269531, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.455" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001231" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.466235+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 114] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007071495056152344, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.466" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001267" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.474858+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.480285+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#token plugin", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.486335+00:00", "levelname": "WARNING", "name": "rhodecode.authentication.plugins.auth_token", "message": "user `justin.massiot` failed to authenticate via authtoken, reason: bad or inactive token.", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.488617+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#rhodecode plugin", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.553431+00:00", "levelname": "INFO", "name": "rhodecode.authentication.plugins.auth_rhodecode", "message": "user `justin.massiot` authenticated correctly", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6", "action": "user_auth_ok", "auth_module": "auth_rhodecode", "username": "justin.massiot"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.554803+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "MAIN-AUTH successful for user `justin.massiot` from rhodecode plugin", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.559340+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:42.584Z", "process":"503", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello/log.txt", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello/!svn/rvr/3/log.txt", "query":"", "method":"COPY", "status":"502", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.572515+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "push action on svn repo \"hello\" by \"justin.massiot\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.586152+00:00", "levelname": "ERROR", "name": "rhodecode.lib.middleware.simplesvn", "message": "Got SVN response:<Response [502]> with text:`\n<!DOCTYPE HTML PUBLIC \"-//W3C//DTD HTML 4.01//EN\" \"http://www.w3.org/TR/html4/strict.dtd\">\n<html>\n<head>\n<title>502 Bad Gateway</title>\n</head><body>\n<h1>Bad Gateway</h1>\n<p>Destination URI refers to different scheme or port (https://hostname:443)\n(want: http://hostname:8090)</p>\n</body></html>\n`", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.588196+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 203] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> COPY Request to /hello/!svn/rvr/3/log.txt time: 0.1388s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "80094282-f84e-4846-92e3-71368eb1e4e6", "time": 0.13882231712341309, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello/!svn/rvr/3/log.txt", "view_name": "NOT_FOUND", "code": 502}
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.603165+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 115] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007052421569824219, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.603" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001319" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.606237+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 116] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0010s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0009894371032714844, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.607" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001794" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.608823+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 117] IP: 127.0.0.1 POST Request to hello@/svn/is_empty time: 0.0006s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.000614166259765625, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_empty", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.611" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.003672" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.614304+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 137] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007266998291015625, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.614" pid=<13> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001132" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.616731+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 166] IP: 127.0.0.1 POST Request to hello@/svn/revision_properties time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0008137226104736328, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "revision_properties", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.616" pid=<12> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001150" response_code="200" response_bytes="123   " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:42.624" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.175588" response_code="502" response_bytes="296   " uri="COPY:/hello/!svn/rvr/3/log.txt " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.701594+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 118] IP: 127.0.0.1 POST Request to var/opt/rhodecode_repo_store/hello@/svn/is_path_valid_repository time: 0.0006s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006043910980224609, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "var/opt/rhodecode_repo_store/hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.702" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001142" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.712312+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 119] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0006s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006172657012939453, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.712" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001102" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.717550+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.724686+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#token plugin", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.730258+00:00", "levelname": "WARNING", "name": "rhodecode.authentication.plugins.auth_token", "message": "user `justin.massiot` failed to authenticate via authtoken, reason: bad or inactive token.", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.732463+00:00", "levelname": "INFO", "name": "rhodecode.authentication.base", "message": "Authenticating user `justin.massiot` using egg:rhodecode-enterprise-ce#rhodecode plugin", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.796799+00:00", "levelname": "INFO", "name": "rhodecode.authentication.plugins.auth_rhodecode", "message": "user `justin.massiot` authenticated correctly", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075", "action": "user_auth_ok", "auth_module": "auth_rhodecode", "username": "justin.massiot"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.797548+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "MAIN-AUTH successful for user `justin.massiot` from rhodecode plugin", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.801528+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "Access for IP:172.18.0.1 allowed", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.814386+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.simplevcs", "message": "push action on svn repo \"hello\" by \"justin.massiot\" from 172.18.0.1 SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075"}
rc_cluster_apps-svn-2          | { "time":"2023-12-06T22:07:42.818Z", "process":"828", "filename":"dav_svn:/var/opt/rhodecode_repo_store/hello", "remoteIP":"172.18.0.11", "host":"vps-5d7e6568.vps.ovh.net", "request":"/hello/!svn/txn/3-6", "query":"", "method":"DELETE", "status":"204", "userAgent":"SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465", "referer":"-" }
rc_cluster_apps-rhodecode-2    | {"timestamp": "2023-12-06T22:07:42.820319+00:00", "levelname": "INFO", "name": "rhodecode.lib.middleware.request_wrapper", "message": "Req[ 204] <AuthUser('id:0[ANONYMOUS] ip:172.18.0.1 auth:False')> DELETE Request to /hello/!svn/txn/3-6 time: 0.1242s [SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465], RhodeCode 5.0.0", "req_id": "d1d531de-1e60-4c09-8b74-033e25a98075", "time": 0.12423920631408691, "ver": "5.0.0", "ip": "172.18.0.1", "path": "/hello/!svn/txn/3-6", "view_name": "NOT_FOUND", "code": 204}
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.833736+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 120] IP: 127.0.0.1 POST Request to hello@/svn/is_path_valid_repository time: 0.0023s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0023314952850341797, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_path_valid_repository", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.834" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.003019" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.836000+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 121] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0008399486541748047, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.836" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001491" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.838242+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 122] IP: 127.0.0.1 POST Request to hello@/svn/is_empty time: 0.0007s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0006754398345947266, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "is_empty", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.838" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001297" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.840262+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 123] IP: 127.0.0.1 POST Request to hello@/svn/lookup time: 0.0004s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0004138946533203125, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "lookup", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.840" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.000968" response_code="200" response_bytes="51    " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-vcsserver-2    | {"timestamp": "2023-12-06T22:07:42.842470+00:00", "levelname": "INFO", "name": "vcsserver.tweens.request_wrapper", "message": "Req[ 124] IP: 127.0.0.1 POST Request to hello@/svn/revision_properties time: 0.0008s [RhodeCode HTTP 5.0.0], VCSServer 5.0.0", "req_id": null, "time": 0.0007848739624023438, "ver": "5.0.0", "code": 200, "path": "/svn", "view_name": "vcs", "user_agent": "RhodeCode HTTP 5.0.0", "vcs_method": "revision_properties", "repo_name": "hello"}
rc_cluster_apps-vcsserver-2    | time="2023-12-06 22:07:42.842" pid=<14> level="INFO" type="[GNCRN]" ip="172.18.0.11    " rqt="0.001249" response_code="200" response_bytes="123   " uri="POST:/svn " user=":-" user_agent="RhodeCode HTTP 5.0.0"
rc_cluster_apps-rhodecode-2    | time="2023-12-06 22:07:42.849" pid=<18> level="INFO" type="[GNCRN]" ip="172.18.0.1     " rqt="0.153076" response_code="204" response_bytes="0     " uri="DELETE:/hello/!svn/txn/3-6 " user=":justin.massiot" user_agent="SVN/1.14.2 (x64-microsoft-windows) serf/1.3.9 TortoiseSVN-1.14.5.29465"

No error from the current SSH connection, no relevant error from dmesg.

11

OK so there’s an error message from apache (quite hidden… :(((

rc_cluster_apps-rhodecode-2 | {“timestamp”: “2023-12-06T22:07:42.586152+00:00”, “levelname”: “ERROR”, “name”: “rhodecode.lib.middleware.simplesvn”, “message”: “Got SVN response:<Response [502]> with text:\n<!DOCTYPE HTML PUBLIC \"-//W3C//DTD HTML 4.01//EN\" \"http://www.w3.org/TR/html4/strict.dtd\">\n<html>\n<head>\n<title>502 Bad Gateway</title>\n</head><body>\n<h1>Bad Gateway</h1>\n<p>Destination URI refers to different scheme or port (https://hostname:443)\n(want: http://hostname:8090)</p>\n</body></html>\n”, “req_id”: “80094282-f84e-4846-92e3-71368eb1e4e6”}

We’ve never seen this before. Looks related to http/https setup, let us try to again reproduce this with SSL enabled…

12

ok can you try the following:

in rhodecode.ini set this:

force_https = true

Then go to admin > settings > vcs > Global Subversion Settings

And click generate apache config, restart the whole stack…

this might fix this…

13

Your trick did fix my issue!
Confirmed to be working also on 5.0.0.beta21.

Thank you!!