bots Regression with QEMU 8.2.4 → 9.0.2: apparmor="DENIED" operation="open" name="/proc/sys/vm/max_map

Regression with QEMU 8.2.4 → 9.0.2: apparmor="DENIED" operation="open" name="/proc/sys/vm/max_map_count"

Open martinpitt opened this issue 1 year ago • 5 comments

Downstream report: https://bugs.debian.org/1076946

libvirt upstream report: https://gitlab.com/libvirt/libvirt/-/issues/660

Aug 13 '24 04:08 martinpitt

debian-testing Ooops, it happened again

# ----------------------------------------------------------------------
# testWatchdog (__main__.TestMachinesSettings.testWatchdog)
[0813/042417.581878:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9441/devtools/browser/bc7716fd-7de2-4652-8fc3-59477eca969f
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523064552.223,"url":"http://127.0.0.2:9291/cockpit/@localhost/*/po.manifest.js","networkRequestId":"3287.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523064553.383,"url":"http://127.0.0.2:9291/cockpit/@localhost/*/po.js","networkRequestId":"3287.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9291/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523064589.213,"url":"http://127.0.0.2:9291/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9291/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523064589.356,"url":"http://127.0.0.2:9291/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warning: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warning: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warning: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warning: GetStats(subVmTest1, system) failed: Domain not found: no domain with matching uuid '85527663-fdb0-4d08-aa95-1c44d0d3de8a'
audit: type=1400 audit(1723523117.824:81): apparmor="DENIED" operation="open" class="file" profile="libvirt-b029a7e4-2957-4527-9994-2bdb0ab72450" name="/proc/sys/vm/max_map_count" pid=2877 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSettings-testWatchdog-debian-testing-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesSettings-testWatchdog-debian-testing-127.0.0.2-2401-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723523117.824:81): apparmor="DENIED" operation="open" class="file" profile="libvirt-b029a7e4-2957-4527-9994-2bdb0ab72450" name="/proc/sys/vm/max_map_count" pid=2877 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testWatchdog (__main__.TestMachinesSettings.testWatchdog) failed
# 1 TEST FAILED [77s on 7ac4edb2e269]
not ok 79 /work/make-checkout-workdir/test/check-machines-settings TestMachinesSettings.testWatchdog [ND@2]

First occurrence: 2024-08-13T04:25:35.159043+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T04:25:35.159043+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

Aug 13 '24 04:08 cockpituous

debian-testing Ooops, it happened again

# ----------------------------------------------------------------------
# testNICDelete (__main__.TestMachinesNICs.testNICDelete)
[0813/042518.653459:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9760/devtools/browser/9b7ba4af-96ed-4c04-8ddf-4582ca0e6522
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523128875.114,"url":"http://127.0.0.2:9691/cockpit/@localhost/*/po.manifest.js","networkRequestId":"8365.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523128879.363,"url":"http://127.0.0.2:9691/cockpit/@localhost/*/po.js","networkRequestId":"8365.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9691/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523128971.652,"url":"http://127.0.0.2:9691/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9691/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523128971.782,"url":"http://127.0.0.2:9691/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523166121.527,"url":"http://127.0.0.2:9691/cockpit/@localhost/*/po.manifest.js","networkRequestId":"8365.170"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523166122.994,"url":"http://127.0.0.2:9691/cockpit/@localhost/*/po.js","networkRequestId":"8365.171"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9691/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523166151.153,"url":"http://127.0.0.2:9691/machines#vm?name=subVmTest1&connection=system"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9691/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523166151.317,"url":"http://127.0.0.2:9691/machines#vm?name=subVmTest1&connection=system"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1723523170.352:70): apparmor="DENIED" operation="open" class="file" profile="libvirt-5334e83a-124d-4c19-a0b4-e78c82a04eaf" name="/proc/sys/vm/max_map_count" pid=3742 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesNICs-testNICDelete-debian-testing-127.0.0.2-2801-FAIL.js.log
Journal extracted to TestMachinesNICs-testNICDelete-debian-testing-127.0.0.2-2801-FAIL.log.gz
CDP: {"source":"rendering","level":"info","text":"Autofocus processing was blocked because a document already has a focused element.","timestamp":1723523179462.953,"url":"http://127.0.0.2:9691/machines#/vms"}
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd.socket, libvirtd-admin.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723523170.352:70): apparmor="DENIED" operation="open" class="file" profile="libvirt-5334e83a-124d-4c19-a0b4-e78c82a04eaf" name="/proc/sys/vm/max_map_count" pid=3742 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testNICDelete (__main__.TestMachinesNICs.testNICDelete) failed
# 1 TEST FAILED [64s on 7ac4edb2e269]
not ok 68 /work/make-checkout-workdir/test/check-machines-nics TestMachinesNICs.testNICDelete [ND@5]

First occurrence: 2024-08-13T04:26:23.310634+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T04:26:23.310634+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testDisks (__main__.TestMachinesDisks.testDisks)
[0813/042659.800653:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9638/devtools/browser/f173a558-f749-4cf9-b56e-61cc08abfffe
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523237278.841,"url":"http://127.0.0.2:9391/cockpit/@localhost/*/po.manifest.js","networkRequestId":"14244.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523237402.651,"url":"http://127.0.0.2:9391/cockpit/@localhost/*/po.js","networkRequestId":"14244.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9391/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523237501.697,"url":"http://127.0.0.2:9391/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9391/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523237501.821,"url":"http://127.0.0.2:9391/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
WARNING: Waiting for ph_is_present("#vm-subVmTest1-disks-vdc-used") took 8.8 seconds, which is 88% of the timeout.
Restarting vm-subVmTest1, might take a while
audit: type=1400 audit(1723523230.428:113): apparmor="DENIED" operation="open" class="file" profile="libvirt-b99f9793-0438-489f-ac1b-0152ecc2c1cd" name="/proc/sys/vm/max_map_count" pid=8654 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesDisks-testDisks-debian-testing-127.0.0.2-2501-FAIL.js.log
Journal extracted to TestMachinesDisks-testDisks-debian-testing-127.0.0.2-2501-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-ro.socket, libvirtd.socket, libvirtd-admin.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723523230.428:113): apparmor="DENIED" operation="open" class="file" profile="libvirt-b99f9793-0438-489f-ac1b-0152ecc2c1cd" name="/proc/sys/vm/max_map_count" pid=8654 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testDisks (__main__.TestMachinesDisks.testDisks) failed
# 1 TEST FAILED [47s on 7ac4edb2e269]
not ok 32 /work/make-checkout-workdir/test/check-machines-disks TestMachinesDisks.testDisks [ND@3]

First occurrence: 2024-08-13T04:27:47.061329+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T04:27:47.061329+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testBasic (__main__.TestMachinesLifecycle.testBasic)
[0813/042601.757558:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9969/devtools/browser/2cb2cae2-b369-4ba7-b9c6-0dd591a94270
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523174192.976,"url":"http://127.0.0.2:9291/cockpit/@localhost/*/po.manifest.js","networkRequestId":"11110.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523174200.726,"url":"http://127.0.0.2:9291/cockpit/@localhost/*/po.js","networkRequestId":"11110.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9291/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523174297.03,"url":"http://127.0.0.2:9291/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9291/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523174297.151,"url":"http://127.0.0.2:9291/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1723523321.584:194): apparmor="DENIED" operation="open" class="file" profile="libvirt-b81817d9-2e90-4b17-a55b-d87272f1caad" name="/proc/sys/vm/max_map_count" pid=5659 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
audit: type=1400 audit(1723523327.520:207): apparmor="DENIED" operation="open" class="file" profile="libvirt-fad46a86-ea30-4516-b471-db61e86a68b3" name="/proc/sys/vm/max_map_count" pid=5727 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesLifecycle-testBasic-debian-testing-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesLifecycle-testBasic-debian-testing-127.0.0.2-2401-FAIL.log.gz
CDP: {"source":"rendering","level":"info","text":"Autofocus processing was blocked because a document already has a focused element.","timestamp":1723523333331.403,"url":"http://127.0.0.2:9291/machines"}
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd.socket, libvirtd-admin.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723523321.584:194): apparmor="DENIED" operation="open" class="file" profile="libvirt-b81817d9-2e90-4b17-a55b-d87272f1caad" name="/proc/sys/vm/max_map_count" pid=5659 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testBasic (__main__.TestMachinesLifecycle.testBasic) failed
# 1 TEST FAILED [174s on 7ac4edb2e269]
not ok 41 /work/make-checkout-workdir/test/check-machines-lifecycle TestMachinesLifecycle.testBasic [ND@2]

First occurrence: 2024-08-13T04:28:56.702147+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T04:28:56.702147+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testCreatePXE (__main__.TestMachinesCreate.testCreatePXE)
[0813/042850.268311:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9868/devtools/browser/5dbb86be-0d3d-4f3c-897c-91d65fd445ae
Failed to try-restart sssd.service: Unit sssd.service not found.
...+.......+++++++++++++++++++++++++++++++++++++++++++++*..........+.........+...+.........+...+..+...+.............+...............+..+++++++++++++++++++++++++++++++++++++++++++++*......+..........................+.+..+..........+..+.+....................+...+.......+...+...........+..................+.+..+..........+...+.....+.......+............+...+....................+.........+.............+..+.............+...+........+.......+........+......+......+....+......+.....+....+...........+...+..........+...........+..........+...+.................+...............+.+...+.....+....+.................+.+........+.......+.................+...............+.+.....+.+.....+.........+..........+..+...+.......+........+.......+...+..+............+.+..+....+...............+...+...+........+....+......+.................+...................+.....+.+.....+...+.........+.+..+....+........+.............+..+......+................+.........+......+.....+.+....................+.........+.+..+.+...............+.....+.+......+.....+.......+.....+.+.....+.+.........+..+...+...............+....+..+......+...+.......+...+.........+..+......+...+.......+.....+...+...............+...............+.......+..+.............+.................+.+.........+......+...............+.....+......+.+..................+.........+...............+.......................+.......+..+...+......+.+......+..+...+...+.........+.............+.....+....+...+...........+.+.....+.+...+..+...........................+.......+........+...+.......+++++
......+...+.+..+....+...+............+...+..+........................+++++++++++++++++++++++++++++++++++++++++++++*...+.....+.+.....+......+.+...+.....+.+...+..+.+.........+...+...+........+++++++++++++++++++++++++++++++++++++++++++++*......+.........+................+.....+.+...+..+...+............+.+...............+..+.+...............+..+.......+......+.........+..+.........+.........+...+............+...+....+......+...+.....+......+......+.......+..+....+..+..........+.....+.........+.+..................+......+.....+.+.....+.............+...........+..................+......+....+...+..+.......+...+.....+................+.........+..+........................+.........................+...............+...........+..........+........+.+......+...+..+.+.........+..............+................+........+.+......+....................+...+......+................+......+..+..............................+.+..+............+......+.......+...+.........+..+.+.................+...+.........+.+............+..+......+..........+............+..+...+..........+...+..+.......+.....+.+..+.......+.....+..........+...+............+..............+......+......+....+........+.......+........+..........+.................+.........+......+.........+.+...+..+....+.................+.............+..+...+.+...+.....+.+....................+.+.....+.+.....+....+...+...+..+......+......+....+.....+................+........+...+.......+.....+.+.....................+....................+......+...+..........+.............................+.............+........+....+..+...+......+.......+...+............+..+..........+......+.........+..+...+.+..+...............+....+...+........+...+.+.....+...+.+.....+.......+.................+......+...................+..+.+............+..+.........+....+...+.....+.............+...........+...+.+..+.........+......+....+.........+..+...+..........+.........+............+...+............+......+..............+...+.+..+...+......+.........+.......+............+...+..................+++++
-----
rehash: warning: skipping ca-certificates.crt,it does not contain exactly one certificate or CRL
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523339307.636,"url":"http://127.0.0.2:9091/cockpit/@localhost/*/po.manifest.js","networkRequestId":"19028.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523339309.357,"url":"http://127.0.0.2:9091/cockpit/@localhost/*/po.js","networkRequestId":"19028.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9091/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523339401.074,"url":"http://127.0.0.2:9091/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9091/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523339401.258,"url":"http://127.0.0.2:9091/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523351785.36,"url":"http://127.0.0.2:9091/cockpit/@localhost/*/po.manifest.js","networkRequestId":"19028.171"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723523351804.458,"url":"http://127.0.0.2:9091/cockpit/@localhost/*/po.js","networkRequestId":"19028.172"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9091/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523351831.979,"url":"http://127.0.0.2:9091/machines#/vms"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9091/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723523351832.115,"url":"http://127.0.0.2:9091/machines#/vms"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
> warning: Server did not accept the resize request: Unknown reason
CDP: {"source":"rendering","level":"warning","text":"Canvas2D: Multiple readback operations using getImageData are faster with the willReadFrequently attribute set to true. See: https://html.spec.whatwg.org/multipage/canvas.html#concept-canvas-will-read-frequently","timestamp":1723523364049.371,"url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":600,"stackTrace":{"callFrames":[{"functionName":"resize","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":600,"columnNumber":80798},{"functionName":"_resize","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":6378},{"functionName":"_handleExtendedDesktopSize","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":5801},{"functionName":"_handleRect","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":3105},{"functionName":"_framebufferUpdate","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":2484},{"functionName":"_normalMsg","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":1104},{"functionName":"_handleMessage","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":600,"columnNumber":214657},{"functionName":"_recvMessage","scriptId":"30","url":"http://127.0.0.2:9091/cockpit/@localhost/machines/index.js","lineNumber":600,"columnNumber":166800}]}}
> warning: LIST_DOMAIN_SNAPSHOTS action failed for domain /org/libvirt/QEMU/domain/_917f92c6_a1dc_4330_8810_4e6a29c16fa1 : {"problem":null,"name":"org.libvirt.Error","message":"Domain not found: no domain with matching uuid '917f92c6-a1dc-4330-8810-4e6a29c16fa1'"} name: org.libvirt.Error
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
audit: type=1400 audit(1723523362.620:245): apparmor="DENIED" operation="open" class="file" profile="libvirt-917f92c6-a1dc-4330-8810-4e6a29c16fa1" name="/proc/sys/vm/max_map_count" pid=8963 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesCreate-testCreatePXE-debian-testing-127.0.0.2-2201-FAIL.js.log
Journal extracted to TestMachinesCreate-testCreatePXE-debian-testing-127.0.0.2-2201-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd-ro.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723523362.620:245): apparmor="DENIED" operation="open" class="file" profile="libvirt-917f92c6-a1dc-4330-8810-4e6a29c16fa1" name="/proc/sys/vm/max_map_count" pid=8963 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testCreatePXE (__main__.TestMachinesCreate.testCreatePXE) failed
# 1 TEST FAILED [66s on 7ac4edb2e269]
not ok 17 /work/make-checkout-workdir/test/check-machines-create TestMachinesCreate.testCreatePXE [ND@0]

First occurrence: 2024-08-13T04:29:56.874897+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T04:29:56.874897+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testNICDelete (__main__.TestMachinesNICs.testNICDelete)
[0813/054304.050273:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9537/devtools/browser/57351426-72f3-422b-bbcb-aebd37d8760d
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527794144.477,"url":"http://127.0.0.2:9591/cockpit/@localhost/*/po.manifest.js","networkRequestId":"8384.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527794148.226,"url":"http://127.0.0.2:9591/cockpit/@localhost/*/po.js","networkRequestId":"8384.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9591/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527794226.415,"url":"http://127.0.0.2:9591/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9591/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527794226.58,"url":"http://127.0.0.2:9591/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527832018.498,"url":"http://127.0.0.2:9591/cockpit/@localhost/*/po.manifest.js","networkRequestId":"8384.170"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527832047.359,"url":"http://127.0.0.2:9591/cockpit/@localhost/*/po.js","networkRequestId":"8384.171"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9591/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527832049.675,"url":"http://127.0.0.2:9591/machines#vm?name=subVmTest1&connection=system"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9591/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527832049.807,"url":"http://127.0.0.2:9591/machines#vm?name=subVmTest1&connection=system"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: GetStats(subVmTest1, system) failed: Domain not found: no domain with matching uuid '8530d431-0cc9-4633-8017-3c6c478fa873'
audit: type=1400 audit(1723527836.888:70): apparmor="DENIED" operation="open" class="file" profile="libvirt-8530d431-0cc9-4633-8017-3c6c478fa873" name="/proc/sys/vm/max_map_count" pid=5581 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesNICs-testNICDelete-debian-testing-127.0.0.2-2701-FAIL.js.log
Journal extracted to TestMachinesNICs-testNICDelete-debian-testing-127.0.0.2-2701-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd.socket, libvirtd-ro.socket, libvirtd-admin.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723527836.888:70): apparmor="DENIED" operation="open" class="file" profile="libvirt-8530d431-0cc9-4633-8017-3c6c478fa873" name="/proc/sys/vm/max_map_count" pid=5581 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testNICDelete (__main__.TestMachinesNICs.testNICDelete) failed
# 1 TEST FAILED [64s on dee6993d3a63]
not ok 68 /work/make-checkout-workdir/test/check-machines-nics TestMachinesNICs.testNICDelete [ND@4]

First occurrence: 2024-08-13T05:44:08.630501+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T05:44:08.630501+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testDisks (__main__.TestMachinesDisks.testDisks)
[0813/054443.014767:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9652/devtools/browser/238a6836-c835-4082-8fe3-9071ba936536
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527899353.529,"url":"http://127.0.0.2:9591/cockpit/@localhost/*/po.js","networkRequestId":"14114.20"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527899353.736,"url":"http://127.0.0.2:9591/cockpit/@localhost/*/po.manifest.js","networkRequestId":"14114.19"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9591/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527899393.237,"url":"http://127.0.0.2:9591/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9591/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527899393.458,"url":"http://127.0.0.2:9591/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
WARNING: Waiting for ph_is_present("#vm-subVmTest1-disks-vdc-used") took 9.1 seconds, which is 91% of the timeout.
Restarting vm-subVmTest1, might take a while
audit: type=1400 audit(1723527892.648:97): apparmor="DENIED" operation="open" class="file" profile="libvirt-d59033d0-e866-46d2-8758-f6bfaa062d55" name="/proc/sys/vm/max_map_count" pid=7981 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesDisks-testDisks-debian-testing-127.0.0.2-2701-FAIL.js.log
Journal extracted to TestMachinesDisks-testDisks-debian-testing-127.0.0.2-2701-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-ro.socket, libvirtd-admin.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723527892.648:97): apparmor="DENIED" operation="open" class="file" profile="libvirt-d59033d0-e866-46d2-8758-f6bfaa062d55" name="/proc/sys/vm/max_map_count" pid=7981 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testDisks (__main__.TestMachinesDisks.testDisks) failed
# 1 TEST FAILED [45s on dee6993d3a63]
not ok 32 /work/make-checkout-workdir/test/check-machines-disks TestMachinesDisks.testDisks [ND@4]

First occurrence: 2024-08-13T05:45:28.536592+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T05:45:28.536592+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testCreatePXE (__main__.TestMachinesCreate.testCreatePXE)
[0813/054625.609776:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9832/devtools/browser/3e4c56fb-0aae-4b6e-a1c1-6a99d2779b70
Failed to try-restart sssd.service: Unit sssd.service not found.
.+.....+...+.+...+.....+......+.......+++++++++++++++++++++++++++++++++++++++++++++*..+..+....+.....................+...+..+...+...+.......+......+..+++++++++++++++++++++++++++++++++++++++++++++*.....+............+..+..........+...+........+...+....+...+...+..+...+......+..........+......+...+..............+.......+..................+...+...+..+++++
................+++++++++++++++++++++++++++++++++++++++++++++*.+.....+....+...+.....+.+...........+.+..+.......+...+..+.+.........+......+.....+...+.......+..+.......+...+.....+...+............+...+..........+..+.+.....+......+.........+....+..+......+.........+......+.......+...+..+...+.........+......+++++++++++++++++++++++++++++++++++++++++++++*.+....+..+............+...+.........+.+..+............+...+.............+.....+.......+..+................+..............+..........+...+........+...+.+...+..+.+..+.............+.........+...............+......+..............+....+.........+........+....+........+.+...........+..........+...........+.......+..+.+..+...+.........+....+.....+.........+..........+...........+....+...+...+.............................+.......+.....+...+.......+.....+.+.....+...+....+...+.........+.........+..............+..........+......+++++
-----
rehash: warning: skipping ca-certificates.crt,it does not contain exactly one certificate or CRL
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527993940.347,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js","networkRequestId":"18530.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723527993943.69,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.js","networkRequestId":"18530.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527993975.101,"url":"http://127.0.0.2:9191/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723527993975.239,"url":"http://127.0.0.2:9191/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723528006590.908,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.js","networkRequestId":"18530.172"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723528006606.693,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js","networkRequestId":"18530.171"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723528006633.279,"url":"http://127.0.0.2:9191/machines#/vms"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723528006633.52,"url":"http://127.0.0.2:9191/machines#/vms"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
> warning: Server did not accept the resize request: Unknown reason
CDP: {"source":"rendering","level":"warning","text":"Canvas2D: Multiple readback operations using getImageData are faster with the willReadFrequently attribute set to true. See: https://html.spec.whatwg.org/multipage/canvas.html#concept-canvas-will-read-frequently","timestamp":1723528019096.995,"url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":600,"stackTrace":{"callFrames":[{"functionName":"resize","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":600,"columnNumber":80798},{"functionName":"_resize","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":6378},{"functionName":"_handleExtendedDesktopSize","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":5801},{"functionName":"_handleRect","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":3105},{"functionName":"_framebufferUpdate","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":2484},{"functionName":"_normalMsg","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":603,"columnNumber":1104},{"functionName":"_handleMessage","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":600,"columnNumber":214657},{"functionName":"_recvMessage","scriptId":"31","url":"http://127.0.0.2:9191/cockpit/@localhost/machines/index.js","lineNumber":600,"columnNumber":166800}]}}
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
audit: type=1400 audit(1723528017.748:217): apparmor="DENIED" operation="open" class="file" profile="libvirt-1fea7e06-a9d4-4fc2-80d7-a865413109f6" name="/proc/sys/vm/max_map_count" pid=13293 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesCreate-testCreatePXE-debian-testing-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestMachinesCreate-testCreatePXE-debian-testing-127.0.0.2-2301-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd.socket, libvirtd-admin.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723528017.748:217): apparmor="DENIED" operation="open" class="file" profile="libvirt-1fea7e06-a9d4-4fc2-80d7-a865413109f6" name="/proc/sys/vm/max_map_count" pid=13293 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testCreatePXE (__main__.TestMachinesCreate.testCreatePXE) failed
# 1 TEST FAILED [66s on dee6993d3a63]
not ok 17 /work/make-checkout-workdir/test/check-machines-create TestMachinesCreate.testCreatePXE [ND@1]

First occurrence: 2024-08-13T05:47:31.646132+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc Times recorded: 1 Latest occurrences:

2024-08-13T05:47:31.646132+00:00 | revision dee48a5fc6c2ea518972576af36e65532b408dbc

# ----------------------------------------------------------------------
# testNICDelete (__main__.TestMachinesNICs.testNICDelete)
[0813/090842.862467:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:9993/devtools/browser/8959bc6c-68cc-4f60-a080-aeec40d03b18
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540131594.406,"url":"http://127.0.0.2:9891/cockpit/@localhost/*/po.manifest.js","networkRequestId":"8259.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540131597.761,"url":"http://127.0.0.2:9891/cockpit/@localhost/*/po.js","networkRequestId":"8259.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9891/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540131639.876,"url":"http://127.0.0.2:9891/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9891/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540131640.146,"url":"http://127.0.0.2:9891/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540168983.93,"url":"http://127.0.0.2:9891/cockpit/@localhost/*/po.manifest.js","networkRequestId":"8259.170"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540168988.905,"url":"http://127.0.0.2:9891/cockpit/@localhost/*/po.js","networkRequestId":"8259.171"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9891/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540169020.544,"url":"http://127.0.0.2:9891/machines#vm?name=subVmTest1&connection=system"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9891/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540169020.657,"url":"http://127.0.0.2:9891/machines#vm?name=subVmTest1&connection=system"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: GetStats(subVmTest1, system) failed: Domain not found: no domain with matching uuid 'da122d1a-bde0-464d-a9ac-0e2fb295f3ef'
audit: type=1400 audit(1723540173.500:100): apparmor="DENIED" operation="open" class="file" profile="libvirt-da122d1a-bde0-464d-a9ac-0e2fb295f3ef" name="/proc/sys/vm/max_map_count" pid=3715 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesNICs-testNICDelete-debian-testing-127.0.0.2-3001-FAIL.js.log
Journal extracted to TestMachinesNICs-testNICDelete-debian-testing-127.0.0.2-3001-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd-ro.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723540173.500:100): apparmor="DENIED" operation="open" class="file" profile="libvirt-da122d1a-bde0-464d-a9ac-0e2fb295f3ef" name="/proc/sys/vm/max_map_count" pid=3715 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testNICDelete (__main__.TestMachinesNICs.testNICDelete) failed
# 1 TEST FAILED [63s on 27173a08c42d]
not ok 68 /work/make-checkout-workdir/test/check-machines-nics TestMachinesNICs.testNICDelete [ND@7]

First occurrence: 2024-08-13T09:09:46.083542+00:00 | revision c4028e092c2a63465721b37c532cbebe4f8b205d Times recorded: 1 Latest occurrences:

2024-08-13T09:09:46.083542+00:00 | revision c4028e092c2a63465721b37c532cbebe4f8b205d

# ----------------------------------------------------------------------
# testDelete (__main__.TestMachinesLifecycle.testDelete)
[0813/090904.354111:WARNING:sandbox_linux.cc(430)] InitializeSandbox() called with multiple threads in process gpu-process.

DevTools listening on ws://127.0.0.1:10050/devtools/browser/9ad87f02-6e6b-4b6e-865d-dc2deeb180bb
Failed to try-restart sssd.service: Unit sssd.service not found.
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540152752.429,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js","networkRequestId":"9455.19"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540152754.294,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.js","networkRequestId":"9455.20"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540152815.587,"url":"http://127.0.0.2:9191/machines"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540152815.737,"url":"http://127.0.0.2:9191/machines"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warning: Server did not accept the resize request: Unknown reason
> info: Connection lost:  {"isTrusted":"false","detail":"Object","type":"disconnect","target":"null","currentTarget":"null"}
> error: Tried changing state of a disconnected RFB object
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540194336.411,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.js","networkRequestId":"9455.172"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540194352.715,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js","networkRequestId":"9455.171"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540194372.079,"url":"http://127.0.0.2:9191/machines#/vms"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540194372.245,"url":"http://127.0.0.2:9191/machines#/vms"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540200256.729,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js","networkRequestId":"9455.322"}
CDP: {"source":"network","level":"error","text":"Failed to load resource: the server responded with a status of 404 (ERROR)","timestamp":1723540200270.098,"url":"http://127.0.0.2:9191/cockpit/@localhost/*/po.js","networkRequestId":"9455.323"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.manifest.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540200288.392,"url":"http://127.0.0.2:9191/machines#/vms"}
CDP: {"source":"security","level":"error","text":"Refused to execute script from 'http://127.0.0.2:9191/cockpit/@localhost/*/po.js' because its MIME type ('text/html') is not executable, and strict MIME type checking is enabled.","timestamp":1723540200288.584,"url":"http://127.0.0.2:9191/machines#/vms"}
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1723540162.768:98): apparmor="DENIED" operation="open" class="file" profile="libvirt-023063c4-be48-40b1-a8b7-6f95c2df405d" name="/proc/sys/vm/max_map_count" pid=5666 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
audit: type=1400 audit(1723540209.888:126): apparmor="DENIED" operation="open" class="file" profile="libvirt-aa1890cd-7173-4bca-bd7a-ea409dbaa796" name="/proc/sys/vm/max_map_count" pid=6043 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesLifecycle-testDelete-debian-testing-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestMachinesLifecycle-testDelete-debian-testing-127.0.0.2-2301-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd.socket, libvirtd-ro.socket, libvirtd-admin.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 515, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1765, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2025, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1723540162.768:98): apparmor="DENIED" operation="open" class="file" profile="libvirt-023063c4-be48-40b1-a8b7-6f95c2df405d" name="/proc/sys/vm/max_map_count" pid=5666 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testDelete (__main__.TestMachinesLifecycle.testDelete) failed
# 1 TEST FAILED [86s on 27173a08c42d]
not ok 47 /work/make-checkout-workdir/test/check-machines-lifecycle TestMachinesLifecycle.testDelete [ND@1]

First occurrence: 2024-08-13T09:10:31.206390+00:00 | revision c4028e092c2a63465721b37c532cbebe4f8b205d Times recorded: 1 Latest occurrences:

2024-08-13T09:10:31.206390+00:00 | revision c4028e092c2a63465721b37c532cbebe4f8b205d

# ----------------------------------------------------------------------
# testCreatePXE (__main__.TestMachinesCreate.testCreatePXE)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 39125
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
Failed to try-restart sssd.service: Unit sssd.service not found.
bash: line 1: rpmquery: command not found
................+..+.+..+..........+..+...+++++++++++++++++++++++++++++++++++++++++++++*.......+++++++++++++++++++++++++++++++++++++++++++++*.....+..+................+..+.......+..+.+.....+.............+..+.......+.....+............+.........+.........+.+............+.....+....+...+....................+.......+.....+....+....................+..........+............+...+......+...+...........+......+....+............................................+............+...+.+...........+..........+.....+..........+.....+.+............+.....+................+...............+..+...+....+.................+....+............+.....+.........+.+...+..+.........+.............+......+.....+.+...+.....+++++
....+.+.....+.......+......+++++++++++++++++++++++++++++++++++++++++++++*..+..+......+...+....+.................+...+......+.+........+...+.........+...+++++++++++++++++++++++++++++++++++++++++++++*........+...+.....................+.......+++++
-----
rehash: warning: skipping ca-certificates.crt, it does not contain exactly one certificate or CRL
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: GET_NETWORK action failed for path /org/libvirt/QEMU/network/_d41fdb27_b4c1_471e_89ac_acb80feaa506 Network not found: no network with matching uuid 'd41fdb27-b4c1-471e-89ac-acb80feaa506'
> warn: cockpit.format_{bytes,bits}[_per_sec](..., MiB, [object Object]) is deprecated.
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: cockpit.format_{bytes,bits}[_per_sec](..., MiB, [object Object]) is deprecated.
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
> warn: Server did not accept the resize request: Unknown reason
> warn: Server did not accept the resize request: Unknown reason
> warn: LIST_DOMAIN_SNAPSHOTS action failed for domain /org/libvirt/QEMU/domain/_38c3f20a_d96a_4a7c_b966_10daf38703dc : {"problem":null,"name":"org.libvirt.Error","message":"Domain not found: no domain with matching uuid '38c3f20a-d96a-4a7c-b966-10daf38703dc'"} name: org.libvirt.Error
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
audit: type=1400 audit(1727202362.504:166): apparmor="DENIED" operation="open" class="file" profile="libvirt-38c3f20a-d96a-4a7c-b966-10daf38703dc" name="/proc/sys/vm/max_map_count" pid=11239 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
audit: type=1400 audit(1727202390.276:180): apparmor="DENIED" operation="open" class="file" profile="libvirt-77b3992e-21cf-4fb8-98e5-70ab24db02af" name="/proc/sys/vm/max_map_count" pid=11368 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesCreate-testCreatePXE-debian-testing-127.0.0.2-2301-FAIL.js.log
Journal extracted to TestMachinesCreate-testCreatePXE-debian-testing-127.0.0.2-2301-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd.socket, libvirtd-ro.socket, libvirtd-admin.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1905, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2165, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1727202362.504:166): apparmor="DENIED" operation="open" class="file" profile="libvirt-38c3f20a-d96a-4a7c-b966-10daf38703dc" name="/proc/sys/vm/max_map_count" pid=11239 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testCreatePXE (__main__.TestMachinesCreate.testCreatePXE) failed
# 1 TEST FAILED [66s on 27fb2e1074c9]
not ok 17 /work/make-checkout-workdir/test/check-machines-create TestMachinesCreate.testCreatePXE [ND@1]

First occurrence: 2024-09-24T18:26:38.514781+00:00 | revision 203e1c9d583715d6ed4687139e2f8c9319c7e2c8 Times recorded: 1 Latest occurrences:

2024-09-24T18:26:38.514781+00:00 | revision 203e1c9d583715d6ed4687139e2f8c9319c7e2c8

Aug 13 '24 04:08 cockpituous

ubuntu-stable Ooops, it happened again

# ----------------------------------------------------------------------
# testSnapshotRevert (__main__.TestMachinesSnapshots.testSnapshotRevert)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 51749
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1724772364.886:186): apparmor="DENIED" operation="open" class="file" profile="libvirt-39ea08ae-4e17-428a-a4b6-b5d887061038" name="/proc/sys/vm/max_map_count" pid=2258 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSnapshots-testSnapshotRevert-ubuntu-stable-127.0.0.2-3001-FAIL.js.log
Journal extracted to TestMachinesSnapshots-testSnapshotRevert-ubuntu-stable-127.0.0.2-3001-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd-ro.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724772364.886:186): apparmor="DENIED" operation="open" class="file" profile="libvirt-39ea08ae-4e17-428a-a4b6-b5d887061038" name="/proc/sys/vm/max_map_count" pid=2258 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testSnapshotRevert (__main__.TestMachinesSnapshots.testSnapshotRevert) failed
# 1 TEST FAILED [62s on 52828c6ce621]
not ok 81 /work/make-checkout-workdir/test/check-machines-snapshots TestMachinesSnapshots.testSnapshotRevert [ND@7]

First occurrence: 2024-08-27T15:26:13.115262+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999 Times recorded: 1 Latest occurrences:

2024-08-27T15:26:13.115262+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999

Aug 27 '24 15:08 cockpituous

ubuntu-stable Ooops, it happened again

# ----------------------------------------------------------------------
# testVsock (__main__.TestMachinesSettings.testVsock)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 49297
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
ERROR    XML error: only a single vsock device is supported
audit: type=1400 audit(1724772388.023:172): apparmor="DENIED" operation="open" class="file" profile="libvirt-0f0f38ce-53f7-4863-869b-ee88440eb2f3" name="/proc/sys/vm/max_map_count" pid=3721 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSettings-testVsock-ubuntu-stable-127.0.0.2-2701-FAIL.js.log
Journal extracted to TestMachinesSettings-testVsock-ubuntu-stable-127.0.0.2-2701-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724772388.023:172): apparmor="DENIED" operation="open" class="file" profile="libvirt-0f0f38ce-53f7-4863-869b-ee88440eb2f3" name="/proc/sys/vm/max_map_count" pid=3721 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testVsock (__main__.TestMachinesSettings.testVsock) failed
# 1 TEST FAILED [26s on 52828c6ce621]
not ok 78 /work/make-checkout-workdir/test/check-machines-settings TestMachinesSettings.testVsock [ND@4]

First occurrence: 2024-08-27T15:26:35.509239+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999 Times recorded: 1 Latest occurrences:

2024-08-27T15:26:35.509239+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999

Aug 27 '24 15:08 cockpituous

ubuntu-stable Ooops, it happened again

# ----------------------------------------------------------------------
# testSnapshotCreate (__main__.TestMachinesSnapshots.testSnapshotCreate)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 35037
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: DomainSnapshot method GetXMLDesc failed unknown error
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1724772398.286:276): apparmor="DENIED" operation="open" class="file" profile="libvirt-eacf96f1-f66b-4412-972a-002f8f15f314" name="/proc/sys/vm/max_map_count" pid=4038 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSnapshots-testSnapshotCreate-ubuntu-stable-127.0.0.2-2201-FAIL.js.log
Journal extracted to TestMachinesSnapshots-testSnapshotCreate-ubuntu-stable-127.0.0.2-2201-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724772398.286:276): apparmor="DENIED" operation="open" class="file" profile="libvirt-eacf96f1-f66b-4412-972a-002f8f15f314" name="/proc/sys/vm/max_map_count" pid=4038 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testSnapshotCreate (__main__.TestMachinesSnapshots.testSnapshotCreate) failed
# 1 TEST FAILED [56s on 52828c6ce621]
not ok 80 /work/make-checkout-workdir/test/check-machines-snapshots TestMachinesSnapshots.testSnapshotCreate [ND@0]

First occurrence: 2024-08-27T15:26:46.610968+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999 Times recorded: 1 Latest occurrences:

2024-08-27T15:26:46.610968+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999

# ----------------------------------------------------------------------
# testWatchdog (__main__.TestMachinesSettings.testWatchdog)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 58733
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
audit: type=1400 audit(1724772426.014:213): apparmor="DENIED" operation="open" class="file" profile="libvirt-64f35aa7-d603-474b-a247-d9675249239e" name="/proc/sys/vm/max_map_count" pid=4050 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSettings-testWatchdog-ubuntu-stable-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesSettings-testWatchdog-ubuntu-stable-127.0.0.2-2401-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd-ro.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724772426.014:213): apparmor="DENIED" operation="open" class="file" profile="libvirt-64f35aa7-d603-474b-a247-d9675249239e" name="/proc/sys/vm/max_map_count" pid=4050 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testWatchdog (__main__.TestMachinesSettings.testWatchdog) failed
# 1 TEST FAILED [80s on 52828c6ce621]
not ok 79 /work/make-checkout-workdir/test/check-machines-settings TestMachinesSettings.testWatchdog [ND@2]

First occurrence: 2024-08-27T15:27:22.733077+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999 Times recorded: 1 Latest occurrences:

2024-08-27T15:27:22.733077+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999

# ----------------------------------------------------------------------
# testDisks (__main__.TestMachinesDisks.testDisks)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 47553
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
WARNING: Waiting for ph_is_present("#vm-subVmTest1-disks-vdc-used") took 9.0 seconds, which is 90% of the timeout.
Restarting vm-subVmTest1, might take a while
audit: type=1400 audit(1724772552.082:351): apparmor="DENIED" operation="open" class="file" profile="libvirt-80c31876-c1d3-4453-b1b1-606da0cf2d83" name="/proc/sys/vm/max_map_count" pid=10453 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesDisks-testDisks-ubuntu-stable-127.0.0.2-2201-FAIL.js.log
Journal extracted to TestMachinesDisks-testDisks-ubuntu-stable-127.0.0.2-2201-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-ro.socket, libvirtd-admin.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724772552.082:351): apparmor="DENIED" operation="open" class="file" profile="libvirt-80c31876-c1d3-4453-b1b1-606da0cf2d83" name="/proc/sys/vm/max_map_count" pid=10453 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testDisks (__main__.TestMachinesDisks.testDisks) failed
# 1 TEST FAILED [47s on 52828c6ce621]
not ok 32 /work/make-checkout-workdir/test/check-machines-disks TestMachinesDisks.testDisks [ND@0]

First occurrence: 2024-08-27T15:29:49.675037+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999 Times recorded: 1 Latest occurrences:

2024-08-27T15:29:49.675037+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999

# ----------------------------------------------------------------------
# testCreatePXE (__main__.TestMachinesCreate.testCreatePXE)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 47459
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
...........+.+..+.......+...+........+...+....+.....+.+.........+..+.........+.+...........+....+++++++++++++++++++++++++++++++++++++++++++++*....+...+......+.........+......+.....+.+...+...+..+......+......+....+......+........+......+.+++++++++++++++++++++++++++++++++++++++++++++*...+..........+.........+..+...+...+...+..........+...........+.............+..+.........+............+...+.......+...+...........+...+.+.....+.+..............+.+...+.................+...+...............+.+...............+......+...+.................+...+.+..+.......+..+...+..........+...+...+...........+......+....+...+..+......+...+.........+......+......+...+.......+...............+...+.....+......+.......+............+...+...+..+....+.........+.....+................+...+......+............+...+......+........................+.....+..........+++++
...+..........+...+....................+.+...........+..........+...+......+++++++++++++++++++++++++++++++++++++++++++++*........+..+......+...+......+...+.+..............+++++++++++++++++++++++++++++++++++++++++++++*...+......+..+.......+......+..+...+.......+..............+.........+......................+.....+...+....+...+.....+.........+......+.........+....+......+...+...+...+..+...+.+......+..+.+...........+.+...+.........+........+.........+.+.....+.......+...............+..........................+......+...............+....+.....+.......+..............+......+...................+...+........+....+..................+...+...+................................+...+.+...+......+..+.........+..................+......+.......+........+.......+........+................+.....+...............+......+.......+........+.......+..+......+...+............+...................+......+...+...........+.+..+...+.......+..+.+...+..............+++++
-----
rehash: warning: skipping ca-certificates.crt, it does not contain exactly one certificate or CRL
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: GET_NETWORK action failed for path /org/libvirt/QEMU/network/_54416ba1_8c82_4f71_bf78_885d5d68861a Network not found: no network with matching uuid '54416ba1-8c82-4f71-bf78-885d5d68861a'
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
> warn: Server did not accept the resize request: Unknown reason
> warn: LIST_DOMAIN_SNAPSHOTS action failed for domain /org/libvirt/QEMU/domain/_d08279f6_8baa_4d93_bab5_febbcb357dcd : {"problem":null,"name":"org.libvirt.Error","message":"Domain not found: no domain with matching uuid 'd08279f6-8baa-4d93-bab5-febbcb357dcd'"} name: org.libvirt.Error
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> warn: GetStats(pxe-guest, system) failed: Domain not found: no domain with matching uuid 'd08279f6-8baa-4d93-bab5-febbcb357dcd'
> error: Tried changing state of a disconnected RFB object
audit: type=1400 audit(1724772697.072:416): apparmor="DENIED" operation="open" class="file" profile="libvirt-d08279f6-8baa-4d93-bab5-febbcb357dcd" name="/proc/sys/vm/max_map_count" pid=11741 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesCreate-testCreatePXE-ubuntu-stable-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesCreate-testCreatePXE-ubuntu-stable-127.0.0.2-2401-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724772697.072:416): apparmor="DENIED" operation="open" class="file" profile="libvirt-d08279f6-8baa-4d93-bab5-febbcb357dcd" name="/proc/sys/vm/max_map_count" pid=11741 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testCreatePXE (__main__.TestMachinesCreate.testCreatePXE) failed
# 1 TEST FAILED [57s on 52828c6ce621]
not ok 17 /work/make-checkout-workdir/test/check-machines-create TestMachinesCreate.testCreatePXE [ND@2]

First occurrence: 2024-08-27T15:31:59.626452+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999 Times recorded: 1 Latest occurrences:

2024-08-27T15:31:59.626452+00:00 | revision d635865895ab9d5a3b8ce6f54c9303a13b9d4999

# ----------------------------------------------------------------------
# testWatchdog (__main__.TestMachinesSettings.testWatchdog)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 53021
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
audit: type=1400 audit(1724783330.221:213): apparmor="DENIED" operation="open" class="file" profile="libvirt-9b06cf55-7523-402d-b1ee-1da53fb36d77" name="/proc/sys/vm/max_map_count" pid=4064 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSettings-testWatchdog-ubuntu-stable-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesSettings-testWatchdog-ubuntu-stable-127.0.0.2-2401-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724783330.221:213): apparmor="DENIED" operation="open" class="file" profile="libvirt-9b06cf55-7523-402d-b1ee-1da53fb36d77" name="/proc/sys/vm/max_map_count" pid=4064 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testWatchdog (__main__.TestMachinesSettings.testWatchdog) failed
# 1 TEST FAILED [86s on d342b5934021]
not ok 79 /work/make-checkout-workdir/test/check-machines-settings TestMachinesSettings.testWatchdog [ND@2]

First occurrence: 2024-08-27T18:29:08.969334+00:00 | revision 32f615fc4f8d85841c692aa8994c3af2290f6fa2 Times recorded: 1 Latest occurrences:

2024-08-27T18:29:08.969334+00:00 | revision 32f615fc4f8d85841c692aa8994c3af2290f6fa2

# ----------------------------------------------------------------------
# testWatchdog (__main__.TestMachinesSettings.testWatchdog)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 52783
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
> warn: ExpandableSection: The toggleId value must be passed in and must match the toggleId of the ExpandableSectionToggle.
audit: type=1400 audit(1724783477.197:213): apparmor="DENIED" operation="open" class="file" profile="libvirt-48db0f97-d18c-48fc-96ba-cb23b9ca53c4" name="/proc/sys/vm/max_map_count" pid=4053 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSettings-testWatchdog-ubuntu-stable-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesSettings-testWatchdog-ubuntu-stable-127.0.0.2-2401-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724783477.197:213): apparmor="DENIED" operation="open" class="file" profile="libvirt-48db0f97-d18c-48fc-96ba-cb23b9ca53c4" name="/proc/sys/vm/max_map_count" pid=4053 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testWatchdog (__main__.TestMachinesSettings.testWatchdog) failed
# 1 TEST FAILED [81s on 60f553ad0390]
not ok 79 /work/make-checkout-workdir/test/check-machines-settings TestMachinesSettings.testWatchdog [ND@2]

First occurrence: 2024-08-27T18:31:35.045943+00:00 | revision 32f615fc4f8d85841c692aa8994c3af2290f6fa2 Times recorded: 1 Latest occurrences:

2024-08-27T18:31:35.045943+00:00 | revision 32f615fc4f8d85841c692aa8994c3af2290f6fa2

# ----------------------------------------------------------------------
# testDisks (__main__.TestMachinesDisks.testDisks)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 35141
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
WARNING: Waiting for ph_is_present("#vm-subVmTest1-disks-vdc-used") took 9.0 seconds, which is 90% of the timeout.
Restarting vm-subVmTest1, might take a while
audit: type=1400 audit(1724783617.217:343): apparmor="DENIED" operation="open" class="file" profile="libvirt-fb3a1ade-eefc-4a18-88df-015d2b0f46c5" name="/proc/sys/vm/max_map_count" pid=7192 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesDisks-testDisks-ubuntu-stable-127.0.0.2-2401-FAIL.js.log
Journal extracted to TestMachinesDisks-testDisks-ubuntu-stable-127.0.0.2-2401-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-ro.socket, libvirtd-admin.socket, libvirtd.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724783617.217:343): apparmor="DENIED" operation="open" class="file" profile="libvirt-fb3a1ade-eefc-4a18-88df-015d2b0f46c5" name="/proc/sys/vm/max_map_count" pid=7192 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testDisks (__main__.TestMachinesDisks.testDisks) failed
# 1 TEST FAILED [45s on 60f553ad0390]
not ok 32 /work/make-checkout-workdir/test/check-machines-disks TestMachinesDisks.testDisks [ND@2]

First occurrence: 2024-08-27T18:34:10.576015+00:00 | revision 32f615fc4f8d85841c692aa8994c3af2290f6fa2 Times recorded: 1 Latest occurrences:

2024-08-27T18:34:10.576015+00:00 | revision 32f615fc4f8d85841c692aa8994c3af2290f6fa2

# ----------------------------------------------------------------------
# testSnapshotRevert (__main__.TestMachinesSnapshots.testSnapshotRevert)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 49771
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1724822567.216:186): apparmor="DENIED" operation="open" class="file" profile="libvirt-b765326f-259f-4bf1-bf51-58dabc5a2558" name="/proc/sys/vm/max_map_count" pid=2251 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSnapshots-testSnapshotRevert-ubuntu-stable-127.0.0.2-3001-FAIL.js.log
Journal extracted to TestMachinesSnapshots-testSnapshotRevert-ubuntu-stable-127.0.0.2-3001-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-ro.socket, libvirtd.socket, libvirtd-admin.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724822567.216:186): apparmor="DENIED" operation="open" class="file" profile="libvirt-b765326f-259f-4bf1-bf51-58dabc5a2558" name="/proc/sys/vm/max_map_count" pid=2251 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testSnapshotRevert (__main__.TestMachinesSnapshots.testSnapshotRevert) failed
# 1 TEST FAILED [63s on 58fc9670a915]
not ok 81 /work/make-checkout-workdir/test/check-machines-snapshots TestMachinesSnapshots.testSnapshotRevert [ND@7]

First occurrence: 2024-08-28T05:22:55.098069+00:00 | revision e3780ed3477a311d0576fb4fe6ac457c70a963fd Times recorded: 1 Latest occurrences:

2024-08-28T05:22:55.098069+00:00 | revision e3780ed3477a311d0576fb4fe6ac457c70a963fd

# ----------------------------------------------------------------------
# testSnapshotRevert (__main__.TestMachinesSnapshots.testSnapshotRevert)
Starting ChromeDriver 127.0.6533.99 (f31af5097d90ef5ae5bd7b8700199bc6189ba34d-refs/branch-heads/6533@{#1910}) on port 45729
Only local connections are allowed.
Please see https://chromedriver.chromium.org/security-considerations for suggestions on keeping ChromeDriver safe.
ChromeDriver was started successfully.
bash: line 1: rpmquery: command not found
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
audit: type=1400 audit(1724822630.577:186): apparmor="DENIED" operation="open" class="file" profile="libvirt-a4d7c994-d3e9-4ca9-8531-6a15fa8d5656" name="/proc/sys/vm/max_map_count" pid=2252 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesSnapshots-testSnapshotRevert-ubuntu-stable-127.0.0.2-3001-FAIL.js.log
Journal extracted to TestMachinesSnapshots-testSnapshotRevert-ubuntu-stable-127.0.0.2-3001-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 527, in tearDown
    super().tearDown()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1904, in tearDown
    self.check_journal_messages()
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2164, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1724822630.577:186): apparmor="DENIED" operation="open" class="file" profile="libvirt-a4d7c994-d3e9-4ca9-8531-6a15fa8d5656" name="/proc/sys/vm/max_map_count" pid=2252 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testSnapshotRevert (__main__.TestMachinesSnapshots.testSnapshotRevert) failed
# 1 TEST FAILED [63s on 837a7ed31271]
not ok 81 /work/make-checkout-workdir/test/check-machines-snapshots TestMachinesSnapshots.testSnapshotRevert [ND@7]

First occurrence: 2024-08-28T05:23:57.941519+00:00 | revision e3780ed3477a311d0576fb4fe6ac457c70a963fd Times recorded: 1 Latest occurrences:

2024-08-28T05:23:57.941519+00:00 | revision e3780ed3477a311d0576fb4fe6ac457c70a963fd

> error: spawn 'vm creation' returned error: "{"problem":null,"exit_status":1,"exit_signal":null,"message":"ERROR    Domain not found: no domain with matching uuid '4e4c8de3-c53e-4c58-bc5d-6a169ed77376' (pxe-guest)\nDomain installation does not appear to have been successful.\nIf it was, you can restart your domain by running:\n  virsh --connect qemu:///system start pxe-guest\notherwise, please restart your installation.\nTraceback (most recent call last):\n  File \"<string>\", line 373, in <module>\n  File \"<string>\", line 275, in create_vm\n  File \"/usr/lib/python3.12/subprocess.py\", line 466, in check_output\n    return run(*popenargs, stdout=PIPE, timeout=timeout, check=True,\n           ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^\n  File \"/usr/lib/python3.12/subprocess.py\", line 571, in run\n    raise CalledProcessError(retcode, process.args,\nsubprocess.CalledProcessError: Command '['virt-install', '--connect', 'qemu:///system', '--quiet', '--os-variant', 'fedora28', '--memory', '128', '--name', 'pxe-guest', '--check', 'path_in_use=off', '--wait', '-1', '--noautoconsole', '--disk', 'none', '--graphics', 'vnc,listen=127.0.0.1', '--graphics', 'spice,listen=::1', '--pxe', '--network', 'type=direct,source=ens14,source.mode=bridge']' returned non-zero exit status 1."}"
> error: Scrollbar test exception: TypeError: Cannot read properties of null (reading 'appendChild')
> warn: cockpit.format_{bytes,bits}[_per_sec](..., MiB, [object Object]) is deprecated.
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
> warn: Server did not accept the resize request: Unknown reason
> warn: Server did not accept the resize request: Unknown reason
> info: Connection lost:  object
> error: Tried changing state of a disconnected RFB object
audit: type=1400 audit(1745813490.792:386): apparmor="DENIED" operation="open" class="file" profile="libvirt-087697fe-0ba0-4d87-8a40-fc654754eb5b" name="/proc/sys/vm/max_map_count" pid=11978 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0
Wrote JS log to TestMachinesCreate-testCreatePXE-ubuntu-stable-127.0.0.2-2801-FAIL.js.log
Journal extracted to TestMachinesCreate-testCreatePXE-ubuntu-stable-127.0.0.2-2801-FAIL.log.gz
Stopping 'libvirtd.service', but its triggering units are still active:
libvirtd-admin.socket, libvirtd.socket, libvirtd-ro.socket
Traceback (most recent call last):
  File "/work/make-checkout-workdir/test/machineslib.py", line 573, in tearDown
    super().tearDown()
    ~~~~~~~~~~~~~~~~^^
  File "/work/make-checkout-workdir/test/common/testlib.py", line 1990, in tearDown
    self.check_journal_messages()
    ~~~~~~~~~~~~~~~~~~~~~~~~~~~^^
  File "/work/make-checkout-workdir/test/common/testlib.py", line 2253, in check_journal_messages
    raise Error(UNEXPECTED_MESSAGE + "journal messages:\n" + first)
testlib.Error: FAIL: Test completed, but found unexpected journal messages:
audit: type=1400 audit(1745813490.792:386): apparmor="DENIED" operation="open" class="file" profile="libvirt-087697fe-0ba0-4d87-8a40-fc654754eb5b" name="/proc/sys/vm/max_map_count" pid=11978 comm="qemu-system-x86" requested_mask="r" denied_mask="r" fsuid=64055 ouid=0

# Result testCreatePXE (__main__.TestMachinesCreate.testCreatePXE) failed
# 1 TEST FAILED [66s on 89fd4336e1e5]
not ok 18 /work/make-checkout-workdir/test/check-machines-create TestMachinesCreate.testCreatePXE [ND@5]

First occurrence: 2025-04-28T04:11:39.989589+00:00 | revision 14e31145aab7e6f80245bfc5def246df2f00115d Times recorded: 1 Latest occurrences:

2025-04-28T04:11:39.989589+00:00 | revision 14e31145aab7e6f80245bfc5def246df2f00115d

Aug 27 '24 15:08 cockpituous

bots bots copied to clipboard

Regression with QEMU 8.2.4 → 9.0.2: apparmor="DENIED" operation="open" name="/proc/sys/vm/max_map_count"

bots
bots copied to clipboard