Some logs are too verbose and not helpful

[antoninbas]

When looking at Antrea logs for e2e tests, the log file can be hard to read because of all the binary dumps from libOpenflow. Some examples:

I0428 18:24:33.352308      14 flowmod.go:127] "Flowmod MarshalBinary succeeded" dataLength=56 data="\x06\x0e\x008\x00\x00\x00\v\x00\x04\x00\x00\x00\x00\x00\x00\xff\xff\x00\x00\x00\x00\x00\x00\xff\x03\x00\x00\x00\x00\x03\xe8\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\x00\x00\x00\x00\x00\x01\x00\x04\x00\x00\x00\x00"

I0428 18:24:33.371391      14 openflow15.go:115] "Openflow15 parse" bytes="\x06\x13\xef0\x00\x00\x00\t\x00\f\x00\x01\x00\x00\x00\x00\x14\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\x00\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\xff\x00\x00\x00\x00\x00\x0fB@\x00\x00\x00\x18\x00\x01\x00\x04\x00\x02\x00\x04\x00\x03\x00\x04\x00\x04\x00\x04\x00\x05\x00\x04\x00\x02\x01\x01\x01\x02\x03\x04\x05\x06\a\b\t\n\v\f\r\x0e\x0f\x10\x11\x12\x13\x14\x15\x16\x17\x18\x19\x1a\x1b\x1c\x1d\x1e\x1f !\"#$%&'()*+,-./0123456789:;<=>?@ABCDEFGHIJKLMNOPQRSTUVWXYZ[\\]^_`abcdefghijklmnopqrstuvwxyz{|}~\x7f\x80\x81\x82\x83\x84\x85\x86\x87\x88\x89\x8a\x8b\x8c\x8d\x8e\x8f\x90\x91\x92\x93\x94\x95\x96\x97\x98\x99\x9a\x9b\x9c\x9d\x9e\x9f\xa0\xa1\xa2\xa3\xa4\xa5\xa6\xa7\xa8\xa9\xaa\xab\xac\xad\xae\xaf\xb0\xb1\xb2\xb3\xb4\xb5\xb6\xb7\xb8\xb9\xba\xbb\xbc\xbd\xbe\xbf\xc0\xc1\xc2\xc3\xc4\xc5\xc6\xc7\xc8\xc9\xca\xcb\xcc\xcd\xce\xcf\xd0\xd1\xd2\xd3\xd4\xd5\xd6\xd7\xd8\xd9\xda\xdb\xdc\xdd\xde\xdf\xe0\xe1\xe2\xe3\xe4\xe5\xe6\xe7\xe8\xe9\xea\xeb\xec\xed\xee\xef\xf0\xf1\xf2\xf3\xf4\xf5\xf6\xf7\xf8\xf9\xfa\xfb\xfc\xfd\x00\x00\x00\x00\x00\x00\x00\x00\x04\x004\x00\x00\x00\x04\x00\x0f\x00\x04\x00\x10\x00\x04\x00\x11\x00\x04\x00\x12\x00\x04\x00\x13\x00\x04\x00\x14\x00\x04\x00\x15\x00\x04\x00\x16\x00\x04\x00\x17\x00\x04\x00\x18\x00\x04\x00\x19\x00\x04\x00\x00\x00\x00\x00\f\x02\xa0\x80\x00L\b\x00\x01>\x04\x00\x01@\x04\x00\x01\xda\x10\x00\x01\xdc\x10\x00\x01\xd0\x02\x00\x01L\x02\x00\x01N\x01\xff\xff\x16\b\x00\x00# \xff\xff\x18\x05\x00\x00# \xff\xff\x1a\x05\x00\x00# \xff\xff\x1c\x05\x00\x00# \x00\x01P|\x00\x01R|\x00\x01T|\x00\x01V|\x00\x01X|\x00\x01Z|\x00\x01\\|\x00\x01^|\x00\x01`|\x00\x01b|\x00\x01d|\x00\x01f|\x00\x01h|\x00\x01j|\x00\x01l|\x00\x01n|\x00\x01p|\x00\x01r|\x00\x01t|\x00\x01v|\x00\x01x|\x00\x01z|\x00\x01||\x00\x01~|\x00\x01\x80|\x00\x01\x82|\x00\x01\x84|\x00\x01\x86|\x00\x01\x88|\x00\x01\x8a|\x00\x01\x8c|\x00\x01\x8e|\x00\x01\x90|\x00\x01\x92|\x00\x01\x94|\x00\x01\x96|\x00\x01\x98|\x00\x01\x9a|\x00\x01\x9c|\x00\x01\x9e|\x00\x01\xa0|\x00\x01\xa2|\x00\x01\xa4|\x00\x01\xa6|\x00\x01\xa8|\x00\x01\xaa|\x00\x01\xac|\x00\x01\xae|\x00\x01\xb0|\x00\x01\xb2|\x00\x01\xb4|\x00\x01\xb6|\x00\x01\xb8|\x00\x01\xba|\x00\x01\xbc|\x00\x01\xbe|\x00\x01\xc0|\x00\x01\xc2|\x00\x01\xc4|\x00\x01\xc6|\x00\x01\xc8|\x00\x01\xca|\x00\x01\xcc|\x00\x01\xce|

The second one goes on for almost 65KB of data!

We also have some plain garbage sometimes:

�����������������������������������������������������
�Ä��Ä�����fi���‡���‚���‰�Ä���Ä�������Ä��Ä���Ä�D�Ä�F���<�Ä���Ä���Ä�4�Ä�6�Ä�8���
�Ä���Ä�����:�Ä�*�Ä�,�Ä�.�Ä�0�Ä�2�Ä���Ä���Ä���Ä� �Ä�"�Ä�$�Ä�&�Ä�(�Ä�:�Ä�<�Ä�>�Ä�@�Ä�B���������ˇˇ���Z÷Pˇˇ���Z÷Pˇˇ
��Z÷Pˇˇ��Z÷Pˇˇ���Z÷Pˇˇ���Z÷Pˇˇ���Z÷Pˇˇ���Z÷P���4�������������������������������������������������������†Ä�L���>���@���⁄���‹���–���L���N�ˇˇ����# ˇˇ����# ˇˇ����# ˇˇ����# ��P|��R|��T|��V|��X|��Z|��\|��^|��`|��b|��d|��f|��h|��j|��l|��n|��p|��r|��t|��v|��x|��z|��||��~|��Ä|��Ç|��Ñ|��Ü|��à|��ä|��å|��é|��ê|��í|��î|��ñ|��ò|��ö|��ú|��û|��†|��¢|��§|��¶|��®|��™|��¨|��Æ|��∞|��≤|��¥|��∂|��∏|��∫|��º|��æ|��¿|��¬|��ƒ|��∆|��»|�� |��Ã|��Œ|Ä�������Ä�����B���÷���ÿ�����������������������
��������������������������������������������������������
�Ä��Ä�����fi���‡���‚���‰�Ä���Ä�������Ä��Ä���Ä�D�Ä�F���<�Ä���Ä���Ä�4�Ä�6�Ä�8���
�Ä���Ä�����:�Ä�*�Ä�,�Ä�.�Ä�0�Ä�2�Ä���Ä���Ä���Ä� �Ä�"�Ä�$�Ä�&�Ä�(�Ä�:�Ä�<�Ä�>�Ä�@�Ä�B���������ˇˇ���Z÷Pˇˇ���Z÷Pˇˇ

In addition to that, some log calls seem to be invalid:

I0428 18:24:33.352164      14 stream.go:128] "Sent" dataLength=16 data=16 �������	�������="(MISSING)"

A couple of ideas:

• maybe we could increase the verbosity level from 4 to 6: Antrea e2e tests run with -v=4 (https://github.com/antrea-io/antrea/blob/main/test/e2e/coverage/agent-arg-file) so at lease these log messages would be omitted.
• truncate binary data to a reasonable max length (128 bytes?)
• format all binary data as an hexadecimal string when logging it, to avoid garbage

[antoninbas]

cc @wenyingd

[tnqn]

Just saw this issue, I had the same feeling and created #39 to fix it, which has implemented most changes proposed here.

[antoninbas]

Thanks @tnqn. Is the second item (truncate binary data) the only one that has not been implemented?
Maybe we can ignore that item, since you have increased verbosity to 7, and close this issue?