为什么日志语句会改变程序的输出？

Question

我曾经在一次采访中被问到以下问题，但我一直没有很清楚地回答。 我想知道是否有人知道我可以在哪里了解更多信息，谷歌搜索没有多大帮助：

假设您有一个想要测试的程序。 您添加一条日志语句，突然，产生预期输出的程序停止产生预期输出。 可能发生了什么？

Answer 1

啊哈。 我其实也遇到过这样的情况。

让我们考虑一个程序，该程序有一个正在破坏堆栈的错误。 如果引入日志或打印语句，对日志的调用可能会移动堆栈足以导致其改变行为。

思考如何展示一个例子是一个有趣的问题。 可能最容易用 printf 中的错误格式来做到这一点...

好吧，总的来说，至少有一个示例如下所示。

int parent(){ ... printf("%s\n", itoa(child()));

int child(){
    int num;
    scanf("%d%d", num);  /* notice the format; scanf is going to eat more of the
                           * stack than it should.
                           */
    return num;            /* but this return may unwind the stack successfully. */
}

如果您在 return 之前插入 printf() ，就会发生这种情况。

Answer 2

您的程序可能在并发线程之间存在竞争条件，因此对时间的任何更改都可能会改变程序的行为。

通常这是相反的情况，这更糟糕（所谓的Heisenbug）：你的程序行为不当，你想通过添加日志输出来调试它。 但日志输出使问题消失，因此诊断变得非常困难。