Failure with actual slow log contents
main.percona_slow_query_log_timestamp_always w1 [ fail ] Test ended at 2016-08-25 08:59:39
CURRENT_TEST: main.percona_slow_query_log_timestamp_always --- /mnt/workspace/percona-server-5.5-asan-param/BUILD_TYPE/release-asan/Host/ubuntu-xenial-64bit/mysql-test/r/percona_slow_query_log_timestamp_always.result 2016-08-25 15:40:36.550089324 +0300 +++ /mnt/workspace/percona-server-5.5-asan-param/BUILD_TYPE/release-asan/Host/ubuntu-xenial-64bit/mysql-test/r/percona_slow_query_log_timestamp_always.reject 2016-08-25 15:59:39.673990416 +0300 @@ -10,7 +10,19 @@ 2 [log_stop.inc] percona_slow_query_log_timestamp_always [log_grep.inc] file: percona_slow_query_log_timestamp_always pattern: ^# Time: \d{6} (\d| )\d:\d\d:\d\d$ expected_matches: 3 -[log_grep.inc] found expected match count: 3 +[log_grep.inc] ERROR: expected matches: 3, actual matches: 1 +[log_grep.inc] log file at /mnt/workspace/percona-server-5.5-asan-param/BUILD_TYPE/release-asan/Host/ubuntu-xenial-64bit/mysql-test/var/1/percona_slow_query_log_timestamp_always.slog +/mnt/workspace/percona-server-5.5-asan-param/BUILD_TYPE/release-asan/Host/ubuntu-xenial-64bit/sql/mysqld, Version: 5.5.51-38.1-log (MySQL Community Server (GPL)). started with: +Tcp port: 13001 Unix socket: /tmp/letsTt0Yn2/1/mysqld.1.sock +Time Id Command Argument +# Time: 160825 15:59:39 +# User@Host: root[root] @ localhost [] +# Thread_id: 49 Schema: test Last_errno: 0 Killed: 0 +# Query_time: 0.000241 Lock_time: 0.000000 Rows_sent: 1 Rows_examined: 0 Rows_affected: 0 Rows_read: 0 +# Bytes_sent: 56 +use test; +SET timestamp=1472129979; +SELECT 2; SET GLOBAL slow_query_log_timestamp_always=default; SET SESSION long_query_time=default; SET SESSION min_examined_row_limit=default;
mysqltest: Result content mismatch
Failure with actual slow log contents
main.percona_ slow_query_ log_timestamp_ always w1 [ fail ]
Test ended at 2016-08-25 08:59:39
CURRENT_TEST: main.percona_ slow_query_ log_timestamp_ always percona- server- 5.5-asan- param/BUILD_ TYPE/release- asan/Host/ ubuntu- xenial- 64bit/mysql- test/r/ percona_ slow_query_ log_timestamp_ always. result 2016-08-25 15:40:36.550089324 +0300 percona- server- 5.5-asan- param/BUILD_ TYPE/release- asan/Host/ ubuntu- xenial- 64bit/mysql- test/r/ percona_ slow_query_ log_timestamp_ always. reject 2016-08-25 15:59:39.673990416 +0300 slow_query_ log_timestamp_ always slow_query_ log_timestamp_ always pattern: ^# Time: \d{6} (\d| )\d:\d\d:\d\d$ expected_matches: 3 percona- server- 5.5-asan- param/BUILD_ TYPE/release- asan/Host/ ubuntu- xenial- 64bit/mysql- test/var/ 1/percona_ slow_query_ log_timestamp_ always. slog /percona- server- 5.5-asan- param/BUILD_ TYPE/release- asan/Host/ ubuntu- xenial- 64bit/sql/ mysqld, Version: 5.5.51-38.1-log (MySQL Community Server (GPL)). started with: /1/mysqld. 1.sock 1472129979; log_timestamp_ always= default; time=default; row_limit= default;
--- /mnt/workspace/
+++ /mnt/workspace/
@@ -10,7 +10,19 @@
2
[log_stop.inc] percona_
[log_grep.inc] file: percona_
-[log_grep.inc] found expected match count: 3
+[log_grep.inc] ERROR: expected matches: 3, actual matches: 1
+[log_grep.inc] log file at /mnt/workspace/
+/mnt/workspace
+Tcp port: 13001 Unix socket: /tmp/letsTt0Yn2
+Time Id Command Argument
+# Time: 160825 15:59:39
+# User@Host: root[root] @ localhost []
+# Thread_id: 49 Schema: test Last_errno: 0 Killed: 0
+# Query_time: 0.000241 Lock_time: 0.000000 Rows_sent: 1 Rows_examined: 0 Rows_affected: 0 Rows_read: 0
+# Bytes_sent: 56
+use test;
+SET timestamp=
+SELECT 2;
SET GLOBAL slow_query_
SET SESSION long_query_
SET SESSION min_examined_
mysqltest: Result content mismatch