/* * Copyright (C) 2015 The Android Open Source Project * * Licensed under the Apache License, Version 2.0 (the "License"); * you may not use this file except in compliance with the License. * You may obtain a copy of the License at * * http://www.apache.org/licenses/LICENSE-2.0 * * Unless required by applicable law or agreed to in writing, software * distributed under the License is distributed on an "AS IS" BASIS, * WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied. * See the License for the specific language governing permissions and * limitations under the License. */ #include "android-base/logging.h" #include #if defined(_WIN32) #include #endif #include #include #include "android-base/file.h" #include "android-base/stringprintf.h" #include "android-base/test_utils.h" #include #ifdef __ANDROID__ #define HOST_TEST(suite, name) TEST(suite, DISABLED_ ## name) #else #define HOST_TEST(suite, name) TEST(suite, name) #endif class CapturedStderr { public: CapturedStderr() : old_stderr_(-1) { init(); } ~CapturedStderr() { reset(); } int fd() const { return temp_file_.fd; } private: void init() { #if defined(_WIN32) // On Windows, stderr is often buffered, so make sure it is unbuffered so // that we can immediately read back what was written to stderr. ASSERT_EQ(0, setvbuf(stderr, NULL, _IONBF, 0)); #endif old_stderr_ = dup(STDERR_FILENO); ASSERT_NE(-1, old_stderr_); ASSERT_NE(-1, dup2(fd(), STDERR_FILENO)); } void reset() { ASSERT_NE(-1, dup2(old_stderr_, STDERR_FILENO)); ASSERT_EQ(0, close(old_stderr_)); // Note: cannot restore prior setvbuf() setting. } TemporaryFile temp_file_; int old_stderr_; }; #if defined(_WIN32) static void ExitSignalAbortHandler(int) { _exit(3); } #endif static void SuppressAbortUI() { #if defined(_WIN32) // We really just want to call _set_abort_behavior(0, _CALL_REPORTFAULT) to // suppress the Windows Error Reporting dialog box, but that API is not // available in the OS-supplied C Runtime, msvcrt.dll, that we currently // use (it is available in the Visual Studio C runtime). // // Instead, we setup a SIGABRT handler, which is called in abort() right // before calling Windows Error Reporting. In the handler, we exit the // process just like abort() does. ASSERT_NE(SIG_ERR, signal(SIGABRT, ExitSignalAbortHandler)); #endif } TEST(logging, CHECK) { ASSERT_DEATH({SuppressAbortUI(); CHECK(false);}, "Check failed: false "); CHECK(true); ASSERT_DEATH({SuppressAbortUI(); CHECK_EQ(0, 1);}, "Check failed: 0 == 1 "); CHECK_EQ(0, 0); ASSERT_DEATH({SuppressAbortUI(); CHECK_STREQ("foo", "bar");}, R"(Check failed: "foo" == "bar")"); CHECK_STREQ("foo", "foo"); // Test whether CHECK() and CHECK_STREQ() have a dangling if with no else. bool flag = false; if (true) CHECK(true); else flag = true; EXPECT_FALSE(flag) << "CHECK macro probably has a dangling if with no else"; flag = false; if (true) CHECK_STREQ("foo", "foo"); else flag = true; EXPECT_FALSE(flag) << "CHECK_STREQ probably has a dangling if with no else"; } std::string make_log_pattern(android::base::LogSeverity severity, const char* message) { static const char* log_characters = "VDIWEF"; char log_char = log_characters[severity]; std::string holder(__FILE__); return android::base::StringPrintf( "%c[[:space:]]+[[:digit:]]+[[:space:]]+[[:digit:]]+ %s:[[:digit:]]+] %s", log_char, basename(&holder[0]), message); } TEST(logging, LOG) { ASSERT_DEATH({SuppressAbortUI(); LOG(FATAL) << "foobar";}, "foobar"); // We can't usefully check the output of any of these on Windows because we // don't have std::regex, but we can at least make sure we printed at least as // many characters are in the log message. { CapturedStderr cap; LOG(WARNING) << "foobar"; ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); ASSERT_GT(output.length(), strlen("foobar")); #if !defined(_WIN32) std::regex message_regex( make_log_pattern(android::base::WARNING, "foobar")); ASSERT_TRUE(std::regex_search(output, message_regex)) << output; #endif } { CapturedStderr cap; LOG(INFO) << "foobar"; ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); ASSERT_GT(output.length(), strlen("foobar")); #if !defined(_WIN32) std::regex message_regex( make_log_pattern(android::base::INFO, "foobar")); ASSERT_TRUE(std::regex_search(output, message_regex)) << output; #endif } { CapturedStderr cap; LOG(DEBUG) << "foobar"; ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); ASSERT_TRUE(output.empty()); } { android::base::ScopedLogSeverity severity(android::base::DEBUG); CapturedStderr cap; LOG(DEBUG) << "foobar"; ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); ASSERT_GT(output.length(), strlen("foobar")); #if !defined(_WIN32) std::regex message_regex( make_log_pattern(android::base::DEBUG, "foobar")); ASSERT_TRUE(std::regex_search(output, message_regex)) << output; #endif } // Test whether LOG() saves and restores errno. { CapturedStderr cap; errno = 12345; LOG(INFO) << (errno = 67890); EXPECT_EQ(12345, errno) << "errno was not restored"; ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); EXPECT_NE(nullptr, strstr(output.c_str(), "67890")) << output; #if !defined(_WIN32) std::regex message_regex( make_log_pattern(android::base::INFO, "67890")); ASSERT_TRUE(std::regex_search(output, message_regex)) << output; #endif } // Test whether LOG() has a dangling if with no else. { CapturedStderr cap; // Do the test two ways: once where we hypothesize that LOG()'s if // will evaluate to true (when severity is high enough) and once when we // expect it to evaluate to false (when severity is not high enough). bool flag = false; if (true) LOG(INFO) << "foobar"; else flag = true; EXPECT_FALSE(flag) << "LOG macro probably has a dangling if with no else"; flag = false; if (true) LOG(VERBOSE) << "foobar"; else flag = true; EXPECT_FALSE(flag) << "LOG macro probably has a dangling if with no else"; } } TEST(logging, PLOG) { { CapturedStderr cap; errno = ENOENT; PLOG(INFO) << "foobar"; ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); ASSERT_GT(output.length(), strlen("foobar")); #if !defined(_WIN32) std::regex message_regex(make_log_pattern( android::base::INFO, "foobar: No such file or directory")); ASSERT_TRUE(std::regex_search(output, message_regex)) << output; #endif } } TEST(logging, UNIMPLEMENTED) { { CapturedStderr cap; errno = ENOENT; UNIMPLEMENTED(ERROR); ASSERT_EQ(0, lseek(cap.fd(), 0, SEEK_SET)); std::string output; android::base::ReadFdToString(cap.fd(), &output); ASSERT_GT(output.length(), strlen("unimplemented")); #if !defined(_WIN32) std::string expected_message = android::base::StringPrintf("%s unimplemented ", __PRETTY_FUNCTION__); std::regex message_regex( make_log_pattern(android::base::ERROR, expected_message.c_str())); ASSERT_TRUE(std::regex_search(output, message_regex)) << output; #endif } }