test_in_tail: Try to fix an unstable test_shutdown_timeout

Probably the cause is that recording start time is too early.

Signed-off-by: Takuro Ashie <[email protected]>

test/plugin/test_in_tail.rb

@@ -2492,6 +2492,7 @@ def test_EACCES
 
   def test_shutdown_timeout
     File.open("#{@tmp_dir}/tail.txt", "wb") do |f|
+      # Should be large enough to take too long time to consume
       (1024 * 1024 * 5).times do
         f.puts "{\"test\":\"fizzbuzz\"}"
       end
@@ -2509,13 +2510,17 @@ def test_shutdown_timeout
       io_handler
     end
 
-    start_time = Fluent::Clock.now
+    shutdown_start_time = 0
     assert_nothing_raised do
-      d.run(expect_emits: 1)
+      d.run(expect_emits: 1) do
+        sleep 0.1 until d.emit_count > 0
+        shutdown_start_time = Fluent::Clock.now
+      end
     end
 
-    elapsed = Fluent::Clock.now - start_time
-    assert_true(elapsed > 0.5 && elapsed < 2.5)
+    elapsed = Fluent::Clock.now - shutdown_start_time
+    assert_true(elapsed > 0.5 && elapsed < 2.0,
+                "elapsed time: #{elapsed}")
   end
 
   sub_test_case "throttling logs at in_tail level" do