Bug 14585 - oe-selftest: tinfoil.TinfoilTests.test_wait_event failure
Summary: oe-selftest: tinfoil.TinfoilTests.test_wait_event failure
Status: RESOLVED FIXED
Alias: None
Product: OE-Core
Classification: Build System, Metadata & Runtime
Component: core (show other bugs)
Version: 5.99
Hardware: x86 Multiple
: Medium+ normal
Target Milestone: 4.0 M4
Assignee: Unassigned
QA Contact:
URL:
Whiteboard: AB-INT AB-SSD
Depends on:
Blocks:
 
Reported: 2021-10-04 03:37 UTC by Naveen Saini
Modified: 2025-02-14 16:48 UTC (History)
8 users (show)

See Also:
OS type for building Yocto: ---
Type of Regression: ---
Verified:
Documentation change: No (bug/feature does not impact docs)


Attachments

Note You need to log in before you can comment on or make changes to this bug.
Description Naveen Saini 2021-10-04 03:37:29 UTC
On master branch, qemux86-64 machine
Worker: debian9-ty-2

https://autobuilder.yoctoproject.org/typhoon/#/builders/56/builds/1609


Error log:
2021-10-02 07:53:59,251 - oe-selftest - INFO - ======================================================================
2021-10-02 07:54:00,977 - oe-selftest - INFO - FAIL: tinfoil.TinfoilTests.test_wait_event (subunit.RemotedTestCase)
2021-10-02 07:54:00,977 - oe-selftest - INFO - ----------------------------------------------------------------------
2021-10-02 07:54:00,977 - oe-selftest - INFO - testtools.testresult.real._StringException: Traceback (most recent call last):
  File "/home/pokybuild/yocto-worker/oe-selftest/build/meta/lib/oeqa/selftest/cases/tinfoil.py", line 121, in test_wait_event
    self.assertTrue(commandcomplete, 'Timed out waiting for CommandCompleted event from bitbake server')
  File "/home/pokybuild/yocto-worker/oe-selftest/build/buildtools/sysroots/x86_64-pokysdk-linux/usr/lib/python3.9/unittest/case.py", line 682, in assertTrue
    raise self.failureException(msg)
AssertionError: False is not true : Timed out waiting for CommandCompleted event from bitbake server
Comment 2 Alexandre Belloni 2021-12-15 23:45:31 UTC
https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/2718/steps/14/logs/stdio

oe-selftest-centos centos8-ty-1
Comment 3 Alexandre Belloni 2022-01-07 13:29:08 UTC
https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/2980/steps/14/logs/stdio

oe-selftest-centos centos8-ty-1
Comment 5 Alexandre Belloni 2022-01-31 20:15:50 UTC
https://autobuilder.yoctoproject.org/typhoon/#/builders/86/builds/3065/steps/14/logs/stdio

fedora35-ty-2 has an SSD
Comment 7 Steve Sakoman 2022-02-24 16:33:22 UTC
Dunfell occurrence:

https://autobuilder.yoctoproject.org/typhoon/#/builders/86/builds/3175/steps/14/logs/stdio

oe-selftest-fedora fedora34-ty-1
Comment 8 Steve Sakoman 2022-03-02 16:03:13 UTC
Dunfell occurrence:

https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/3235

oe-selftest-centos alma8-ty-2 SSD
Comment 9 Alexandre Belloni 2022-03-17 10:26:59 UTC
https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/3280/steps/14/logs/stdio

oe-selftest-centos alma8-ty-1 SSD
Comment 10 Steve Sakoman 2022-03-17 21:28:12 UTC
Dunfell:

https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/3309/steps/14/logs/stdio

oe-selftest-centos alma8-ty-1
Comment 11 Steve Sakoman 2022-03-19 18:25:14 UTC
Dunfell:

https://autobuilder.yoctoproject.org/typhoon/#/builders/87/builds/3319

oe-selftest-ubuntu ubuntu1604-ty-1
Comment 12 Steve Sakoman 2022-03-24 13:55:23 UTC
Dunfell:

https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/3335

oe-selftest-centos centos8-ty-1
Comment 13 Richard Purdie 2022-03-24 15:42:18 UTC
This last failure shows:

AssertionError: False is not true : Timed out waiting for CommandCompleted event from bitbake server (Matching event received: False)

which is with the extra debugging. This means that neither the event we're looking for or the command completed.

I was also able to find the cookerdaemon log:

https://autobuilder.yocto.io/pub/failed-builds-data/centos8-ty-1-20220323-tinfoil/bitbake-cookerdaemon.log

the key piece of which is:

Running command ['setEventMask', 2, 20, {'BitBake.SigGen.HashEquiv': 19, 'BitBake.RunQueue.HashEquiv': 19}, ['bb.event.FilesMatchingFound', 'bb.command.CommandCompleted', 'bb.command.CommandFailed', 'bb.command.CommandExit']]
Running command ['testCookerCommandEvent', 'conf']
Running command ['clientComplete']
Processing Client

so the cooker did get the command and did have an event mask with the right events allowed but the command never ran? It was also alive enough to shut down...
Comment 14 Richard Purdie 2022-03-24 17:49:02 UTC
Issue identified, patches on the list. The issue was tinfoil's run_command swallowing the events.
Comment 15 Alexandre Belloni 2022-03-25 11:48:07 UTC
https://autobuilder.yoctoproject.org/typhoon/#/builders/79/builds/3342/steps/14/logs/stdio

This didn't have the fix
Comment 17 Randy MacLeod 2025-02-14 16:46:22 UTC
bulk change to add Saul's non-WR address.
Comment 18 Randy MacLeod 2025-02-14 16:48:13 UTC
Bulk change: Remove Saul's old WR address.