search

Red5 / red5-client

Red5 Client
Apache License 2.0
162 stars 140 forks source link

ChunkSize Problem #48

Open hlwolf opened 4 years ago

hlwolf commented 4 years ago

### When client connected success to server and server reponses set Chunk Size 4096, then client invokes method "call" and data size is between 129 and 4095, the data won't send to server.

below is log info. 19:41:56.649 [NioProcessor-2] DEBUG o.r.c.net.rtmp.BaseRTMPClientHandler - invoke method: execute params [{cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}}] callback cn.compass.App$1@52ee888 19:41:56.650 [NioProcessor-2] TRACE org.red5.server.net.rtmp.Channel - write to stream id: 0 channel: 3 19:41:56.650 [NioProcessor-2] TRACE o.r.server.net.rtmp.message.Packet - Header: empty event: Invoke #2: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:41:56.650 [NioProcessor-2] TRACE o.r.s.net.rtmp.RTMPMinaConnection - Write lock wait count: 0 closed: false 19:41:56.650 [NioProcessor-2] TRACE o.r.s.net.rtmp.RTMPMinaConnection - Writing message 19:41:56.650 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolEncoder - Session id: 5NYKUYF7EFHZN 19:41:56.650 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: 5NYKUYF7EFHZN 19:41:56.650 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: 5NYKUYF7EFHZN with thread: NioProcessor-2 19:41:56.651 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.codec.RTMPMinaCodecFactory$2.encode #83 19:41:56.651 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Not dropping due to flag, source type: 0 (0=vod,1=live) 19:41:56.651 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Invoke Invoke #2: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:41:56.651 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:41:56.651 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - encodeCommand - command: Invoke #2: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:41:56.651 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Get connection: 5NYKUYF7EFHZN on thread: NioProcessor-2 19:41:56.651 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - Call: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} pending: true 19:41:56.651 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - This is a pending call, send request 19:41:56.651 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.651 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.652 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - Writing params 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeComplex 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeListType 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeArrayType 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeXMLType 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeComplex 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeListType 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeArrayType 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeXMLType 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.652 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.653 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:41:56.654 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:41:56.654 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Get connection: 5NYKUYF7EFHZN on thread: NioProcessor-2 19:41:56.654 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Channel id: 3 chunkSize: 4096 19:41:56.654 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - HEADER_SAME_SOURCE lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=395, extended=false] 19:41:56.654 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Encoded chunk HEADER_SAME_SOURCE Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:41:56.654 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolEncoder - Writing output data: 43000000000267140200076578656375746500400000000000000005030003636d6402000853454e445f4d53470005706172616d03000375696400413e9618000000000005756e616d6502000653595354454d00047475696400413e9acc000000000007636f6e74656e740201ec7b22756964223a323030343530342c22756e616d65223a2253797374656d222c2274797065223a302c22636f6e74656e74223a2225334354657874466c6f772b786d6c6e73253344253232687474702533412532462532466e732e61646f62652e636f6d253246746578744c61796f7574253246323030382532322b76657273696f6e253344253232332e302e302532322b77686974657370616365636f6c6c6170736525334425323270726573657276652532322b70616464696e67746f7025334425323235253232253345253343702b666f6e7453697a6525334425323231342532322b666f6e7446616d696c792533442532322545352541452538422545342542442539332532322b636f6c6f722533442532322532333030303030302532322533452533437370616e2b666f6e7453697a6525334425323231342532322b666f6e7446616d696c792533442532322545352541452538422545342542442539332532322b636f6c6f722533442532322532333030303030302532322533452545352539332538382545352539332538382b2545362542352538422545382541462539352533432532467370616e2533452533432532467025334525334325324654657874466c6f77253345222c227473223a22323032302d30322d32382031383a30303a3030227d0004747970650000000000000000000000090000090000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 19:41:56.654 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: null with thread: NioProcessor-2 19:41:56.654 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.codec.RTMPMinaCodecFactory$2.encode #102 19:41:56.654 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: 5NYKUYF7EFHZN 19:41:56.654 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Non-encrypted message 19:41:56.654 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: 5NYKUYF7EFHZN 19:41:56.654 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Non-encrypted message 19:41:56.654 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: null with thread: NioProcessor-2 19:41:56.655 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.RTMPMinaIoHandler.messageReceived #127 19:41:56.655 [NioProcessor-2] DEBUG o.r.c.net.rtmp.RTMPMinaIoHandler - messageSent 19:41:56.655 [NioProcessor-2] TRACE o.r.c.net.rtmp.RTMPMinaIoHandler - Session id: 5NYKUYF7EFHZN 19:41:56.655 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: 5NYKUYF7EFHZN 19:41:56.655 [NioProcessor-2] TRACE o.r.server.net.rtmp.BaseRTMPHandler - Message sent

if add two line codes before invoking method like below:

RTMP rtmp = ((RTMPConnection) Red5.getConnectionLocal()).getState();
rtmp.setWriteChunkSize(128);

it will success

19:46:53.874 [NioProcessor-2] DEBUG o.r.c.net.rtmp.BaseRTMPClientHandler - invoke method: execute params [{cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}}] callback cn.compass.App$1@500538e6 19:46:53.874 [NioProcessor-2] TRACE org.red5.server.net.rtmp.Channel - write to stream id: 0 channel: 3 19:46:53.874 [NioProcessor-2] TRACE o.r.server.net.rtmp.message.Packet - Header: empty event: Invoke #2: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:46:53.876 [NioProcessor-2] TRACE o.r.s.net.rtmp.RTMPMinaConnection - Write lock wait count: 0 closed: false 19:46:53.876 [NioProcessor-2] TRACE o.r.s.net.rtmp.RTMPMinaConnection - Writing message 19:46:53.876 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolEncoder - Session id: OJJ0LHPV93USW 19:46:53.876 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.876 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: OJJ0LHPV93USW with thread: NioProcessor-2 19:46:53.876 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.codec.RTMPMinaCodecFactory$2.encode #83 19:46:53.877 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Not dropping due to flag, source type: 0 (0=vod,1=live) 19:46:53.877 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Invoke Invoke #2: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:46:53.877 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:46:53.877 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - encodeCommand - command: Invoke #2: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} 19:46:53.877 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Get connection: OJJ0LHPV93USW on thread: NioProcessor-2 19:46:53.877 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - Call: Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} pending: true 19:46:53.877 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - This is a pending call, send request 19:46:53.877 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.877 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.877 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.877 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.877 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.877 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.878 [NioProcessor-2] DEBUG o.r.c.n.r.c.RTMPClientProtocolEncoder - Writing params 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeComplex 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeListType 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeArrayType 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeXMLType 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeComplex 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeListType 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeArrayType 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - writeXMLType 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.878 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.879 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.879 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.879 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.879 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.879 [NioProcessor-2] TRACE org.red5.io.object.Serializer - serialize 19:46:53.879 [NioProcessor-2] TRACE org.red5.io.object.Serializer - Wrote as basic 19:46:53.879 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Get connection: OJJ0LHPV93USW on thread: NioProcessor-2 19:46:53.879 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Channel id: 3 chunkSize: 128 19:46:53.879 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - HEADER_SAME_SOURCE lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=395, extended=false] 19:46:53.879 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Encoded chunk HEADER_SAME_SOURCE Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.879 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - HEADER_CONTINUE lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.879 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Encoded chunk HEADER_CONTINUE Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - HEADER_CONTINUE lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Encoded chunk HEADER_CONTINUE Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - HEADER_CONTINUE lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Encoded chunk HEADER_CONTINUE Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - HEADER_CONTINUE lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.c.n.r.c.RTMPClientProtocolEncoder - Encoded chunk HEADER_CONTINUE Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=615, extended=false] 19:46:53.880 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolEncoder - Writing output data: 43000000000267140200076578656375746500400000000000000005030003636d6402000853454e445f4d53470005706172616d03000375696400413e9618000000000005756e616d6502000653595354454d00047475696400413e9acc000000000007636f6e74656e740201ec7b22756964223a323030343530342c22756e616d65223a225379c37374656d222c2274797065223a302c22636f6e74656e74223a2225334354657874466c6f772b786d6c6e73253344253232687474702533412532462532466e732e61646f62652e636f6d253246746578744c61796f7574253246323030382532322b76657273696f6e253344253232332e302e302532322b7768697465737061c36365636f6c6c6170736525334425323270726573657276652532322b70616464696e67746f7025334425323235253232253345253343702b666f6e7453697a6525334425323231342532322b666f6e7446616d696c792533442532322545352541452538422545342542442539332532322b636f6c6f72253344253232253233c33030303030302532322533452533437370616e2b666f6e7453697a6525334425323231342532322b666f6e7446616d696c792533442532322545352541452538422545342542442539332532322b636f6c6f722533442532322532333030303030302532322533452545352539332538382545352539332538382b2545362542c3352538422545382541462539352533432532467370616e2533452533432532467025334525334325324654657874466c6f77253345222c227473223a22323032302d30322d32382031383a30303a3030227d00047479706500000000000000000000000900000900000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000000 19:46:53.880 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: null with thread: NioProcessor-2 19:46:53.880 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.codec.RTMPMinaCodecFactory$2.encode #102 19:46:53.880 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.880 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Non-encrypted message 19:46:53.881 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.881 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Non-encrypted message 19:46:53.881 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: null with thread: NioProcessor-2 19:46:53.881 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.RTMPMinaIoHandler.messageReceived #127 19:46:53.881 [NioProcessor-2] DEBUG o.r.c.net.rtmp.RTMPMinaIoHandler - messageSent 19:46:53.881 [NioProcessor-2] TRACE o.r.c.net.rtmp.RTMPMinaIoHandler - Session id: OJJ0LHPV93USW 19:46:53.881 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.881 [NioProcessor-2] TRACE o.r.server.net.rtmp.BaseRTMPHandler - Message sent 19:46:53.885 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Session id: OJJ0LHPV93USW 19:46:53.885 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.885 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Bytes read: 3410 written: 4110 19:46:53.885 [NioProcessor-2] TRACE o.r.client.net.rtmpe.RTMPEIoFilter - Not decrypting message: HeapBuffer[pos=0 lim=34 cap=2048: 03 00 00 00 00 00 16 14 00 00 00 00 02 00 07 5F 72 65 73 75 6C 74 00 40 00 00 00 00 00 00 00 05 01 01...] 19:46:53.885 [NioProcessor-2] DEBUG o.a.m.f.codec.ProtocolCodecFilter - Processing a MESSAGE_RECEIVED for session 1 19:46:53.885 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolDecoder - decode buffer position: 0 19:46:53.885 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolDecoder - Session id: OJJ0LHPV93USW 19:46:53.885 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.885 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: OJJ0LHPV93USW with thread: NioProcessor-2 19:46:53.885 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.codec.RTMPMinaCodecFactory$1.decode #37 19:46:53.885 [NioProcessor-2] TRACE o.r.s.net.rtmp.message.ChunkHeader - CHUNK header byte 03, count 1, header 0, channel 3 19:46:53.885 [NioProcessor-2] TRACE o.r.s.n.r.codec.RTMPProtocolDecoder - HEADER_NEW lastHeader: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=242, extended=false] 19:46:53.885 [NioProcessor-2] TRACE o.r.s.n.r.codec.RTMPProtocolDecoder - Decoded chunk HEADER_NEW Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=22, extended=false] 19:46:53.886 [NioProcessor-2] TRACE o.r.server.net.rtmp.message.Packet - Header: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=22, extended=false] 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.amf.Input - Input: 0200075f726573756c74004000000000000000050101 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.amf.Input - Data type: 2 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.object.Deserializer - Type: 4 target: class java.lang.String 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.amf.Input - Std string type 19:46:53.886 [NioProcessor-2] DEBUG org.red5.io.amf.Input - Length: 7 limit: 22 19:46:53.886 [NioProcessor-2] DEBUG org.red5.io.amf.Input - String: _result 19:46:53.886 [NioProcessor-2] TRACE o.r.s.n.r.codec.RTMPProtocolDecoder - Action: _result 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.amf.Input - Data type: 0 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.object.Deserializer - Type: 3 target: class java.lang.Number 19:46:53.886 [NioProcessor-2] DEBUG org.red5.io.amf.Input - readNumber from 11 bytes 19:46:53.886 [NioProcessor-2] DEBUG org.red5.io.amf.Input - Number: 2.0 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.amf.Input - Data type: 5 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.object.Deserializer - Type: 1 target: class java.lang.Object 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.amf.Input - Data type: 1 19:46:53.886 [NioProcessor-2] TRACE org.red5.io.object.Deserializer - Type: 2 target: class java.lang.Object 19:46:53.886 [NioProcessor-2] DEBUG o.r.s.n.r.codec.RTMPProtocolDecoder - Num params: 1 19:46:53.886 [NioProcessor-2] DEBUG o.r.s.n.r.codec.RTMPProtocolDecoder - > 0: true 19:46:53.886 [NioProcessor-2] TRACE o.r.s.n.r.codec.RTMPProtocolDecoder - Decoded message: Invoke #2: Service: null Method: _result Num Params: 1 0: true 19:46:53.886 [NioProcessor-2] TRACE o.r.s.n.r.codec.RTMPProtocolDecoder - Last read header after decode: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=22, extended=false] 19:46:53.886 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolDecoder - Decoded: [Packet [[header data type=20, channel=3, timer=0], [message timestamp=0]]] 19:46:53.886 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolDecoder - Writing Packet [[header data type=20, channel=3, timer=0], [message timestamp=0]] to decoder output: org.apache.mina.filter.codec.ProtocolCodecFilter$ProtocolDecoderOutputImpl@6bf4c182 19:46:53.886 [NioProcessor-2] TRACE o.r.s.n.r.c.RTMPMinaProtocolDecoder - Input buffer position: 34 19:46:53.886 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: null with thread: NioProcessor-2 19:46:53.886 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.codec.RTMPMinaCodecFactory$1.decode #69 19:46:53.887 [NioProcessor-2] DEBUG o.r.c.net.rtmp.RTMPMinaIoHandler - messageReceived 19:46:53.887 [NioProcessor-2] TRACE o.r.c.net.rtmp.RTMPMinaIoHandler - Session id: OJJ0LHPV93USW 19:46:53.887 [NioProcessor-2] DEBUG o.r.client.net.rtmp.RTMPConnManager - Getting connection by session id: OJJ0LHPV93USW 19:46:53.887 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: OJJ0LHPV93USW with thread: NioProcessor-2 19:46:53.887 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.RTMPMinaIoHandler.messageReceived #125 19:46:53.887 [NioProcessor-2] TRACE o.r.server.net.rtmp.RTMPConnection - handleMessageReceived - OJJ0LHPV93USW 19:46:53.887 [NioProcessor-2] DEBUG o.r.server.net.rtmp.RTMPConnection - Executor is null on OJJ0LHPV93USW state: connected 19:46:53.887 [NioProcessor-2] TRACE o.r.server.net.rtmp.BaseRTMPHandler - messageReceived connection: OJJ0LHPV93USW 19:46:53.887 [NioProcessor-2] TRACE o.r.server.net.rtmp.BaseRTMPHandler - Message received - header: Header [streamId=0, channelId=3, dataType=20, timerBase=0, timerDelta=0, size=22, extended=false] 19:46:53.887 [NioProcessor-2] TRACE o.r.server.net.rtmp.RTMPConnection - messageReceived 19:46:53.887 [NioProcessor-2] TRACE o.r.server.net.rtmp.RTMPConnection - updateBytesRead 19:46:53.887 [NioProcessor-2] TRACE o.r.server.net.rtmp.BaseRTMPHandler - Header / message data type: 20 19:46:53.887 [NioProcessor-2] TRACE o.r.c.net.rtmp.BaseRTMPClientHandler - onCommand: Invoke #2: Service: null Method: _result Num Params: 1 0: true, id: 2 19:46:53.887 [NioProcessor-2] DEBUG o.r.c.net.rtmp.BaseRTMPClientHandler - Service name: _result args[0]: true 19:46:53.887 [NioProcessor-2] DEBUG o.r.c.net.rtmp.BaseRTMPClientHandler - Received result for pending call - Service: null Method: execute Num Params: 1 0: {cmd=SEND_MSG, param={uid=1111111, uname=SYSTEM, tuid=2222222, content={"uid":1111111,"uname":"System","type":0,"content":"%3CTextFlow+xmlns%3D%22http%3A%2F%2Fns.adobe.com%2FtextLayout%2F2008%22+version%3D%223.0.0%22+whitespacecollapse%3D%22preserve%22+paddingtop%3D%225%22%3E%3Cp+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%3Cspan+fontSize%3D%2214%22+fontFamily%3D%22%E5%AE%8B%E4%BD%93%22+color%3D%22%23000000%22%3E%E5%93%88%E5%93%88+%E6%B5%8B%E8%AF%95%3C%2Fspan%3E%3C%2Fp%3E%3C%2FTextFlow%3E","ts":"2020-02-28 18:00:00"}, type=0}} Response true 19:46:53.887 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Set connection: null with thread: NioProcessor-2 19:46:53.887 [NioProcessor-2] DEBUG org.red5.server.api.Red5 - Caller: org.red5.client.net.rtmp.RTMPMinaIoHandler.messageReceived #127

mondain commented 3 years ago

I had to back-out setting the default larger than 128 for now, in newer sources; the current work around is to set the default back to 128 via Red5.setTargetChunkSize(128) at startup in your code.