Bug #101155 mtr test failed auth_sec.early_plugin_load
Submitted: 13 Oct 2020 13:59 Modified: 13 Oct 2020 19:19
Reporter: wei liu Email Updates:
Status: Verified Impact on me:
None 
Category:MySQL Server: Tests Severity:S7 (Test Cases)
Version: OS:CentOS
Assigned to: CPU Architecture:ARM

[13 Oct 2020 13:59] wei liu
Description:
[root@xx01 mysql-test]#  ./mtr --debug-server  auth_sec.early_plugin_load
Logging: ./mtr  --debug-server auth_sec.early_plugin_load
MySQL Version 8.0.21
Checking supported features
 - Binaries are debug compiled
Using 'all' suites
Collecting tests
Checking leftover processes
Removing old var directory
Creating var directory '/usr/local/mysql8.0.21-release-debug/mysql-test/var'
Installing system database
Using parallel: 1

==============================================================================
                  TEST NAME                       RESULT  TIME (ms) COMMENT
------------------------------------------------------------------------------
worker[1] mysql-test-run: WARNING: running this script as _root_ will cause some tests to be skipped
[ 50%] auth_sec.early_plugin_load                [ fail ]
        Test ended at 2020-10-13 09:49:48

CURRENT_TEST: auth_sec.early_plugin_load
mysqltest: At line 24: Query 'UNINSTALL PLUGIN keyring_file' failed.
ERROR 1305 (42000): PLUGIN keyring_file does not exist

The result from queries just before the failure was:
# Setup : Restart server with --early_plugin_load option
# 1. Check that KEYRING_FILE plugin is installed properly
SELECT PLUGIN_NAME, PLUGIN_STATUS, LOAD_OPTION FROM INFORMATION_SCHEMA.PLUGINS
WHERE PLUGIN_NAME LIKE 'keyring_file';
PLUGIN_NAME     PLUGIN_STATUS   LOAD_OPTION
SHOW VARIABLES LIKE 'keyring_file';
Variable_name   Value
# 3. Try uninstalling keyring_file plugin
safe_process[70248]: Child process: 70249, exit: 1

 - the logfile can be found in '/usr/local/mysql8.0.21-release-debug/mysql-test/var/log/auth_sec.early_plugin_load/early_plugin_load.log'

[100%] shutdown_report                           [ pass ]
------------------------------------------------------------------------------
The servers were restarted 0 times
The servers were reinitialized 0 times
Spent 0.000 of 25 seconds executing testcases

Completed: Failed 1/2 tests, 50.00% were successful.

Failing test(s): auth_sec.early_plugin_load

The log files in var/log may give you some hint of what went wrong.

If you want to report this error, please read first the documentation
at http://dev.mysql.com/doc/mysql/en/mysql-test-suite.html

mysql-test-run: *** ERROR: there were failing test cases

include testcase:
auth_sec.early_plugin_load
auth_sec.install_keyring_file
auth_sec.keyring_file_data
auth_sec.keyring_file_data_qa
auth_sec.keyring_udf
auth_sec.key_rotation_qa
auth_sec.server_withssl_client_withssl
auth_sec.wrong_keyring_file_data

How to repeat:
1. cmake .. -DBUILD_CONFIG=mysql_release -DWITH_DEBUG=1 -DWITH_BOOST=../boost -DCMAKE_INSTALL_PREFIX=/usr/local/mysql 
2. make
3. make install
4. ./mtr --debug-server  auth_sec.early_plugin_load

but if delete the args:-DBUILD_CONFIG=mysql_release, then it can pass the testcase.
[13 Oct 2020 15:58] MySQL Verification Team
Thank you for the bug report. I couldn't repeat:

miguel@tikal:~/Downloads/mysql-8.0.21$ cmake . -DBUILD_CONFIG=mysql_release -DWITH_DEBUG=1 -DWITH_BOOST=~/build -DCMAKE_INSTALL_PREFIX=/usr/local  -DFORCE_INSOURCE_BUILD=1
-- Running cmake version 3.16.3
-- MySQL 8.0.21
-- Source directory /home/miguel/Downloads/mysql-8.0.21
-- Binary directory /home/miguel/Downloads/mysql-8.0.21
CMake Warning at CMakeLists.txt:382 (MESSAGE):
  This is an in-source build

-- CMAKE_GENERATOR: Unix Makefiles
-- Looking for SHM_HUGETLB
-- Looking for SHM_HUGETLB - found
-- Looking for sys/types.h
-- Looking for sys/types.h - found
-- Looking for stdint.h
-- Looking for stdint.h - found
-- Looking for stddef.h
-- Looking for stddef.h - found
-- Check size of void *
-- Check size of void * - done
-- SIZEOF_VOIDP 8
-- Performing Test HAVE_C_FLOATING_POINT_FUSED_MADD
-- Performing Test HAVE_C_FLOATING_POINT_FUSED_MADD - Failed
-- Performing Test HAVE_CXX_FLOATING_POINT_FUSED_MADD
-- Performing Test HAVE_CXX_FLOATING_POINT_FUSED_MADD - Failed
-- Packaging as: mysql-8.0.21-Linux-x86_64
-- Performing Test C_LD_LLD_RESULT
-- Performing Test C_LD_LLD_RESULT - Failed
-- Performing Test CXX_LD_LLD_RESULT
-- Performing Test CXX_LD_LLD_RESULT - Failed
-- Performing Test C_LD_GOLD_RESULT
-- Performing Test C_LD_GOLD_RESULT - Success
-- Performing Test CXX_LD_GOLD_RESULT
-- Performing Test CXX_LD_GOLD_RESULT - Success
-- Local boost dir /home/miguel/build/boost_1_72_0
-- Local boost zip /home/miguel/build/boost_1_72_0.tar.gz
-- Found /home/miguel/build/boost_1_72_0/boost/version.hpp
-- BOOST_VERSION_NUMBER is #define BOOST_VERSION 107200
-- BOOST_INCLUDE_DIR /home/miguel/build/boost_1_72_0
-- Looking for pthread.h
_MACROS;__STDC_FORMAT_MACROS;_USE_MATH_DEFINES;LZ4_DISABLE_DEPRECATE_WARNINGS;HAVE_TLSv13
-- CMAKE_C_FLAGS: -fno-omit-frame-pointer -ftls-model=initial-exec  -Wall -Wextra -Wformat-security -Wvla -Wundef -Wmissing-format-attribute -Wwrite-strings -Wjump-misses-init -Wstringop-truncation -Werror
-- CMAKE_CXX_FLAGS: -std=c++14 -fno-omit-frame-pointer -ftls-model=initial-exec  -Wall -Wextra -Wformat-security -Wvla -Wundef -Wmissing-format-attribute -Woverloaded-virtual -Wcast-qual -Wimplicit-fallthrough=2 -Wstringop-truncation -Wlogical-op -Werror
-- CMAKE_CXX_FLAGS_DEBUG: -DSAFE_MUTEX -DENABLED_DEBUG_SYNC -g
-- CMAKE_CXX_FLAGS_RELWITHDEBINFO: -DDBUG_OFF -ffunction-sections -fdata-sections -O2 -g -DNDEBUG
-- CMAKE_CXX_FLAGS_RELEASE: -DDBUG_OFF -ffunction-sections -fdata-sections -O3 -DNDEBUG
-- CMAKE_CXX_FLAGS_MINSIZEREL: -DDBUG_OFF -ffunction-sections -fdata-sections -Os -DNDEBUG
-- CMAKE_C_LINK_FLAGS:  -fuse-ld=gold -Wl,--gc-sections
-- CMAKE_CXX_LINK_FLAGS:  -fuse-ld=gold -Wl,--gc-sections
-- CMAKE_EXE_LINKER_FLAGS
-- CMAKE_MODULE_LINKER_FLAGS
-- CMAKE_SHARED_LINKER_FLAGS
<CUT>
-- Configuring done
-- Generating done
-- Build files have been written to: /home/miguel/Downloads/mysql-8.0.21
miguel@tikal:~/Downloads/mysql-8.0.21$ make
Scanning dependencies of target INFO_BIN
[  0%] Built target INFO_BIN
Scanning dependencies of target mytime_objlib
[  0%] Building CXX object mysys/CMakeFiles/mytime_objlib.dir/my_time.cc.o
[  0%] Building CXX object mysys/CMakeFiles/mytime_objlib.dir/my_systime.cc.o
[  0%] Built target mytime_objlib
Scanning dependencies of target mytime
[  0%] Linking CXX static library ../archive_output_directory/libmytime.a
[  0%] Built target mytime
Scanning dependencies of target zlib_objlib
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/adler32.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/compress.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/crc32.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/deflate.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/gzclose.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/gzlib.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/gzread.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/gzwrite.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/inflate.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/infback.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/inftrees.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/inffast.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/trees.o
[  0%] Building C object extra/zlib/CMakeFiles/zlib_objlib.dir/uncompr.o
<cut>

[100%] Linking CXX executable ../../../../runtime_output_directory/mysqlrouter_keyring
[100%] Built target mysqlrouter_keyring
Scanning dependencies of target mysqlrouter
[100%] Building CXX object router/src/router/src/CMakeFiles/mysqlrouter.dir/main.cc.o
[100%] Linking CXX executable ../../../../runtime_output_directory/mysqlrouter
[100%] Built target mysqlrouter
miguel@tikal:~/Downloads/mysql-8.0.21$ cd mysql-test/
miguel@tikal:~/Downloads/mysql-8.0.21/mysql-test$ ./mtr --debug-server  auth_sec.early_plugin_load
Logging: ./mtr  --debug-server auth_sec.early_plugin_load
MySQL Version 8.0.21
Checking supported features
 - Binaries are debug compiled
Using 'all' suites
Collecting tests
Removing old var directory
Creating var directory '/home/miguel/Downloads/mysql-8.0.21/mysql-test/var'
Installing system database
Using parallel: 1

==============================================================================
                  TEST NAME                       RESULT  TIME (ms) COMMENT
------------------------------------------------------------------------------
[ 50%] auth_sec.early_plugin_load                [ pass ]   7771
[100%] shutdown_report                           [ pass ]
------------------------------------------------------------------------------
The servers were restarted 0 times
The servers were reinitialized 0 times
Spent 7.771 of 204 seconds executing testcases

Completed: All 2 tests were successful.
[13 Oct 2020 17:52] Terje Røsten
Hi!

> worker[1] mysql-test-run: WARNING: running this script as _root_ will cause some tests to be skipped

Try to run test as normal user, not root.
[13 Oct 2020 19:19] MySQL Verification Team
Thank you for the bug report.

Installing system database
Using parallel: 1

==============================================================================
                  TEST NAME                       RESULT  TIME (ms) COMMENT
------------------------------------------------------------------------------
[ 50%] auth_sec.early_plugin_load                [ fail ]
        Test ended at 2020-10-13 16:15:52

<CUT>

Spent 0.000 of 113 seconds executing testcases

Completed: Failed 1/2 tests, 50.00% were successful.

Failing test(s): auth_sec.early_plugin_load