build checks.x86_64-linux.e2e-test

Reproduce this run
  1. 0.51 s $ /nix/store/9ypz3flqsrl5xl495mm8h645gadjsxi1-coreutils-9.11/bin/timeout --kill-after=15s 7200s /nix/store/23zk8sgzamrbmj1fday15szf7f2279s8-nix-2.34.7/bin/nix --extra-experimental-features nix-command --extra-experimental-features flakes --log-format internal-json build --no-link --print-out-paths git+https://github.com/NorfairKing/centjes?ref=refs%2Fpull%2F8%2Fmerge&rev=0861c484ed0514efe3484a4f326b102a38615833&shallow=1#checks.x86_64-linux.e2e-test --print-build-logs
  2. 0.70 s warning: ignoring untrusted flake configuration setting 'extra-substituters'.
  3. 0.70 s Pass '--accept-flake-config' to trust it
  4. 0.70 s warning: ignoring untrusted flake configuration setting 'extra-trusted-public-keys'.
  5. 0.70 s Pass '--accept-flake-config' to trust it
  6. 6.21 s
  7. 6.35 s Downloading cached nixos-test-driver-centjes-e2e-test from https://cache.staging.nix-ci.com
  8. 7.05 s Downloaded cached nixos-test-driver-centjes-e2e-test (1888 B) in 692ms
  9. 7.05 s Progress: 0 of 2 built, 1 of 1 downloaded from cache
  10. 7.17 s Building /nix/store/7r8ws66ysvg4i52nif1hdkwsgig4nd75-vm-test-run-centjes-e2e-test.drv
  11. 8.18 s [vm-test-run-centjes-e2e-test] Machine state will be reset. To keep it, pass --keep-vm-state
  12. 8.18 s [vm-test-run-centjes-e2e-test] start all VLans
  13. 8.18 s [vm-test-run-centjes-e2e-test] start vlan
  14. 8.18 s [vm-test-run-centjes-e2e-test] running vlan (pid 7; ctl /build/vde1.ctl)
  15. 8.18 s [vm-test-run-centjes-e2e-test] (finished: start all VLans, in 0.00 seconds)
  16. 8.18 s [vm-test-run-centjes-e2e-test] Test will time out and terminate in 3600 seconds
  17. 8.19 s [vm-test-run-centjes-e2e-test] run the VM test script
  18. 8.19 s [vm-test-run-centjes-e2e-test] additionally exposed symbols:
  19. 8.19 s [vm-test-run-centjes-e2e-test] client, docsserver,
  20. 8.19 s [vm-test-run-centjes-e2e-test] vlan1,
  21. 8.19 s [vm-test-run-centjes-e2e-test] start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug
  22. 8.19 s [vm-test-run-centjes-e2e-test] docsserver: starting vm
  23. 8.24 s [vm-test-run-centjes-e2e-test] mke2fs 1.47.3 (8-Jul-2025)
  24. 8.42 s [vm-test-run-centjes-e2e-test] docsserver # Disk image does not exist, creating the virtualisation disk image...
  25. 8.43 s [vm-test-run-centjes-e2e-test] docsserver: QEMU running (pid 9)
  26. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Formatting '/build/vm-state-docsserver/tmp.7nWBjeNuE4', fmt=raw size=1073741824
  27. 8.43 s [vm-test-run-centjes-e2e-test] client: starting vm
  28. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Discarding device blocks: 0/262144 done
  29. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Creating filesystem with 262144 4k blocks and 65536 inodes
  30. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Filesystem UUID: 8bafdc3e-a9c6-4182-85ff-ada38abb7a0a
  31. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Superblock backups stored on blocks:
  32. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # 32768, 98304, 163840, 229376
  33. 8.43 s [vm-test-run-centjes-e2e-test] docsserver #
  34. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Allocating group tables: 0/8 done
  35. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Writing inode tables: 0/8 done
  36. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Creating journal (8192 blocks): done
  37. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Writing superblocks and filesystem accounting information: 0/8 done
  38. 8.43 s [vm-test-run-centjes-e2e-test] docsserver #
  39. 8.43 s [vm-test-run-centjes-e2e-test] docsserver # Virtualisation disk image created.
  40. 8.45 s [vm-test-run-centjes-e2e-test] mke2fs 1.47.3 (8-Jul-2025)
  41. 8.53 s [vm-test-run-centjes-e2e-test] docsserver # c[?7lSeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)
  42. 8.58 s [vm-test-run-centjes-e2e-test] client # Disk image does not exist, creating the virtualisation disk image...
  43. 8.58 s [vm-test-run-centjes-e2e-test] client: QEMU running (pid 31)
  44. 8.58 s [vm-test-run-centjes-e2e-test] client # Formatting '/build/vm-state-client/tmp.1YIJzmJuwW', fmt=raw size=1073741824
  45. 8.58 s [vm-test-run-centjes-e2e-test] client # Discarding device blocks: 0/262144 done
  46. 8.58 s [vm-test-run-centjes-e2e-test] docsserver: waiting for unit default.target
  47. 8.58 s [vm-test-run-centjes-e2e-test] docsserver: waiting for the VM to finish booting
  48. 8.60 s [vm-test-run-centjes-e2e-test] client # Creating filesystem with 262144 4k blocks and 65536 inodes
  49. 8.60 s [vm-test-run-centjes-e2e-test] client # Filesystem UUID: 13ea7290-ac56-4d64-9292-a47a8c0330df
  50. 8.60 s [vm-test-run-centjes-e2e-test] client # Superblock backups stored on blocks:
  51. 8.60 s [vm-test-run-centjes-e2e-test] client # 32768, 98304, 163840, 229376
  52. 8.60 s [vm-test-run-centjes-e2e-test] client #
  53. 8.60 s [vm-test-run-centjes-e2e-test] client # Allocating group tables: 0/8 done
  54. 8.60 s [vm-test-run-centjes-e2e-test] client # Writing inode tables: 0/8 done
  55. 8.60 s [vm-test-run-centjes-e2e-test] client # Creating journal (8192 blocks): done
  56. 8.60 s [vm-test-run-centjes-e2e-test] client # Writing superblocks and filesystem accounting information: 0/8 done
  57. 8.60 s [vm-test-run-centjes-e2e-test] client #
  58. 8.60 s [vm-test-run-centjes-e2e-test] client # Virtualisation disk image created.
  59. 8.63 s [vm-test-run-centjes-e2e-test] docsserver #
  60. 8.63 s [vm-test-run-centjes-e2e-test] docsserver #
  61. 8.63 s [vm-test-run-centjes-e2e-test] docsserver # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00
  62. 8.65 s [vm-test-run-centjes-e2e-test] docsserver # Press Ctrl-B to configure iPXE (PCI 00:03.0)...
  63. 8.65 s [vm-test-run-centjes-e2e-test] docsserver #
  64. 8.65 s [vm-test-run-centjes-e2e-test] docsserver #
  65. 8.65 s [vm-test-run-centjes-e2e-test] docsserver #
  66. 8.65 s [vm-test-run-centjes-e2e-test] docsserver #
  67. 8.65 s [vm-test-run-centjes-e2e-test] docsserver # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00
  68. 8.67 s [vm-test-run-centjes-e2e-test] docsserver # Press Ctrl-B to configure iPXE (PCI 00:09.0)...
  69. 8.67 s [vm-test-run-centjes-e2e-test] docsserver #
  70. 8.67 s [vm-test-run-centjes-e2e-test] docsserver #
  71. 8.68 s [vm-test-run-centjes-e2e-test] docsserver # Booting from ROM...
  72. 8.68 s [vm-test-run-centjes-e2e-test] client # c[?7lSeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)
  73. 8.69 s [vm-test-run-centjes-e2e-test] docsserver # Probing EDD (edd=off to disable)... ok
  74. 8.78 s [vm-test-run-centjes-e2e-test] client #
  75. 8.78 s [vm-test-run-centjes-e2e-test] client #
  76. 8.79 s [vm-test-run-centjes-e2e-test] client # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00
  77. 8.80 s [vm-test-run-centjes-e2e-test] client # Press Ctrl-B to configure iPXE (PCI 00:03.0)...
  78. 8.80 s [vm-test-run-centjes-e2e-test] client #
  79. 8.80 s [vm-test-run-centjes-e2e-test] client #
  80. 8.80 s [vm-test-run-centjes-e2e-test] client #
  81. 8.80 s [vm-test-run-centjes-e2e-test] client #
  82. 8.81 s [vm-test-run-centjes-e2e-test] client # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00
  83. 8.82 s [vm-test-run-centjes-e2e-test] client # Press Ctrl-B to configure iPXE (PCI 00:09.0)...
  84. 8.82 s [vm-test-run-centjes-e2e-test] client #
  85. 8.82 s [vm-test-run-centjes-e2e-test] client #
  86. 8.84 s [vm-test-run-centjes-e2e-test] client # Booting from ROM...
  87. 9.01 s [vm-test-run-centjes-e2e-test] docsserver # c[?7l[ 0.000000] Linux version 6.12.62 (nixbld@localhost) (gcc (GCC) 14.3.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP PREEMPT_DYNAMIC Fri Dec 12 17:37:22 UTC 2025
  88. 9.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5qakzg9g44siizj8li3r9blll9pw7bvp-nixos-system-docsserver-test/init regInfo=/nix/store/5l48w5m1s97d3i5gvqi6s37bd766i05w-closure-info/registration console=ttyS0,115200n8 console=tty0
  89. 9.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-provided physical RAM map:
  90. 9.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
  91. 9.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
  92. 9.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
  93. 9.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable
  94. 9.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved
  95. 9.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
  96. 9.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
  97. 9.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
  98. 9.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] NX (Execute Disable) protection: active
  99. 9.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] APIC: Static calls initialized
  100. 9.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] SMBIOS 2.8 present.
  101. 9.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014
  102. 9.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] DMI: Memory slots populated: 1/1
  103. 9.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] Hypervisor detected: KVM
  104. 9.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000
  105. 9.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
  106. 9.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] kvm-clock: using sched offset of 437862529 cycles
  107. 9.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
  108. 9.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000005] tsc: Detected 3399.998 MHz processor
  109. 9.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000708] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000
  110. 9.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000891] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
  111. 9.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.000899] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
  112. 9.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002684] found SMP MP-table at [mem 0x000f5470-0x000f547f]
  113. 9.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002695] Using GB pages for direct mapping
  114. 9.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002767] RAMDISK: [mem 0x3f3cd000-0x3ffcffff]
  115. 9.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002786] ACPI: Early table checksum verification disabled
  116. 9.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002789] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )
  117. 9.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002792] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  118. 9.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002795] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  119. 9.10 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002799] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001)
  120. 9.10 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002800] ACPI: FACS 0x000000003FFE0000 000040
  121. 9.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002802] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)
  122. 9.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002803] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  123. 9.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002805] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  124. 9.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002806] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300]
  125. 9.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002807] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c]
  126. 9.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002807] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]
  127. 9.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002808] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378]
  128. 9.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002808] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0]
  129. 9.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.002809] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8]
  130. 9.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003560] No NUMA configuration found
  131. 9.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003561] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]
  132. 9.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003564] NODE_DATA(0) allocated [mem 0x3ffd58c0-0x3ffdadff]
  133. 9.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003580] Zone ranges:
  134. 9.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003580] DMA [mem 0x0000000000001000-0x0000000000ffffff]
  135. 9.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003582] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]
  136. 9.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003582] Normal empty
  137. 9.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003583] Device empty
  138. 9.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003584] Movable zone start for each node
  139. 9.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003584] Early memory node ranges
  140. 9.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003584] node 0: [mem 0x0000000000001000-0x000000000009efff]
  141. 9.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003585] node 0: [mem 0x0000000000100000-0x000000003ffdafff]
  142. 9.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003586] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]
  143. 9.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003733] On node 0, zone DMA: 1 pages in unavailable ranges
  144. 9.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.003746] On node 0, zone DMA: 97 pages in unavailable ranges
  145. 9.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.005512] On node 0, zone DMA32: 37 pages in unavailable ranges
  146. 9.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007094] ACPI: PM-Timer IO Port: 0x608
  147. 9.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007119] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
  148. 9.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007202] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
  149. 9.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007204] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
  150. 9.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007205] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
  151. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007206] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
  152. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007207] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
  153. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007208] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
  154. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007210] ACPI: Using ACPI (MADT) for SMP configuration information
  155. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007211] ACPI: HPET id: 0x8086a201 base: 0xfed00000
  156. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007213] TSC deadline timer available
  157. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007217] CPU topo: Max. logical packages: 1
  158. 9.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007218] CPU topo: Max. logical dies: 1
  159. 9.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007218] CPU topo: Max. dies per package: 1
  160. 9.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007221] CPU topo: Max. threads per core: 1
  161. 9.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007222] CPU topo: Num. cores per package: 1
  162. 9.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007222] CPU topo: Num. threads per package: 1
  163. 9.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007222] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs
  164. 9.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007250] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
  165. 9.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007329] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
  166. 9.21 s [vm-test-run-centjes-e2e-test] client # Probing EDD (edd=off to disable)... oc[?7lk[ 0.000000] Linux version 6.12.62 (nixbld@localhost) (gcc (GCC) 14.3.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP PREEMPT_DYNAMIC Fri Dec 12 17:37:22 UTC 2025
  167. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007331] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
  168. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007332] [mem 0x40000000-0xfeffbfff] available for PCI devices
  169. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007333] Booting paravirtualized kernel on KVM
  170. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.007335] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
  171. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/001k9r4jinw78ih5x5hxggb82ynlbkqn-nixos-system-client-test/init regInfo=/nix/store/j7kn31fka8vp5bhm6sw8hv64iyzix7xw-closure-info/registration console=ttyS0,115200n8 console=tty0
  172. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.010913] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
  173. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-provided physical RAM map:
  174. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011227] percpu: Embedded 116 pages/cpu s294912 r65536 d114688 u2097152
  175. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
  176. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011319] kvm-guest: PV spinlocks disabled, single CPU
  177. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
  178. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
  179. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable
  180. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved
  181. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
  182. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011320] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5qakzg9g44siizj8li3r9blll9pw7bvp-nixos-system-docsserver-test/init regInfo=/nix/store/5l48w5m1s97d3i5gvqi6s37bd766i05w-closure-info/registration console=ttyS0,115200n8 console=tty0
  183. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
  184. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
  185. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011397] Unknown kernel command line parameters "regInfo=/nix/store/5l48w5m1s97d3i5gvqi6s37bd766i05w-closure-info/registration", will be passed to user space.
  186. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] NX (Execute Disable) protection: active
  187. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011411] random: crng init done
  188. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] APIC: Static calls initialized
  189. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011470] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
  190. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] SMBIOS 2.8 present.
  191. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011502] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
  192. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011538] Fallback order for Node 0: 0
  193. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014
  194. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011540] Built 1 zonelists, mobility grouping on. Total pages: 262009
  195. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] DMI: Memory slots populated: 1/1
  196. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011541] Policy zone: DMA32
  197. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] Hypervisor detected: KVM
  198. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.011771] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
  199. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000
  200. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.013902] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
  201. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
  202. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.014165] allocated 2097152 bytes of page_ext
  203. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000000] kvm-clock: using sched offset of 438436129 cycles
  204. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.014179] ftrace: allocating 46208 entries in 181 pages
  205. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022046] ftrace: allocated 181 pages with 5 groups
  206. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000014] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
  207. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022679] Dynamic Preempt: voluntary
  208. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000016] tsc: Detected 3399.998 MHz processor
  209. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022864] rcu: Preemptible hierarchical RCU implementation.
  210. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000711] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000
  211. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022864] rcu: RCU event tracing is enabled.
  212. 9.22 s [vm-test-run-centjes-e2e-test] client # [ 0.000897] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
  213. 9.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022865] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
  214. 9.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022866] Trampoline variant of Tasks RCU enabled.
  215. 9.23 s [vm-test-run-centjes-e2e-test] client # [ 0.000905] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
  216. 9.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022866] Rude variant of Tasks RCU enabled.
  217. 9.23 s [vm-test-run-centjes-e2e-test] client # [ 0.002743] found SMP MP-table at [mem 0x000f5470-0x000f547f]
  218. 9.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022866] Tracing variant of Tasks RCU enabled.
  219. 9.23 s [vm-test-run-centjes-e2e-test] client # [ 0.002754] Using GB pages for direct mapping
  220. 9.23 s [vm-test-run-centjes-e2e-test] client # [ 0.002870] RAMDISK: [mem 0x3f3cd000-0x3ffcffff]
  221. 9.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022867] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
  222. 9.23 s [vm-test-run-centjes-e2e-test] client # [ 0.002893] ACPI: Early table checksum verification disabled
  223. 9.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022868] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
  224. 9.24 s [vm-test-run-centjes-e2e-test] client # [ 0.002895] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )
  225. 9.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022874] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  226. 9.24 s [vm-test-run-centjes-e2e-test] client # [ 0.002898] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  227. 9.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022876] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  228. 9.24 s [vm-test-run-centjes-e2e-test] client # [ 0.002902] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  229. 9.24 s [vm-test-run-centjes-e2e-test] client # [ 0.002905] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001)
  230. 9.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.022876] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  231. 9.24 s [vm-test-run-centjes-e2e-test] client # [ 0.002907] ACPI: FACS 0x000000003FFE0000 000040
  232. 9.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.026372] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
  233. 9.25 s [vm-test-run-centjes-e2e-test] client # [ 0.002909] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)
  234. 9.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.026621] rcu: srcu_init: Setting srcu_struct sizes based on contention.
  235. 9.25 s [vm-test-run-centjes-e2e-test] client # [ 0.002910] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  236. 9.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.026696] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
  237. 9.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.040699] Console: colour VGA+ 80x25
  238. 9.25 s [vm-test-run-centjes-e2e-test] client # [ 0.002912] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  239. 9.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.040703] printk: legacy console [tty0] enabled
  240. 9.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.144775] printk: legacy console [ttyS0] enabled
  241. 9.25 s [vm-test-run-centjes-e2e-test] client # [ 0.002913] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300]
  242. 9.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.393998] ACPI: Core revision 20240827
  243. 9.26 s [vm-test-run-centjes-e2e-test] client # [ 0.002914] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c]
  244. 9.26 s [vm-test-run-centjes-e2e-test] client # [ 0.002914] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]
  245. 9.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.396195] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
  246. 9.26 s [vm-test-run-centjes-e2e-test] client # [ 0.002915] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378]
  247. 9.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.400401] APIC: Switch to symmetric I/O mode setup
  248. 9.26 s [vm-test-run-centjes-e2e-test] client # [ 0.002915] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0]
  249. 9.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.403606] x2apic enabled
  250. 9.27 s [vm-test-run-centjes-e2e-test] client # [ 0.002916] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8]
  251. 9.27 s [vm-test-run-centjes-e2e-test] client # [ 0.003676] No NUMA configuration found
  252. 9.27 s [vm-test-run-centjes-e2e-test] client # [ 0.003677] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]
  253. 9.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.405906] APIC: Switched APIC routing to: physical x2apic
  254. 9.27 s [vm-test-run-centjes-e2e-test] client # [ 0.003680] NODE_DATA(0) allocated [mem 0x3ffd58c0-0x3ffdadff]
  255. 9.27 s [vm-test-run-centjes-e2e-test] client # [ 0.003695] Zone ranges:
  256. 9.27 s [vm-test-run-centjes-e2e-test] client # [ 0.003695] DMA [mem 0x0000000000001000-0x0000000000ffffff]
  257. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003696] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]
  258. 9.28 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.412796] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
  259. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003697] Normal empty
  260. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003698] Device empty
  261. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003698] Movable zone start for each node
  262. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003699] Early memory node ranges
  263. 9.28 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.415721] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns
  264. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003699] node 0: [mem 0x0000000000001000-0x000000000009efff]
  265. 9.28 s [vm-test-run-centjes-e2e-test] client # [ 0.003700] node 0: [mem 0x0000000000100000-0x000000003ffdafff]
  266. 9.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.420592] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399998)
  267. 9.29 s [vm-test-run-centjes-e2e-test] client # [ 0.003701] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]
  268. 9.29 s [vm-test-run-centjes-e2e-test] client # [ 0.003839] On node 0, zone DMA: 1 pages in unavailable ranges
  269. 9.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.423153] x86/cpu: User Mode Instruction Prevention (UMIP) activated
  270. 9.29 s [vm-test-run-centjes-e2e-test] client # [ 0.003851] On node 0, zone DMA: 97 pages in unavailable ranges
  271. 9.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.425956] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
  272. 9.29 s [vm-test-run-centjes-e2e-test] client # [ 0.005417] On node 0, zone DMA32: 37 pages in unavailable ranges
  273. 9.29 s [vm-test-run-centjes-e2e-test] client # [ 0.006978] ACPI: PM-Timer IO Port: 0x608
  274. 9.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.427591] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
  275. 9.30 s [vm-test-run-centjes-e2e-test] client # [ 0.007030] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
  276. 9.30 s [vm-test-run-centjes-e2e-test] client # [ 0.007119] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
  277. 9.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.429601] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
  278. 9.30 s [vm-test-run-centjes-e2e-test] client # [ 0.007121] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
  279. 9.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.431592] Spectre V2 : Mitigation: Retpolines
  280. 9.30 s [vm-test-run-centjes-e2e-test] client # [ 0.007122] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
  281. 9.30 s [vm-test-run-centjes-e2e-test] client # [ 0.007123] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
  282. 9.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.432590] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
  283. 9.31 s [vm-test-run-centjes-e2e-test] client # [ 0.007124] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
  284. 9.31 s [vm-test-run-centjes-e2e-test] client # [ 0.007124] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
  285. 9.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.434591] Spectre V2 : Enabling Restricted Speculation for firmware calls
  286. 9.31 s [vm-test-run-centjes-e2e-test] client # [ 0.007127] ACPI: Using ACPI (MADT) for SMP configuration information
  287. 9.31 s [vm-test-run-centjes-e2e-test] client # [ 0.007127] ACPI: HPET id: 0x8086a201 base: 0xfed00000
  288. 9.31 s [vm-test-run-centjes-e2e-test] client # [ 0.007130] TSC deadline timer available
  289. 9.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.436593] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
  290. 9.31 s [vm-test-run-centjes-e2e-test] client # [ 0.007134] CPU topo: Max. logical packages: 1
  291. 9.32 s [vm-test-run-centjes-e2e-test] client # [ 0.007134] CPU topo: Max. logical dies: 1
  292. 9.32 s [vm-test-run-centjes-e2e-test] client # [ 0.007135] CPU topo: Max. dies per package: 1
  293. 9.32 s [vm-test-run-centjes-e2e-test] client # [ 0.007138] CPU topo: Max. threads per core: 1
  294. 9.32 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.438593] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
  295. 9.32 s [vm-test-run-centjes-e2e-test] client # [ 0.007138] CPU topo: Num. cores per package: 1
  296. 9.32 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.440591] active return thunk: srso_alias_return_thunk
  297. 9.32 s [vm-test-run-centjes-e2e-test] client # [ 0.007139] CPU topo: Num. threads per package: 1
  298. 9.32 s [vm-test-run-centjes-e2e-test] client # [ 0.007139] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs
  299. 9.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.441591] Speculative Return Stack Overflow: Mitigation: Safe RET
  300. 9.33 s [vm-test-run-centjes-e2e-test] client # [ 0.007169] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
  301. 9.33 s [vm-test-run-centjes-e2e-test] client # [ 0.007224] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
  302. 9.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.443591] Transient Scheduler Attacks: Forcing mitigation on in a VM
  303. 9.33 s [vm-test-run-centjes-e2e-test] client # [ 0.007225] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
  304. 9.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.445591] Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode
  305. 9.33 s [vm-test-run-centjes-e2e-test] client # [ 0.007227] [mem 0x40000000-0xfeffbfff] available for PCI devices
  306. 9.34 s [vm-test-run-centjes-e2e-test] client # [ 0.007228] Booting paravirtualized kernel on KVM
  307. 9.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.447676] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
  308. 9.34 s [vm-test-run-centjes-e2e-test] client # [ 0.007230] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
  309. 9.34 s [vm-test-run-centjes-e2e-test] client # [ 0.010764] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
  310. 9.34 s [vm-test-run-centjes-e2e-test] client # [ 0.010992] percpu: Embedded 116 pages/cpu s294912 r65536 d114688 u2097152
  311. 9.35 s [vm-test-run-centjes-e2e-test] client # [ 0.011083] kvm-guest: PV spinlocks disabled, single CPU
  312. 9.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.449592] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
  313. 9.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.451592] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
  314. 9.36 s [vm-test-run-centjes-e2e-test] client # [ 0.011084] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/001k9r4jinw78ih5x5hxggb82ynlbkqn-nixos-system-client-test/init regInfo=/nix/store/j7kn31fka8vp5bhm6sw8hv64iyzix7xw-closure-info/registration console=ttyS0,115200n8 console=tty0
  315. 9.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.453591] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
  316. 9.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.455592] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
  317. 9.36 s [vm-test-run-centjes-e2e-test] client # [ 0.011161] Unknown kernel command line parameters "regInfo=/nix/store/j7kn31fka8vp5bhm6sw8hv64iyzix7xw-closure-info/registration", will be passed to user space.
  318. 9.36 s [vm-test-run-centjes-e2e-test] client # [ 0.011175] random: crng init done
  319. 9.37 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.457591] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8
  320. 9.37 s [vm-test-run-centjes-e2e-test] client # [ 0.011227] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
  321. 9.37 s [vm-test-run-centjes-e2e-test] client # [ 0.011256] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
  322. 9.37 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.459591] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format.
  323. 9.37 s [vm-test-run-centjes-e2e-test] client # [ 0.011292] Fallback order for Node 0: 0
  324. 9.37 s [vm-test-run-centjes-e2e-test] client # [ 0.011294] Built 1 zonelists, mobility grouping on. Total pages: 262009
  325. 9.37 s [vm-test-run-centjes-e2e-test] client # [ 0.011295] Policy zone: DMA32
  326. 9.38 s [vm-test-run-centjes-e2e-test] client # [ 0.011475] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
  327. 9.38 s [vm-test-run-centjes-e2e-test] client # [ 0.013624] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
  328. 9.38 s [vm-test-run-centjes-e2e-test] client # [ 0.013850] allocated 2097152 bytes of page_ext
  329. 9.38 s [vm-test-run-centjes-e2e-test] client # [ 0.013864] ftrace: allocating 46208 entries in 181 pages
  330. 9.38 s [vm-test-run-centjes-e2e-test] client # [ 0.021606] ftrace: allocated 181 pages with 5 groups
  331. 9.39 s [vm-test-run-centjes-e2e-test] client # [ 0.022214] Dynamic Preempt: voluntary
  332. 9.39 s [vm-test-run-centjes-e2e-test] client # [ 0.022381] rcu: Preemptible hierarchical RCU implementation.
  333. 9.39 s [vm-test-run-centjes-e2e-test] client # [ 0.022382] rcu: RCU event tracing is enabled.
  334. 9.39 s [vm-test-run-centjes-e2e-test] client # [ 0.022382] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
  335. 9.39 s [vm-test-run-centjes-e2e-test] client # [ 0.022383] Trampoline variant of Tasks RCU enabled.
  336. 9.39 s [vm-test-run-centjes-e2e-test] client # [ 0.022384] Rude variant of Tasks RCU enabled.
  337. 9.40 s [vm-test-run-centjes-e2e-test] client # [ 0.022384] Tracing variant of Tasks RCU enabled.
  338. 9.40 s [vm-test-run-centjes-e2e-test] client # [ 0.022385] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
  339. 9.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.488079] Freeing SMP alternatives memory: 40K
  340. 9.40 s [vm-test-run-centjes-e2e-test] client # [ 0.022385] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
  341. 9.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.489593] pid_max: default: 32768 minimum: 301
  342. 9.40 s [vm-test-run-centjes-e2e-test] client # [ 0.022393] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  343. 9.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.491654] LSM: initializing lsm=capability,landlock,yama,bpf
  344. 9.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.493682] landlock: Up and running.
  345. 9.41 s [vm-test-run-centjes-e2e-test] client # [ 0.022394] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  346. 9.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.494591] Yama: becoming mindful.
  347. 9.41 s [vm-test-run-centjes-e2e-test] client # [ 0.022395] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  348. 9.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.496808] LSM support for eBPF active
  349. 9.41 s [vm-test-run-centjes-e2e-test] client # [ 0.025971] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
  350. 9.41 s [vm-test-run-centjes-e2e-test] client # [ 0.026265] rcu: srcu_init: Setting srcu_struct sizes based on contention.
  351. 9.42 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.497628] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
  352. 9.42 s [vm-test-run-centjes-e2e-test] client # [ 0.026339] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
  353. 9.42 s [vm-test-run-centjes-e2e-test] client # [ 0.039604] Console: colour VGA+ 80x25
  354. 9.42 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.499593] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
  355. 9.42 s [vm-test-run-centjes-e2e-test] client # [ 0.039607] printk: legacy console [tty0] enabled
  356. 9.42 s [vm-test-run-centjes-e2e-test] client # [ 0.146942] printk: legacy console [ttyS0] enabled
  357. 9.42 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.502840] smpboot: CPU0: AMD Ryzen 9 5950X 16-Core Processor (family: 0x19, model: 0x21, stepping: 0x0)
  358. 9.42 s [vm-test-run-centjes-e2e-test] client # [ 0.406963] ACPI: Core revision 20240827
  359. 9.43 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.504871] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
  360. 9.43 s [vm-test-run-centjes-e2e-test] client # [ 0.409315] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
  361. 9.43 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.506606] ... version: 0
  362. 9.43 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.507597] ... bit width: 48
  363. 9.43 s [vm-test-run-centjes-e2e-test] client # [ 0.413750] APIC: Switch to symmetric I/O mode setup
  364. 9.43 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.508598] ... generic registers: 6
  365. 9.43 s [vm-test-run-centjes-e2e-test] client # [ 0.417263] x2apic enabled
  366. 9.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.509598] ... value mask: 0000ffffffffffff
  367. 9.44 s [vm-test-run-centjes-e2e-test] client # [ 0.419700] APIC: Switched APIC routing to: physical x2apic
  368. 9.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.510597] ... max period: 00007fffffffffff
  369. 9.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.511598] ... fixed-purpose events: 0
  370. 9.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.512598] ... event mask: 000000000000003f
  371. 9.44 s [vm-test-run-centjes-e2e-test] client # [ 0.426474] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
  372. 9.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.513708] signal: max sigframe size: 3376
  373. 9.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.514641] rcu: Hierarchical SRCU implementation.
  374. 9.45 s [vm-test-run-centjes-e2e-test] client # [ 0.429431] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns
  375. 9.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.515598] rcu: Max phase no-delay instances is 400.
  376. 9.45 s [vm-test-run-centjes-e2e-test] client # [ 0.434551] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399998)
  377. 9.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.520651] smp: Bringing up secondary CPUs ...
  378. 9.46 s [vm-test-run-centjes-e2e-test] client # [ 0.438178] x86/cpu: User Mode Instruction Prevention (UMIP) activated
  379. 9.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.521612] smp: Brought up 1 node, 1 CPU
  380. 9.46 s [vm-test-run-centjes-e2e-test] client # [ 0.440578] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
  381. 9.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.522602] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
  382. 9.47 s [vm-test-run-centjes-e2e-test] client # [ 0.441549] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
  383. 9.47 s [vm-test-run-centjes-e2e-test] client # [ 0.443560] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
  384. 9.47 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.524934] Memory: 962124K/1048036K available (16384K kernel code, 2645K rwdata, 12580K rodata, 3408K init, 3360K bss, 78836K reserved, 0K cma-reserved)
  385. 9.47 s [vm-test-run-centjes-e2e-test] client # [ 0.445551] Spectre V2 : Mitigation: Retpolines
  386. 9.47 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.526772] devtmpfs: initialized
  387. 9.48 s [vm-test-run-centjes-e2e-test] client # [ 0.447550] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
  388. 9.48 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.527708] x86/mm: Memory block size: 128MB
  389. 9.48 s [vm-test-run-centjes-e2e-test] client # [ 0.449550] Spectre V2 : Enabling Restricted Speculation for firmware calls
  390. 9.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.530277] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
  391. 9.52 s [vm-test-run-centjes-e2e-test] client # [ 0.451552] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
  392. 9.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.531601] futex hash table entries: 256 (order: 2, 16384 bytes, linear)
  393. 9.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.533655] pinctrl core: initialized pinctrl subsystem
  394. 9.52 s [vm-test-run-centjes-e2e-test] client # [ 0.453550] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
  395. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.455550] active return thunk: srso_alias_return_thunk
  396. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.534976] PM: RTC time: 21:20:10, date: 2026-08-06
  397. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.457550] Speculative Return Stack Overflow: Mitigation: Safe RET
  398. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.537548] NET: Registered PF_NETLINK/PF_ROUTE protocol family
  399. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.459550] Transient Scheduler Attacks: Forcing mitigation on in a VM
  400. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.538755] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
  401. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.461549] Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode
  402. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.540606] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
  403. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.463641] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
  404. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.542605] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
  405. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.544611] audit: initializing netlink subsys (disabled)
  406. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.545648] audit: type=2000 audit(1786051210.449:1): state=initialized audit_enabled=0 res=1
  407. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.547745] thermal_sys: Registered thermal governor 'bang_bang'
  408. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.466548] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
  409. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.547748] thermal_sys: Registered thermal governor 'step_wise'
  410. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.468550] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
  411. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.549601] thermal_sys: Registered thermal governor 'user_space'
  412. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.550612] cpuidle: using governor menu
  413. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.470550] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
  414. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.472550] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
  415. 9.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.554705] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
  416. 9.53 s [vm-test-run-centjes-e2e-test] client # [ 0.474549] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8
  417. 9.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.556912] PCI: Using configuration type 1 for base access
  418. 9.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.558598] PCI: Using configuration type 1 for extended access
  419. 9.54 s [vm-test-run-centjes-e2e-test] client # [ 0.476549] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format.
  420. 9.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.559826] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
  421. 9.57 s [vm-test-run-centjes-e2e-test] client # [ 0.504111] Freeing SMP alternatives memory: 40K
  422. 9.57 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.582811] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
  423. 9.57 s [vm-test-run-centjes-e2e-test] client # [ 0.505550] pid_max: default: 32768 minimum: 301
  424. 9.57 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.584599] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
  425. 9.57 s [vm-test-run-centjes-e2e-test] client # [ 0.507596] LSM: initializing lsm=capability,landlock,yama,bpf
  426. 9.57 s [vm-test-run-centjes-e2e-test] client # [ 0.510553] landlock: Up and running.
  427. 9.57 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.585601] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
  428. 9.58 s [vm-test-run-centjes-e2e-test] client # [ 0.511549] Yama: becoming mindful.
  429. 9.58 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.586600] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
  430. 9.58 s [vm-test-run-centjes-e2e-test] client # [ 0.513764] LSM support for eBPF active
  431. 9.58 s [vm-test-run-centjes-e2e-test] client # [ 0.515575] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
  432. 9.59 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.592709] ACPI: Added _OSI(Module Device)
  433. 9.59 s [vm-test-run-centjes-e2e-test] client # [ 0.517551] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
  434. 9.59 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.593600] ACPI: Added _OSI(Processor Device)
  435. 9.59 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.594601] ACPI: Added _OSI(Processor Aggregator Device)
  436. 9.59 s [vm-test-run-centjes-e2e-test] client # [ 0.519967] smpboot: CPU0: AMD Ryzen 9 5950X 16-Core Processor (family: 0x19, model: 0x21, stepping: 0x0)
  437. 9.59 s [vm-test-run-centjes-e2e-test] client # [ 0.521869] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
  438. 9.60 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.597381] ACPI: 1 ACPI AML tables successfully acquired and loaded
  439. 9.60 s [vm-test-run-centjes-e2e-test] client # [ 0.523564] ... version: 0
  440. 9.60 s [vm-test-run-centjes-e2e-test] client # [ 0.524556] ... bit width: 48
  441. 9.60 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.599855] ACPI: Interpreter enabled
  442. 9.60 s [vm-test-run-centjes-e2e-test] client # [ 0.525556] ... generic registers: 6
  443. 9.60 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.600639] ACPI: PM: (supports S0 S3 S4 S5)
  444. 9.60 s [vm-test-run-centjes-e2e-test] client # [ 0.526556] ... value mask: 0000ffffffffffff
  445. 9.60 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.601598] ACPI: Using IOAPIC for interrupt routing
  446. 9.60 s [vm-test-run-centjes-e2e-test] client # [ 0.527556] ... max period: 00007fffffffffff
  447. 9.61 s [vm-test-run-centjes-e2e-test] client # [ 0.528556] ... fixed-purpose events: 0
  448. 9.61 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.602610] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
  449. 9.61 s [vm-test-run-centjes-e2e-test] client # [ 0.529556] ... event mask: 000000000000003f
  450. 9.61 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.604597] PCI: Using E820 reservations for host bridge windows
  451. 9.61 s [vm-test-run-centjes-e2e-test] client # [ 0.530639] signal: max sigframe size: 3376
  452. 9.61 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.605757] ACPI: Enabled 2 GPEs in block 00 to 0F
  453. 9.61 s [vm-test-run-centjes-e2e-test] client # [ 0.531590] rcu: Hierarchical SRCU implementation.
  454. 9.62 s [vm-test-run-centjes-e2e-test] client # [ 0.532556] rcu: Max phase no-delay instances is 400.
  455. 9.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.610529] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
  456. 9.62 s [vm-test-run-centjes-e2e-test] client # [ 0.536748] smp: Bringing up secondary CPUs ...
  457. 9.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.611601] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
  458. 9.62 s [vm-test-run-centjes-e2e-test] client # [ 0.537567] smp: Brought up 1 node, 1 CPU
  459. 9.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.613984] acpiphp: Slot [3] registered
  460. 9.63 s [vm-test-run-centjes-e2e-test] client # [ 0.538558] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
  461. 9.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.615637] acpiphp: Slot [4] registered
  462. 9.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.616637] acpiphp: Slot [5] registered
  463. 9.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.617634] acpiphp: Slot [6] registered
  464. 9.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.618636] acpiphp: Slot [7] registered
  465. 9.63 s [vm-test-run-centjes-e2e-test] client # [ 0.539896] Memory: 962116K/1048036K available (16384K kernel code, 2645K rwdata, 12580K rodata, 3408K init, 3360K bss, 78836K reserved, 0K cma-reserved)
  466. 9.64 s [vm-test-run-centjes-e2e-test] client # [ 0.541674] devtmpfs: initialized
  467. 9.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.619634] acpiphp: Slot [8] registered
  468. 9.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.620653] acpiphp: Slot [9] registered
  469. 9.64 s [vm-test-run-centjes-e2e-test] client # [ 0.542667] x86/mm: Memory block size: 128MB
  470. 9.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.621637] acpiphp: Slot [10] registered
  471. 9.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.622635] acpiphp: Slot [11] registered
  472. 9.64 s [vm-test-run-centjes-e2e-test] client # [ 0.544027] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
  473. 9.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.623647] acpiphp: Slot [12] registered
  474. 9.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.624637] acpiphp: Slot [13] registered
  475. 9.65 s [vm-test-run-centjes-e2e-test] client # [ 0.545562] futex hash table entries: 256 (order: 2, 16384 bytes, linear)
  476. 9.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.625633] acpiphp: Slot [14] registered
  477. 9.65 s [vm-test-run-centjes-e2e-test] client # [ 0.546617] pinctrl core: initialized pinctrl subsystem
  478. 9.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.626635] acpiphp: Slot [15] registered
  479. 9.65 s [vm-test-run-centjes-e2e-test] client # [ 0.547915] PM: RTC time: 21:20:10, date: 2026-08-06
  480. 9.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.627637] acpiphp: Slot [16] registered
  481. 9.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.628636] acpiphp: Slot [17] registered
  482. 9.65 s [vm-test-run-centjes-e2e-test] client # [ 0.550129] NET: Registered PF_NETLINK/PF_ROUTE protocol family
  483. 9.66 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.629640] acpiphp: Slot [18] registered
  484. 9.66 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.630635] acpiphp: Slot [19] registered
  485. 9.66 s [vm-test-run-centjes-e2e-test] client # [ 0.551707] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
  486. 9.66 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.631636] acpiphp: Slot [20] registered
  487. 9.66 s [vm-test-run-centjes-e2e-test] client # [ 0.553568] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
  488. 9.66 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.632634] acpiphp: Slot [21] registered
  489. 9.66 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.633635] acpiphp: Slot [22] registered
  490. 9.67 s [vm-test-run-centjes-e2e-test] client # [ 0.555567] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
  491. 9.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.634635] acpiphp: Slot [23] registered
  492. 9.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.635642] acpiphp: Slot [24] registered
  493. 9.67 s [vm-test-run-centjes-e2e-test] client # [ 0.557566] audit: initializing netlink subsys (disabled)
  494. 9.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.636637] acpiphp: Slot [25] registered
  495. 9.67 s [vm-test-run-centjes-e2e-test] client # [ 0.558604] audit: type=2000 audit(1786051210.603:1): state=initialized audit_enabled=0 res=1
  496. 9.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.637635] acpiphp: Slot [26] registered
  497. 9.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.638639] acpiphp: Slot [27] registered
  498. 9.68 s [vm-test-run-centjes-e2e-test] client # [ 0.560689] thermal_sys: Registered thermal governor 'bang_bang'
  499. 9.68 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.639641] acpiphp: Slot [28] registered
  500. 9.68 s [vm-test-run-centjes-e2e-test] client # [ 0.560691] thermal_sys: Registered thermal governor 'step_wise'
  501. 9.68 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.640638] acpiphp: Slot [29] registered
  502. 9.68 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.641648] acpiphp: Slot [30] registered
  503. 9.68 s [vm-test-run-centjes-e2e-test] client # [ 0.562562] thermal_sys: Registered thermal governor 'user_space'
  504. 9.68 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.642640] acpiphp: Slot [31] registered
  505. 9.68 s [vm-test-run-centjes-e2e-test] client # [ 0.563569] cpuidle: using governor menu
  506. 9.68 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.643628] PCI host bridge to bus 0000:00
  507. 9.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.644602] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
  508. 9.69 s [vm-test-run-centjes-e2e-test] client # [ 0.567409] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
  509. 9.69 s [vm-test-run-centjes-e2e-test] client # [ 0.568850] PCI: Using configuration type 1 for base access
  510. 9.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.645598] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
  511. 9.69 s [vm-test-run-centjes-e2e-test] client # [ 0.570557] PCI: Using configuration type 1 for extended access
  512. 9.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.646598] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
  513. 9.70 s [vm-test-run-centjes-e2e-test] client # [ 0.571711] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
  514. 9.70 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.648597] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
  515. 9.70 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.650598] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
  516. 9.70 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.652597] pci_bus 0000:00: root bus resource [bus 00-ff]
  517. 9.71 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.654039] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint
  518. 9.71 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.656733] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint
  519. 9.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.660128] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint
  520. 9.72 s [vm-test-run-centjes-e2e-test] client # [ 0.593728] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
  521. 9.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.664999] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]
  522. 9.72 s [vm-test-run-centjes-e2e-test] client # [ 0.595555] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
  523. 9.73 s [vm-test-run-centjes-e2e-test] client # [ 0.597558] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
  524. 9.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.668052] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk
  525. 9.73 s [vm-test-run-centjes-e2e-test] client # [ 0.598555] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
  526. 9.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.669597] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk
  527. 9.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.670597] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk
  528. 9.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.671597] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk
  529. 9.74 s [vm-test-run-centjes-e2e-test] client # [ 0.605157] ACPI: Added _OSI(Module Device)
  530. 9.74 s [vm-test-run-centjes-e2e-test] client # [ 0.606556] ACPI: Added _OSI(Processor Device)
  531. 9.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.672970] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint
  532. 9.74 s [vm-test-run-centjes-e2e-test] client # [ 0.607556] ACPI: Added _OSI(Processor Aggregator Device)
  533. 9.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.677157] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]
  534. 9.75 s [vm-test-run-centjes-e2e-test] client # [ 0.610327] ACPI: 1 ACPI AML tables successfully acquired and loaded
  535. 9.75 s [vm-test-run-centjes-e2e-test] client # [ 0.612773] ACPI: Interpreter enabled
  536. 9.75 s [vm-test-run-centjes-e2e-test] client # [ 0.613571] ACPI: PM: (supports S0 S3 S4 S5)
  537. 9.76 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.681768] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint
  538. 9.76 s [vm-test-run-centjes-e2e-test] client # [ 0.614556] ACPI: Using IOAPIC for interrupt routing
  539. 9.76 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.684852] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
  540. 9.76 s [vm-test-run-centjes-e2e-test] client # [ 0.615580] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
  541. 9.76 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.686621] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
  542. 9.76 s [vm-test-run-centjes-e2e-test] client # [ 0.617556] PCI: Using E820 reservations for host bridge windows
  543. 9.77 s [vm-test-run-centjes-e2e-test] client # [ 0.618753] ACPI: Enabled 2 GPEs in block 00 to 0F
  544. 9.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.688128] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint
  545. 9.77 s [vm-test-run-centjes-e2e-test] client # [ 0.623686] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
  546. 9.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.691242] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]
  547. 9.78 s [vm-test-run-centjes-e2e-test] client # [ 0.624560] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
  548. 9.78 s [vm-test-run-centjes-e2e-test] client # [ 0.626938] acpiphp: Slot [3] registered
  549. 9.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.695220] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]
  550. 9.78 s [vm-test-run-centjes-e2e-test] client # [ 0.628631] acpiphp: Slot [4] registered
  551. 9.78 s [vm-test-run-centjes-e2e-test] client # [ 0.629618] acpiphp: Slot [5] registered
  552. 9.79 s [vm-test-run-centjes-e2e-test] client # [ 0.630595] acpiphp: Slot [6] registered
  553. 9.79 s [vm-test-run-centjes-e2e-test] client # [ 0.631595] acpiphp: Slot [7] registered
  554. 9.79 s [vm-test-run-centjes-e2e-test] client # [ 0.632596] acpiphp: Slot [8] registered
  555. 9.79 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.702283] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]
  556. 9.79 s [vm-test-run-centjes-e2e-test] client # [ 0.633597] acpiphp: Slot [9] registered
  557. 9.79 s [vm-test-run-centjes-e2e-test] client # [ 0.634606] acpiphp: Slot [10] registered
  558. 9.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.703762] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
  559. 9.80 s [vm-test-run-centjes-e2e-test] client # [ 0.635603] acpiphp: Slot [11] registered
  560. 9.80 s [vm-test-run-centjes-e2e-test] client # [ 0.636594] acpiphp: Slot [12] registered
  561. 9.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.706452] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
  562. 9.80 s [vm-test-run-centjes-e2e-test] client # [ 0.637597] acpiphp: Slot [13] registered
  563. 9.80 s [vm-test-run-centjes-e2e-test] client # [ 0.638592] acpiphp: Slot [14] registered
  564. 9.80 s [vm-test-run-centjes-e2e-test] client # [ 0.639595] acpiphp: Slot [15] registered
  565. 9.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.708598] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]
  566. 9.81 s [vm-test-run-centjes-e2e-test] client # [ 0.640597] acpiphp: Slot [16] registered
  567. 9.81 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.710597] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]
  568. 9.81 s [vm-test-run-centjes-e2e-test] client # [ 0.641594] acpiphp: Slot [17] registered
  569. 9.81 s [vm-test-run-centjes-e2e-test] client # [ 0.642593] acpiphp: Slot [18] registered
  570. 9.81 s [vm-test-run-centjes-e2e-test] client # [ 0.643596] acpiphp: Slot [19] registered
  571. 9.81 s [vm-test-run-centjes-e2e-test] client # [ 0.644605] acpiphp: Slot [20] registered
  572. 9.82 s [vm-test-run-centjes-e2e-test] client # [ 0.645595] acpiphp: Slot [21] registered
  573. 9.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.715597] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]
  574. 9.82 s [vm-test-run-centjes-e2e-test] client # [ 0.646596] acpiphp: Slot [22] registered
  575. 9.82 s [vm-test-run-centjes-e2e-test] client # [ 0.647597] acpiphp: Slot [23] registered
  576. 9.82 s [vm-test-run-centjes-e2e-test] client # [ 0.648597] acpiphp: Slot [24] registered
  577. 9.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.718597] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]
  578. 9.82 s [vm-test-run-centjes-e2e-test] client # [ 0.649596] acpiphp: Slot [25] registered
  579. 9.83 s [vm-test-run-centjes-e2e-test] client # [ 0.650597] acpiphp: Slot [26] registered
  580. 9.83 s [vm-test-run-centjes-e2e-test] client # [ 0.651595] acpiphp: Slot [27] registered
  581. 9.83 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.722741] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
  582. 9.83 s [vm-test-run-centjes-e2e-test] client # [ 0.652597] acpiphp: Slot [28] registered
  583. 9.83 s [vm-test-run-centjes-e2e-test] client # [ 0.653596] acpiphp: Slot [29] registered
  584. 9.83 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.725596] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]
  585. 9.83 s [vm-test-run-centjes-e2e-test] client # [ 0.654615] acpiphp: Slot [30] registered
  586. 9.84 s [vm-test-run-centjes-e2e-test] client # [ 0.655614] acpiphp: Slot [31] registered
  587. 9.84 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.727602] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]
  588. 9.84 s [vm-test-run-centjes-e2e-test] client # [ 0.656592] PCI host bridge to bus 0000:00
  589. 9.84 s [vm-test-run-centjes-e2e-test] client # [ 0.657561] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
  590. 9.84 s [vm-test-run-centjes-e2e-test] client # [ 0.658557] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
  591. 9.84 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.732598] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]
  592. 9.85 s [vm-test-run-centjes-e2e-test] client # [ 0.659556] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
  593. 9.85 s [vm-test-run-centjes-e2e-test] client # [ 0.661556] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
  594. 9.85 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.737618] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  595. 9.86 s [vm-test-run-centjes-e2e-test] client # [ 0.663558] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
  596. 9.86 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.740597] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]
  597. 9.86 s [vm-test-run-centjes-e2e-test] client # [ 0.665558] pci_bus 0000:00: root bus resource [bus 00-ff]
  598. 9.86 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.742596] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]
  599. 9.86 s [vm-test-run-centjes-e2e-test] client # [ 0.667044] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint
  600. 9.87 s [vm-test-run-centjes-e2e-test] client # [ 0.669725] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint
  601. 9.87 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.746597] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]
  602. 9.87 s [vm-test-run-centjes-e2e-test] client # [ 0.673247] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint
  603. 9.88 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.751254] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  604. 9.88 s [vm-test-run-centjes-e2e-test] client # [ 0.678556] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]
  605. 9.88 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.753602] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]
  606. 9.89 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.756597] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]
  607. 9.89 s [vm-test-run-centjes-e2e-test] client # [ 0.681107] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk
  608. 9.89 s [vm-test-run-centjes-e2e-test] client # [ 0.682557] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk
  609. 9.89 s [vm-test-run-centjes-e2e-test] client # [ 0.683557] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk
  610. 9.89 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.760597] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]
  611. 9.90 s [vm-test-run-centjes-e2e-test] client # [ 0.684556] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk
  612. 9.90 s [vm-test-run-centjes-e2e-test] client # [ 0.686015] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint
  613. 9.90 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.766280] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  614. 9.91 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.768596] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]
  615. 9.91 s [vm-test-run-centjes-e2e-test] client # [ 0.690910] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]
  616. 9.91 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.770597] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]
  617. 9.91 s [vm-test-run-centjes-e2e-test] client # [ 0.694836] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint
  618. 9.92 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.775302] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]
  619. 9.92 s [vm-test-run-centjes-e2e-test] client # [ 0.698118] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
  620. 9.92 s [vm-test-run-centjes-e2e-test] client # [ 0.699580] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
  621. 9.93 s [vm-test-run-centjes-e2e-test] client # [ 0.701128] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint
  622. 9.93 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.780232] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
  623. 9.93 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.782597] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]
  624. 9.93 s [vm-test-run-centjes-e2e-test] client # [ 0.704111] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]
  625. 9.93 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.784597] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]
  626. 9.94 s [vm-test-run-centjes-e2e-test] client # [ 0.708160] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]
  627. 9.95 s [vm-test-run-centjes-e2e-test] client # [ 0.714557] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]
  628. 9.95 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.789322] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]
  629. 9.95 s [vm-test-run-centjes-e2e-test] client # [ 0.715709] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
  630. 9.95 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.794255] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
  631. 9.95 s [vm-test-run-centjes-e2e-test] client # [ 0.718361] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
  632. 9.96 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.796597] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]
  633. 9.96 s [vm-test-run-centjes-e2e-test] client # [ 0.720557] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]
  634. 9.96 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.799600] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]
  635. 9.96 s [vm-test-run-centjes-e2e-test] client # [ 0.722558] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]
  636. 9.97 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.803597] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]
  637. 9.97 s [vm-test-run-centjes-e2e-test] client # [ 0.727558] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]
  638. 9.98 s [vm-test-run-centjes-e2e-test] client # [ 0.730462] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]
  639. 9.98 s [vm-test-run-centjes-e2e-test] client # [ 0.734305] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
  640. 9.98 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.806600] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]
  641. 9.99 s [vm-test-run-centjes-e2e-test] client # [ 0.736555] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]
  642. 9.99 s [vm-test-run-centjes-e2e-test] client # [ 0.738534] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]
  643. 9.99 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.811285] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
  644. 9.99 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.814008] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]
  645. 10.00 s [vm-test-run-centjes-e2e-test] client # [ 0.742233] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]
  646. 10.00 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.817912] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]
  647. 10.00 s [vm-test-run-centjes-e2e-test] client # [ 0.747883] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  648. 10.01 s [vm-test-run-centjes-e2e-test] client # [ 0.750555] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]
  649. 10.01 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.823091] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
  650. 10.01 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.826097] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]
  651. 10.01 s [vm-test-run-centjes-e2e-test] client # [ 0.752558] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]
  652. 10.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.828519] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]
  653. 10.02 s [vm-test-run-centjes-e2e-test] client # [ 0.757555] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]
  654. 10.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.833226] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]
  655. 10.03 s [vm-test-run-centjes-e2e-test] client # [ 0.763539] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  656. 10.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.838472] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
  657. 10.03 s [vm-test-run-centjes-e2e-test] client # [ 0.765557] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]
  658. 10.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.840597] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]
  659. 10.04 s [vm-test-run-centjes-e2e-test] client # [ 0.767527] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]
  660. 10.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.842608] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]
  661. 10.04 s [vm-test-run-centjes-e2e-test] client # [ 0.771245] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]
  662. 10.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.846597] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]
  663. 10.05 s [vm-test-run-centjes-e2e-test] client # [ 0.776393] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  664. 10.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.851629] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
  665. 10.06 s [vm-test-run-centjes-e2e-test] client # [ 0.778555] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]
  666. 10.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.853857] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
  667. 10.06 s [vm-test-run-centjes-e2e-test] client # [ 0.781438] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]
  668. 10.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.855850] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
  669. 10.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.857820] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
  670. 10.07 s [vm-test-run-centjes-e2e-test] client # [ 0.785201] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]
  671. 10.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.859705] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
  672. 10.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.862172] iommu: Default domain type: Translated
  673. 10.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.863597] iommu: DMA domain TLB invalidation policy: lazy mode
  674. 10.07 s [vm-test-run-centjes-e2e-test] client # [ 0.790269] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
  675. 10.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.864637] ACPI: bus type USB registered
  676. 10.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.865631] usbcore: registered new interface driver usbfs
  677. 10.08 s [vm-test-run-centjes-e2e-test] client # [ 0.793012] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]
  678. 10.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.866606] usbcore: registered new interface driver hub
  679. 10.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.867607] usbcore: registered new device driver usb
  680. 10.08 s [vm-test-run-centjes-e2e-test] client # [ 0.795556] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]
  681. 10.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.868969] NetLabel: Initializing
  682. 10.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.869597] NetLabel: domain hash size = 128
  683. 10.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.870597] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
  684. 10.09 s [vm-test-run-centjes-e2e-test] client # [ 0.801103] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]
  685. 10.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.871618] NetLabel: unlabeled traffic allowed by default
  686. 10.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.872599] PCI: Using ACPI for IRQ routing
  687. 10.10 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.874489] pci 0000:00:02.0: vgaarb: setting as boot VGA device
  688. 10.10 s [vm-test-run-centjes-e2e-test] client # [ 0.806319] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
  689. 10.10 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.874588] pci 0000:00:02.0: vgaarb: bridge control possible
  690. 10.10 s [vm-test-run-centjes-e2e-test] client # [ 0.808555] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]
  691. 10.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.874588] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
  692. 10.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.874600] vgaarb: loaded
  693. 10.11 s [vm-test-run-centjes-e2e-test] client # [ 0.810556] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]
  694. 10.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.875688] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
  695. 10.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.876597] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
  696. 10.11 s [vm-test-run-centjes-e2e-test] client # [ 0.814555] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]
  697. 10.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.879718] clocksource: Switched to clocksource kvm-clock
  698. 10.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.883555] VFS: Disk quotas dquot_6.6.0
  699. 10.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.885566] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
  700. 10.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.888904] pnp: PnP ACPI init
  701. 10.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.891194] pnp: PnP ACPI: found 6 devices
  702. 10.13 s [vm-test-run-centjes-e2e-test] client # [ 0.816557] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]
  703. 10.14 s [vm-test-run-centjes-e2e-test] client # [ 0.821233] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
  704. 10.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.899203] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
  705. 10.14 s [vm-test-run-centjes-e2e-test] client # [ 0.823932] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]
  706. 10.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.903209] clocksource: Switched to clocksource acpi_pm
  707. 10.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.905868] NET: Registered PF_INET protocol family
  708. 10.15 s [vm-test-run-centjes-e2e-test] client # [ 0.827555] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]
  709. 10.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.908349] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
  710. 10.15 s [vm-test-run-centjes-e2e-test] client # [ 0.831787] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
  711. 10.16 s [vm-test-run-centjes-e2e-test] client # [ 0.834561] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]
  712. 10.16 s [vm-test-run-centjes-e2e-test] client # [ 0.836498] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]
  713. 10.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.922357] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
  714. 10.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.926298] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
  715. 10.17 s [vm-test-run-centjes-e2e-test] client # [ 0.840995] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]
  716. 10.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.930061] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
  717. 10.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.933806] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
  718. 10.18 s [vm-test-run-centjes-e2e-test] client # [ 0.846695] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
  719. 10.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.937593] TCP: Hash tables configured (established 8192 bind 8192)
  720. 10.18 s [vm-test-run-centjes-e2e-test] client # [ 0.849555] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]
  721. 10.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.940622] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
  722. 10.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.944225] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
  723. 10.18 s [vm-test-run-centjes-e2e-test] client # [ 0.851442] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]
  724. 10.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.947375] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
  725. 10.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.950782] NET: Registered PF_UNIX/PF_LOCAL protocol family
  726. 10.19 s [vm-test-run-centjes-e2e-test] client # [ 0.855168] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]
  727. 10.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.953599] NET: Registered PF_XDP protocol family
  728. 10.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.956124] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
  729. 10.20 s [vm-test-run-centjes-e2e-test] client # [ 0.861073] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
  730. 10.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.959173] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
  731. 10.20 s [vm-test-run-centjes-e2e-test] client # [ 0.862787] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
  732. 10.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.962315] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
  733. 10.20 s [vm-test-run-centjes-e2e-test] client # [ 0.864765] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
  734. 10.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.965625] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]
  735. 10.21 s [vm-test-run-centjes-e2e-test] client # [ 0.866843] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
  736. 10.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.969547] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]
  737. 10.21 s [vm-test-run-centjes-e2e-test] client # [ 0.868657] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
  738. 10.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.972944] pci 0000:00:01.0: PIIX3: Enabling Passive Release
  739. 10.21 s [vm-test-run-centjes-e2e-test] client # [ 0.869980] iommu: Default domain type: Translated
  740. 10.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.975794] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
  741. 10.21 s [vm-test-run-centjes-e2e-test] client # [ 0.871556] iommu: DMA domain TLB invalidation policy: lazy mode
  742. 10.22 s [vm-test-run-centjes-e2e-test] client # [ 0.872605] ACPI: bus type USB registered
  743. 10.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.980231] ACPI: \_SB_.LNKD: Enabled at IRQ 11
  744. 10.22 s [vm-test-run-centjes-e2e-test] client # [ 0.873578] usbcore: registered new interface driver usbfs
  745. 10.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.984625] PCI: CLS 0 bytes, default 64
  746. 10.22 s [vm-test-run-centjes-e2e-test] client # [ 0.874565] usbcore: registered new interface driver hub
  747. 10.22 s [vm-test-run-centjes-e2e-test] client # [ 0.875588] usbcore: registered new device driver usb
  748. 10.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.987047] Trying to unpack rootfs image as initramfs...
  749. 10.23 s [vm-test-run-centjes-e2e-test] client # [ 0.877060] NetLabel: Initializing
  750. 10.23 s [vm-test-run-centjes-e2e-test] client # [ 0.878556] NetLabel: domain hash size = 128
  751. 10.23 s [vm-test-run-centjes-e2e-test] client # [ 0.879556] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
  752. 10.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 0.992127] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns
  753. 10.23 s [vm-test-run-centjes-e2e-test] client # [ 0.880576] NetLabel: unlabeled traffic allowed by default
  754. 10.24 s [vm-test-run-centjes-e2e-test] client # [ 0.881559] PCI: Using ACPI for IRQ routing
  755. 10.24 s [vm-test-run-centjes-e2e-test] client # [ 0.883320] pci 0000:00:02.0: vgaarb: setting as boot VGA device
  756. 10.24 s [vm-test-run-centjes-e2e-test] client # [ 0.883547] pci 0000:00:02.0: vgaarb: bridge control possible
  757. 10.25 s [vm-test-run-centjes-e2e-test] client # [ 0.883547] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
  758. 10.25 s [vm-test-run-centjes-e2e-test] client # [ 0.883559] vgaarb: loaded
  759. 10.25 s [vm-test-run-centjes-e2e-test] client # [ 0.884632] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
  760. 10.25 s [vm-test-run-centjes-e2e-test] client # [ 0.885556] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
  761. 10.26 s [vm-test-run-centjes-e2e-test] client # [ 0.888628] clocksource: Switched to clocksource kvm-clock
  762. 10.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.023302] Initialise system trusted keyrings
  763. 10.26 s [vm-test-run-centjes-e2e-test] client # [ 0.892897] VFS: Disk quotas dquot_6.6.0
  764. 10.26 s [vm-test-run-centjes-e2e-test] client # [ 0.895004] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
  765. 10.27 s [vm-test-run-centjes-e2e-test] client # [ 0.898415] pnp: PnP ACPI init
  766. 10.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.028211] workingset: timestamp_bits=40 max_order=18 bucket_order=0
  767. 10.27 s [vm-test-run-centjes-e2e-test] client # [ 0.900700] pnp: PnP ACPI: found 6 devices
  768. 10.28 s [vm-test-run-centjes-e2e-test] client # [ 0.908992] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
  769. 10.28 s [vm-test-run-centjes-e2e-test] client # [ 0.913071] clocksource: Switched to clocksource acpi_pm
  770. 10.28 s [vm-test-run-centjes-e2e-test] client # [ 0.915760] NET: Registered PF_INET protocol family
  771. 10.29 s [vm-test-run-centjes-e2e-test] client # [ 0.918267] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
  772. 10.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.054046] Key type asymmetric registered
  773. 10.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.059175] Asymmetric key parser 'x509' registered
  774. 10.30 s [vm-test-run-centjes-e2e-test] client # [ 0.931381] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
  775. 10.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.066075] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
  776. 10.30 s [vm-test-run-centjes-e2e-test] client # [ 0.935189] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
  777. 10.31 s [vm-test-run-centjes-e2e-test] client # [ 0.938779] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
  778. 10.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.074245] io scheduler mq-deadline registered
  779. 10.31 s [vm-test-run-centjes-e2e-test] client # [ 0.942455] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
  780. 10.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.076602] io scheduler kyber registered
  781. 10.31 s [vm-test-run-centjes-e2e-test] client # [ 0.945907] TCP: Hash tables configured (established 8192 bind 8192)
  782. 10.32 s [vm-test-run-centjes-e2e-test] client # [ 0.948962] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
  783. 10.32 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.082568] Freeing initrd memory: 12300K
  784. 10.32 s [vm-test-run-centjes-e2e-test] client # [ 0.952475] UDP hash table entries: 512 (order: 2, 16384 bytes, linear)
  785. 10.32 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.085142] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
  786. 10.32 s [vm-test-run-centjes-e2e-test] client # [ 0.955592] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear)
  787. 10.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.088528] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
  788. 10.33 s [vm-test-run-centjes-e2e-test] client # [ 0.958944] NET: Registered PF_UNIX/PF_LOCAL protocol family
  789. 10.33 s [vm-test-run-centjes-e2e-test] client # [ 0.961711] NET: Registered PF_XDP protocol family
  790. 10.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.093297] Linux agpgart interface v0.103
  791. 10.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.095312] ACPI: bus type drm_connector registered
  792. 10.33 s [vm-test-run-centjes-e2e-test] client # [ 0.964024] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
  793. 10.34 s [vm-test-run-centjes-e2e-test] client # [ 0.966884] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
  794. 10.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.098106] usbcore: registered new interface driver usbserial_generic
  795. 10.34 s [vm-test-run-centjes-e2e-test] client # [ 0.969796] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
  796. 10.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.101137] usbserial: USB Serial support registered for generic
  797. 10.34 s [vm-test-run-centjes-e2e-test] client # [ 0.972961] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]
  798. 10.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.104059] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
  799. 10.35 s [vm-test-run-centjes-e2e-test] client # [ 0.976187] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]
  800. 10.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.107795] drop_monitor: Initializing network drop monitor service
  801. 10.35 s [vm-test-run-centjes-e2e-test] client # [ 0.979474] pci 0000:00:01.0: PIIX3: Enabling Passive Release
  802. 10.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.111119] NET: Registered PF_INET6 protocol family
  803. 10.35 s [vm-test-run-centjes-e2e-test] client # [ 0.982372] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
  804. 10.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.114302] Segment Routing with IPv6
  805. 10.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.116479] In-situ OAM (IOAM) with IPv6
  806. 10.35 s [vm-test-run-centjes-e2e-test] client # [ 0.986626] ACPI: \_SB_.LNKD: Enabled at IRQ 11
  807. 10.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.118857] IPI shorthand broadcast: enabled
  808. 10.36 s [vm-test-run-centjes-e2e-test] client # [ 0.990989] PCI: CLS 0 bytes, default 64
  809. 10.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.123305] registered taskstats version 1
  810. 10.36 s [vm-test-run-centjes-e2e-test] client # [ 0.993219] Trying to unpack rootfs image as initramfs...
  811. 10.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.125640] Loading compiled-in X.509 certificates
  812. 10.37 s [vm-test-run-centjes-e2e-test] client # [ 0.997423] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns
  813. 10.37 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.132848] Demotion targets for Node 0: null
  814. 10.37 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.135358] Key type .fscrypt registered
  815. 10.37 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.137488] Key type fscrypt-provisioning registered
  816. 10.38 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.140191] PM: Magic number: 6:961:347
  817. 10.38 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.142250] pci0000:00: hash matches
  818. 10.38 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.144792] RAS: Correctable Errors collector initialized.
  819. 10.39 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.150607] Unstable clock detected, switching default tracing clock to "global"
  820. 10.39 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.150607] If you want to keep using the local clock, then add:
  821. 10.39 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.150607] "trace_clock=local"
  822. 10.39 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.150607] on the kernel command line
  823. 10.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.159606] clk: Disabling unused clocks
  824. 10.40 s [vm-test-run-centjes-e2e-test] client # [ 1.029592] Initialise system trusted keyrings
  825. 10.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.161655] PM: genpd: Disabling unused power domains
  826. 10.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.165271] Freeing unused decrypted memory: 2028K
  827. 10.40 s [vm-test-run-centjes-e2e-test] client # [ 1.034521] workingset: timestamp_bits=40 max_order=18 bucket_order=0
  828. 10.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.168150] Freeing unused kernel image (initmem) memory: 3408K
  829. 10.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.171023] Write protecting the kernel read-only data: 30720k
  830. 10.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.174201] Freeing unused kernel image (rodata/data gap) memory: 1756K
  831. 10.43 s [vm-test-run-centjes-e2e-test] client # [ 1.060477] Key type asymmetric registered
  832. 10.43 s [vm-test-run-centjes-e2e-test] client # [ 1.065537] Asymmetric key parser 'x509' registered
  833. 10.44 s [vm-test-run-centjes-e2e-test] client # [ 1.072429] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
  834. 10.45 s [vm-test-run-centjes-e2e-test] client # [ 1.080438] io scheduler mq-deadline registered
  835. 10.45 s [vm-test-run-centjes-e2e-test] client # [ 1.082620] io scheduler kyber registered
  836. 10.46 s [vm-test-run-centjes-e2e-test] client # [ 1.089375] Freeing initrd memory: 12300K
  837. 10.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.219932] x86/mm: Checked W+X mappings: passed, no W+X pages found.
  838. 10.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.223082] Run /init as init process
  839. 10.46 s [vm-test-run-centjes-e2e-test] client # [ 1.091808] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
  840. 10.46 s [vm-test-run-centjes-e2e-test] client # [ 1.095199] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
  841. 10.47 s [vm-test-run-centjes-e2e-test] client # [ 1.100077] Linux agpgart interface v0.103
  842. 10.47 s [vm-test-run-centjes-e2e-test] client # [ 1.102165] ACPI: bus type drm_connector registered
  843. 10.47 s [vm-test-run-centjes-e2e-test] client # [ 1.104930] usbcore: registered new interface driver usbserial_generic
  844. 10.48 s [vm-test-run-centjes-e2e-test] client # [ 1.107986] usbserial: USB Serial support registered for generic
  845. 10.48 s [vm-test-run-centjes-e2e-test] client # [ 1.110919] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
  846. 10.48 s [vm-test-run-centjes-e2e-test] client # [ 1.114417] drop_monitor: Initializing network drop monitor service
  847. 10.49 s [vm-test-run-centjes-e2e-test] client # [ 1.117378] NET: Registered PF_INET6 protocol family
  848. 10.49 s [vm-test-run-centjes-e2e-test] client # [ 1.120358] Segment Routing with IPv6
  849. 10.49 s [vm-test-run-centjes-e2e-test] client # [ 1.122243] In-situ OAM (IOAM) with IPv6
  850. 10.49 s [vm-test-run-centjes-e2e-test] client # [ 1.125180] IPI shorthand broadcast: enabled
  851. 10.50 s [vm-test-run-centjes-e2e-test] client # [ 1.130189] registered taskstats version 1
  852. 10.50 s [vm-test-run-centjes-e2e-test] client # [ 1.132615] Loading compiled-in X.509 certificates
  853. 10.51 s [vm-test-run-centjes-e2e-test] client # [ 1.140639] Demotion targets for Node 0: null
  854. 10.51 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.271282] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
  855. 10.51 s [vm-test-run-centjes-e2e-test] client # [ 1.143116] Key type .fscrypt registered
  856. 10.51 s [vm-test-run-centjes-e2e-test] client # [ 1.145333] Key type fscrypt-provisioning registered
  857. 10.52 s [vm-test-run-centjes-e2e-test] client # [ 1.148167] PM: Magic number: 6:961:347
  858. 10.52 s [vm-test-run-centjes-e2e-test] client # [ 1.150357] pci0000:00: hash matches
  859. 10.52 s [vm-test-run-centjes-e2e-test] client # [ 1.153032] RAS: Correctable Errors collector initialized.
  860. 10.53 s [vm-test-run-centjes-e2e-test] client # [ 1.159425] Unstable clock detected, switching default tracing clock to "global"
  861. 10.53 s [vm-test-run-centjes-e2e-test] client # [ 1.159425] If you want to keep using the local clock, then add:
  862. 10.53 s [vm-test-run-centjes-e2e-test] client # [ 1.159425] "trace_clock=local"
  863. 10.53 s [vm-test-run-centjes-e2e-test] client # [ 1.159425] on the kernel command line
  864. 10.54 s [vm-test-run-centjes-e2e-test] client # [ 1.168366] clk: Disabling unused clocks
  865. 10.54 s [vm-test-run-centjes-e2e-test] client # [ 1.170387] PM: genpd: Disabling unused power domains
  866. 10.54 s [vm-test-run-centjes-e2e-test] client # [ 1.173953] Freeing unused decrypted memory: 2028K
  867. 10.55 s [vm-test-run-centjes-e2e-test] client # [ 1.176727] Freeing unused kernel image (initmem) memory: 3408K
  868. 10.55 s [vm-test-run-centjes-e2e-test] client # [ 1.179731] Write protecting the kernel read-only data: 30720k
  869. 10.55 s [vm-test-run-centjes-e2e-test] client # [ 1.183078] Freeing unused kernel image (rodata/data gap) memory: 1756K
  870. 10.60 s [vm-test-run-centjes-e2e-test] client # [ 1.228791] x86/mm: Checked W+X mappings: passed, no W+X pages found.
  871. 10.60 s [vm-test-run-centjes-e2e-test] client # [ 1.231922] Run /init as init process
  872. 10.65 s [vm-test-run-centjes-e2e-test] client # [ 1.280101] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev
  873. 10.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.451219] ACPI: \_SB_.LNKC: Enabled at IRQ 10
  874. 10.70 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.459844] uhci_hcd 0000:00:01.2: UHCI Host Controller
  875. 10.70 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.465540] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
  876. 10.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.479382] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
  877. 10.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.482899] SCSI subsystem initialized
  878. 10.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.493577] serio: i8042 KBD port at 0x60,0x64 irq 1
  879. 10.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.498641] uhci_hcd 0000:00:01.2: detected 2 ports
  880. 10.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.507064] serio: i8042 AUX port at 0x60,0x64 irq 12
  881. 10.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.514274] ACPI: \_SB_.LNKA: Enabled at IRQ 10
  882. 10.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.517098] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100
  883. 10.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.529050] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12
  884. 10.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.533663] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
  885. 10.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.538245] usb usb1: Product: UHCI Host Controller
  886. 10.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.540668] usb usb1: Manufacturer: Linux 6.12.62 uhci_hcd
  887. 10.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.543460] usb usb1: SerialNumber: 0000:00:01.2
  888. 10.79 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.556935] ACPI: \_SB_.LNKB: Enabled at IRQ 11
  889. 10.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.567157] scsi host0: ata_piix
  890. 10.81 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.574260] scsi host1: ata_piix
  891. 10.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.578482] hub 1-0:1.0: USB hub found
  892. 10.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.582571] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0
  893. 10.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.586158] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0
  894. 10.83 s [vm-test-run-centjes-e2e-test] client # [ 1.456530] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
  895. 10.83 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.593211] hub 1-0:1.0: 2 ports detected
  896. 10.85 s [vm-test-run-centjes-e2e-test] client # [ 1.480129] uhci_hcd 0000:00:01.2: UHCI Host Controller
  897. 10.86 s [vm-test-run-centjes-e2e-test] client # [ 1.491087] ACPI: \_SB_.LNKC: Enabled at IRQ 10
  898. 10.86 s [vm-test-run-centjes-e2e-test] client # [ 1.493948] serio: i8042 KBD port at 0x60,0x64 irq 1
  899. 10.86 s [vm-test-run-centjes-e2e-test] client # [ 1.496731] SCSI subsystem initialized
  900. 10.87 s [vm-test-run-centjes-e2e-test] client # [ 1.498640] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
  901. 10.87 s [vm-test-run-centjes-e2e-test] client # [ 1.504363] serio: i8042 AUX port at 0x60,0x64 irq 12
  902. 10.88 s [vm-test-run-centjes-e2e-test] client # [ 1.511409] uhci_hcd 0000:00:01.2: detected 2 ports
  903. 10.89 s [vm-test-run-centjes-e2e-test] client # [ 1.524585] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100
  904. 10.90 s [vm-test-run-centjes-e2e-test] client # [ 1.531438] ACPI: \_SB_.LNKA: Enabled at IRQ 10
  905. 10.91 s [vm-test-run-centjes-e2e-test] client # [ 1.536520] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12
  906. 10.91 s [vm-test-run-centjes-e2e-test] client # [ 1.540134] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
  907. 10.91 s [vm-test-run-centjes-e2e-test] client # [ 1.543461] usb usb1: Product: UHCI Host Controller
  908. 10.91 s [vm-test-run-centjes-e2e-test] client # [ 1.545968] usb usb1: Manufacturer: Linux 6.12.62 uhci_hcd
  909. 10.92 s [vm-test-run-centjes-e2e-test] client # [ 1.548713] usb usb1: SerialNumber: 0000:00:01.2
  910. 10.93 s [vm-test-run-centjes-e2e-test] client # [ 1.559490] scsi host0: ata_piix
  911. 10.93 s [vm-test-run-centjes-e2e-test] client # [ 1.562730] ACPI: \_SB_.LNKB: Enabled at IRQ 11
  912. 10.93 s [vm-test-run-centjes-e2e-test] client # [ 1.565924] scsi host1: ata_piix
  913. 10.94 s [vm-test-run-centjes-e2e-test] client # [ 1.570065] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0
  914. 10.94 s [vm-test-run-centjes-e2e-test] client # [ 1.573830] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0
  915. 10.95 s [vm-test-run-centjes-e2e-test] client # [ 1.579718] hub 1-0:1.0: USB hub found
  916. 10.95 s [vm-test-run-centjes-e2e-test] client # [ 1.585718] hub 1-0:1.0: 2 ports detected
  917. 10.98 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.741609] ata2: found unknown device (class 0)
  918. 10.98 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.745609] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
  919. 10.99 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.750370] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
  920. 11.05 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.813204] usb 1-1: new full-speed USB device number 2 using uhci_hcd
  921. 11.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.841762] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
  922. 11.10 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.862485] virtio_blk virtio5: 1/0/0 default/read/poll queues
  923. 11.10 s [vm-test-run-centjes-e2e-test] client # [ 1.732405] ata2: found unknown device (class 0)
  924. 11.10 s [vm-test-run-centjes-e2e-test] client # [ 1.736007] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
  925. 11.11 s [vm-test-run-centjes-e2e-test] client # [ 1.740882] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
  926. 11.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.894394] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
  927. 11.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.905204] netfs: FS-Cache loaded
  928. 11.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.910467] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
  929. 11.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.913801] cdrom: Uniform CD-ROM driver Revision: 3.20
  930. 11.17 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.930767] 9pnet: Installing 9P2000 support
  931. 11.18 s [vm-test-run-centjes-e2e-test] client # [ 1.811388] usb 1-1: new full-speed USB device number 2 using uhci_hcd
  932. 11.20 s [vm-test-run-centjes-e2e-test] client # [ 1.830551] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
  933. 11.22 s [vm-test-run-centjes-e2e-test] client # [ 1.856026] virtio_blk virtio5: 1/0/0 default/read/poll queues
  934. 11.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.988177] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
  935. 11.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.992370] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
  936. 11.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.995709] usb 1-1: Product: QEMU USB Tablet
  937. 11.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.997932] usb 1-1: Manufacturer: QEMU
  938. 11.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 1.999885] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
  939. 11.25 s [vm-test-run-centjes-e2e-test] client # [ 1.884830] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
  940. 11.26 s [vm-test-run-centjes-e2e-test] client # [ 1.891136] netfs: FS-Cache loaded
  941. 11.27 s [vm-test-run-centjes-e2e-test] client # [ 1.901811] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
  942. 11.27 s [vm-test-run-centjes-e2e-test] client # [ 1.904952] cdrom: Uniform CD-ROM driver Revision: 3.20
  943. 11.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.036153] hid: raw HID events driver (C) Jiri Kosina
  944. 11.28 s [vm-test-run-centjes-e2e-test] client # [ 1.916633] 9pnet: Installing 9P2000 support
  945. 11.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.048345] usbcore: registered new interface driver usbhid
  946. 11.29 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.051261] usbhid: USB HID core driver
  947. 11.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.056111] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2
  948. 11.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.062488] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0
  949. 11.35 s [vm-test-run-centjes-e2e-test] client # [ 1.984001] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
  950. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 1.988062] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
  951. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 1.992379] usb 1-1: Product: QEMU USB Tablet
  952. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 1.994908] usb 1-1: Manufacturer: QEMU
  953. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 1.997097] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
  954. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.024076] hid: raw HID events driver (C) Jiri Kosina
  955. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.035266] usbcore: registered new interface driver usbhid
  956. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.037916] usbhid: USB HID core driver
  957. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.043919] input: QEMU QEMU USB Tablet as /devices/pci0000:00/0000:00:01.2/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input2
  958. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.049784] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:01.2-1/input0
  959. 11.71 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.229133] EXT4-fs (vda): mounted filesystem 8bafdc3e-a9c6-4182-85ff-ada38abb7a0a r/w with ordered data mode. Quota mode: none.
  960. 11.71 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.254904] 9p: Installing v9fs 9p2000 file system support
  961. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.201066] EXT4-fs (vda): mounted filesystem 13ea7290-ac56-4d64-9292-a47a8c0330df r/w with ordered data mode. Quota mode: none.
  962. 11.71 s [vm-test-run-centjes-e2e-test] client # [ 2.222228] 9p: Installing v9fs 9p2000 file system support
  963. 11.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.510148] EXT4-fs (vda): re-mounted 8bafdc3e-a9c6-4182-85ff-ada38abb7a0a.
  964. 11.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 2.515263] booting system configuration /nix/store/5qakzg9g44siizj8li3r9blll9pw7bvp-nixos-system-docsserver-test
  965. 11.83 s [vm-test-run-centjes-e2e-test] client # [ 2.464401] EXT4-fs (vda): re-mounted 13ea7290-ac56-4d64-9292-a47a8c0330df.
  966. 11.84 s [vm-test-run-centjes-e2e-test] client # [ 2.469227] booting system configuration /nix/store/001k9r4jinw78ih5x5hxggb82ynlbkqn-nixos-system-client-test
  967. 13.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.428360] systemd[1]: Inserted module 'autofs4'
  968. 13.67 s [vm-test-run-centjes-e2e-test] client # [ 4.297775] systemd[1]: Inserted module 'autofs4'
  969. 13.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.482839] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE)
  970. 13.73 s [vm-test-run-centjes-e2e-test] client # [ 4.351726] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE)
  971. 13.73 s [vm-test-run-centjes-e2e-test] client # [ 4.365871] systemd[1]: Detected virtualization kvm.
  972. 13.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.496832] systemd[1]: Detected virtualization kvm.
  973. 13.74 s [vm-test-run-centjes-e2e-test] client # [ 4.368378] systemd[1]: Detected architecture x86-64.
  974. 13.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.500206] systemd[1]: Detected architecture x86-64.
  975. 13.74 s [vm-test-run-centjes-e2e-test] client # [ 4.370823] systemd[1]: Detected first boot.
  976. 13.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.502822] systemd[1]: Detected first boot.
  977. 13.75 s [vm-test-run-centjes-e2e-test] client # [ 4.379122] systemd[1]: Initializing machine ID from random generator.
  978. 13.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.510876] systemd[1]: Initializing machine ID from random generator.
  979. 13.80 s [vm-test-run-centjes-e2e-test] client # [ 4.431019] systemd[1]: Hostname set to <client>.
  980. 13.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.562116] systemd[1]: Hostname set to <docsserver>.
  981. 13.92 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.679311] systemd[1]: bpf-restrict-fs: LSM BPF program attached
  982. 13.92 s [vm-test-run-centjes-e2e-test] client # [ 4.552256] systemd[1]: bpf-restrict-fs: LSM BPF program attached
  983. 14.08 s [vm-test-run-centjes-e2e-test] docsserver # [ 4.842311] systemd[1]: Applying preset policy.
  984. 14.08 s [vm-test-run-centjes-e2e-test] client # [ 4.714132] systemd[1]: Applying preset policy.
  985. 14.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.393534] systemd[1]: Populated /etc with preset unit settings.
  986. 14.64 s [vm-test-run-centjes-e2e-test] client # [ 5.275475] systemd[1]: Populated /etc with preset unit settings.
  987. 15.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.801318] systemd[1]: /etc/systemd/system/centjes-docs-site-production.service:3: Invalid URL, ignoring: /nix/store/d5g8rpx497v2ywm07q1pfjg7pdgi1761-settings-check
  988. 15.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.912129] systemd[1]: Queued start job for default target Multi-User System.
  989. 15.15 s [vm-test-run-centjes-e2e-test] client # [ 5.781069] systemd[1]: Queued start job for default target Multi-User System.
  990. 15.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.945213] systemd[1]: Created slice Slice /system/getty.
  991. 15.18 s [vm-test-run-centjes-e2e-test] client # [ 5.816026] systemd[1]: Created slice Slice /system/getty.
  992. 15.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.947948] systemd[1]: Created slice Slice /system/modprobe.
  993. 15.19 s [vm-test-run-centjes-e2e-test] client # [ 5.818963] systemd[1]: Created slice Slice /system/modprobe.
  994. 15.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.951445] systemd[1]: Created slice User and Session Slice.
  995. 15.19 s [vm-test-run-centjes-e2e-test] client # [ 5.821827] systemd[1]: Created slice User and Session Slice.
  996. 15.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.954776] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
  997. 15.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.957831] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
  998. 15.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.960839] systemd[1]: Expecting device /dev/hvc0...
  999. 15.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.962811] systemd[1]: Expecting device /dev/ttyS0...
  1000. 15.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.964872] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1...
  1001. 15.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.967600] systemd[1]: Reached target Local Encrypted Volumes.
  1002. 15.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.970114] systemd[1]: Reached target Virtual Machines and Containers.
  1003. 15.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.972530] systemd[1]: Reached target Path Units.
  1004. 15.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.974438] systemd[1]: Reached target Remote File Systems.
  1005. 15.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.976527] systemd[1]: Reached target Slice Units.
  1006. 15.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.978462] systemd[1]: Reached target Swaps.
  1007. 15.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.984803] systemd[1]: Listening on Process Core Dump Socket.
  1008. 15.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.989654] systemd[1]: Listening on Credential Encryption/Decryption.
  1009. 15.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.992611] systemd[1]: Listening on Journal Audit Socket.
  1010. 15.23 s [vm-test-run-centjes-e2e-test] client # [ 5.863064] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
  1011. 15.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.995137] systemd[1]: Listening on Journal Socket (/dev/log).
  1012. 15.23 s [vm-test-run-centjes-e2e-test] docsserver # [ 5.997747] systemd[1]: Listening on Journal Sockets.
  1013. 15.24 s [vm-test-run-centjes-e2e-test] client # [ 5.866562] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
  1014. 15.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.000715] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
  1015. 15.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.003562] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
  1016. 15.24 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.007651] systemd[1]: Listening on udev Control Socket.
  1017. 15.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.009863] systemd[1]: Listening on udev Kernel Socket.
  1018. 15.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.016397] systemd[1]: Mounting Huge Pages File System...
  1019. 15.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.021900] systemd[1]: Mounting POSIX Message Queue File System...
  1020. 15.26 s [vm-test-run-centjes-e2e-test] client # [ 5.891092] systemd[1]: Expecting device /dev/hvc0...
  1021. 15.26 s [vm-test-run-centjes-e2e-test] client # [ 5.893723] systemd[1]: Expecting device /dev/ttyS0...
  1022. 15.26 s [vm-test-run-centjes-e2e-test] client # [ 5.896055] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1...
  1023. 15.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.030113] systemd[1]: Mounting Kernel Debug File System...
  1024. 15.27 s [vm-test-run-centjes-e2e-test] client # [ 5.899106] systemd[1]: Reached target Local Encrypted Volumes.
  1025. 15.27 s [vm-test-run-centjes-e2e-test] client # [ 5.901818] systemd[1]: Reached target Virtual Machines and Containers.
  1026. 15.27 s [vm-test-run-centjes-e2e-test] client # [ 5.904657] systemd[1]: Reached target Path Units.
  1027. 15.27 s [vm-test-run-centjes-e2e-test] client # [ 5.906767] systemd[1]: Reached target Remote File Systems.
  1028. 15.28 s [vm-test-run-centjes-e2e-test] client # [ 5.909122] systemd[1]: Reached target Slice Units.
  1029. 15.28 s [vm-test-run-centjes-e2e-test] client # [ 5.911180] systemd[1]: Reached target Swaps.
  1030. 15.28 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.043298] systemd[1]: Mounting Kernel Trace File System...
  1031. 15.29 s [vm-test-run-centjes-e2e-test] client # [ 5.923621] systemd[1]: Listening on Process Core Dump Socket.
  1032. 15.30 s [vm-test-run-centjes-e2e-test] client # [ 5.928636] systemd[1]: Listening on Credential Encryption/Decryption.
  1033. 15.30 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.060716] systemd[1]: Starting Create List of Static Device Nodes...
  1034. 15.30 s [vm-test-run-centjes-e2e-test] client # [ 5.931842] systemd[1]: Listening on Journal Audit Socket.
  1035. 15.30 s [vm-test-run-centjes-e2e-test] client # [ 5.934382] systemd[1]: Listening on Journal Socket (/dev/log).
  1036. 15.30 s [vm-test-run-centjes-e2e-test] client # [ 5.936919] systemd[1]: Listening on Journal Sockets.
  1037. 15.31 s [vm-test-run-centjes-e2e-test] client # [ 5.939620] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
  1038. 15.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.070874] systemd[1]: Load Kernel Module 9pnet_virtio was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!9pnet_virtio).
  1039. 15.31 s [vm-test-run-centjes-e2e-test] client # [ 5.942858] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
  1040. 15.32 s [vm-test-run-centjes-e2e-test] client # [ 5.947516] systemd[1]: Listening on udev Control Socket.
  1041. 15.32 s [vm-test-run-centjes-e2e-test] client # [ 5.949989] systemd[1]: Listening on udev Kernel Socket.
  1042. 15.32 s [vm-test-run-centjes-e2e-test] client # [ 5.956478] systemd[1]: Mounting Huge Pages File System...
  1043. 15.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.092302] systemd[1]: Starting Load Kernel Module configfs...
  1044. 15.33 s [vm-test-run-centjes-e2e-test] client # [ 5.962071] systemd[1]: Mounting POSIX Message Queue File System...
  1045. 15.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.096246] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm).
  1046. 15.34 s [vm-test-run-centjes-e2e-test] client # [ 5.970425] systemd[1]: Mounting Kernel Debug File System...
  1047. 15.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.106256] systemd[1]: Starting Load Kernel Module efi_pstore...
  1048. 15.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.115504] systemd[1]: Starting Load Kernel Module fuse...
  1049. 15.35 s [vm-test-run-centjes-e2e-test] client # [ 5.985481] systemd[1]: Mounting Kernel Trace File System...
  1050. 15.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.120161] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
  1051. 15.37 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.126378] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
  1052. 15.37 s [vm-test-run-centjes-e2e-test] client # [ 5.999470] systemd[1]: Starting Create List of Static Device Nodes...
  1053. 15.38 s [vm-test-run-centjes-e2e-test] client # [ 6.008240] systemd[1]: Load Kernel Module 9pnet_virtio was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!9pnet_virtio).
  1054. 15.38 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.146927] systemd[1]: Starting Journal Service...
  1055. 15.40 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.159937] systemd[1]: Starting Load Kernel Modules...
  1056. 15.40 s [vm-test-run-centjes-e2e-test] client # [ 6.034021] systemd[1]: Starting Load Kernel Module configfs...
  1057. 15.41 s [vm-test-run-centjes-e2e-test] client # [ 6.037596] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm).
  1058. 15.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.171579] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
  1059. 15.42 s [vm-test-run-centjes-e2e-test] client # [ 6.050615] systemd[1]: Starting Load Kernel Module efi_pstore...
  1060. 15.42 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.185287] systemd[1]: Starting Remount Root and Kernel File Systems...
  1061. 15.43 s [vm-test-run-centjes-e2e-test] client # [ 6.060762] systemd[1]: Starting Load Kernel Module fuse...
  1062. 15.43 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.191670] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
  1063. 15.44 s [vm-test-run-centjes-e2e-test] client # [ 6.065470] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/).
  1064. 15.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.205609] systemd[1]: Starting Coldplug All udev Devices...
  1065. 15.45 s [vm-test-run-centjes-e2e-test] client # [ 6.076117] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67).
  1066. 15.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.223266] systemd[1]: Mounted Huge Pages File System.
  1067. 15.46 s [vm-test-run-centjes-e2e-test] client # [ 6.093766] systemd[1]: Starting Journal Service...
  1068. 15.47 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.230665] systemd[1]: Mounted POSIX Message Queue File System.
  1069. 15.47 s [vm-test-run-centjes-e2e-test] client # [ 6.102938] systemd[1]: Starting Load Kernel Modules...
  1070. 15.47 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.236350] systemd[1]: Mounted Kernel Debug File System.
  1071. 15.48 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.241873] systemd[1]: Mounted Kernel Trace File System.
  1072. 15.48 s [vm-test-run-centjes-e2e-test] client # [ 6.113794] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
  1073. 15.49 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.248503] systemd[1]: Finished Create List of Static Device Nodes.
  1074. 15.49 s [vm-test-run-centjes-e2e-test] client # [ 6.123951] systemd[1]: Starting Remount Root and Kernel File Systems...
  1075. 15.50 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.261195] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
  1076. 15.50 s [vm-test-run-centjes-e2e-test] client # [ 6.128931] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
  1077. 15.51 s [vm-test-run-centjes-e2e-test] client # [ 6.144231] systemd[1]: Starting Coldplug All udev Devices...
  1078. 15.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.280547] systemd[1]: modprobe@configfs.service: Deactivated successfully.
  1079. 15.52 s [vm-test-run-centjes-e2e-test] client # [ 6.155634] systemd[1]: Mounted Huge Pages File System.
  1080. 15.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.287241] systemd[1]: Finished Load Kernel Module configfs.
  1081. 15.53 s [vm-test-run-centjes-e2e-test] client # [ 6.160793] systemd[1]: Mounted POSIX Message Queue File System.
  1082. 15.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.293683] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
  1083. 15.53 s [vm-test-run-centjes-e2e-test] client # [ 6.166835] systemd[1]: Mounted Kernel Debug File System.
  1084. 15.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.301769] systemd[1]: Finished Load Kernel Module efi_pstore.
  1085. 15.54 s [vm-test-run-centjes-e2e-test] client # [ 6.171650] systemd[1]: Mounted Kernel Trace File System.
  1086. 15.55 s [vm-test-run-centjes-e2e-test] client # [ 6.179675] systemd[1]: Finished Create List of Static Device Nodes.
  1087. 15.55 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.313163] systemd[1]: Mounting Kernel Configuration File System...
  1088. 15.56 s [vm-test-run-centjes-e2e-test] client # [ 6.192536] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
  1089. 15.58 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.341531] systemd[1]: Mounted Kernel Configuration File System.
  1090. 15.59 s [vm-test-run-centjes-e2e-test] client # [ 6.216858] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully.
  1091. 15.59 s [vm-test-run-centjes-e2e-test] client # [ 6.224457] systemd[1]: Finished Load Kernel Module efi_pstore.
  1092. 15.60 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.360884] EXT4-fs (vda): re-mounted 8bafdc3e-a9c6-4182-85ff-ada38abb7a0a.
  1093. 15.61 s [vm-test-run-centjes-e2e-test] client # [ 6.238222] systemd[1]: modprobe@configfs.service: Deactivated successfully.
  1094. 15.61 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.372621] fuse: init (API version 7.41)
  1095. 15.61 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.375777] loop: module loaded
  1096. 15.61 s [vm-test-run-centjes-e2e-test] client # [ 6.244122] systemd[1]: Finished Load Kernel Module configfs.
  1097. 15.62 s [vm-test-run-centjes-e2e-test] client # [ 6.253516] systemd[1]: Mounting Kernel Configuration File System...
  1098. 15.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.384667] systemd[1]: Finished Remount Root and Kernel File Systems.
  1099. 15.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.388475] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
  1100. 15.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.396228] systemd-journald[383]: Collecting audit messages is enabled.
  1101. 15.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.403258] systemd[1]: Starting Load/Save OS Random Seed...
  1102. 15.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.407532] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
  1103. 15.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.416574] systemd[1]: modprobe@fuse.service: Deactivated successfully.
  1104. 15.65 s [vm-test-run-centjes-e2e-test] client # [ 6.285083] EXT4-fs (vda): re-mounted 13ea7290-ac56-4d64-9292-a47a8c0330df.
  1105. 15.66 s [vm-test-run-centjes-e2e-test] client # [ 6.289944] systemd[1]: Mounted Kernel Configuration File System.
  1106. 15.66 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.423884] systemd[1]: Finished Load Kernel Module fuse.
  1107. 15.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.431144] systemd[1]: Finished Load Kernel Modules.
  1108. 15.68 s [vm-test-run-centjes-e2e-test] client # [ 6.311614] loop: module loaded
  1109. 15.68 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.444465] systemd[1]: Starting Firewall...
  1110. 15.69 s [vm-test-run-centjes-e2e-test] client # [ 6.320524] systemd[1]: Finished Remount Root and Kernel File Systems.
  1111. 15.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.454156] systemd[1]: Starting Apply Kernel Variables...
  1112. 15.69 s [vm-test-run-centjes-e2e-test] client # [ 6.325437] fuse: init (API version 7.41)
  1113. 15.70 s [vm-test-run-centjes-e2e-test] client # [ 6.327797] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore).
  1114. 15.71 s [vm-test-run-centjes-e2e-test] client # [ 6.339907] systemd-journald[386]: Collecting audit messages is enabled.
  1115. 15.71 s [vm-test-run-centjes-e2e-test] client # [ 6.345993] systemd[1]: Starting Load/Save OS Random Seed...
  1116. 15.72 s [vm-test-run-centjes-e2e-test] client # [ 6.350821] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki).
  1117. 15.73 s [vm-test-run-centjes-e2e-test] client # [ 6.361931] systemd[1]: modprobe@fuse.service: Deactivated successfully.
  1118. 15.74 s [vm-test-run-centjes-e2e-test] client # [ 6.368930] systemd[1]: Finished Load Kernel Module fuse.
  1119. 15.74 s [vm-test-run-centjes-e2e-test] client # [ 6.375913] systemd[1]: Finished Load Kernel Modules.
  1120. 15.75 s [vm-test-run-centjes-e2e-test] client # [ 6.386997] systemd[1]: Starting Firewall...
  1121. 15.76 s [vm-test-run-centjes-e2e-test] client # [ 6.396071] systemd[1]: Starting Apply Kernel Variables...
  1122. 15.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.529953] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
  1123. 15.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.543183] systemd[1]: Starting Create Static Device Nodes in /dev...
  1124. 15.79 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.549221] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
  1125. 15.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.558428] systemd[1]: Finished Load/Save OS Random Seed.
  1126. 15.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.563949] systemd[1]: Reached target First Boot Complete.
  1127. 15.84 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.601217] systemd[1]: Finished Apply Kernel Variables.
  1128. 15.85 s [vm-test-run-centjes-e2e-test] client # [ 6.481202] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
  1129. 15.86 s [vm-test-run-centjes-e2e-test] client # [ 6.491513] systemd[1]: Starting Create Static Device Nodes in /dev...
  1130. 15.87 s [vm-test-run-centjes-e2e-test] client # [ 6.505813] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
  1131. 15.89 s [vm-test-run-centjes-e2e-test] client # [ 6.517768] systemd[1]: Finished Load/Save OS Random Seed.
  1132. 15.89 s [vm-test-run-centjes-e2e-test] client # [ 6.524084] systemd[1]: Reached target First Boot Complete.
  1133. 15.91 s [vm-test-run-centjes-e2e-test] client # [ 6.540554] systemd[1]: Finished Apply Kernel Variables.
  1134. 15.93 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.695279] systemd[1]: Finished Create Static Device Nodes in /dev.
  1135. 15.94 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.700772] systemd[1]: Reached target Preparation for Local File Systems.
  1136. 15.95 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.713217] systemd[1]: Starting Rule-based Manager for Device Events and Files...
  1137. 16.01 s [vm-test-run-centjes-e2e-test] client # [ 6.644649] systemd[1]: Finished Create Static Device Nodes in /dev.
  1138. 16.02 s [vm-test-run-centjes-e2e-test] client # [ 6.650831] systemd[1]: Reached target Preparation for Local File Systems.
  1139. 16.03 s [vm-test-run-centjes-e2e-test] client # [ 6.659582] systemd[1]: Starting Rule-based Manager for Device Events and Files...
  1140. 16.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.918198] systemd[1]: Started Journal Service.
  1141. 16.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.536091] systemd-modules-load[384]: Inserted module 'loop'
  1142. 16.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.547628] systemd-oomd[385]: [0;1;38:5:185mNo swap; memory pressure usage will be degraded
  1143. 16.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.563451] systemd-udevd[408]: Using default interface naming scheme 'v258'.
  1144. 16.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.578841] systemd[1]: Starting Flush Journal to Persistent Storage...
  1145. 16.22 s [vm-test-run-centjes-e2e-test] client # [ 6.856868] systemd[1]: Started Journal Service.
  1146. 16.23 s [vm-test-run-centjes-e2e-test] client # [ 6.460409] systemd-modules-load[387]: Inserted module 'loop'
  1147. 16.24 s [vm-test-run-centjes-e2e-test] client # [ 6.469715] systemd-oomd[388]: [0;1;38:5:185mNo swap; memory pressure usage will be degraded
  1148. 16.26 s [vm-test-run-centjes-e2e-test] client # [ 6.486466] systemd-udevd[411]: Using default interface naming scheme 'v258'.
  1149. 16.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.028358] systemd-journald[383]: Received client request to flush runtime journal.
  1150. 16.27 s [vm-test-run-centjes-e2e-test] client # [ 6.499796] systemd[1]: Starting Flush Journal to Persistent Storage...
  1151. 16.35 s [vm-test-run-centjes-e2e-test] client # [ 6.978046] systemd-journald[386]: Received client request to flush runtime journal.
  1152. 16.51 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.881422] systemd[1]: Finished Coldplug All udev Devices.
  1153. 16.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.893672] systemd[1]: Started Rule-based Manager for Device Events and Files.
  1154. 16.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.909190] systemd[1]: Mounting /run/wrappers...
  1155. 16.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.918944] systemd[1]: Mounting FUSE Control File System...
  1156. 16.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.925610] systemd[1]: Mounted FUSE Control File System.
  1157. 16.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.939283] systemd[1]: Finished Flush Journal to Persistent Storage.
  1158. 16.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.949339] systemd[1]: Mounted /run/wrappers.
  1159. 16.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.954875] systemd[1]: Reached target Local File Systems.
  1160. 16.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.966237] systemd[1]: Listening on Boot Entries Service Socket.
  1161. 16.63 s [vm-test-run-centjes-e2e-test] client # [ 6.818781] systemd[1]: Finished Coldplug All udev Devices.
  1162. 16.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.975484] systemd[1]: Starting Create SUID/SGID Wrappers...
  1163. 16.63 s [vm-test-run-centjes-e2e-test] client # [ 6.839636] systemd[1]: Started Rule-based Manager for Device Events and Files.
  1164. 16.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 6.986370] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.
  1165. 16.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.002237] systemd[1]: Starting Save Transient machine-id to Disk...
  1166. 16.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.015841] systemd[1]: Starting Create System Files and Directories...
  1167. 16.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.093710] systemd[1]: Finished Create System Files and Directories.
  1168. 16.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.112560] systemd[1]: Starting Rebuild Journal Catalog...
  1169. 16.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.121667] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
  1170. 16.76 s [vm-test-run-centjes-e2e-test] client # [ 6.858339] systemd[1]: Mounting /run/wrappers...
  1171. 16.76 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.133613] systemd[1]: Finished Save Transient machine-id to Disk.
  1172. 16.79 s [vm-test-run-centjes-e2e-test] client # [ 7.018499] systemd[1]: Mounting FUSE Control File System...
  1173. 16.80 s [vm-test-run-centjes-e2e-test] client # [ 7.033479] systemd[1]: Mounted FUSE Control File System.
  1174. 16.80 s [vm-test-run-centjes-e2e-test] client # [ 7.036347] systemd[1]: Mounted /run/wrappers.
  1175. 16.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.192405] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
  1176. 16.82 s [vm-test-run-centjes-e2e-test] client # [ 7.051643] systemd[1]: Reached target Local File Systems.
  1177. 16.84 s [vm-test-run-centjes-e2e-test] client # [ 7.068537] systemd[1]: Listening on Boot Entries Service Socket.
  1178. 16.85 s [vm-test-run-centjes-e2e-test] client # [ 7.075283] systemd[1]: Starting Create SUID/SGID Wrappers...
  1179. 16.86 s [vm-test-run-centjes-e2e-test] client # [ 7.082538] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met.
  1180. 16.87 s [vm-test-run-centjes-e2e-test] client # [ 7.098976] systemd[1]: Starting Save Transient machine-id to Disk...
  1181. 16.88 s [vm-test-run-centjes-e2e-test] client # [ 7.107628] systemd[1]: Finished Flush Journal to Persistent Storage.
  1182. 16.89 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.266325] systemd[1]: Finished Rebuild Journal Catalog.
  1183. 16.90 s [vm-test-run-centjes-e2e-test] client # [ 7.115805] systemd[1]: Starting Create System Files and Directories...
  1184. 16.90 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.273898] systemd[1]: Starting Update is Completed...
  1185. 16.93 s [vm-test-run-centjes-e2e-test] client # [ 7.159306] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
  1186. 16.94 s [vm-test-run-centjes-e2e-test] client # [ 7.170346] systemd[1]: Finished Save Transient machine-id to Disk.
  1187. 16.97 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.345340] systemd[1]: Finished Update is Completed.
  1188. 16.98 s [vm-test-run-centjes-e2e-test] client # [ 7.205457] systemd[1]: Finished Create System Files and Directories.
  1189. 16.99 s [vm-test-run-centjes-e2e-test] client # [ 7.215588] systemd[1]: Starting Rebuild Journal Catalog...
  1190. 17.00 s [vm-test-run-centjes-e2e-test] client # [ 7.230305] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
  1191. 17.10 s [vm-test-run-centjes-e2e-test] client # [ 7.321532] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
  1192. 17.16 s [vm-test-run-centjes-e2e-test] client # [ 7.384628] systemd[1]: Found device /dev/hvc0.
  1193. 17.17 s [vm-test-run-centjes-e2e-test] client # [ 7.393538] systemd[1]: Finished Rebuild Journal Catalog.
  1194. 17.18 s [vm-test-run-centjes-e2e-test] client # [ 7.404221] systemd[1]: Starting Update is Completed...
  1195. 17.20 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.572892] systemd[1]: Found device /dev/hvc0.
  1196. 17.25 s [vm-test-run-centjes-e2e-test] client # [ 7.482247] systemd[1]: Found device /dev/ttyS0.
  1197. 17.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.636364] systemd[1]: Found device /dev/ttyS0.
  1198. 17.26 s [vm-test-run-centjes-e2e-test] client # [ 7.490352] systemd[1]: Finished Update is Completed.
  1199. 17.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.668879] (udev-worker)[500]: [0;1;38:5:185meth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
  1200. 17.32 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.691099] (udev-worker)[500]: Network interface NamePolicy= disabled on kernel command line.
  1201. 17.33 s [vm-test-run-centjes-e2e-test] client # [ 7.551654] (udev-worker)[480]: [0;1;38:5:185meth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
  1202. 17.33 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.706479] (udev-worker)[503]: Network interface NamePolicy= disabled on kernel command line.
  1203. 17.35 s [vm-test-run-centjes-e2e-test] client # [ 7.572539] (udev-worker)[480]: Network interface NamePolicy= disabled on kernel command line.
  1204. 17.37 s [vm-test-run-centjes-e2e-test] client # [ 7.591744] (udev-worker)[474]: Network interface NamePolicy= disabled on kernel command line.
  1205. 17.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.810218] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
  1206. 17.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.820974] systemd[1]: Finished Create SUID/SGID Wrappers.
  1207. 17.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.829956] systemd[1]: Reached target System Initialization.
  1208. 17.47 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.836792] systemd[1]: Started Discard unused filesystem blocks once a week.
  1209. 17.49 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.852425] systemd[1]: Started Daily Cleanup of Temporary Directories.
  1210. 17.50 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.870600] systemd[1]: Reached target Timer Units.
  1211. 17.53 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.884723] systemd[1]: Listening on D-Bus System Message Bus Socket.
  1212. 17.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.904525] systemd[1]: Listening on Nix Daemon Socket.
  1213. 17.55 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.918179] systemd[1]: Listening on Hostname Service Socket.
  1214. 17.57 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.926823] systemd[1]: Reached target Socket Units.
  1215. 17.59 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.953805] systemd[1]: Reached target Basic System.
  1216. 17.61 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.977183] systemd[1]: System is tainted: support-ended
  1217. 17.61 s [vm-test-run-centjes-e2e-test] client # [ 7.841205] systemd[1]: Found device Virtio network device.
  1218. 17.62 s [vm-test-run-centjes-e2e-test] docsserver # [ 7.994526] systemd[1]: Started backdoor.service.
  1219. 17.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.007564] systemd[1]: Starting Import lastlog data into lastlog2 database...
  1220. 17.67 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.029765] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
  1221. 17.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.054210] systemd[1]: Started Reset console on configuration changes.
  1222. 17.69 s [vm-test-run-centjes-e2e-test] client # [ 7.912192] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
  1223. 17.69 s [vm-test-run-centjes-e2e-test] docsserver # connecting to host...
  1224. 17.70 s [vm-test-run-centjes-e2e-test] client # [ 7.924983] systemd[1]: Finished Create SUID/SGID Wrappers.
  1225. 17.70 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.070959] systemd[1]: Starting resolvconf update...
  1226. 17.71 s [vm-test-run-centjes-e2e-test] client # [ 7.932589] systemd[1]: Reached target System Initialization.
  1227. 17.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.086511] systemd[1]: Started Centjes docs site production Service.
  1228. 17.73 s [vm-test-run-centjes-e2e-test] client # [ 7.945635] systemd[1]: Started Discard unused filesystem blocks once a week.
  1229. 17.75 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.104408] nsncd[616]: Aug 06 21:20:18.366 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
  1230. 17.75 s [vm-test-run-centjes-e2e-test] client # [ 7.968412] systemd[1]: Started Daily Cleanup of Temporary Directories.
  1231. 17.75 s [vm-test-run-centjes-e2e-test] docsserver: Guest shell says: b'Spawning backdoor root shell...\n'
  1232. 17.77 s [vm-test-run-centjes-e2e-test] docsserver: connected to guest root shell
  1233. 17.77 s [vm-test-run-centjes-e2e-test] docsserver: (connecting took 9.18 seconds)
  1234. 17.77 s [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for the VM to finish booting, in 9.18 seconds)
  1235. 17.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.129409] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
  1236. 17.77 s [vm-test-run-centjes-e2e-test] client # [ 7.990880] systemd[1]: Reached target Timer Units.
  1237. 17.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.141371] systemd[1]: Starting D-Bus System Message Bus...
  1238. 17.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.150994] systemd[1]: Finished Firewall.
  1239. 17.78 s [vm-test-run-centjes-e2e-test] client # [ 8.004191] systemd[1]: Listening on D-Bus System Message Bus Socket.
  1240. 17.79 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.159946] systemd[1]: Finished Import lastlog data into lastlog2 database.
  1241. 17.80 s [vm-test-run-centjes-e2e-test] client # [ 8.018593] systemd[1]: Listening on Nix Daemon Socket.
  1242. 17.81 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.171734] dbus-daemon[621]: dbus[621]: Unknown username "systemd-timesync" in message bus configuration file
  1243. 17.82 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.190723] systemd[1]: Started Name Service Cache Daemon (nsncd).
  1244. 17.82 s [vm-test-run-centjes-e2e-test] client # [ 8.043315] systemd[1]: Listening on Hostname Service Socket.
  1245. 17.84 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.204656] systemd[1]: Reached target Host and Network Name Lookups.
  1246. 17.85 s [vm-test-run-centjes-e2e-test] client # [ 8.061985] systemd[1]: Reached target Socket Units.
  1247. 17.85 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.218768] systemd[1]: Reached target User and Group Name Lookups.
  1248. 17.86 s [vm-test-run-centjes-e2e-test] client # [ 8.088757] systemd[1]: Reached target Basic System.
  1249. 17.87 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.233783] systemd[1]: Starting User Login Management...
  1250. 17.88 s [vm-test-run-centjes-e2e-test] client # [ 8.101373] systemd[1]: System is tainted: support-ended
  1251. 17.88 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.245935] systemd[1]: Found device Virtio network device.
  1252. 17.90 s [vm-test-run-centjes-e2e-test] client # [ 8.119317] systemd[1]: Started backdoor.service.
  1253. 17.90 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.261664] systemd[1]: Started D-Bus System Message Bus.
  1254. 17.90 s [vm-test-run-centjes-e2e-test] client # connecting to host...
  1255. 17.91 s [vm-test-run-centjes-e2e-test] client # [ 8.134881] systemd[1]: Starting Import lastlog data into lastlog2 database...
  1256. 17.93 s [vm-test-run-centjes-e2e-test] client # [ 8.151462] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
  1257. 17.95 s [vm-test-run-centjes-e2e-test] client # [ 8.164903] systemd[1]: Started Reset console on configuration changes.
  1258. 17.97 s [vm-test-run-centjes-e2e-test] client # [ 8.186235] nsncd[620]: Aug 06 21:20:18.615 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
  1259. 17.98 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.351259] systemd-logind[646]: New seat seat0.
  1260. 17.99 s [vm-test-run-centjes-e2e-test] client # [ 8.206819] systemd[1]: Starting resolvconf update...
  1261. 18.00 s [vm-test-run-centjes-e2e-test] client # [ 8.223332] systemd[1]: Starting D-Bus System Message Bus...
  1262. 18.01 s [vm-test-run-centjes-e2e-test] client # [ 8.240122] systemd[1]: Finished Firewall.
  1263. 18.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.384767] systemd[1]: Started User Login Management.
  1264. 18.02 s [vm-test-run-centjes-e2e-test] client # [ 8.245804] systemd[1]: Finished Import lastlog data into lastlog2 database.
  1265. 18.03 s [vm-test-run-centjes-e2e-test] client # [ 8.257927] systemd[1]: Started Name Service Cache Daemon (nsncd).
  1266. 18.04 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.407801] systemd[1]: Stopped target Host and Network Name Lookups.
  1267. 18.05 s [vm-test-run-centjes-e2e-test] client # [ 8.267442] dbus-daemon[624]: dbus[624]: Unknown username "systemd-timesync" in message bus configuration file
  1268. 18.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.420677] systemd[1]: Stopping Host and Network Name Lookups...
  1269. 18.06 s [vm-test-run-centjes-e2e-test] client # [ 8.285334] systemd[1]: Reached target Host and Network Name Lookups.
  1270. 18.07 s [vm-test-run-centjes-e2e-test] client # [ 8.295756] systemd[1]: Reached target User and Group Name Lookups.
  1271. 18.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.442653] systemd[1]: Stopped target User and Group Name Lookups.
  1272. 18.08 s [vm-test-run-centjes-e2e-test] client # [ 8.307232] systemd[1]: Starting User Login Management...
  1273. 18.09 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.455921] systemd[1]: Stopping User and Group Name Lookups...
  1274. 18.10 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.468956] systemd[1]: Starting linger-users.service...
  1275. 18.10 s [vm-test-run-centjes-e2e-test] client # [ 8.324827] systemd[1]: Started D-Bus System Message Bus.
  1276. 18.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.474939] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
  1277. 18.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.485692] systemd[1]: nscd.service: Deactivated successfully.
  1278. 18.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.495648] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
  1279. 18.14 s [vm-test-run-centjes-e2e-test] client # [ 8.370257] systemd[1]: Stopped target Host and Network Name Lookups.
  1280. 18.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.509650] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
  1281. 18.15 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.527132] systemd[1]: linger-users.service: Deactivated successfully.
  1282. 18.15 s [vm-test-run-centjes-e2e-test] client # [ 8.381289] systemd[1]: Stopping Host and Network Name Lookups...
  1283. 18.16 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.533304] systemd[1]: Finished linger-users.service.
  1284. 18.17 s [vm-test-run-centjes-e2e-test] client # [ 8.393494] systemd[1]: Stopped target User and Group Name Lookups.
  1285. 18.18 s [vm-test-run-centjes-e2e-test] client # [ 8.401567] systemd[1]: Stopping User and Group Name Lookups...
  1286. 18.18 s [vm-test-run-centjes-e2e-test] client # [ 8.410638] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
  1287. 18.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.551648] systemd[1]: Started Name Service Cache Daemon (nsncd).
  1288. 18.19 s [vm-test-run-centjes-e2e-test] client # [ 8.418651] systemd[1]: nscd.service: Deactivated successfully.
  1289. 18.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.563370] systemd[1]: Reached target Host and Network Name Lookups.
  1290. 18.20 s [vm-test-run-centjes-e2e-test] client # [ 8.427974] systemd[1]: Stopped Name Service Cache Daemon (nsncd).[ 8.833250] mousedev: PS/2 mouse device common for all mice
  1291. 18.20 s [vm-test-run-centjes-e2e-test] client #
  1292. 18.21 s [vm-test-run-centjes-e2e-test] client # [ 8.435640] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
  1293. 18.21 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.576550] nsncd[699]: Aug 06 21:20:18.839 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
  1294. 18.22 s [vm-test-run-centjes-e2e-test] client # [ 8.444359] systemd-logind[650]: New seat seat0.
  1295. 18.22 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.592957] systemd[1]: Reached target User and Group Name Lookups.
  1296. 18.22 s [vm-test-run-centjes-e2e-test] client # [ 8.452788] systemd[1]: Started User Login Management.[ 8.854566] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
  1297. 18.23 s [vm-test-run-centjes-e2e-test] client #
  1298. 18.24 s [vm-test-run-centjes-e2e-test] client # [ 8.466978] systemd[1]: Starting linger-users.service...
  1299. 18.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.620982] systemd[1]: Finished resolvconf update.
  1300. 18.25 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.629951] systemd[1]: Reached target Preparation for Network.[ 9.017811] mousedev: PS/2 mouse device common for all mice
  1301. 18.25 s [vm-test-run-centjes-e2e-test] client # [ 8.887412] ACPI: button: Power Button [PWRF]
  1302. 18.26 s [vm-test-run-centjes-e2e-test] docsserver #
  1303. 18.26 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.636752] systemd[1]: Starting DHCP Client...
  1304. 18.27 s [vm-test-run-centjes-e2e-test] client # [ 8.500391] systemd[1]: Started Name Service Cache Daemon (nsncd).
  1305. 18.27 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.645580] systemd[1]: Starting Address configuration of eth1...
  1306. 18.29 s [vm-test-run-centjes-e2e-test] client # [ 8.508153] nsncd[687]: Aug 06 21:20:18.938 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
  1307. 18.30 s [vm-test-run-centjes-e2e-test] client # [ 8.522917] systemd[1]: Reached target Host and Network Name Lookups.
  1308. 18.31 s [vm-test-run-centjes-e2e-test] client # [ 8.536362] systemd[1]: Reached target User and Group Name Lookups.
  1309. 18.32 s [vm-test-run-centjes-e2e-test] client # [ 8.544796] systemd[1]: linger-users.service: Deactivated successfully.
  1310. 18.32 s [vm-test-run-centjes-e2e-test] client # [ 8.551307] systemd[1]: Finished linger-users.service.
  1311. 18.34 s [vm-test-run-centjes-e2e-test] client # [ 8.572189] systemd[1]: Finished resolvconf update.
  1312. 18.35 s [vm-test-run-centjes-e2e-test] client # [ 8.578637] systemd[1]: Reached target Preparation for Network.
  1313. 18.36 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.120838] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
  1314. 18.36 s [vm-test-run-centjes-e2e-test] client # [ 8.586671] systemd[1]: Starting DHCP Client...
  1315. 18.37 s [vm-test-run-centjes-e2e-test] client # [ 8.594665] systemd[1]: Starting Address configuration of eth1...
  1316. 18.39 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.154474] ACPI: button: Power Button [PWRF]
  1317. 18.41 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.777878] network-addresses-eth1-start[730]: adding address 192.168.1.2/24... done
  1318. 18.42 s [vm-test-run-centjes-e2e-test] client # [ 9.049739] rtc_cmos 00:05: RTC can wake from S4
  1319. 18.43 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.800654] network-addresses-eth1-start[730]: adding address 2001:db8:1::2/64... done
  1320. 18.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.828403] systemd[1]: Finished Address configuration of eth1.
  1321. 18.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.837650] systemd[1]: Starting Networking Setup...
  1322. 18.46 s [vm-test-run-centjes-e2e-test] client # [ 9.094594] parport_pc 00:03: reported by Plug and Play ACPI
  1323. 18.47 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.234846] rtc_cmos 00:05: RTC can wake from S4
  1324. 18.48 s [vm-test-run-centjes-e2e-test] client # [ 9.104482] Floppy drive(s): fd0 is 2.88M AMI BIOS
  1325. 18.49 s [vm-test-run-centjes-e2e-test] client # [ 9.119564] rtc_cmos 00:05: registered as rtc0
  1326. 18.50 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.880943] dhcpcd[737]: dhcpcd-10.2.4 starting
  1327. 18.51 s [vm-test-run-centjes-e2e-test] client # [ 9.140628] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
  1328. 18.51 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.275887] Floppy drive(s): fd0 is 2.88M AMI BIOS
  1329. 18.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 8.897481] dhcpcd[749]: dev: loaded udev
  1330. 18.53 s [vm-test-run-centjes-e2e-test] client # [ 8.750758] network-addresses-eth1-start[717]: adding address 192.168.1.1/24... done[ 9.156712] rtc_cmos 00:05: setting system clock to 2026-08-06T21:20:18 UTC (1786051218)
  1331. 18.53 s [vm-test-run-centjes-e2e-test] client #
  1332. 18.53 s [vm-test-run-centjes-e2e-test] client # [ 8.760392] network-addresses-eth1-start[717]: adding address 2001:db8:1::1/64... done
  1333. 18.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.298332] parport_pc 00:03: reported by Plug and Play ACPI
  1334. 18.54 s [vm-test-run-centjes-e2e-test] client # [ 9.170547] FDC 0 is a S82078B
  1335. 18.54 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.303796] rtc_cmos 00:05: registered as rtc0
  1336. 18.54 s [vm-test-run-centjes-e2e-test] client # [ 9.174420] systemd-journald[386]: Time jumped backwards, rotating.
  1337. 18.55 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.309273] rtc_cmos 00:05: setting system clock to 2026-08-06T21:20:19 UTC (1786051219)
  1338. 18.55 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.317828] 8021q: 802.1Q VLAN Support v1.8
  1339. 18.56 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.322386] FDC 0 is a S82078B
  1340. 18.56 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.323941] 8021q: adding VLAN 0 to HW filter on device eth1
  1341. 18.57 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.331822] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
  1342. 18.59 s [vm-test-run-centjes-e2e-test] client # [ 9.225038] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
  1343. 18.60 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.365622] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
  1344. 18.61 s [vm-test-run-centjes-e2e-test] client # [ 8.835580] systemd[1]: Finished Address configuration of eth1.
  1345. 18.63 s [vm-test-run-centjes-e2e-test] client # [ 8.858669] systemd[1]: Starting Networking Setup...
  1346. 18.64 s [vm-test-run-centjes-e2e-test] client # [ 8.866530] dhcpcd[723]: dhcpcd-10.2.4 starting
  1347. 18.65 s [vm-test-run-centjes-e2e-test] client # [ 8.878289] dhcpcd[737]: dev: loaded udev
  1348. 18.66 s [vm-test-run-centjes-e2e-test] client # [ 9.292019] 8021q: 802.1Q VLAN Support v1.8
  1349. 18.66 s [vm-test-run-centjes-e2e-test] client # [ 9.295712] 8021q: adding VLAN 0 to HW filter on device eth1
  1350. 18.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.453889] cfg80211: Loading compiled-in X.509 certificates for regulatory database
  1351. 18.70 s [vm-test-run-centjes-e2e-test] client # [ 9.336067] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
  1352. 18.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.484604] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
  1353. 18.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.491589] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
  1354. 18.73 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.494759] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
  1355. 18.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.501826] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
  1356. 18.74 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.505065] cfg80211: failed to load regulatory.db
  1357. 18.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.137914] systemd[1]: Finished Networking Setup.
  1358. 18.77 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.147314] systemd[1]: Reached target Network.
  1359. 18.78 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.150938] systemd[1]: Starting Permit User Sessions...
  1360. 18.79 s [vm-test-run-centjes-e2e-test] client # [ 9.416856] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
  1361. 18.79 s [vm-test-run-centjes-e2e-test] client # [ 9.420459] cfg80211: Loading compiled-in X.509 certificates for regulatory database
  1362. 18.80 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.564670] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
  1363. 18.81 s [vm-test-run-centjes-e2e-test] client # [ 9.444897] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4
  1364. 18.83 s [vm-test-run-centjes-e2e-test] client # [ 9.457558] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
  1365. 18.83 s [vm-test-run-centjes-e2e-test] client # [ 9.460635] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
  1366. 18.84 s [vm-test-run-centjes-e2e-test] client # [ 9.468078] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
  1367. 18.84 s [vm-test-run-centjes-e2e-test] client # [ 9.471212] cfg80211: failed to load regulatory.db
  1368. 18.85 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.219629] systemd[1]: Finished Permit User Sessions.
  1369. 18.85 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.230377] systemd[1]: Started Getty on tty1.
  1370. 18.86 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.234444] systemd[1]: Reached target Login Prompts.
  1371. 18.86 s [vm-test-run-centjes-e2e-test] client # [ 9.086592] systemd[1]: Finished Networking Setup.
  1372. 18.87 s [vm-test-run-centjes-e2e-test] client # [ 9.093929] systemd[1]: Reached target Network.
  1373. 18.87 s [vm-test-run-centjes-e2e-test] client # [ 9.102246] systemd[1]: Starting Permit User Sessions...
  1374. 18.88 s [vm-test-run-centjes-e2e-test] client # [ 9.509073] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console
  1375. 18.88 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.643127] 8021q: adding VLAN 0 to HW filter on device eth0
  1376. 18.88 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.646898] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4
  1377. 18.89 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.264764] dhcpcd[749]: eth0: waiting for carrier
  1378. 18.89 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.656290] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console
  1379. 18.91 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.665584] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6
  1380. 18.94 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.698428] cryptd: max_cpu_qlen set to 1000
  1381. 18.94 s [vm-test-run-centjes-e2e-test] client # [ 9.169662] systemd[1]: Finished Permit User Sessions.
  1382. 18.98 s [vm-test-run-centjes-e2e-test] client # [ 9.545892] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6
  1383. 18.98 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.718700] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5
  1384. 18.99 s [vm-test-run-centjes-e2e-test] client # [ 9.546482] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5
  1385. 19.00 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.735673] AES CTR mode by8 optimization enabled
  1386. 19.00 s [vm-test-run-centjes-e2e-test] client # [ 9.565620] cryptd: max_cpu_qlen set to 1000
  1387. 19.01 s [vm-test-run-centjes-e2e-test] client # [ 9.597428] 8021q: adding VLAN 0 to HW filter on device eth0
  1388. 19.01 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.743304] Console: switching to colour dummy device 80x25
  1389. 19.02 s [vm-test-run-centjes-e2e-test] client # [ 9.607655] Console: switching to colour dummy device 80x25
  1390. 19.02 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.788539] [drm] Found bochs VGA, ID 0xb0c5.
  1391. 19.03 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.789697] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
  1392. 19.03 s [vm-test-run-centjes-e2e-test] client # [ 9.617731] AES CTR mode by8 optimization enabled
  1393. 19.04 s [vm-test-run-centjes-e2e-test] client # [ 9.197955] dhcpcd[737]: eth0: waiting for carrier
  1394. 19.05 s [vm-test-run-centjes-e2e-test] client # [ 9.279661] systemd[1]: Started Getty on tty1.[ 9.681206] [drm] Found bochs VGA, ID 0xb0c5.
  1395. 19.05 s [vm-test-run-centjes-e2e-test] client # [ 9.682236] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
  1396. 19.05 s [vm-test-run-centjes-e2e-test] client #
  1397. 19.05 s [vm-test-run-centjes-e2e-test] client # [ 9.283900] dhcpcd[737]: libudev: received NULL device
  1398. 19.06 s [vm-test-run-centjes-e2e-test] client # [ 9.287558] dhcpcd[737]: libudev: received NULL device
  1399. 19.06 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.436362] systemd[1]: Starting Virtual Console Setup...
  1400. 19.06 s [vm-test-run-centjes-e2e-test] client # [ 9.291474] systemd[1]: Reached target Login Prompts.
  1401. 19.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.833937] [drm] Found EDID data blob.
  1402. 19.07 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.837428] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0
  1403. 19.11 s [vm-test-run-centjes-e2e-test] client # [ 9.338726] systemd[1]: Starting Virtual Console Setup...
  1404. 19.12 s [vm-test-run-centjes-e2e-test] client # [ 9.756713] [drm] Found EDID data blob.
  1405. 19.13 s [vm-test-run-centjes-e2e-test] client # [ 9.361152] systemd-logind[650]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
  1406. 19.14 s [vm-test-run-centjes-e2e-test] client # [ 9.772558] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0
  1407. 20.01 s [vm-test-run-centjes-e2e-test] client # [ 10.242645] dhcpcd[737]: eth0: carrier acquired
  1408. 20.11 s [vm-test-run-centjes-e2e-test] docsserver # [ 9.846282] fbcon: bochs-drmdrmfb (fb0) is primary device
  1409. 20.12 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.741921] Console: switching to colour frame buffer device 160x50
  1410. 20.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.893247] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device
  1411. 20.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.325572] dhcpcd[749]: eth0: carrier acquired
  1412. 20.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.511206] dhcpcd[749]: DUID 00:01:00:01:32:07:b7:14:52:54:00:12:34:56
  1413. 20.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.513918] dhcpcd[749]: eth0: IAID 00:12:34:56
  1414. 20.14 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.515948] dhcpcd[749]: eth0: adding address fe80::5054:ff:fe12:3456
  1415. 20.18 s [vm-test-run-centjes-e2e-test] client # [ 9.786155] fbcon: bochs-drmdrmfb (fb0) is primary device
  1416. 20.18 s [vm-test-run-centjes-e2e-test] client # [ 10.665770] Console: switching to colour frame buffer device 160x50
  1417. 20.19 s [vm-test-run-centjes-e2e-test] client # [ 10.818180] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device
  1418. 20.19 s [vm-test-run-centjes-e2e-test] client # [ 10.258174] dhcpcd[737]: DUID 00:01:00:01:32:07:b7:14:52:54:00:12:34:56
  1419. 20.19 s [vm-test-run-centjes-e2e-test] client # [ 10.423568] dhcpcd[737]: eth0: IAID 00:12:34:56
  1420. 20.19 s [vm-test-run-centjes-e2e-test] client # [ 10.425353] dhcpcd[737]: eth0: adding address fe80::5054:ff:fe12:3456
  1421. 20.20 s [vm-test-run-centjes-e2e-test] client # [ 10.427766] dhcpcd[737]: eth0: soliciting a DHCP lease
  1422. 20.24 s [vm-test-run-centjes-e2e-test] client # [ 10.871539] NET: Registered PF_PACKET protocol family
  1423. 20.26 s [vm-test-run-centjes-e2e-test] client # [ 10.488839] dhcpcd[737]: eth0: offered 10.0.2.15 from 10.0.2.2
  1424. 20.26 s [vm-test-run-centjes-e2e-test] client # [ 10.494893] dhcpcd[737]: eth0: probing address 10.0.2.15/24
  1425. 20.38 s [vm-test-run-centjes-e2e-test] client # [ 11.013566] kvm_amd: TSC scaling supported
  1426. 20.38 s [vm-test-run-centjes-e2e-test] client # [ 11.014605] kvm_amd: Nested Virtualization enabled
  1427. 20.38 s [vm-test-run-centjes-e2e-test] client # [ 11.015782] kvm_amd: Nested Paging enabled
  1428. 20.38 s [vm-test-run-centjes-e2e-test] client # [ 11.016931] kvm_amd: LBR virtualization supported
  1429. 20.42 s [vm-test-run-centjes-e2e-test] client # [ 10.644568] systemd-logind[650]: Watching system buttons on /dev/input/event2 (Power Button)
  1430. 20.43 s [vm-test-run-centjes-e2e-test] client # [ 11.062168] kvm_amd: Virtual VMLOAD VMSAVE supported
  1431. 20.43 s [vm-test-run-centjes-e2e-test] client # [ 11.063346] kvm_amd: Virtual GIF supported
  1432. 20.43 s [vm-test-run-centjes-e2e-test] client # [ 11.067919] ppdev: user-space parallel port driver
  1433. 20.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.808532] systemd-logind[646]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
  1434. 20.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.823314] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
  1435. 20.46 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.837409] systemd-logind[646]: Watching system buttons on /dev/input/event2 (Power Button)
  1436. 20.48 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.245826] ppdev: user-space parallel port driver
  1437. 20.49 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.250778] kvm_amd: TSC scaling supported
  1438. 20.49 s [vm-test-run-centjes-e2e-test] client # [ 10.715772] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
  1439. 20.49 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.251780] kvm_amd: Nested Virtualization enabled
  1440. 20.49 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.253105] kvm_amd: Nested Paging enabled
  1441. 20.49 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.254100] kvm_amd: LBR virtualization supported
  1442. 20.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.286888] kvm_amd: Virtual VMLOAD VMSAVE supported
  1443. 20.52 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.288099] kvm_amd: Virtual GIF supported
  1444. 20.55 s [vm-test-run-centjes-e2e-test] client # [ 10.779375] systemd-logind[650]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
  1445. 20.57 s [vm-test-run-centjes-e2e-test] client # [ 11.203768] EDAC MC: Ver: 3.0.0
  1446. 20.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 10.997669] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1447. 20.63 s [vm-test-run-centjes-e2e-test] client # [ 10.848906] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1448. 20.63 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.008319] systemd[1]: Stopped Virtual Console Setup.
  1449. 20.63 s [vm-test-run-centjes-e2e-test] client # [ 10.862790] systemd[1]: Stopped Virtual Console Setup.
  1450. 20.64 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.012485] systemd[1]: Starting Virtual Console Setup...
  1451. 20.64 s [vm-test-run-centjes-e2e-test] client # [ 10.869939] systemd[1]: Starting Virtual Console Setup...
  1452. 20.65 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.021295] systemd-logind[646]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
  1453. 20.68 s [vm-test-run-centjes-e2e-test] client # [ 10.909651] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1454. 20.69 s [vm-test-run-centjes-e2e-test] client # [ 10.922531] systemd[1]: Stopped Virtual Console Setup.
  1455. 20.69 s [vm-test-run-centjes-e2e-test] client # [ 10.925126] systemd[1]: Starting Virtual Console Setup...
  1456. 20.69 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.457765] EDAC MC: Ver: 3.0.0
  1457. 20.71 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.084825] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1458. 20.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.095904] systemd[1]: Stopped Virtual Console Setup.
  1459. 20.72 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.099099] systemd[1]: Starting Virtual Console Setup...
  1460. 21.10 s [vm-test-run-centjes-e2e-test] client # [ 11.335415] systemd[1]: Finished Virtual Console Setup.
  1461. 21.13 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.505946] systemd[1]: Finished Virtual Console Setup.
  1462. 21.32 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.695349] dhcpcd[749]: eth0: soliciting a DHCP lease
  1463. 21.34 s [vm-test-run-centjes-e2e-test] docsserver # [ 12.102194] NET: Registered PF_PACKET protocol family
  1464. 21.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.725772] dhcpcd[749]: eth0: offered 10.0.2.15 from 10.0.2.2
  1465. 21.35 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.729360] dhcpcd[749]: eth0: probing address 10.0.2.15/24
  1466. 21.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.815681] dhcpcd[749]: eth0: soliciting an IPv6 router
  1467. 21.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.818424] dhcpcd[749]: eth0: Router Advertisement from fe80::2
  1468. 21.44 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.820842] dhcpcd[749]: eth0: adding address fec0::5054:ff:fe12:3456/64
  1469. 21.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.822853] dhcpcd[749]: eth0: adding route to fec0::/64
  1470. 21.45 s [vm-test-run-centjes-e2e-test] docsserver # [ 11.824640] dhcpcd[749]: eth0: adding default route via fe80::2
  1471. 22.11 s [vm-test-run-centjes-e2e-test] client # [ 12.338494] dhcpcd[737]: eth0: soliciting an IPv6 router
  1472. 22.11 s [vm-test-run-centjes-e2e-test] client # [ 12.340664] dhcpcd[737]: eth0: Router Advertisement from fe80::2
  1473. 22.26 s [vm-test-run-centjes-e2e-test] client # [ 12.342750] dhcpcd[737]: eth0: adding address fec0::5054:ff:fe12:3456/64
  1474. 22.26 s [vm-test-run-centjes-e2e-test] client # [ 12.344781] dhcpcd[737]: eth0: adding route to fec0::/64
  1475. 22.26 s [vm-test-run-centjes-e2e-test] client # [ 12.346496] dhcpcd[737]: eth0: adding default route via fe80::2
  1476. 24.98 s [vm-test-run-centjes-e2e-test] client # [ 15.207809] dhcpcd[737]: eth0: leased 10.0.2.15 for 86400 seconds
  1477. 24.98 s [vm-test-run-centjes-e2e-test] client # [ 15.210657] dhcpcd[737]: eth0: adding route to 10.0.2.0/24
  1478. 24.98 s [vm-test-run-centjes-e2e-test] client # [ 15.212829] dhcpcd[737]: eth0: adding default route via 10.0.2.2
  1479. 25.10 s [vm-test-run-centjes-e2e-test] client # [ 15.331946] systemd[1]: Started DHCP Client.
  1480. 25.10 s [vm-test-run-centjes-e2e-test] client # [ 15.334967] systemd[1]: Reached target Multi-User System.
  1481. 25.11 s [vm-test-run-centjes-e2e-test] client # [ 15.338474] systemd[1]: Startup finished in 3.845s (kernel) + 11.491s (userspace) = 15.336s.
  1482. 26.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 16.559091] dhcpcd[749]: eth0: leased 10.0.2.15 for 86400 seconds
  1483. 26.18 s [vm-test-run-centjes-e2e-test] docsserver # [ 16.561726] dhcpcd[749]: eth0: adding route to 10.0.2.0/24
  1484. 26.19 s [vm-test-run-centjes-e2e-test] docsserver # [ 16.565377] dhcpcd[749]: eth0: adding default route via 10.0.2.2
  1485. 26.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 16.682969] systemd[1]: Started DHCP Client.
  1486. 26.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 16.689409] systemd[1]: Reached target Multi-User System.
  1487. 26.31 s [vm-test-run-centjes-e2e-test] docsserver # [ 16.691294] systemd[1]: Startup finished in 3.990s (kernel) + 12.698s (userspace) = 16.688s.
  1488. 26.84 s [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for unit default.target, in 18.25 seconds)
  1489. 26.84 s [vm-test-run-centjes-e2e-test] client: waiting for unit default.target
  1490. 26.84 s [vm-test-run-centjes-e2e-test] client: waiting for the VM to finish booting
  1491. 26.84 s [vm-test-run-centjes-e2e-test] client: Guest shell says: b'Spawning backdoor root shell...\n'
  1492. 26.84 s [vm-test-run-centjes-e2e-test] client: connected to guest root shell
  1493. 26.84 s [vm-test-run-centjes-e2e-test] client: (connecting took 0.00 seconds)
  1494. 26.84 s [vm-test-run-centjes-e2e-test] client: (finished: waiting for the VM to finish booting, in 0.00 seconds)
  1495. 26.96 s [vm-test-run-centjes-e2e-test] client: (finished: waiting for unit default.target, in 0.12 seconds)
  1496. 27.04 s [vm-test-run-centjes-e2e-test] docsserver: waiting for unit centjes-docs-site-production.service
  1497. 27.10 s [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for unit centjes-docs-site-production.service, in 0.05 seconds)
  1498. 27.10 s [vm-test-run-centjes-e2e-test] docsserver: waiting for unit default.target
  1499. 27.15 s [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for unit default.target, in 0.05 seconds)
  1500. 27.17 s [vm-test-run-centjes-e2e-test] docsserver: waiting for TCP port 8001 on localhost
  1501. 27.23 s [vm-test-run-centjes-e2e-test] docsserver # Connection to localhost (127.0.0.1) 8001 port [tcp/vcom-tunnel] succeeded!
  1502. 27.24 s [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for TCP port 8001 on localhost, in 0.09 seconds)
  1503. 27.24 s [vm-test-run-centjes-e2e-test] client: must succeed: curl docsserver:8001
  1504. 27.34 s [vm-test-run-centjes-e2e-test] client # % Total % Received % Xferd Average Speed Time Time Time Current
  1505. 27.35 s [vm-test-run-centjes-e2e-test] client # Dload Upload Total Spent Left Speed
  1506. 27.38 s [vm-test-run-centjes-e2e-test] docsserver # [ 17.752787] centjes-docs-site-production-start[631]: 192.168.1.1 - - [06/Aug/2026:21:20:28 +0000] "GET / HTTP/1.1" 200 3595 "" "curl/8.17.0"
  1507. 27.40 s [vm-test-run-centjes-e2e-test] client # 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0100 3595 100 3595 0 0 53355 0 --:--:-- --:--:-- --:--:-- 54469
  1508. 27.40 s [vm-test-run-centjes-e2e-test] client: (finished: must succeed: curl docsserver:8001, in 0.16 seconds)
  1509. 27.40 s [vm-test-run-centjes-e2e-test] (finished: run the VM test script, in 19.22 seconds)
  1510. 27.53 s [vm-test-run-centjes-e2e-test] test script finished in 19.34s
  1511. 27.53 s [vm-test-run-centjes-e2e-test] cleanup
  1512. 27.53 s [vm-test-run-centjes-e2e-test] kill machine (pid 31)
  1513. 27.53 s [vm-test-run-centjes-e2e-test] qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/jj6jldlw37r8yy9kc1smrax9dhnjm2x4-python3-3.13.9/bin/python3.13)
  1514. 27.54 s [vm-test-run-centjes-e2e-test] kill machine (pid 9)
  1515. 27.54 s [vm-test-run-centjes-e2e-test] qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/jj6jldlw37r8yy9kc1smrax9dhnjm2x4-python3-3.13.9/bin/python3.13)
  1516. 27.55 s [vm-test-run-centjes-e2e-test] kill vlan (pid 7)
  1517. 27.55 s [vm-test-run-centjes-e2e-test] (finished: cleanup, in 0.02 seconds)
  1518. 27.67 s [vm-test-run-centjes-e2e-test:post-build] Uploading to cachix cache "centjes": /nix/store/xxn3rlimd8z5cjg9jxyv34nydi7lhmx1-vm-test-run-centjes-e2e-test
  1519. 28.02 s [vm-test-run-centjes-e2e-test:post-build] Pushing 1 paths (0 are already present) using zstd to cache centjes ⏳
  1520. 28.02 s [vm-test-run-centjes-e2e-test:post-build]
  1521. 28.39 s [vm-test-run-centjes-e2e-test:post-build] Pushing /nix/store/xxn3rlimd8z5cjg9jxyv34nydi7lhmx1-vm-test-run-centjes-e2e-test (96.00 B)
  1522. 29.28 s [vm-test-run-centjes-e2e-test:post-build]
  1523. 29.28 s [vm-test-run-centjes-e2e-test:post-build] All done.
  1524. 29.29 s [vm-test-run-centjes-e2e-test:post-build] Uploading to the NixCI staging cache: /nix/store/xxn3rlimd8z5cjg9jxyv34nydi7lhmx1-vm-test-run-centjes-e2e-test
  1525. 29.34 s [vm-test-run-centjes-e2e-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  1526. 29.35 s [vm-test-run-centjes-e2e-test:post-build] copying 1 paths...
  1527. 29.35 s [vm-test-run-centjes-e2e-test:post-build] copying path '/nix/store/xxn3rlimd8z5cjg9jxyv34nydi7lhmx1-vm-test-run-centjes-e2e-test' to 'https://cache.staging.nix-ci.com'...
  1528. 30.05 s [vm-test-run-centjes-e2e-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead
  1529. 30.29 s [vm-test-run-centjes-e2e-test:post-build] copying 0 paths...
  1530. 30.32 s Uploaded vm-test-run-centjes-e2e-test in 2.6s
  1531. 30.32 s Progress: 1 of 2 built, 1 of 1 downloaded from cache
  1532. 30.32 s Built vm-test-run-centjes-e2e-test in 23.1s
  1533. 30.32 s Progress: 2 of 2 built, 1 of 1 downloaded from cache
  1534. 30.32 s /nix/store/xxn3rlimd8z5cjg9jxyv34nydi7lhmx1-vm-test-run-centjes-e2e-test
  1535. 30.47 s Build succeeded.
More Logs Raw Logs

Agent Instructions

Wait for completion, without logs:

curl --netrc -N https://staging.nix-ci.com/gh:NorfairKing:centjes/refs%2Fpull%2F8%2Fmerge/0861c484ed0514efe3484a4f326b102a38615833/5af5de5b-e605-4251-aa83-9adbae7ad038/wait

Latest logs, with timestamps (streams while running):

curl --netrc -N https://staging.nix-ci.com/gh:NorfairKing:centjes/refs%2Fpull%2F8%2Fmerge/0861c484ed0514efe3484a4f326b102a38615833/5af5de5b-e605-4251-aa83-9adbae7ad038/tail

All logs, with timestamps (available after completion):

curl --netrc https://staging.nix-ci.com/gh:NorfairKing:centjes/refs%2Fpull%2F8%2Fmerge/0861c484ed0514efe3484a4f326b102a38615833/5af5de5b-e605-4251-aa83-9adbae7ad038/logs

Raw logs, from the start (no timestamps):

curl --netrc -N https://staging.nix-ci.com/gh:NorfairKing:centjes/refs%2Fpull%2F8%2Fmerge/0861c484ed0514efe3484a4f326b102a38615833/5af5de5b-e605-4251-aa83-9adbae7ad038/raw-logs

Content types available for /logs and /tail (use Accept header):

Example:

curl --netrc -H "Accept: text/csv" https://staging.nix-ci.com/gh:NorfairKing:centjes/refs%2Fpull%2F8%2Fmerge/0861c484ed0514efe3484a4f326b102a38615833/5af5de5b-e605-4251-aa83-9adbae7ad038/logs

Reproduce locally: https://staging.nix-ci.com/gh:NorfairKing:centjes/refs%2Fpull%2F8%2Fmerge/0861c484ed0514efe3484a4f326b102a38615833/5af5de5b-e605-4251-aa83-9adbae7ad038/repro

This page is also available in machine-friendly formats. Request one with the Accept header:

For more instructions, fetch https://staging.nix-ci.com/instructions .