コンテキスト
ユーザー向けのメッセージを出力するロガーを作成しました。レベルが「debug」、「info」、または「warning」std::coutのメッセージは に出力され、レベルが「error」または「system_error」のメッセージは に出力されstd::cerrます。私のプログラムはマルチスレッドではありません。Linux openSUSE 12.3 と gcc 4.7.2 および CMake 3.1.0 で作業しています。
私の問題
エラー メッセージ (に出力)std::cerrが長い情報メッセージ ( に出力) の後に続き、出力がCTest によってstd::coutファイルにリダイレクトされるときに、エラー メッセージが情報メッセージに表示されることがあることがわかりました (以下の例を参照)。LastTest.log私はこの動作をよく理解していませんが、書き込みスレッドが起動されstd::cout、コードが続行され、最初の書き込みスレッドが終了するのを待たずに別の書き込みスレッドが起動されると思いstd::cerrます。
only を使用せずにそれを回避することは可能std::coutですか?
端末に問題はありません。これは、CTest が出力をLastTest.logファイルにリダイレクトする場合にのみ発生します。
私のバッファがフラッシュされていることに注意してください。std::endlへの呼び出しの後に来るのは問題ではありませんstd::cerr。
例
予想される動作:
[ 12:06:51.497 TRACE ] Start test
[ 12:06:52.837 WARNING ] This
is
a
very
long
warning
message...
[ 12:06:52.837 ERROR ] AT LINE 49 : 7
[ 12:06:52.841 ERROR ] AT LINE 71 : 506
[ 12:06:52.841 TRACE ] End of test
何が起こるのですか ：
[ 12:06:51.497 TRACE ] Start test
[ 12:06:52.837 WARNING ] This
is
a
very
long
[ 12:06:52.837 ERROR ] AT LINE 49 : 7
warning
message...
[ 12:06:52.841 ERROR ] AT LINE 71 : 506
[ 12:06:52.841 TRACE ] End of test
ロガーの呼び方
std::coutこれは、またはstd::cerrロガーを使用して呼び出す方法の例です。私はそのようなマクロでロガーを呼び出します:
#define LOG_DEBUG(X) {if(Log::debug_is_active()){std::ostringstream o;o<<X;Log::debug(o.str());}}
#define LOG_ERROR(X) {if(Log::error_is_active()){std::ostringstream o;o<<X;Log::error(o.str());}}
//...
LOG_DEBUG("This" << std::endl << "is" << std::endl << "a message");
LOG_ERROR("at line " << __LINE__ << " : " << err_id);
と
void Log::debug(const std::string& msg)
{
Log::write_if_active(Log::DEBUG, msg);
}
void Log::error(const std::string& msg)
{
Log::write_if_active(Log::ERROR, msg);
}
//...
void Log::write_if_active(unsigned short int state, const std::string& msg)
{
Instant now;
now.setCurrentTime();
std::vector<std::string> lines;
for(std::size_t k = 0; k < msg.size();)
{
std::size_t next_endl = msg.find('\n', k);
if(next_endl == std::string::npos)
next_endl = msg.size();
lines.push_back(msg.substr(k, next_endl - k));
k = next_endl + 1;
}
boost::mutex::scoped_lock lock(Log::mutex);
for(unsigned long int i = 0; i < Log::chanels.size(); ++i)
if(Log::chanels[i])
if(Log::chanels[i]->flags & state)
Log::chanels[i]->write(state, now, lines);
}
ここで、ログ シャネルは端末出力専用のオブジェクトであり、書き込み関数は次のとおりです。
void Log::StdOut::write(unsigned short int state, const Instant& t, const std::vector<std::string>& lines)
{
assert(lines.size() > 0 && "PRE: empty lines");
std::string prefix = "[ ";
if(this->withDate || this->withTime)
{
std::string pattern = "";
if(this->withDate)
pattern += "%Y-%m-%d ";
if(this->withTime)
pattern += "%H:%M:%S.%Z ";
prefix += t.toString(pattern);
}
std::ostream* out = 0;
if(state == Log::TRACE)
{
prefix += " TRACE";
out = &std::cout;
}
else if(state == Log::DEBUG)
{
prefix += " DEBUG";
out = &std::cout;
}
else if(state == Log::INFO)
{
prefix += " INFO";
out = &std::cout;
}
else if(state == Log::WARNING)
{
prefix += "WARNING";
out = &std::cout;
}
else if(state == Log::ERROR)
{
prefix += " ERROR";
out = &std::cerr;
}
else if(state == Log::SYS_ERROR)
{
prefix += "SYERROR";
out = &std::cerr;
}
else
assert(false && "PRE: Invalid Log state");
prefix += " ] ";
(*out) << prefix << lines[0] << "\n";
prefix = std::string(prefix.size(), ' ');
for(unsigned long int i = 1; i < lines.size(); ++i)
(*out) << prefix << lines[i] << "\n";
out->flush();
}
ログ命令が実行されると、バッファがフラッシュされることがわかります。