talked icon indicating copy to clipboard operation
talked copied to clipboard
verified publisher icon MetaProvide

continuous joined/left call

Open shylaev opened this issue 3 years ago • 2 comments

General Description

I am sorry for large listing Talked server and NextCloud are separate hosts

How To Reproduce?

get fresh install

  1. Ubuntu 20.04 LTS up-to-date on hyper-v
  2. Talked server cloned by git and installed as pointed in ReadMe by the way geckodriver is not in repos for present time, it was installed manually
  3. NextCloud Talked App was configured in according with manual on NextCloud Apps project's site
  4. Create Chat allowing guest
  5. Start conversation
  6. type /recording start in chat of conversation

Screenshots from NextCloud 24.0.4 Talk 14.0.4

https://ibb.co/6WWKMjS

Logs of httpd_access of NextCloud (Apache/2.4.51) 10.222.10.55 is Talked Server host

10.222.10.55 - - [21/Sep/2022:08:58:26 +0300] "DELETE /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:16 +0300] "GET /ocs/v2.php/apps/spreed/api/v1/chat/fmrnh4x8?setReadMarker=0&lookIntoFuture=1&lastKnownMessageId=16740&includeLastKnown=0 HTTP/1.1" 200 301 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:27 +0300] "POST /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:27 +0300] "GET /ocs/v2.php/apps/spreed/api/v1/chat/fmrnh4x8?setReadMarker=0&lookIntoFuture=1&lastKnownMessageId=16742&includeLastKnown=0 HTTP/1.1" 200 304 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:28 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 701 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:30 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/room/fmrnh4x8 HTTP/1.1" 200 839 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:38 +0300] "DELETE /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:38 +0300] "POST /ocs/v2.php/apps/spreed/api/v4/room/fmrnh4x8/participants/active HTTP/1.1" 200 841 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:28 +0300] "GET /ocs/v2.php/apps/spreed/api/v1/chat/fmrnh4x8?setReadMarker=0&lookIntoFuture=1&lastKnownMessageId=16743&includeLastKnown=0 HTTP/1.1" 200 302 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:40 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 436 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:40 +0300] "POST /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:40 +0300] "GET /ocs/v2.php/apps/spreed/api/v1/chat/fmrnh4x8?setReadMarker=0&lookIntoFuture=1&lastKnownMessageId=16744&includeLastKnown=0 HTTP/1.1" 200 303 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:41 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 699 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:43 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/room/fmrnh4x8 HTTP/1.1" 200 838 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:43 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/room/fmrnh4x8 HTTP/1.1" 200 838 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:51 +0300] "DELETE /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:51 +0300] "POST /ocs/v2.php/apps/spreed/api/v4/room/fmrnh4x8/participants/active HTTP/1.1" 200 838 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:42 +0300] "GET /ocs/v2.php/apps/spreed/api/v1/chat/fmrnh4x8?setReadMarker=0&lookIntoFuture=1&lastKnownMessageId=16745&includeLastKnown=0 HTTP/1.1" 200 301 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:52 +0300] "POST /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:52 +0300] "GET /ocs/v2.php/apps/spreed/api/v1/chat/fmrnh4x8?setReadMarker=0&lookIntoFuture=1&lastKnownMessageId=16746&includeLastKnown=0 HTTP/1.1" 200 304 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:54 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 697 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:58:55 +0300] "GET /ocs/v2.php/apps/spreed/api/v4/room/fmrnh4x8 HTTP/1.1" 200 837 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0" 10.222.10.55 - - [21/Sep/2022:08:59:04 +0300] "DELETE /ocs/v2.php/apps/spreed/api/v4/call/fmrnh4x8 HTTP/1.1" 200 81 "-" "Mozilla/5.0 (X11; Linux x86_64; rv:91.0) Gecko/20100101 Firefox/91.0

no suspicious logs on Talked server side even in debug mode. (10.222.10.71 is NextCloud host) something like this

DEBUG:selenium.webdriver.remote.remote_connection:Remote response: status=200 | data={"value":null} | headers=HTTPHeaderDict({'content-type': 'application/json; charset=utf-8', 'cache-control': 'no-cache', 'content-length': '14', 'date': 'Wed, 21 Sep 2022 06:12:04 GMT'}) DEBUG:selenium.webdriver.remote.remote_connection:Finished Request INFO:root:Starting ffmpeg process INFO:root:Recording has started [pid: 14236|app: 0|req: 1/1] 10.222.10.71 () {32 vars in 359 bytes} [Wed Sep 21 09:11:49 2022] POST /start => generated 37 bytes in 19692 msecs (HTTP/1.1 200) 2 headers in 71 bytes (1 switches on core 0) [x11grab @ 0x55eaef1f19c0] Stream #0: not enough frames to estimate rate; consider increasing probesize INFO:root:Stop ffmpeg process INFO:root:Stop browser DEBUG:selenium.webdriver.remote.remote_connection:DELETE http://localhost:46841/session/0c005eb8-ab4c-4859-90a1-b1518b77b756/window {}

how to turn on debug selenium/firefox to get logs? how to fix it

shylaev avatar Sep 21 '22 18:09 shylaev

Hi, inside folder where talked is installed you should find a geckodriver.log file, which contains logs from the browser. There might be some relevant info in there.

mwalbeck avatar Sep 23 '22 16:09 mwalbeck

Hi, thanks for attention here is the geckodriver.log during call with joined/left 1664174092642 mozrunner::runner INFO Running command: "/usr/bin/firefox" "--marionette" "--kiosk" "--width=1280" "--height=720" "--remote-debugging-port" "53739" "--remote-allow-hosts" "localhost" "-no-remote" "-profile" "/tmp/rust_mozprofileCUOh92" [GFX1-]: glxtest: libEGL missing 1664174093200 Marionette INFO Marionette enabled console.warn: SearchSettings: "get: No settings file exists, new profile?" (new NotFoundError("Could not open the file at /tmp/rust_mozprofileCUOh92/search.json.mozlz4", (void 0))) DevTools listening on ws://localhost:53739/devtools/browser/7299dbff-31d5-4efa-9cfc-0a6c5af5a86c 1664174094952 Marionette INFO Listening on port 42873 1664174095074 RemoteAgent WARN TLS certificate errors will be ignored for this session

from this point I'm seeing numerous attempts join and left chatroom. and this is the end of records

JavaScript error: resource://gre/actors/AutoCompleteChild.jsm, line 125: Error: Invalid autocomplete selectedIndex 1664174157913 Marionette INFO Stopped listening on port 42873 JavaScript error: resource:///modules/Interactions.jsm, line 209: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIUserIdleService.removeIdleObserver] Exiting due to channel error. Exiting due to channel error.

that's all was it helpful?

shylaev avatar Sep 26 '22 07:09 shylaev