strukturag / nextcloud-spreed-signaling

Standalone signaling server for Nextcloud Talk.
GNU Affero General Public License v3.0
381 stars 69 forks source link

Connecting Problem #342

Closed goNeuland closed 1 year ago

goNeuland commented 2 years ago

Enviroment One Server for NC and nextcloud spreed signaling for testing

Nextcloud GUI Everything looks good in the gui

nextcloud-001

Problem: Users cannot connect. I have already tried several browsers and devices.

nextcloud-002

Server Logs

Attaching to coturn, janus, nats, spreed
coturn  | 0: : WARNING: Cannot find config file: turnserver.conf. Default and command-line settings will be used.
coturn  | 0: : WARNING: Cannot find config file: turnserver.conf. Default and command-line settings will be used.
coturn  | 0: : WARNING: Cannot find config file: turnserver.conf. Default and command-line settings will be used.
coturn  | 0: :
coturn  | RFC 3489/5389/5766/5780/6062/6156 STUN/TURN Server
coturn  | Version Coturn-4.6.0 'Gorst'
coturn  | 0: :
coturn  | Max number of open files/sockets allowed for this process: 1048576
coturn  | 0: :
coturn  | Due to the open files/sockets limitation,
coturn  | max supported number of TURN Sessions possible is: 524000 (approximately)
coturn  | 0: :
coturn  |
coturn  | ==== Show him the instruments, Practical Frost: ====
coturn  |
coturn  | 0: : TLS supported
coturn  | 0: : DTLS supported
coturn  | 0: : DTLS 1.2 supported
coturn  | 0: : TURN/STUN ALPN supported
coturn  | 0: : Third-party authorization (oAuth) supported
coturn  | 0: : GCM (AEAD) supported
coturn  | 0: : OpenSSL compile-time version: OpenSSL 1.1.1n  15 Mar 2022 (0x101010ef)
coturn  | 0: :
coturn  | 0: : SQLite supported, default database location is /var/lib/coturn/turndb
coturn  | 0: : Redis supported
coturn  | 0: : PostgreSQL supported
coturn  | 0: : MySQL supported
coturn  | 0: : MongoDB supported
coturn  | 0: :
coturn  | 0: : Default Net Engine version: 3 (UDP thread per CPU core)
coturn  |
coturn  | =====================================================
coturn  |
coturn  | 0: : Domain name:
coturn  | 0: : Default realm: signal.testbereich.net
coturn  | 0: :
coturn  | CONFIGURATION ALERT: You specified --lt-cred-mech and --use-auth-secret in the same time.
coturn  | Be aware that you could not mix the username/password and the shared secret based auth methods.
coturn  | Shared secret overrides username/password based auth method. Check your configuration!
coturn  | 0: : ERROR:
coturn  | CONFIG ERROR: Empty cli-password, and so telnet cli interface is disabled! Please set a non empty cli-password!
coturn  | 0: : WARNING: cannot find certificate file: turn_server_cert.pem (1)
coturn  | 0: : WARNING: cannot start TLS and DTLS listeners because certificate file is not set properly
coturn  | 0: : WARNING: cannot find private key file: turn_server_pkey.pem (1)
coturn  | 0: : WARNING: cannot start TLS and DTLS listeners because private key file is not set properly
coturn  | 0: : NO EXPLICIT LISTENER ADDRESS(ES) ARE CONFIGURED
coturn  | 0: : ===========Discovering listener addresses: =========
coturn  | 0: : Listener address to use: 127.0.0.1
coturn  | 0: : Listener address to use: 178.250.170.125
coturn  | 0: : Listener address to use: 172.17.0.1
coturn  | 0: : Listener address to use: 172.18.0.1
coturn  | 0: : Listener address to use: 172.24.0.1
coturn  | 0: : Listener address to use: ::1
coturn  | 0: : =====================================================
coturn  | 0: : Total: 5 'real' addresses discovered
coturn  | 0: : =====================================================
coturn  | 0: : NO EXPLICIT RELAY ADDRESS(ES) ARE CONFIGURED
coturn  | 0: : ===========Discovering relay addresses: =============
coturn  | 0: : Relay address to use: 127.0.0.1
coturn  | 0: : Relay address to use: 178.250.170.125
coturn  | 0: : Relay address to use: 172.17.0.1
coturn  | 0: : Relay address to use: 172.18.0.1
coturn  | 0: : Relay address to use: 172.24.0.1
coturn  | 0: : Relay address to use: ::1
coturn  | 0: : =====================================================
coturn  | 0: : Total: 6 relay addresses discovered
coturn  | 0: : =====================================================
coturn  | 0: : Cannot create pid file: /var/run/turnserver.pid
coturn  | 0: : pid file created: /var/tmp/turnserver.pid
coturn  | 0: : IO method (main listener thread): epoll (with changelist)
coturn  | 0: : Wait for relay ports initialization...
coturn  | 0: :   relay 127.0.0.1 initialization...
coturn  | Cannot create pid file: /var/run/turnserver.pid: Permission denied
coturn  | 0: :   relay 127.0.0.1 initialization done
coturn  | 0: :   relay 178.250.170.125 initialization...
coturn  | 0: :   relay 178.250.170.125 initialization done
coturn  | 0: :   relay 172.17.0.1 initialization...
coturn  | 0: :   relay 172.17.0.1 initialization done
coturn  | 0: :   relay 172.18.0.1 initialization...
coturn  | 0: :   relay 172.18.0.1 initialization done
coturn  | 0: :   relay 172.24.0.1 initialization...
coturn  | 0: :   relay 172.24.0.1 initialization done
coturn  | 0: :   relay ::1 initialization...
coturn  | 0: :   relay ::1 initialization done
coturn  | 0: : Relay ports initialization done
coturn  | 0: : IO method (general relay thread): epoll (with changelist)
coturn  | 0: : turn server id=2 created
coturn  | 0: : IO method (general relay thread): epoll (with changelist)
coturn  | 0: : turn server id=3 created
coturn  | 0: : IO method (general relay thread): epoll (with changelist)
coturn  | 0: : turn server id=1 created
coturn  | 0: : IO method (general relay thread): epoll (with changelist)
coturn  | 0: : turn server id=0 created
coturn  | socket: Protocol not supported
coturn  | socket: Protocol not supported
coturn  | socket: Protocol not supported
coturn  | socket: Protocol not supported
coturn  | socket: Protocol not supported
coturn  | 0: : Total General servers: 4
coturn  | 0: : IO method (admin thread): epoll (with changelist)
coturn  | 0: : IO method (auth thread): epoll (with changelist)
coturn  | 0: : IO method (auth thread): epoll (with changelist)
coturn  | 0: : SQLite DB connection success: /var/lib/coturn/turndb
coturn  | 0: : Prometheus collector disabled, not started.
nats    | [1] 2022/09/29 15:28:47.047156 [INF] Starting nats-server
nats    | [1] 2022/09/29 15:28:47.047199 [INF]   Version:  2.2.1
nats    | [1] 2022/09/29 15:28:47.047202 [INF]   Git:      [0bdd8f8]
nats    | [1] 2022/09/29 15:28:47.047206 [INF]   Name:     NBNILATJEUYCH7MIID6WLH55BEJ7RV3ICZA4KD7Y34MGORFWJVO4ZJTA
nats    | [1] 2022/09/29 15:28:47.047209 [INF]   ID:       NBNILATJEUYCH7MIID6WLH55BEJ7RV3ICZA4KD7Y34MGORFWJVO4ZJTA
nats    | [1] 2022/09/29 15:28:47.047212 [INF] Using configuration file: /config/gnatsd.conf
nats    | [1] 2022/09/29 15:28:47.048817 [INF] Listening for client connections on 0.0.0.0:4222
nats    | [1] 2022/09/29 15:28:47.049050 [INF] Server is ready
nats    | [1] 2022/09/29 15:28:47.050042 [INF] Cluster name is HcdDzIGQe6eTfIhZWSwRZm
nats    | [1] 2022/09/29 15:28:47.050051 [WRN] Cluster name was dynamically generated, consider setting one
nats    | [1] 2022/09/29 15:28:47.050090 [INF] Listening for route connections on 0.0.0.0:4244
janus   | Janus commit: not-a-git-repo
janus   | Compiled on:  Tue Sep 27 14:19:13 UTC 2022
janus   |
janus   | Logger plugins folder: /usr/local/lib/janus/loggers
janus   | [WARN]        Couldn't access logger plugins folder...
janus   | ---------------------------------------------------
janus   |   Starting Meetecho Janus (WebRTC Server) v0.11.8
janus   | ---------------------------------------------------
janus   |
janus   | Checking command line arguments...
janus   | Debug/log level is 4
janus   | Debug/log timestamps are disabled
janus   | Debug/log colors are enabled
janus   | Adding 'vmnet' to the ICE ignore list...
janus   | Using 172.18.0.5 as local IP...
janus   | Token based authentication disabled
janus   | Initializing recorder code
janus   | Initializing ICE stuff (Full mode, ICE-TCP candidates disabled, full-trickle, IPv6 support disabled)
janus   | TURN REST API backend: (disabled)
janus   | [WARN] Janus is deployed on a private address (172.18.0.5) but you didn't specify any STUN server! Expect trouble if this is supposed to work over the internet and not just in a LAN...
janus   | Crypto: OpenSSL >= 1.1.0
janus   | No cert/key specified, autogenerating some...
janus   | Fingerprint of our certificate: D4:3C:69:5F:D8:4C:3D:DE:C9:B9:8F:90:E0:CE:5F:DF:F6:52:81:94:97:3E:76:52:E2:7A:7E:E8:F3:99:D2:E5
janus   | Event handlers support disabled
janus   | Plugins folder: /usr/local/lib/janus/plugins
janus   | Joining Janus requests handler thread
janus   | Sessions watchdog started
janus   | Loading plugin 'libjanus_recordplay.so'...
janus   | JANUS Record&Play plugin initialized!
janus   | Loading plugin 'libjanus_videoroom.so'...
janus   | JANUS VideoRoom plugin initialized!
janus   | Loading plugin 'libjanus_textroom.so'...
janus   | JANUS TextRoom plugin initialized!
janus   | Loading plugin 'libjanus_nosip.so'...
janus   | JANUS NoSIP plugin initialized!
janus   | Loading plugin 'libjanus_voicemail.so'...
janus   | JANUS VoiceMail plugin initialized!
janus   | Loading plugin 'libjanus_videocall.so'...
janus   | JANUS VideoCall plugin initialized!
janus   | Loading plugin 'libjanus_streaming.so'...
janus   | JANUS Streaming plugin initialized!
janus   | Loading plugin 'libjanus_echotest.so'...
janus   | JANUS EchoTest plugin initialized!
janus   | Transport plugins folder: /usr/local/lib/janus/transports
janus   | Loading transport plugin 'libjanus_pfunix.so'...
janus   | [WARN] No Unix Sockets server started, giving up...
janus   | [WARN] The 'janus.transport.pfunix' plugin could not be initialized
janus   | Loading transport plugin 'libjanus_websockets.so'...
janus   | [WARN] libwebsockets has been built without IPv6 support, will bind to IPv4 only
janus   | libwebsockets logging: 0
janus   | Websockets server started (port 8188)...
janus   | JANUS WebSockets transport plugin initialized!
janus   | WebSockets thread started
spreed  | Starting signaling server with /config/server.conf ...
spreed  | main.go:133: Starting up version 5f716c3b6422e43ddbf1a8db9bfc93e93ce27f1e/go1.19.1 as pid 1
spreed  | main.go:142: Using a maximum of 4 CPUs
spreed  | natsclient.go:108: Connection established to nats://nats:4222 (NBNILATJEUYCH7MIID6WLH55BEJ7RV3ICZA4KD7Y34MGORFWJVO4ZJTA)
spreed  | grpc_common.go:167: WARNING: No GRPC server certificate and/or key configured, running unencrypted
spreed  | grpc_common.go:169: WARNING: No GRPC CA configured, expecting unencrypted connections
spreed  | backend_storage_static.go:72: Backend backend1 added for https://nextcloud.xxxxxxxx.net/
spreed  | hub.go:201: Using a maximum of 8 concurrent backend connections per host
spreed  | hub.go:208: Using a timeout of 10s for backend connections
spreed  | hub.go:304: Not using GeoIP database
spreed  | mcu_janus.go:294: Connected to Janus WebRTC Server 0.11.8 by Meetecho s.r.l.
spreed  | mcu_janus.go:300: Found JANUS VideoRoom plugin 0.0.9 by Meetecho s.r.l.
spreed  | mcu_janus.go:305: Data channels are supported
spreed  | mcu_janus.go:309: Full-Trickle is enabled
spreed  | mcu_janus.go:311: Maximum bandwidth 1048576 bits/sec per publishing stream
spreed  | mcu_janus.go:312: Maximum bandwidth 2097152 bits/sec per screensharing stream
janus   | Creating new session: 3367089151431510; 0x7ff1cd8f0ed0
spreed  | mcu_janus.go:318: Created Janus session 3367089151431510
janus   | Creating new handle in session 3367089151431510: 2194761477125812; 0x7ff1cd8f0ed0 0x7ff1cc38a9a0
spreed  | mcu_janus.go:325: Created Janus handle 2194761477125812
spreed  | main.go:263: Using janus MCU
spreed  | hub.go:386: Using a timeout of 10s for MCU requests
spreed  | backend_server.go:95: Using configured TURN API key
spreed  | backend_server.go:96: Using configured shared TURN secret
spreed  | backend_server.go:98: Adding "turn:coturn:3478?transport=udp" as TURN server
spreed  | backend_server.go:98: Adding "turn:coturn:3478?transport=tcp" as TURN server
spreed  | backend_server.go:105: No IPs configured for the stats endpoint, only allowing access from 127.0.0.1
spreed  | main.go:339: Listening on spreed:8080
spreed  | client.go:282: Client from 95.91.223.89 has RTT of 24 ms (24.441671ms)
spreed  | capabilities.go:151: Capabilities expired for https://nextcloud.xxxxx.net/ocs/v2.php/cloud/capabilities, updating
spreed  | capabilities.go:214: Received capabilities map[config:map[attachments:map[allowed:false] chat:map[max-length:32000 read-privacy:0] conversations:map[can-create:false] previews:map[max-gif-size:3.145728e+06] signaling:map[session-ping-limit:200]] features:[audio video chat-v2 conversation-v4 guest-signaling empty-group-room guest-display-names multi-room-users favorites last-room-activity no-ping system-messages delete-messages mention-flag in-call-flags conversation-call-flags notification-levels invite-groups-and-mails locked-one-to-one-rooms read-only-rooms listable-rooms chat-read-marker chat-unread webinary-lobby start-call-flag chat-replies circles-support force-mute sip-support chat-read-status phonebook-search raise-hand room-description rich-object-sharing temp-user-avatar-api geo-location-sharing voice-message-sharing signaling-v3 publishing-permissions clear-history direct-mention-flag notification-calls conversation-permissions rich-object-list-media rich-object-delete unified-search reactions chat-reference-id]] from https://nextcloud.xxxxxx.net/ocs/v2.php/cloud/capabilities
spreed  | hub.go:749: Register anonymous@backend1 from 95.91.0.0 in unknown-country (Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Edg/105.0.1343.53) 1GGGYqaSy7ctVsXdvCfs_AsUhA2Oa_Dg_OdSGO5IBqp8R2ZiTURKWnRRRl9Ub1JBSjkwSjhudXN4RlBtOWJieDFTa19JTFVxRzF1V3pZS2RPV0JkV0Z0bmlSdkNlSFBFRFQ5eko4ZFVxUGFqOTE3Uld5eGJOMUdJT19UNm0zVk5PQUdOR25LWm9DZEgxek5QZWZ5UW9xakJBVHpMZVc3MGYwNmFLQ2U3aVZmNVVHTHBBdEh2QUhXLXNzcS1IMkFRSFVqMGJXWm1lcUV5UXwxMzM1NjQ0NjYx (private=MTY2NDQ2NTMzMXx3OV9LN3YwdGJqdHhvWENFWmY4aFg0RzNteF80RENiNnYzNTdxbWlsYVgtanJtbG92ZHFUeTljYUVUWlpBUFppLW95QnJKbkxLODh1VXZYUFlGSi10N01YVlJOYUVROG9PUURnWTl3MV9SZ1dsWGJKXzF6N3lxcWZjYVFBV3FIdzJCcGgxV3FyVjl4aFQ5ejVXR2FSeXhJY3JsY1dTU0hfZzhNbnFrcldndWg4fH0LzkLaqGjPYUbPC3Hsmop29VpN3julwqFlcNGkqgsD)
spreed  | clientsession.go:400: Session 1GGGYqaSy7ctVsXdvCfs_AsUhA2Oa_Dg_OdSGO5IBqp8R2ZiTURKWnRRRl9Ub1JBSjkwSjhudXN4RlBtOWJieDFTa19JTFVxRzF1V3pZS2RPV0JkV0Z0bmlSdkNlSFBFRFQ5eko4ZFVxUGFqOTE3Uld5eGJOMUdJT19UNm0zVk5PQUdOR25LWm9DZEgxek5QZWZ5UW9xakJBVHpMZVc3MGYwNmFLQ2U3aVZmNVVHTHBBdEh2QUhXLXNzcS1IMkFRSFVqMGJXWm1lcUV5UXwxMzM1NjQ0NjYx joined room m55usibv with room session id R70Y8AdUk+sthnADvROxYUV92rKCLEhXf/q+KxT5J/afksAjBb8to0WbSV/VFzBPhl34XYPAWlZfNfPzpl+OS3AFKu0GXtjT1D1+BumRxveiipBQaln2UZt2pKuSVIs0XlNbvPahBu4SUUu/Va8Pk7bLysKqcnF7RGAjkCfenqcfoKV26OczxTiqiAINrzZV9EyvgGFwLF3ttNNVOGPoiE7k/cRzuOXyEEVTxaUMCZVyrVzOmggLzkhvsAQVHQb
spreed  | clientsession.go:256: Permissions of session 1GGGYqaSy7ctVsXdvCfs_AsUhA2Oa_Dg_OdSGO5IBqp8R2ZiTURKWnRRRl9Ub1JBSjkwSjhudXN4RlBtOWJieDFTa19JTFVxRzF1V3pZS2RPV0JkV0Z0bmlSdkNlSFBFRFQ5eko4ZFVxUGFqOTE3Uld5eGJOMUdJT19UNm0zVk5PQUdOR25LWm9DZEgxek5QZWZ5UW9xakJBVHpMZVc3MGYwNmFLQ2U3aVZmNVVHTHBBdEh2QUhXLXNzcS1IMkFRSFVqMGJXWm1lcUV5UXwxMzM1NjQ0NjYx changed: [publish-audio publish-video publish-screen]
spreed  | client.go:282: Client from 95.91.0.0 has RTT of 26 ms (26.967499ms)
spreed  | hub.go:745: Register user test@backend1 from 95.91.223.89 in unknown-country (Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36) 9aWF4bNUN9sE03USehbmPbjcnZ3q2RrUPcBaFFy_8Yh8NVZtYzA5VlZSbnB3Rl9ZM3BNSlVkUk0wQVpjbjNXeGhCSGxldGJXVjcxd1l3dGtQRUw2SzZXRTJ4bUdRa0JwRmh1RUJRTjdKdTBPeUpGZF9xOWpFbWdnT0NUV0VsNGV5S1U4bWxUc3RDSnE3dk5SSWREOUktUXNCcWRoT1RPZFZVLVp6WHNKMk1uejJQZ2RJT0RMSVpJNTIzV0htd2hJaW12MFhINWNhSm40bHw2NDM1NjQ0NjYx (private=MTY2NDQ2NTM0NnxWTGpQSWJvelBfRzJVSzhyZkZHTFBNR1N4UnBoRXlTQUl2Qm1QYkZpUkV2WDFTWHNqb0h2SVd6WEYtT3E0UTBISGx0RUU4NnI2WDUxc05TOWRlUTNjZndhOVpvYkZ0WngwZ2ZFYTJWSG5vYzR0R3pZbU8wMFdoQ3J0bGxSMkJHalVDVWVTVm94RG94UHhxY3J0VUZGSXMwMUkwVGlTMXZtYWJCV0RUYm5LNmVwfLXje2Q7dekrtzZ6u2fjEZcV-ivTVBT3zdtjqOo9lZUX)
spreed  | clientsession.go:400: Session 9aWF4bNUN9sE03USehbmPbjcnZ3q2RrUPcBaFFy_8Yh8NVZtYzA5VlZSbnB3Rl9ZM3BNSlVkUk0wQVpjbjNXeGhCSGxldGJXVjcxd1l3dGtQRUw2SzZXRTJ4bUdRa0JwRmh1RUJRTjdKdTBPeUpGZF9xOWpFbWdnT0NUV0VsNGV5S1U4bWxUc3RDSnE3dk5SSWREOUktUXNCcWRoT1RPZFZVLVp6WHNKMk1uejJQZ2RJT0RMSVpJNTIzV0htd2hJaW12MFhINWNhSm40bHw2NDM1NjQ0NjYx joined room m55usibv with room session id /pV05SL+YtnGO9y1AiJHWCDDcKeVLvwMtr2+3M7rk84uuPNBgAn9wxpadZZ+lDeOqXFk6y1A/0Kdy8/Os2XkQc8H0rUCOeV2OKjrKjZiDeoJha6/RUNPwJf7XxFdwTpCzDExRlkbIPcMynqtq18SFC1ZZa2Ejg/DnudKSUse773gx5q3igGHAi305vnEBt21RNWkO6iK5qYejuM9zuyKZfu9HLuB2rzjmBc230M4iVmdhZNjS7vvOlRQjMlhO5x
spreed  | clientsession.go:256: Permissions of session 9aWF4bNUN9sE03USehbmPbjcnZ3q2RrUPcBaFFy_8Yh8NVZtYzA5VlZSbnB3Rl9ZM3BNSlVkUk0wQVpjbjNXeGhCSGxldGJXVjcxd1l3dGtQRUw2SzZXRTJ4bUdRa0JwRmh1RUJRTjdKdTBPeUpGZF9xOWpFbWdnT0NUV0VsNGV5S1U4bWxUc3RDSnE3dk5SSWREOUktUXNCcWRoT1RPZFZVLVp6WHNKMk1uejJQZ2RJT0RMSVpJNTIzV0htd2hJaW12MFhINWNhSm40bHw2NDM1NjQ0NjYx changed: [publish-audio publish-video publish-screen control]
spreed  | client.go:280: Client 1GGGYqaSy7ctVsXdvCfs_AsUhA2Oa_Dg_OdSGO5IBqp8R2ZiTURKWnRRRl9Ub1JBSjkwSjhudXN4RlBtOWJieDFTa19JTFVxRzF1V3pZS2RPV0JkV0Z0bmlSdkNlSFBFRFQ5eko4ZFVxUGFqOTE3Uld5eGJOMUdJT19UNm0zVk5PQUdOR25LWm9DZEgxek5QZWZ5UW9xakJBVHpMZVc3MGYwNmFLQ2U3aVZmNVVHTHBBdEh2QUhXLXNzcS1IMkFRSFVqMGJXWm1lcUV5UXwxMzM1NjQ0NjYx has RTT of 23 ms (23.25651ms)
spreed  | hub.go:837: Unregister 9aWF4bNUN9sE03USehbmPbjcnZ3q2RrUPcBaFFy_8Yh8NVZtYzA5VlZSbnB3Rl9ZM3BNSlVkUk0wQVpjbjNXeGhCSGxldGJXVjcxd1l3dGtQRUw2SzZXRTJ4bUdRa0JwRmh1RUJRTjdKdTBPeUpGZF9xOWpFbWdnT0NUV0VsNGV5S1U4bWxUc3RDSnE3dk5SSWREOUktUXNCcWRoT1RPZFZVLVp6WHNKMk1uejJQZ2RJT0RMSVpJNTIzV0htd2hJaW12MFhINWNhSm40bHw2NDM1NjQ0NjYx (private=MTY2NDQ2NTM0NnxWTGpQSWJvelBfRzJVSzhyZkZHTFBNR1N4UnBoRXlTQUl2Qm1QYkZpUkV2WDFTWHNqb0h2SVd6WEYtT3E0UTBISGx0RUU4NnI2WDUxc05TOWRlUTNjZndhOVpvYkZ0WngwZ2ZFYTJWSG5vYzR0R3pZbU8wMFdoQ3J0bGxSMkJHalVDVWVTVm94RG94UHhxY3J0VUZGSXMwMUkwVGlTMXZtYWJCV0RUYm5LNmVwfLXje2Q7dekrtzZ6u2fjEZcV-ivTVBT3zdtjqOo9lZUX)
spreed  | clientsession.go:457: Removed room session /pV05SL+YtnGO9y1AiJHWCDDcKeVLvwMtr2+3M7rk84uuPNBgAn9wxpadZZ+lDeOqXFk6y1A/0Kdy8/Os2XkQc8H0rUCOeV2OKjrKjZiDeoJha6/RUNPwJf7XxFdwTpCzDExRlkbIPcMynqtq18SFC1ZZa2Ejg/DnudKSUse773gx5q3igGHAi305vnEBt21RNWkO6iK5qYejuM9zuyKZfu9HLuB2rzjmBc230M4iVmdhZNjS7vvOlRQjMlhO5x: map[room:map[permissions:[publish-audio publish-video publish-screen control] properties:map[active-since:map[date:2022-09-29 15:16:42.000000 timezone:UTC timezone_type:3] description: listable:0 lobby-state:0 lobby-timer:<nil> name:ads read-only:0 sip-enabled:0 type:3] roomid:m55usibv version:1.0] type:room]
spreed  | client.go:280: Client 1GGGYqaSy7ctVsXdvCfs_AsUhA2Oa_Dg_OdSGO5IBqp8R2ZiTURKWnRRRl9Ub1JBSjkwSjhudXN4RlBtOWJieDFTa19JTFVxRzF1V3pZS2RPV0JkV0Z0bmlSdkNlSFBFRFQ5eko4ZFVxUGFqOTE3Uld5eGJOMUdJT19UNm0zVk5PQUdOR25LWm9DZEgxek5QZWZ5UW9xakJBVHpMZVc3MGYwNmFLQ2U3aVZmNVVHTHBBdEh2QUhXLXNzcS1IMkFRSFVqMGJXWm1lcUV5UXwxMzM1NjQ0NjYx has RTT of 23 ms (23.291194ms)
spreed  | client.go:282: Client from 95.91.0.0 has RTT of 23 ms (23.394148ms)
spreed  | hub.go:745: Register user test@backend1 from 95.91.0.0 in unknown-country (Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36) GIyHu62AE8T0E-GHZAlegBSllT3ZtoCzGi56nc_hvG98ZHhNWVlpS3JrYVZ5bE9JdWtJT1FKaEJHUm1FQ2toeWNNeS1PQTAxZk1RUDZ4aE5JSldFa214WkxrV0JlVDE3bW1JV2tJMDY2dmRSODZ2NUQtWHh6M1A2TUtCc2NqY3l5b1hobzVCZVpzcVZYbkkxSDRwSW9zdS04YTlMeEMwMGIwaXJXTWFKTW9Ra1NFLUlTanJ5WFFKTHBaX0NiQmFqMTM2OVBJU0ZPZUdZaHwxNjQ1NjQ0NjYx (private=MTY2NDQ2NTQ2MXxmaGFZeEhLSHAxcS1YUjQtNjFzMkVtTGQzT0doSlVMSzlGSmlIQkpqazIzLWVkVG9IX2hEdWFMSzFWZElxODQwek9wN05zMWFmZmxVeTVYZmVpc3NBdmc1NVhhMnJ3Q0pPWFhlTDdkQTBBVTVpLV8yMVhTbHlfXzBNeHd0S001Q09KWE5ldVF3b2wwZjVBLUdsdjZsYmN5bXlacnRHQUMxeWNHaGsySkhZano3fHwRa0QF-HGkbWTXjFflywBIQAP26aB2yPEoRXUCjYkh)
spreed  | clientsession.go:400: Session GIyHu62AE8T0E-GHZAlegBSllT3ZtoCzGi56nc_hvG98ZHhNWVlpS3JrYVZ5bE9JdWtJT1FKaEJHUm1FQ2toeWNNeS1PQTAxZk1RUDZ4aE5JSldFa214WkxrV0JlVDE3bW1JV2tJMDY2dmRSODZ2NUQtWHh6M1A2TUtCc2NqY3l5b1hobzVCZVpzcVZYbkkxSDRwSW9zdS04YTlMeEMwMGIwaXJXTWFKTW9Ra1NFLUlTanJ5WFFKTHBaX0NiQmFqMTM2OVBJU0ZPZUdZaHwxNjQ1NjQ0NjYx joined room bi949ydu with room session id R+Ln4Jj6QomRahAVzX6OAh9drpd8wVVYI76qV1S3fVAU4pGTQH8QmqpYeX6ZEeY55Bw++ZdEvABSan0tnEWh53AJd62cRhu8Ysd8mXKP/0EMk/XXdJyuskPirWsM8/WvD2gcojNhCMDiqLjBOOdVz5D8s0bb6Ycn5PD1xNS1jaqKSFMcWFu6lUdbYsOilH0/MPGTXqFAjFjhYX5BwqFpfHmLMrXay4WvacjfKeIRIpniN1+nzC6L/2SBsf2AsnZ
spreed  | clientsession.go:256: Permissions of session GIyHu62AE8T0E-GHZAlegBSllT3ZtoCzGi56nc_hvG98ZHhNWVlpS3JrYVZ5bE9JdWtJT1FKaEJHUm1FQ2toeWNNeS1PQTAxZk1RUDZ4aE5JSldFa214WkxrV0JlVDE3bW1JV2tJMDY2dmRSODZ2NUQtWHh6M1A2TUtCc2NqY3l5b1hobzVCZVpzcVZYbkkxSDRwSW9zdS04YTlMeEMwMGIwaXJXTWFKTW9Ra1NFLUlTanJ5WFFKTHBaX0NiQmFqMTM2OVBJU0ZPZUdZaHwxNjQ1NjQ0NjYx changed: [publish-audio publish-video publish-screen control]
janus   | Creating new handle in session 3367089151431510: 6514169392355208; 0x7ff1cd8f0ed0 0x7ff1cc38ab50
spreed  | mcu_janus.go:729: Attached video as publisher 6514169392355208 to plugin janus.plugin.videoroom in session 3367089151431510
spreed  | mcu_janus.go:767: Created room 4268089846352352 {janus.plugin.videoroom map[permanent:false room:4268089846352352 videoroom:created]}
spreed  | mcu_janus.go:825: Publisher GIyHu62AE8T0E-GHZAlegBSllT3ZtoCzGi56nc_hvG98ZHhNWVlpS3JrYVZ5bE9JdWtJT1FKaEJHUm1FQ2toeWNNeS1PQTAxZk1RUDZ4aE5JSldFa214WkxrV0JlVDE3bW1JV2tJMDY2dmRSODZ2NUQtWHh6M1A2TUtCc2NqY3l5b1hobzVCZVpzcVZYbkkxSDRwSW9zdS04YTlMeEMwMGIwaXJXTWFKTW9Ra1NFLUlTanJ5WFFKTHBaX0NiQmFqMTM2OVBJU0ZPZUdZaHwxNjQ1NjQ0NjYx is using handle 6514169392355208
spreed  | clientsession.go:876: Publishing video as 1 for session GIyHu62AE8T0E-GHZAlegBSllT3ZtoCzGi56nc_hvG98ZHhNWVlpS3JrYVZ5bE9JdWtJT1FKaEJHUm1FQ2toeWNNeS1PQTAxZk1RUDZ4aE5JSldFa214WkxrV0JlVDE3bW1JV2tJMDY2dmRSODZ2NUQtWHh6M1A2TUtCc2NqY3l5b1hobzVCZVpzcVZYbkkxSDRwSW9zdS04YTlMeEMwMGIwaXJXTWFKTW9Ra1NFLUlTanJ5WFFKTHBaX0NiQmFqMTM2OVBJU0ZPZUdZaHwxNjQ1NjQ0NjYx
janus   | [6514169392355208] Creating ICE agent (ICE Full mode, controlled)
janus   | [6514169392355208] The DTLS handshake has been completed
janus   | [janus.plugin.videoroom-0x7ff1cd8a1850] WebRTC media is now available
spreed  | mcu_janus.go:864: Publisher 6514169392355208 received connected
janus   | [janus.plugin.videoroom-0x7ff1cd8a1850] Data channel available
spreed  | hub.go:837: Unregister 1GGGYqaSy7ctVsXdvCfs_AsUhA2Oa_Dg_OdSGO5IBqp8R2ZiTURKWnRRRl9Ub1JBSjkwSjhudXN4RlBtOWJieDFTa19JTFVxRzF1V3pZS2RPV0JkV0Z0bmlSdkNlSFBFRFQ5eko4ZFVxUGFqOTE3Uld5eGJOMUdJT19UNm0zVk5PQUdOR25LWm9DZEgxek5QZWZ5UW9xakJBVHpMZVc3MGYwNmFLQ2U3aVZmNVVHTHBBdEh2QUhXLXNzcS1IMkFRSFVqMGJXWm1lcUV5UXwxMzM1NjQ0NjYx (private=MTY2NDQ2NTMzMXx3OV9LN3YwdGJqdHhvWENFWmY4aFg0RzNteF80RENiNnYzNTdxbWlsYVgtanJtbG92ZHFUeTljYUVUWlpBUFppLW95QnJKbkxLODh1VXZYUFlGSi10N01YVlJOYUVROG9PUURnWTl3MV9SZ1dsWGJKXzF6N3lxcWZjYVFBV3FIdzJCcGgxV3FyVjl4aFQ5ejVXR2FSeXhJY3JsY1dTU0hfZzhNbnFrcldndWg4fH0LzkLaqGjPYUbPC3Hsmop29VpN3julwqFlcNGkqgsD)
janus   | [WARN] [6514169392355208] Didn't receive video #0 for more than a second...
spreed  | clientsession.go:457: Removed room session R70Y8AdUk+sthnADvROxYUV92rKCLEhXf/q+KxT5J/afksAjBb8to0WbSV/VFzBPhl34XYPAWlZfNfPzpl+OS3AFKu0GXtjT1D1+BumRxveiipBQaln2UZt2pKuSVIs0XlNbvPahBu4SUUu/Va8Pk7bLysKqcnF7RGAjkCfenqcfoKV26OczxTiqiAINrzZV9EyvgGFwLF3ttNNVOGPoiE7k/cRzuOXyEEVTxaUMCZVyrVzOmggLzkhvsAQVHQb: map[room:map[permissions:[publish-audio publish-video publish-screen] properties:map[active-since:<nil> description: listable:0 lobby-state:0 lobby-timer:<nil> name:Private conversation read-only:0 sip-enabled:0 type:3] roomid:m55usibv version:1.0] type:room]
spreed  | client.go:282: Client from 95.91.0.0 has RTT of 29 ms (29.234994ms)
spreed  | hub.go:749: Register anonymous@backend1 from 95.91.0.0 in unknown-country (Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/105.0.0.0 Safari/537.36 Edg/105.0.1343.53) MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx (private=MTY2NDQ2NTQ3MnxqTFZfcWRkVVZNaVZZZWY2eUpJcV82QXBUYWdFaUU0R3JqY05semU1c0h2ODJXZExwSlpOXzJScjRXVlFaTjVsYmRLcTZ6V2FrRXdacXhzUTVnSXJLYjJqcUpBS2c5TlZ6WkdoRHU1cnJWbFpJU2dVUjY1UHMtS2RTSVhFa2xwX0dyOEkzU0pDeEx0NTBvMy1JenBlbFBKSjRJNG10a3ZxaW5QZXp6MGdsNDRTfADK7ripkM45HwaHANgw9TsI_x1i9ExbIJAGAgs8_EDp)
spreed  | clientsession.go:400: Session MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx joined room bi949ydu with room session id cCdq+Z0Nt0HGUwr/+C2UZ9ZWui8tezH1+uT0gF/A09h14FkXWtwMQFVm5ek1eHtvsLj7r3Py9X96KE3fC/Yrv11qnGJkUFt3VTbrDPmd59n0G18/9xMrTlvYUSjc0v0y/mukYpHQHM0KwvLlIEm50qn167cAqOKWPf7lcyA+2gFJMiDwJcIoopyhEFYIr3LCLIojp5IzIVveCwMKoW7mACDN679zgJl1QDtdQDdKXB6UeArLtRg4pQ2C0TmJ0YZ
spreed  | clientsession.go:256: Permissions of session MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx changed: [publish-audio publish-video publish-screen]
janus   | Creating new handle in session 3367089151431510: 8965206604290618; 0x7ff1cd8f0ed0 0x7ff1cc2ee670
spreed  | mcu_janus.go:729: Attached video as publisher 8965206604290618 to plugin janus.plugin.videoroom in session 3367089151431510
spreed  | mcu_janus.go:767: Created room 5565699418641624 {janus.plugin.videoroom map[permanent:false room:5565699418641624 videoroom:created]}
spreed  | mcu_janus.go:825: Publisher MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx is using handle 8965206604290618
spreed  | clientsession.go:876: Publishing video as 2 for session MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx
janus   | [8965206604290618] Creating ICE agent (ICE Full mode, controlled)
janus   | [8965206604290618] The DTLS handshake has been completed
janus   | [janus.plugin.videoroom-0x7ff1cc2fb550] WebRTC media is now available
spreed  | mcu_janus.go:864: Publisher 8965206604290618 received connected
janus   | [janus.plugin.videoroom-0x7ff1cc2fb550] Data channel available
spreed  | client.go:280: Client GIyHu62AE8T0E-GHZAlegBSllT3ZtoCzGi56nc_hvG98ZHhNWVlpS3JrYVZ5bE9JdWtJT1FKaEJHUm1FQ2toeWNNeS1PQTAxZk1RUDZ4aE5JSldFa214WkxrV0JlVDE3bW1JV2tJMDY2dmRSODZ2NUQtWHh6M1A2TUtCc2NqY3l5b1hobzVCZVpzcVZYbkkxSDRwSW9zdS04YTlMeEMwMGIwaXJXTWFKTW9Ra1NFLUlTanJ5WFFKTHBaX0NiQmFqMTM2OVBJU0ZPZUdZaHwxNjQ1NjQ0NjYx has RTT of 22 ms (22.001322ms)
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f859c004fb0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f859c004fb0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f8598005ab0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f8598005ab0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f8590004ea0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f8590004ea0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f85a002fdd0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f85a002fdd0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f85a0039ad0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f85a0039ad0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f859c004fb0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f859c004fb0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f859003f4a0, st=6, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f859003f4a0, st=6, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f85a002a1e0, st=17, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f85a002a1e0, st=17, sat=1
coturn  | 198: : !!! ioa_socket_tobeclosed: magic is wrong on the socket: 0x7f859c005530, st=17, sat=1
coturn  | 198: : !!! close_ioa_socket wrong magic on socket: 0x7f859c005530, st=17, sat=1
spreed  | client.go:280: Client MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx has RTT of 22 ms (22.727649ms)
fancycode commented 2 years ago

Potential causes:

Some clients could publish successfully, for example this one:

janus   | Creating new handle in session 3367089151431510: 8965206604290618; 0x7ff1cd8f0ed0 0x7ff1cc2ee670
spreed  | mcu_janus.go:729: Attached video as publisher 8965206604290618 to plugin janus.plugin.videoroom in session 3367089151431510
spreed  | mcu_janus.go:767: Created room 5565699418641624 {janus.plugin.videoroom map[permanent:false room:5565699418641624 videoroom:created]}
spreed  | mcu_janus.go:825: Publisher MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx is using handle 8965206604290618
spreed  | clientsession.go:876: Publishing video as 2 for session MuigdFDlMzfUsM3uTBeU4EwJ_L5UflwIE4YJuL_b02d8TmZkUDd4YUkzM2dNQXlhMGFUTDNlM0JfU3RvdkdyVWdsSkNWSVpwMEZ1VnV3b25sclBKak92NVVkc3RmSEdRSi1kLUpOTFlxXzVQOUNBMjRTQ1RPd3hneEhmNXFCUk9CWGk2UHNpYmdHN2o0OUlkeV9uVVRQMEJoN05yVEFBUW1yamN1anV4OVduX0Juc0VVeEQwRy02US1Gbi1oWXdMRXBOMHNOb2ljdXg1b3wyNzQ1NjQ0NjYx
janus   | [8965206604290618] Creating ICE agent (ICE Full mode, controlled)
janus   | [8965206604290618] The DTLS handshake has been completed
janus   | [janus.plugin.videoroom-0x7ff1cc2fb550] WebRTC media is now available
spreed  | mcu_janus.go:864: Publisher 8965206604290618 received connected
janus   | [janus.plugin.videoroom-0x7ff1cc2fb550] Data channel available

In any case this looks like a coturn configuration / clientside connection problem and is most likely not related to the signaling server.

fancycode commented 1 year ago

Another thing: Janus is only running on a private address:

janus   | [WARN] Janus is deployed on a private address (172.18.0.5) but you didn't specify any STUN server! Expect trouble if this is supposed to work over the internet and not just in a LAN...

The Janus server should be directly reachable by clients, i.e. either run on a public IP or behind a 1-1 firewall.

Closing as this seems to be a networking / firewall / configuration issue. Feel free to reopen with more details if you think this is a problem of the signaling server.