1
2
3
4
5
6
7
8
9
10
11
12
13
14
15
16
17
18
19
20
21
22
23
24
25
26
27
28
29
30
31
32
33
34
35
36
37
38
39
40
41
42
43
44
45
46
47
48
49
50
51
52
53
54
55
56
57
58
59
60
61
62
63
64
65
66
67
68
69
70
71
72
73
74
75
76
77
78
79
80
81
82
83
84
85
86
87
88
89
90
91
92
93
94
95
96
97
98
99
100
101
102
103
104
105
106
107
108
109
110
111
112
113
114
115
116
117
118
119
120
121
122
|
--echo # WL14955: Have backtraces of failed runs appear in pfs.error_log
--echo #
--echo
# While log_backtrace.test does not require have_debug and works
# with stacktraces we prepared earlier, in this test, we actually
# synthesize a crash and then look at the stacktrace afterwards.
# (Mostly we show that it exists through being able to read the
# timestamp/signal-preamble. Anything beyond that is somewhat
# platform-dependent.)
--source include/not_valgrind.inc
--source include/not_crashrep.inc
--source include/not_windows.inc
# Only debug-build has self-crash option.
--source include/have_debug.inc
# Let's have performance_schema.error_log to ourselves.
--source include/not_parallel.inc
# Error-log to this file:
--let LOG_FILE1= $MYSQLTEST_VARDIR/tmp/wl14955_debug.err
--echo #
--echo # Take down server started by mtr.
--let $_server_id= `SELECT @@server_id`
--let $_expect_file_name= $MYSQLTEST_VARDIR/tmp/mysqld.$_server_id.expect
--exec echo "wait" > $_expect_file_name
--shutdown_server
--echo #
--echo # Start our own server. Log to LOG_FILE1.
--exec_in_background $MYSQLD_CMD --port $MASTER_MYPORT --log-error=$LOG_FILE1 --log-timestamps=UTC --log-error-verbosity=1
--enable_reconnect
--echo #
--echo # Connect to our own server.
--let $wait_counter=3000
--source include/wait_until_connected_again.inc
--disable_reconnect
--echo #
--echo # Log a header.
--echo # If the header is present, but the stackdump is not, the stackdump
--echo # failed. If the header is not present, we have bigger issues.
SET @@session.debug="+d,parser_stmt_to_error_log_with_system_prio";
SELECT "--- STACKTRACE TO FOLLOW ---";
SET @@session.debug="-d,parser_stmt_to_error_log_with_system_prio";
--echo #
--echo # Let's synthesize a crash, so to hopefully get a backtrace.
--source include/expect_crash.inc
--error 2013
SET @@session.debug='d,crash_now';
--echo #
--echo # Restart mysqld after the crash using the same log-file.
--echo # Then, reconnect.
--let restart_parameters="restart: --log-error=$LOG_FILE1 --log-timestamps=UTC"
--replace_result $LOG_FILE1 LOG_FILE1
--source include/start_mysqld.inc
--enable_reconnect
--echo #
--echo # Connect to our own server.
--let $wait_counter=3000
--source include/wait_until_connected_again.inc
--disable_reconnect
--echo #
--echo # Check error-log file for stacktrace.
--echo # Test 1: expect one match (processed line only)
--let $assert_file= $LOG_FILE1
--let $assert_count= 1
--let $assert_select=.* \[Server\] .*[0-9]Z UTC - mysqld got .*
--let $assert_text= Found the expected stacktrace in the error-log file.
--source include/assert_grep.inc
--echo #
--echo # Check error-log file for stacktrace.
--echo # Test 2: expect two matches (original and processed line)
--let $assert_file= $LOG_FILE1
--let $assert_count= 2
--let $assert_select=.*[0-9]Z UTC - mysqld got .*
--let $assert_text= Found the expected stacktraces in the error-log file.
--source include/assert_grep.inc
--echo #
--echo # Show that a stacktrace was created, and was read at start-up.
--echo # While in log_backtrace.test, we wrote the processed stacktrace
--echo # to the JSON-log, this time we'll use the traditional error-log
--echo # format. It is worth testing both scenarios (input and output in
--echo # different log files vis-a-vis input and output in the same log
--echo # file).
# Find error-number for the error symbol ER_STACK_BACKTRACE we'll be using
# (and normalize to symbol in .result file).
--let $err_code= convert_error(ER_STACK_BACKTRACE)
--replace_regex /=.*/=ER_STACK_BACKTRACE/
--eval SET @err_code=CONCAT("MY-",LPAD($err_code,6,"0"));
--echo #
--echo # Look for 'SELECT'-header.
SELECT data
FROM performance_schema.error_log
WHERE data LIKE "%--- STACKTRACE TO FOLLOW ---%";
# SELECT ">", data FROM performance_schema.error_log WHERE error_code=@err_code;
--echo #
--echo # Look for stacktrace in pfs.error_log. Should find 1 signal-header.
SELECT COUNT(*)
FROM performance_schema.error_log
WHERE error_code=@err_code
AND data LIKE "% UTC - mysqld got %";
--echo #
--echo # Clean up.
--source include/force_restart.inc
--remove_file $LOG_FILE1
|
