[jitsi-dev] [jibri] How to debug missing jibri-recording-status tag in Jibri's presence iq?


#1

I tried to play to jibri but always get the "The live streaming service is currently unavailable. Please try again later." when I clicked the record button.

Further reading the related source codes , I found out that the presence message sent by jibri does not have the jibri-recording-status tag . ( should it ? )

How to debug this case please ?

================== jibri running log =====================
~/jibri-xmpp-client $ ./run.sh
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ python3 app.py -d
2017-04-10 22:40:43,845 DEBUG Client Options: {'my_jitsi_meet_ip_addr': {'boshdomain_prefix': 'recorder.', 'selenium_xmpp_prefix': 'recorder.', 'selenium_xmpp_username': 'recorder', 'roompass': '', 'room': '123@conference.my_jitsi_meet_ip_addr', 'usage_timeout': 0, 'jid': 'jibri@auth.my_jitsi_meet_ip_addr', 'jid_username': 'jibri', 'roomname': '123', 'password': 'jibri', 'boshdomain': 'recorder.my_jitsi_meet_ip_addr', 'mucserver_prefix': 'conference.', 'url': 'https://my_jitsi_meet_ip_addr/%ROOM%', 'jidserver_prefix': 'auth.', 'selenium_xmpp_login': 'recorder@recorder.my_jitsi_meet_ip_addr', 'xmpp_domain': 'my_jitsi_meet_ip_addr', 'nick': 'jibri-37416628236289884', 'selenium_xmpp_password': 'recorderpass'}}
2017-04-10 22:40:43,845 DEBUG Starting up client thread for host: my_jitsi_meet_ip_addr
2017-04-10 22:40:43,846 INFO Creating a client for hostname: my_jitsi_meet_ip_addr with options: {'boshdomain_prefix': 'recorder.', 'selenium_xmpp_prefix': 'recorder.', 'selenium_xmpp_username': 'recorder', 'roompass': '', 'room': '123@conference.my_jitsi_meet_ip_addr', 'usage_timeout': 0, 'jid': 'jibri@auth.my_jitsi_meet_ip_addr', 'jid_username': 'jibri', 'roomname': '123', 'password': 'jibri', 'boshdomain': 'recorder.my_jitsi_meet_ip_addr', 'mucserver_prefix': 'conference.', 'url': 'https://my_jitsi_meet_ip_addr/%ROOM%', 'jidserver_prefix': 'auth.', 'selenium_xmpp_login': 'recorder@recorder.my_jitsi_meet_ip_addr', 'xmpp_domain': 'my_jitsi_meet_ip_addr', 'nick': 'jibri-37416628236289884', 'selenium_xmpp_password': 'recorderpass'}
2017-04-10 22:40:43,847 DEBUG Loaded Plugin: RFC 6120: Stream Feature: STARTTLS
2017-04-10 22:40:43,848 DEBUG Loaded Plugin: RFC 6120: Stream Feature: Resource Binding
2017-04-10 22:40:43,853 DEBUG Loaded Plugin: RFC 3920: Stream Feature: Start Session
2017-04-10 22:40:43,854 DEBUG Loaded Plugin: RFC 6121: Stream Feature: Roster Versioning
2017-04-10 22:40:43,854 DEBUG Loaded Plugin: RFC 6121: Stream Feature: Subscription Pre-Approval
2017-04-10 22:40:43,857 DEBUG Loaded Plugin: RFC 6120: Stream Feature: SASL
2017-04-10 22:40:43,857 INFO jibri_watcher starting up...
2017-04-10 22:40:43,857 WARNING jid property deprecated. Use boundjid.bare
2017-04-10 22:40:43,859 DEBUG Loaded Plugin: XEP-0030: Service Discovery
2017-04-10 22:40:43,860 DEBUG Loaded Plugin: XEP-0004: Data Forms
2017-04-10 22:40:43,861 DEBUG Loaded Plugin: XEP-0045: Multi-User Chat
2017-04-10 22:40:43,861 DEBUG Connecting client for hostname: my_jitsi_meet_ip_addr port 5222
2017-04-10 22:40:43,861 DEBUG Connecting to my_jitsi_meet_ip_addr:5222
2017-04-10 22:40:44,024 DEBUG Event triggered: connected
2017-04-10 22:40:44,024 DEBUG ==== TRANSITION disconnected -> connected
2017-04-10 22:40:44,025 DEBUG Starting HANDLER THREAD
2017-04-10 22:40:44,025 DEBUG Loading event runner
2017-04-10 22:40:44,025 DEBUG SEND (IMMED): <stream:stream to='auth.my_jitsi_meet_ip_addr' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' xml:lang='en' version='1.0'>
2017-04-10 22:40:44,189 DEBUG RECV: <stream:stream version="1.0" id="dab804ca-fee3-4817-a5ed-73c1a853fe40" from="auth.my_jitsi_meet_ip_addr" xml:lang="en">
2017-04-10 22:40:44,189 DEBUG RECV: <stream:features xmlns="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-1</mechanism><mechanism>DIGEST-MD5</mechanism></mechanisms><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls" /></stream:features>
2017-04-10 22:40:44,190 DEBUG SEND (IMMED): <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls" />
2017-04-10 22:40:44,353 DEBUG RECV: <proceed xmlns="urn:ietf:params:xml:ns:xmpp-tls" />
2017-04-10 22:40:44,354 DEBUG Starting TLS
2017-04-10 22:40:44,354 INFO Negotiating TLS
2017-04-10 22:40:44,354 INFO Using SSL version: TLS 1.0
2017-04-10 22:40:44,707 DEBUG CERT: -----BEGIN CERTIFICATE-----
MIIFrTCCA5WgAwIBAgIJANajvT8iEurvMA0GCSqGSIb3DQEBCwUAMG0xFDASBgNV
BAoMC2xvY2FsZG9tYWluMQ8wDQYDVQQLDAZ1YnVudHUxFzAVBgNVBAMMDjExOC4y
NDQuMjE2LjIwMSswKQYJKoZIhvcNAQkBFhx3ZWJtYXN0ZXJAdWJ1bnR1LmxvY2Fs
ZG9tYWluMB4XDTE3MDQwMzE2MTcxMVoXDTE4MDQwMzE2MTcxMVowbTEUMBIGA1UE
CgwLbG9jYWxkb21haW4xDzANBgNVBAsMBnVidW50dTEXMBUGA1UEAwwOMTE4LjI0
NC4yMTYuMjAxKzApBgkqhkiG9w0BCQEWHHdlYm1hc3RlckB1YnVudHUubG9jYWxk
b21haW4wggIiMA0GCSqGSIb3DQEBAQUAA4ICDwAwggIKAoICAQC6bnVC3NPjZSAP
tPVyMbsgleMQwaWXoFO6WALjldXWpWk4BthBxmeBNbtDo+yGvwKdJttUCG/B4sq7
N/oreWbjGRLWQiTU1BA+A2erTKGKf5i/iO4INjj1wlUOxaOFTv7Ax9KzCiEG97AU
qcKLN6DmtsoNQOBdzaISkMJlrXaGKhcJ4X+o0HHBWv/qgbyj+t31IDcHXml7uUip
cpn8ToqNH/+9jXYecPclLWEeQZCsL9BOqa8Z43Q7S2xuEKUqzf7bqPErdN7z/zdF
BDnOQ4gj35O/oNCaw+HJLvw12fm5xf36bEgvXHf2JV+VPal1dG/l5DCQqB8K6W2j
Xx1SSquoAJz8jmqUatoAnTrcFY9ARPRW1r9amlv/6XiDlRKgi7Oz6VFcZ+E8HpTv
c8kcxNFileuBZZfDOW6bmYWTUOzEADevxdWIo3GaaJ1qDxUGzUPd9SOjAGxY6+Qc
BKgtLjTUtqAjS9RzOgRuhYd+wieaZt1YRQcrOcocTDLKcPg+IW+VsseYY5k0+bJQ
F9HV47RhKh94OBUsBR8axNNm6Gas1Hyk9Zdy1GN+Oumi69KbJeoTiVfCASnW8x5j
GgVmhlTGp1feAaRwsNBWcTwf81+FrlKg2Pkvhl2hcTU2LZvjId6bhBO2m6xY2D8O
nM8gPqQehmkJM/bVJfw8IiqnjX6InQIDAQABo1AwTjAdBgNVHQ4EFgQU/4bFY5u6
zqwjnBCSe4K8pyrT6R4wHwYDVR0jBBgwFoAU/4bFY5u6zqwjnBCSe4K8pyrT6R4w
DAYDVR0TBAUwAwEB/zANBgkqhkiG9w0BAQsFAAOCAgEAP3LUkNjtcuFUdSryfOXQ
2E8HDNK+QgWfraLDsFrBPE16MSaGFbKgZ6QU95eC1UwFHoaEwukDGdgE5yRM7vOH
1TJtLHmfVzL7cfZjtyU9I07J2AqOtGf//MnpK5NVYB7eZ7dp4UbUaUAr4/AWU2N3
TWUvCvuNJbV2fSBWwakwjdpfH1IaH/yP9Uyrwto/ghEelumfH5tXbBbIZF6DSEzt
1jpMskReKobzXzE6K/lLTA13CNCOuGRvElCwkb5+I9y5ax5xfLfYu5MgEP31lBLz
RUSO1/syaegA25qp4pIitX/+JcN3UnoO0+GAaafsw3zZgBYJecGMTMyNqWBHAHpO
T/KuKmRWxnUgzq5t2c9iwrUYvL7KlqZM8jtU/0CCdQTlUJL+54DE/lSdoU1jqenh
cGIAnPeSztTeorHUYDPC5yPc6OtRRGf7IvjD6ex+ZrBd/jg5slDwLnv/KCa/F//Q
s7IWYiA2s8YZVwbFFB2Jh3QRNFmgkOfXmYH+tMwPyoHCNYj6Asf6KhWVXupsBY+L
pPTN+uSSnc+UZ4fJRPP52ovarXMyO/6CmvVkktwvZ6J3z7r//7q/lgfKzLzUbQMr
4aAaxFFSmBtqoilS3mgRowfy8fXzxhMSwGLRb8rz7jQDUInr8r5gA6+Q0s4TgO41
dcqdt53AhMxDFqDSrXe1zPo=
-----END CERTIFICATE-----

2017-04-10 22:40:44,708 DEBUG Event triggered: ssl_cert
2017-04-10 22:40:44,708 WARNING Could not find pyasn1 and pyasn1_modules. SSL certificate COULD NOT BE VERIFIED.
2017-04-10 22:40:44,709 DEBUG SEND (IMMED): <stream:stream to='auth.my_jitsi_meet_ip_addr' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' xml:lang='en' version='1.0'>
2017-04-10 22:40:44,874 DEBUG RECV: <stream:stream version="1.0" id="3d24e129-a3b3-4dc2-b7e8-4eb226d24ce0" from="auth.my_jitsi_meet_ip_addr" xml:lang="en">
2017-04-10 22:40:44,875 DEBUG RECV: <stream:features xmlns="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
2017-04-10 22:40:44,875 DEBUG SEND (IMMED): <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">eSwsbj1qaWJyaSxyPTQwNzU3MjgwOTE0NTI0NDM=</auth>
2017-04-10 22:40:45,047 DEBUG RECV: <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00MDc1NzI4MDkxNDUyNDQzZjNhODVhZWMtYTIyYi00YzNjLWEyNDEtY2VkNTJmNzI5M2IwLHM9T1dZMFpEZGxNMkV0WW1FNVl5MDBZams0TFdFd1lXTXRZelJqWlRFek56QXhNek5rLGk9NDA5Ng==</challenge>
2017-04-10 22:40:45,191 DEBUG SEND (IMMED): <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1lU3dzLHI9NDA3NTcyODA5MTQ1MjQ0M2YzYTg1YWVjLWEyMmItNGMzYy1hMjQxLWNlZDUyZjcyOTNiMCxwPTFDSFJ4aENZNVNOb3owalpUSWNMT3FBekxmUT0=</response>
2017-04-10 22:40:45,355 DEBUG RECV: <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OWDJEbkFaWnBmWGRxR0VrNHErMERqY202c009</success>
2017-04-10 22:40:45,356 DEBUG Event triggered: auth_success
2017-04-10 22:40:45,356 DEBUG SEND (IMMED): <stream:stream to='auth.my_jitsi_meet_ip_addr' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' xml:lang='en' version='1.0'>
2017-04-10 22:40:45,520 DEBUG RECV: <stream:stream version="1.0" id="668e8b14-92fb-4048-9f81-3d9df589f5a5" from="auth.my_jitsi_meet_ip_addr" xml:lang="en">
2017-04-10 22:40:45,520 DEBUG RECV: <stream:features xmlns="http://etherx.jabber.org/streams"><c xmlns="http://jabber.org/protocol/caps" node="http://prosody.im" hash="sha-1" ver="ZBWApSGFMsTZkuVThHtyU5xv1Mk=" /><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><required /></bind><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional /></session><ver xmlns="urn:xmpp:features:rosterver" /></stream:features>
2017-04-10 22:40:45,521 DEBUG Enabling roster versioning.
2017-04-10 22:40:45,521 DEBUG Requesting resource:
2017-04-10 22:40:45,521 DEBUG SEND (IMMED): <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-1" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind" /></iq>
2017-04-10 22:40:45,685 DEBUG RECV: <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-1" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb</jid></bind></iq>
2017-04-10 22:40:45,686 DEBUG Event triggered: session_bind
2017-04-10 22:40:45,686 INFO JID set to: jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb
2017-04-10 22:40:45,686 DEBUG SEND (IMMED): <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-2" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session" /></iq>

···

2017-04-10 22:40:45,850 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-2" type="result" />
2017-04-10 22:40:45,851 DEBUG Established Session
2017-04-10 22:40:45,851 DEBUG Event triggered: session_start
2017-04-10 22:40:45,851 DEBUG Finished processing stream features.
2017-04-10 22:40:45,851 DEBUG Event triggered: stream_negotiated
2017-04-10 22:40:45,851 WARNING Could not find pyasn1 and pyasn1_modules. SSL certificate expiration COULD NOT BE VERIFIED.
2017-04-10 22:40:45,851 INFO Starting up client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>, connecting to room 123@conference.my_jitsi_meet_ip_addr as jibri-37416628236289884
2017-04-10 22:40:45,851 DEBUG Getting roster for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:45,852 DEBUG SEND: <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-3" type="get"><query xmlns="jabber:iq:roster" ver="" /></iq>
2017-04-10 22:40:46,016 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-3" type="result"><query xmlns="jabber:iq:roster" ver="1" /></iq>
2017-04-10 22:40:46,016 DEBUG Event triggered: roster_update
2017-04-10 22:40:46,016 DEBUG Sending initial presence for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,016 DEBUG Event triggered: sent_presence
2017-04-10 22:40:46,017 DEBUG Attempting to join MUC now for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,017 DEBUG SEND: <presence xml:lang="en" />
2017-04-10 22:40:46,017 DEBUG SEND: <presence to="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><x xmlns="http://jabber.org/protocol/muc"><history maxchars="0" /></x></presence>
2017-04-10 22:40:46,017 DEBUG Sending initial idle presence for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,018 INFO sending presence: <presence to="123@conference.my_jitsi_meet_ip_addr" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /></presence>
2017-04-10 22:40:46,018 DEBUG Adding asyncio queue check to the scheduler for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,018 DEBUG SEND: <presence to="123@conference.my_jitsi_meet_ip_addr" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /></presence>
2017-04-10 22:40:46,018 INFO Started up client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,182 DEBUG RECV: <presence from="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" xml:lang="en" />
2017-04-10 22:40:46,182 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf" xml:lang="en"><delay xmlns="urn:xmpp:delay" stamp="2017-04-11T02:39:13Z" from="auth.my_jitsi_meet_ip_addr" /></presence>
2017-04-10 22:40:46,182 DEBUG Event triggered: presence
2017-04-10 22:40:46,183 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,183 DEBUG Event triggered: presence
2017-04-10 22:40:46,183 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,184 DEBUG Event triggered: got_online
2017-04-10 22:40:46,184 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,184 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,362 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="mrOHm-75" from="123@conference.my_jitsi_meet_ip_addr/focus"><etherpad xmlns="http://jitsi.org/jitmeet/etherpad">f20ffcac78e6476f846bd7350962bd01</etherpad><jibri-recording-status xmlns="http://jitsi.org/protocol/jibri" status="undefined" /><versions xmlns="http://jitsi.org/jitmeet"><component name="xmpp">Prosody(0.9.1,Linux)</component><component name="focus">JiCoFo(1.0.1.0-320,Linux)</component><component name="videobridge">JVB(0.1.879,Linux)</component></versions><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org" hash="sha-1" ver="MPbX4TmPVk4oe6hiyStGMdG6mmU=" ext="" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="focus@auth.my_jitsi_meet_ip_addr/focus23033023607" affiliation="owner" role="moderator" /></x></presence>
2017-04-10 22:40:46,362 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/308018bc"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.133 Safari/537.36</user-agent><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video /></devices><avatar-id>b7f4550102b5e333e8c1dab2e21cf3fd</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="308018bc-2626-4313-89d0-98dc10adc311@my_jitsi_meet_ip_addr/38c80ac4-f2f0-40cd-b96a-bf0d7469c747" affiliation="none" role="participant" /></x></presence>
2017-04-10 22:40:46,363 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/1e078668"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.98 Safari/537.36</user-agent><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video>true</video></devices><avatar-id>286b5cf2c73af7539ab005f714ad9781</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><videoType xmlns="http://jitsi.org/jitmeet/video">camera</videoType><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="1e078668-e488-4391-a383-e78c38817ea2@my_jitsi_meet_ip_addr/5b47c0ec-5e5c-498a-ac66-8b2aafa37901" affiliation="owner" role="moderator" /></x></presence>
2017-04-10 22:40:46,363 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-23130252618767377" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf" affiliation="none" role="participant" /></x></presence>
2017-04-10 22:40:46,364 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" affiliation="none" role="participant" /><status code="110" /><status code="100" /></x></presence>
2017-04-10 22:40:46,364 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" affiliation="none" role="participant" /><status code="110" /></x></presence>
2017-04-10 22:40:46,365 DEBUG Event triggered: presence
2017-04-10 22:40:46,365 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,365 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/focus : {'jid': focus@auth.my_jitsi_meet_ip_addr/focus23033023607, 'affiliation': 'owner', 'show': '', 'nick': 'focus', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': '', 'status': '', 'role': 'moderator'}
2017-04-10 22:40:46,366 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,366 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,366 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,366 DEBUG Event triggered: presence
2017-04-10 22:40:46,366 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,367 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/308018bc : {'jid': 308018bc-2626-4313-89d0-98dc10adc311@my_jitsi_meet_ip_addr/38c80ac4-f2f0-40cd-b96a-bf0d7469c747, 'affiliation': 'none', 'show': '', 'nick': '308018bc', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': '', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,367 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,367 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,367 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,367 DEBUG Event triggered: presence
2017-04-10 22:40:46,367 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,368 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/1e078668 : {'jid': 1e078668-e488-4391-a383-e78c38817ea2@my_jitsi_meet_ip_addr/5b47c0ec-5e5c-498a-ac66-8b2aafa37901, 'affiliation': 'owner', 'show': '', 'nick': '1e078668', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': '', 'status': '', 'role': 'moderator'}
2017-04-10 22:40:46,368 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,368 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,368 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,369 DEBUG Event triggered: presence
2017-04-10 22:40:46,369 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,370 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/jibri-23130252618767377 : {'jid': jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf, 'affiliation': 'none', 'show': '', 'nick': 'jibri-23130252618767377', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': 'en', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,370 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,370 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,370 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,370 DEBUG Event triggered: presence
2017-04-10 22:40:46,370 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,371 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884 : {'jid': jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb, 'affiliation': 'none', 'show': '', 'nick': 'jibri-37416628236289884', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': 'en', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,371 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,371 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,371 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,371 DEBUG Event triggered: presence
2017-04-10 22:40:46,371 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,371 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884 : {'jid': jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb, 'affiliation': 'none', 'show': '', 'nick': 'jibri-37416628236289884', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': 'en', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,371 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,372 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,372 DEBUG Event triggered: got_online
2017-04-10 22:40:46,372 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,372 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="mrOHm-75" from="123@conference.my_jitsi_meet_ip_addr/focus"><etherpad xmlns="http://jitsi.org/jitmeet/etherpad">f20ffcac78e6476f846bd7350962bd01</etherpad><jibri-recording-status xmlns="http://jitsi.org/protocol/jibri" status="undefined" /><versions xmlns="http://jitsi.org/jitmeet"><component name="xmpp">Prosody(0.9.1,Linux)</component><component name="focus">JiCoFo(1.0.1.0-320,Linux)</component><component name="videobridge">JVB(0.1.879,Linux)</component></versions><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org" hash="sha-1" ver="MPbX4TmPVk4oe6hiyStGMdG6mmU=" ext="" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="focus@auth.my_jitsi_meet_ip_addr/focus23033023607" affiliation="owner" role="moderator" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,372 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,373 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/308018bc"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.133 Safari/537.36</user-agent><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video /></devices><avatar-id>b7f4550102b5e333e8c1dab2e21cf3fd</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="308018bc-2626-4313-89d0-98dc10adc311@my_jitsi_meet_ip_addr/38c80ac4-f2f0-40cd-b96a-bf0d7469c747" affiliation="none" role="participant" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,373 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,373 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/1e078668"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.98 Safari/537.36</user-agent><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video>true</video></devices><avatar-id>286b5cf2c73af7539ab005f714ad9781</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><videoType xmlns="http://jitsi.org/jitmeet/video">camera</videoType><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="1e078668-e488-4391-a383-e78c38817ea2@my_jitsi_meet_ip_addr/5b47c0ec-5e5c-498a-ac66-8b2aafa37901" affiliation="owner" role="moderator" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,373 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,374 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-23130252618767377" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf" affiliation="none" role="participant" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,374 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,374 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" affiliation="none" role="participant" /><status code="110" /><status code="100" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,561 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzA4AFL9KXVd0BjDAqkPcrEyAo8=" from="123@conference.my_jitsi_meet_ip_addr/focus" type="get"><query xmlns="http://jabber.org/protocol/disco#info" /></iq>
2017-04-10 22:40:46,561 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IANDAzNTU1YWMtMTFlMi00YTRhLWI3MzEtODgxNmViMzBlNDk5OnNlbmRJUQBMGCFrzwg+D8XMXmpRT/oL" from="123@conference.my_jitsi_meet_ip_addr/308018bc" type="get"><query xmlns="http://jabber.org/protocol/disco#info" /></iq>
2017-04-10 22:40:46,562 DEBUG Received disco info query from <123@conference.my_jitsi_meet_ip_addr/focus> to <jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb>.
2017-04-10 22:40:46,562 DEBUG No identity found for this entity. Using default client identity.
2017-04-10 22:40:46,562 DEBUG Received disco info query from <123@conference.my_jitsi_meet_ip_addr/308018bc> to <jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb>.
2017-04-10 22:40:46,562 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/focus" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzA4AFL9KXVd0BjDAqkPcrEyAo8=" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="jabber:x:data" /><identity category="client" type="bot" /></query></iq>
2017-04-10 22:40:46,563 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/308018bc" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IANDAzNTU1YWMtMTFlMi00YTRhLWI3MzEtODgxNmViMzBlNDk5OnNlbmRJUQBMGCFrzwg+D8XMXmpRT/oL" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="jabber:x:data" /><identity category="client" type="bot" /></query></iq>
2017-04-10 22:40:46,723 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAMzg0NGI5OTYtMzBmYi00MzgyLWEzNWYtY2UzYmRhYzU2MzUyOnNlbmRJUQBkjgymC4Su1+y0YjqfCSUj" from="123@conference.my_jitsi_meet_ip_addr/1e078668" type="get"><query xmlns="http://jabber.org/protocol/disco#info" /></iq>
2017-04-10 22:40:46,724 DEBUG Received disco info query from <123@conference.my_jitsi_meet_ip_addr/1e078668> to <jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb>.
2017-04-10 22:40:46,724 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/1e078668" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAMzg0NGI5OTYtMzBmYi00MzgyLWEzNWYtY2UzYmRhYzU2MzUyOnNlbmRJUQBkjgymC4Su1+y0YjqfCSUj" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="jabber:x:data" /><identity category="client" type="bot" /></query></iq>
2017-04-10 22:40:46,924 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzEwAFL9KXVd0BjDAqkPcrEyAo8=" from="123@conference.my_jitsi_meet_ip_addr/focus" type="set"><jingle xmlns="urn:xmpp:jingle:1" sid="bo4qpas96s807" initiator="focus@auth.my_jitsi_meet_ip_addr/focus23033023607" action="session-initiate" /></iq>
2017-04-10 22:40:46,925 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/focus" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzEwAFL9KXVd0BjDAqkPcrEyAo8=" type="error"><error type="cancel"><feature-not-implemented xmlns="urn:ietf:params:xml:ns:xmpp-stanzas" /><text xmlns="urn:ietf:params:xml:ns:xmpp-stanzas">No handlers registered for this request.</text></error></iq>
2017-04-10 22:40:47,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:48,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:49,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:50,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:51,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:52,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:53,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:54,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:55,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:56,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:57,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:58,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:59,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:00,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:01,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:02,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:03,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:04,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:05,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:06,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:07,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:08,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:09,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:10,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:11,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:12,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:13,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:14,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:15,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:16,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:17,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:18,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:19,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:20,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:21,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:22,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:23,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:24,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:24,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:25,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:26,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:27,026 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:28,026 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:29,025 DEBUG Scheduled event: Session timeout check: ()
2017-04-10 22:41:29,026 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:30,026 DEBUG Scheduled event: asyncio_queue: ()


#2

Be sure that your jicofo is configured as expected. It looks like your jibri is connecting without a problem, and sending its presence properly to jicofo. Once jicofo receives this presence, it sends the jibri-recording-status presence to your room. So you’ll need to be running a relatively recent jicofo, and then be sure to have the setting (setting your domain.com to the proper value).

  org.jitsi.jicofo.jibri.BREWERY=TheBrewery@conference.yourdomain.com

in your sip-communicator.properties. Then check the jicofo logs (in /var/log/jitsi/jicofo.log by default) to see whether there’s any output that includes the term “Jibri”. This should help you in your debugging.

Cheers,

-Aaron

···

On Apr 11, 2017, at 03:47, hanguofu <hanguofu@163.com> wrote:

I tried to play to jibri but always get the "The live streaming service is currently unavailable. Please try again later." when I clicked the record button.

Further reading the related source codes , I found out that the presence message sent by jibri does not have the jibri-recording-status tag . ( should it ? )

How to debug this case please ?

================== jibri running log =====================
~/jibri-xmpp-client $ ./run.sh
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ [ -z ]
+ python3 app.py -d
2017-04-10 22:40:43,845 DEBUG Client Options: {'my_jitsi_meet_ip_addr': {'boshdomain_prefix': 'recorder.', 'selenium_xmpp_prefix': 'recorder.', 'selenium_xmpp_username': 'recorder', 'roompass': '', 'room': '123@conference.my_jitsi_meet_ip_addr', 'usage_timeout': 0, 'jid': 'jibri@auth.my_jitsi_meet_ip_addr', 'jid_username': 'jibri', 'roomname': '123', 'password': 'jibri', 'boshdomain': 'recorder.my_jitsi_meet_ip_addr', 'mucserver_prefix': 'conference.', 'url': 'https://my_jitsi_meet_ip_addr/%ROOM%', 'jidserver_prefix': 'auth.', 'selenium_xmpp_login': 'recorder@recorder.my_jitsi_meet_ip_addr', 'xmpp_domain': 'my_jitsi_meet_ip_addr', 'nick': 'jibri-37416628236289884', 'selenium_xmpp_password': 'recorderpass'}}
2017-04-10 22:40:43,845 DEBUG Starting up client thread for host: my_jitsi_meet_ip_addr
2017-04-10 22:40:43,846 INFO Creating a client for hostname: my_jitsi_meet_ip_addr with options: {'boshdomain_prefix': 'recorder.', 'selenium_xmpp_prefix': 'recorder.', 'selenium_xmpp_username': 'recorder', 'roompass': '', 'room': '123@conference.my_jitsi_meet_ip_addr', 'usage_timeout': 0, 'jid': 'jibri@auth.my_jitsi_meet_ip_addr', 'jid_username': 'jibri', 'roomname': '123', 'password': 'jibri', 'boshdomain': 'recorder.my_jitsi_meet_ip_addr', 'mucserver_prefix': 'conference.', 'url': 'https://my_jitsi_meet_ip_addr/%ROOM%', 'jidserver_prefix': 'auth.', 'selenium_xmpp_login': 'recorder@recorder.my_jitsi_meet_ip_addr', 'xmpp_domain': 'my_jitsi_meet_ip_addr', 'nick': 'jibri-37416628236289884', 'selenium_xmpp_password': 'recorderpass'}
2017-04-10 22:40:43,847 DEBUG Loaded Plugin: RFC 6120: Stream Feature: STARTTLS
2017-04-10 22:40:43,848 DEBUG Loaded Plugin: RFC 6120: Stream Feature: Resource Binding
2017-04-10 22:40:43,853 DEBUG Loaded Plugin: RFC 3920: Stream Feature: Start Session
2017-04-10 22:40:43,854 DEBUG Loaded Plugin: RFC 6121: Stream Feature: Roster Versioning
2017-04-10 22:40:43,854 DEBUG Loaded Plugin: RFC 6121: Stream Feature: Subscription Pre-Approval
2017-04-10 22:40:43,857 DEBUG Loaded Plugin: RFC 6120: Stream Feature: SASL
2017-04-10 22:40:43,857 INFO jibri_watcher starting up...
2017-04-10 22:40:43,857 WARNING jid property deprecated. Use boundjid.bare
2017-04-10 22:40:43,859 DEBUG Loaded Plugin: XEP-0030: Service Discovery
2017-04-10 22:40:43,860 DEBUG Loaded Plugin: XEP-0004: Data Forms
2017-04-10 22:40:43,861 DEBUG Loaded Plugin: XEP-0045: Multi-User Chat
2017-04-10 22:40:43,861 DEBUG Connecting client for hostname: my_jitsi_meet_ip_addr port 5222
2017-04-10 22:40:43,861 DEBUG Connecting to my_jitsi_meet_ip_addr:5222
2017-04-10 22:40:44,024 DEBUG Event triggered: connected
2017-04-10 22:40:44,024 DEBUG ==== TRANSITION disconnected -> connected
2017-04-10 22:40:44,025 DEBUG Starting HANDLER THREAD
2017-04-10 22:40:44,025 DEBUG Loading event runner
2017-04-10 22:40:44,025 DEBUG SEND (IMMED): <stream:stream to='auth.my_jitsi_meet_ip_addr' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' xml:lang='en' version='1.0'>
2017-04-10 22:40:44,189 DEBUG RECV: <stream:stream version="1.0" id="dab804ca-fee3-4817-a5ed-73c1a853fe40" from="auth.my_jitsi_meet_ip_addr" xml:lang="en">
2017-04-10 22:40:44,189 DEBUG RECV: <stream:features xmlns="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-1</mechanism><mechanism>DIGEST-MD5</mechanism></mechanisms><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls" /></stream:features>
2017-04-10 22:40:44,190 DEBUG SEND (IMMED): <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls" />
2017-04-10 22:40:44,353 DEBUG RECV: <proceed xmlns="urn:ietf:params:xml:ns:xmpp-tls" />
2017-04-10 22:40:44,354 DEBUG Starting TLS
2017-04-10 22:40:44,354 INFO Negotiating TLS
2017-04-10 22:40:44,354 INFO Using SSL version: TLS 1.0
2017-04-10 22:40:44,707 DEBUG CERT: -----BEGIN CERTIFICATE-----
MIIFrTCCA5WgAwIBAgIJANajvT8iEurvMA0GCSqGSIb3DQEBCwUAMG0xFDASBgNV
BAoMC2xvY2FsZG9tYWluMQ8wDQYDVQQLDAZ1YnVudHUxFzAVBgNVBAMMDjExOC4y
NDQuMjE2LjIwMSswKQYJKoZIhvcNAQkBFhx3ZWJtYXN0ZXJAdWJ1bnR1LmxvY2Fs
ZG9tYWluMB4XDTE3MDQwMzE2MTcxMVoXDTE4MDQwMzE2MTcxMVowbTEUMBIGA1UE
CgwLbG9jYWxkb21haW4xDzANBgNVBAsMBnVidW50dTEXMBUGA1UEAwwOMTE4LjI0
NC4yMTYuMjAxKzApBgkqhkiG9w0BCQEWHHdlYm1hc3RlckB1YnVudHUubG9jYWxk
b21haW4wggIiMA0GCSqGSIb3DQEBAQUAA4ICDwAwggIKAoICAQC6bnVC3NPjZSAP
tPVyMbsgleMQwaWXoFO6WALjldXWpWk4BthBxmeBNbtDo+yGvwKdJttUCG/B4sq7
N/oreWbjGRLWQiTU1BA+A2erTKGKf5i/iO4INjj1wlUOxaOFTv7Ax9KzCiEG97AU
qcKLN6DmtsoNQOBdzaISkMJlrXaGKhcJ4X+o0HHBWv/qgbyj+t31IDcHXml7uUip
cpn8ToqNH/+9jXYecPclLWEeQZCsL9BOqa8Z43Q7S2xuEKUqzf7bqPErdN7z/zdF
BDnOQ4gj35O/oNCaw+HJLvw12fm5xf36bEgvXHf2JV+VPal1dG/l5DCQqB8K6W2j
Xx1SSquoAJz8jmqUatoAnTrcFY9ARPRW1r9amlv/6XiDlRKgi7Oz6VFcZ+E8HpTv
c8kcxNFileuBZZfDOW6bmYWTUOzEADevxdWIo3GaaJ1qDxUGzUPd9SOjAGxY6+Qc
BKgtLjTUtqAjS9RzOgRuhYd+wieaZt1YRQcrOcocTDLKcPg+IW+VsseYY5k0+bJQ
F9HV47RhKh94OBUsBR8axNNm6Gas1Hyk9Zdy1GN+Oumi69KbJeoTiVfCASnW8x5j
GgVmhlTGp1feAaRwsNBWcTwf81+FrlKg2Pkvhl2hcTU2LZvjId6bhBO2m6xY2D8O
nM8gPqQehmkJM/bVJfw8IiqnjX6InQIDAQABo1AwTjAdBgNVHQ4EFgQU/4bFY5u6
zqwjnBCSe4K8pyrT6R4wHwYDVR0jBBgwFoAU/4bFY5u6zqwjnBCSe4K8pyrT6R4w
DAYDVR0TBAUwAwEB/zANBgkqhkiG9w0BAQsFAAOCAgEAP3LUkNjtcuFUdSryfOXQ
2E8HDNK+QgWfraLDsFrBPE16MSaGFbKgZ6QU95eC1UwFHoaEwukDGdgE5yRM7vOH
1TJtLHmfVzL7cfZjtyU9I07J2AqOtGf//MnpK5NVYB7eZ7dp4UbUaUAr4/AWU2N3
TWUvCvuNJbV2fSBWwakwjdpfH1IaH/yP9Uyrwto/ghEelumfH5tXbBbIZF6DSEzt
1jpMskReKobzXzE6K/lLTA13CNCOuGRvElCwkb5+I9y5ax5xfLfYu5MgEP31lBLz
RUSO1/syaegA25qp4pIitX/+JcN3UnoO0+GAaafsw3zZgBYJecGMTMyNqWBHAHpO
T/KuKmRWxnUgzq5t2c9iwrUYvL7KlqZM8jtU/0CCdQTlUJL+54DE/lSdoU1jqenh
cGIAnPeSztTeorHUYDPC5yPc6OtRRGf7IvjD6ex+ZrBd/jg5slDwLnv/KCa/F//Q
s7IWYiA2s8YZVwbFFB2Jh3QRNFmgkOfXmYH+tMwPyoHCNYj6Asf6KhWVXupsBY+L
pPTN+uSSnc+UZ4fJRPP52ovarXMyO/6CmvVkktwvZ6J3z7r//7q/lgfKzLzUbQMr
4aAaxFFSmBtqoilS3mgRowfy8fXzxhMSwGLRb8rz7jQDUInr8r5gA6+Q0s4TgO41
dcqdt53AhMxDFqDSrXe1zPo=
-----END CERTIFICATE-----

2017-04-10 22:40:44,708 DEBUG Event triggered: ssl_cert
2017-04-10 22:40:44,708 WARNING Could not find pyasn1 and pyasn1_modules. SSL certificate COULD NOT BE VERIFIED.
2017-04-10 22:40:44,709 DEBUG SEND (IMMED): <stream:stream to='auth.my_jitsi_meet_ip_addr' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' xml:lang='en' version='1.0'>
2017-04-10 22:40:44,874 DEBUG RECV: <stream:stream version="1.0" id="3d24e129-a3b3-4dc2-b7e8-4eb226d24ce0" from="auth.my_jitsi_meet_ip_addr" xml:lang="en">
2017-04-10 22:40:44,875 DEBUG RECV: <stream:features xmlns="http://etherx.jabber.org/streams"><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>PLAIN</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>DIGEST-MD5</mechanism></mechanisms></stream:features>
2017-04-10 22:40:44,875 DEBUG SEND (IMMED): <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">eSwsbj1qaWJyaSxyPTQwNzU3MjgwOTE0NTI0NDM=</auth>
2017-04-10 22:40:45,047 DEBUG RECV: <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00MDc1NzI4MDkxNDUyNDQzZjNhODVhZWMtYTIyYi00YzNjLWEyNDEtY2VkNTJmNzI5M2IwLHM9T1dZMFpEZGxNMkV0WW1FNVl5MDBZams0TFdFd1lXTXRZelJqWlRFek56QXhNek5rLGk9NDA5Ng==</challenge>
2017-04-10 22:40:45,191 DEBUG SEND (IMMED): <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1lU3dzLHI9NDA3NTcyODA5MTQ1MjQ0M2YzYTg1YWVjLWEyMmItNGMzYy1hMjQxLWNlZDUyZjcyOTNiMCxwPTFDSFJ4aENZNVNOb3owalpUSWNMT3FBekxmUT0=</response>
2017-04-10 22:40:45,355 DEBUG RECV: <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OWDJEbkFaWnBmWGRxR0VrNHErMERqY202c009</success>
2017-04-10 22:40:45,356 DEBUG Event triggered: auth_success
2017-04-10 22:40:45,356 DEBUG SEND (IMMED): <stream:stream to='auth.my_jitsi_meet_ip_addr' xmlns:stream='http://etherx.jabber.org/streams' xmlns='jabber:client' xml:lang='en' version='1.0'>
2017-04-10 22:40:45,520 DEBUG RECV: <stream:stream version="1.0" id="668e8b14-92fb-4048-9f81-3d9df589f5a5" from="auth.my_jitsi_meet_ip_addr" xml:lang="en">
2017-04-10 22:40:45,520 DEBUG RECV: <stream:features xmlns="http://etherx.jabber.org/streams"><c xmlns="http://jabber.org/protocol/caps" node="http://prosody.im" hash="sha-1" ver="ZBWApSGFMsTZkuVThHtyU5xv1Mk=" /><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><required /></bind><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional /></session><ver xmlns="urn:xmpp:features:rosterver" /></stream:features>
2017-04-10 22:40:45,521 DEBUG Enabling roster versioning.
2017-04-10 22:40:45,521 DEBUG Requesting resource:
2017-04-10 22:40:45,521 DEBUG SEND (IMMED): <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-1" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind" /></iq>
2017-04-10 22:40:45,685 DEBUG RECV: <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-1" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb</jid></bind></iq>
2017-04-10 22:40:45,686 DEBUG Event triggered: session_bind
2017-04-10 22:40:45,686 INFO JID set to: jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb
2017-04-10 22:40:45,686 DEBUG SEND (IMMED): <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-2" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session" /></iq>
2017-04-10 22:40:45,850 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-2" type="result" />
2017-04-10 22:40:45,851 DEBUG Established Session
2017-04-10 22:40:45,851 DEBUG Event triggered: session_start
2017-04-10 22:40:45,851 DEBUG Finished processing stream features.
2017-04-10 22:40:45,851 DEBUG Event triggered: stream_negotiated
2017-04-10 22:40:45,851 WARNING Could not find pyasn1 and pyasn1_modules. SSL certificate expiration COULD NOT BE VERIFIED.
2017-04-10 22:40:45,851 INFO Starting up client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>, connecting to room 123@conference.my_jitsi_meet_ip_addr as jibri-37416628236289884
2017-04-10 22:40:45,851 DEBUG Getting roster for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:45,852 DEBUG SEND: <iq id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-3" type="get"><query xmlns="jabber:iq:roster" ver="" /></iq>
2017-04-10 22:40:46,016 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="a10957b4-6bd0-4d53-b989-bf36f4b927a7-3" type="result"><query xmlns="jabber:iq:roster" ver="1" /></iq>
2017-04-10 22:40:46,016 DEBUG Event triggered: roster_update
2017-04-10 22:40:46,016 DEBUG Sending initial presence for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,016 DEBUG Event triggered: sent_presence
2017-04-10 22:40:46,017 DEBUG Attempting to join MUC now for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,017 DEBUG SEND: <presence xml:lang="en" />
2017-04-10 22:40:46,017 DEBUG SEND: <presence to="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><x xmlns="http://jabber.org/protocol/muc"><history maxchars="0" /></x></presence>
2017-04-10 22:40:46,017 DEBUG Sending initial idle presence for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,018 INFO sending presence: <presence to="123@conference.my_jitsi_meet_ip_addr" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /></presence>
2017-04-10 22:40:46,018 DEBUG Adding asyncio queue check to the scheduler for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,018 DEBUG SEND: <presence to="123@conference.my_jitsi_meet_ip_addr" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /></presence>
2017-04-10 22:40:46,018 INFO Started up client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>
2017-04-10 22:40:46,182 DEBUG RECV: <presence from="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" xml:lang="en" />
2017-04-10 22:40:46,182 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf" xml:lang="en"><delay xmlns="urn:xmpp:delay" stamp="2017-04-11T02:39:13Z" from="auth.my_jitsi_meet_ip_addr" /></presence>
2017-04-10 22:40:46,182 DEBUG Event triggered: presence
2017-04-10 22:40:46,183 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,183 DEBUG Event triggered: presence
2017-04-10 22:40:46,183 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,184 DEBUG Event triggered: got_online
2017-04-10 22:40:46,184 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,184 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,362 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="mrOHm-75" from="123@conference.my_jitsi_meet_ip_addr/focus"><etherpad xmlns="http://jitsi.org/jitmeet/etherpad">f20ffcac78e6476f846bd7350962bd01</etherpad><jibri-recording-status xmlns="http://jitsi.org/protocol/jibri" status="undefined" /><versions xmlns="http://jitsi.org/jitmeet"><component name="xmpp">Prosody(0.9.1,Linux)</component><component name="focus">JiCoFo(1.0.1.0-320,Linux)</component><component name="videobridge">JVB(0.1.879,Linux)</component></versions><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org" hash="sha-1" ver="MPbX4TmPVk4oe6hiyStGMdG6mmU=" ext="" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="focus@auth.my_jitsi_meet_ip_addr/focus23033023607" affiliation="owner" role="moderator" /></x></presence>
2017-04-10 22:40:46,362 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/308018bc"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.133 Safari/537.36</user-agent><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video /></devices><avatar-id>b7f4550102b5e333e8c1dab2e21cf3fd</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="308018bc-2626-4313-89d0-98dc10adc311@my_jitsi_meet_ip_addr/38c80ac4-f2f0-40cd-b96a-bf0d7469c747" affiliation="none" role="participant" /></x></presence>
2017-04-10 22:40:46,363 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/1e078668"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.98 Safari/537.36</user-agent><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video>true</video></devices><avatar-id>286b5cf2c73af7539ab005f714ad9781</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><videoType xmlns="http://jitsi.org/jitmeet/video">camera</videoType><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="1e078668-e488-4391-a383-e78c38817ea2@my_jitsi_meet_ip_addr/5b47c0ec-5e5c-498a-ac66-8b2aafa37901" affiliation="owner" role="moderator" /></x></presence>
2017-04-10 22:40:46,363 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-23130252618767377" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf" affiliation="none" role="participant" /></x></presence>
2017-04-10 22:40:46,364 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" affiliation="none" role="participant" /><status code="110" /><status code="100" /></x></presence>
2017-04-10 22:40:46,364 DEBUG RECV: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" affiliation="none" role="participant" /><status code="110" /></x></presence>
2017-04-10 22:40:46,365 DEBUG Event triggered: presence
2017-04-10 22:40:46,365 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,365 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/focus : {'jid': focus@auth.my_jitsi_meet_ip_addr/focus23033023607, 'affiliation': 'owner', 'show': '', 'nick': 'focus', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': '', 'status': '', 'role': 'moderator'}
2017-04-10 22:40:46,366 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,366 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,366 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,366 DEBUG Event triggered: presence
2017-04-10 22:40:46,366 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,367 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/308018bc : {'jid': 308018bc-2626-4313-89d0-98dc10adc311@my_jitsi_meet_ip_addr/38c80ac4-f2f0-40cd-b96a-bf0d7469c747, 'affiliation': 'none', 'show': '', 'nick': '308018bc', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': '', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,367 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,367 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,367 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,367 DEBUG Event triggered: presence
2017-04-10 22:40:46,367 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,368 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/1e078668 : {'jid': 1e078668-e488-4391-a383-e78c38817ea2@my_jitsi_meet_ip_addr/5b47c0ec-5e5c-498a-ac66-8b2aafa37901, 'affiliation': 'owner', 'show': '', 'nick': '1e078668', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': '', 'status': '', 'role': 'moderator'}
2017-04-10 22:40:46,368 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,368 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,368 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,369 DEBUG Event triggered: presence
2017-04-10 22:40:46,369 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,370 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/jibri-23130252618767377 : {'jid': jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf, 'affiliation': 'none', 'show': '', 'nick': 'jibri-23130252618767377', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': 'en', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,370 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,370 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,370 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,370 DEBUG Event triggered: presence
2017-04-10 22:40:46,370 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,371 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884 : {'jid': jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb, 'affiliation': 'none', 'show': '', 'nick': 'jibri-37416628236289884', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': 'en', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,371 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,371 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,371 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::got_online
2017-04-10 22:40:46,371 DEBUG Event triggered: presence
2017-04-10 22:40:46,371 DEBUG Event triggered: presence_available
2017-04-10 22:40:46,371 DEBUG MUC presence from 123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884 : {'jid': jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb, 'affiliation': 'none', 'show': '', 'nick': 'jibri-37416628236289884', 'alt_nick': <nick xmlns="http://jabber.org/protocol/nick" />, 'room': '123@conference.my_jitsi_meet_ip_addr', 'lang': 'en', 'status': '', 'role': 'participant'}
2017-04-10 22:40:46,371 DEBUG Event triggered: groupchat_presence
2017-04-10 22:40:46,372 DEBUG Event triggered: muc::123@conference.my_jitsi_meet_ip_addr::presence
2017-04-10 22:40:46,372 DEBUG Event triggered: got_online
2017-04-10 22:40:46,372 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,372 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="mrOHm-75" from="123@conference.my_jitsi_meet_ip_addr/focus"><etherpad xmlns="http://jitsi.org/jitmeet/etherpad">f20ffcac78e6476f846bd7350962bd01</etherpad><jibri-recording-status xmlns="http://jitsi.org/protocol/jibri" status="undefined" /><versions xmlns="http://jitsi.org/jitmeet"><component name="xmpp">Prosody(0.9.1,Linux)</component><component name="focus">JiCoFo(1.0.1.0-320,Linux)</component><component name="videobridge">JVB(0.1.879,Linux)</component></versions><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org" hash="sha-1" ver="MPbX4TmPVk4oe6hiyStGMdG6mmU=" ext="" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="focus@auth.my_jitsi_meet_ip_addr/focus23033023607" affiliation="owner" role="moderator" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,372 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,373 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/308018bc"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/57.0.2987.133 Safari/537.36</user-agent><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video /></devices><avatar-id>b7f4550102b5e333e8c1dab2e21cf3fd</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="308018bc-2626-4313-89d0-98dc10adc311@my_jitsi_meet_ip_addr/38c80ac4-f2f0-40cd-b96a-bf0d7469c747" affiliation="none" role="participant" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,373 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,373 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/1e078668"><user-agent xmlns="http://jitsi.org/jitmeet/user-agent">Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/52.0.2743.98 Safari/537.36</user-agent><c xmlns="http://jabber.org/protocol/caps" node="http://jitsi.org/jitsimeet" hash="sha-1" ver="z1aBBLuF0kcC4cvtqaI3m4YQdkI=" /><devices><audio>true</audio><video>true</video></devices><avatar-id>286b5cf2c73af7539ab005f714ad9781</avatar-id><audiomuted xmlns="http://jitsi.org/jitmeet/audio">false</audiomuted><videoType xmlns="http://jitsi.org/jitmeet/video">camera</videoType><videomuted xmlns="http://jitsi.org/jitmeet/video">false</videomuted><x xmlns="http://jabber.org/protocol/muc#user"><item jid="1e078668-e488-4391-a383-e78c38817ea2@my_jitsi_meet_ip_addr/5b47c0ec-5e5c-498a-ac66-8b2aafa37901" affiliation="owner" role="moderator" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,373 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,374 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-23130252618767377" xml:lang="en"><jibri-status xmlns="http://jitsi.org/protocol/jibri" status="idle" /><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/e1c1b56b-8b59-4645-99ea-57168f6a93cf" affiliation="none" role="participant" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,374 DEBUG Event triggered: changed_status
2017-04-10 22:40:46,374 INFO Got online into a MUC for client <jibrixmppclient.JibriXMPPClient object at 0x7fdfbff652e8>: presence recived: <presence to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" from="123@conference.my_jitsi_meet_ip_addr/jibri-37416628236289884" xml:lang="en"><x xmlns="http://jabber.org/protocol/muc#user"><item jid="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" affiliation="none" role="participant" /><status code="110" /><status code="100" /></x><nick xmlns="http://jabber.org/protocol/nick" /></presence>
2017-04-10 22:40:46,561 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzA4AFL9KXVd0BjDAqkPcrEyAo8=" from="123@conference.my_jitsi_meet_ip_addr/focus" type="get"><query xmlns="http://jabber.org/protocol/disco#info" /></iq>
2017-04-10 22:40:46,561 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IANDAzNTU1YWMtMTFlMi00YTRhLWI3MzEtODgxNmViMzBlNDk5OnNlbmRJUQBMGCFrzwg+D8XMXmpRT/oL" from="123@conference.my_jitsi_meet_ip_addr/308018bc" type="get"><query xmlns="http://jabber.org/protocol/disco#info" /></iq>
2017-04-10 22:40:46,562 DEBUG Received disco info query from <123@conference.my_jitsi_meet_ip_addr/focus> to <jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb>.
2017-04-10 22:40:46,562 DEBUG No identity found for this entity. Using default client identity.
2017-04-10 22:40:46,562 DEBUG Received disco info query from <123@conference.my_jitsi_meet_ip_addr/308018bc> to <jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb>.
2017-04-10 22:40:46,562 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/focus" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzA4AFL9KXVd0BjDAqkPcrEyAo8=" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="jabber:x:data" /><identity category="client" type="bot" /></query></iq>
2017-04-10 22:40:46,563 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/308018bc" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IANDAzNTU1YWMtMTFlMi00YTRhLWI3MzEtODgxNmViMzBlNDk5OnNlbmRJUQBMGCFrzwg+D8XMXmpRT/oL" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="jabber:x:data" /><identity category="client" type="bot" /></query></iq>
2017-04-10 22:40:46,723 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAMzg0NGI5OTYtMzBmYi00MzgyLWEzNWYtY2UzYmRhYzU2MzUyOnNlbmRJUQBkjgymC4Su1+y0YjqfCSUj" from="123@conference.my_jitsi_meet_ip_addr/1e078668" type="get"><query xmlns="http://jabber.org/protocol/disco#info" /></iq>
2017-04-10 22:40:46,724 DEBUG Received disco info query from <123@conference.my_jitsi_meet_ip_addr/1e078668> to <jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb>.
2017-04-10 22:40:46,724 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/1e078668" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAMzg0NGI5OTYtMzBmYi00MzgyLWEzNWYtY2UzYmRhYzU2MzUyOnNlbmRJUQBkjgymC4Su1+y0YjqfCSUj" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><feature var="jabber:x:data" /><identity category="client" type="bot" /></query></iq>
2017-04-10 22:40:46,924 DEBUG RECV: <iq to="jibri@auth.my_jitsi_meet_ip_addr/5c9581ca-d17c-43f3-8ede-a742a9a080cb" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzEwAFL9KXVd0BjDAqkPcrEyAo8=" from="123@conference.my_jitsi_meet_ip_addr/focus" type="set"><jingle xmlns="urn:xmpp:jingle:1" sid="bo4qpas96s807" initiator="focus@auth.my_jitsi_meet_ip_addr/focus23033023607" action="session-initiate" /></iq>
2017-04-10 22:40:46,925 DEBUG SEND: <iq to="123@conference.my_jitsi_meet_ip_addr/focus" id="amlicmlAYXV0aC4xMTguMjQ0LjIxNi4yMC81Yzk1ODFjYS1kMTdjLTQzZjMtOGVkZS1hNzQyYTlhMDgwY2IAbXJPSG0tMzEwAFL9KXVd0BjDAqkPcrEyAo8=" type="error"><error type="cancel"><feature-not-implemented xmlns="urn:ietf:params:xml:ns:xmpp-stanzas" /><text xmlns="urn:ietf:params:xml:ns:xmpp-stanzas">No handlers registered for this request.</text></error></iq>
2017-04-10 22:40:47,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:48,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:49,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:50,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:51,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:52,019 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:53,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:54,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:55,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:56,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:57,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:58,020 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:40:59,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:00,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:01,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:02,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:03,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:04,021 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:05,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:06,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:07,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:08,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:09,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:10,022 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:11,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:12,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:13,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:14,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:15,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:16,023 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:17,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:18,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:19,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:20,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:21,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:22,024 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:23,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:24,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:24,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:25,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:26,025 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:27,026 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:28,026 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:29,025 DEBUG Scheduled event: Session timeout check: ()
2017-04-10 22:41:29,026 DEBUG Scheduled event: asyncio_queue: ()
2017-04-10 22:41:30,026 DEBUG Scheduled event: asyncio_queue: ()
_______________________________________________
dev mailing list
dev@jitsi.org
Unsubscribe instructions and other list options:
http://lists.jitsi.org/mailman/listinfo/dev