1. 0.13 s $ /nix/store/vzx1mi9c0xfadmsm9dhd83d005cb1qs9-coreutils-9.8/bin/timeout --kill-after=15s 7200s /nix/store/86n4l5yri6hys3zk2mwy2azcv9prqb8j-nix-2.31.4/bin/nix --extra-experimental-features nix-command --extra-experimental-features flakes --log-format internal-json build --no-link git+https://github.com/NorfairKing/dnscheck?ref=master&rev=baecfe195b020cf5ab10432b343559bc503be36d#checks.x86_64-linux.nixos-module-test --print-build-logs
  2. 0.15 s warning: ignoring untrusted flake configuration setting 'extra-substituters'.
  3. 0.15 s Pass '--accept-flake-config' to trust it
  4. 0.15 s warning: ignoring untrusted flake configuration setting 'extra-trusted-public-keys'.
  5. 0.15 s Pass '--accept-flake-config' to trust it
  6. 0.54 s error (ignored): SQLite database '/var/cache/private/nix-ci-worker/eval-cache-v6/c017217f2ab592f98a862e37980c8c47eebcf6ccb9c35faed77a0afef27051af.sqlite' is busy
  7. 5.79 s
  8. 6.87 s Downloading cached test-script from https://cache.staging.nix-ci.com
  9. 6.91 s Downloading cached liburing from https://cache.staging.nix-ci.com
  10. 6.91 s Downloading cached util-linux from https://cache.staging.nix-ci.com
  11. 6.91 s Downloading cached capstone from https://cache.staging.nix-ci.com
  12. 6.92 s Downloading cached firmware from https://cache.staging.nix-ci.com
  13. 6.92 s Downloading cached initrd-linux from https://cache.staging.nix-ci.com
  14. 6.92 s Downloading cached linux from https://cache.staging.nix-ci.com
  15. 6.92 s Downloading cached local-cmds from https://cache.staging.nix-ci.com
  16. 6.92 s Downloading cached mounts.sh from https://cache.staging.nix-ci.com
  17. 6.92 s Downloading cached python3.13-annotated-types from https://cache.staging.nix-ci.com
  18. 6.92 s Downloading cached python3.13-appdirs from https://cache.staging.nix-ci.com
  19. 6.92 s Downloading cached python3.13-asttokens from https://cache.staging.nix-ci.com
  20. 6.92 s Downloading cached python3.13-colorama from https://cache.staging.nix-ci.com
  21. 6.92 s Downloading cached python3.13-decorator from https://cache.staging.nix-ci.com
  22. 6.92 s Downloading cached python3.13-executing from https://cache.staging.nix-ci.com
  23. 6.92 s Downloading cached python3.13-junit-xml from https://cache.staging.nix-ci.com
  24. 6.94 s Progress: 0 of 2 built, 1 of 524 downloaded from cache (15 downloading)
  25. 6.94 s Progress: 0 of 2 built, 2 of 524 downloaded from cache (14 downloading)
  26. 6.94 s Progress: 0 of 2 built, 3 of 524 downloaded from cache (13 downloading)
  27. 6.94 s Progress: 0 of 2 built, 4 of 524 downloaded from cache (12 downloading)
  28. 6.94 s Progress: 0 of 2 built, 5 of 524 downloaded from cache (11 downloading)
  29. 6.94 s Progress: 0 of 2 built, 6 of 524 downloaded from cache (10 downloading)
  30. 6.94 s Downloading cached 55-nixos-aslr-entropy.conf from https://cache.staging.nix-ci.com
  31. 6.94 s Downloading cached X-Restart-Triggers-dhcpcd from https://cache.staging.nix-ci.com
  32. 6.94 s Downloading cached acl-2.3.2-bin from https://cache.staging.nix-ci.com
  33. 6.94 s Downloading cached acl-2.3.2-doc from https://cache.staging.nix-ci.com
  34. 6.94 s Downloading cached acl-2.3.2-man from https://cache.staging.nix-ci.com
  35. 6.94 s Downloading cached attr-2.5.2-bin from https://cache.staging.nix-ci.com
  36. 7.30 s Progress: 0 of 2 built, 7 of 524 downloaded from cache (15 downloading)
  37. 7.31 s Downloading cached attr-2.5.2-doc from https://cache.staging.nix-ci.com
  38. 7.33 s Progress: 0 of 2 built, 8 of 524 downloaded from cache (15 downloading)
  39. 7.33 s Downloading cached attr-2.5.2-man from https://cache.staging.nix-ci.com
  40. 7.33 s Progress: 0 of 2 built, 9 of 524 downloaded from cache (15 downloading)
  41. 7.33 s Downloading cached aws-c-common from https://cache.staging.nix-ci.com
  42. 7.33 s Progress: 0 of 2 built, 10 of 524 downloaded from cache (15 downloading)
  43. 7.33 s Downloading cached bash-completion from https://cache.staging.nix-ci.com
  44. 7.33 s Progress: 0 of 2 built, 11 of 524 downloaded from cache (15 downloading)
  45. 7.33 s Progress: 0 of 2 built, 12 of 524 downloaded from cache (14 downloading)
  46. 7.34 s Downloading cached bash-interactive-5.3p9-doc from https://cache.staging.nix-ci.com
  47. 7.34 s Downloading cached bash-interactive-5.3p9-info from https://cache.staging.nix-ci.com
  48. 7.34 s Progress: 0 of 2 built, 13 of 524 downloaded from cache (15 downloading)
  49. 7.34 s Downloading cached bash-interactive-5.3p9-man from https://cache.staging.nix-ci.com
  50. 7.34 s Progress: 0 of 2 built, 14 of 524 downloaded from cache (15 downloading)
  51. 7.34 s Downloading cached bind-9.20.23-man from https://cache.staging.nix-ci.com
  52. 7.34 s Progress: 0 of 2 built, 15 of 524 downloaded from cache (15 downloading)
  53. 7.34 s Progress: 0 of 2 built, 16 of 524 downloaded from cache (15 downloading)
  54. 7.34 s Downloading cached boost from https://cache.staging.nix-ci.com
  55. 7.34 s Progress: 0 of 2 built, 17 of 524 downloaded from cache (15 downloading)
  56. 7.34 s Downloading cached busybox from https://cache.staging.nix-ci.com
  57. 7.35 s Progress: 0 of 2 built, 18 of 524 downloaded from cache (15 downloading)
  58. 7.35 s Downloading cached bzip2-1.0.8-man from https://cache.staging.nix-ci.com
  59. 7.35 s Progress: 0 of 2 built, 19 of 524 downloaded from cache (15 downloading)
  60. 7.35 s Downloading cached c-rbtree from https://cache.staging.nix-ci.com
  61. 7.35 s Progress: 0 of 2 built, 20 of 524 downloaded from cache (15 downloading)
  62. 7.35 s Downloading cached c-shquote from https://cache.staging.nix-ci.com
  63. 7.40 s Progress: 0 of 2 built, 21 of 524 downloaded from cache (15 downloading)
  64. 7.40 s Downloading cached c-utf8 from https://cache.staging.nix-ci.com
  65. 7.40 s Progress: 0 of 2 built, 22 of 524 downloaded from cache (15 downloading)
  66. 7.40 s Downloading cached coreutils-full from https://cache.staging.nix-ci.com
  67. 7.44 s Progress: 0 of 2 built, 23 of 524 downloaded from cache (15 downloading)
  68. 7.44 s Downloading cached coreutils-full-9.11-info from https://cache.staging.nix-ci.com
  69. 7.44 s Progress: 0 of 2 built, 24 of 524 downloaded from cache (15 downloading)
  70. 7.44 s Downloading cached cpio from https://cache.staging.nix-ci.com
  71. 7.46 s Progress: 0 of 2 built, 25 of 524 downloaded from cache (15 downloading)
  72. 7.46 s Downloading cached cracklib from https://cache.staging.nix-ci.com
  73. 7.46 s Progress: 0 of 2 built, 26 of 524 downloaded from cache (15 downloading)
  74. 7.46 s Downloading cached curl-8.20.0-bin from https://cache.staging.nix-ci.com
  75. 7.48 s Progress: 0 of 2 built, 27 of 524 downloaded from cache (15 downloading)
  76. 7.48 s Downloading cached curl-8.20.0-man from https://cache.staging.nix-ci.com
  77. 7.48 s Progress: 0 of 2 built, 28 of 524 downloaded from cache (15 downloading)
  78. 7.48 s Downloading cached aws-c-cal from https://cache.staging.nix-ci.com
  79. 7.48 s Progress: 0 of 2 built, 29 of 524 downloaded from cache (15 downloading)
  80. 7.48 s Downloading cached aws-c-compression from https://cache.staging.nix-ci.com
  81. 7.49 s Progress: 0 of 2 built, 30 of 524 downloaded from cache (15 downloading)
  82. 7.49 s Downloading cached aws-c-sdkutils from https://cache.staging.nix-ci.com
  83. 7.49 s Progress: 0 of 2 built, 31 of 524 downloaded from cache (15 downloading)
  84. 7.50 s Downloading cached aws-checksums from https://cache.staging.nix-ci.com
  85. 7.52 s Progress: 0 of 2 built, 32 of 524 downloaded from cache (15 downloading)
  86. 7.52 s Downloading cached c-ini from https://cache.staging.nix-ci.com
  87. 7.55 s Progress: 0 of 2 built, 33 of 524 downloaded from cache (15 downloading)
  88. 7.55 s Downloading cached c-dvar from https://cache.staging.nix-ci.com
  89. 7.56 s Progress: 0 of 2 built, 34 of 524 downloaded from cache (15 downloading)
  90. 7.57 s Downloading cached db from https://cache.staging.nix-ci.com
  91. 7.58 s Progress: 0 of 2 built, 35 of 524 downloaded from cache (15 downloading)
  92. 7.58 s Downloading cached dbus-1.16.2-doc from https://cache.staging.nix-ci.com
  93. 7.58 s Progress: 0 of 2 built, 36 of 524 downloaded from cache (15 downloading)
  94. 7.58 s Progress: 0 of 2 built, 37 of 524 downloaded from cache (14 downloading)
  95. 7.58 s Downloading cached dbus-1.16.2-man from https://cache.staging.nix-ci.com
  96. 7.58 s Downloading cached dhcpcd from https://cache.staging.nix-ci.com
  97. 7.58 s Progress: 0 of 2 built, 38 of 524 downloaded from cache (15 downloading)
  98. 7.58 s Downloading cached dhcpcd.conf from https://cache.staging.nix-ci.com
  99. 7.59 s Progress: 0 of 2 built, 39 of 524 downloaded from cache (15 downloading)
  100. 7.59 s Downloading cached diffutils-3.12-info from https://cache.staging.nix-ci.com
  101. 7.60 s Progress: 0 of 2 built, 40 of 524 downloaded from cache (15 downloading)
  102. 7.60 s Downloading cached dnscheck-config.yaml from https://cache.staging.nix-ci.com
  103. 7.60 s Progress: 0 of 2 built, 41 of 524 downloaded from cache (15 downloading)
  104. 7.60 s Downloading cached dnscheck-settings-check from https://cache.staging.nix-ci.com
  105. 7.60 s Progress: 0 of 2 built, 42 of 524 downloaded from cache (15 downloading)
  106. 7.60 s Downloading cached dosfstools from https://cache.staging.nix-ci.com
  107. 7.61 s Progress: 0 of 2 built, 43 of 524 downloaded from cache (15 downloading)
  108. 7.61 s Downloading cached dosfstools-4.2-doc from https://cache.staging.nix-ci.com
  109. 7.65 s Progress: 0 of 2 built, 44 of 524 downloaded from cache (15 downloading)
  110. 7.65 s Downloading cached dosfstools-4.2-man from https://cache.staging.nix-ci.com
  111. 7.65 s Progress: 0 of 2 built, 45 of 524 downloaded from cache (15 downloading)
  112. 7.66 s Downloading cached dtc from https://cache.staging.nix-ci.com
  113. 7.66 s Progress: 0 of 2 built, 46 of 524 downloaded from cache (15 downloading)
  114. 7.66 s Downloading cached e2fsprogs from https://cache.staging.nix-ci.com
  115. 7.67 s Progress: 0 of 2 built, 47 of 524 downloaded from cache (15 downloading)
  116. 7.67 s Downloading cached e2fsprogs-1.47.3-info from https://cache.staging.nix-ci.com
  117. 7.68 s Progress: 0 of 2 built, 48 of 524 downloaded from cache (15 downloading)
  118. 7.68 s Downloading cached e2fsprogs-1.47.3-man from https://cache.staging.nix-ci.com
  119. 7.68 s Progress: 0 of 2 built, 49 of 524 downloaded from cache (15 downloading)
  120. 7.68 s Downloading cached editline-1.17.1-unstable-2025-05 from https://cache.staging.nix-ci.com
  121. 7.68 s Progress: 0 of 2 built, 50 of 524 downloaded from cache (15 downloading)
  122. 7.69 s Downloading cached etc-bash_logout from https://cache.staging.nix-ci.com
  123. 7.69 s Progress: 0 of 2 built, 51 of 524 downloaded from cache (15 downloading)
  124. 7.69 s Progress: 0 of 2 built, 52 of 524 downloaded from cache (14 downloading)
  125. 7.69 s Downloading cached etc-bashrc from https://cache.staging.nix-ci.com
  126. 7.69 s Downloading cached etc-dhcpcd.exit-hook from https://cache.staging.nix-ci.com
  127. 7.69 s Progress: 0 of 2 built, 53 of 524 downloaded from cache (15 downloading)
  128. 7.69 s Downloading cached etc-environment.d-50-systemd-path.conf from https://cache.staging.nix-ci.com
  129. 7.70 s Progress: 0 of 2 built, 54 of 524 downloaded from cache (15 downloading)
  130. 7.70 s Downloading cached etc-fstab from https://cache.staging.nix-ci.com
  131. 7.73 s Progress: 0 of 2 built, 55 of 524 downloaded from cache (15 downloading)
  132. 7.73 s Downloading cached etc-fuse.conf from https://cache.staging.nix-ci.com
  133. 7.73 s Progress: 0 of 2 built, 56 of 524 downloaded from cache (15 downloading)
  134. 7.73 s Downloading cached etc-gai.conf from https://cache.staging.nix-ci.com
  135. 7.73 s Progress: 0 of 2 built, 57 of 524 downloaded from cache (15 downloading)
  136. 7.73 s Downloading cached etc-host.conf from https://cache.staging.nix-ci.com
  137. 7.73 s Progress: 0 of 2 built, 58 of 524 downloaded from cache (15 downloading)
  138. 7.73 s Downloading cached etc-hostname from https://cache.staging.nix-ci.com
  139. 7.74 s Progress: 0 of 2 built, 59 of 524 downloaded from cache (15 downloading)
  140. 7.74 s Downloading cached etc-lsb-release from https://cache.staging.nix-ci.com
  141. 7.74 s Progress: 0 of 2 built, 60 of 524 downloaded from cache (15 downloading)
  142. 7.74 s Progress: 0 of 2 built, 61 of 524 downloaded from cache (14 downloading)
  143. 7.74 s Downloading cached etc-man_db.conf from https://cache.staging.nix-ci.com
  144. 7.74 s Downloading cached etc-modprobe.d-firmware.conf from https://cache.staging.nix-ci.com
  145. 7.77 s Progress: 0 of 2 built, 62 of 524 downloaded from cache (15 downloading)
  146. 7.77 s Downloading cached etc-modprobe.d-nixos.conf from https://cache.staging.nix-ci.com
  147. 7.77 s Progress: 0 of 2 built, 63 of 524 downloaded from cache (15 downloading)
  148. 7.77 s Progress: 0 of 2 built, 64 of 524 downloaded from cache (14 downloading)
  149. 7.77 s Downloading cached etc-nanorc from https://cache.staging.nix-ci.com
  150. 7.77 s Downloading cached etc-netgroup from https://cache.staging.nix-ci.com
  151. 7.77 s Progress: 0 of 2 built, 65 of 524 downloaded from cache (15 downloading)
  152. 7.77 s Progress: 0 of 2 built, 66 of 524 downloaded from cache (14 downloading)
  153. 7.77 s Downloading cached etc-nix-registry.json from https://cache.staging.nix-ci.com
  154. 7.77 s Downloading cached etc-nscd.conf from https://cache.staging.nix-ci.com
  155. 7.77 s Progress: 0 of 2 built, 67 of 524 downloaded from cache (15 downloading)
  156. 7.77 s Progress: 0 of 2 built, 68 of 524 downloaded from cache (14 downloading)
  157. 7.77 s Downloading cached etc-nsswitch.conf from https://cache.staging.nix-ci.com
  158. 7.78 s Downloading cached etc-os-release from https://cache.staging.nix-ci.com
  159. 7.78 s Progress: 0 of 2 built, 69 of 524 downloaded from cache (15 downloading)
  160. 7.78 s Downloading cached etc-pam-environment from https://cache.staging.nix-ci.com
  161. 7.79 s Progress: 0 of 2 built, 70 of 524 downloaded from cache (15 downloading)
  162. 7.79 s Downloading cached etc-resolvconf.conf from https://cache.staging.nix-ci.com
  163. 7.80 s Progress: 0 of 2 built, 71 of 524 downloaded from cache (15 downloading)
  164. 7.80 s Downloading cached etc-shells from https://cache.staging.nix-ci.com
  165. 7.80 s Progress: 0 of 2 built, 72 of 524 downloaded from cache (15 downloading)
  166. 7.80 s Progress: 0 of 2 built, 73 of 524 downloaded from cache (14 downloading)
  167. 7.80 s Downloading cached etc-ssh-ssh_known_hosts from https://cache.staging.nix-ci.com
  168. 7.80 s Downloading cached etc-systemd-coredump.conf from https://cache.staging.nix-ci.com
  169. 7.80 s Progress: 0 of 2 built, 74 of 524 downloaded from cache (15 downloading)
  170. 7.81 s Downloading cached etc-systemd-journald.conf from https://cache.staging.nix-ci.com
  171. 7.81 s Progress: 0 of 2 built, 75 of 524 downloaded from cache (15 downloading)
  172. 7.81 s Downloading cached btrfs-progs from https://cache.staging.nix-ci.com
  173. 7.81 s Progress: 0 of 2 built, 76 of 524 downloaded from cache (15 downloading)
  174. 7.81 s Progress: 0 of 2 built, 77 of 524 downloaded from cache (14 downloading)
  175. 7.81 s Progress: 0 of 2 built, 78 of 524 downloaded from cache (13 downloading)
  176. 7.81 s Progress: 0 of 2 built, 79 of 524 downloaded from cache (12 downloading)
  177. 7.81 s Downloading cached e2fsprogs-1.47.3-bin from https://cache.staging.nix-ci.com
  178. 7.81 s Downloading cached etc-systemd-logind.conf from https://cache.staging.nix-ci.com
  179. 7.81 s Downloading cached etc-systemd-oomd.conf from https://cache.staging.nix-ci.com
  180. 7.81 s Downloading cached etc-systemd-sleep.conf from https://cache.staging.nix-ci.com
  181. 7.82 s Progress: 0 of 2 built, 80 of 524 downloaded from cache (15 downloading)
  182. 7.82 s Downloading cached etc-systemd-system-preset-00-nixos.preset from https://cache.staging.nix-ci.com
  183. 7.82 s Progress: 0 of 2 built, 81 of 524 downloaded from cache (15 downloading)
  184. 7.83 s Progress: 0 of 2 built, 82 of 524 downloaded from cache (14 downloading)
  185. 7.83 s Progress: 0 of 2 built, 83 of 524 downloaded from cache (13 downloading)
  186. 7.83 s Downloading cached etc-systemd-user-preset-00-nixos.preset from https://cache.staging.nix-ci.com
  187. 7.83 s Downloading cached etc-systemd-user.conf from https://cache.staging.nix-ci.com
  188. 7.83 s Downloading cached fc-10-nixos-rendering.conf from https://cache.staging.nix-ci.com
  189. 7.83 s Progress: 0 of 2 built, 84 of 524 downloaded from cache (15 downloading)
  190. 7.83 s Downloading cached X-Restart-Triggers-resolvconf from https://cache.staging.nix-ci.com
  191. 7.83 s Progress: 0 of 2 built, 85 of 524 downloaded from cache (15 downloading)
  192. 7.83 s Progress: 0 of 2 built, 86 of 524 downloaded from cache (14 downloading)
  193. 7.83 s Downloading cached fc-52-nixos-default-fonts.conf from https://cache.staging.nix-ci.com
  194. 7.83 s Downloading cached fc-53-nixos-reject-type1.conf from https://cache.staging.nix-ci.com
  195. 7.83 s Progress: 0 of 2 built, 87 of 524 downloaded from cache (15 downloading)
  196. 7.83 s Downloading cached X-Restart-Triggers-systemd-journald from https://cache.staging.nix-ci.com
  197. 7.83 s Progress: 0 of 2 built, 88 of 524 downloaded from cache (15 downloading)
  198. 7.83 s Downloading cached X-Restart-Triggers-systemd-journald- from https://cache.staging.nix-ci.com
  199. 7.83 s Progress: 0 of 2 built, 89 of 524 downloaded from cache (15 downloading)
  200. 7.83 s Downloading cached fc-53-no-bitmaps.conf from https://cache.staging.nix-ci.com
  201. 7.84 s Progress: 0 of 2 built, 90 of 524 downloaded from cache (15 downloading)
  202. 7.84 s Downloading cached fc-cache from https://cache.staging.nix-ci.com
  203. 7.84 s Progress: 0 of 2 built, 91 of 524 downloaded from cache (15 downloading)
  204. 7.84 s Downloading cached findutils-4.10.0-info from https://cache.staging.nix-ci.com
  205. 7.84 s Progress: 0 of 2 built, 92 of 524 downloaded from cache (15 downloading)
  206. 7.84 s Progress: 0 of 2 built, 93 of 524 downloaded from cache (14 downloading)
  207. 7.84 s Downloading cached firewall-start from https://cache.staging.nix-ci.com
  208. 7.84 s Downloading cached firewall-stop from https://cache.staging.nix-ci.com
  209. 7.84 s Progress: 0 of 2 built, 94 of 524 downloaded from cache (15 downloading)
  210. 7.84 s Downloading cached fontconfig-2.17.1-bin from https://cache.staging.nix-ci.com
  211. 7.85 s Progress: 0 of 2 built, 95 of 524 downloaded from cache (15 downloading)
  212. 7.85 s Downloading cached fstrm from https://cache.staging.nix-ci.com
  213. 7.85 s Progress: 0 of 2 built, 96 of 524 downloaded from cache (15 downloading)
  214. 7.85 s Downloading cached fuse-2.9.9-man from https://cache.staging.nix-ci.com
  215. 7.86 s Progress: 0 of 2 built, 97 of 524 downloaded from cache (15 downloading)
  216. 7.86 s Downloading cached fuse-3.17.4-man from https://cache.staging.nix-ci.com
  217. 7.86 s Progress: 0 of 2 built, 98 of 524 downloaded from cache (15 downloading)
  218. 7.86 s Downloading cached gawk-5.4.0-info from https://cache.staging.nix-ci.com
  219. 7.86 s Progress: 0 of 2 built, 99 of 524 downloaded from cache (15 downloading)
  220. 7.86 s Downloading cached gawk-5.4.0-man from https://cache.staging.nix-ci.com
  221. 7.86 s Progress: 0 of 2 built, 100 of 524 downloaded from cache (15 downloading)
  222. 7.87 s Downloading cached glibc-2.42-61-getent from https://cache.staging.nix-ci.com
  223. 7.87 s Progress: 0 of 2 built, 101 of 524 downloaded from cache (15 downloading)
  224. 7.87 s Downloading cached glibc-locales-2.42 from https://cache.staging.nix-ci.com
  225. 7.87 s Progress: 0 of 2 built, 102 of 524 downloaded from cache (15 downloading)
  226. 7.87 s Downloading cached gnugrep-3.12-info from https://cache.staging.nix-ci.com
  227. 7.87 s Progress: 0 of 2 built, 103 of 524 downloaded from cache (15 downloading)
  228. 7.87 s Downloading cached fc-00-nixos-cache.conf from https://cache.staging.nix-ci.com
  229. 7.88 s Progress: 0 of 2 built, 104 of 524 downloaded from cache (15 downloading)
  230. 7.88 s Downloading cached gnused-4.9-info from https://cache.staging.nix-ci.com
  231. 7.88 s Progress: 0 of 2 built, 105 of 524 downloaded from cache (15 downloading)
  232. 7.88 s Downloading cached gnutar from https://cache.staging.nix-ci.com
  233. 7.88 s Progress: 0 of 2 built, 106 of 524 downloaded from cache (15 downloading)
  234. 7.88 s Downloading cached firewall-reload from https://cache.staging.nix-ci.com
  235. 7.88 s Progress: 0 of 2 built, 107 of 524 downloaded from cache (15 downloading)
  236. 7.88 s Downloading cached gnutar-1.35-info from https://cache.staging.nix-ci.com
  237. 7.89 s Progress: 0 of 2 built, 108 of 524 downloaded from cache (15 downloading)
  238. 7.89 s Downloading cached gzip-1.14-info from https://cache.staging.nix-ci.com
  239. 7.90 s Progress: 0 of 2 built, 109 of 524 downloaded from cache (15 downloading)
  240. 7.90 s Downloading cached gzip-1.14-man from https://cache.staging.nix-ci.com
  241. 7.90 s Progress: 0 of 2 built, 110 of 524 downloaded from cache (15 downloading)
  242. 7.90 s Downloading cached hashed-password.root from https://cache.staging.nix-ci.com
  243. 7.91 s Progress: 0 of 2 built, 111 of 524 downloaded from cache (15 downloading)
  244. 7.91 s Downloading cached hicolor-icon-theme from https://cache.staging.nix-ci.com
  245. 7.91 s Progress: 0 of 2 built, 112 of 524 downloaded from cache (15 downloading)
  246. 7.91 s Downloading cached hostname-debian from https://cache.staging.nix-ci.com
  247. 7.91 s Progress: 0 of 2 built, 113 of 524 downloaded from cache (15 downloading)
  248. 7.91 s Downloading cached hostname-debian-3.25-man from https://cache.staging.nix-ci.com
  249. 7.92 s Progress: 0 of 2 built, 114 of 524 downloaded from cache (15 downloading)
  250. 7.92 s Downloading cached getent-glibc-2.42 from https://cache.staging.nix-ci.com
  251. 7.92 s Progress: 0 of 2 built, 115 of 524 downloaded from cache (15 downloading)
  252. 7.92 s Downloading cached hosts from https://cache.staging.nix-ci.com
  253. 7.93 s Progress: 0 of 2 built, 116 of 524 downloaded from cache (15 downloading)
  254. 7.93 s Downloading cached hwdb.bin from https://cache.staging.nix-ci.com
  255. 7.93 s Progress: 0 of 2 built, 117 of 524 downloaded from cache (15 downloading)
  256. 7.93 s Downloading cached hwloc-2.13.0-lib from https://cache.staging.nix-ci.com
  257. 7.93 s Progress: 0 of 2 built, 118 of 524 downloaded from cache (15 downloading)
  258. 7.93 s Downloading cached iptables-1.8.13-man from https://cache.staging.nix-ci.com
  259. 7.93 s Progress: 0 of 2 built, 119 of 524 downloaded from cache (15 downloading)
  260. 7.93 s Downloading cached fontconfig-conf from https://cache.staging.nix-ci.com
  261. 7.94 s Progress: 0 of 2 built, 120 of 524 downloaded from cache (15 downloading)
  262. 7.94 s Downloading cached iputils-20250605-man from https://cache.staging.nix-ci.com
  263. 7.94 s Progress: 0 of 2 built, 121 of 524 downloaded from cache (15 downloading)
  264. 7.94 s Downloading cached issue from https://cache.staging.nix-ci.com
  265. 7.95 s Progress: 0 of 2 built, 122 of 524 downloaded from cache (15 downloading)
  266. 7.95 s Downloading cached jbigkit from https://cache.staging.nix-ci.com
  267. 7.96 s Progress: 0 of 2 built, 123 of 524 downloaded from cache (15 downloading)
  268. 7.96 s Downloading cached jemalloc from https://cache.staging.nix-ci.com
  269. 7.97 s Progress: 0 of 2 built, 124 of 524 downloaded from cache (15 downloading)
  270. 7.97 s Downloading cached hostname-hostname-debian from https://cache.staging.nix-ci.com
  271. 7.97 s Progress: 0 of 2 built, 125 of 524 downloaded from cache (15 downloading)
  272. 7.97 s Downloading cached kbd from https://cache.staging.nix-ci.com
  273. 7.97 s Progress: 0 of 2 built, 126 of 524 downloaded from cache (15 downloading)
  274. 7.97 s Downloading cached kbd-2.9.0-man from https://cache.staging.nix-ci.com
  275. 7.98 s Progress: 0 of 2 built, 127 of 524 downloaded from cache (15 downloading)
  276. 7.98 s Downloading cached kexec-tools from https://cache.staging.nix-ci.com
  277. 7.98 s Progress: 0 of 2 built, 128 of 524 downloaded from cache (15 downloading)
  278. 7.98 s Downloading cached kmod-31-man from https://cache.staging.nix-ci.com
  279. 8.00 s Progress: 0 of 2 built, 129 of 524 downloaded from cache (15 downloading)
  280. 8.00 s Downloading cached kmod-blacklist-31+20240202 from https://cache.staging.nix-ci.com
  281. 8.01 s Progress: 0 of 2 built, 130 of 524 downloaded from cache (15 downloading)
  282. 8.01 s Downloading cached kmod-debian-aliases.conf-30+20230601 from https://cache.staging.nix-ci.com
  283. 8.01 s Progress: 0 of 2 built, 131 of 524 downloaded from cache (15 downloading)
  284. 8.01 s Downloading cached ldns from https://cache.staging.nix-ci.com
  285. 8.02 s Progress: 0 of 2 built, 132 of 524 downloaded from cache (15 downloading)
  286. 8.02 s Downloading cached less from https://cache.staging.nix-ci.com
  287. 8.03 s Progress: 0 of 2 built, 133 of 524 downloaded from cache (15 downloading)
  288. 8.03 s Downloading cached less-692-man from https://cache.staging.nix-ci.com
  289. 8.03 s Progress: 0 of 2 built, 134 of 524 downloaded from cache (15 downloading)
  290. 8.03 s Downloading cached lessconfig from https://cache.staging.nix-ci.com
  291. 8.03 s Progress: 0 of 2 built, 135 of 524 downloaded from cache (15 downloading)
  292. 8.03 s Downloading cached libaio from https://cache.staging.nix-ci.com
  293. 8.04 s Progress: 0 of 2 built, 136 of 524 downloaded from cache (15 downloading)
  294. 8.04 s Downloading cached fontconfig-etc from https://cache.staging.nix-ci.com
  295. 8.04 s Progress: 0 of 2 built, 137 of 524 downloaded from cache (15 downloading)
  296. 8.04 s Downloading cached libapparmor from https://cache.staging.nix-ci.com
  297. 8.04 s Progress: 0 of 2 built, 138 of 524 downloaded from cache (15 downloading)
  298. 8.04 s Downloading cached libbpf from https://cache.staging.nix-ci.com
  299. 8.04 s Progress: 0 of 2 built, 139 of 524 downloaded from cache (15 downloading)
  300. 8.04 s Downloading cached libcap-2.77-doc from https://cache.staging.nix-ci.com
  301. 8.05 s Progress: 0 of 2 built, 140 of 524 downloaded from cache (15 downloading)
  302. 8.05 s Downloading cached libcap-2.77-lib from https://cache.staging.nix-ci.com
  303. 8.06 s Progress: 0 of 2 built, 141 of 524 downloaded from cache (15 downloading)
  304. 8.06 s Downloading cached libcap-2.77-man from https://cache.staging.nix-ci.com
  305. 8.06 s Progress: 0 of 2 built, 142 of 524 downloaded from cache (15 downloading)
  306. 8.06 s Downloading cached libcap-ng from https://cache.staging.nix-ci.com
  307. 8.08 s Progress: 0 of 2 built, 143 of 524 downloaded from cache (15 downloading)
  308. 8.08 s Downloading cached libcbor from https://cache.staging.nix-ci.com
  309. 8.08 s Progress: 0 of 2 built, 144 of 524 downloaded from cache (15 downloading)
  310. 8.08 s Downloading cached libcpuid from https://cache.staging.nix-ci.com
  311. 8.08 s Progress: 0 of 2 built, 145 of 524 downloaded from cache (15 downloading)
  312. 8.08 s Downloading cached libedit-20251016 from https://cache.staging.nix-ci.com
  313. 8.09 s Progress: 0 of 2 built, 146 of 524 downloaded from cache (15 downloading)
  314. 8.09 s Downloading cached libgpg-error from https://cache.staging.nix-ci.com
  315. 8.09 s Progress: 0 of 2 built, 147 of 524 downloaded from cache (15 downloading)
  316. 8.09 s Downloading cached libice from https://cache.staging.nix-ci.com
  317. 8.10 s Progress: 0 of 2 built, 148 of 524 downloaded from cache (15 downloading)
  318. 8.10 s Downloading cached libiscsi from https://cache.staging.nix-ci.com
  319. 8.10 s Progress: 0 of 2 built, 149 of 524 downloaded from cache (15 downloading)
  320. 8.10 s Downloading cached libmd from https://cache.staging.nix-ci.com
  321. 8.10 s Progress: 0 of 2 built, 150 of 524 downloaded from cache (15 downloading)
  322. 8.11 s Downloading cached iputils from https://cache.staging.nix-ci.com
  323. 8.11 s Progress: 0 of 2 built, 151 of 524 downloaded from cache (15 downloading)
  324. 8.11 s Downloading cached libcap from https://cache.staging.nix-ci.com
  325. 8.12 s Progress: 0 of 2 built, 152 of 524 downloaded from cache (15 downloading)
  326. 8.12 s Downloading cached console-env from https://cache.staging.nix-ci.com
  327. 8.14 s Progress: 0 of 2 built, 153 of 524 downloaded from cache (15 downloading)
  328. 8.14 s Downloading cached audit-4.1.2-unstable-2025-09-06-lib from https://cache.staging.nix-ci.com
  329. 8.15 s Progress: 0 of 2 built, 154 of 524 downloaded from cache (15 downloading)
  330. 8.15 s Downloading cached libmnl from https://cache.staging.nix-ci.com
  331. 8.15 s Progress: 0 of 2 built, 155 of 524 downloaded from cache (15 downloading)
  332. 8.15 s Downloading cached libnfnetlink from https://cache.staging.nix-ci.com
  333. 8.16 s Progress: 0 of 2 built, 156 of 524 downloaded from cache (15 downloading)
  334. 8.16 s Downloading cached dash from https://cache.staging.nix-ci.com
  335. 8.17 s Progress: 0 of 2 built, 157 of 524 downloaded from cache (15 downloading)
  336. 8.18 s Downloading cached libnl from https://cache.staging.nix-ci.com
  337. 8.18 s Progress: 0 of 2 built, 158 of 524 downloaded from cache (15 downloading)
  338. 8.18 s Downloading cached libpipeline from https://cache.staging.nix-ci.com
  339. 8.19 s Progress: 0 of 2 built, 159 of 524 downloaded from cache (15 downloading)
  340. 8.19 s Downloading cached libressl from https://cache.staging.nix-ci.com
  341. 8.19 s Progress: 0 of 2 built, 160 of 524 downloaded from cache (15 downloading)
  342. 8.19 s Downloading cached libbsd from https://cache.staging.nix-ci.com
  343. 8.19 s Progress: 0 of 2 built, 161 of 524 downloaded from cache (15 downloading)
  344. 8.19 s Downloading cached libressl-4.2.1-man from https://cache.staging.nix-ci.com
  345. 8.19 s Progress: 0 of 2 built, 162 of 524 downloaded from cache (15 downloading)
  346. 8.19 s Downloading cached libassuan from https://cache.staging.nix-ci.com
  347. 8.20 s Progress: 0 of 2 built, 163 of 524 downloaded from cache (15 downloading)
  348. 8.20 s Downloading cached libgcrypt-1.11.2-lib from https://cache.staging.nix-ci.com
  349. 8.21 s Progress: 0 of 2 built, 164 of 524 downloaded from cache (15 downloading)
  350. 8.21 s Downloading cached libksba from https://cache.staging.nix-ci.com
  351. 8.26 s Progress: 0 of 2 built, 165 of 524 downloaded from cache (15 downloading)
  352. 8.26 s Downloading cached libseccomp-2.6.0-lib from https://cache.staging.nix-ci.com
  353. 8.72 s Progress: 0 of 2 built, 166 of 524 downloaded from cache (15 downloading)
  354. 8.72 s Downloading cached libslirp from https://cache.staging.nix-ci.com
  355. 8.72 s Progress: 0 of 2 built, 167 of 524 downloaded from cache (15 downloading)
  356. 8.72 s Downloading cached libsm from https://cache.staging.nix-ci.com
  357. 8.73 s Progress: 0 of 2 built, 168 of 524 downloaded from cache (15 downloading)
  358. 8.73 s Downloading cached libnftnl from https://cache.staging.nix-ci.com
  359. 8.73 s Progress: 0 of 2 built, 169 of 524 downloaded from cache (15 downloading)
  360. 8.73 s Downloading cached libnetfilter_conntrack from https://cache.staging.nix-ci.com
  361. 8.74 s Progress: 0 of 2 built, 170 of 524 downloaded from cache (15 downloading)
  362. 8.74 s Downloading cached libtpms from https://cache.staging.nix-ci.com
  363. 8.75 s Progress: 0 of 2 built, 171 of 524 downloaded from cache (15 downloading)
  364. 8.75 s Downloading cached dbus from https://cache.staging.nix-ci.com
  365. 8.75 s Progress: 0 of 2 built, 172 of 524 downloaded from cache (15 downloading)
  366. 8.75 s Progress: 0 of 2 built, 173 of 524 downloaded from cache (14 downloading)
  367. 8.75 s Downloading cached liburcu from https://cache.staging.nix-ci.com
  368. 8.75 s Downloading cached libusb from https://cache.staging.nix-ci.com
  369. 8.75 s Progress: 0 of 2 built, 174 of 524 downloaded from cache (15 downloading)
  370. 8.75 s Downloading cached libuv from https://cache.staging.nix-ci.com
  371. 8.75 s Progress: 0 of 2 built, 175 of 524 downloaded from cache (15 downloading)
  372. 8.75 s Downloading cached linux-6.18.33-modules from https://cache.staging.nix-ci.com
  373. 8.75 s Progress: 0 of 2 built, 176 of 524 downloaded from cache (15 downloading)
  374. 8.75 s Downloading cached linux-headers-static from https://cache.staging.nix-ci.com
  375. 8.77 s Progress: 0 of 2 built, 177 of 524 downloaded from cache (15 downloading)
  376. 8.77 s Downloading cached linux-pam from https://cache.staging.nix-ci.com
  377. 8.78 s Progress: 0 of 2 built, 178 of 524 downloaded from cache (15 downloading)
  378. 8.78 s Downloading cached libpcap-1.10.6-lib from https://cache.staging.nix-ci.com
  379. 8.78 s Progress: 0 of 2 built, 179 of 524 downloaded from cache (15 downloading)
  380. 8.78 s Downloading cached libxt from https://cache.staging.nix-ci.com
  381. 8.78 s Progress: 0 of 2 built, 180 of 524 downloaded from cache (15 downloading)
  382. 8.78 s Downloading cached linux-pam-1.7.1-doc from https://cache.staging.nix-ci.com
  383. 8.79 s Progress: 0 of 2 built, 181 of 524 downloaded from cache (15 downloading)
  384. 8.79 s Downloading cached linux-pam-1.7.1-man from https://cache.staging.nix-ci.com
  385. 8.79 s Progress: 0 of 2 built, 182 of 524 downloaded from cache (15 downloading)
  386. 8.79 s Downloading cached locale.conf from https://cache.staging.nix-ci.com
  387. 8.82 s Progress: 0 of 2 built, 183 of 524 downloaded from cache (15 downloading)
  388. 8.82 s Downloading cached iptables-1.8.13-lib from https://cache.staging.nix-ci.com
  389. 8.82 s Progress: 0 of 2 built, 184 of 524 downloaded from cache (15 downloading)
  390. 8.82 s Progress: 0 of 2 built, 185 of 524 downloaded from cache (14 downloading)
  391. 8.82 s Downloading cached login.defs from https://cache.staging.nix-ci.com
  392. 8.82 s Downloading cached lowdown-3.0.1-lib from https://cache.staging.nix-ci.com
  393. 8.82 s Progress: 0 of 2 built, 186 of 524 downloaded from cache (15 downloading)
  394. 8.82 s Downloading cached lvm2-2.03.39-lib from https://cache.staging.nix-ci.com
  395. 8.83 s Progress: 0 of 2 built, 187 of 524 downloaded from cache (15 downloading)
  396. 8.83 s Downloading cached lvm2-2.03.39-man from https://cache.staging.nix-ci.com
  397. 8.83 s Progress: 0 of 2 built, 188 of 524 downloaded from cache (15 downloading)
  398. 8.83 s Downloading cached make-initrd-ng from https://cache.staging.nix-ci.com
  399. 8.83 s Progress: 0 of 2 built, 189 of 524 downloaded from cache (15 downloading)
  400. 8.83 s Downloading cached libressl-4.2.1-nc from https://cache.staging.nix-ci.com
  401. 8.84 s Progress: 0 of 2 built, 190 of 524 downloaded from cache (15 downloading)
  402. 8.84 s Downloading cached man-db-2.13.1-doc from https://cache.staging.nix-ci.com
  403. 8.84 s Progress: 0 of 2 built, 191 of 524 downloaded from cache (15 downloading)
  404. 8.84 s Downloading cached mbedtls from https://cache.staging.nix-ci.com
  405. 8.84 s Progress: 0 of 2 built, 192 of 524 downloaded from cache (15 downloading)
  406. 8.84 s Downloading cached migrate-dhcpcd from https://cache.staging.nix-ci.com
  407. 8.86 s Progress: 0 of 2 built, 193 of 524 downloaded from cache (15 downloading)
  408. 8.86 s Downloading cached mkpasswd from https://cache.staging.nix-ci.com
  409. 8.86 s Progress: 0 of 2 built, 194 of 524 downloaded from cache (15 downloading)
  410. 8.86 s Downloading cached libxmu from https://cache.staging.nix-ci.com
  411. 8.88 s Progress: 0 of 2 built, 195 of 524 downloaded from cache (15 downloading)
  412. 8.88 s Downloading cached mkpasswd-5.6.6-man from https://cache.staging.nix-ci.com
  413. 8.89 s Progress: 0 of 2 built, 196 of 524 downloaded from cache (15 downloading)
  414. 8.89 s Downloading cached chfn.pam from https://cache.staging.nix-ci.com
  415. 8.89 s Progress: 0 of 2 built, 197 of 524 downloaded from cache (15 downloading)
  416. 8.89 s Downloading cached chpasswd.pam from https://cache.staging.nix-ci.com
  417. 8.90 s Progress: 0 of 2 built, 198 of 524 downloaded from cache (15 downloading)
  418. 8.90 s Downloading cached chsh.pam from https://cache.staging.nix-ci.com
  419. 8.90 s Progress: 0 of 2 built, 199 of 524 downloaded from cache (15 downloading)
  420. 8.90 s Downloading cached cryptsetup from https://cache.staging.nix-ci.com
  421. 8.90 s Progress: 0 of 2 built, 200 of 524 downloaded from cache (15 downloading)
  422. 8.90 s Downloading cached groupadd.pam from https://cache.staging.nix-ci.com
  423. 8.91 s Progress: 0 of 2 built, 201 of 524 downloaded from cache (15 downloading)
  424. 8.91 s Downloading cached groupdel.pam from https://cache.staging.nix-ci.com
  425. 8.92 s Progress: 0 of 2 built, 202 of 524 downloaded from cache (15 downloading)
  426. 8.92 s Downloading cached groupmems.pam from https://cache.staging.nix-ci.com
  427. 8.92 s Progress: 0 of 2 built, 203 of 524 downloaded from cache (15 downloading)
  428. 8.92 s Downloading cached groupmod.pam from https://cache.staging.nix-ci.com
  429. 8.92 s Progress: 0 of 2 built, 204 of 524 downloaded from cache (15 downloading)
  430. 8.92 s Downloading cached iproute2 from https://cache.staging.nix-ci.com
  431. 8.94 s Progress: 0 of 2 built, 205 of 524 downloaded from cache (15 downloading)
  432. 8.94 s Downloading cached iptables from https://cache.staging.nix-ci.com
  433. 8.94 s Progress: 0 of 2 built, 206 of 524 downloaded from cache (15 downloading)
  434. 8.94 s Downloading cached libpwquality-1.4.5-lib from https://cache.staging.nix-ci.com
  435. 8.94 s Progress: 0 of 2 built, 207 of 524 downloaded from cache (15 downloading)
  436. 8.94 s Downloading cached lvm2-2.03.39-bin from https://cache.staging.nix-ci.com
  437. 8.94 s Progress: 0 of 2 built, 208 of 524 downloaded from cache (15 downloading)
  438. 8.94 s Downloading cached nano-9.0-doc from https://cache.staging.nix-ci.com
  439. 8.95 s Progress: 0 of 2 built, 209 of 524 downloaded from cache (15 downloading)
  440. 8.95 s Downloading cached nano-9.0-info from https://cache.staging.nix-ci.com
  441. 8.95 s Progress: 0 of 2 built, 210 of 524 downloaded from cache (15 downloading)
  442. 8.96 s Downloading cached nano-9.0-man from https://cache.staging.nix-ci.com
  443. 8.96 s Progress: 0 of 2 built, 211 of 524 downloaded from cache (15 downloading)
  444. 8.96 s Downloading cached netpbm from https://cache.staging.nix-ci.com
  445. 8.96 s Progress: 0 of 2 built, 212 of 524 downloaded from cache (15 downloading)
  446. 8.97 s Downloading cached nix-bash-completions from https://cache.staging.nix-ci.com
  447. 8.97 s Progress: 0 of 2 built, 213 of 524 downloaded from cache (15 downloading)
  448. 8.97 s Downloading cached nix-info from https://cache.staging.nix-ci.com
  449. 8.97 s Progress: 0 of 2 built, 214 of 524 downloaded from cache (15 downloading)
  450. 8.97 s Downloading cached nix-manual from https://cache.staging.nix-ci.com
  451. 8.98 s Progress: 0 of 2 built, 215 of 524 downloaded from cache (15 downloading)
  452. 8.98 s Downloading cached nix-manual-2.34.7-man from https://cache.staging.nix-ci.com
  453. 9.24 s Progress: 0 of 2 built, 216 of 524 downloaded from cache (15 downloading)
  454. 9.24 s Downloading cached nix.conf from https://cache.staging.nix-ci.com
  455. 9.25 s Progress: 0 of 2 built, 217 of 524 downloaded from cache (15 downloading)
  456. 9.25 s Downloading cached nixos-build-vms from https://cache.staging.nix-ci.com
  457. 9.25 s Progress: 0 of 2 built, 218 of 524 downloaded from cache (15 downloading)
  458. 9.25 s Downloading cached nix-2.34.7-doc from https://cache.staging.nix-ci.com
  459. 9.25 s Progress: 0 of 2 built, 219 of 524 downloaded from cache (15 downloading)
  460. 9.25 s Downloading cached nixos-firewall-tool from https://cache.staging.nix-ci.com
  461. 9.26 s Progress: 0 of 2 built, 220 of 524 downloaded from cache (15 downloading)
  462. 9.26 s Downloading cached nixos-init from https://cache.staging.nix-ci.com
  463. 9.27 s Progress: 0 of 2 built, 221 of 524 downloaded from cache (15 downloading)
  464. 9.27 s Downloading cached nixos-version from https://cache.staging.nix-ci.com
  465. 9.27 s Progress: 0 of 2 built, 222 of 524 downloaded from cache (15 downloading)
  466. 9.27 s Downloading cached X-Restart-Triggers-nix-daemon from https://cache.staging.nix-ci.com
  467. 9.27 s Progress: 0 of 2 built, 223 of 524 downloaded from cache (15 downloading)
  468. 9.27 s Downloading cached nixos.conf from https://cache.staging.nix-ci.com
  469. 9.27 s Progress: 0 of 2 built, 224 of 524 downloaded from cache (15 downloading)
  470. 9.27 s Downloading cached nix-2.34.7-man from https://cache.staging.nix-ci.com
  471. 9.27 s Progress: 0 of 2 built, 225 of 524 downloaded from cache (15 downloading)
  472. 9.27 s Downloading cached npth from https://cache.staging.nix-ci.com
  473. 9.28 s Progress: 0 of 2 built, 226 of 524 downloaded from cache (15 downloading)
  474. 9.28 s Downloading cached nsncd from https://cache.staging.nix-ci.com
  475. 9.28 s Progress: 0 of 2 built, 227 of 524 downloaded from cache (15 downloading)
  476. 9.28 s Downloading cached netpbm-11.13.3-bin from https://cache.staging.nix-ci.com
  477. 9.29 s Progress: 0 of 2 built, 228 of 524 downloaded from cache (15 downloading)
  478. 9.29 s Downloading cached X-Restart-Triggers-systemd-modules-load from https://cache.staging.nix-ci.com
  479. 9.29 s Progress: 0 of 2 built, 229 of 524 downloaded from cache (15 downloading)
  480. 9.29 s Downloading cached nss-cacert-3.123-p11kit from https://cache.staging.nix-ci.com
  481. 9.29 s Progress: 0 of 2 built, 230 of 524 downloaded from cache (15 downloading)
  482. 9.29 s Downloading cached onetbb from https://cache.staging.nix-ci.com
  483. 9.30 s Progress: 0 of 2 built, 231 of 524 downloaded from cache (15 downloading)
  484. 9.30 s Downloading cached openresolv from https://cache.staging.nix-ci.com
  485. 9.30 s Progress: 0 of 2 built, 232 of 524 downloaded from cache (15 downloading)
  486. 9.30 s Downloading cached openssh-10.3p1-man from https://cache.staging.nix-ci.com
  487. 9.31 s Progress: 0 of 2 built, 233 of 524 downloaded from cache (15 downloading)
  488. 9.31 s Downloading cached other.pam from https://cache.staging.nix-ci.com
  489. 9.31 s Progress: 0 of 2 built, 234 of 524 downloaded from cache (15 downloading)
  490. 9.31 s Downloading cached passwd.pam from https://cache.staging.nix-ci.com
  491. 9.31 s Progress: 0 of 2 built, 235 of 524 downloaded from cache (15 downloading)
  492. 9.31 s Downloading cached pcsclite-2.4.1-lib from https://cache.staging.nix-ci.com
  493. 9.31 s Progress: 0 of 2 built, 236 of 524 downloaded from cache (15 downloading)
  494. 9.31 s Downloading cached perl-5.42.0-man from https://cache.staging.nix-ci.com
  495. 9.31 s Progress: 0 of 2 built, 237 of 524 downloaded from cache (15 downloading)
  496. 9.31 s Downloading cached perl5.42.0-File-Slurp from https://cache.staging.nix-ci.com
  497. 9.31 s Progress: 0 of 2 built, 238 of 524 downloaded from cache (15 downloading)
  498. 9.31 s Downloading cached lvm2 from https://cache.staging.nix-ci.com
  499. 9.32 s Progress: 0 of 2 built, 239 of 524 downloaded from cache (15 downloading)
  500. 9.32 s Downloading cached perl5.42.0-IO-Stringy from https://cache.staging.nix-ci.com
  501. 9.34 s Progress: 0 of 2 built, 240 of 524 downloaded from cache (15 downloading)
  502. 9.34 s Downloading cached perl5.42.0-JSON from https://cache.staging.nix-ci.com
  503. 9.34 s Progress: 0 of 2 built, 241 of 524 downloaded from cache (15 downloading)
  504. 9.34 s Downloading cached libblake3 from https://cache.staging.nix-ci.com
  505. 9.35 s Progress: 0 of 2 built, 242 of 524 downloaded from cache (15 downloading)
  506. 9.35 s Downloading cached procps from https://cache.staging.nix-ci.com
  507. 9.35 s Progress: 0 of 2 built, 243 of 524 downloaded from cache (15 downloading)
  508. 9.35 s Downloading cached protobuf-c-1.5.2-lib from https://cache.staging.nix-ci.com
  509. 9.35 s Progress: 0 of 2 built, 244 of 524 downloaded from cache (15 downloading)
  510. 9.35 s Downloading cached python3.13-parso from https://cache.staging.nix-ci.com
  511. 9.35 s Progress: 0 of 2 built, 245 of 524 downloaded from cache (15 downloading)
  512. 9.35 s Downloading cached python3.13-ptyprocess from https://cache.staging.nix-ci.com
  513. 9.36 s Progress: 0 of 2 built, 246 of 524 downloaded from cache (15 downloading)
  514. 9.36 s Downloading cached python3.13-pydantic-core from https://cache.staging.nix-ci.com
  515. 9.36 s Progress: 0 of 2 built, 247 of 524 downloaded from cache (15 downloading)
  516. 9.36 s Downloading cached python3.13-pygments from https://cache.staging.nix-ci.com
  517. 9.37 s Progress: 0 of 2 built, 248 of 524 downloaded from cache (15 downloading)
  518. 9.37 s Downloading cached python3.13-remote-pdb from https://cache.staging.nix-ci.com
  519. 9.37 s Progress: 0 of 2 built, 249 of 524 downloaded from cache (15 downloading)
  520. 9.37 s Downloading cached libfido2 from https://cache.staging.nix-ci.com
  521. 9.38 s Progress: 0 of 2 built, 250 of 524 downloaded from cache (15 downloading)
  522. 9.38 s Downloading cached python3.13-toml from https://cache.staging.nix-ci.com
  523. 9.38 s Progress: 0 of 2 built, 251 of 524 downloaded from cache (15 downloading)
  524. 9.38 s Downloading cached nix-util from https://cache.staging.nix-ci.com
  525. 9.38 s Progress: 0 of 2 built, 252 of 524 downloaded from cache (15 downloading)
  526. 9.38 s Downloading cached python3.13-traitlets from https://cache.staging.nix-ci.com
  527. 9.40 s Progress: 0 of 2 built, 253 of 524 downloaded from cache (15 downloading)
  528. 9.40 s Downloading cached perl5.42.0-Config-IniFiles from https://cache.staging.nix-ci.com
  529. 9.41 s Progress: 0 of 2 built, 254 of 524 downloaded from cache (15 downloading)
  530. 9.41 s Downloading cached python3.13-pexpect from https://cache.staging.nix-ci.com
  531. 9.42 s Progress: 0 of 2 built, 255 of 524 downloaded from cache (15 downloading)
  532. 9.42 s Downloading cached bind-9.20.23-lib from https://cache.staging.nix-ci.com
  533. 9.44 s Progress: 0 of 2 built, 256 of 524 downloaded from cache (15 downloading)
  534. 9.44 s Downloading cached python3.13-typing-inspection from https://cache.staging.nix-ci.com
  535. 9.47 s Progress: 0 of 2 built, 257 of 524 downloaded from cache (15 downloading)
  536. 9.47 s Downloading cached python3.13-wcwidth from https://cache.staging.nix-ci.com
  537. 9.48 s Progress: 0 of 2 built, 258 of 524 downloaded from cache (15 downloading)
  538. 9.48 s Downloading cached python3.13-pure-eval from https://cache.staging.nix-ci.com
  539. 9.48 s Progress: 0 of 2 built, 259 of 524 downloaded from cache (15 downloading)
  540. 9.48 s Downloading cached openssh from https://cache.staging.nix-ci.com
  541. 9.50 s Progress: 0 of 2 built, 260 of 524 downloaded from cache (15 downloading)
  542. 9.50 s Downloading cached qemu-host-cpu-only-for-vm-tests-10.2.2-ga from https://cache.staging.nix-ci.com
  543. 9.50 s Progress: 0 of 2 built, 261 of 524 downloaded from cache (15 downloading)
  544. 9.50 s Downloading cached netpbm-11.13.3-dev from https://cache.staging.nix-ci.com
  545. 9.50 s Progress: 0 of 2 built, 262 of 524 downloaded from cache (15 downloading)
  546. 9.50 s Downloading cached qrencode from https://cache.staging.nix-ci.com
  547. 9.50 s Progress: 0 of 2 built, 263 of 524 downloaded from cache (15 downloading)
  548. 9.50 s Downloading cached python3.13-jedi from https://cache.staging.nix-ci.com
  549. 9.51 s Progress: 0 of 2 built, 264 of 524 downloaded from cache (15 downloading)
  550. 9.51 s Downloading cached runuser-l.pam from https://cache.staging.nix-ci.com
  551. 9.51 s Progress: 0 of 2 built, 265 of 524 downloaded from cache (15 downloading)
  552. 9.51 s Downloading cached nix-nswrapper from https://cache.staging.nix-ci.com
  553. 9.52 s Progress: 0 of 2 built, 266 of 524 downloaded from cache (15 downloading)
  554. 9.52 s Downloading cached python3.13-matplotlib-inline from https://cache.staging.nix-ci.com
  555. 9.52 s Progress: 0 of 2 built, 267 of 524 downloaded from cache (15 downloading)
  556. 9.52 s Downloading cached python3.13-pydantic from https://cache.staging.nix-ci.com
  557. 9.52 s Progress: 0 of 2 built, 268 of 524 downloaded from cache (15 downloading)
  558. 9.52 s Downloading cached python3.13-stack-data from https://cache.staging.nix-ci.com
  559. 9.55 s Progress: 0 of 2 built, 269 of 524 downloaded from cache (15 downloading)
  560. 9.55 s Downloading cached python3.13-prompt-toolkit from https://cache.staging.nix-ci.com
  561. 9.56 s Progress: 0 of 2 built, 270 of 524 downloaded from cache (15 downloading)
  562. 9.56 s Downloading cached runuser.pam from https://cache.staging.nix-ci.com
  563. 9.56 s Progress: 0 of 2 built, 271 of 524 downloaded from cache (15 downloading)
  564. 9.56 s Progress: 0 of 2 built, 272 of 524 downloaded from cache (14 downloading)
  565. 9.56 s Downloading cached bind-9.20.23-host from https://cache.staging.nix-ci.com
  566. 9.56 s Downloading cached s2n-tls from https://cache.staging.nix-ci.com
  567. 9.57 s Progress: 0 of 2 built, 273 of 524 downloaded from cache (15 downloading)
  568. 9.57 s Downloading cached security-wrapper-unix_chkpwd-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  569. 9.57 s Progress: 0 of 2 built, 274 of 524 downloaded from cache (15 downloading)
  570. 9.57 s Downloading cached set-environment from https://cache.staging.nix-ci.com
  571. 9.57 s Progress: 0 of 2 built, 275 of 524 downloaded from cache (15 downloading)
  572. 9.57 s Downloading cached shadow-4.19.4-man from https://cache.staging.nix-ci.com
  573. 9.58 s Progress: 0 of 2 built, 276 of 524 downloaded from cache (15 downloading)
  574. 9.58 s Downloading cached shared-mime-info from https://cache.staging.nix-ci.com
  575. 9.58 s Progress: 0 of 2 built, 277 of 524 downloaded from cache (15 downloading)
  576. 9.58 s Downloading cached snappy from https://cache.staging.nix-ci.com
  577. 9.60 s Progress: 0 of 2 built, 278 of 524 downloaded from cache (15 downloading)
  578. 9.60 s Downloading cached socat from https://cache.staging.nix-ci.com
  579. 9.60 s Progress: 0 of 2 built, 279 of 524 downloaded from cache (15 downloading)
  580. 9.60 s Downloading cached python3.13-ipython-pygments-lexers from https://cache.staging.nix-ci.com
  581. 9.61 s Progress: 0 of 2 built, 280 of 524 downloaded from cache (15 downloading)
  582. 9.61 s Downloading cached sound-theme-freedesktop from https://cache.staging.nix-ci.com
  583. 9.61 s Progress: 0 of 2 built, 281 of 524 downloaded from cache (15 downloading)
  584. 9.61 s Downloading cached strace from https://cache.staging.nix-ci.com
  585. 9.61 s Progress: 0 of 2 built, 282 of 524 downloaded from cache (15 downloading)
  586. 9.61 s Downloading cached strace-7.0-man from https://cache.staging.nix-ci.com
  587. 9.65 s Progress: 0 of 2 built, 283 of 524 downloaded from cache (15 downloading)
  588. 9.65 s Downloading cached aws-c-io from https://cache.staging.nix-ci.com
  589. 9.65 s Progress: 0 of 2 built, 284 of 524 downloaded from cache (15 downloading)
  590. 9.65 s Downloading cached stub-ld-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  591. 9.66 s Progress: 0 of 2 built, 285 of 524 downloaded from cache (15 downloading)
  592. 9.66 s Downloading cached sudo from https://cache.staging.nix-ci.com
  593. 9.66 s Progress: 0 of 2 built, 286 of 524 downloaded from cache (15 downloading)
  594. 9.67 s Downloading cached sudo-1.9.17p2-man from https://cache.staging.nix-ci.com
  595. 9.67 s Progress: 0 of 2 built, 287 of 524 downloaded from cache (15 downloading)
  596. 9.67 s Downloading cached sudo.pam from https://cache.staging.nix-ci.com
  597. 9.67 s Progress: 0 of 2 built, 288 of 524 downloaded from cache (15 downloading)
  598. 9.67 s Downloading cached sudoers from https://cache.staging.nix-ci.com
  599. 9.67 s Progress: 0 of 2 built, 289 of 524 downloaded from cache (15 downloading)
  600. 9.67 s Downloading cached system-generators from https://cache.staging.nix-ci.com
  601. 9.67 s Progress: 0 of 2 built, 290 of 524 downloaded from cache (15 downloading)
  602. 9.68 s Progress: 0 of 2 built, 291 of 524 downloaded from cache (15 downloading)
  603. 9.68 s Downloading cached system-shutdown from https://cache.staging.nix-ci.com
  604. 9.68 s Downloading cached systemd-260.1-man from https://cache.staging.nix-ci.com
  605. 9.69 s Progress: 0 of 2 built, 292 of 524 downloaded from cache (15 downloading)
  606. 9.69 s Downloading cached tcb from https://cache.staging.nix-ci.com
  607. 9.69 s Progress: 0 of 2 built, 293 of 524 downloaded from cache (15 downloading)
  608. 9.69 s Downloading cached texinfo-interactive from https://cache.staging.nix-ci.com
  609. 9.69 s Progress: 0 of 2 built, 294 of 524 downloaded from cache (15 downloading)
  610. 9.69 s Downloading cached time from https://cache.staging.nix-ci.com
  611. 9.69 s Progress: 0 of 2 built, 295 of 524 downloaded from cache (15 downloading)
  612. 9.69 s Downloading cached time-1.10-info from https://cache.staging.nix-ci.com
  613. 9.69 s Progress: 0 of 2 built, 296 of 524 downloaded from cache (15 downloading)
  614. 9.69 s Downloading cached etc-profile from https://cache.staging.nix-ci.com
  615. 9.70 s Progress: 0 of 2 built, 297 of 524 downloaded from cache (15 downloading)
  616. 9.70 s Downloading cached nixos-tmpfiles.d from https://cache.staging.nix-ci.com
  617. 9.71 s Progress: 0 of 2 built, 298 of 524 downloaded from cache (15 downloading)
  618. 9.71 s Downloading cached tpm2-tss from https://cache.staging.nix-ci.com
  619. 9.71 s Progress: 0 of 2 built, 299 of 524 downloaded from cache (15 downloading)
  620. 9.71 s Downloading cached unit--.slice from https://cache.staging.nix-ci.com
  621. 9.71 s Progress: 0 of 2 built, 300 of 524 downloaded from cache (15 downloading)
  622. 9.71 s Downloading cached aws-c-event-stream from https://cache.staging.nix-ci.com
  623. 9.72 s Progress: 0 of 2 built, 301 of 524 downloaded from cache (15 downloading)
  624. 9.72 s Downloading cached aws-c-http from https://cache.staging.nix-ci.com
  625. 9.73 s Progress: 0 of 2 built, 302 of 524 downloaded from cache (15 downloading)
  626. 9.73 s Downloading cached shadow from https://cache.staging.nix-ci.com
  627. 9.73 s Progress: 0 of 2 built, 303 of 524 downloaded from cache (15 downloading)
  628. 9.73 s Downloading cached unit-40-eth1.link from https://cache.staging.nix-ci.com
  629. 9.73 s Progress: 0 of 2 built, 304 of 524 downloaded from cache (15 downloading)
  630. 9.74 s Downloading cached unit-dbus.socket from https://cache.staging.nix-ci.com
  631. 9.75 s Progress: 0 of 2 built, 305 of 524 downloaded from cache (15 downloading)
  632. 9.75 s Downloading cached unit-dnscheck.timer from https://cache.staging.nix-ci.com
  633. 9.75 s Progress: 0 of 2 built, 306 of 524 downloaded from cache (15 downloading)
  634. 9.75 s Downloading cached unit-fs.target from https://cache.staging.nix-ci.com
  635. 9.76 s Progress: 0 of 2 built, 307 of 524 downloaded from cache (15 downloading)
  636. 9.76 s Downloading cached unit-fstrim.timer from https://cache.staging.nix-ci.com
  637. 9.76 s Progress: 0 of 2 built, 308 of 524 downloaded from cache (15 downloading)
  638. 9.76 s Downloading cached unit-getty.target from https://cache.staging.nix-ci.com
  639. 9.77 s Progress: 0 of 2 built, 309 of 524 downloaded from cache (15 downloading)
  640. 9.77 s Downloading cached perl-5.42.0-env from https://cache.staging.nix-ci.com
  641. 9.77 s Progress: 0 of 2 built, 310 of 524 downloaded from cache (15 downloading)
  642. 9.77 s Downloading cached perl-5.42.0-env from https://cache.staging.nix-ci.com
  643. 9.77 s Progress: 0 of 2 built, 311 of 524 downloaded from cache (15 downloading)
  644. 9.78 s Downloading cached perl-5.42.0-env from https://cache.staging.nix-ci.com
  645. 9.78 s Progress: 0 of 2 built, 312 of 524 downloaded from cache (15 downloading)
  646. 9.78 s Downloading cached unit-keys.target from https://cache.staging.nix-ci.com
  647. 9.78 s Progress: 0 of 2 built, 313 of 524 downloaded from cache (15 downloading)
  648. 9.78 s Downloading cached aws-c-auth from https://cache.staging.nix-ci.com
  649. 9.78 s Progress: 0 of 2 built, 314 of 524 downloaded from cache (15 downloading)
  650. 9.78 s Downloading cached aws-c-mqtt from https://cache.staging.nix-ci.com
  651. 9.78 s Progress: 0 of 2 built, 315 of 524 downloaded from cache (15 downloading)
  652. 9.78 s Downloading cached unit-local-fs.target from https://cache.staging.nix-ci.com
  653. 9.78 s Progress: 0 of 2 built, 316 of 524 downloaded from cache (15 downloading)
  654. 9.78 s Downloading cached unit-multi-user.target from https://cache.staging.nix-ci.com
  655. 9.79 s Progress: 0 of 2 built, 317 of 524 downloaded from cache (15 downloading)
  656. 9.79 s Downloading cached security-wrapper-sudo-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  657. 9.79 s Progress: 0 of 2 built, 318 of 524 downloaded from cache (15 downloading)
  658. 9.79 s Downloading cached gnupg from https://cache.staging.nix-ci.com
  659. 9.79 s Progress: 0 of 2 built, 319 of 524 downloaded from cache (15 downloading)
  660. 9.79 s Downloading cached security-wrapper-sudoedit-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  661. 9.80 s Progress: 0 of 2 built, 320 of 524 downloaded from cache (15 downloading)
  662. 9.80 s Downloading cached sudo-1.9.17p2-doc from https://cache.staging.nix-ci.com
  663. 9.81 s Progress: 0 of 2 built, 321 of 524 downloaded from cache (15 downloading)
  664. 9.81 s Downloading cached systemd from https://cache.staging.nix-ci.com
  665. 9.81 s Progress: 0 of 2 built, 322 of 524 downloaded from cache (15 downloading)
  666. 9.81 s Downloading cached unit-network.target from https://cache.staging.nix-ci.com
  667. 9.81 s Progress: 0 of 2 built, 323 of 524 downloaded from cache (15 downloading)
  668. 9.81 s Downloading cached unit-networking-scripted.target from https://cache.staging.nix-ci.com
  669. 9.82 s Progress: 0 of 2 built, 324 of 524 downloaded from cache (15 downloading)
  670. 9.82 s Downloading cached aws-c-s3 from https://cache.staging.nix-ci.com
  671. 9.82 s Progress: 0 of 2 built, 325 of 524 downloaded from cache (15 downloading)
  672. 9.82 s Downloading cached unit-nix-daemon.socket from https://cache.staging.nix-ci.com
  673. 9.82 s Progress: 0 of 2 built, 326 of 524 downloaded from cache (15 downloading)
  674. 9.82 s Downloading cached security-wrapper-chsh-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  675. 9.82 s Progress: 0 of 2 built, 327 of 524 downloaded from cache (15 downloading)
  676. 9.82 s Downloading cached security-wrapper-newgidmap-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  677. 9.83 s Progress: 0 of 2 built, 328 of 524 downloaded from cache (15 downloading)
  678. 9.83 s Downloading cached security-wrapper-newgrp-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  679. 9.83 s Progress: 0 of 2 built, 329 of 524 downloaded from cache (15 downloading)
  680. 9.83 s Downloading cached security-wrapper-newuidmap-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  681. 9.83 s Progress: 0 of 2 built, 330 of 524 downloaded from cache (15 downloading)
  682. 9.84 s Downloading cached security-wrapper-passwd-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  683. 9.84 s Progress: 0 of 2 built, 331 of 524 downloaded from cache (15 downloading)
  684. 9.84 s Downloading cached security-wrapper-sg-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  685. 9.84 s Progress: 0 of 2 built, 332 of 524 downloaded from cache (15 downloading)
  686. 9.85 s Downloading cached shadow-4.19.4-su from https://cache.staging.nix-ci.com
  687. 9.85 s Progress: 0 of 2 built, 333 of 524 downloaded from cache (15 downloading)
  688. 9.85 s Downloading cached unit-nixos-fake-graphical-session.target from https://cache.staging.nix-ci.com
  689. 9.86 s Progress: 0 of 2 built, 334 of 524 downloaded from cache (15 downloading)
  690. 9.86 s Downloading cached unit-remote-fs.target from https://cache.staging.nix-ci.com
  691. 9.86 s Progress: 0 of 2 built, 335 of 524 downloaded from cache (15 downloading)
  692. 9.86 s Downloading cached unit-run-initramfs.mount from https://cache.staging.nix-ci.com
  693. 9.87 s Progress: 0 of 2 built, 336 of 524 downloaded from cache (15 downloading)
  694. 9.87 s Downloading cached aws-crt-cpp from https://cache.staging.nix-ci.com
  695. 9.87 s Progress: 0 of 2 built, 337 of 524 downloaded from cache (15 downloading)
  696. 9.87 s Downloading cached unit-run-wrappers.mount from https://cache.staging.nix-ci.com
  697. 9.87 s Progress: 0 of 2 built, 338 of 524 downloaded from cache (15 downloading)
  698. 9.87 s Downloading cached unit-script-backdoor-start from https://cache.staging.nix-ci.com
  699. 9.87 s Progress: 0 of 2 built, 339 of 524 downloaded from cache (15 downloading)
  700. 9.87 s Downloading cached unit-script-dnscheck-start from https://cache.staging.nix-ci.com
  701. 9.88 s Progress: 0 of 2 built, 340 of 524 downloaded from cache (15 downloading)
  702. 9.88 s Downloading cached unit-script-network-addresses-eth1-pre-stop from https://cache.staging.nix-ci.com
  703. 9.88 s Progress: 0 of 2 built, 341 of 524 downloaded from cache (15 downloading)
  704. 9.88 s Downloading cached unit-script-network-addresses-eth1-start from https://cache.staging.nix-ci.com
  705. 9.88 s Progress: 0 of 2 built, 342 of 524 downloaded from cache (15 downloading)
  706. 9.88 s Downloading cached unit-script-network-local-commands-start from https://cache.staging.nix-ci.com
  707. 9.88 s Progress: 0 of 2 built, 343 of 524 downloaded from cache (15 downloading)
  708. 9.89 s Downloading cached unit-script-post-boot-pre-stop from https://cache.staging.nix-ci.com
  709. 9.89 s Progress: 0 of 2 built, 344 of 524 downloaded from cache (15 downloading)
  710. 9.89 s Downloading cached unit-script-post-boot-start from https://cache.staging.nix-ci.com
  711. 9.89 s Progress: 0 of 2 built, 345 of 524 downloaded from cache (15 downloading)
  712. 9.89 s Downloading cached unit-script-prepare-kexec-start from https://cache.staging.nix-ci.com
  713. 9.89 s Progress: 0 of 2 built, 346 of 524 downloaded from cache (15 downloading)
  714. 9.89 s Downloading cached unit-script-resolvconf-start from https://cache.staging.nix-ci.com
  715. 9.90 s Progress: 0 of 2 built, 347 of 524 downloaded from cache (15 downloading)
  716. 9.90 s Downloading cached security-wrapper-su-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  717. 9.91 s Progress: 0 of 2 built, 348 of 524 downloaded from cache (15 downloading)
  718. 9.91 s Downloading cached unit-script-sleep-actions-pre-stop from https://cache.staging.nix-ci.com
  719. 9.91 s Progress: 0 of 2 built, 349 of 524 downloaded from cache (15 downloading)
  720. 9.91 s Downloading cached unit-script-sleep-actions-start from https://cache.staging.nix-ci.com
  721. 9.91 s Progress: 0 of 2 built, 350 of 524 downloaded from cache (15 downloading)
  722. 9.91 s Downloading cached unit-serial-getty-hvc0.service-disabled from https://cache.staging.nix-ci.com
  723. 9.91 s Progress: 0 of 2 built, 351 of 524 downloaded from cache (15 downloading)
  724. 9.91 s Progress: 0 of 2 built, 352 of 524 downloaded from cache (15 downloading)
  725. 9.91 s Downloading cached unit-serial-getty-ttyS0.service-disabled from https://cache.staging.nix-ci.com
  726. 9.91 s Downloading cached nix-store from https://cache.staging.nix-ci.com
  727. 9.92 s Progress: 0 of 2 built, 353 of 524 downloaded from cache (15 downloading)
  728. 9.92 s Downloading cached unit-sysinit-reactivation.target from https://cache.staging.nix-ci.com
  729. 9.92 s Progress: 0 of 2 built, 354 of 524 downloaded from cache (15 downloading)
  730. 9.92 s Downloading cached unit-system.slice from https://cache.staging.nix-ci.com
  731. 9.92 s Progress: 0 of 2 built, 355 of 524 downloaded from cache (15 downloading)
  732. 9.92 s Downloading cached unit-systemd-journald-audit.socket from https://cache.staging.nix-ci.com
  733. 9.92 s Progress: 0 of 2 built, 356 of 524 downloaded from cache (15 downloading)
  734. 9.92 s Downloading cached unit-systemd-tmpfiles-clean.timer from https://cache.staging.nix-ci.com
  735. 9.93 s Progress: 0 of 2 built, 357 of 524 downloaded from cache (15 downloading)
  736. 9.93 s Downloading cached unit-user.slice from https://cache.staging.nix-ci.com
  737. 9.93 s Progress: 0 of 2 built, 358 of 524 downloaded from cache (15 downloading)
  738. 9.93 s Downloading cached user-generators from https://cache.staging.nix-ci.com
  739. 9.93 s Progress: 0 of 2 built, 359 of 524 downloaded from cache (15 downloading)
  740. 9.93 s Downloading cached useradd from https://cache.staging.nix-ci.com
  741. 9.94 s Progress: 0 of 2 built, 360 of 524 downloaded from cache (15 downloading)
  742. 9.94 s Downloading cached useradd.pam from https://cache.staging.nix-ci.com
  743. 9.94 s Progress: 0 of 2 built, 361 of 524 downloaded from cache (15 downloading)
  744. 9.94 s Downloading cached userdel.pam from https://cache.staging.nix-ci.com
  745. 9.94 s Progress: 0 of 2 built, 362 of 524 downloaded from cache (15 downloading)
  746. 9.94 s Downloading cached usermod.pam from https://cache.staging.nix-ci.com
  747. 9.94 s Progress: 0 of 2 built, 363 of 524 downloaded from cache (15 downloading)
  748. 9.94 s Downloading cached users-groups.json from https://cache.staging.nix-ci.com
  749. 9.94 s Progress: 0 of 2 built, 364 of 524 downloaded from cache (15 downloading)
  750. 9.94 s Downloading cached util-linux-2.42-lib from https://cache.staging.nix-ci.com
  751. 9.94 s Progress: 0 of 2 built, 365 of 524 downloaded from cache (15 downloading)
  752. 9.94 s Downloading cached util-linux-2.42-man from https://cache.staging.nix-ci.com
  753. 9.94 s Progress: 0 of 2 built, 366 of 524 downloaded from cache (15 downloading)
  754. 9.94 s Downloading cached util-linux-minimal-2.42-bin from https://cache.staging.nix-ci.com
  755. 9.95 s Progress: 0 of 2 built, 367 of 524 downloaded from cache (15 downloading)
  756. 9.95 s Downloading cached vconsole.conf from https://cache.staging.nix-ci.com
  757. 9.95 s Progress: 0 of 2 built, 368 of 524 downloaded from cache (15 downloading)
  758. 9.95 s Downloading cached vde2 from https://cache.staging.nix-ci.com
  759. 9.95 s Progress: 0 of 2 built, 369 of 524 downloaded from cache (15 downloading)
  760. 9.95 s Downloading cached vhost-device-vsock from https://cache.staging.nix-ci.com
  761. 9.96 s Progress: 0 of 2 built, 370 of 524 downloaded from cache (15 downloading)
  762. 9.96 s Downloading cached vlock.pam from https://cache.staging.nix-ci.com
  763. 9.96 s Progress: 0 of 2 built, 371 of 524 downloaded from cache (15 downloading)
  764. 9.97 s Downloading cached X-Restart-Triggers-reload-systemd-vconsole-setup from https://cache.staging.nix-ci.com
  765. 9.97 s Progress: 0 of 2 built, 372 of 524 downloaded from cache (15 downloading)
  766. 9.97 s Downloading cached which from https://cache.staging.nix-ci.com
  767. 9.97 s Progress: 0 of 2 built, 373 of 524 downloaded from cache (15 downloading)
  768. 9.97 s Downloading cached which-2.23-info from https://cache.staging.nix-ci.com
  769. 9.98 s Progress: 0 of 2 built, 374 of 524 downloaded from cache (15 downloading)
  770. 9.98 s Downloading cached which-2.23-man from https://cache.staging.nix-ci.com
  771. 10.01 s Progress: 0 of 2 built, 375 of 524 downloaded from cache (15 downloading)
  772. 10.01 s Downloading cached xauth from https://cache.staging.nix-ci.com
  773. 10.02 s Progress: 0 of 2 built, 376 of 524 downloaded from cache (15 downloading)
  774. 10.02 s Downloading cached xwininfo from https://cache.staging.nix-ci.com
  775. 10.02 s Progress: 0 of 2 built, 377 of 524 downloaded from cache (15 downloading)
  776. 10.02 s Downloading cached xz-5.8.3-doc from https://cache.staging.nix-ci.com
  777. 10.03 s Progress: 0 of 2 built, 378 of 524 downloaded from cache (15 downloading)
  778. 10.03 s Downloading cached xz-5.8.3-man from https://cache.staging.nix-ci.com
  779. 10.03 s Progress: 0 of 2 built, 379 of 524 downloaded from cache (15 downloading)
  780. 10.03 s Downloading cached zstd-1.5.7-man from https://cache.staging.nix-ci.com
  781. 10.03 s Progress: 0 of 2 built, 380 of 524 downloaded from cache (15 downloading)
  782. 10.03 s Progress: 0 of 2 built, 381 of 524 downloaded from cache (14 downloading)
  783. 10.03 s Progress: 0 of 2 built, 382 of 524 downloaded from cache (13 downloading)
  784. 10.05 s Progress: 0 of 2 built, 383 of 524 downloaded from cache (12 downloading)
  785. 10.05 s Progress: 0 of 2 built, 384 of 524 downloaded from cache (11 downloading)
  786. 10.05 s Downloading cached nix-fetchers from https://cache.staging.nix-ci.com
  787. 10.05 s Downloading cached nix-main from https://cache.staging.nix-ci.com
  788. 10.05 s Progress: 0 of 2 built, 385 of 524 downloaded from cache (12 downloading)
  789. 10.05 s Downloading cached su.pam from https://cache.staging.nix-ci.com
  790. 10.05 s Progress: 0 of 2 built, 386 of 524 downloaded from cache (12 downloading)
  791. 10.05 s Downloading cached python3.13-ipython from https://cache.staging.nix-ci.com
  792. 10.05 s Downloading cached python3.13-ptpython from https://cache.staging.nix-ci.com
  793. 10.06 s Progress: 0 of 2 built, 387 of 524 downloaded from cache (13 downloading)
  794. 10.06 s Progress: 0 of 2 built, 388 of 524 downloaded from cache (12 downloading)
  795. 10.07 s Progress: 0 of 2 built, 389 of 524 downloaded from cache (11 downloading)
  796. 10.07 s Downloading cached etc-systemd-system.conf from https://cache.staging.nix-ci.com
  797. 10.07 s Downloading cached fuse from https://cache.staging.nix-ci.com
  798. 10.07 s Downloading cached fuse-2.9.9-bin from https://cache.staging.nix-ci.com
  799. 10.07 s Downloading cached fuse from https://cache.staging.nix-ci.com
  800. 10.07 s Downloading cached lvm2-2.03.39-scripts from https://cache.staging.nix-ci.com
  801. 10.09 s Progress: 0 of 2 built, 390 of 524 downloaded from cache (15 downloading)
  802. 10.09 s Downloading cached man-db from https://cache.staging.nix-ci.com
  803. 10.09 s Progress: 0 of 2 built, 391 of 524 downloaded from cache (15 downloading)
  804. 10.09 s Downloading cached nixos-enter from https://cache.staging.nix-ci.com
  805. 10.10 s Progress: 0 of 2 built, 392 of 524 downloaded from cache (15 downloading)
  806. 10.10 s Downloading cached systemd-generator-environment.json from https://cache.staging.nix-ci.com
  807. 10.11 s Progress: 0 of 2 built, 393 of 524 downloaded from cache (15 downloading)
  808. 10.12 s Progress: 0 of 2 built, 394 of 524 downloaded from cache (14 downloading)
  809. 10.12 s Downloading cached fuse-3.17.4-bin from https://cache.staging.nix-ci.com
  810. 10.12 s Downloading cached qemu-host-cpu-only-for-vm-tests from https://cache.staging.nix-ci.com
  811. 10.12 s Progress: 0 of 2 built, 395 of 524 downloaded from cache (15 downloading)
  812. 10.12 s Progress: 0 of 2 built, 396 of 524 downloaded from cache (14 downloading)
  813. 10.12 s Downloading cached security-wrapper-fusermount-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  814. 10.12 s Progress: 0 of 2 built, 397 of 524 downloaded from cache (14 downloading)
  815. 10.12 s Downloading cached etc-lvm-lvm.conf from https://cache.staging.nix-ci.com
  816. 10.12 s Progress: 0 of 2 built, 398 of 524 downloaded from cache (14 downloading)
  817. 10.12 s Downloading cached grub from https://cache.staging.nix-ci.com
  818. 10.13 s Progress: 0 of 2 built, 399 of 524 downloaded from cache (14 downloading)
  819. 10.13 s Downloading cached nixos-install from https://cache.staging.nix-ci.com
  820. 10.14 s Progress: 0 of 2 built, 400 of 524 downloaded from cache (14 downloading)
  821. 10.15 s Progress: 0 of 2 built, 401 of 524 downloaded from cache (13 downloading)
  822. 10.15 s Downloading cached security-wrapper-fusermount3-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  823. 10.16 s Progress: 0 of 2 built, 402 of 524 downloaded from cache (13 downloading)
  824. 10.16 s Progress: 0 of 2 built, 403 of 524 downloaded from cache (12 downloading)
  825. 10.17 s Progress: 0 of 2 built, 404 of 524 downloaded from cache (11 downloading)
  826. 10.18 s Progress: 0 of 2 built, 405 of 524 downloaded from cache (10 downloading)
  827. 10.19 s Progress: 0 of 2 built, 406 of 524 downloaded from cache (9 downloading)
  828. 10.20 s Progress: 0 of 2 built, 407 of 524 downloaded from cache (8 downloading)
  829. 10.20 s Progress: 0 of 2 built, 408 of 524 downloaded from cache (7 downloading)
  830. 10.20 s Progress: 0 of 2 built, 409 of 524 downloaded from cache (6 downloading)
  831. 10.22 s Progress: 0 of 2 built, 410 of 524 downloaded from cache (5 downloading)
  832. 10.22 s Downloading cached bcache-tools from https://cache.staging.nix-ci.com
  833. 10.22 s Downloading cached util-linux-2.42-lastlog from https://cache.staging.nix-ci.com
  834. 10.22 s Downloading cached util-linux-2.42-login from https://cache.staging.nix-ci.com
  835. 10.22 s Downloading cached util-linux-2.42-mount from https://cache.staging.nix-ci.com
  836. 10.22 s Downloading cached util-linux-2.42-swap from https://cache.staging.nix-ci.com
  837. 10.25 s Progress: 0 of 2 built, 411 of 524 downloaded from cache (9 downloading)
  838. 10.25 s Progress: 0 of 2 built, 412 of 524 downloaded from cache (8 downloading)
  839. 10.26 s Progress: 0 of 2 built, 413 of 524 downloaded from cache (7 downloading)
  840. 10.26 s Progress: 0 of 2 built, 414 of 524 downloaded from cache (6 downloading)
  841. 10.26 s Downloading cached util-linux-2.42-bin from https://cache.staging.nix-ci.com
  842. 10.26 s Progress: 0 of 2 built, 415 of 524 downloaded from cache (6 downloading)
  843. 10.40 s Progress: 0 of 2 built, 416 of 524 downloaded from cache (5 downloading)
  844. 10.42 s Progress: 0 of 2 built, 417 of 524 downloaded from cache (4 downloading)
  845. 10.43 s Downloading cached dbus-broker from https://cache.staging.nix-ci.com
  846. 10.43 s Downloading cached etc-ssh-ssh_config from https://cache.staging.nix-ci.com
  847. 10.43 s Downloading cached etc-sysctl.d-60-nixos.conf from https://cache.staging.nix-ci.com
  848. 10.43 s Downloading cached hostname from https://cache.staging.nix-ci.com
  849. 10.43 s Downloading cached login.pam from https://cache.staging.nix-ci.com
  850. 10.43 s Downloading cached nixos-generate-config from https://cache.staging.nix-ci.com
  851. 10.43 s Downloading cached shutdown-ramfs-contents.json from https://cache.staging.nix-ci.com
  852. 10.43 s Downloading cached systemd from https://cache.staging.nix-ci.com
  853. 10.43 s Downloading cached systemd-user.pam from https://cache.staging.nix-ci.com
  854. 10.43 s Downloading cached unit-backdoor.service from https://cache.staging.nix-ci.com
  855. 10.43 s Downloading cached unit-dbus.service from https://cache.staging.nix-ci.com
  856. 10.43 s Downloading cached unit-dnscheck.service from https://cache.staging.nix-ci.com
  857. 10.43 s Progress: 0 of 2 built, 418 of 524 downloaded from cache (15 downloading)
  858. 10.43 s Downloading cached unit-firewall.service from https://cache.staging.nix-ci.com
  859. 10.47 s Progress: 0 of 2 built, 419 of 524 downloaded from cache (15 downloading)
  860. 10.47 s Downloading cached getty from https://cache.staging.nix-ci.com
  861. 10.47 s Progress: 0 of 2 built, 420 of 524 downloaded from cache (15 downloading)
  862. 10.47 s Downloading cached security-wrapper-mount-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  863. 10.48 s Progress: 0 of 2 built, 421 of 524 downloaded from cache (15 downloading)
  864. 10.49 s Downloading cached security-wrapper-umount-x86_64-unknown-linux-musl from https://cache.staging.nix-ci.com
  865. 10.49 s Progress: 0 of 2 built, 422 of 524 downloaded from cache (15 downloading)
  866. 10.49 s Downloading cached udev-path from https://cache.staging.nix-ci.com
  867. 10.49 s Progress: 0 of 2 built, 423 of 524 downloaded from cache (15 downloading)
  868. 10.49 s Downloading cached unit-container-getty-.service from https://cache.staging.nix-ci.com
  869. 10.49 s Progress: 0 of 2 built, 424 of 524 downloaded from cache (15 downloading)
  870. 10.49 s Downloading cached unit-dhcpcd.service from https://cache.staging.nix-ci.com
  871. 10.49 s Progress: 0 of 2 built, 425 of 524 downloaded from cache (15 downloading)
  872. 10.49 s Downloading cached unit-kmod-static-nodes.service from https://cache.staging.nix-ci.com
  873. 10.50 s Progress: 0 of 2 built, 426 of 524 downloaded from cache (15 downloading)
  874. 10.50 s Downloading cached unit-lastlog2-import.service from https://cache.staging.nix-ci.com
  875. 10.50 s Progress: 0 of 2 built, 427 of 524 downloaded from cache (15 downloading)
  876. 10.50 s Downloading cached unit-modprobe-.service from https://cache.staging.nix-ci.com
  877. 10.50 s Progress: 0 of 2 built, 428 of 524 downloaded from cache (15 downloading)
  878. 10.50 s Downloading cached getty from https://cache.staging.nix-ci.com
  879. 10.50 s Progress: 0 of 2 built, 429 of 524 downloaded from cache (15 downloading)
  880. 10.50 s Downloading cached unit-network-addresses-eth1.service from https://cache.staging.nix-ci.com
  881. 10.51 s Progress: 0 of 2 built, 430 of 524 downloaded from cache (15 downloading)
  882. 10.51 s Downloading cached unit-generate-shutdown-ramfs.service from https://cache.staging.nix-ci.com
  883. 10.53 s Progress: 0 of 2 built, 431 of 524 downloaded from cache (15 downloading)
  884. 10.53 s Downloading cached unit-network-local-commands.service from https://cache.staging.nix-ci.com
  885. 10.53 s Progress: 0 of 2 built, 432 of 524 downloaded from cache (15 downloading)
  886. 10.53 s Downloading cached unit-nscd.service from https://cache.staging.nix-ci.com
  887. 10.53 s Progress: 0 of 2 built, 433 of 524 downloaded from cache (15 downloading)
  888. 10.53 s Downloading cached unit-post-boot.service from https://cache.staging.nix-ci.com
  889. 10.53 s Progress: 0 of 2 built, 434 of 524 downloaded from cache (15 downloading)
  890. 10.53 s Downloading cached unit-prepare-kexec.service from https://cache.staging.nix-ci.com
  891. 10.53 s Progress: 0 of 2 built, 435 of 524 downloaded from cache (15 downloading)
  892. 10.53 s Downloading cached unit-qemu-guest-agent.service from https://cache.staging.nix-ci.com
  893. 10.54 s Progress: 0 of 2 built, 436 of 524 downloaded from cache (15 downloading)
  894. 10.54 s Downloading cached unit-reload-systemd-vconsole-setup.service from https://cache.staging.nix-ci.com
  895. 10.54 s Progress: 0 of 2 built, 437 of 524 downloaded from cache (15 downloading)
  896. 10.54 s Downloading cached unit-getty-.service from https://cache.staging.nix-ci.com
  897. 10.54 s Progress: 0 of 2 built, 438 of 524 downloaded from cache (15 downloading)
  898. 10.54 s Downloading cached unit-resolvconf.service from https://cache.staging.nix-ci.com
  899. 10.54 s Progress: 0 of 2 built, 439 of 524 downloaded from cache (15 downloading)
  900. 10.54 s Downloading cached unit-script-linger-users-start from https://cache.staging.nix-ci.com
  901. 10.55 s Progress: 0 of 2 built, 440 of 524 downloaded from cache (15 downloading)
  902. 10.55 s Downloading cached unit-script-nixos-activation-start from https://cache.staging.nix-ci.com
  903. 10.55 s Progress: 0 of 2 built, 441 of 524 downloaded from cache (15 downloading)
  904. 10.55 s Downloading cached 50-coredump.conf from https://cache.staging.nix-ci.com
  905. 10.56 s Progress: 0 of 2 built, 442 of 524 downloaded from cache (15 downloading)
  906. 10.56 s Downloading cached udev-rules from https://cache.staging.nix-ci.com
  907. 10.56 s Progress: 0 of 2 built, 443 of 524 downloaded from cache (15 downloading)
  908. 10.56 s Downloading cached unit-script-suid-sgid-wrappers-start from https://cache.staging.nix-ci.com
  909. 10.56 s Progress: 0 of 2 built, 444 of 524 downloaded from cache (15 downloading)
  910. 10.56 s Downloading cached unit-serial-getty-.service from https://cache.staging.nix-ci.com
  911. 10.57 s Progress: 0 of 2 built, 445 of 524 downloaded from cache (15 downloading)
  912. 10.57 s Downloading cached unit-sleep-actions.service from https://cache.staging.nix-ci.com
  913. 10.57 s Progress: 0 of 2 built, 446 of 524 downloaded from cache (15 downloading)
  914. 10.57 s Downloading cached unit-systemd-backlight-.service from https://cache.staging.nix-ci.com
  915. 10.57 s Progress: 0 of 2 built, 447 of 524 downloaded from cache (15 downloading)
  916. 10.57 s Downloading cached unit-systemd-fsck-.service from https://cache.staging.nix-ci.com
  917. 10.57 s Progress: 0 of 2 built, 448 of 524 downloaded from cache (15 downloading)
  918. 10.57 s Downloading cached unit-systemd-hostnamed.service from https://cache.staging.nix-ci.com
  919. 10.58 s Progress: 0 of 2 built, 449 of 524 downloaded from cache (15 downloading)
  920. 10.58 s Downloading cached unit-systemd-importd.service from https://cache.staging.nix-ci.com
  921. 10.58 s Progress: 0 of 2 built, 450 of 524 downloaded from cache (15 downloading)
  922. 10.58 s Downloading cached unit-systemd-journal-flush.service from https://cache.staging.nix-ci.com
  923. 10.58 s Progress: 0 of 2 built, 451 of 524 downloaded from cache (15 downloading)
  924. 10.58 s Downloading cached unit-linger-users.service from https://cache.staging.nix-ci.com
  925. 10.58 s Progress: 0 of 2 built, 452 of 524 downloaded from cache (15 downloading)
  926. 10.58 s Downloading cached unit-nixos-activation.service from https://cache.staging.nix-ci.com
  927. 10.59 s Progress: 0 of 2 built, 453 of 524 downloaded from cache (15 downloading)
  928. 10.59 s Downloading cached unit-systemd-journald-.service from https://cache.staging.nix-ci.com
  929. 10.59 s Progress: 0 of 2 built, 454 of 524 downloaded from cache (15 downloading)
  930. 10.59 s Downloading cached X-Restart-Triggers-systemd-udevd from https://cache.staging.nix-ci.com
  931. 10.60 s Progress: 0 of 2 built, 455 of 524 downloaded from cache (15 downloading)
  932. 10.60 s Downloading cached X-Restart-Triggers-systemd-sysctl from https://cache.staging.nix-ci.com
  933. 10.60 s Progress: 0 of 2 built, 456 of 524 downloaded from cache (15 downloading)
  934. 10.60 s Downloading cached unit-systemd-journald.service from https://cache.staging.nix-ci.com
  935. 10.60 s Progress: 0 of 2 built, 457 of 524 downloaded from cache (15 downloading)
  936. 10.60 s Downloading cached unit-suid-sgid-wrappers.service from https://cache.staging.nix-ci.com
  937. 10.60 s Progress: 0 of 2 built, 458 of 524 downloaded from cache (15 downloading)
  938. 10.60 s Downloading cached unit-systemd-localed.service from https://cache.staging.nix-ci.com
  939. 10.60 s Progress: 0 of 2 built, 459 of 524 downloaded from cache (15 downloading)
  940. 10.60 s Downloading cached unit-systemd-logind.service from https://cache.staging.nix-ci.com
  941. 10.61 s Progress: 0 of 2 built, 460 of 524 downloaded from cache (15 downloading)
  942. 10.61 s Downloading cached unit-systemd-makefs-.service from https://cache.staging.nix-ci.com
  943. 10.61 s Progress: 0 of 2 built, 461 of 524 downloaded from cache (15 downloading)
  944. 10.61 s Downloading cached unit-systemd-mkswap-.service from https://cache.staging.nix-ci.com
  945. 10.61 s Progress: 0 of 2 built, 462 of 524 downloaded from cache (15 downloading)
  946. 10.61 s Downloading cached unit-systemd-modules-load.service from https://cache.staging.nix-ci.com
  947. 10.61 s Progress: 0 of 2 built, 463 of 524 downloaded from cache (15 downloading)
  948. 10.61 s Downloading cached unit-systemd-nspawn-.service from https://cache.staging.nix-ci.com
  949. 10.62 s Progress: 0 of 2 built, 464 of 524 downloaded from cache (15 downloading)
  950. 10.62 s Downloading cached unit-systemd-oomd.service from https://cache.staging.nix-ci.com
  951. 10.64 s Progress: 0 of 2 built, 465 of 524 downloaded from cache (15 downloading)
  952. 10.64 s Downloading cached unit-systemd-pstore.service from https://cache.staging.nix-ci.com
  953. 10.64 s Progress: 0 of 2 built, 466 of 524 downloaded from cache (15 downloading)
  954. 10.64 s Downloading cached unit-systemd-random-seed.service from https://cache.staging.nix-ci.com
  955. 10.64 s Progress: 0 of 2 built, 467 of 524 downloaded from cache (15 downloading)
  956. 10.64 s Downloading cached unit-systemd-remount-fs.service from https://cache.staging.nix-ci.com
  957. 10.64 s Progress: 0 of 2 built, 468 of 524 downloaded from cache (15 downloading)
  958. 10.64 s Downloading cached unit-systemd-sysctl.service from https://cache.staging.nix-ci.com
  959. 10.64 s Progress: 0 of 2 built, 469 of 524 downloaded from cache (15 downloading)
  960. 10.64 s Downloading cached unit-systemd-timedated.service from https://cache.staging.nix-ci.com
  961. 10.65 s Progress: 0 of 2 built, 470 of 524 downloaded from cache (15 downloading)
  962. 10.65 s Downloading cached unit-systemd-tmpfiles-setup.service from https://cache.staging.nix-ci.com
  963. 10.66 s Progress: 0 of 2 built, 471 of 524 downloaded from cache (15 downloading)
  964. 10.66 s Downloading cached unit-systemd-udevd.service from https://cache.staging.nix-ci.com
  965. 10.68 s Progress: 0 of 2 built, 472 of 524 downloaded from cache (15 downloading)
  966. 10.68 s Downloading cached unit-systemd-update-utmp.service from https://cache.staging.nix-ci.com
  967. 10.68 s Progress: 0 of 2 built, 473 of 524 downloaded from cache (15 downloading)
  968. 10.68 s Downloading cached unit-systemd-user-sessions.service from https://cache.staging.nix-ci.com
  969. 10.68 s Progress: 0 of 2 built, 474 of 524 downloaded from cache (15 downloading)
  970. 10.68 s Downloading cached unit-user-.service from https://cache.staging.nix-ci.com
  971. 10.68 s Progress: 0 of 2 built, 475 of 524 downloaded from cache (15 downloading)
  972. 10.69 s Downloading cached unit-user-runtime-dir-.service from https://cache.staging.nix-ci.com
  973. 10.69 s Progress: 0 of 2 built, 476 of 524 downloaded from cache (15 downloading)
  974. 10.69 s Progress: 0 of 2 built, 477 of 524 downloaded from cache (15 downloading)
  975. 10.69 s Downloading cached util-linux-2.42-dev from https://cache.staging.nix-ci.com
  976. 10.69 s Progress: 0 of 2 built, 478 of 524 downloaded from cache (14 downloading)
  977. 10.70 s Progress: 0 of 2 built, 479 of 524 downloaded from cache (13 downloading)
  978. 10.70 s Progress: 0 of 2 built, 480 of 524 downloaded from cache (12 downloading)
  979. 10.70 s Progress: 0 of 2 built, 481 of 524 downloaded from cache (11 downloading)
  980. 10.71 s Progress: 0 of 2 built, 482 of 524 downloaded from cache (10 downloading)
  981. 10.71 s Progress: 0 of 2 built, 483 of 524 downloaded from cache (9 downloading)
  982. 10.72 s Progress: 0 of 2 built, 484 of 524 downloaded from cache (8 downloading)
  983. 10.72 s Progress: 0 of 2 built, 485 of 524 downloaded from cache (7 downloading)
  984. 10.72 s Progress: 0 of 2 built, 486 of 524 downloaded from cache (6 downloading)
  985. 10.72 s Progress: 0 of 2 built, 487 of 524 downloaded from cache (5 downloading)
  986. 10.74 s Progress: 0 of 2 built, 488 of 524 downloaded from cache (4 downloading)
  987. 10.76 s Progress: 0 of 2 built, 489 of 524 downloaded from cache (3 downloading)
  988. 12.13 s Progress: 0 of 2 built, 490 of 524 downloaded from cache (2 downloading)
  989. 12.30 s Downloading cached nixos-test-driver from https://cache.staging.nix-ci.com
  990. 12.32 s Progress: 0 of 2 built, 491 of 524 downloaded from cache (2 downloading)
  991. 12.80 s Progress: 0 of 2 built, 492 of 524 downloaded from cache (1 downloading)
  992. 12.80 s Downloading cached linux-6.18.33-modules from https://cache.staging.nix-ci.com
  993. 12.83 s Progress: 0 of 2 built, 493 of 524 downloaded from cache (1 downloading)
  994. 16.42 s Downloading cached boehm-gc from https://cache.staging.nix-ci.com
  995. 16.51 s Progress: 0 of 2 built, 494 of 524 downloaded from cache
  996. 16.51 s Downloading cached nix-expr from https://cache.staging.nix-ci.com
  997. 16.61 s Progress: 0 of 2 built, 495 of 524 downloaded from cache
  998. 16.61 s Downloading cached nix-flake from https://cache.staging.nix-ci.com
  999. 16.65 s Progress: 0 of 2 built, 496 of 524 downloaded from cache
  1000. 16.65 s Downloading cached nix-cmd from https://cache.staging.nix-ci.com
  1001. 16.70 s Progress: 0 of 2 built, 497 of 524 downloaded from cache
  1002. 16.70 s Downloading cached nix from https://cache.staging.nix-ci.com
  1003. 16.78 s Progress: 0 of 2 built, 498 of 524 downloaded from cache
  1004. 16.78 s Downloading cached nix from https://cache.staging.nix-ci.com
  1005. 16.78 s Downloading cached tmpfiles.d from https://cache.staging.nix-ci.com
  1006. 16.81 s Progress: 0 of 2 built, 499 of 524 downloaded from cache (1 downloading)
  1007. 16.81 s Downloading cached nixos-option from https://cache.staging.nix-ci.com
  1008. 16.81 s Downloading cached nixos-rebuild-ng from https://cache.staging.nix-ci.com
  1009. 16.81 s Downloading cached unit-nix-daemon.service from https://cache.staging.nix-ci.com
  1010. 16.81 s Downloading cached unit-nix-optimise.service from https://cache.staging.nix-ci.com
  1011. 16.81 s Downloading cached unit-script-nix-gc-start from https://cache.staging.nix-ci.com
  1012. 16.81 s Downloading cached unit-script-register-nix-paths-start from https://cache.staging.nix-ci.com
  1013. 16.81 s Progress: 0 of 2 built, 500 of 524 downloaded from cache (6 downloading)
  1014. 16.81 s Downloading cached X-Restart-Triggers-systemd-tmpfiles-resetup from https://cache.staging.nix-ci.com
  1015. 16.84 s Progress: 0 of 2 built, 501 of 524 downloaded from cache (6 downloading)
  1016. 16.84 s Progress: 0 of 2 built, 502 of 524 downloaded from cache (5 downloading)
  1017. 16.85 s Progress: 0 of 2 built, 503 of 524 downloaded from cache (4 downloading)
  1018. 16.85 s Progress: 0 of 2 built, 504 of 524 downloaded from cache (3 downloading)
  1019. 16.85 s Downloading cached unit-systemd-tmpfiles-resetup.service from https://cache.staging.nix-ci.com
  1020. 16.85 s Progress: 0 of 2 built, 505 of 524 downloaded from cache (3 downloading)
  1021. 16.85 s Downloading cached system-path from https://cache.staging.nix-ci.com
  1022. 16.85 s Progress: 0 of 2 built, 506 of 524 downloaded from cache (3 downloading)
  1023. 16.85 s Downloading cached unit-register-nix-paths.service from https://cache.staging.nix-ci.com
  1024. 16.85 s Progress: 0 of 2 built, 507 of 524 downloaded from cache (3 downloading)
  1025. 16.85 s Downloading cached unit-nix-gc.service from https://cache.staging.nix-ci.com
  1026. 16.87 s Progress: 0 of 2 built, 508 of 524 downloaded from cache (3 downloading)
  1027. 16.88 s Progress: 0 of 2 built, 509 of 524 downloaded from cache (2 downloading)
  1028. 16.88 s Progress: 0 of 2 built, 510 of 524 downloaded from cache (1 downloading)
  1029. 17.21 s Progress: 0 of 2 built, 511 of 524 downloaded from cache
  1030. 17.29 s Downloading cached dbus from https://cache.staging.nix-ci.com
  1031. 17.29 s Progress: 0 of 2 built, 512 of 524 downloaded from cache
  1032. 17.29 s Downloading cached X-Restart-Triggers-dbus-broker from https://cache.staging.nix-ci.com
  1033. 17.30 s Progress: 0 of 2 built, 513 of 524 downloaded from cache
  1034. 17.30 s Downloading cached unit-dbus-broker.service from https://cache.staging.nix-ci.com
  1035. 17.30 s Downloading cached unit-dbus-broker.service from https://cache.staging.nix-ci.com
  1036. 17.30 s Progress: 0 of 2 built, 514 of 524 downloaded from cache (1 downloading)
  1037. 17.30 s Progress: 0 of 2 built, 515 of 524 downloaded from cache (1 downloading)
  1038. 17.30 s Downloading cached system-units from https://cache.staging.nix-ci.com
  1039. 17.30 s Downloading cached user-units from https://cache.staging.nix-ci.com
  1040. 17.30 s Progress: 0 of 2 built, 516 of 524 downloaded from cache (1 downloading)
  1041. 17.30 s Progress: 0 of 2 built, 517 of 524 downloaded from cache
  1042. 17.30 s Downloading cached etc from https://cache.staging.nix-ci.com
  1043. 17.32 s Progress: 0 of 2 built, 518 of 524 downloaded from cache
  1044. 17.32 s Downloading cached nixos-system-machine-test from https://cache.staging.nix-ci.com
  1045. 17.33 s Progress: 0 of 2 built, 519 of 524 downloaded from cache
  1046. 17.34 s Downloading cached closure-info from https://cache.staging.nix-ci.com
  1047. 17.36 s Progress: 0 of 2 built, 520 of 524 downloaded from cache
  1048. 17.36 s Downloading cached run-nixos-vm from https://cache.staging.nix-ci.com
  1049. 17.37 s Progress: 0 of 2 built, 521 of 524 downloaded from cache
  1050. 17.46 s Downloading cached nixos-vm from https://cache.staging.nix-ci.com
  1051. 17.49 s Progress: 0 of 2 built, 522 of 524 downloaded from cache
  1052. 17.49 s Downloading cached driverConfiguration.json from https://cache.staging.nix-ci.com
  1053. 17.50 s Progress: 0 of 2 built, 523 of 524 downloaded from cache
  1054. 17.50 s Downloading cached nixos-test-driver-dnscheck-module-test from https://cache.staging.nix-ci.com
  1055. 17.51 s Progress: 0 of 2 built, 524 of 524 downloaded from cache
  1056. 17.65 s Building vm-test-run-dnscheck-module-test
  1057. 18.04 s [vm-test-run-dnscheck-module-test] Machine state will be reset. To keep it, pass --keep-machine-state
  1058. 18.04 s [vm-test-run-dnscheck-module-test] start all VLans
  1059. 18.04 s [vm-test-run-dnscheck-module-test] (finished: start all VLans, in 0.00 seconds)
  1060. 18.04 s [vm-test-run-dnscheck-module-test] Test will time out and terminate in 3600 seconds
  1061. 18.04 s [vm-test-run-dnscheck-module-test] run the VM test script
  1062. 18.04 s [vm-test-run-dnscheck-module-test] additionally exposed symbols:
  1063. 18.04 s [vm-test-run-dnscheck-module-test] machine,
  1064. 18.04 s [vm-test-run-dnscheck-module-test] vlan1,
  1065. 18.04 s [vm-test-run-dnscheck-module-test] start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh
  1066. 18.04 s [vm-test-run-dnscheck-module-test] machine: starting vm
  1067. 18.68 s [vm-test-run-dnscheck-module-test] machine # Disk image does not exist, creating the virtualisation disk image...
  1068. 18.68 s [vm-test-run-dnscheck-module-test] machine: QEMU running (pid 12)
  1069. 18.68 s [vm-test-run-dnscheck-module-test] machine # Formatting '/build/vm-state-machine/tmp.ZcoOuvD8nr', fmt=raw size=1073741824
  1070. 18.69 s [vm-test-run-dnscheck-module-test] machine: waiting for unit multi-user.target
  1071. 18.69 s [vm-test-run-dnscheck-module-test] machine # mke2fs 1.47.3 (8-Jul-2025)
  1072. 18.69 s [vm-test-run-dnscheck-module-test] machine: waiting for the VM to finish booting
  1073. 18.69 s [vm-test-run-dnscheck-module-test] machine # Discarding device blocks: 0/262144 done
  1074. 18.69 s [vm-test-run-dnscheck-module-test] machine # Creating filesystem with 262144 4k blocks and 65536 inodes
  1075. 18.69 s [vm-test-run-dnscheck-module-test] machine # Filesystem UUID: a7f0569e-f96b-43d5-a8bc-308bd756e412
  1076. 18.69 s [vm-test-run-dnscheck-module-test] machine # Superblock backups stored on blocks:
  1077. 18.69 s [vm-test-run-dnscheck-module-test] machine # 32768, 98304, 163840, 229376
  1078. 18.69 s [vm-test-run-dnscheck-module-test] machine #
  1079. 18.69 s [vm-test-run-dnscheck-module-test] machine # Allocating group tables: 0/8 done
  1080. 18.69 s [vm-test-run-dnscheck-module-test] machine # Writing inode tables: 0/8 done
  1081. 18.69 s [vm-test-run-dnscheck-module-test] machine # Creating journal (8192 blocks): done
  1082. 18.69 s [vm-test-run-dnscheck-module-test] machine # Writing superblocks and filesystem accounting information: 0/8 done
  1083. 18.69 s [vm-test-run-dnscheck-module-test] machine #
  1084. 18.69 s [vm-test-run-dnscheck-module-test] machine # Virtualisation disk image created.
  1085. 18.89 s [vm-test-run-dnscheck-module-test] machine # c[?7lSeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org)
  1086. 18.99 s [vm-test-run-dnscheck-module-test] machine #
  1087. 18.99 s [vm-test-run-dnscheck-module-test] machine #
  1088. 19.00 s [vm-test-run-dnscheck-module-test] machine # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00
  1089. 19.02 s [vm-test-run-dnscheck-module-test] machine # Press Ctrl-B to configure iPXE (PCI 00:03.0)...
  1090. 19.02 s [vm-test-run-dnscheck-module-test] machine #
  1091. 19.02 s [vm-test-run-dnscheck-module-test] machine #
  1092. 19.02 s [vm-test-run-dnscheck-module-test] machine #
  1093. 19.02 s [vm-test-run-dnscheck-module-test] machine #
  1094. 19.03 s [vm-test-run-dnscheck-module-test] machine # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00
  1095. 19.05 s [vm-test-run-dnscheck-module-test] machine # Press Ctrl-B to configure iPXE (PCI 00:09.0)...
  1096. 19.05 s [vm-test-run-dnscheck-module-test] machine #
  1097. 19.05 s [vm-test-run-dnscheck-module-test] machine #
  1098. 19.08 s [vm-test-run-dnscheck-module-test] machine # Booting from ROM...
  1099. 19.11 s [vm-test-run-dnscheck-module-test] machine # Probing EDD (edd=off to disable)... ok
  1100. 20.30 s [vm-test-run-dnscheck-module-test] machine # c[?7l[ 0.000000] Linux version 6.18.33 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT_DYNAMIC Sat May 23 11:07:21 UTC 2026
  1101. 20.31 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5n1hdyis33xpxcp8sr39dsn9qp75lh4s-nixos-system-machine-test/init regInfo=/nix/store/rqdvxk3g015891l8b0y0q0p0lmnc5pjw-closure-info/registration console=ttyS0,115200n8 console=tty0
  1102. 20.31 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-provided physical RAM map:
  1103. 20.31 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
  1104. 20.31 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
  1105. 20.31 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
  1106. 20.32 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable
  1107. 20.32 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved
  1108. 20.32 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
  1109. 20.32 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
  1110. 20.32 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved
  1111. 20.33 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] NX (Execute Disable) protection: active
  1112. 20.33 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] APIC: Static calls initialized
  1113. 20.33 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] SMBIOS 2.8 present.
  1114. 20.33 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014
  1115. 20.33 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] DMI: Memory slots populated: 1/1
  1116. 20.34 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] Hypervisor detected: KVM
  1117. 20.34 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000
  1118. 20.34 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
  1119. 20.34 s [vm-test-run-dnscheck-module-test] machine # [ 0.000000] kvm-clock: using sched offset of 1243517681 cycles
  1120. 20.34 s [vm-test-run-dnscheck-module-test] machine # [ 0.000002] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
  1121. 20.35 s [vm-test-run-dnscheck-module-test] machine # [ 0.000004] tsc: Detected 3399.998 MHz processor
  1122. 20.35 s [vm-test-run-dnscheck-module-test] machine # [ 0.000654] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000
  1123. 20.35 s [vm-test-run-dnscheck-module-test] machine # [ 0.000865] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs
  1124. 20.35 s [vm-test-run-dnscheck-module-test] machine # [ 0.000873] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT
  1125. 20.35 s [vm-test-run-dnscheck-module-test] machine # [ 0.002769] found SMP MP-table at [mem 0x000f5470-0x000f547f]
  1126. 20.36 s [vm-test-run-dnscheck-module-test] machine # [ 0.002783] Using GB pages for direct mapping
  1127. 20.36 s [vm-test-run-dnscheck-module-test] machine # [ 0.002849] RAMDISK: [mem 0x3e4ef000-0x3ffcffff]
  1128. 20.36 s [vm-test-run-dnscheck-module-test] machine # [ 0.002899] ACPI: Early table checksum verification disabled
  1129. 20.36 s [vm-test-run-dnscheck-module-test] machine # [ 0.002903] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS )
  1130. 20.36 s [vm-test-run-dnscheck-module-test] machine # [ 0.002907] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  1131. 20.37 s [vm-test-run-dnscheck-module-test] machine # [ 0.002912] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  1132. 20.37 s [vm-test-run-dnscheck-module-test] machine # [ 0.002951] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001)
  1133. 20.37 s [vm-test-run-dnscheck-module-test] machine # [ 0.002955] ACPI: FACS 0x000000003FFE0000 000040
  1134. 20.37 s [vm-test-run-dnscheck-module-test] machine # [ 0.002958] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001)
  1135. 20.38 s [vm-test-run-dnscheck-module-test] machine # [ 0.002960] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  1136. 20.38 s [vm-test-run-dnscheck-module-test] machine # [ 0.002963] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001)
  1137. 20.38 s [vm-test-run-dnscheck-module-test] machine # [ 0.002965] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300]
  1138. 20.38 s [vm-test-run-dnscheck-module-test] machine # [ 0.002966] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c]
  1139. 20.39 s [vm-test-run-dnscheck-module-test] machine # [ 0.002967] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f]
  1140. 20.39 s [vm-test-run-dnscheck-module-test] machine # [ 0.002967] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378]
  1141. 20.39 s [vm-test-run-dnscheck-module-test] machine # [ 0.002968] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0]
  1142. 20.39 s [vm-test-run-dnscheck-module-test] machine # [ 0.002969] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8]
  1143. 20.39 s [vm-test-run-dnscheck-module-test] machine # [ 0.003899] No NUMA configuration found
  1144. 20.40 s [vm-test-run-dnscheck-module-test] machine # [ 0.003901] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff]
  1145. 20.40 s [vm-test-run-dnscheck-module-test] machine # [ 0.003903] NODE_DATA(0) allocated [mem 0x3ffd5780-0x3ffdacff]
  1146. 20.40 s [vm-test-run-dnscheck-module-test] machine # [ 0.004223] Zone ranges:
  1147. 20.40 s [vm-test-run-dnscheck-module-test] machine # [ 0.004223] DMA [mem 0x0000000000001000-0x0000000000ffffff]
  1148. 20.40 s [vm-test-run-dnscheck-module-test] machine # [ 0.004225] DMA32 [mem 0x0000000001000000-0x000000003ffdafff]
  1149. 20.40 s [vm-test-run-dnscheck-module-test] machine # [ 0.004226] Normal empty
  1150. 20.41 s [vm-test-run-dnscheck-module-test] machine # [ 0.004226] Device empty
  1151. 20.41 s [vm-test-run-dnscheck-module-test] machine # [ 0.004227] Movable zone start for each node
  1152. 20.41 s [vm-test-run-dnscheck-module-test] machine # [ 0.004227] Early memory node ranges
  1153. 20.41 s [vm-test-run-dnscheck-module-test] machine # [ 0.004228] node 0: [mem 0x0000000000001000-0x000000000009efff]
  1154. 20.41 s [vm-test-run-dnscheck-module-test] machine # [ 0.004229] node 0: [mem 0x0000000000100000-0x000000003ffdafff]
  1155. 20.41 s [vm-test-run-dnscheck-module-test] machine # [ 0.004230] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff]
  1156. 20.42 s [vm-test-run-dnscheck-module-test] machine # [ 0.004297] On node 0, zone DMA: 1 pages in unavailable ranges
  1157. 20.42 s [vm-test-run-dnscheck-module-test] machine # [ 0.005630] On node 0, zone DMA: 97 pages in unavailable ranges
  1158. 20.42 s [vm-test-run-dnscheck-module-test] machine # [ 0.145414] On node 0, zone DMA32: 37 pages in unavailable ranges
  1159. 20.42 s [vm-test-run-dnscheck-module-test] machine # [ 0.147101] ACPI: PM-Timer IO Port: 0x608
  1160. 20.42 s [vm-test-run-dnscheck-module-test] machine # [ 0.147131] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
  1161. 20.43 s [vm-test-run-dnscheck-module-test] machine # [ 0.147227] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
  1162. 20.43 s [vm-test-run-dnscheck-module-test] machine # [ 0.147229] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
  1163. 20.43 s [vm-test-run-dnscheck-module-test] machine # [ 0.147230] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
  1164. 20.43 s [vm-test-run-dnscheck-module-test] machine # [ 0.147231] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
  1165. 20.43 s [vm-test-run-dnscheck-module-test] machine # [ 0.147232] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
  1166. 20.44 s [vm-test-run-dnscheck-module-test] machine # [ 0.147233] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
  1167. 20.44 s [vm-test-run-dnscheck-module-test] machine # [ 0.147235] ACPI: Using ACPI (MADT) for SMP configuration information
  1168. 20.44 s [vm-test-run-dnscheck-module-test] machine # [ 0.147236] ACPI: HPET id: 0x8086a201 base: 0xfed00000
  1169. 20.44 s [vm-test-run-dnscheck-module-test] machine # [ 0.147240] TSC deadline timer available
  1170. 20.44 s [vm-test-run-dnscheck-module-test] machine # [ 0.147244] CPU topo: Max. logical packages: 1
  1171. 20.44 s [vm-test-run-dnscheck-module-test] machine # [ 0.147245] CPU topo: Max. logical dies: 1
  1172. 20.45 s [vm-test-run-dnscheck-module-test] machine # [ 0.147245] CPU topo: Max. dies per package: 1
  1173. 20.45 s [vm-test-run-dnscheck-module-test] machine # [ 0.147248] CPU topo: Max. threads per core: 1
  1174. 20.45 s [vm-test-run-dnscheck-module-test] machine # [ 0.147249] CPU topo: Num. cores per package: 1
  1175. 20.45 s [vm-test-run-dnscheck-module-test] machine # [ 0.147249] CPU topo: Num. threads per package: 1
  1176. 20.45 s [vm-test-run-dnscheck-module-test] machine # [ 0.147249] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs
  1177. 20.46 s [vm-test-run-dnscheck-module-test] machine # [ 0.147283] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write()
  1178. 20.46 s [vm-test-run-dnscheck-module-test] machine # [ 0.147372] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff]
  1179. 20.46 s [vm-test-run-dnscheck-module-test] machine # [ 0.147373] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff]
  1180. 20.46 s [vm-test-run-dnscheck-module-test] machine # [ 0.147374] [mem 0x40000000-0xfeffbfff] available for PCI devices
  1181. 20.46 s [vm-test-run-dnscheck-module-test] machine # [ 0.147376] Booting paravirtualized kernel on KVM
  1182. 20.47 s [vm-test-run-dnscheck-module-test] machine # [ 0.147379] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
  1183. 20.47 s [vm-test-run-dnscheck-module-test] machine # [ 0.151121] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1
  1184. 20.47 s [vm-test-run-dnscheck-module-test] machine # [ 0.168291] percpu: Embedded 98 pages/cpu s278528 r8192 d114688 u2097152
  1185. 20.47 s [vm-test-run-dnscheck-module-test] machine # [ 0.168410] kvm-guest: PV spinlocks disabled, single CPU
  1186. 20.48 s [vm-test-run-dnscheck-module-test] machine # [ 0.168412] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/5n1hdyis33xpxcp8sr39dsn9qp75lh4s-nixos-system-machine-test/init regInfo=/nix/store/rqdvxk3g015891l8b0y0q0p0lmnc5pjw-closure-info/registration console=ttyS0,115200n8 console=tty0
  1187. 20.49 s [vm-test-run-dnscheck-module-test] machine # [ 0.168513] Unknown kernel command line parameters "regInfo=/nix/store/rqdvxk3g015891l8b0y0q0p0lmnc5pjw-closure-info/registration", will be passed to user space.
  1188. 20.49 s [vm-test-run-dnscheck-module-test] machine # [ 0.168528] random: crng init done
  1189. 20.49 s [vm-test-run-dnscheck-module-test] machine # [ 0.168528] printk: log buffer data + meta data: 262144 + 917504 = 1179648 bytes
  1190. 20.49 s [vm-test-run-dnscheck-module-test] machine # [ 0.168571] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)
  1191. 20.50 s [vm-test-run-dnscheck-module-test] machine # [ 0.171449] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)
  1192. 20.50 s [vm-test-run-dnscheck-module-test] machine # [ 0.171536] Fallback order for Node 0: 0
  1193. 20.50 s [vm-test-run-dnscheck-module-test] machine # [ 0.171538] Built 1 zonelists, mobility grouping on. Total pages: 262009
  1194. 20.50 s [vm-test-run-dnscheck-module-test] machine # [ 0.171539] Policy zone: DMA32
  1195. 20.50 s [vm-test-run-dnscheck-module-test] machine # [ 0.190667] mem auto-init: stack:all(zero), heap alloc:on, heap free:off
  1196. 20.51 s [vm-test-run-dnscheck-module-test] machine # [ 0.195731] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
  1197. 20.51 s [vm-test-run-dnscheck-module-test] machine # [ 0.212111] allocated 2097152 bytes of page_ext
  1198. 20.51 s [vm-test-run-dnscheck-module-test] machine # [ 0.227545] ftrace: allocating 48552 entries in 192 pages
  1199. 20.51 s [vm-test-run-dnscheck-module-test] machine # [ 0.227547] ftrace: allocated 192 pages with 2 groups
  1200. 20.51 s [vm-test-run-dnscheck-module-test] machine # [ 0.231715] Dynamic Preempt: lazy
  1201. 20.51 s [vm-test-run-dnscheck-module-test] machine # [ 0.233156] rcu: Preemptible hierarchical RCU implementation.
  1202. 20.52 s [vm-test-run-dnscheck-module-test] machine # [ 0.233157] rcu: RCU event tracing is enabled.
  1203. 20.52 s [vm-test-run-dnscheck-module-test] machine # [ 0.233158] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
  1204. 20.52 s [vm-test-run-dnscheck-module-test] machine # [ 0.233159] Trampoline variant of Tasks RCU enabled.
  1205. 20.52 s [vm-test-run-dnscheck-module-test] machine # [ 0.233159] Rude variant of Tasks RCU enabled.
  1206. 20.52 s [vm-test-run-dnscheck-module-test] machine # [ 0.233160] Tracing variant of Tasks RCU enabled.
  1207. 20.53 s [vm-test-run-dnscheck-module-test] machine # [ 0.233160] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies.
  1208. 20.53 s [vm-test-run-dnscheck-module-test] machine # [ 0.233161] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
  1209. 20.53 s [vm-test-run-dnscheck-module-test] machine # [ 0.233306] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  1210. 20.53 s [vm-test-run-dnscheck-module-test] machine # [ 0.233307] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  1211. 20.54 s [vm-test-run-dnscheck-module-test] machine # [ 0.233308] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.
  1212. 20.54 s [vm-test-run-dnscheck-module-test] machine # [ 0.241347] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
  1213. 20.54 s [vm-test-run-dnscheck-module-test] machine # [ 0.242136] rcu: srcu_init: Setting srcu_struct sizes based on contention.
  1214. 20.54 s [vm-test-run-dnscheck-module-test] machine # [ 0.242244] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)
  1215. 20.54 s [vm-test-run-dnscheck-module-test] machine # [ 0.256332] Console: colour VGA+ 80x25
  1216. 20.55 s [vm-test-run-dnscheck-module-test] machine # [ 0.256335] printk: legacy console [tty0] enabled
  1217. 20.55 s [vm-test-run-dnscheck-module-test] machine # [ 0.364186] printk: legacy console [ttyS0] enabled
  1218. 20.55 s [vm-test-run-dnscheck-module-test] machine # [ 0.622509] ACPI: Core revision 20250807
  1219. 20.56 s [vm-test-run-dnscheck-module-test] machine # [ 0.625180] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
  1220. 20.56 s [vm-test-run-dnscheck-module-test] machine # [ 0.629625] APIC: Switch to symmetric I/O mode setup
  1221. 20.56 s [vm-test-run-dnscheck-module-test] machine # [ 0.632943] x2apic enabled
  1222. 20.56 s [vm-test-run-dnscheck-module-test] machine # [ 0.635336] APIC: Switched APIC routing to: physical x2apic
  1223. 20.94 s [vm-test-run-dnscheck-module-test] machine # [ 1.009385] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
  1224. 20.94 s [vm-test-run-dnscheck-module-test] machine # [ 1.012316] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns
  1225. 20.95 s [vm-test-run-dnscheck-module-test] machine # [ 1.017637] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399998)
  1226. 20.95 s [vm-test-run-dnscheck-module-test] machine # [ 1.020648] x86/cpu: User Mode Instruction Prevention (UMIP) activated
  1227. 20.96 s [vm-test-run-dnscheck-module-test] machine # [ 1.022715] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127
  1228. 20.96 s [vm-test-run-dnscheck-module-test] machine # [ 1.023634] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0
  1229. 20.96 s [vm-test-run-dnscheck-module-test] machine # [ 1.025649] mitigations: Enabled attack vectors: user_kernel, user_user, guest_host, guest_guest, SMT mitigations: auto
  1230. 20.97 s [vm-test-run-dnscheck-module-test] machine # [ 1.027634] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl
  1231. 20.97 s [vm-test-run-dnscheck-module-test] machine # [ 1.029634] Transient Scheduler Attacks: Vulnerable: No microcode
  1232. 20.97 s [vm-test-run-dnscheck-module-test] machine # [ 1.031634] Spectre V2 : Mitigation: Retpolines
  1233. 20.98 s [vm-test-run-dnscheck-module-test] machine # [ 1.033634] Speculative Return Stack Overflow: Mitigation: Safe RET
  1234. 20.98 s [vm-test-run-dnscheck-module-test] machine # [ 1.035634] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization
  1235. 20.98 s [vm-test-run-dnscheck-module-test] machine # [ 1.037634] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT
  1236. 20.99 s [vm-test-run-dnscheck-module-test] machine # [ 1.039634] Spectre V2 : Enabling Restricted Speculation for firmware calls
  1237. 20.99 s [vm-test-run-dnscheck-module-test] machine # [ 1.041636] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier
  1238. 20.99 s [vm-test-run-dnscheck-module-test] machine # [ 1.043634] active return thunk: srso_alias_return_thunk
  1239. 21.01 s [vm-test-run-dnscheck-module-test] machine # [ 1.044718] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
  1240. 21.01 s [vm-test-run-dnscheck-module-test] machine # [ 1.046634] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
  1241. 21.02 s [vm-test-run-dnscheck-module-test] machine # [ 1.048635] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
  1242. 21.02 s [vm-test-run-dnscheck-module-test] machine # [ 1.050637] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers'
  1243. 21.02 s [vm-test-run-dnscheck-module-test] machine # [ 1.052634] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
  1244. 21.03 s [vm-test-run-dnscheck-module-test] machine # [ 1.054634] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8
  1245. 21.03 s [vm-test-run-dnscheck-module-test] machine # [ 1.056633] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format.
  1246. 21.06 s [vm-test-run-dnscheck-module-test] machine # [ 1.086155] Freeing SMP alternatives memory: 44K
  1247. 21.06 s [vm-test-run-dnscheck-module-test] machine # [ 1.087635] pid_max: default: 32768 minimum: 301
  1248. 21.06 s [vm-test-run-dnscheck-module-test] machine # [ 1.089777] LSM: initializing lsm=capability,landlock,yama,bpf,ima
  1249. 21.07 s [vm-test-run-dnscheck-module-test] machine # [ 1.091766] landlock: Up and running.
  1250. 21.07 s [vm-test-run-dnscheck-module-test] machine # [ 1.092634] Yama: becoming mindful.
  1251. 21.07 s [vm-test-run-dnscheck-module-test] machine # [ 1.093832] LSM support for eBPF active
  1252. 21.07 s [vm-test-run-dnscheck-module-test] machine # [ 1.094905] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
  1253. 21.08 s [vm-test-run-dnscheck-module-test] machine # [ 1.097729] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)
  1254. 21.09 s [vm-test-run-dnscheck-module-test] machine # [ 1.104825] smpboot: CPU0: AMD Ryzen 9 5950X 16-Core Processor (family: 0x19, model: 0x21, stepping: 0x0)
  1255. 21.09 s [vm-test-run-dnscheck-module-test] machine # [ 1.109468] Performance Events: Fam17h+ core perfctr, AMD PMU driver.
  1256. 21.09 s [vm-test-run-dnscheck-module-test] machine # [ 1.110650] ... version: 0
  1257. 21.10 s [vm-test-run-dnscheck-module-test] machine # [ 1.111657] ... bit width: 48
  1258. 21.10 s [vm-test-run-dnscheck-module-test] machine # [ 1.112644] ... generic counters: 6
  1259. 21.10 s [vm-test-run-dnscheck-module-test] machine # [ 1.113642] ... generic bitmap: 000000000000003f
  1260. 21.10 s [vm-test-run-dnscheck-module-test] machine # [ 1.114643] ... fixed-purpose counters: 0
  1261. 21.11 s [vm-test-run-dnscheck-module-test] machine # [ 1.115645] ... fixed-purpose bitmap: 0000000000000000
  1262. 21.11 s [vm-test-run-dnscheck-module-test] machine # [ 1.116644] ... value mask: 0000ffffffffffff
  1263. 21.11 s [vm-test-run-dnscheck-module-test] machine # [ 1.117642] ... max period: 00007fffffffffff
  1264. 21.11 s [vm-test-run-dnscheck-module-test] machine # [ 1.118645] ... global_ctrl mask: 000000000000003f
  1265. 21.12 s [vm-test-run-dnscheck-module-test] machine # [ 1.119797] signal: max sigframe size: 3376
  1266. 21.12 s [vm-test-run-dnscheck-module-test] machine # [ 1.121056] rcu: Hierarchical SRCU implementation.
  1267. 21.12 s [vm-test-run-dnscheck-module-test] machine # [ 1.122646] rcu: Max phase no-delay instances is 400.
  1268. 21.13 s [vm-test-run-dnscheck-module-test] machine # [ 1.129429] smp: Bringing up secondary CPUs ...
  1269. 21.13 s [vm-test-run-dnscheck-module-test] machine # [ 1.130654] smp: Brought up 1 node, 1 CPU
  1270. 21.14 s [vm-test-run-dnscheck-module-test] machine # [ 1.131648] smpboot: Total of 1 processors activated (6799.99 BogoMIPS)
  1271. 21.14 s [vm-test-run-dnscheck-module-test] machine # [ 1.133360] Memory: 944800K/1048036K available (17094K kernel code, 2721K rwdata, 13512K rodata, 3644K init, 3008K bss, 96028K reserved, 0K cma-reserved)
  1272. 21.15 s [vm-test-run-dnscheck-module-test] machine # [ 1.135412] devtmpfs: initialized
  1273. 21.15 s [vm-test-run-dnscheck-module-test] machine # [ 1.137759] x86/mm: Memory block size: 128MB
  1274. 21.16 s [vm-test-run-dnscheck-module-test] machine # [ 1.140875] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
  1275. 21.16 s [vm-test-run-dnscheck-module-test] machine # [ 1.142749] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)
  1276. 21.16 s [vm-test-run-dnscheck-module-test] machine # [ 1.144832] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).
  1277. 21.17 s [vm-test-run-dnscheck-module-test] machine # [ 1.146793] pinctrl core: initialized pinctrl subsystem
  1278. 21.17 s [vm-test-run-dnscheck-module-test] machine # [ 1.148392] PM: RTC time: 11:15:57, date: 2026-06-01
  1279. 21.19 s [vm-test-run-dnscheck-module-test] machine # [ 1.166960] NET: Registered PF_NETLINK/PF_ROUTE protocol family
  1280. 21.19 s [vm-test-run-dnscheck-module-test] machine # [ 1.169792] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations
  1281. 21.20 s [vm-test-run-dnscheck-module-test] machine # [ 1.171693] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations
  1282. 21.20 s [vm-test-run-dnscheck-module-test] machine # [ 1.174303] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations
  1283. 21.20 s [vm-test-run-dnscheck-module-test] machine # [ 1.175650] audit: initializing netlink subsys (disabled)
  1284. 21.21 s [vm-test-run-dnscheck-module-test] machine # [ 1.177318] thermal_sys: Registered thermal governor 'fair_share'
  1285. 21.21 s [vm-test-run-dnscheck-module-test] machine # [ 1.177320] thermal_sys: Registered thermal governor 'bang_bang'
  1286. 21.22 s [vm-test-run-dnscheck-module-test] machine # [ 1.178645] audit: type=2000 audit(1780312557.579:1): state=initialized audit_enabled=0 res=1
  1287. 21.22 s [vm-test-run-dnscheck-module-test] machine # [ 1.181645] thermal_sys: Registered thermal governor 'step_wise'
  1288. 21.22 s [vm-test-run-dnscheck-module-test] machine # [ 1.181646] thermal_sys: Registered thermal governor 'user_space'
  1289. 21.22 s [vm-test-run-dnscheck-module-test] machine # [ 1.182643] thermal_sys: Registered thermal governor 'power_allocator'
  1290. 21.23 s [vm-test-run-dnscheck-module-test] machine # [ 1.183658] cpuidle: using governor menu
  1291. 21.23 s [vm-test-run-dnscheck-module-test] machine # [ 1.187509] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
  1292. 21.23 s [vm-test-run-dnscheck-module-test] machine # [ 1.189549] PCI: Using configuration type 1 for base access
  1293. 21.24 s [vm-test-run-dnscheck-module-test] machine # [ 1.190642] PCI: Using configuration type 1 for extended access
  1294. 21.24 s [vm-test-run-dnscheck-module-test] machine # [ 1.192603] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible.
  1295. 21.26 s [vm-test-run-dnscheck-module-test] machine # [ 1.203895] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages
  1296. 21.26 s [vm-test-run-dnscheck-module-test] machine # [ 1.209643] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page
  1297. 21.27 s [vm-test-run-dnscheck-module-test] machine # [ 1.210642] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages
  1298. 21.27 s [vm-test-run-dnscheck-module-test] machine # [ 1.215447] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page
  1299. 21.28 s [vm-test-run-dnscheck-module-test] machine # [ 1.225077] ACPI: Added _OSI(Module Device)
  1300. 21.29 s [vm-test-run-dnscheck-module-test] machine # [ 1.230643] ACPI: Added _OSI(Processor Device)
  1301. 21.29 s [vm-test-run-dnscheck-module-test] machine # [ 1.231643] ACPI: Added _OSI(Processor Aggregator Device)
  1302. 21.30 s [vm-test-run-dnscheck-module-test] machine # [ 1.237399] ACPI: 1 ACPI AML tables successfully acquired and loaded
  1303. 21.31 s [vm-test-run-dnscheck-module-test] machine # [ 1.240645] ACPI: Interpreter enabled
  1304. 21.31 s [vm-test-run-dnscheck-module-test] machine # [ 1.241655] ACPI: PM: (supports S0 S3 S4 S5)
  1305. 21.31 s [vm-test-run-dnscheck-module-test] machine # [ 1.242642] ACPI: Using IOAPIC for interrupt routing
  1306. 21.31 s [vm-test-run-dnscheck-module-test] machine # [ 1.243656] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
  1307. 21.32 s [vm-test-run-dnscheck-module-test] machine # [ 1.245642] PCI: Using E820 reservations for host bridge windows
  1308. 21.32 s [vm-test-run-dnscheck-module-test] machine # [ 1.246792] ACPI: Enabled 2 GPEs in block 00 to 0F
  1309. 21.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.255781] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
  1310. 21.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.257646] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3]
  1311. 21.34 s [vm-test-run-dnscheck-module-test] machine # [ 1.260230] acpiphp: Slot [3] registered
  1312. 21.34 s [vm-test-run-dnscheck-module-test] machine # [ 1.261739] acpiphp: Slot [4] registered
  1313. 21.34 s [vm-test-run-dnscheck-module-test] machine # [ 1.262682] acpiphp: Slot [5] registered
  1314. 21.34 s [vm-test-run-dnscheck-module-test] machine # [ 1.263682] acpiphp: Slot [6] registered
  1315. 21.35 s [vm-test-run-dnscheck-module-test] machine # [ 1.264682] acpiphp: Slot [7] registered
  1316. 21.35 s [vm-test-run-dnscheck-module-test] machine # [ 1.265739] acpiphp: Slot [8] registered
  1317. 21.35 s [vm-test-run-dnscheck-module-test] machine # [ 1.266682] acpiphp: Slot [9] registered
  1318. 21.35 s [vm-test-run-dnscheck-module-test] machine # [ 1.267682] acpiphp: Slot [10] registered
  1319. 21.35 s [vm-test-run-dnscheck-module-test] machine # [ 1.268688] acpiphp: Slot [11] registered
  1320. 21.36 s [vm-test-run-dnscheck-module-test] machine # [ 1.269740] acpiphp: Slot [12] registered
  1321. 21.36 s [vm-test-run-dnscheck-module-test] machine # [ 1.270680] acpiphp: Slot [13] registered
  1322. 21.36 s [vm-test-run-dnscheck-module-test] machine # [ 1.271681] acpiphp: Slot [14] registered
  1323. 21.36 s [vm-test-run-dnscheck-module-test] machine # [ 1.272681] acpiphp: Slot [15] registered
  1324. 21.36 s [vm-test-run-dnscheck-module-test] machine # [ 1.273739] acpiphp: Slot [16] registered
  1325. 21.37 s [vm-test-run-dnscheck-module-test] machine # [ 1.274682] acpiphp: Slot [17] registered
  1326. 21.37 s [vm-test-run-dnscheck-module-test] machine # [ 1.275682] acpiphp: Slot [18] registered
  1327. 21.37 s [vm-test-run-dnscheck-module-test] machine # [ 1.276762] acpiphp: Slot [19] registered
  1328. 21.37 s [vm-test-run-dnscheck-module-test] machine # [ 1.277682] acpiphp: Slot [20] registered
  1329. 21.37 s [vm-test-run-dnscheck-module-test] machine # [ 1.278681] acpiphp: Slot [21] registered
  1330. 21.38 s [vm-test-run-dnscheck-module-test] machine # [ 1.279679] acpiphp: Slot [22] registered
  1331. 21.38 s [vm-test-run-dnscheck-module-test] machine # [ 1.280738] acpiphp: Slot [23] registered
  1332. 21.38 s [vm-test-run-dnscheck-module-test] machine # [ 1.281679] acpiphp: Slot [24] registered
  1333. 21.38 s [vm-test-run-dnscheck-module-test] machine # [ 1.282681] acpiphp: Slot [25] registered
  1334. 21.38 s [vm-test-run-dnscheck-module-test] machine # [ 1.283679] acpiphp: Slot [26] registered
  1335. 21.39 s [vm-test-run-dnscheck-module-test] machine # [ 1.284798] acpiphp: Slot [27] registered
  1336. 21.39 s [vm-test-run-dnscheck-module-test] machine # [ 1.285737] acpiphp: Slot [28] registered
  1337. 21.39 s [vm-test-run-dnscheck-module-test] machine # [ 1.286682] acpiphp: Slot [29] registered
  1338. 21.39 s [vm-test-run-dnscheck-module-test] machine # [ 1.287699] acpiphp: Slot [30] registered
  1339. 21.40 s [vm-test-run-dnscheck-module-test] machine # [ 1.288739] acpiphp: Slot [31] registered
  1340. 21.40 s [vm-test-run-dnscheck-module-test] machine # [ 1.289671] PCI host bridge to bus 0000:00
  1341. 21.40 s [vm-test-run-dnscheck-module-test] machine # [ 1.290647] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
  1342. 21.40 s [vm-test-run-dnscheck-module-test] machine # [ 1.291643] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
  1343. 21.41 s [vm-test-run-dnscheck-module-test] machine # [ 1.293643] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
  1344. 21.41 s [vm-test-run-dnscheck-module-test] machine # [ 1.295643] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window]
  1345. 21.41 s [vm-test-run-dnscheck-module-test] machine # [ 1.297643] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
  1346. 21.42 s [vm-test-run-dnscheck-module-test] machine # [ 1.299643] pci_bus 0000:00: root bus resource [bus 00-ff]
  1347. 21.42 s [vm-test-run-dnscheck-module-test] machine # [ 1.301378] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint
  1348. 21.43 s [vm-test-run-dnscheck-module-test] machine # [ 1.304145] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint
  1349. 21.43 s [vm-test-run-dnscheck-module-test] machine # [ 1.307137] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint
  1350. 21.44 s [vm-test-run-dnscheck-module-test] machine # [ 1.310229] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef]
  1351. 21.44 s [vm-test-run-dnscheck-module-test] machine # [ 1.311778] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk
  1352. 21.44 s [vm-test-run-dnscheck-module-test] machine # [ 1.313643] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk
  1353. 21.45 s [vm-test-run-dnscheck-module-test] machine # [ 1.314643] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk
  1354. 21.45 s [vm-test-run-dnscheck-module-test] machine # [ 1.316643] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk
  1355. 21.45 s [vm-test-run-dnscheck-module-test] machine # [ 1.318330] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint
  1356. 21.46 s [vm-test-run-dnscheck-module-test] machine # [ 1.321180] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f]
  1357. 21.46 s [vm-test-run-dnscheck-module-test] machine # [ 1.324064] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint
  1358. 21.47 s [vm-test-run-dnscheck-module-test] machine # [ 1.326717] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
  1359. 21.47 s [vm-test-run-dnscheck-module-test] machine # [ 1.328667] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
  1360. 21.47 s [vm-test-run-dnscheck-module-test] machine # [ 1.330298] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint
  1361. 21.49 s [vm-test-run-dnscheck-module-test] machine # [ 1.334166] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref]
  1362. 21.49 s [vm-test-run-dnscheck-module-test] machine # [ 1.335687] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff]
  1363. 21.50 s [vm-test-run-dnscheck-module-test] machine # [ 1.336843] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref]
  1364. 21.50 s [vm-test-run-dnscheck-module-test] machine # [ 1.340478] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
  1365. 21.51 s [vm-test-run-dnscheck-module-test] machine # [ 1.347347] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
  1366. 21.52 s [vm-test-run-dnscheck-module-test] machine # [ 1.350667] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f]
  1367. 21.52 s [vm-test-run-dnscheck-module-test] machine # [ 1.352670] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff]
  1368. 21.52 s [vm-test-run-dnscheck-module-test] machine # [ 1.353762] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref]
  1369. 21.53 s [vm-test-run-dnscheck-module-test] machine # [ 1.355666] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref]
  1370. 21.53 s [vm-test-run-dnscheck-module-test] machine # [ 1.360707] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
  1371. 21.54 s [vm-test-run-dnscheck-module-test] machine # [ 1.364665] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f]
  1372. 21.54 s [vm-test-run-dnscheck-module-test] machine # [ 1.365666] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff]
  1373. 21.55 s [vm-test-run-dnscheck-module-test] machine # [ 1.366743] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref]
  1374. 21.55 s [vm-test-run-dnscheck-module-test] machine # [ 1.371626] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  1375. 21.56 s [vm-test-run-dnscheck-module-test] machine # [ 1.375665] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf]
  1376. 21.56 s [vm-test-run-dnscheck-module-test] machine # [ 1.376665] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff]
  1377. 21.56 s [vm-test-run-dnscheck-module-test] machine # [ 1.377737] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref]
  1378. 21.57 s [vm-test-run-dnscheck-module-test] machine # [ 1.382846] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  1379. 21.58 s [vm-test-run-dnscheck-module-test] machine # [ 1.386666] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f]
  1380. 21.58 s [vm-test-run-dnscheck-module-test] machine # [ 1.387666] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff]
  1381. 21.58 s [vm-test-run-dnscheck-module-test] machine # [ 1.388750] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref]
  1382. 21.59 s [vm-test-run-dnscheck-module-test] machine # [ 1.393432] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint
  1383. 21.59 s [vm-test-run-dnscheck-module-test] machine # [ 1.396666] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f]
  1384. 21.60 s [vm-test-run-dnscheck-module-test] machine # [ 1.397666] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff]
  1385. 21.60 s [vm-test-run-dnscheck-module-test] machine # [ 1.398743] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref]
  1386. 21.62 s [vm-test-run-dnscheck-module-test] machine # [ 1.403411] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint
  1387. 21.62 s [vm-test-run-dnscheck-module-test] machine # [ 1.406679] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f]
  1388. 21.63 s [vm-test-run-dnscheck-module-test] machine # [ 1.407667] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff]
  1389. 21.63 s [vm-test-run-dnscheck-module-test] machine # [ 1.408733] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref]
  1390. 21.64 s [vm-test-run-dnscheck-module-test] machine # [ 1.413549] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint
  1391. 21.64 s [vm-test-run-dnscheck-module-test] machine # [ 1.416667] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf]
  1392. 21.64 s [vm-test-run-dnscheck-module-test] machine # [ 1.417668] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff]
  1393. 21.65 s [vm-test-run-dnscheck-module-test] machine # [ 1.418734] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref]
  1394. 21.65 s [vm-test-run-dnscheck-module-test] machine # [ 1.420749] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref]
  1395. 21.66 s [vm-test-run-dnscheck-module-test] machine # [ 1.427584] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint
  1396. 21.67 s [vm-test-run-dnscheck-module-test] machine # [ 1.430686] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff]
  1397. 21.67 s [vm-test-run-dnscheck-module-test] machine # [ 1.431731] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref]
  1398. 21.68 s [vm-test-run-dnscheck-module-test] machine # [ 1.436606] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint
  1399. 21.68 s [vm-test-run-dnscheck-module-test] machine # [ 1.439666] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff]
  1400. 21.68 s [vm-test-run-dnscheck-module-test] machine # [ 1.440711] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff]
  1401. 21.69 s [vm-test-run-dnscheck-module-test] machine # [ 1.441748] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref]
  1402. 21.69 s [vm-test-run-dnscheck-module-test] machine # [ 1.446686] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint
  1403. 21.70 s [vm-test-run-dnscheck-module-test] machine # [ 1.450666] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df]
  1404. 21.70 s [vm-test-run-dnscheck-module-test] machine # [ 1.451666] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff]
  1405. 21.71 s [vm-test-run-dnscheck-module-test] machine # [ 1.452725] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref]
  1406. 21.72 s [vm-test-run-dnscheck-module-test] machine # [ 1.466776] ACPI: PCI: Interrupt link LNKA configured for IRQ 10
  1407. 21.73 s [vm-test-run-dnscheck-module-test] machine # [ 1.467937] ACPI: PCI: Interrupt link LNKB configured for IRQ 10
  1408. 21.73 s [vm-test-run-dnscheck-module-test] machine # [ 1.469870] ACPI: PCI: Interrupt link LNKC configured for IRQ 11
  1409. 21.73 s [vm-test-run-dnscheck-module-test] machine # [ 1.471861] ACPI: PCI: Interrupt link LNKD configured for IRQ 11
  1410. 21.74 s [vm-test-run-dnscheck-module-test] machine # [ 1.473772] ACPI: PCI: Interrupt link LNKS configured for IRQ 9
  1411. 21.74 s [vm-test-run-dnscheck-module-test] machine # [ 1.480991] iommu: Default domain type: Translated
  1412. 21.75 s [vm-test-run-dnscheck-module-test] machine # [ 1.482675] iommu: DMA domain TLB invalidation policy: lazy mode
  1413. 21.75 s [vm-test-run-dnscheck-module-test] machine # [ 1.485823] ACPI: bus type USB registered
  1414. 21.75 s [vm-test-run-dnscheck-module-test] machine # [ 1.486977] usbcore: registered new interface driver usbfs
  1415. 21.76 s [vm-test-run-dnscheck-module-test] machine # [ 1.488780] usbcore: registered new interface driver hub
  1416. 21.76 s [vm-test-run-dnscheck-module-test] machine # [ 1.489651] usbcore: registered new device driver usb
  1417. 21.77 s [vm-test-run-dnscheck-module-test] machine # [ 1.495056] NetLabel: Initializing
  1418. 21.77 s [vm-test-run-dnscheck-module-test] machine # [ 1.496642] NetLabel: domain hash size = 128
  1419. 21.77 s [vm-test-run-dnscheck-module-test] machine # [ 1.497642] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
  1420. 21.77 s [vm-test-run-dnscheck-module-test] machine # [ 1.498854] NetLabel: unlabeled traffic allowed by default
  1421. 21.78 s [vm-test-run-dnscheck-module-test] machine # [ 1.500704] PCI: Using ACPI for IRQ routing
  1422. 21.78 s [vm-test-run-dnscheck-module-test] machine # [ 1.503773] pci 0000:00:02.0: vgaarb: setting as boot VGA device
  1423. 21.78 s [vm-test-run-dnscheck-module-test] machine # [ 1.504631] pci 0000:00:02.0: vgaarb: bridge control possible
  1424. 21.79 s [vm-test-run-dnscheck-module-test] machine # [ 1.504631] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
  1425. 21.79 s [vm-test-run-dnscheck-module-test] machine # [ 1.504644] vgaarb: loaded
  1426. 21.79 s [vm-test-run-dnscheck-module-test] machine # [ 1.507324] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
  1427. 21.80 s [vm-test-run-dnscheck-module-test] machine # [ 1.508642] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
  1428. 21.80 s [vm-test-run-dnscheck-module-test] machine # [ 1.513102] clocksource: Switched to clocksource kvm-clock
  1429. 21.82 s [vm-test-run-dnscheck-module-test] machine # [ 1.525853] VFS: Disk quotas dquot_6.6.0
  1430. 21.82 s [vm-test-run-dnscheck-module-test] machine # [ 1.530874] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
  1431. 21.83 s [vm-test-run-dnscheck-module-test] machine # [ 1.537408] pnp: PnP ACPI init
  1432. 21.83 s [vm-test-run-dnscheck-module-test] machine # [ 1.540722] pnp: PnP ACPI: found 6 devices
  1433. 21.85 s [vm-test-run-dnscheck-module-test] machine # [ 1.556156] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
  1434. 21.85 s [vm-test-run-dnscheck-module-test] machine # [ 1.560369] clocksource: Switched to clocksource acpi_pm
  1435. 21.85 s [vm-test-run-dnscheck-module-test] machine # [ 1.563437] NET: Registered PF_INET protocol family
  1436. 21.86 s [vm-test-run-dnscheck-module-test] machine # [ 1.566916] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)
  1437. 21.94 s [vm-test-run-dnscheck-module-test] machine # [ 1.644323] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)
  1438. 21.94 s [vm-test-run-dnscheck-module-test] machine # [ 1.649182] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)
  1439. 21.94 s [vm-test-run-dnscheck-module-test] machine # [ 1.653208] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)
  1440. 21.95 s [vm-test-run-dnscheck-module-test] machine # [ 1.657083] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)
  1441. 21.95 s [vm-test-run-dnscheck-module-test] machine # [ 1.660695] TCP: Hash tables configured (established 8192 bind 8192)
  1442. 21.96 s [vm-test-run-dnscheck-module-test] machine # [ 1.664433] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)
  1443. 21.96 s [vm-test-run-dnscheck-module-test] machine # [ 1.669064] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)
  1444. 21.96 s [vm-test-run-dnscheck-module-test] machine # [ 1.673141] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)
  1445. 21.97 s [vm-test-run-dnscheck-module-test] machine # [ 1.677153] NET: Registered PF_UNIX/PF_LOCAL protocol family
  1446. 21.97 s [vm-test-run-dnscheck-module-test] machine # [ 1.680413] NET: Registered PF_XDP protocol family
  1447. 21.97 s [vm-test-run-dnscheck-module-test] machine # [ 1.683623] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
  1448. 21.98 s [vm-test-run-dnscheck-module-test] machine # [ 1.687089] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
  1449. 21.98 s [vm-test-run-dnscheck-module-test] machine # [ 1.690684] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
  1450. 22.00 s [vm-test-run-dnscheck-module-test] machine # [ 1.694092] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window]
  1451. 22.01 s [vm-test-run-dnscheck-module-test] machine # [ 1.715225] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]
  1452. 22.01 s [vm-test-run-dnscheck-module-test] machine # [ 1.719587] pci 0000:00:01.0: PIIX3: Enabling Passive Release
  1453. 22.01 s [vm-test-run-dnscheck-module-test] machine # [ 1.722825] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
  1454. 22.02 s [vm-test-run-dnscheck-module-test] machine # [ 1.729055] ACPI: \_SB_.LNKD: Enabled at IRQ 11
  1455. 22.02 s [vm-test-run-dnscheck-module-test] machine # [ 1.733680] PCI: CLS 0 bytes, default 64
  1456. 22.03 s [vm-test-run-dnscheck-module-test] machine # [ 1.737257] Trying to unpack rootfs image as initramfs...
  1457. 22.04 s [vm-test-run-dnscheck-module-test] machine # [ 1.746589] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns
  1458. 22.09 s [vm-test-run-dnscheck-module-test] machine # [ 1.795661] Initialise system trusted keyrings
  1459. 22.10 s [vm-test-run-dnscheck-module-test] machine # [ 1.804893] workingset: timestamp_bits=40 max_order=18 bucket_order=0
  1460. 22.12 s [vm-test-run-dnscheck-module-test] machine # [ 1.834882] Key type asymmetric registered
  1461. 22.13 s [vm-test-run-dnscheck-module-test] machine # [ 1.841637] Asymmetric key parser 'x509' registered
  1462. 22.14 s [vm-test-run-dnscheck-module-test] machine # [ 1.844323] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 248)
  1463. 22.14 s [vm-test-run-dnscheck-module-test] machine # [ 1.854467] io scheduler mq-deadline registered
  1464. 22.15 s [vm-test-run-dnscheck-module-test] machine # [ 1.859608] io scheduler kyber registered
  1465. 22.16 s [vm-test-run-dnscheck-module-test] machine # [ 1.870098] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
  1466. 22.17 s [vm-test-run-dnscheck-module-test] machine # [ 1.879009] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
  1467. 22.18 s [vm-test-run-dnscheck-module-test] machine # [ 1.892646] Linux agpgart interface v0.103
  1468. 22.19 s [vm-test-run-dnscheck-module-test] machine # [ 1.898800] ACPI: bus type drm_connector registered
  1469. 22.20 s [vm-test-run-dnscheck-module-test] machine # [ 1.908309] usbcore: registered new interface driver usbserial_generic
  1470. 22.21 s [vm-test-run-dnscheck-module-test] machine # [ 1.916666] usbserial: USB Serial support registered for generic
  1471. 22.21 s [vm-test-run-dnscheck-module-test] machine # [ 1.923583] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled
  1472. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.934059] drop_monitor: Initializing network drop monitor service
  1473. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.940959] NET: Registered PF_INET6 protocol family
  1474. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.951988] Segment Routing with IPv6
  1475. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.956639] In-situ OAM (IOAM) with IPv6
  1476. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.962705] IPI shorthand broadcast: enabled
  1477. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.983877] registered taskstats version 1
  1478. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 1.989211] Loading compiled-in X.509 certificates
  1479. 22.33 s [vm-test-run-dnscheck-module-test] machine # [ 2.045005] Demotion targets for Node 0: null
  1480. 22.34 s [vm-test-run-dnscheck-module-test] machine # [ 2.050022] Key type .fscrypt registered
  1481. 22.35 s [vm-test-run-dnscheck-module-test] machine # [ 2.055567] Key type fscrypt-provisioning registered
  1482. 22.35 s [vm-test-run-dnscheck-module-test] machine # [ 2.058353] ima: No TPM chip found, activating TPM-bypass!
  1483. 22.36 s [vm-test-run-dnscheck-module-test] machine # [ 2.066635] ima: Allocated hash algorithm: sha1
  1484. 22.36 s [vm-test-run-dnscheck-module-test] machine # [ 2.069200] ima: No architecture policies found
  1485. 22.37 s [vm-test-run-dnscheck-module-test] machine # [ 2.076359] PM: Magic number: 14:957:275
  1486. 22.37 s [vm-test-run-dnscheck-module-test] machine # [ 2.080658] misc udmabuf: hash matches
  1487. 22.37 s [vm-test-run-dnscheck-module-test] machine # [ 2.082567] tty tty12: hash matches
  1488. 22.38 s [vm-test-run-dnscheck-module-test] machine # [ 2.088729] RAS: Correctable Errors collector initialized.
  1489. 22.40 s [vm-test-run-dnscheck-module-test] machine # [ 2.104611] Unstable clock detected, switching default tracing clock to "global"
  1490. 22.40 s [vm-test-run-dnscheck-module-test] machine # [ 2.104611] If you want to keep using the local clock, then add:
  1491. 22.40 s [vm-test-run-dnscheck-module-test] machine # [ 2.104611] "trace_clock=local"
  1492. 22.40 s [vm-test-run-dnscheck-module-test] machine # [ 2.104611] on the kernel command line
  1493. 22.42 s [vm-test-run-dnscheck-module-test] machine # [ 2.127975] clk: Disabling unused clocks
  1494. 22.42 s [vm-test-run-dnscheck-module-test] machine # [ 2.132661] PM: genpd: Disabling unused power domains
  1495. 23.35 s [vm-test-run-dnscheck-module-test] machine # [ 3.058132] Freeing initrd memory: 27524K
  1496. 23.37 s [vm-test-run-dnscheck-module-test] machine # [ 3.079038] Freeing unused decrypted memory: 2028K
  1497. 23.40 s [vm-test-run-dnscheck-module-test] machine # [ 3.107755] Freeing unused kernel image (initmem) memory: 3644K
  1498. 23.40 s [vm-test-run-dnscheck-module-test] machine # [ 3.112180] Write protecting the kernel read-only data: 32768k
  1499. 23.42 s [vm-test-run-dnscheck-module-test] machine # [ 3.126625] Freeing unused kernel image (text/rodata gap) memory: 1336K
  1500. 23.43 s [vm-test-run-dnscheck-module-test] machine # [ 3.138715] Freeing unused kernel image (rodata/data gap) memory: 824K
  1501. 23.48 s [vm-test-run-dnscheck-module-test] machine # [ 3.185254] x86/mm: Checked W+X mappings: passed, no W+X pages found.
  1502. 23.48 s [vm-test-run-dnscheck-module-test] machine # [ 3.188668] Run /init as init process
  1503. 23.52 s [vm-test-run-dnscheck-module-test] machine # [ 3.225762] systemd[1]: Inserted module 'autofs4'
  1504. 23.54 s [vm-test-run-dnscheck-module-test] machine # [ 3.247322] fuse: init (API version 7.45)
  1505. 23.55 s [vm-test-run-dnscheck-module-test] machine # [ 3.255969] ACPI: \_SB_.LNKC: Enabled at IRQ 10
  1506. 23.56 s [vm-test-run-dnscheck-module-test] machine # [ 3.269126] ACPI: \_SB_.LNKA: Enabled at IRQ 10
  1507. 23.56 s [vm-test-run-dnscheck-module-test] machine # [ 3.275257] ACPI: \_SB_.LNKB: Enabled at IRQ 11
  1508. 23.63 s [vm-test-run-dnscheck-module-test] machine # [ 3.338690] systemd[1]: Successfully made /usr/ read-only.
  1509. 23.98 s [vm-test-run-dnscheck-module-test] machine # [ 3.679375] systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
  1510. 23.98 s [vm-test-run-dnscheck-module-test] machine # [ 3.693601] systemd[1]: Detected virtualization kvm.
  1511. 23.99 s [vm-test-run-dnscheck-module-test] machine # [ 3.696127] systemd[1]: Detected architecture x86-64.
  1512. 23.99 s [vm-test-run-dnscheck-module-test] machine # [ 3.698689] systemd[1]: Running in initrd.
  1513. 23.99 s [vm-test-run-dnscheck-module-test] machine # [ 3.701193] systemd[1]: Initializing machine ID from random generator.
  1514. 23.99 s [vm-test-run-dnscheck-module-test] machine # [ 3.704695] systemd[1]: Hostname set to <machine>.
  1515. 24.06 s [vm-test-run-dnscheck-module-test] machine # [ 3.766644] systemd[1]: Queued start job for default target Initrd Default Target.
  1516. 24.12 s [vm-test-run-dnscheck-module-test] machine # [ 3.834075] systemd[1]: Created slice Slice /system/modprobe.
  1517. 24.13 s [vm-test-run-dnscheck-module-test] machine # [ 3.837270] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
  1518. 24.13 s [vm-test-run-dnscheck-module-test] machine # [ 3.841376] systemd[1]: Expecting device /dev/disk/by-label/nixos...
  1519. 24.13 s [vm-test-run-dnscheck-module-test] machine # [ 3.844679] systemd[1]: Reached target Path Units.
  1520. 24.14 s [vm-test-run-dnscheck-module-test] machine # [ 3.847167] systemd[1]: Reached target Slice Units.
  1521. 24.14 s [vm-test-run-dnscheck-module-test] machine # [ 3.849757] systemd[1]: Reached target Swaps.
  1522. 24.14 s [vm-test-run-dnscheck-module-test] machine # [ 3.852081] systemd[1]: Reached target Timer Units.
  1523. 24.15 s [vm-test-run-dnscheck-module-test] machine # [ 3.855100] systemd[1]: Listening on D-Bus System Message Bus Socket.
  1524. 24.15 s [vm-test-run-dnscheck-module-test] machine # [ 3.858589] systemd[1]: Listening on Journal Socket (/dev/log).
  1525. 24.15 s [vm-test-run-dnscheck-module-test] machine # [ 3.861901] systemd[1]: Listening on Journal Sockets.
  1526. 24.15 s [vm-test-run-dnscheck-module-test] machine # [ 3.864756] systemd[1]: Listening on udev Control Socket.
  1527. 24.16 s [vm-test-run-dnscheck-module-test] machine # [ 3.867730] systemd[1]: Listening on udev Kernel Socket.
  1528. 24.16 s [vm-test-run-dnscheck-module-test] machine # [ 3.870605] systemd[1]: Reached target Socket Units.
  1529. 24.17 s [vm-test-run-dnscheck-module-test] machine # [ 3.876314] systemd[1]: Starting Create List of Static Device Nodes...
  1530. 24.18 s [vm-test-run-dnscheck-module-test] machine # [ 3.888991] systemd[1]: Starting Load Kernel Module 9pnet_virtio...
  1531. 24.19 s [vm-test-run-dnscheck-module-test] machine # [ 3.904000] systemd[1]: Starting Load Kernel Module configfs...
  1532. 24.22 s [vm-test-run-dnscheck-module-test] machine # [ 3.928155] systemd[1]: Starting Journal Service...
  1533. 24.22 s [vm-test-run-dnscheck-module-test] machine # [ 3.934743] netfs: FS-Cache loaded
  1534. 24.23 s [vm-test-run-dnscheck-module-test] machine # [ 3.945014] systemd[1]: Starting Load Kernel Modules...
  1535. 24.24 s [vm-test-run-dnscheck-module-test] machine # [ 3.948607] 9pnet: Installing 9P2000 support
  1536. 24.25 s [vm-test-run-dnscheck-module-test] machine # [ 3.958641] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
  1537. 24.27 s [vm-test-run-dnscheck-module-test] machine # [ 3.981798] systemd-journald[125]: Collecting audit messages is disabled.
  1538. 24.28 s [vm-test-run-dnscheck-module-test] machine # [ 3.989073] systemd[1]: Starting Coldplug All udev Devices...
  1539. 24.30 s [vm-test-run-dnscheck-module-test] machine # [ 4.006055] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.
  1540. 24.34 s [vm-test-run-dnscheck-module-test] machine # [ 4.034897] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev
  1541. 24.36 s [vm-test-run-dnscheck-module-test] machine # [ 4.069242] systemd[1]: Finished Create List of Static Device Nodes.
  1542. 24.37 s [vm-test-run-dnscheck-module-test] machine # [ 4.080308] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.
  1543. 24.39 s [vm-test-run-dnscheck-module-test] machine # [ 4.097632] systemd[1]: Finished Load Kernel Module 9pnet_virtio.
  1544. 24.41 s [vm-test-run-dnscheck-module-test] machine # [ 4.121221] systemd[1]: modprobe@configfs.service: Deactivated successfully.
  1545. 24.43 s [vm-test-run-dnscheck-module-test] machine # [ 4.137480] systemd[1]: Finished Load Kernel Module configfs.
  1546. 24.45 s [vm-test-run-dnscheck-module-test] machine # [ 4.158326] systemd[1]: Finished Load Kernel Modules.
  1547. 24.46 s [vm-test-run-dnscheck-module-test] machine # [ 4.170641] systemd[1]: Kernel Configuration File System skipped, unmet condition check ConditionPathExists=/sys/kernel/config
  1548. 24.48 s [vm-test-run-dnscheck-module-test] machine # [ 4.193008] systemd[1]: Starting Apply Kernel Variables...
  1549. 24.51 s [vm-test-run-dnscheck-module-test] machine # [ 4.219664] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
  1550. 24.53 s [vm-test-run-dnscheck-module-test] machine # [ 4.241056] systemd[1]: Started Journal Service.
  1551. 24.54 s [vm-test-run-dnscheck-module-test] machine # [ 3.472634] systemd-modules-load[127]: Inserted module 'dm_mod'
  1552. 24.54 s [vm-test-run-dnscheck-module-test] machine # [ 3.484990] systemd-modules-load[127]: Inserted module 'virtio_balloon'
  1553. 24.55 s [vm-test-run-dnscheck-module-test] machine # [ 3.495710] systemd-modules-load[127]: Inserted module 'virtio_gpu'
  1554. 24.56 s [vm-test-run-dnscheck-module-test] machine # [ 3.503615] systemd[1]: Finished Apply Kernel Variables.
  1555. 24.57 s [vm-test-run-dnscheck-module-test] machine # [ 3.511789] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
  1556. 24.58 s [vm-test-run-dnscheck-module-test] machine # [ 3.521335] systemd[1]: Starting Create Static Device Nodes in /dev...
  1557. 24.60 s [vm-test-run-dnscheck-module-test] machine # [ 3.540230] systemd[1]: Finished Create Static Device Nodes in /dev.
  1558. 24.60 s [vm-test-run-dnscheck-module-test] machine # [ 3.545869] systemd[1]: Reached target Preparation for Local File Systems.
  1559. 24.61 s [vm-test-run-dnscheck-module-test] machine # [ 3.554340] systemd[1]: Reached target Local File Systems.
  1560. 24.62 s [vm-test-run-dnscheck-module-test] machine # [ 3.560157] systemd[1]: Starting Create System Files and Directories...
  1561. 24.62 s [vm-test-run-dnscheck-module-test] machine # [ 3.566437] systemd[1]: Starting Rule-based Manager for Device Events and Files...
  1562. 24.65 s [vm-test-run-dnscheck-module-test] machine # [ 3.589886] systemd[1]: Finished Create System Files and Directories.
  1563. 24.66 s [vm-test-run-dnscheck-module-test] machine # [ 3.607631] systemd-udevd[162]: Using default interface naming scheme 'v260'.
  1564. 24.69 s [vm-test-run-dnscheck-module-test] machine # [ 3.631140] systemd[1]: Finished Coldplug All udev Devices.
  1565. 24.70 s [vm-test-run-dnscheck-module-test] machine # [ 3.645839] systemd[1]: Started Rule-based Manager for Device Events and Files.
  1566. 24.71 s [vm-test-run-dnscheck-module-test] machine # [ 3.652348] systemd[1]: Reached target System Initialization.
  1567. 24.71 s [vm-test-run-dnscheck-module-test] machine # [ 3.656337] systemd[1]: Reached target Basic System.
  1568. 25.07 s [vm-test-run-dnscheck-module-test] machine # [ 4.775054] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
  1569. 25.07 s [vm-test-run-dnscheck-module-test] machine # [ 4.781459] virtio_blk virtio5: 1/0/0 default/read/poll queues
  1570. 25.10 s [vm-test-run-dnscheck-module-test] machine # [ 4.809882] serio: i8042 KBD port at 0x60,0x64 irq 1
  1571. 25.12 s [vm-test-run-dnscheck-module-test] machine # [ 4.825349] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)
  1572. 25.13 s [vm-test-run-dnscheck-module-test] machine # [ 4.843871] serio: i8042 AUX port at 0x60,0x64 irq 12
  1573. 25.14 s [vm-test-run-dnscheck-module-test] machine # [ 4.851065] uhci_hcd 0000:00:01.2: UHCI Host Controller
  1574. 25.16 s [vm-test-run-dnscheck-module-test] machine # [ 4.873044] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
  1575. 25.18 s [vm-test-run-dnscheck-module-test] machine # [ 4.891195] uhci_hcd 0000:00:01.2: detected 2 ports
  1576. 25.20 s [vm-test-run-dnscheck-module-test] machine # [ 4.907249] SCSI subsystem initialized
  1577. 25.20 s [vm-test-run-dnscheck-module-test] machine # [ 4.909269] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100
  1578. 25.22 s [vm-test-run-dnscheck-module-test] machine # [ 4.931367] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.18
  1579. 25.23 s [vm-test-run-dnscheck-module-test] machine # [ 4.170584] (udev-worker)[177]: Network interface NamePolicy= disabled on kernel command line.
  1580. 25.25 s [vm-test-run-dnscheck-module-test] machine # [ 4.962004] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
  1581. 25.26 s [vm-test-run-dnscheck-module-test] machine # [ 4.201217] systemd[1]: Starting Virtual Console Setup...
  1582. 25.27 s [vm-test-run-dnscheck-module-test] machine # [ 4.207326] (udev-worker)[174]: [0;1;38:5:185meth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
  1583. 25.28 s [vm-test-run-dnscheck-module-test] machine # [ 4.223129] (udev-worker)[174]: Network interface NamePolicy= disabled on kernel command line.
  1584. 25.30 s [vm-test-run-dnscheck-module-test] machine # [ 5.012010] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
  1585. 25.31 s [vm-test-run-dnscheck-module-test] machine # [ 5.020104] usb usb1: Product: UHCI Host Controller
  1586. 25.31 s [vm-test-run-dnscheck-module-test] machine # [ 4.257298] systemd-vconsole-setup[182]: Configuration of first virtual console was skipped, ignoring remaining ones.
  1587. 25.32 s [vm-test-run-dnscheck-module-test] machine # [ 4.268206] systemd[1]: Finished Virtual Console Setup.
  1588. 25.33 s [vm-test-run-dnscheck-module-test] machine # [ 5.045346] usb usb1: Manufacturer: Linux 6.18.33 uhci_hcd
  1589. 25.34 s [vm-test-run-dnscheck-module-test] machine # [ 5.052666] usb usb1: SerialNumber: 0000:00:01.2
  1590. 25.35 s [vm-test-run-dnscheck-module-test] machine # [ 4.294142] systemd[1]: Found device /dev/disk/by-label/nixos.
  1591. 25.35 s [vm-test-run-dnscheck-module-test] machine # [ 4.297972] systemd[1]: Reached target Initrd Root Device.
  1592. 25.36 s [vm-test-run-dnscheck-module-test] machine # [ 4.304958] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...
  1593. 25.36 s [vm-test-run-dnscheck-module-test] machine # [ 5.075915] hub 1-0:1.0: USB hub found
  1594. 25.37 s [vm-test-run-dnscheck-module-test] machine # [ 5.079932] hub 1-0:1.0: 2 ports detected
  1595. 25.40 s [vm-test-run-dnscheck-module-test] machine # [ 4.345695] systemd-fsck[191]: nixos: clean, 12/65536 files, 13019/262144 blocks
  1596. 25.41 s [vm-test-run-dnscheck-module-test] machine # [ 5.123602] scsi host0: ata_piix
  1597. 25.42 s [vm-test-run-dnscheck-module-test] machine # [ 5.127285] scsi host1: ata_piix
  1598. 25.42 s [vm-test-run-dnscheck-module-test] machine # [ 5.130044] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0
  1599. 25.42 s [vm-test-run-dnscheck-module-test] machine # [ 5.133958] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0
  1600. 25.44 s [vm-test-run-dnscheck-module-test] machine # [ 4.388553] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.
  1601. 25.45 s [vm-test-run-dnscheck-module-test] machine # [ 4.398203] systemd[1]: Mounting /sysroot...
  1602. 25.58 s [vm-test-run-dnscheck-module-test] machine # [ 5.290584] ata2: found unknown device (class 0)
  1603. 25.58 s [vm-test-run-dnscheck-module-test] machine # [ 5.293671] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
  1604. 25.59 s [vm-test-run-dnscheck-module-test] machine # [ 5.298214] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
  1605. 25.60 s [vm-test-run-dnscheck-module-test] machine # [ 5.305714] usb 1-1: new full-speed USB device number 2 using uhci_hcd
  1606. 25.65 s [vm-test-run-dnscheck-module-test] machine # [ 5.363861] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
  1607. 25.68 s [vm-test-run-dnscheck-module-test] machine # [ 5.390200] cdrom: Uniform CD-ROM driver Revision: 3.20
  1608. 25.72 s [vm-test-run-dnscheck-module-test] machine # [ 5.432627] EXT4-fs (vda): mounted filesystem a7f0569e-f96b-43d5-a8bc-308bd756e412 r/w with ordered data mode. Quota mode: none.
  1609. 25.73 s [vm-test-run-dnscheck-module-test] machine # [ 4.673532] systemd[1]: Mounted /sysroot.
  1610. 25.74 s [vm-test-run-dnscheck-module-test] machine # [ 4.679369] systemd[1]: Reached target Initrd Root File System.
  1611. 25.75 s [vm-test-run-dnscheck-module-test] machine # [ 4.683318] systemd[1]: Starting Mountpoints Configured in the Real Root...
  1612. 25.76 s [vm-test-run-dnscheck-module-test] machine # [ 4.704599] systemd-sysroot-fstab-check[209]: /sysroot should be mounted in the initrd, will request daemon-reload.
  1613. 25.77 s [vm-test-run-dnscheck-module-test] machine # [ 5.477015] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
  1614. 25.77 s [vm-test-run-dnscheck-module-test] machine # [ 5.481577] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10
  1615. 25.78 s [vm-test-run-dnscheck-module-test] machine # [ 4.718804] systemd[1]: Reload requested from client PID 209 ('systemd-sysroot') (unit initrd-parse-etc.service)...
  1616. 25.78 s [vm-test-run-dnscheck-module-test] machine # [ 5.491644] usb 1-1: Product: QEMU USB Tablet
  1617. 25.78 s [vm-test-run-dnscheck-module-test] machine # [ 5.493350] usb 1-1: Manufacturer: QEMU
  1618. 25.79 s [vm-test-run-dnscheck-module-test] machine # [ 4.730440] systemd[1]: Reloading...
  1619. 25.79 s [vm-test-run-dnscheck-module-test] machine # [ 5.501466] usb 1-1: SerialNumber: 28754-0000:00:01.2-1
  1620. 25.84 s [vm-test-run-dnscheck-module-test] machine # [ 5.552986] hid: raw HID events driver (C) Jiri Kosina
  1621. 25.86 s [vm-test-run-dnscheck-module-test] machine # [ 5.574615] usbcore: registered new interface driver usbhid
  1622. 25.88 s [vm-test-run-dnscheck-module-test] machine # [ 5.590879] usbhid: USB HID core driver
  1623. 25.90 s [vm-test-run-dnscheck-module-test] machine # [ 5.610207] 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
  1624. 25.91 s [vm-test-run-dnscheck-module-test] machine # [ 5.622749] 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
  1625. 26.09 s [vm-test-run-dnscheck-module-test] machine # [ 5.036287] systemd[1]: Reloading finished in 327 ms.
  1626. 26.11 s [vm-test-run-dnscheck-module-test] machine # [ 5.054978] systemd-sysroot-fstab-check[209]: Requesting initrd-fs.target/start/replace...
  1627. 26.18 s [vm-test-run-dnscheck-module-test] machine # [ 5.119865] systemd-sysroot-fstab-check[209]: Requesting swap.target/start/replace...
  1628. 26.18 s [vm-test-run-dnscheck-module-test] machine # [ 5.127250] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
  1629. 26.19 s [vm-test-run-dnscheck-module-test] machine # [ 5.135530] systemd[1]: initrd-parse-etc.service: Deactivated successfully.
  1630. 26.19 s [vm-test-run-dnscheck-module-test] machine # [ 5.137875] systemd[1]: Finished Mountpoints Configured in the Real Root.
  1631. 26.20 s [vm-test-run-dnscheck-module-test] machine # [ 5.140224] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.
  1632. 26.33 s [vm-test-run-dnscheck-module-test] machine # [ 5.271339] systemd[1]: Mounting /sysroot/nix/.ro-store...
  1633. 26.34 s [vm-test-run-dnscheck-module-test] machine # [ 5.280269] systemd[1]: Mounting /sysroot/nix/.rw-store...
  1634. 26.34 s [vm-test-run-dnscheck-module-test] machine # [ 5.288610] systemd[1]: Mounting /sysroot/run...
  1635. 26.36 s [vm-test-run-dnscheck-module-test] machine # [ 5.295614] systemd[1]: Mounting /sysroot/tmp/shared...
  1636. 26.36 s [vm-test-run-dnscheck-module-test] machine # [ 6.070185] 9p: Installing v9fs 9p2000 file system support
  1637. 26.37 s [vm-test-run-dnscheck-module-test] machine # [ 5.310257] systemd[1]: Mounting /sysroot/tmp/xchg...
  1638. 26.38 s [vm-test-run-dnscheck-module-test] machine # [ 5.323645] systemd[1]: Mounted /sysroot/nix/.ro-store.
  1639. 26.39 s [vm-test-run-dnscheck-module-test] machine # [ 5.332311] systemd[1]: Mounted /sysroot/nix/.rw-store.
  1640. 26.40 s [vm-test-run-dnscheck-module-test] machine # [ 5.345181] systemd[1]: Mounted /sysroot/run.
  1641. 26.40 s [vm-test-run-dnscheck-module-test] machine # [ 5.347246] systemd[1]: Mounted /sysroot/tmp/shared.
  1642. 26.41 s [vm-test-run-dnscheck-module-test] machine # [ 5.350310] systemd[1]: Mounted /sysroot/tmp/xchg.
  1643. 26.41 s [vm-test-run-dnscheck-module-test] machine # [ 5.356499] systemd[1]: Starting rw-sysroot-nix-store.service...
  1644. 26.42 s [vm-test-run-dnscheck-module-test] machine # [ 5.367606] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
  1645. 26.43 s [vm-test-run-dnscheck-module-test] machine # [ 5.374229] systemd[1]: Finished rw-sysroot-nix-store.service.
  1646. 26.43 s [vm-test-run-dnscheck-module-test] machine # [ 5.378987] systemd[1]: Mounting /sysroot/nix/store...
  1647. 26.46 s [vm-test-run-dnscheck-module-test] machine # [ 5.399948] systemd[1]: Mounted /sysroot/nix/store.
  1648. 26.46 s [vm-test-run-dnscheck-module-test] machine # [ 5.402876] systemd[1]: Reached target Initrd File Systems.
  1649. 26.46 s [vm-test-run-dnscheck-module-test] machine # [ 5.408380] systemd[1]: Starting Find NixOS closure...
  1650. 26.47 s [vm-test-run-dnscheck-module-test] machine # [ 5.411833] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...
  1651. 26.49 s [vm-test-run-dnscheck-module-test] machine # [ 5.435485] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.
  1652. 26.50 s [vm-test-run-dnscheck-module-test] machine # [ 5.445476] systemd[1]: Finished Find NixOS closure.
  1653. 26.50 s [vm-test-run-dnscheck-module-test] machine # [ 5.449360] systemd[1]: Reached target Initrd Default Target.
  1654. 26.51 s [vm-test-run-dnscheck-module-test] machine # [ 5.452635] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...
  1655. 26.53 s [vm-test-run-dnscheck-module-test] machine # [ 5.470236] systemd[1]: Stopped target Initrd Default Target.
  1656. 26.53 s [vm-test-run-dnscheck-module-test] machine # [ 5.473538] systemd[1]: Stopped target Basic System.
  1657. 26.53 s [vm-test-run-dnscheck-module-test] machine # [ 5.477882] systemd[1]: Stopped target Initrd Root Device.
  1658. 26.54 s [vm-test-run-dnscheck-module-test] machine # [ 5.482532] systemd[1]: Stopped target Path Units.
  1659. 26.54 s [vm-test-run-dnscheck-module-test] machine # [ 5.488169] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.
  1660. 26.55 s [vm-test-run-dnscheck-module-test] machine # [ 5.493842] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.
  1661. 26.56 s [vm-test-run-dnscheck-module-test] machine # [ 5.502429] systemd[1]: Stopped target Slice Units.
  1662. 26.57 s [vm-test-run-dnscheck-module-test] machine # [ 5.509654] systemd[1]: Stopped target Socket Units.
  1663. 26.57 s [vm-test-run-dnscheck-module-test] machine # [ 5.514654] systemd[1]: Stopped target System Initialization.
  1664. 26.58 s [vm-test-run-dnscheck-module-test] machine # [ 5.520531] systemd[1]: Stopped target Swaps.
  1665. 26.58 s [vm-test-run-dnscheck-module-test] machine # [ 5.523632] systemd[1]: Stopped target Timer Units.
  1666. 26.59 s [vm-test-run-dnscheck-module-test] machine # [ 5.529397] systemd[1]: dbus.socket: Deactivated successfully.
  1667. 26.59 s [vm-test-run-dnscheck-module-test] machine # [ 5.535742] systemd[1]: Closed D-Bus System Message Bus Socket.
  1668. 26.60 s [vm-test-run-dnscheck-module-test] machine # [ 5.543468] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.
  1669. 26.61 s [vm-test-run-dnscheck-module-test] machine # [ 5.550891] systemd[1]: Stopped Find NixOS closure.
  1670. 26.61 s [vm-test-run-dnscheck-module-test] machine # [ 5.556272] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
  1671. 26.62 s [vm-test-run-dnscheck-module-test] machine # [ 5.563380] systemd[1]: Starting rw-sysroot-nix-store.service...
  1672. 26.63 s [vm-test-run-dnscheck-module-test] machine # [ 5.568262] systemd[1]: systemd-sysctl.service: Deactivated successfully.
  1673. 26.63 s [vm-test-run-dnscheck-module-test] machine # [ 5.573615] systemd[1]: Stopped Apply Kernel Variables.
  1674. 26.64 s [vm-test-run-dnscheck-module-test] machine # [ 5.579499] systemd[1]: systemd-modules-load.service: Deactivated successfully.
  1675. 26.64 s [vm-test-run-dnscheck-module-test] machine # [ 5.585343] systemd[1]: Stopped Load Kernel Modules.
  1676. 26.64 s [vm-test-run-dnscheck-module-test] machine # [ 5.588766] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.
  1677. 26.65 s [vm-test-run-dnscheck-module-test] machine # [ 5.595355] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.
  1678. 26.66 s [vm-test-run-dnscheck-module-test] machine # [ 5.602370] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.
  1679. 26.67 s [vm-test-run-dnscheck-module-test] machine # [ 5.609333] systemd[1]: Stopped Create System Files and Directories.
  1680. 26.67 s [vm-test-run-dnscheck-module-test] machine # [ 5.615612] systemd[1]: Stopped target Local File Systems.
  1681. 26.68 s [vm-test-run-dnscheck-module-test] machine # [ 5.620647] systemd[1]: Stopped target Preparation for Local File Systems.
  1682. 26.68 s [vm-test-run-dnscheck-module-test] machine # [ 5.626583] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.
  1683. 26.69 s [vm-test-run-dnscheck-module-test] machine # [ 5.633331] systemd[1]: Stopped Coldplug All udev Devices.
  1684. 26.69 s [vm-test-run-dnscheck-module-test] machine # [ 5.637357] systemd[1]: Stopping Rule-based Manager for Device Events and Files...
  1685. 26.70 s [vm-test-run-dnscheck-module-test] machine # [ 5.642358] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1686. 26.70 s [vm-test-run-dnscheck-module-test] machine # [ 5.646903] systemd[1]: Stopped Virtual Console Setup.
  1687. 26.70 s [vm-test-run-dnscheck-module-test] machine # [ 5.648771] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.
  1688. 26.71 s [vm-test-run-dnscheck-module-test] machine # [ 5.654277] systemd[1]: Finished rw-sysroot-nix-store.service.
  1689. 26.71 s [vm-test-run-dnscheck-module-test] machine # [ 5.658454] systemd[1]: systemd-udevd.service: Deactivated successfully.
  1690. 26.72 s [vm-test-run-dnscheck-module-test] machine # [ 5.662540] systemd[1]: Stopped Rule-based Manager for Device Events and Files.
  1691. 26.72 s [vm-test-run-dnscheck-module-test] machine # [ 5.664801] systemd[1]: initrd-cleanup.service: Deactivated successfully.
  1692. 26.72 s [vm-test-run-dnscheck-module-test] machine # [ 5.667121] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.
  1693. 26.73 s [vm-test-run-dnscheck-module-test] machine # [ 5.669384] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.
  1694. 26.73 s [vm-test-run-dnscheck-module-test] machine # [ 5.671717] systemd[1]: Closed udev Control Socket.
  1695. 26.73 s [vm-test-run-dnscheck-module-test] machine # [ 5.673556] systemd[1]: Starting Cleanup udev Database...
  1696. 26.73 s [vm-test-run-dnscheck-module-test] machine # [ 5.675533] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.
  1697. 26.73 s [vm-test-run-dnscheck-module-test] machine # [ 5.677975] systemd[1]: Stopped Create Static Device Nodes in /dev.
  1698. 26.74 s [vm-test-run-dnscheck-module-test] machine # [ 5.680236] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.
  1699. 26.74 s [vm-test-run-dnscheck-module-test] machine # [ 5.682788] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.
  1700. 26.74 s [vm-test-run-dnscheck-module-test] machine # [ 5.685148] systemd[1]: kmod-static-nodes.service: Deactivated successfully.
  1701. 26.74 s [vm-test-run-dnscheck-module-test] machine # [ 5.687479] systemd[1]: Stopped Create List of Static Device Nodes.
  1702. 26.75 s [vm-test-run-dnscheck-module-test] machine # [ 5.689570] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.
  1703. 26.75 s [vm-test-run-dnscheck-module-test] machine # [ 5.691969] systemd[1]: Finished Cleanup udev Database.
  1704. 26.75 s [vm-test-run-dnscheck-module-test] machine # [ 5.693837] systemd[1]: Reached target Switch Root.
  1705. 26.75 s [vm-test-run-dnscheck-module-test] machine # [ 5.695562] systemd[1]: Starting NixOS Activation...
  1706. 27.01 s [vm-test-run-dnscheck-module-test] machine # [ 5.948265] initrd-nixos-activation-start[497]: booting system configuration /nix/store/5n1hdyis33xpxcp8sr39dsn9qp75lh4s-nixos-system-machine-test
  1707. 27.06 s [vm-test-run-dnscheck-module-test] machine # [ 6.007867] initrd-nixos-activation-start[497]: running activation script...
  1708. 27.46 s [vm-test-run-dnscheck-module-test] machine # [ 6.400756] initrd-nixos-activation-start[520]: setting up /etc...
  1709. 27.71 s [vm-test-run-dnscheck-module-test] machine # [ 6.651507] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.
  1710. 27.71 s [vm-test-run-dnscheck-module-test] machine # [ 6.657379] systemd[1]: Finished NixOS Activation.
  1711. 27.72 s [vm-test-run-dnscheck-module-test] machine # [ 6.662790] systemd[1]: Starting Switch Root...
  1712. 27.73 s [vm-test-run-dnscheck-module-test] machine # [ 6.676723] systemd[1]: Switching root.
  1713. 27.90 s [vm-test-run-dnscheck-module-test] machine # [ 7.607355] systemd-journald[125]: Received SIGTERM from PID 1 (systemd).
  1714. 28.12 s [vm-test-run-dnscheck-module-test] machine # [ 7.825971] NET: Registered PF_VSOCK protocol family
  1715. 28.52 s [vm-test-run-dnscheck-module-test] machine # [ 8.226183] systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)
  1716. 28.53 s [vm-test-run-dnscheck-module-test] machine # [ 8.237125] systemd[1]: Detected virtualization kvm.
  1717. 28.53 s [vm-test-run-dnscheck-module-test] machine # [ 8.239151] systemd[1]: Detected architecture x86-64.
  1718. 28.53 s [vm-test-run-dnscheck-module-test] machine # [ 8.241221] systemd[1]: Detected first boot.
  1719. 28.55 s [vm-test-run-dnscheck-module-test] machine # [ 8.265160] systemd[1]: Initializing machine ID from random generator.
  1720. 28.84 s [vm-test-run-dnscheck-module-test] machine # [ 8.547211] systemd[1]: bpf-restrict-fs: LSM BPF program attached
  1721. 28.97 s [vm-test-run-dnscheck-module-test] machine # [ 8.680124] systemd[1]: Applying preset policy.
  1722. 29.46 s [vm-test-run-dnscheck-module-test] machine # [ 9.168866] systemd[1]: Populated /etc with preset unit settings.
  1723. 29.69 s [vm-test-run-dnscheck-module-test] machine # [ 9.394792] systemd[1]: /etc/systemd/system/dnscheck.service:3: Invalid URL, ignoring: /nix/store/gcncbsr8n1nrkrhczh8087qi8lmingvq-dnscheck-settings-check
  1724. 29.95 s [vm-test-run-dnscheck-module-test] machine # [ 9.656348] systemd[1]: initrd-switch-root.service: Deactivated successfully.
  1725. 29.95 s [vm-test-run-dnscheck-module-test] machine # [ 9.660182] systemd[1]: Stopped initrd-switch-root.service.
  1726. 29.96 s [vm-test-run-dnscheck-module-test] machine # [ 9.665683] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.
  1727. 29.96 s [vm-test-run-dnscheck-module-test] machine # [ 9.670410] systemd[1]: Created slice Slice /system/getty.
  1728. 29.96 s [vm-test-run-dnscheck-module-test] machine # [ 9.673453] systemd[1]: Created slice User and Session Slice.
  1729. 29.97 s [vm-test-run-dnscheck-module-test] machine # [ 9.676111] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
  1730. 29.97 s [vm-test-run-dnscheck-module-test] machine # [ 9.679825] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
  1731. 29.97 s [vm-test-run-dnscheck-module-test] machine # [ 9.683645] systemd[1]: Expecting device /dev/hvc0...
  1732. 29.98 s [vm-test-run-dnscheck-module-test] machine # [ 9.686108] systemd[1]: Expecting device /dev/ttyS0...
  1733. 29.98 s [vm-test-run-dnscheck-module-test] machine # [ 9.688396] systemd[1]: Reached target Local Encrypted Volumes.
  1734. 29.98 s [vm-test-run-dnscheck-module-test] machine # [ 9.690862] systemd[1]: Stopped target initrd-fs.target.
  1735. 29.98 s [vm-test-run-dnscheck-module-test] machine # [ 9.693088] systemd[1]: Stopped target initrd-root-fs.target.
  1736. 29.98 s [vm-test-run-dnscheck-module-test] machine # [ 9.695333] systemd[1]: Stopped target initrd-switch-root.target.
  1737. 29.99 s [vm-test-run-dnscheck-module-test] machine # [ 9.697689] systemd[1]: Reached target Virtual Machines and Containers.
  1738. 29.99 s [vm-test-run-dnscheck-module-test] machine # [ 9.700208] systemd[1]: Reached target Path Units.
  1739. 29.99 s [vm-test-run-dnscheck-module-test] machine # [ 9.702231] systemd[1]: Reached target Remote File Systems.
  1740. 29.99 s [vm-test-run-dnscheck-module-test] machine # [ 9.704459] systemd[1]: Reached target Slice Units.
  1741. 30.00 s [vm-test-run-dnscheck-module-test] machine # [ 9.706574] systemd[1]: Reached target Swaps.
  1742. 30.00 s [vm-test-run-dnscheck-module-test] machine # [ 9.711955] systemd[1]: Listening on Process Core Dump Socket.
  1743. 30.01 s [vm-test-run-dnscheck-module-test] machine # [ 9.716475] systemd[1]: Listening on Credential Encryption/Decryption.
  1744. 30.01 s [vm-test-run-dnscheck-module-test] machine # [ 9.722939] systemd[1]: Starting Journal Log Access Socket...
  1745. 30.02 s [vm-test-run-dnscheck-module-test] machine # [ 9.726428] systemd[1]: Listening on Journal Audit Socket.
  1746. 30.02 s [vm-test-run-dnscheck-module-test] machine # [ 9.729631] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.
  1747. 30.02 s [vm-test-run-dnscheck-module-test] machine # [ 9.732937] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki
  1748. 30.03 s [vm-test-run-dnscheck-module-test] machine # [ 9.737152] systemd[1]: Listening on udev Control Socket.
  1749. 30.03 s [vm-test-run-dnscheck-module-test] machine # [ 9.742382] systemd[1]: Mounting Huge Pages File System...
  1750. 30.04 s [vm-test-run-dnscheck-module-test] machine # [ 9.748644] systemd[1]: Mounting POSIX Message Queue File System...
  1751. 30.05 s [vm-test-run-dnscheck-module-test] machine # [ 9.759994] systemd[1]: Mounting Kernel Debug File System...
  1752. 30.06 s [vm-test-run-dnscheck-module-test] machine # [ 9.770277] systemd[1]: Mounting Kernel Trace File System...
  1753. 30.07 s [vm-test-run-dnscheck-module-test] machine # [ 9.780680] systemd[1]: Starting Create List of Static Device Nodes...
  1754. 30.08 s [vm-test-run-dnscheck-module-test] machine # [ 9.790212] systemd[1]: Load Kernel Module 9pnet_virtio skipped, unmet condition check ConditionKernelModuleLoaded=!9pnet_virtio
  1755. 30.10 s [vm-test-run-dnscheck-module-test] machine # [ 9.809207] systemd[1]: Starting Load Kernel Module configfs...
  1756. 30.11 s [vm-test-run-dnscheck-module-test] machine # [ 9.823675] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm
  1757. 30.13 s [vm-test-run-dnscheck-module-test] machine # [ 9.842860] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore
  1758. 30.16 s [vm-test-run-dnscheck-module-test] machine # [ 9.868930] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
  1759. 30.17 s [vm-test-run-dnscheck-module-test] machine # [ 9.880759] systemd[1]: Mounting FUSE Control File System...
  1760. 30.18 s [vm-test-run-dnscheck-module-test] machine # [ 9.883961] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67
  1761. 30.19 s [vm-test-run-dnscheck-module-test] machine # [ 9.902166] systemd[1]: Starting Journal Service...
  1762. 30.20 s [vm-test-run-dnscheck-module-test] machine # [ 9.912160] systemd[1]: Starting Load Kernel Modules...
  1763. 30.22 s [vm-test-run-dnscheck-module-test] machine # [ 9.931628] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...
  1764. 30.24 s [vm-test-run-dnscheck-module-test] machine # [ 9.947633] systemd[1]: Starting Remount Root and Kernel File Systems...
  1765. 30.25 s [vm-test-run-dnscheck-module-test] machine # [ 9.959996] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
  1766. 30.26 s [vm-test-run-dnscheck-module-test] machine # [ 9.973564] systemd-journald[730]: Collecting audit messages is enabled.
  1767. 30.28 s [vm-test-run-dnscheck-module-test] machine # [ 9.986855] systemd[1]: Starting Coldplug All udev Devices...
  1768. 30.30 s [vm-test-run-dnscheck-module-test] machine # [ 10.012224] loop: module loaded
  1769. 30.32 s [vm-test-run-dnscheck-module-test] machine # [ 10.026385] systemd[1]: Listening on Journal Log Access Socket.
  1770. 30.33 s [vm-test-run-dnscheck-module-test] machine # [ 10.038167] systemd[1]: Mounted Huge Pages File System.
  1771. 30.33 s [vm-test-run-dnscheck-module-test] machine # [ 10.043637] EXT4-fs (vda): re-mounted a7f0569e-f96b-43d5-a8bc-308bd756e412.
  1772. 30.34 s [vm-test-run-dnscheck-module-test] machine # [ 10.048316] systemd[1]: Started Journal Service.
  1773. 30.35 s [vm-test-run-dnscheck-module-test] machine # [ 9.286589] systemd[1]: Queued start job for default target Multi-User System.
  1774. 30.36 s [vm-test-run-dnscheck-module-test] machine # [ 9.301773] systemd[1]: systemd-journald.service: Deactivated successfully.
  1775. 30.37 s [vm-test-run-dnscheck-module-test] machine # [ 9.312947] systemd-modules-load[731]: Inserted module 'loop'
  1776. 30.38 s [vm-test-run-dnscheck-module-test] machine # [ 9.322948] systemd[1]: Mounted POSIX Message Queue File System.
  1777. 30.39 s [vm-test-run-dnscheck-module-test] machine # [ 9.331572] systemd[1]: Mounted Kernel Debug File System.
  1778. 30.40 s [vm-test-run-dnscheck-module-test] machine # [ 9.341561] systemd[1]: Mounted Kernel Trace File System.
  1779. 30.40 s [vm-test-run-dnscheck-module-test] machine # [ 9.348619] systemd[1]: Finished Create List of Static Device Nodes.
  1780. 30.42 s [vm-test-run-dnscheck-module-test] machine # [ 9.360703] systemd[1]: modprobe@configfs.service: Deactivated successfully.
  1781. 30.43 s [vm-test-run-dnscheck-module-test] machine # [ 9.370845] systemd[1]: Finished Load Kernel Module configfs.
  1782. 30.44 s [vm-test-run-dnscheck-module-test] machine # [ 9.377560] systemd[1]: Mounted FUSE Control File System.
  1783. 30.45 s [vm-test-run-dnscheck-module-test] machine # [ 9.385635] systemd[1]: Finished Load Kernel Modules.
  1784. 30.45 s [vm-test-run-dnscheck-module-test] machine # [ 9.392909] systemd[1]: Finished Remount Root and Kernel File Systems.
  1785. 30.46 s [vm-test-run-dnscheck-module-test] machine # [ 9.401381] systemd[1]: Mounting Kernel Configuration File System...
  1786. 30.46 s [vm-test-run-dnscheck-module-test] machine # [ 9.406991] systemd[1]: Starting Firewall...
  1787. 30.47 s [vm-test-run-dnscheck-module-test] machine # [ 9.412518] systemd-oomd[733]: [0;1;38:5:185mNo swap; memory pressure usage will be degraded
  1788. 30.48 s [vm-test-run-dnscheck-module-test] machine # [ 9.421556] systemd[1]: Starting Flush Journal to Persistent Storage...
  1789. 30.49 s [vm-test-run-dnscheck-module-test] machine # [ 9.429914] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore
  1790. 30.50 s [vm-test-run-dnscheck-module-test] machine # [ 9.442189] systemd[1]: Starting Load/Save OS Random Seed...
  1791. 30.50 s [vm-test-run-dnscheck-module-test] machine # [ 9.448452] systemd[1]: Starting Apply Kernel Variables...
  1792. 30.51 s [vm-test-run-dnscheck-module-test] machine # [ 9.456154] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...
  1793. 30.52 s [vm-test-run-dnscheck-module-test] machine # [ 9.463345] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki
  1794. 30.53 s [vm-test-run-dnscheck-module-test] machine # [ 9.474182] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.
  1795. 30.67 s [vm-test-run-dnscheck-module-test] machine # [ 9.615411] systemd[1]: Mounted Kernel Configuration File System.
  1796. 30.75 s [vm-test-run-dnscheck-module-test] machine # [ 9.697959] systemd[1]: Finished Load/Save OS Random Seed.
  1797. 30.76 s [vm-test-run-dnscheck-module-test] machine # [ 9.703600] systemd[1]: Reached target First Boot Complete.
  1798. 30.77 s [vm-test-run-dnscheck-module-test] machine # [ 9.718453] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.
  1799. 30.78 s [vm-test-run-dnscheck-module-test] machine # [ 9.726442] systemd[1]: Starting Create Static Device Nodes in /dev...
  1800. 30.87 s [vm-test-run-dnscheck-module-test] machine # [ 9.817738] systemd[1]: Finished Create Static Device Nodes in /dev.
  1801. 30.88 s [vm-test-run-dnscheck-module-test] machine # [ 9.825580] systemd[1]: Reached target Preparation for Local File Systems.
  1802. 30.89 s [vm-test-run-dnscheck-module-test] machine # [ 9.837475] systemd[1]: Starting Rule-based Manager for Device Events and Files...
  1803. 30.92 s [vm-test-run-dnscheck-module-test] machine # [ 9.858592] systemd[1]: Finished Coldplug All udev Devices.
  1804. 30.95 s [vm-test-run-dnscheck-module-test] machine # [ 9.897379] systemd[1]: Mounting /run/wrappers...
  1805. 30.98 s [vm-test-run-dnscheck-module-test] machine # [ 9.924854] systemd-udevd[773]: Using default interface naming scheme 'v260'.
  1806. 31.00 s [vm-test-run-dnscheck-module-test] machine # [ 9.947325] systemd[1]: Mounted /run/wrappers.
  1807. 31.01 s [vm-test-run-dnscheck-module-test] machine # [ 9.950885] systemd[1]: Reached target Local File Systems.
  1808. 31.01 s [vm-test-run-dnscheck-module-test] machine # [ 9.957546] systemd[1]: Listening on Boot Loader Control Service Socket.
  1809. 31.02 s [vm-test-run-dnscheck-module-test] machine # [ 9.964652] systemd[1]: Starting register-nix-paths.service...
  1810. 31.03 s [vm-test-run-dnscheck-module-test] machine # [ 9.971310] systemd[1]: Starting Create SUID/SGID Wrappers...
  1811. 31.04 s [vm-test-run-dnscheck-module-test] machine # [ 9.980855] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.
  1812. 31.05 s [vm-test-run-dnscheck-module-test] machine # [ 10.762129] systemd-journald[730]: Received client request to flush runtime journal.
  1813. 31.62 s [vm-test-run-dnscheck-module-test] machine # [ 10.556844] systemd[1]: Starting Save Transient machine-id to Disk...
  1814. 31.63 s [vm-test-run-dnscheck-module-test] machine # [ 10.575548] systemd[1]: Finished Apply Kernel Variables.
  1815. 31.64 s [vm-test-run-dnscheck-module-test] machine # [ 10.588790] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.
  1816. 31.66 s [vm-test-run-dnscheck-module-test] machine # [ 10.603919] systemd[1]: Finished Save Transient machine-id to Disk.
  1817. 31.67 s [vm-test-run-dnscheck-module-test] machine # [ 10.618366] systemd[1]: Started Rule-based Manager for Device Events and Files.
  1818. 31.69 s [vm-test-run-dnscheck-module-test] machine # [ 10.628738] systemd[1]: Finished Flush Journal to Persistent Storage.
  1819. 31.70 s [vm-test-run-dnscheck-module-test] machine # [ 10.640464] systemd[1]: Starting Create System Files and Directories...
  1820. 31.84 s [vm-test-run-dnscheck-module-test] machine # [ 10.784958] systemd[1]: Finished Create System Files and Directories.
  1821. 31.86 s [vm-test-run-dnscheck-module-test] machine # [ 10.801869] systemd[1]: Starting Rebuild Journal Catalog...
  1822. 31.88 s [vm-test-run-dnscheck-module-test] machine # [ 10.819884] systemd[1]: Starting Record System Boot/Shutdown in UTMP...
  1823. 32.11 s [vm-test-run-dnscheck-module-test] machine # [ 11.053388] systemd[1]: Finished Record System Boot/Shutdown in UTMP.
  1824. 32.19 s [vm-test-run-dnscheck-module-test] machine # [ 11.136410] systemd[1]: Finished Rebuild Journal Catalog.
  1825. 32.21 s [vm-test-run-dnscheck-module-test] machine # [ 11.152127] systemd[1]: Starting Update is Completed...
  1826. 32.23 s [vm-test-run-dnscheck-module-test] machine # [ 11.172683] systemd[1]: Load Kernel Module fuse skipped, unmet condition check ConditionKernelModuleLoaded=!fuse
  1827. 32.32 s [vm-test-run-dnscheck-module-test] machine # [ 11.264231] systemd[1]: Finished Update is Completed.
  1828. 32.35 s [vm-test-run-dnscheck-module-test] machine # [ 11.297359] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.
  1829. 32.36 s [vm-test-run-dnscheck-module-test] machine # [ 11.305641] systemd[1]: Finished Create SUID/SGID Wrappers.
  1830. 32.56 s [vm-test-run-dnscheck-module-test] machine # [ 11.500334] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.
  1831. 32.64 s [vm-test-run-dnscheck-module-test] machine # [ 11.531539] systemd[1]: Condition check resulted in /dev/ttyS0 being skipped.
  1832. 32.65 s [vm-test-run-dnscheck-module-test] machine # [ 11.594984] (udev-worker)[865]: [0;1;38:5:185meth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.
  1833. 32.67 s [vm-test-run-dnscheck-module-test] machine # [ 11.610804] (udev-worker)[865]: Network interface NamePolicy= disabled on kernel command line.
  1834. 32.68 s [vm-test-run-dnscheck-module-test] machine # [ 11.625698] (udev-worker)[872]: Network interface NamePolicy= disabled on kernel command line.
  1835. 32.82 s [vm-test-run-dnscheck-module-test] machine # [ 11.766539] systemd[1]: Finished Firewall.
  1836. 32.92 s [vm-test-run-dnscheck-module-test] machine # [ 11.862433] systemd[1]: Finished register-nix-paths.service.
  1837. 32.92 s [vm-test-run-dnscheck-module-test] machine # [ 11.866890] systemd[1]: Reached target System Initialization.
  1838. 32.93 s [vm-test-run-dnscheck-module-test] machine # [ 11.874574] systemd[1]: Started dnscheck.timer.
  1839. 32.94 s [vm-test-run-dnscheck-module-test] machine # [ 11.880623] systemd[1]: Started Discard unused filesystem blocks once a week.
  1840. 32.94 s [vm-test-run-dnscheck-module-test] machine # [ 11.886824] systemd[1]: Started Daily Cleanup of Temporary Directories.
  1841. 32.95 s [vm-test-run-dnscheck-module-test] machine # [ 11.895139] systemd[1]: Reached target Timer Units.
  1842. 32.95 s [vm-test-run-dnscheck-module-test] machine # [ 11.898675] systemd[1]: Listening on D-Bus System Message Bus Socket.
  1843. 32.96 s [vm-test-run-dnscheck-module-test] machine # [ 11.905326] systemd[1]: Listening on Nix Daemon Socket.
  1844. 32.96 s [vm-test-run-dnscheck-module-test] machine # [ 11.909367] systemd[1]: Listening on Hostname Service Socket.
  1845. 32.97 s [vm-test-run-dnscheck-module-test] machine # [ 11.915370] systemd[1]: Reached target Socket Units.
  1846. 32.98 s [vm-test-run-dnscheck-module-test] machine # [ 11.920193] systemd[1]: Reached target Basic System.
  1847. 32.98 s [vm-test-run-dnscheck-module-test] machine # [ 11.924882] systemd[1]: Started backdoor.service.
  1848. 32.99 s [vm-test-run-dnscheck-module-test] machine # [ 11.932344] systemd[1]: Starting Import lastlog data into lastlog2 database...
  1849. 32.99 s [vm-test-run-dnscheck-module-test] machine # [ 11.938978] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
  1850. 33.00 s [vm-test-run-dnscheck-module-test] machine # [ 11.943932] systemd[1]: Starting Post-Boot Actions...
  1851. 33.02 s [vm-test-run-dnscheck-module-test] machine # [ 11.959846] systemd[1]: Started Reset console on configuration changes.
  1852. 33.05 s [vm-test-run-dnscheck-module-test] machine # [ 11.991255] systemd[1]: Starting resolvconf update...
  1853. 33.10 s [vm-test-run-dnscheck-module-test] machine # [ 12.027603] systemd[1]: Condition check resulted in Virtio network device being skipped.
  1854. 33.12 s [vm-test-run-dnscheck-module-test] machine # connecting to host...
  1855. 33.15 s [vm-test-run-dnscheck-module-test] machine # [ 12.094723] systemd[1]: Starting D-Bus System Message Bus...
  1856. 33.16 s [vm-test-run-dnscheck-module-test] machine # [ 12.102950] nsncd[957]: Jun 01 11:16:09.259 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
  1857. 33.18 s [vm-test-run-dnscheck-module-test] machine # [ 12.124453] systemd[1]: Started Name Service Cache Daemon (nsncd).
  1858. 33.19 s [vm-test-run-dnscheck-module-test] machine # [ 12.133818] systemd[1]: Finished Post-Boot Actions.
  1859. 33.19 s [vm-test-run-dnscheck-module-test] machine: Guest shell says: b'Spawning backdoor root shell...\n'
  1860. 33.20 s [vm-test-run-dnscheck-module-test] machine: connected to guest root shell
  1861. 33.20 s [vm-test-run-dnscheck-module-test] machine: (connecting took 14.52 seconds)
  1862. 33.20 s [vm-test-run-dnscheck-module-test] machine: (finished: waiting for the VM to finish booting, in 14.52 seconds)
  1863. 33.20 s [vm-test-run-dnscheck-module-test] machine # [ 12.142836] systemd[1]: Reached target Host and Network Name Lookups.
  1864. 33.21 s [vm-test-run-dnscheck-module-test] machine # [ 12.153872] systemd[1]: Reached target User and Group Name Lookups.
  1865. 33.23 s [vm-test-run-dnscheck-module-test] machine # [ 12.170253] systemd[1]: Starting User Login Management...
  1866. 33.25 s [vm-test-run-dnscheck-module-test] machine # [ 12.190685] systemd[1]: Finished Import lastlog data into lastlog2 database.
  1867. 33.35 s [vm-test-run-dnscheck-module-test] machine # [ 13.063648] mousedev: PS/2 mouse device common for all mice
  1868. 33.42 s [vm-test-run-dnscheck-module-test] machine # [ 12.363837] dbus-broker-launch[968]: Looking up NSS user entry for 'systemd-timesync'...
  1869. 33.47 s [vm-test-run-dnscheck-module-test] machine # [ 13.182295] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
  1870. 33.48 s [vm-test-run-dnscheck-module-test] machine # [ 12.426880] systemd-logind[985]: New seat seat0.
  1871. 33.50 s [vm-test-run-dnscheck-module-test] machine # [ 12.440775] systemd[1]: Started User Login Management.
  1872. 33.52 s [vm-test-run-dnscheck-module-test] machine # [ 13.229840] ACPI: button: Power Button [PWRF]
  1873. 33.53 s [vm-test-run-dnscheck-module-test] machine # [ 12.478160] dbus-broker-launch[968]: NSS returned no entry for 'systemd-timesync'
  1874. 33.55 s [vm-test-run-dnscheck-module-test] machine # [ 12.486904] dbus-broker-launch[968]: Invalid user-name in /nix/store/849by4s7qkbp076m8r2b8qh1nc4l53if-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"
  1875. 33.57 s [vm-test-run-dnscheck-module-test] machine # [ 12.510673] systemd[1]: Stopped target Host and Network Name Lookups.
  1876. 33.58 s [vm-test-run-dnscheck-module-test] machine # [ 12.527840] systemd[1]: Stopping Host and Network Name Lookups...
  1877. 33.60 s [vm-test-run-dnscheck-module-test] machine # [ 12.540277] systemd[1]: Stopped target User and Group Name Lookups.
  1878. 33.61 s [vm-test-run-dnscheck-module-test] machine # [ 12.550851] systemd[1]: Stopping User and Group Name Lookups...
  1879. 33.62 s [vm-test-run-dnscheck-module-test] machine # [ 12.567639] systemd[1]: Starting linger-users.service...
  1880. 33.63 s [vm-test-run-dnscheck-module-test] machine # [ 12.577608] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...
  1881. 33.65 s [vm-test-run-dnscheck-module-test] machine # [ 12.588974] systemd[1]: nscd.service: Deactivated successfully.
  1882. 33.66 s [vm-test-run-dnscheck-module-test] machine # [ 12.599381] systemd[1]: Stopped Name Service Cache Daemon (nsncd).
  1883. 33.66 s [vm-test-run-dnscheck-module-test] machine # [ 12.605941] systemd[1]: Started D-Bus System Message Bus.
  1884. 33.69 s [vm-test-run-dnscheck-module-test] machine # [ 13.401831] rtc_cmos 00:05: RTC can wake from S4
  1885. 33.71 s [vm-test-run-dnscheck-module-test] machine # [ 12.649792] dbus-broker-launch[968]: Ready
  1886. 33.72 s [vm-test-run-dnscheck-module-test] machine # [ 12.665486] systemd[1]: linger-users.service: Deactivated successfully.
  1887. 33.73 s [vm-test-run-dnscheck-module-test] machine # [ 13.438118] Floppy drive(s): fd0 is 2.88M AMI BIOS
  1888. 33.73 s [vm-test-run-dnscheck-module-test] machine # [ 12.676348] systemd[1]: Finished linger-users.service.
  1889. 33.76 s [vm-test-run-dnscheck-module-test] machine # [ 12.705509] systemd[1]: Finished resolvconf update.
  1890. 33.77 s [vm-test-run-dnscheck-module-test] machine # [ 12.713230] systemd[1]: Reached target Preparation for Network.
  1891. 33.78 s [vm-test-run-dnscheck-module-test] machine # [ 12.724171] systemd[1]: Starting DHCP Client...
  1892. 33.79 s [vm-test-run-dnscheck-module-test] machine # [ 13.499077] parport_pc 00:03: reported by Plug and Play ACPI
  1893. 33.79 s [vm-test-run-dnscheck-module-test] machine # [ 12.737858] systemd[1]: Starting Address configuration of eth1...
  1894. 33.80 s [vm-test-run-dnscheck-module-test] machine # [ 12.748746] systemd[1]: Starting Extra networking commands....
  1895. 33.83 s [vm-test-run-dnscheck-module-test] machine # [ 12.769327] systemd[1]: Starting Name Service Cache Daemon (nsncd)...
  1896. 33.84 s [vm-test-run-dnscheck-module-test] machine # [ 13.552288] FDC 0 is a S82078B
  1897. 33.86 s [vm-test-run-dnscheck-module-test] machine # [ 13.566759] rtc_cmos 00:05: registered as rtc0
  1898. 33.91 s [vm-test-run-dnscheck-module-test] machine # [ 13.618200] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
  1899. 33.92 s [vm-test-run-dnscheck-module-test] machine # [ 13.630406] rtc_cmos 00:05: setting system clock to 2026-06-01T11:16:10 UTC (1780312570)
  1900. 33.95 s [vm-test-run-dnscheck-module-test] machine # [ 12.892686] systemd[1]: Started Name Service Cache Daemon (nsncd).
  1901. 33.96 s [vm-test-run-dnscheck-module-test] machine # [ 12.905841] systemd[1]: Reached target Host and Network Name Lookups.
  1902. 33.98 s [vm-test-run-dnscheck-module-test] machine # [ 12.919826] nsncd[1052]: Jun 01 11:16:10.534 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"
  1903. 33.99 s [vm-test-run-dnscheck-module-test] machine # [ 13.701149] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
  1904. 34.00 s [vm-test-run-dnscheck-module-test] machine # [ 12.946339] systemd[1]: Reached target User and Group Name Lookups.
  1905. 34.02 s [vm-test-run-dnscheck-module-test] machine # [ 13.729443] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs
  1906. 34.04 s [vm-test-run-dnscheck-module-test] machine # [ 12.981921] network-addresses-eth1-start[1050]: adding address 192.168.1.1/24... done[ 13.752022] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console
  1907. 34.05 s [vm-test-run-dnscheck-module-test] machine #
  1908. 34.08 s [vm-test-run-dnscheck-module-test] machine # [ 13.023167] network-addresses-eth1-start[1050]: adding address 2001:db8:1::1/64... done
  1909. 34.11 s [vm-test-run-dnscheck-module-test] machine # [ 13.045707] dhcpcd[1057]: dhcpcd-10.3.1 starting
  1910. 34.11 s [vm-test-run-dnscheck-module-test] machine # [ 13.058693] systemd[1]: Finished Address configuration of eth1.
  1911. 34.13 s [vm-test-run-dnscheck-module-test] machine # [ 13.071166] dhcpcd[1095]: dev: loaded udev
  1912. 34.15 s [vm-test-run-dnscheck-module-test] machine # [ 13.784238] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD
  1913. 34.16 s [vm-test-run-dnscheck-module-test] machine # [ 13.855950] Console: switching to colour dummy device 80x25
  1914. 34.17 s [vm-test-run-dnscheck-module-test] machine # [ 13.870077] 8021q: 802.1Q VLAN Support v1.8
  1915. 34.17 s [vm-test-run-dnscheck-module-test] machine # [ 13.870088] 8021q: adding VLAN 0 to HW filter on device eth1
  1916. 34.17 s [vm-test-run-dnscheck-module-test] machine # [ 13.882056] [drm] Found bochs VGA, ID 0xb0c5.
  1917. 34.17 s [vm-test-run-dnscheck-module-test] machine # [ 13.883721] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
  1918. 34.19 s [vm-test-run-dnscheck-module-test] machine # [ 13.904314] bochs-drm 0000:00:02.0: [drm] Registered 1 planes with drm panic
  1919. 34.20 s [vm-test-run-dnscheck-module-test] machine # [ 13.906311] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0
  1920. 34.21 s [vm-test-run-dnscheck-module-test] machine # [ 13.157719] systemd[1]: Finished Extra networking commands..
  1921. 34.22 s [vm-test-run-dnscheck-module-test] machine # [ 13.164524] systemd[1]: Reached target Network.
  1922. 34.23 s [vm-test-run-dnscheck-module-test] machine # [ 13.170214] systemd[1]: Starting Permit User Sessions...
  1923. 34.29 s [vm-test-run-dnscheck-module-test] machine # [ 13.235478] systemd[1]: Finished Permit User Sessions.
  1924. 34.36 s [vm-test-run-dnscheck-module-test] machine # [ 13.952830] fbcon: bochs-drmdrmfb (fb0) is primary device
  1925. 34.36 s [vm-test-run-dnscheck-module-test] machine # [ 14.066164] Console: switching to colour frame buffer device 160x50
  1926. 34.36 s [vm-test-run-dnscheck-module-test] machine # [ 14.069611] cfg80211: Loading compiled-in X.509 certificates for regulatory database
  1927. 34.36 s [vm-test-run-dnscheck-module-test] machine # [ 14.073721] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device
  1928. 34.37 s [vm-test-run-dnscheck-module-test] machine # [ 13.309917] systemd[1]: Started Getty on tty1.
  1929. 34.37 s [vm-test-run-dnscheck-module-test] machine # [ 13.316259] systemd[1]: Reached target Login Prompts.
  1930. 34.40 s [vm-test-run-dnscheck-module-test] machine # [ 14.107642] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
  1931. 34.40 s [vm-test-run-dnscheck-module-test] machine # [ 14.109261] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'
  1932. 34.40 s [vm-test-run-dnscheck-module-test] machine # [ 14.114175] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2
  1933. 34.40 s [vm-test-run-dnscheck-module-test] machine # [ 14.116332] cfg80211: failed to load regulatory.db
  1934. 34.48 s [vm-test-run-dnscheck-module-test] machine # [ 14.190689] 8021q: adding VLAN 0 to HW filter on device eth0
  1935. 34.48 s [vm-test-run-dnscheck-module-test] machine # [ 13.427613] dhcpcd[1095]: eth0: waiting for carrier
  1936. 34.49 s [vm-test-run-dnscheck-module-test] machine # [ 13.429811] dhcpcd[1095]: eth0: carrier acquired
  1937. 34.51 s [vm-test-run-dnscheck-module-test] machine # [ 13.446197] dhcpcd[1095]: DUID 00:01:00:01:31:b0:26:7b:52:54:00:12:34:56
  1938. 34.51 s [vm-test-run-dnscheck-module-test] machine # [ 13.451794] dhcpcd[1095]: eth0: IAID 00:12:34:56
  1939. 34.51 s [vm-test-run-dnscheck-module-test] machine # [ 13.455557] dhcpcd[1095]: eth0: adding address fe80::5054:ff:fe12:3456
  1940. 34.54 s [vm-test-run-dnscheck-module-test] machine # [ 14.245476] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4
  1941. 34.56 s [vm-test-run-dnscheck-module-test] machine # [ 14.268088] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6
  1942. 34.56 s [vm-test-run-dnscheck-module-test] machine # [ 13.507131] dhcpcd[1095]: eth0: soliciting a DHCP lease
  1943. 34.57 s [vm-test-run-dnscheck-module-test] machine # [ 14.276432] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5
  1944. 34.59 s [vm-test-run-dnscheck-module-test] machine # [ 14.299939] NET: Registered PF_PACKET protocol family
  1945. 34.60 s [vm-test-run-dnscheck-module-test] machine # [ 13.543152] dhcpcd[1095]: eth0: offered 10.0.2.15 from 10.0.2.2
  1946. 34.60 s [vm-test-run-dnscheck-module-test] machine # [ 13.546340] dhcpcd[1095]: eth0: probing address 10.0.2.15/24
  1947. 34.70 s [vm-test-run-dnscheck-module-test] machine # [ 13.648894] systemd[1]: Starting Virtual Console Setup...
  1948. 34.71 s [vm-test-run-dnscheck-module-test] machine # [ 13.657364] systemd-logind[985]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
  1949. 34.79 s [vm-test-run-dnscheck-module-test] machine # [ 13.732845] systemd-logind[985]: Watching system buttons on /dev/input/event2 (Power Button)
  1950. 34.85 s [vm-test-run-dnscheck-module-test] machine # [ 14.565946] ppdev: user-space parallel port driver
  1951. 34.91 s [vm-test-run-dnscheck-module-test] machine # [ 13.852853] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
  1952. 34.99 s [vm-test-run-dnscheck-module-test] machine # [ 13.934169] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1953. 35.00 s [vm-test-run-dnscheck-module-test] machine # [ 13.940619] systemd[1]: Stopped Virtual Console Setup.
  1954. 35.01 s [vm-test-run-dnscheck-module-test] machine # [ 13.952894] systemd[1]: Starting Virtual Console Setup...
  1955. 35.03 s [vm-test-run-dnscheck-module-test] machine # [ 13.973168] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.
  1956. 35.03 s [vm-test-run-dnscheck-module-test] machine # [ 13.978274] systemd[1]: Stopped Virtual Console Setup.
  1957. 35.04 s [vm-test-run-dnscheck-module-test] machine # [ 13.988770] systemd[1]: Starting Virtual Console Setup...
  1958. 35.07 s [vm-test-run-dnscheck-module-test] machine # [ 14.010273] systemd-logind[985]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard)
  1959. 35.15 s [vm-test-run-dnscheck-module-test] machine # [ 14.865992] kvm_amd: TSC scaling supported
  1960. 35.16 s [vm-test-run-dnscheck-module-test] machine # [ 14.867176] kvm_amd: Nested Virtualization enabled
  1961. 35.16 s [vm-test-run-dnscheck-module-test] machine # [ 14.868907] kvm_amd: Nested Paging enabled
  1962. 35.16 s [vm-test-run-dnscheck-module-test] machine # [ 14.870294] kvm_amd: LBR virtualization supported
  1963. 35.16 s [vm-test-run-dnscheck-module-test] machine # [ 14.871909] kvm_amd: Virtual VMLOAD VMSAVE supported
  1964. 35.16 s [vm-test-run-dnscheck-module-test] machine # [ 14.873399] kvm_amd: Virtual GIF supported
  1965. 35.21 s [vm-test-run-dnscheck-module-test] machine # [ 14.918246] EDAC MC: Ver: 3.0.0
  1966. 35.46 s [vm-test-run-dnscheck-module-test] machine # [ 14.407894] systemd-vconsole-setup[1166]: Configuration of first virtual console was skipped, ignoring remaining ones.
  1967. 35.47 s [vm-test-run-dnscheck-module-test] machine # [ 14.414575] systemd[1]: Finished Virtual Console Setup.
  1968. 36.07 s [vm-test-run-dnscheck-module-test] machine # [ 15.009861] dhcpcd[1095]: eth0: soliciting an IPv6 router
  1969. 36.07 s [vm-test-run-dnscheck-module-test] machine # [ 15.012354] dhcpcd[1095]: eth0: Router Advertisement from fe80::2
  1970. 36.07 s [vm-test-run-dnscheck-module-test] machine # [ 15.014444] dhcpcd[1095]: eth0: adding address fec0::5054:ff:fe12:3456/64
  1971. 36.07 s [vm-test-run-dnscheck-module-test] machine # [ 15.016477] dhcpcd[1095]: eth0: adding route to fec0::/64
  1972. 36.07 s [vm-test-run-dnscheck-module-test] machine # [ 15.018404] dhcpcd[1095]: eth0: adding default route via fe80::2
  1973. 39.72 s [vm-test-run-dnscheck-module-test] machine # [ 18.665101] dhcpcd[1095]: eth0: leased 10.0.2.15 for 86400 seconds
  1974. 39.77 s [vm-test-run-dnscheck-module-test] machine # [ 18.667596] dhcpcd[1095]: eth0: adding route to 10.0.2.0/24
  1975. 39.77 s [vm-test-run-dnscheck-module-test] machine # [ 18.670158] dhcpcd[1095]: eth0: adding default route via 10.0.2.2
  1976. 39.81 s [vm-test-run-dnscheck-module-test] machine # [ 18.757276] systemd[1]: Started DHCP Client.
  1977. 39.82 s [vm-test-run-dnscheck-module-test] machine # [ 18.760808] systemd[1]: Reached target Multi-User System.
  1978. 39.82 s [vm-test-run-dnscheck-module-test] machine # [ 18.763153] systemd[1]: Startup finished in 2.430s (kernel) + 4.555s (initrd) + 11.776s (userspace) = 18.762s.
  1979. 40.29 s [vm-test-run-dnscheck-module-test] machine: (finished: waiting for unit multi-user.target, in 21.61 seconds)
  1980. 40.33 s [vm-test-run-dnscheck-module-test] machine # [ 19.275526] systemd[1]: Started DNS Checker.
  1981. 40.36 s [vm-test-run-dnscheck-module-test] machine # [ 19.307505] dnscheck-start[1267]: + tmpfile=/root/.dnscheck
  1982. 40.37 s [vm-test-run-dnscheck-module-test] machine # [ 19.310255] dnscheck-start[1267]: + /nix/store/j5y3fig564w0g24hn9k4c0skjd8kmmk9-dnscheck-0.0.0.0/bin/dnscheck /nix/store/5ycb8gix9xbrv34zd7bkadcvn3czsf0b-dnscheck-config.yaml
  1983. 40.45 s [vm-test-run-dnscheck-module-test] machine # [ 19.396516] dnscheck-start[1267]: + exitcode=0
  1984. 40.45 s [vm-test-run-dnscheck-module-test] machine # [ 19.398082] dnscheck-start[1267]: + [[ 0 != 0 ]]
  1985. 40.46 s [vm-test-run-dnscheck-module-test] machine # [ 19.401314] systemd[1]: dnscheck.service: Deactivated successfully.
  1986. 40.46 s [vm-test-run-dnscheck-module-test] machine: checking if unit 'dnscheck.service' has reached state 'inactive'
  1987. 40.50 s [vm-test-run-dnscheck-module-test] machine: (finished: checking if unit 'dnscheck.service' has reached state 'inactive', in 0.04 seconds)
  1988. 40.50 s [vm-test-run-dnscheck-module-test] (finished: run the VM test script, in 22.46 seconds)
  1989. 40.57 s [vm-test-run-dnscheck-module-test] test script finished in 22.53s
  1990. 40.57 s [vm-test-run-dnscheck-module-test] cleanup
  1991. 40.57 s [vm-test-run-dnscheck-module-test] kill QemuMachine (pid 12)
  1992. 40.57 s [vm-test-run-dnscheck-module-test] machine # qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/60m4rxhg2fldqaak400c0lry96ijrzqn-python3-3.13.13/bin/python3.13)
  1993. 40.66 s [vm-test-run-dnscheck-module-test] (finished: cleanup, in 0.09 seconds)
  1994. 40.74 s [post-build-hook] Uploading to the NixCI staging cache: /nix/store/0h9aj15h20kq4ldqc2l1rami935kdzbc-vm-test-run-dnscheck-module-test
  1995. 40.79 s [post-build-hook] copying 1 paths...
  1996. 40.79 s [post-build-hook] copying path '/nix/store/0h9aj15h20kq4ldqc2l1rami935kdzbc-vm-test-run-dnscheck-module-test' to 'https://cache.staging.nix-ci.com'...
  1997. 42.06 s [post-build-hook] copying 0 paths...
  1998. 42.12 s Progress: 1 of 2 built, 524 of 524 downloaded from cache
Tail Raw Logs