New issue
Advanced search Search tips

Issue 847941 link

Starred by 1 user

Issue metadata

Status: Duplicate
Merged: issue 847927
Owner:
Closed: May 2018
Components:
EstimatedDays: ----
NextAction: ----
OS: Fuchsia
Pri: 2
Type: Bug



Sign in to add a comment

TestLauncher no longer suppresses sub-process output when running multiple jobs

Project Member Reported by w...@chromium.org, May 30 2018

Issue description

In runs like https://ci.chromium.org/buildbot/chromium.fyi/Fuchsia/18065, steps running unit-test suites log both the TestLauncher output, but also the sub-process' output, e.g:

[----------] Global test environment tear-down
[==========] 10 tests from 2 test cases ran. (379 ms total)
[  PASSED  ] 10 tests.
[3051/3076] MainThreadUI/ScopedTaskEnvironmentTest.AsyncTasksRunAsTheyArePostedAfterRunUntilIdle/0 (98 ms)
[3052/3076] MainThreadUI/ScopedTaskEnvironmentTest.DelayedTasks/0 (11 ms)
[3053/3076] MainThreadUI/ScopedTaskEnvironmentTest.SupportsSequenceLocalStorageOnMainThread/0 (5 ms)
[3054/3076] MainThreadIO/ScopedTaskEnvironmentTest.QueuedRunUntilIdle/0 (12 ms)
[3055/3076] MainThreadIO/ScopedTaskEnvironmentTest.AsyncRunUntilIdle/0 (10 ms)
[3056/3076] MainThreadIO/ScopedTaskEnvironmentTest.QueuedTasksDoNotRunOutsideOfRunUntilIdle/0 (206 ms)
[3057/3076] MainThreadIO/ScopedTaskEnvironmentTest.AsyncTasksRunAsTheyArePosted/0 (7 ms)
[3058/3076] MainThreadIO/ScopedTaskEnvironmentTest.AsyncTasksRunAsTheyArePostedAfterRunUntilIdle/0 (7 ms)
[3059/3076] MainThreadIO/ScopedTaskEnvironmentTest.DelayedTasks/0 (7 ms)
[3060/3076] MainThreadIO/ScopedTaskEnvironmentTest.SupportsSequenceLocalStorageOnMainThread/0 (4 ms)
[       OK ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchReadableTwoBytes/0 (201 ms)
[ RUN      ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchReadableByteWrittenFromCallback/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableTwoBytes/0 (202 ms)
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableByteWrittenFromCallback/0
[       OK ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchReadableByteWrittenFromCallback/0 (201 ms)
[ RUN      ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerFromCallback/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableByteWrittenFromCallback/0 (206 ms)
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerFromCallback/0
[       OK ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerFromCallback/0 (201 ms)
[ RUN      ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerBeforeFileDescriptorReadable/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerFromCallback/0 (203 ms)
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerBeforeFileDescriptorReadable/0
[       OK ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerBeforeFileDescriptorReadable/0 (201 ms)
[ RUN      ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerAfterFileDescriptorReadable/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerBeforeFileDescriptorReadable/0 (206 ms)
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerAfterFileDescriptorReadable/0
[       OK ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerAfterFileDescriptorReadable/0 (201 ms)
[ RUN      ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerAfterDeleteMessageLoopForIO/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerAfterFileDescriptorReadable/0 (202 ms)
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerAfterDeleteMessageLoopForIO/0
[       OK ] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerAfterDeleteMessageLoopForIO/0 (101 ms)
[----------] 8 tests from MessageLoopForIOOnMainThread/FileDescriptorWatcherTest (1346 ms total)

[----------] 2 tests from MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchWritable/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchWritable/0 (2 ms)
[ RUN      ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableOneByte/0
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerAfterDeleteMessageLoopForIO/0 (103 ms)
[----------] 6 tests from MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest (1125 ms total)

[----------] Global test environment tear-down
[==========] 6 tests from 1 test case ran. (1128 ms total)
[  PASSED  ] 6 tests.
[3061/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableTwoBytes/0 (202 ms)
[3062/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableByteWrittenFromCallback/0 (206 ms)
[3063/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerFromCallback/0 (203 ms)
[3064/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerBeforeFileDescriptorReadable/0 (206 ms)
[3065/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerAfterFileDescriptorReadable/0 (202 ms)
[3066/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.DeleteControllerAfterDeleteMessageLoopForIO/0 (103 ms)
[       OK ] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableOneByte/0 (201 ms)
[----------] 2 tests from MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest (206 ms total)

[----------] Global test environment tear-down
[==========] 10 tests from 2 test cases ran. (1556 ms total)
[  PASSED  ] 10 tests.
[3067/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchWritable/0 (14 ms)
[3068/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchReadableOneByte/0 (207 ms)
[3069/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchReadableTwoBytes/0 (201 ms)
[3070/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.WatchReadableByteWrittenFromCallback/0 (201 ms)
[3071/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerFromCallback/0 (201 ms)
[3072/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerBeforeFileDescriptorReadable/0 (201 ms)
[3073/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerAfterFileDescriptorReadable/0 (201 ms)
[3074/3076] MessageLoopForIOOnMainThread/FileDescriptorWatcherTest.DeleteControllerAfterDeleteMessageLoopForIO/0 (101 ms)
[3075/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.Watc2018-05-29 22:05:49,594:INFO:root:Process exited normally with status code 0.
2018-05-29 22:05:49,594:INFO:root:Terminating kernel log reader.
2018-05-29 22:05:49,594:INFO:root:Removing package source from device.
2018-05-29 22:05:51,343:INFO:root:Shutting down QEMU.
hWritable/0 (2 ms)
[3076/3076] MessageLoopForIOOnOtherThread/FileDescriptorWatcherTest.WatchReadableOneByte/0 (201 ms)
SUCCESS: all tests passed.
Tests took 103 seconds.
847915
Note also that the "Process exited normally with status code..." logged lines are interleaved with TestLauncher output, similarly to  issue 847915 .

 
sergeyu filed  bug 847927  earlier.

Comment 2 by w...@chromium.org, May 30 2018

Mergedinto: 847927
Status: Duplicate (was: Assigned)

Sign in to add a comment