Bug 14275

Summary: qemuarm64 parselogs fail due to udev taking to much time
Product: [QA/Testing] Runtime Testing Reporter: Aníbal Limón <anibal>
Component: oeqa/runtimeAssignee: Unassigned <unassigned>
Status: RESOLVED WORKSFORME QA Contact:
Severity: normal    
Priority: Medium CC: alexandre.belloni, kory.maincent, randy.macleod
Version: unspecified   
Target Milestone: 3.4   
Hardware: x86   
OS: Multiple   
Whiteboard: AB-INT
OS type for building Yocto: --- Type of Regression: ---
Verified: Documentation change: No (bug/feature does not impact docs)

Description Aníbal Limón 2021-03-02 00:44:26 UTC
Udev is taking to much time to execute, causing the test to failure,

...
Traceback (most recent call last):
  File "/home/pokybuild/yocto-worker/qemuarm64/build/meta/lib/oeqa/core/decorator/__init__.py", line 36, in wrapped_f
    return func(*args, **kwargs)
  File "/home/pokybuild/yocto-worker/qemuarm64/build/meta/lib/oeqa/runtime/cases/parselogs.py", line 375, in test_parselogs
    self.assertEqual(errcount, 0, msg=self.msg)
AssertionError: 2 != 0 : Log: /home/pokybuild/yocto-worker/qemuarm64/build/build/tmp/work/qemuarm64-poky-linux/core-image-sato-sdk/1.0-r0/target_logs/dmesg
-----------------------
Central error: [  339.385755] udevd[117]: worker [136] failed while handling '/devices/virtual/block/ram2'
***********************
[  313.383024] udevd[122]: slow: '/etc/udev/scripts/mount.sh' [130]
[  313.383508] udevd[132]: timeout '/etc/udev/scripts/mount.sh'
[  313.383882] udevd[132]: slow: '/etc/udev/scripts/mount.sh' [134]
[  313.384765] udevd[121]: timeout: killing '/etc/udev/scripts/network.sh' [129]
[  313.385342] udevd[121]: slow: '/etc/udev/scripts/network.sh' [129]
[  327.505972] udevd[117]: worker [127] /devices/virtual/block/ram4 is taking a long time
[  327.506942] udevd[117]: worker [125] /devices/virtual/block/ram5 is taking a long time
[  339.369358] udevd[117]: worker [136] /devices/virtual/block/ram2 timeout; kill it
[  339.378455] udevd[117]: seq 698 '/devices/virtual/block/ram2' killed
[  339.380248] udevd[117]: worker [136] terminated by signal 9 (Killed)
[  339.385755] udevd[117]: worker [136] failed while handling '/devices/virtual/block/ram2'
[  343.894086] udevd[117]: worker [124] /devices/virtual/block/ram6 is taking a long time
[  371.129877] udevd[117]: worker [135] /devices/virtual/block/ram7 is taking a long time
[  371.130741] udevd[117]: worker [126] /devices/virtual/block/ram8 is taking a long time
...

From,

https://autobuilder.yoctoproject.org/typhoon/#/builders/42/builds/3128/steps/14/logs/stdio
Comment 2 Randy MacLeod 2021-07-22 14:59:48 UTC
We are running qemu from tmpfs now and this hasn't happened since March 9th.
It may have been due to the RCU hang as well.