$ /nix/store/61685rbaxmpigwi3z23i33sv3jyfl70q-coreutils-9.11/bin/timeout --kill-after=15s 7200s /nix/store/wknkybkzrc16r11vk5vrykh4wmw7a353-nix-2.34.8/bin/nix --extra-experimental-features nix-command --extra-experimental-features flakes --log-format internal-json build --no-link --print-out-paths git+https://github.com/NorfairKing/centjes?ref=stripe-stop-at-failing-month&rev=fed3b3d1a894d6632c2fb1bb97a441ecc781368c&shallow=1#checks.x86_64-linux.e2e-test --print-build-logs fetching Git repository 'https://github.com/NorfairKing/centjes' remote: Enumerating objects: 1112, done. remote: Counting objects: 0% (1/1112) remote: Counting objects: 1% (12/1112) remote: Counting objects: 2% (23/1112) remote: Counting objects: 3% (34/1112) remote: Counting objects: 4% (45/1112) remote: Counting objects: 5% (56/1112) remote: Counting objects: 6% (67/1112) remote: Counting objects: 7% (78/1112) remote: Counting objects: 8% (89/1112) remote: Counting objects: 9% (101/1112) remote: Counting objects: 10% (112/1112) remote: Counting objects: 11% (123/1112) remote: Counting objects: 12% (134/1112) remote: Counting objects: 13% (145/1112) remote: Counting objects: 14% (156/1112) remote: Counting objects: 15% (167/1112) remote: Counting objects: 16% (178/1112) remote: Counting objects: 17% (190/1112) remote: Counting objects: 18% (201/1112) remote: Counting objects: 19% (212/1112) remote: Counting objects: 20% (223/1112) remote: Counting objects: 21% (234/1112) remote: Counting objects: 22% (245/1112) remote: Counting objects: 23% (256/1112) remote: Counting objects: 24% (267/1112) remote: Counting objects: 25% (278/1112) remote: Counting objects: 26% (290/1112) remote: Counting objects: 27% (301/1112) remote: Counting objects: 28% (312/1112) remote: Counting objects: 29% (323/1112) remote: Counting objects: 30% (334/1112) remote: Counting objects: 31% (345/1112) remote: Counting objects: 32% (356/1112) remote: Counting objects: 33% (367/1112) remote: Counting objects: 34% (379/1112) remote: Counting objects: 35% (390/1112) remote: Counting objects: 36% (401/1112) remote: Counting objects: 37% (412/1112) remote: Counting objects: 38% (423/1112) remote: Counting objects: 39% (434/1112) remote: Counting objects: 40% (445/1112) remote: Counting objects: 41% (456/1112) remote: Counting objects: 42% (468/1112) remote: Counting objects: 43% (479/1112) remote: Counting objects: 44% (490/1112) remote: Counting objects: 45% (501/1112) remote: Counting objects: 46% (512/1112) remote: Counting objects: 47% (523/1112) remote: Counting objects: 48% (534/1112) remote: Counting objects: 49% (545/1112) remote: Counting objects: 50% (556/1112) remote: Counting objects: 51% (568/1112) remote: Counting objects: 52% (579/1112) remote: Counting objects: 53% (590/1112) remote: Counting objects: 54% (601/1112) remote: Counting objects: 55% (612/1112) remote: Counting objects: 56% (623/1112) remote: Counting objects: 57% (634/1112) remote: Counting objects: 58% (645/1112) remote: Counting objects: 59% (657/1112) remote: Counting objects: 60% (668/1112) remote: Counting objects: 61% (679/1112) remote: Counting objects: 62% (690/1112) remote: Counting objects: 63% (701/1112) remote: Counting objects: 64% (712/1112) remote: Counting objects: 65% (723/1112) remote: Counting objects: 66% (734/1112) remote: Counting objects: 67% (746/1112) remote: Counting objects: 68% (757/1112) remote: Counting objects: 69% (768/1112) remote: Counting objects: 70% (779/1112) remote: Counting objects: 71% (790/1112) remote: Counting objects: 72% (801/1112) remote: Counting objects: 73% (812/1112) remote: Counting objects: 74% (823/1112) remote: Counting objects: 75% (834/1112) remote: Counting objects: 76% (846/1112) remote: Counting objects: 77% (857/1112) remote: Counting objects: 78% (868/1112) remote: Counting objects: 79% (879/1112) remote: Counting objects: 80% (890/1112) remote: Counting objects: 81% (901/1112) remote: Counting objects: 82% (912/1112) remote: Counting objects: 83% (923/1112) remote: Counting objects: 84% (935/1112) remote: Counting objects: 85% (946/1112) remote: Counting objects: 86% (957/1112) remote: Counting objects: 87% (968/1112) remote: Counting objects: 88% (979/1112) remote: Counting objects: 89% (990/1112) remote: Counting objects: 90% (1001/1112) remote: Counting objects: 91% (1012/1112) remote: Counting objects: 92% (1024/1112) remote: Counting objects: 93% (1035/1112) remote: Counting objects: 94% (1046/1112) remote: Counting objects: 95% (1057/1112) remote: Counting objects: 96% (1068/1112) remote: Counting objects: 97% (1079/1112) remote: Counting objects: 98% (1090/1112) remote: Counting objects: 99% (1101/1112) remote: Counting objects: 100% (1112/1112) remote: Counting objects: 100% (1112/1112), done. remote: Compressing objects: 0% (1/753) remote: Compressing objects: 1% (8/753) remote: Compressing objects: 2% (16/753) remote: Compressing objects: 3% (23/753) remote: Compressing objects: 4% (31/753) remote: Compressing objects: 5% (38/753) remote: Compressing objects: 6% (46/753) remote: Compressing objects: 7% (53/753) remote: Compressing objects: 8% (61/753) remote: Compressing objects: 9% (68/753) remote: Compressing objects: 10% (76/753) remote: Compressing objects: 11% (83/753) remote: Compressing objects: 12% (91/753) remote: Compressing objects: 13% (98/753) remote: Compressing objects: 14% (106/753) remote: Compressing objects: 15% (113/753) remote: Compressing objects: 16% (121/753) remote: Compressing objects: 17% (129/753) remote: Compressing objects: 18% (136/753) remote: Compressing objects: 19% (144/753) remote: Compressing objects: 20% (151/753) remote: Compressing objects: 21% (159/753) remote: Compressing objects: 22% (166/753) remote: Compressing objects: 23% (174/753) remote: Compressing objects: 24% (181/753) remote: Compressing objects: 25% (189/753) remote: Compressing objects: 26% (196/753) remote: Compressing objects: 27% (204/753) remote: Compressing objects: 28% (211/753) remote: Compressing objects: 29% (219/753) remote: Compressing objects: 30% (226/753) remote: Compressing objects: 31% (234/753) remote: Compressing objects: 32% (241/753) remote: Compressing objects: 33% (249/753) remote: Compressing objects: 34% (257/753) remote: Compressing objects: 35% (264/753) remote: Compressing objects: 36% (272/753) remote: Compressing objects: 37% (279/753) remote: Compressing objects: 38% (287/753) remote: Compressing objects: 39% (294/753) remote: Compressing objects: 40% (302/753) remote: Compressing objects: 41% (309/753) remote: Compressing objects: 42% (317/753) remote: Compressing objects: 43% (324/753) remote: Compressing objects: 44% (332/753) remote: Compressing objects: 45% (339/753) remote: Compressing objects: 46% (347/753) remote: Compressing objects: 47% (354/753) remote: Compressing objects: 48% (362/753) remote: Compressing objects: 49% (369/753) remote: Compressing objects: 50% (377/753) remote: Compressing objects: 51% (385/753) remote: Compressing objects: 52% (392/753) remote: Compressing objects: 53% (400/753) remote: Compressing objects: 54% (407/753) remote: Compressing objects: 55% (415/753) remote: Compressing objects: 56% (422/753) remote: Compressing objects: 57% (430/753) remote: Compressing objects: 58% (437/753) remote: Compressing objects: 59% (445/753) remote: Compressing objects: 60% (452/753) remote: Compressing objects: 61% (460/753) remote: Compressing objects: 62% (467/753) remote: Compressing objects: 63% (475/753) remote: Compressing objects: 64% (482/753) remote: Compressing objects: 65% (490/753) remote: Compressing objects: 66% (497/753) remote: Compressing objects: 67% (505/753) remote: Compressing objects: 68% (513/753) remote: Compressing objects: 69% (520/753) remote: Compressing objects: 70% (528/753) remote: Compressing objects: 71% (535/753) remote: Compressing objects: 72% (543/753) remote: Compressing objects: 73% (550/753) remote: Compressing objects: 74% (558/753) remote: Compressing objects: 75% (565/753) remote: Compressing objects: 76% (573/753) remote: Compressing objects: 77% (580/753) remote: Compressing objects: 78% (588/753) remote: Compressing objects: 79% (595/753) remote: Compressing objects: 80% (603/753) remote: Compressing objects: 81% (610/753) remote: Compressing objects: 82% (618/753) remote: Compressing objects: 83% (625/753) remote: Compressing objects: 84% (633/753) remote: Compressing objects: 85% (641/753) remote: Compressing objects: 86% (648/753) remote: Compressing objects: 87% (656/753) remote: Compressing objects: 88% (663/753) remote: Compressing objects: 89% (671/753) remote: Compressing objects: 90% (678/753) remote: Compressing objects: 91% (686/753) remote: Compressing objects: 92% (693/753) remote: Compressing objects: 93% (701/753) remote: Compressing objects: 94% (708/753) remote: Compressing objects: 95% (716/753) remote: Compressing objects: 96% (723/753) remote: Compressing objects: 97% (731/753) remote: Compressing objects: 98% (738/753) remote: Compressing objects: 99% (746/753) remote: Compressing objects: 100% (753/753) remote: Compressing objects: 100% (753/753), done. Receiving objects: 0% (1/1112) Receiving objects: 1% (12/1112) Receiving objects: 2% (23/1112) Receiving objects: 3% (34/1112) Receiving objects: 4% (45/1112) Receiving objects: 5% (56/1112) Receiving objects: 6% (67/1112) Receiving objects: 7% (78/1112) Receiving objects: 8% (89/1112) Receiving objects: 9% (101/1112) Receiving objects: 10% (112/1112) Receiving objects: 11% (123/1112) Receiving objects: 12% (134/1112) Receiving objects: 13% (145/1112) Receiving objects: 14% (156/1112) Receiving objects: 15% (167/1112) Receiving objects: 16% (178/1112) Receiving objects: 17% (190/1112) Receiving objects: 18% (201/1112) Receiving objects: 19% (212/1112) Receiving objects: 20% (223/1112) Receiving objects: 21% (234/1112) Receiving objects: 22% (245/1112) Receiving objects: 23% (256/1112) Receiving objects: 24% (267/1112) Receiving objects: 25% (278/1112) Receiving objects: 26% (290/1112) Receiving objects: 27% (301/1112) Receiving objects: 28% (312/1112) Receiving objects: 29% (323/1112) Receiving objects: 30% (334/1112) Receiving objects: 31% (345/1112) Receiving objects: 32% (356/1112) Receiving objects: 33% (367/1112) Receiving objects: 34% (379/1112) Receiving objects: 35% (390/1112) Receiving objects: 36% (401/1112) Receiving objects: 37% (412/1112) Receiving objects: 38% (423/1112) Receiving objects: 39% (434/1112) Receiving objects: 40% (445/1112) Receiving objects: 41% (456/1112) Receiving objects: 42% (468/1112) Receiving objects: 43% (479/1112) Receiving objects: 44% (490/1112) Receiving objects: 45% (501/1112) Receiving objects: 46% (512/1112) Receiving objects: 47% (523/1112) Receiving objects: 48% (534/1112) Receiving objects: 49% (545/1112) Receiving objects: 50% (556/1112) Receiving objects: 51% (568/1112) Receiving objects: 52% (579/1112) Receiving objects: 53% (590/1112) Receiving objects: 54% (601/1112) Receiving objects: 55% (612/1112) Receiving objects: 56% (623/1112) Receiving objects: 57% (634/1112) Receiving objects: 58% (645/1112) Receiving objects: 59% (657/1112) Receiving objects: 60% (668/1112) Receiving objects: 61% (679/1112) Receiving objects: 62% (690/1112) Receiving objects: 63% (701/1112) Receiving objects: 64% (712/1112) Receiving objects: 65% (723/1112) Receiving objects: 66% (734/1112) Receiving objects: 67% (746/1112) Receiving objects: 68% (757/1112) Receiving objects: 69% (768/1112) Receiving objects: 70% (779/1112) Receiving objects: 71% (790/1112) Receiving objects: 72% (801/1112) Receiving objects: 73% (812/1112) Receiving objects: 74% (823/1112) Receiving objects: 75% (834/1112) Receiving objects: 76% (846/1112) Receiving objects: 77% (857/1112) Receiving objects: 78% (868/1112) Receiving objects: 79% (879/1112) Receiving objects: 80% (890/1112) Receiving objects: 81% (901/1112) Receiving objects: 82% (912/1112) Receiving objects: 83% (923/1112) Receiving objects: 84% (935/1112) Receiving objects: 85% (946/1112) Receiving objects: 86% (957/1112) Receiving objects: 87% (968/1112) Receiving objects: 88% (979/1112) Receiving objects: 89% (990/1112) Receiving objects: 90% (1001/1112) Receiving objects: 91% (1012/1112) Receiving objects: 92% (1024/1112) Receiving objects: 93% (1035/1112) Receiving objects: 94% (1046/1112) Receiving objects: 95% (1057/1112) Receiving objects: 96% (1068/1112) Receiving objects: 97% (1079/1112) remote: Total 1112 (delta 293), reused 779 (delta 180), pack-reused 0 (from 0) Receiving objects: 98% (1090/1112) Receiving objects: 99% (1101/1112) Receiving objects: 100% (1112/1112) Receiving objects: 100% (1112/1112), 452.73 KiB | 4.97 MiB/s, done. Resolving deltas: 0% (0/293) Resolving deltas: 1% (3/293) Resolving deltas: 2% (6/293) Resolving deltas: 3% (9/293) Resolving deltas: 4% (12/293) Resolving deltas: 5% (15/293) Resolving deltas: 6% (18/293) Resolving deltas: 7% (21/293) Resolving deltas: 8% (24/293) Resolving deltas: 9% (27/293) Resolving deltas: 10% (30/293) Resolving deltas: 11% (33/293) Resolving deltas: 12% (36/293) Resolving deltas: 13% (39/293) Resolving deltas: 14% (42/293) Resolving deltas: 15% (44/293) Resolving deltas: 16% (47/293) Resolving deltas: 17% (50/293) Resolving deltas: 18% (53/293) Resolving deltas: 19% (56/293) Resolving deltas: 20% (59/293) Resolving deltas: 21% (62/293) Resolving deltas: 22% (65/293) Resolving deltas: 23% (68/293) Resolving deltas: 24% (71/293) Resolving deltas: 25% (74/293) Resolving deltas: 26% (77/293) Resolving deltas: 27% (80/293) Resolving deltas: 28% (83/293) Resolving deltas: 29% (87/293) Resolving deltas: 30% (88/293) Resolving deltas: 31% (92/293) Resolving deltas: 32% (94/293) Resolving deltas: 33% (97/293) Resolving deltas: 34% (100/293) Resolving deltas: 35% (104/293) Resolving deltas: 36% (106/293) Resolving deltas: 37% (109/293) Resolving deltas: 38% (112/293) Resolving deltas: 39% (115/293) Resolving deltas: 40% (118/293) Resolving deltas: 41% (121/293) Resolving deltas: 42% (124/293) Resolving deltas: 43% (126/293) Resolving deltas: 44% (129/293) Resolving deltas: 45% (132/293) Resolving deltas: 46% (135/293) Resolving deltas: 47% (138/293) Resolving deltas: 48% (141/293) Resolving deltas: 49% (144/293) Resolving deltas: 50% (147/293) Resolving deltas: 51% (150/293) Resolving deltas: 52% (153/293) Resolving deltas: 53% (156/293) Resolving deltas: 54% (159/293) Resolving deltas: 55% (162/293) Resolving deltas: 56% (165/293) Resolving deltas: 57% (168/293) Resolving deltas: 58% (170/293) Resolving deltas: 59% (173/293) Resolving deltas: 60% (176/293) Resolving deltas: 61% (179/293) Resolving deltas: 62% (182/293) Resolving deltas: 63% (185/293) Resolving deltas: 64% (188/293) Resolving deltas: 65% (191/293) Resolving deltas: 66% (195/293) Resolving deltas: 67% (197/293) Resolving deltas: 68% (200/293) Resolving deltas: 69% (203/293) Resolving deltas: 70% (206/293) Resolving deltas: 71% (209/293) Resolving deltas: 72% (211/293) Resolving deltas: 73% (214/293) Resolving deltas: 74% (217/293) Resolving deltas: 75% (220/293) Resolving deltas: 76% (224/293) Resolving deltas: 77% (226/293) Resolving deltas: 78% (229/293) Resolving deltas: 79% (232/293) Resolving deltas: 80% (235/293) Resolving deltas: 81% (238/293) Resolving deltas: 82% (242/293) Resolving deltas: 83% (244/293) Resolving deltas: 84% (247/293) Resolving deltas: 85% (250/293) Resolving deltas: 86% (254/293) Resolving deltas: 87% (255/293) Resolving deltas: 88% (258/293) Resolving deltas: 89% (261/293) Resolving deltas: 90% (264/293) Resolving deltas: 91% (268/293) Resolving deltas: 92% (271/293) Resolving deltas: 93% (273/293) Resolving deltas: 94% (276/293) Resolving deltas: 95% (279/293) Resolving deltas: 96% (282/293) Resolving deltas: 97% (285/293) Resolving deltas: 98% (288/293) Resolving deltas: 99% (291/293) Resolving deltas: 100% (293/293) Resolving deltas: 100% (293/293), done. From https://github.com/NorfairKing/centjes * branch fed3b3d1a894d6632c2fb1bb97a441ecc781368c -> FETCH_HEAD warning: ignoring untrusted flake configuration setting 'extra-substituters'. Pass '--accept-flake-config' to trust it warning: ignoring untrusted flake configuration setting 'extra-trusted-public-keys'. Pass '--accept-flake-config' to trust it error (ignored): SQLite database '/var/cache/nix-ci-worker/eval-cache-v6/f302d970bb62a75a9211e26193abb4a0f4be84fb318b74233c5d06830cfe9826.sqlite' is busy  Waiting for lock on centjes-docs-site-source Waiting for lock on centjes-docs-site Building /nix/store/l9xyin54x2snqlh3ywrk39v1jfjgv4r9-settings-check.drv Building /nix/store/hkdygij2l8yc6jmvdjk93l4am4zbx7vn-unit-script-centjes-docs-site-production-start.drv [unit-script-centjes-docs-site-production-start:post-build] Uploading to cachix cache "centjes": /nix/store/6135lh1fh1qqhphar602c82r3pcpp1fr-unit-script-centjes-docs-site-production-start [unit-script-centjes-docs-site-production-start:post-build] Pushing 1 paths (29 are already present) using zstd to cache centjes ⏳ [unit-script-centjes-docs-site-production-start:post-build]  [unit-script-centjes-docs-site-production-start:post-build] Pushing /nix/store/6135lh1fh1qqhphar602c82r3pcpp1fr-unit-script-centjes-docs-site-production-start (680.00 B) [unit-script-centjes-docs-site-production-start:post-build]  [unit-script-centjes-docs-site-production-start:post-build] All done. [unit-script-centjes-docs-site-production-start:post-build] Uploading to the NixCI staging cache: /nix/store/6135lh1fh1qqhphar602c82r3pcpp1fr-unit-script-centjes-docs-site-production-start [unit-script-centjes-docs-site-production-start:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [unit-script-centjes-docs-site-production-start:post-build] copying 1 paths... [unit-script-centjes-docs-site-production-start:post-build] copying path '/nix/store/6135lh1fh1qqhphar602c82r3pcpp1fr-unit-script-centjes-docs-site-production-start' to 'https://cache.staging.nix-ci.com'... [unit-script-centjes-docs-site-production-start:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [unit-script-centjes-docs-site-production-start:post-build] copying 1 paths... [unit-script-centjes-docs-site-production-start:post-build] copying path '/nix/store/hkdygij2l8yc6jmvdjk93l4am4zbx7vn-unit-script-centjes-docs-site-production-start.drv' to 'https://cache.staging.nix-ci.com'... Uploaded unit-script-centjes-docs-site-production-start in 3.0s Progress: 1 of 13 built (1 building) Built unit-script-centjes-docs-site-production-start in 3.1s [settings-check:post-build] Uploading to cachix cache "centjes": /nix/store/ifkgcykij1jhj7c3zarjjbx2z764l7s5-settings-check [settings-check:post-build] Pushing 1 paths (30 are already present) using zstd to cache centjes ⏳ [settings-check:post-build]  [settings-check:post-build] Pushing /nix/store/ifkgcykij1jhj7c3zarjjbx2z764l7s5-settings-check (880.00 B) [settings-check:post-build]  [settings-check:post-build] All done. [settings-check:post-build] Uploading to the NixCI staging cache: /nix/store/ifkgcykij1jhj7c3zarjjbx2z764l7s5-settings-check [settings-check:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [settings-check:post-build] copying 1 paths... [settings-check:post-build] copying path '/nix/store/ifkgcykij1jhj7c3zarjjbx2z764l7s5-settings-check' to 'https://cache.staging.nix-ci.com'... [settings-check:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [settings-check:post-build] copying 0 paths... Uploaded settings-check in 2.2s Progress: 2 of 13 built Built settings-check in 5.4s Building /nix/store/sjmsh56n6v6m3l6gidmwwrbpw5m4g1vj-settings-check.drv [settings-check] WithConfig: src/Centjes/Docs/Site/OptParse.hs:27:7 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  loading config [settings-check]  Parser with check: src/Centjes/Docs/Site/OptParse.hs:27:7 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  parser [settings-check]  Alt [settings-check]  Trying left side. [settings-check]  Parser with check: src/Centjes/Docs/Site/OptParse.hs:27:7 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  parser [settings-check]  Setting: src/Centjes/Docs/Site/OptParse.hs:27:7 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  could not set based on options, no option: ["--config-file"] [settings-check]  set based on env: "/nix/store/vb9vv8cg7xwfa7010fyznaj7b5syrx63-centjes-docs-site-config.yaml" [settings-check]  check [settings-check]  succeeded [settings-check]  Left side succeeded. [settings-check]  check [settings-check]  succeeded [settings-check]  with loaded config [settings-check]  Ap [settings-check]  Ap [settings-check]  Parser with check: without srcLoc [settings-check]  parser [settings-check]  Setting: src/Centjes/Docs/Site/OptParse.hs:29:11 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  could not set based on options, no option: ["--port"] [settings-check]  could not set based on env vars, no var: [EnvVarSetting {envVarSettingVar = "CENTJES_DOCS_SITE_PORT", envVarSettingAllowPrefix = True}] [settings-check]  set based on config value: Number 8001.0 [settings-check]  check [settings-check]  succeeded [settings-check]  Alt [settings-check]  Trying left side. [settings-check]  Parser with check: without srcLoc [settings-check]  parser [settings-check]  Setting: src/Centjes/Docs/Site/OptParse.hs:38:13 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  could not set based on options, no option: ["--google-analytics-tracking"] [settings-check]  could not set based on env vars, no var: [EnvVarSetting {envVarSettingVar = "CENTJES_DOCS_SITE_GOOGLE_ANALYTICS_TRACKING", envVarSettingAllowPrefix = True}] [settings-check]  could not set based on config value, configured to nothing: ["google-analytics-tracking"] [settings-check]  not found [settings-check]  check [settings-check]  Left side failed, trying right side. [settings-check]  pure value [settings-check]  Alt [settings-check]  Trying left side. [settings-check]  Parser with check: without srcLoc [settings-check]  parser [settings-check]  Setting: src/Centjes/Docs/Site/OptParse.hs:46:13 in centjes-docs-site:Centjes.Docs.Site.OptParse [settings-check]  could not set based on options, no option: ["--google-search-console-verification"] [settings-check]  could not set based on env vars, no var: [EnvVarSetting {envVarSettingVar = "CENTJES_DOCS_SITE_GOOGLE_SEARCH_CONSOLE_VERIFICATION", envVarSettingAllowPrefix = True}] [settings-check]  could not set based on config value, configured to nothing: ["google-search-console-verification"] [settings-check]  not found [settings-check]  check [settings-check]  Left side failed, trying right side. [settings-check]  pure value [settings-check:post-build] Uploading to cachix cache "centjes": /nix/store/nciahq33l541v3i4y2dnpk28dxjk66k8-settings-check [settings-check:post-build] Pushing 1 paths (0 are already present) using zstd to cache centjes ⏳ [settings-check:post-build]  [settings-check:post-build] Pushing /nix/store/nciahq33l541v3i4y2dnpk28dxjk66k8-settings-check (144.00 B) [settings-check:post-build]  [settings-check:post-build] All done. [settings-check:post-build] Uploading to the NixCI staging cache: /nix/store/nciahq33l541v3i4y2dnpk28dxjk66k8-settings-check [settings-check:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [settings-check:post-build] copying 1 paths... [settings-check:post-build] copying path '/nix/store/nciahq33l541v3i4y2dnpk28dxjk66k8-settings-check' to 'https://cache.staging.nix-ci.com'... [settings-check:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [settings-check:post-build] copying 1 paths... [settings-check:post-build] copying path '/nix/store/sjmsh56n6v6m3l6gidmwwrbpw5m4g1vj-settings-check.drv' to 'https://cache.staging.nix-ci.com'... Uploaded settings-check in 2.7s Progress: 3 of 13 built Built settings-check in 2.9s Building /nix/store/sqzbg2q35yqf661iqgnd5v81l1wlhmyw-unit-centjes-docs-site-production.service.drv [unit-centjes-docs-site-production.service:post-build] Uploading to cachix cache "centjes": /nix/store/csii69fj3hb3x99pijg8hwv7j50wgkrd-unit-centjes-docs-site-production.service [unit-centjes-docs-site-production.service:post-build] Pushing 1 paths (91 are already present) using zstd to cache centjes ⏳ [unit-centjes-docs-site-production.service:post-build]  [unit-centjes-docs-site-production.service:post-build] Pushing /nix/store/csii69fj3hb3x99pijg8hwv7j50wgkrd-unit-centjes-docs-site-production.service (1.62 KiB) [unit-centjes-docs-site-production.service:post-build]  [unit-centjes-docs-site-production.service:post-build] All done. [unit-centjes-docs-site-production.service:post-build] Uploading to the NixCI staging cache: /nix/store/csii69fj3hb3x99pijg8hwv7j50wgkrd-unit-centjes-docs-site-production.service [unit-centjes-docs-site-production.service:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [unit-centjes-docs-site-production.service:post-build] copying 1 paths... [unit-centjes-docs-site-production.service:post-build] copying path '/nix/store/csii69fj3hb3x99pijg8hwv7j50wgkrd-unit-centjes-docs-site-production.service' to 'https://cache.staging.nix-ci.com'... [unit-centjes-docs-site-production.service:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [unit-centjes-docs-site-production.service:post-build] copying 1 paths... [unit-centjes-docs-site-production.service:post-build] copying path '/nix/store/sqzbg2q35yqf661iqgnd5v81l1wlhmyw-unit-centjes-docs-site-production.service.drv' to 'https://cache.staging.nix-ci.com'... Uploaded unit-centjes-docs-site-production.service in 2.6s Progress: 4 of 13 built Built unit-centjes-docs-site-production.service in 2.7s Building /nix/store/ikd6qlddyzp7z605sxbkcqhgr28az43d-system-units.drv [system-units:post-build] Uploading to cachix cache "centjes": /nix/store/nvbhxa6czgcm6ss20l903v4hybqkp1s8-system-units [system-units:post-build] Pushing 1 paths (450 are already present) using zstd to cache centjes ⏳ [system-units:post-build]  [system-units:post-build] Pushing /nix/store/nvbhxa6czgcm6ss20l903v4hybqkp1s8-system-units (96.09 KiB) [system-units:post-build]  [system-units:post-build] All done. [system-units:post-build] Uploading to the NixCI staging cache: /nix/store/nvbhxa6czgcm6ss20l903v4hybqkp1s8-system-units [system-units:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [system-units:post-build] copying 1 paths... [system-units:post-build] copying path '/nix/store/nvbhxa6czgcm6ss20l903v4hybqkp1s8-system-units' to 'https://cache.staging.nix-ci.com'... [system-units:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [system-units:post-build] copying 1 paths... [system-units:post-build] copying path '/nix/store/ikd6qlddyzp7z605sxbkcqhgr28az43d-system-units.drv' to 'https://cache.staging.nix-ci.com'... Uploaded system-units in 4.6s Progress: 5 of 13 built Built system-units in 5.5s Building /nix/store/zwg7xjhz8qxkxhizqcqqcczlmrxx2932-etc.drv [etc:post-build] Uploading to cachix cache "centjes": /nix/store/w90krml2dq8lgm30lv3zl7lrgsvi0dp3-etc [etc:post-build] Pushing 1 paths (546 are already present) using zstd to cache centjes ⏳ [etc:post-build]  [etc:post-build] Pushing /nix/store/w90krml2dq8lgm30lv3zl7lrgsvi0dp3-etc (31.56 KiB) [etc:post-build]  [etc:post-build] All done. [etc:post-build] Uploading to the NixCI staging cache: /nix/store/w90krml2dq8lgm30lv3zl7lrgsvi0dp3-etc [etc:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [etc:post-build] copying 1 paths... [etc:post-build] copying path '/nix/store/w90krml2dq8lgm30lv3zl7lrgsvi0dp3-etc' to 'https://cache.staging.nix-ci.com'... [etc:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [etc:post-build] copying 1 paths... [etc:post-build] copying path '/nix/store/zwg7xjhz8qxkxhizqcqqcczlmrxx2932-etc.drv' to 'https://cache.staging.nix-ci.com'... Uploaded etc in 3.3s Progress: 6 of 13 built Built etc in 3.7s Building /nix/store/23332fbygrgy00ysbnsl3lfikzgflgh2-nixos-system-docsserver-test.drv [nixos-system-docsserver-test:post-build] Uploading to cachix cache "centjes": /nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test [nixos-system-docsserver-test:post-build] Pushing 1 paths (568 are already present) using zstd to cache centjes ⏳ [nixos-system-docsserver-test:post-build]  [nixos-system-docsserver-test:post-build] Pushing /nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test (17.26 KiB) [nixos-system-docsserver-test:post-build]  [nixos-system-docsserver-test:post-build] All done. [nixos-system-docsserver-test:post-build] Uploading to the NixCI staging cache: /nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test [nixos-system-docsserver-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [nixos-system-docsserver-test:post-build] copying 1 paths... [nixos-system-docsserver-test:post-build] copying path '/nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test' to 'https://cache.staging.nix-ci.com'... [nixos-system-docsserver-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [nixos-system-docsserver-test:post-build] copying 1 paths... [nixos-system-docsserver-test:post-build] copying path '/nix/store/23332fbygrgy00ysbnsl3lfikzgflgh2-nixos-system-docsserver-test.drv' to 'https://cache.staging.nix-ci.com'... Uploaded nixos-system-docsserver-test in 3.5s Progress: 7 of 13 built Built nixos-system-docsserver-test in 3.6s Building /nix/store/ag601kvjx2sgi0pks0dphyhlczh1xyyp-closure-info.drv [closure-info] structuredAttrs is enabled [closure-info:post-build] Uploading to cachix cache "centjes": /nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info [closure-info:post-build] Pushing 1 paths (569 are already present) using zstd to cache centjes ⏳ [closure-info:post-build]  [closure-info:post-build] Pushing /nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info (228.66 KiB) [closure-info:post-build]  [closure-info:post-build] All done. [closure-info:post-build] Uploading to the NixCI staging cache: /nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info [closure-info:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [closure-info:post-build] copying 1 paths... [closure-info:post-build] copying path '/nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info' to 'https://cache.staging.nix-ci.com'... [closure-info:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [closure-info:post-build] copying 1 paths... [closure-info:post-build] copying path '/nix/store/ag601kvjx2sgi0pks0dphyhlczh1xyyp-closure-info.drv' to 'https://cache.staging.nix-ci.com'... Uploaded closure-info in 2.9s Progress: 8 of 13 built Built closure-info in 3.0s Building /nix/store/wiz7dnsps5siwvir0yn4czxn8mb3nmm1-run-nixos-vm.drv [run-nixos-vm:post-build] Uploading to cachix cache "centjes": /nix/store/08pdgjy9qf0pa2557p29pcb88nrhwz8j-run-nixos-vm [run-nixos-vm:post-build] Pushing 1 paths (580 are already present) using zstd to cache centjes ⏳ [run-nixos-vm:post-build]  [run-nixos-vm:post-build] Pushing /nix/store/08pdgjy9qf0pa2557p29pcb88nrhwz8j-run-nixos-vm (2.94 KiB) [run-nixos-vm:post-build]  [run-nixos-vm:post-build] All done. [run-nixos-vm:post-build] Uploading to the NixCI staging cache: /nix/store/08pdgjy9qf0pa2557p29pcb88nrhwz8j-run-nixos-vm [run-nixos-vm:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [run-nixos-vm:post-build] copying 1 paths... [run-nixos-vm:post-build] copying path '/nix/store/08pdgjy9qf0pa2557p29pcb88nrhwz8j-run-nixos-vm' to 'https://cache.staging.nix-ci.com'... [run-nixos-vm:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [run-nixos-vm:post-build] copying 1 paths... [run-nixos-vm:post-build] copying path '/nix/store/wiz7dnsps5siwvir0yn4czxn8mb3nmm1-run-nixos-vm.drv' to 'https://cache.staging.nix-ci.com'... Uploaded run-nixos-vm in 3.6s Progress: 9 of 13 built Built run-nixos-vm in 3.6s Building /nix/store/j5cv8k5xrhw6anilj3x4y1si68bwwf0w-nixos-vm.drv [nixos-vm:post-build] Uploading to cachix cache "centjes": /nix/store/865fjgwsx3ak1nc9g0afcw3kgafvwmfz-nixos-vm [nixos-vm:post-build] Pushing 1 paths (581 are already present) using zstd to cache centjes ⏳ [nixos-vm:post-build]  [nixos-vm:post-build] Pushing /nix/store/865fjgwsx3ak1nc9g0afcw3kgafvwmfz-nixos-vm (776.00 B) [nixos-vm:post-build]  [nixos-vm:post-build] All done. [nixos-vm:post-build] Uploading to the NixCI staging cache: /nix/store/865fjgwsx3ak1nc9g0afcw3kgafvwmfz-nixos-vm [nixos-vm:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [nixos-vm:post-build] copying 1 paths... [nixos-vm:post-build] copying path '/nix/store/865fjgwsx3ak1nc9g0afcw3kgafvwmfz-nixos-vm' to 'https://cache.staging.nix-ci.com'... [nixos-vm:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [nixos-vm:post-build] copying 1 paths... [nixos-vm:post-build] copying path '/nix/store/j5cv8k5xrhw6anilj3x4y1si68bwwf0w-nixos-vm.drv' to 'https://cache.staging.nix-ci.com'... Uploaded nixos-vm in 3.1s Progress: 10 of 13 built Built nixos-vm in 3.2s Building /nix/store/4vi8ncxf1hdv0zsqwd9pqg72nqk278fk-nixos-test-driver-centjes-e2e-test.drv [nixos-test-driver-centjes-e2e-test] Running type check (enable/disable: config.skipTypeCheck) [nixos-test-driver-centjes-e2e-test] See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck [nixos-test-driver-centjes-e2e-test] Success: no issues found in 1 source file [nixos-test-driver-centjes-e2e-test] additionally exposed symbols: [nixos-test-driver-centjes-e2e-test]  , [nixos-test-driver-centjes-e2e-test]  , [nixos-test-driver-centjes-e2e-test]  start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug [nixos-test-driver-centjes-e2e-test] Linting test script (enable/disable: config.skipLint) [nixos-test-driver-centjes-e2e-test] See https://nixos.org/manual/nixos/stable/#test-opt-skipLint [nixos-test-driver-centjes-e2e-test:post-build] Uploading to cachix cache "centjes": /nix/store/kg5hqdnj6bj1ckqb7z7j4dzzxcm8x3a3-nixos-test-driver-centjes-e2e-test [nixos-test-driver-centjes-e2e-test:post-build] Pushing 1 paths (633 are already present) using zstd to cache centjes ⏳ [nixos-test-driver-centjes-e2e-test:post-build]  [nixos-test-driver-centjes-e2e-test:post-build] Pushing /nix/store/kg5hqdnj6bj1ckqb7z7j4dzzxcm8x3a3-nixos-test-driver-centjes-e2e-test (1.84 KiB) [nixos-test-driver-centjes-e2e-test:post-build]  [nixos-test-driver-centjes-e2e-test:post-build] All done. [nixos-test-driver-centjes-e2e-test:post-build] Uploading to the NixCI staging cache: /nix/store/kg5hqdnj6bj1ckqb7z7j4dzzxcm8x3a3-nixos-test-driver-centjes-e2e-test [nixos-test-driver-centjes-e2e-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [nixos-test-driver-centjes-e2e-test:post-build] copying 1 paths... [nixos-test-driver-centjes-e2e-test:post-build] copying path '/nix/store/kg5hqdnj6bj1ckqb7z7j4dzzxcm8x3a3-nixos-test-driver-centjes-e2e-test' to 'https://cache.staging.nix-ci.com'... [nixos-test-driver-centjes-e2e-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [nixos-test-driver-centjes-e2e-test:post-build] copying 1 paths... [nixos-test-driver-centjes-e2e-test:post-build] copying path '/nix/store/4vi8ncxf1hdv0zsqwd9pqg72nqk278fk-nixos-test-driver-centjes-e2e-test.drv' to 'https://cache.staging.nix-ci.com'... Uploaded nixos-test-driver-centjes-e2e-test in 3.0s Progress: 11 of 13 built Built nixos-test-driver-centjes-e2e-test in 9.6s Building /nix/store/1l2n1nwfzll9v7nzhc8d25h85v1980vx-vm-test-run-centjes-e2e-test.drv [vm-test-run-centjes-e2e-test] Machine state will be reset. To keep it, pass --keep-vm-state [vm-test-run-centjes-e2e-test] start all VLans [vm-test-run-centjes-e2e-test] start vlan [vm-test-run-centjes-e2e-test] running vlan (pid 7; ctl /build/vde1.ctl) [vm-test-run-centjes-e2e-test] (finished: start all VLans, in 0.00 seconds) [vm-test-run-centjes-e2e-test] Test will time out and terminate in 3600 seconds [vm-test-run-centjes-e2e-test] run the VM test script [vm-test-run-centjes-e2e-test] additionally exposed symbols: [vm-test-run-centjes-e2e-test]  client, docsserver, [vm-test-run-centjes-e2e-test]  vlan1, [vm-test-run-centjes-e2e-test]  start_all, test_script, machines, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, Machine, t, debug [vm-test-run-centjes-e2e-test] docsserver: starting vm [vm-test-run-centjes-e2e-test] mke2fs 1.47.3 (8-Jul-2025) [vm-test-run-centjes-e2e-test] docsserver # Disk image does not exist, creating the virtualisation disk image... [vm-test-run-centjes-e2e-test] docsserver: QEMU running (pid 9) [vm-test-run-centjes-e2e-test] docsserver # Formatting '/build/vm-state-docsserver/tmp.EFCAlUSd82', fmt=raw size=1073741824 [vm-test-run-centjes-e2e-test] docsserver # Discarding device blocks: 0/262144 done [vm-test-run-centjes-e2e-test] docsserver # Creating filesystem with 262144 4k blocks and 65536 inodes [vm-test-run-centjes-e2e-test] client: starting vm [vm-test-run-centjes-e2e-test] docsserver # Filesystem UUID: d8d433f3-a725-481a-a7ff-a218e1210a9a [vm-test-run-centjes-e2e-test] docsserver # Superblock backups stored on blocks: [vm-test-run-centjes-e2e-test] docsserver # 32768, 98304, 163840, 229376 [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # Allocating group tables: 0/8 done [vm-test-run-centjes-e2e-test] docsserver # Writing inode tables: 0/8 done [vm-test-run-centjes-e2e-test] docsserver # Creating journal (8192 blocks): done [vm-test-run-centjes-e2e-test] docsserver # Writing superblocks and filesystem accounting information: 0/8 done [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # Virtualisation disk image created. [vm-test-run-centjes-e2e-test] mke2fs 1.47.3 (8-Jul-2025) [vm-test-run-centjes-e2e-test] docsserver # c[?7lSeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) [vm-test-run-centjes-e2e-test] client # Disk image does not exist, creating the virtualisation disk image... [vm-test-run-centjes-e2e-test] client # Formatting '/build/vm-state-client/tmp.VTLjfZyNGi', fmt=raw size=1073741824 [vm-test-run-centjes-e2e-test] client: QEMU running (pid 31) [vm-test-run-centjes-e2e-test] client # Discarding device blocks: 0/262144 done [vm-test-run-centjes-e2e-test] client # Creating filesystem with 262144 4k blocks and 65536 inodes [vm-test-run-centjes-e2e-test] client # Filesystem UUID: 1eff4a94-67d8-4533-9e9d-a2d04e660a4c [vm-test-run-centjes-e2e-test] client # Superblock backups stored on blocks: [vm-test-run-centjes-e2e-test] client # 32768, 98304, 163840, 229376 [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] docsserver: waiting for unit default.target [vm-test-run-centjes-e2e-test] client # Allocating group tables: 0/8 done [vm-test-run-centjes-e2e-test] docsserver: waiting for the VM to finish booting [vm-test-run-centjes-e2e-test] client # Writing inode tables: 0/8 done [vm-test-run-centjes-e2e-test] client # Creating journal (8192 blocks): done [vm-test-run-centjes-e2e-test] client # Writing superblocks and filesystem accounting information: 0/8 done [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # Virtualisation disk image created. [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00 [vm-test-run-centjes-e2e-test] docsserver # Press Ctrl-B to configure iPXE (PCI 00:03.0)... [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00 [vm-test-run-centjes-e2e-test] client # c[?7lSeaBIOS (version rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org) [vm-test-run-centjes-e2e-test] docsserver # Press Ctrl-B to configure iPXE (PCI 00:09.0)... [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # Booting from ROM... [vm-test-run-centjes-e2e-test] docsserver # Probing EDD (edd=off to disable)... ok [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # iPXE (http://ipxe.org) 00:03.0 CA00 PCI2.10 PnP PMM+3EFD1920+3EF31920 CA00 [vm-test-run-centjes-e2e-test] client # Press Ctrl-B to configure iPXE (PCI 00:03.0)... [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # iPXE (http://ipxe.org) 00:09.0 CB00 PCI2.10 PnP PMM 3EFD1920 3EF31920 CB00 [vm-test-run-centjes-e2e-test] client # Press Ctrl-B to configure iPXE (PCI 00:09.0)... [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # Booting from ROM... [vm-test-run-centjes-e2e-test] client # Probing EDD (edd=off to disable)... ok [vm-test-run-centjes-e2e-test] docsserver # c[?7l[ 0.000000] Linux version 6.12.62 (nixbld@localhost) (gcc (GCC) 14.3.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP PREEMPT_DYNAMIC Fri Dec 12 17:37:22 UTC 2025 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test/init regInfo=/nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info/registration console=ttyS0,115200n8 console=tty0 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-provided physical RAM map: [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] NX (Execute Disable) protection: active [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] APIC: Static calls initialized [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] SMBIOS 2.8 present. [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] DMI: Memory slots populated: 1/1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] Hypervisor detected: KVM [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000000] kvm-clock: using sched offset of 415412811 cycles [vm-test-run-centjes-e2e-test] docsserver # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.000004] tsc: Detected 3399.998 MHz processor [vm-test-run-centjes-e2e-test] docsserver # [ 0.000674] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 [vm-test-run-centjes-e2e-test] docsserver # [ 0.000850] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs [vm-test-run-centjes-e2e-test] docsserver # [ 0.000857] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [vm-test-run-centjes-e2e-test] docsserver # [ 0.002571] found SMP MP-table at [mem 0x000f5470-0x000f547f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002581] Using GB pages for direct mapping [vm-test-run-centjes-e2e-test] docsserver # [ 0.002626] RAMDISK: [mem 0x3f3cd000-0x3ffcffff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002642] ACPI: Early table checksum verification disabled [vm-test-run-centjes-e2e-test] docsserver # [ 0.002645] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002647] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002650] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002653] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002654] ACPI: FACS 0x000000003FFE0000 000040 [vm-test-run-centjes-e2e-test] docsserver # [ 0.002656] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002657] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002658] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.002660] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002661] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002661] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002661] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002662] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0] [vm-test-run-centjes-e2e-test] docsserver # [ 0.002662] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003374] No NUMA configuration found [vm-test-run-centjes-e2e-test] docsserver # [ 0.003375] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003377] NODE_DATA(0) allocated [mem 0x3ffd58c0-0x3ffdadff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003392] Zone ranges: [vm-test-run-centjes-e2e-test] docsserver # [ 0.003392] DMA [mem 0x0000000000001000-0x0000000000ffffff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003393] DMA32 [mem 0x0000000001000000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003394] Normal empty [vm-test-run-centjes-e2e-test] docsserver # [ 0.003395] Device empty [vm-test-run-centjes-e2e-test] docsserver # [ 0.003395] Movable zone start for each node [vm-test-run-centjes-e2e-test] docsserver # [ 0.003395] Early memory node ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.003396] node 0: [mem 0x0000000000001000-0x000000000009efff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003397] node 0: [mem 0x0000000000100000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003398] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.003531] On node 0, zone DMA: 1 pages in unavailable ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.003543] On node 0, zone DMA: 97 pages in unavailable ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.004992] On node 0, zone DMA32: 37 pages in unavailable ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.006430] ACPI: PM-Timer IO Port: 0x608 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006451] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [vm-test-run-centjes-e2e-test] docsserver # [ 0.006526] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006527] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [vm-test-run-centjes-e2e-test] docsserver # [ 0.006529] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [vm-test-run-centjes-e2e-test] docsserver # [ 0.006529] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [vm-test-run-centjes-e2e-test] docsserver # [ 0.006530] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [vm-test-run-centjes-e2e-test] docsserver # [ 0.006531] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [vm-test-run-centjes-e2e-test] docsserver # [ 0.006533] ACPI: Using ACPI (MADT) for SMP configuration information [vm-test-run-centjes-e2e-test] docsserver # [ 0.006533] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006535] TSC deadline timer available [vm-test-run-centjes-e2e-test] docsserver # [ 0.006538] CPU topo: Max. logical packages: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006539] CPU topo: Max. logical dies: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006540] CPU topo: Max. dies per package: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006543] CPU topo: Max. threads per core: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006543] CPU topo: Num. cores per package: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006543] CPU topo: Num. threads per package: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006544] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs [vm-test-run-centjes-e2e-test] docsserver # [ 0.006567] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() [vm-test-run-centjes-e2e-test] docsserver # [ 0.006614] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.006615] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] [vm-test-run-centjes-e2e-test] client # c[?7l[ 0.000000] Linux version 6.12.62 (nixbld@localhost) (gcc (GCC) 14.3.0, GNU ld (GNU Binutils) 2.44) #1-NixOS SMP PREEMPT_DYNAMIC Fri Dec 12 17:37:22 UTC 2025 [vm-test-run-centjes-e2e-test] docsserver # [ 0.006616] [mem 0x40000000-0xfeffbfff] available for PCI devices [vm-test-run-centjes-e2e-test] docsserver # [ 0.006617] Booting paravirtualized kernel on KVM [vm-test-run-centjes-e2e-test] docsserver # [ 0.006618] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.009889] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 [vm-test-run-centjes-e2e-test] client # [ 0.000000] Command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/001k9r4jinw78ih5x5hxggb82ynlbkqn-nixos-system-client-test/init regInfo=/nix/store/j7kn31fka8vp5bhm6sw8hv64iyzix7xw-closure-info/registration console=ttyS0,115200n8 console=tty0 [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-provided physical RAM map: [vm-test-run-centjes-e2e-test] docsserver # [ 0.010085] percpu: Embedded 116 pages/cpu s294912 r65536 d114688 u2097152 [vm-test-run-centjes-e2e-test] docsserver # [ 0.010148] kvm-guest: PV spinlocks disabled, single CPU [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdafff] usable [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x000000003ffdb000-0x000000003fffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.010149] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test/init regInfo=/nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info/registration console=ttyS0,115200n8 console=tty0 [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.010217] Unknown kernel command line parameters "regInfo=/nix/store/jqary0si5hzalcfc66qd31pmp8j3q8dc-closure-info/registration", will be passed to user space. [vm-test-run-centjes-e2e-test] docsserver # [ 0.010229] random: crng init done [vm-test-run-centjes-e2e-test] client # [ 0.000000] BIOS-e820: [mem 0x000000fd00000000-0x000000ffffffffff] reserved [vm-test-run-centjes-e2e-test] docsserver # [ 0.010281] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.000000] NX (Execute Disable) protection: active [vm-test-run-centjes-e2e-test] client # [ 0.000000] APIC: Static calls initialized [vm-test-run-centjes-e2e-test] docsserver # [ 0.010309] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.000000] SMBIOS 2.8 present. [vm-test-run-centjes-e2e-test] docsserver # [ 0.010356] Fallback order for Node 0: 0 [vm-test-run-centjes-e2e-test] docsserver # [ 0.010357] Built 1 zonelists, mobility grouping on. Total pages: 262009 [vm-test-run-centjes-e2e-test] client # [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.17.0-0-gb52ca86e094d-prebuilt.qemu.org 04/01/2014 [vm-test-run-centjes-e2e-test] docsserver # [ 0.010358] Policy zone: DMA32 [vm-test-run-centjes-e2e-test] client # [ 0.000000] DMI: Memory slots populated: 1/1 [vm-test-run-centjes-e2e-test] client # [ 0.000000] Hypervisor detected: KVM [vm-test-run-centjes-e2e-test] docsserver # [ 0.010530] mem auto-init: stack:all(zero), heap alloc:on, heap free:off [vm-test-run-centjes-e2e-test] client # [ 0.000000] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 [vm-test-run-centjes-e2e-test] docsserver # [ 0.012142] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [vm-test-run-centjes-e2e-test] client # [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [vm-test-run-centjes-e2e-test] docsserver # [ 0.012312] allocated 2097152 bytes of page_ext [vm-test-run-centjes-e2e-test] client # [ 0.000000] kvm-clock: using sched offset of 416150392 cycles [vm-test-run-centjes-e2e-test] docsserver # [ 0.012338] ftrace: allocating 46208 entries in 181 pages [vm-test-run-centjes-e2e-test] docsserver # [ 0.019645] ftrace: allocated 181 pages with 5 groups [vm-test-run-centjes-e2e-test] docsserver # [ 0.020152] Dynamic Preempt: voluntary [vm-test-run-centjes-e2e-test] client # [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.020306] rcu: Preemptible hierarchical RCU implementation. [vm-test-run-centjes-e2e-test] client # [ 0.000003] tsc: Detected 3399.998 MHz processor [vm-test-run-centjes-e2e-test] docsserver # [ 0.020306] rcu: RCU event tracing is enabled. [vm-test-run-centjes-e2e-test] client # [ 0.000697] last_pfn = 0x3ffdb max_arch_pfn = 0x400000000 [vm-test-run-centjes-e2e-test] docsserver # [ 0.020307] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. [vm-test-run-centjes-e2e-test] client # [ 0.000880] MTRR map: 4 entries (3 fixed + 1 variable; max 19), built from 8 variable MTRRs [vm-test-run-centjes-e2e-test] docsserver # [ 0.020308] Trampoline variant of Tasks RCU enabled. [vm-test-run-centjes-e2e-test] docsserver # [ 0.020308] Rude variant of Tasks RCU enabled. [vm-test-run-centjes-e2e-test] client # [ 0.000887] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WP UC- WT [vm-test-run-centjes-e2e-test] docsserver # [ 0.020308] Tracing variant of Tasks RCU enabled. [vm-test-run-centjes-e2e-test] client # [ 0.002624] found SMP MP-table at [mem 0x000f5470-0x000f547f] [vm-test-run-centjes-e2e-test] client # [ 0.002632] Using GB pages for direct mapping [vm-test-run-centjes-e2e-test] docsserver # [ 0.020309] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [vm-test-run-centjes-e2e-test] client # [ 0.002691] RAMDISK: [mem 0x3f3cd000-0x3ffcffff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.020310] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [vm-test-run-centjes-e2e-test] client # [ 0.002713] ACPI: Early table checksum verification disabled [vm-test-run-centjes-e2e-test] client # [ 0.002715] ACPI: RSDP 0x00000000000F5290 000014 (v00 BOCHS ) [vm-test-run-centjes-e2e-test] docsserver # [ 0.020317] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. [vm-test-run-centjes-e2e-test] client # [ 0.002717] ACPI: RSDT 0x000000003FFE23D9 000034 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.020318] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. [vm-test-run-centjes-e2e-test] client # [ 0.002721] ACPI: FACP 0x000000003FFE228D 000074 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.020319] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. [vm-test-run-centjes-e2e-test] client # [ 0.002723] ACPI: DSDT 0x000000003FFE0040 00224D (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.023642] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 [vm-test-run-centjes-e2e-test] client # [ 0.002725] ACPI: FACS 0x000000003FFE0000 000040 [vm-test-run-centjes-e2e-test] docsserver # [ 0.023879] rcu: srcu_init: Setting srcu_struct sizes based on contention. [vm-test-run-centjes-e2e-test] client # [ 0.002726] ACPI: APIC 0x000000003FFE2301 000078 (v03 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.023940] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) [vm-test-run-centjes-e2e-test] docsserver # [ 0.036091] Console: colour VGA+ 80x25 [vm-test-run-centjes-e2e-test] client # [ 0.002728] ACPI: HPET 0x000000003FFE2379 000038 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.036093] printk: legacy console [tty0] enabled [vm-test-run-centjes-e2e-test] client # [ 0.002729] ACPI: WAET 0x000000003FFE23B1 000028 (v01 BOCHS BXPC 00000001 BXPC 00000001) [vm-test-run-centjes-e2e-test] docsserver # [ 0.130006] printk: legacy console [ttyS0] enabled [vm-test-run-centjes-e2e-test] docsserver # [ 0.352224] ACPI: Core revision 20240827 [vm-test-run-centjes-e2e-test] client # [ 0.002730] ACPI: Reserving FACP table memory at [mem 0x3ffe228d-0x3ffe2300] [vm-test-run-centjes-e2e-test] client # [ 0.002731] ACPI: Reserving DSDT table memory at [mem 0x3ffe0040-0x3ffe228c] [vm-test-run-centjes-e2e-test] docsserver # [ 0.354299] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [vm-test-run-centjes-e2e-test] client # [ 0.002732] ACPI: Reserving FACS table memory at [mem 0x3ffe0000-0x3ffe003f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.358177] APIC: Switch to symmetric I/O mode setup [vm-test-run-centjes-e2e-test] client # [ 0.002732] ACPI: Reserving APIC table memory at [mem 0x3ffe2301-0x3ffe2378] [vm-test-run-centjes-e2e-test] client # [ 0.002732] ACPI: Reserving HPET table memory at [mem 0x3ffe2379-0x3ffe23b0] [vm-test-run-centjes-e2e-test] docsserver # [ 0.361096] x2apic enabled [vm-test-run-centjes-e2e-test] client # [ 0.002733] ACPI: Reserving WAET table memory at [mem 0x3ffe23b1-0x3ffe23d8] [vm-test-run-centjes-e2e-test] docsserver # [ 0.363252] APIC: Switched APIC routing to: physical x2apic [vm-test-run-centjes-e2e-test] client # [ 0.003446] No NUMA configuration found [vm-test-run-centjes-e2e-test] client # [ 0.003447] Faking a node at [mem 0x0000000000000000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] client # [ 0.003449] NODE_DATA(0) allocated [mem 0x3ffd58c0-0x3ffdadff] [vm-test-run-centjes-e2e-test] client # [ 0.003470] Zone ranges: [vm-test-run-centjes-e2e-test] docsserver # [ 0.369069] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [vm-test-run-centjes-e2e-test] client # [ 0.003470] DMA [mem 0x0000000000001000-0x0000000000ffffff] [vm-test-run-centjes-e2e-test] client # [ 0.003471] DMA32 [mem 0x0000000001000000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] client # [ 0.003472] Normal empty [vm-test-run-centjes-e2e-test] client # [ 0.003473] Device empty [vm-test-run-centjes-e2e-test] docsserver # [ 0.371689] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns [vm-test-run-centjes-e2e-test] client # [ 0.003473] Movable zone start for each node [vm-test-run-centjes-e2e-test] client # [ 0.003473] Early memory node ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.375987] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399998) [vm-test-run-centjes-e2e-test] client # [ 0.003474] node 0: [mem 0x0000000000001000-0x000000000009efff] [vm-test-run-centjes-e2e-test] client # [ 0.003475] node 0: [mem 0x0000000000100000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.378523] x86/cpu: User Mode Instruction Prevention (UMIP) activated [vm-test-run-centjes-e2e-test] client # [ 0.003475] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdafff] [vm-test-run-centjes-e2e-test] client # [ 0.003574] On node 0, zone DMA: 1 pages in unavailable ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.381008] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 [vm-test-run-centjes-e2e-test] client # [ 0.003585] On node 0, zone DMA: 97 pages in unavailable ranges [vm-test-run-centjes-e2e-test] docsserver # [ 0.381986] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 [vm-test-run-centjes-e2e-test] client # [ 0.004916] On node 0, zone DMA32: 37 pages in unavailable ranges [vm-test-run-centjes-e2e-test] client # [ 0.006390] ACPI: PM-Timer IO Port: 0x608 [vm-test-run-centjes-e2e-test] docsserver # [ 0.383995] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization [vm-test-run-centjes-e2e-test] client # [ 0.006412] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [vm-test-run-centjes-e2e-test] docsserver # [ 0.385988] Spectre V2 : Mitigation: Retpolines [vm-test-run-centjes-e2e-test] client # [ 0.006488] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [vm-test-run-centjes-e2e-test] client # [ 0.006490] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [vm-test-run-centjes-e2e-test] docsserver # [ 0.387986] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT [vm-test-run-centjes-e2e-test] client # [ 0.006492] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [vm-test-run-centjes-e2e-test] docsserver # [ 0.389986] Spectre V2 : Enabling Restricted Speculation for firmware calls [vm-test-run-centjes-e2e-test] client # [ 0.006492] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [vm-test-run-centjes-e2e-test] client # [ 0.006493] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [vm-test-run-centjes-e2e-test] docsserver # [ 0.391987] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier [vm-test-run-centjes-e2e-test] client # [ 0.006494] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [vm-test-run-centjes-e2e-test] client # [ 0.006496] ACPI: Using ACPI (MADT) for SMP configuration information [vm-test-run-centjes-e2e-test] docsserver # [ 0.393987] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl [vm-test-run-centjes-e2e-test] client # [ 0.006496] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [vm-test-run-centjes-e2e-test] client # [ 0.006498] TSC deadline timer available [vm-test-run-centjes-e2e-test] docsserver # [ 0.395986] active return thunk: srso_alias_return_thunk [vm-test-run-centjes-e2e-test] client # [ 0.006502] CPU topo: Max. logical packages: 1 [vm-test-run-centjes-e2e-test] client # [ 0.006502] CPU topo: Max. logical dies: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.397986] Speculative Return Stack Overflow: Mitigation: Safe RET [vm-test-run-centjes-e2e-test] client # [ 0.006502] CPU topo: Max. dies per package: 1 [vm-test-run-centjes-e2e-test] client # [ 0.006506] CPU topo: Max. threads per core: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.399986] Transient Scheduler Attacks: Forcing mitigation on in a VM [vm-test-run-centjes-e2e-test] client # [ 0.006506] CPU topo: Num. cores per package: 1 [vm-test-run-centjes-e2e-test] client # [ 0.006506] CPU topo: Num. threads per package: 1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.401986] Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode [vm-test-run-centjes-e2e-test] client # [ 0.006507] CPU topo: Allowing 1 present CPUs plus 0 hotplug CPUs [vm-test-run-centjes-e2e-test] client # [ 0.006531] kvm-guest: APIC: eoi() replaced with kvm_guest_apic_eoi_write() [vm-test-run-centjes-e2e-test] docsserver # [ 0.404069] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [vm-test-run-centjes-e2e-test] client # [ 0.006579] PM: hibernation: Registered nosave memory: [mem 0x00000000-0x00000fff] [vm-test-run-centjes-e2e-test] client # [ 0.006580] PM: hibernation: Registered nosave memory: [mem 0x0009f000-0x000fffff] [vm-test-run-centjes-e2e-test] client # [ 0.006581] [mem 0x40000000-0xfeffbfff] available for PCI devices [vm-test-run-centjes-e2e-test] client # [ 0.006582] Booting paravirtualized kernel on KVM [vm-test-run-centjes-e2e-test] client # [ 0.006584] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns [vm-test-run-centjes-e2e-test] client # [ 0.009999] setup_percpu: NR_CPUS:384 nr_cpumask_bits:1 nr_cpu_ids:1 nr_node_ids:1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.405986] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [vm-test-run-centjes-e2e-test] client # [ 0.010248] percpu: Embedded 116 pages/cpu s294912 r65536 d114688 u2097152 [vm-test-run-centjes-e2e-test] client # [ 0.010315] kvm-guest: PV spinlocks disabled, single CPU [vm-test-run-centjes-e2e-test] docsserver # [ 0.407986] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [vm-test-run-centjes-e2e-test] docsserver # [ 0.408986] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' [vm-test-run-centjes-e2e-test] docsserver # [ 0.410986] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [vm-test-run-centjes-e2e-test] client # [ 0.010317] Kernel command line: console=ttyS0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf init=/nix/store/001k9r4jinw78ih5x5hxggb82ynlbkqn-nixos-system-client-test/init regInfo=/nix/store/j7kn31fka8vp5bhm6sw8hv64iyzix7xw-closure-info/registration console=ttyS0,115200n8 console=tty0 [vm-test-run-centjes-e2e-test] docsserver # [ 0.411986] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8 [vm-test-run-centjes-e2e-test] client # [ 0.010387] Unknown kernel command line parameters "regInfo=/nix/store/j7kn31fka8vp5bhm6sw8hv64iyzix7xw-closure-info/registration", will be passed to user space. [vm-test-run-centjes-e2e-test] docsserver # [ 0.413986] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format. [vm-test-run-centjes-e2e-test] client # [ 0.010400] random: crng init done [vm-test-run-centjes-e2e-test] client # [ 0.010626] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.010742] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.010774] Fallback order for Node 0: 0 [vm-test-run-centjes-e2e-test] client # [ 0.010776] Built 1 zonelists, mobility grouping on. Total pages: 262009 [vm-test-run-centjes-e2e-test] client # [ 0.010777] Policy zone: DMA32 [vm-test-run-centjes-e2e-test] client # [ 0.010945] mem auto-init: stack:all(zero), heap alloc:on, heap free:off [vm-test-run-centjes-e2e-test] client # [ 0.012715] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [vm-test-run-centjes-e2e-test] client # [ 0.012892] allocated 2097152 bytes of page_ext [vm-test-run-centjes-e2e-test] client # [ 0.012903] ftrace: allocating 46208 entries in 181 pages [vm-test-run-centjes-e2e-test] client # [ 0.020402] ftrace: allocated 181 pages with 5 groups [vm-test-run-centjes-e2e-test] client # [ 0.020937] Dynamic Preempt: voluntary [vm-test-run-centjes-e2e-test] client # [ 0.021111] rcu: Preemptible hierarchical RCU implementation. [vm-test-run-centjes-e2e-test] client # [ 0.021112] rcu: RCU event tracing is enabled. [vm-test-run-centjes-e2e-test] client # [ 0.021112] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1. [vm-test-run-centjes-e2e-test] client # [ 0.021113] Trampoline variant of Tasks RCU enabled. [vm-test-run-centjes-e2e-test] docsserver # [ 0.440320] Freeing SMP alternatives memory: 40K [vm-test-run-centjes-e2e-test] client # [ 0.021113] Rude variant of Tasks RCU enabled. [vm-test-run-centjes-e2e-test] client # [ 0.021114] Tracing variant of Tasks RCU enabled. [vm-test-run-centjes-e2e-test] docsserver # [ 0.441987] pid_max: default: 32768 minimum: 301 [vm-test-run-centjes-e2e-test] client # [ 0.021114] rcu: RCU calculated value of scheduler-enlistment delay is 100 jiffies. [vm-test-run-centjes-e2e-test] docsserver # [ 0.444028] LSM: initializing lsm=capability,landlock,yama,bpf [vm-test-run-centjes-e2e-test] client # [ 0.021115] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.447058] landlock: Up and running. [vm-test-run-centjes-e2e-test] docsserver # [ 0.447987] Yama: becoming mindful. [vm-test-run-centjes-e2e-test] client # [ 0.021122] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. [vm-test-run-centjes-e2e-test] docsserver # [ 0.450189] LSM support for eBPF active [vm-test-run-centjes-e2e-test] client # [ 0.021123] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. [vm-test-run-centjes-e2e-test] docsserver # [ 0.452014] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.021124] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1. [vm-test-run-centjes-e2e-test] client # [ 0.024551] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16 [vm-test-run-centjes-e2e-test] docsserver # [ 0.453988] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.024792] rcu: srcu_init: Setting srcu_struct sizes based on contention. [vm-test-run-centjes-e2e-test] client # [ 0.024856] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____) [vm-test-run-centjes-e2e-test] docsserver # [ 0.456400] smpboot: CPU0: AMD Ryzen 9 5950X 16-Core Processor (family: 0x19, model: 0x21, stepping: 0x0) [vm-test-run-centjes-e2e-test] client # [ 0.038016] Console: colour VGA+ 80x25 [vm-test-run-centjes-e2e-test] client # [ 0.038019] printk: legacy console [tty0] enabled [vm-test-run-centjes-e2e-test] docsserver # [ 0.458231] Performance Events: Fam17h+ core perfctr, AMD PMU driver. [vm-test-run-centjes-e2e-test] client # [ 0.136586] printk: legacy console [ttyS0] enabled [vm-test-run-centjes-e2e-test] docsserver # [ 0.459999] ... version: 0 [vm-test-run-centjes-e2e-test] client # [ 0.364910] ACPI: Core revision 20240827 [vm-test-run-centjes-e2e-test] docsserver # [ 0.460992] ... bit width: 48 [vm-test-run-centjes-e2e-test] docsserver # [ 0.461992] ... generic registers: 6 [vm-test-run-centjes-e2e-test] client # [ 0.367008] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.462992] ... value mask: 0000ffffffffffff [vm-test-run-centjes-e2e-test] client # [ 0.371021] APIC: Switch to symmetric I/O mode setup [vm-test-run-centjes-e2e-test] docsserver # [ 0.463992] ... max period: 00007fffffffffff [vm-test-run-centjes-e2e-test] client # [ 0.374092] x2apic enabled [vm-test-run-centjes-e2e-test] docsserver # [ 0.464992] ... fixed-purpose events: 0 [vm-test-run-centjes-e2e-test] client # [ 0.376288] APIC: Switched APIC routing to: physical x2apic [vm-test-run-centjes-e2e-test] docsserver # [ 0.465992] ... event mask: 000000000000003f [vm-test-run-centjes-e2e-test] docsserver # [ 0.467068] signal: max sigframe size: 3376 [vm-test-run-centjes-e2e-test] docsserver # [ 0.468023] rcu: Hierarchical SRCU implementation. [vm-test-run-centjes-e2e-test] client # [ 0.382302] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.468993] rcu: Max phase no-delay instances is 400. [vm-test-run-centjes-e2e-test] client # [ 0.384925] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.473029] smp: Bringing up secondary CPUs ... [vm-test-run-centjes-e2e-test] client # [ 0.389364] Calibrating delay loop (skipped) preset value.. 6799.99 BogoMIPS (lpj=3399998) [vm-test-run-centjes-e2e-test] docsserver # [ 0.474008] smp: Brought up 1 node, 1 CPU [vm-test-run-centjes-e2e-test] docsserver # [ 0.474994] smpboot: Total of 1 processors activated (6799.99 BogoMIPS) [vm-test-run-centjes-e2e-test] client # [ 0.392791] x86/cpu: User Mode Instruction Prevention (UMIP) activated [vm-test-run-centjes-e2e-test] client # [ 0.394754] Last level iTLB entries: 4KB 512, 2MB 255, 4MB 127 [vm-test-run-centjes-e2e-test] docsserver # [ 0.476292] Memory: 962148K/1048036K available (16384K kernel code, 2645K rwdata, 12580K rodata, 3408K init, 3360K bss, 78836K reserved, 0K cma-reserved) [vm-test-run-centjes-e2e-test] client # [ 0.396363] Last level dTLB entries: 4KB 512, 2MB 255, 4MB 127, 1GB 0 [vm-test-run-centjes-e2e-test] docsserver # [ 0.478075] devtmpfs: initialized [vm-test-run-centjes-e2e-test] docsserver # [ 0.479051] x86/mm: Memory block size: 128MB [vm-test-run-centjes-e2e-test] client # [ 0.398374] Spectre V1 : Mitigation: usercopy/swapgs barriers and __user pointer sanitization [vm-test-run-centjes-e2e-test] client # [ 0.400365] Spectre V2 : Mitigation: Retpolines [vm-test-run-centjes-e2e-test] docsserver # [ 0.480427] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [vm-test-run-centjes-e2e-test] client # [ 0.402363] Spectre V2 : Spectre v2 / SpectreRSB: Filling RSB on context switch and VMEXIT [vm-test-run-centjes-e2e-test] docsserver # [ 0.481996] futex hash table entries: 256 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.404363] Spectre V2 : Enabling Restricted Speculation for firmware calls [vm-test-run-centjes-e2e-test] docsserver # [ 0.483046] pinctrl core: initialized pinctrl subsystem [vm-test-run-centjes-e2e-test] client # [ 0.406365] Spectre V2 : mitigation: Enabling conditional Indirect Branch Prediction Barrier [vm-test-run-centjes-e2e-test] docsserver # [ 0.484285] PM: RTC time: 14:36:06, date: 2026-10-02 [vm-test-run-centjes-e2e-test] docsserver # [ 0.486518] NET: Registered PF_NETLINK/PF_ROUTE protocol family [vm-test-run-centjes-e2e-test] client # [ 0.408364] Speculative Store Bypass: Mitigation: Speculative Store Bypass disabled via prctl [vm-test-run-centjes-e2e-test] client # [ 0.410363] active return thunk: srso_alias_return_thunk [vm-test-run-centjes-e2e-test] docsserver # [ 0.488129] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations [vm-test-run-centjes-e2e-test] client # [ 0.412363] Speculative Return Stack Overflow: Mitigation: Safe RET [vm-test-run-centjes-e2e-test] docsserver # [ 0.490001] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [vm-test-run-centjes-e2e-test] client # [ 0.414363] Transient Scheduler Attacks: Forcing mitigation on in a VM [vm-test-run-centjes-e2e-test] docsserver # [ 0.491999] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [vm-test-run-centjes-e2e-test] client # [ 0.416363] Transient Scheduler Attacks: Vulnerable: Clear CPU buffers attempted, no microcode [vm-test-run-centjes-e2e-test] docsserver # [ 0.493999] audit: initializing netlink subsys (disabled) [vm-test-run-centjes-e2e-test] client # [ 0.418448] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [vm-test-run-centjes-e2e-test] docsserver # [ 0.495030] audit: type=2000 audit(1790951767.289:1): state=initialized audit_enabled=0 res=1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.497095] thermal_sys: Registered thermal governor 'bang_bang' [vm-test-run-centjes-e2e-test] docsserver # [ 0.497097] thermal_sys: Registered thermal governor 'step_wise' [vm-test-run-centjes-e2e-test] docsserver # [ 0.497993] thermal_sys: Registered thermal governor 'user_space' [vm-test-run-centjes-e2e-test] docsserver # [ 0.499004] cpuidle: using governor menu [vm-test-run-centjes-e2e-test] client # [ 0.420363] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [vm-test-run-centjes-e2e-test] client # [ 0.422363] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [vm-test-run-centjes-e2e-test] docsserver # [ 0.502778] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [vm-test-run-centjes-e2e-test] docsserver # [ 0.504233] PCI: Using configuration type 1 for base access [vm-test-run-centjes-e2e-test] client # [ 0.424363] x86/fpu: Supporting XSAVE feature 0x200: 'Protection Keys User registers' [vm-test-run-centjes-e2e-test] docsserver # [ 0.505992] PCI: Using configuration type 1 for extended access [vm-test-run-centjes-e2e-test] client # [ 0.426364] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [vm-test-run-centjes-e2e-test] client # [ 0.427363] x86/fpu: xstate_offset[9]: 832, xstate_sizes[9]: 8 [vm-test-run-centjes-e2e-test] docsserver # [ 0.507129] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. [vm-test-run-centjes-e2e-test] client # [ 0.429364] x86/fpu: Enabled xstate features 0x207, context size is 840 bytes, using 'compacted' format. [vm-test-run-centjes-e2e-test] docsserver # [ 0.529237] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages [vm-test-run-centjes-e2e-test] docsserver # [ 0.530992] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page [vm-test-run-centjes-e2e-test] client # [ 0.455799] Freeing SMP alternatives memory: 40K [vm-test-run-centjes-e2e-test] client # [ 0.457365] pid_max: default: 32768 minimum: 301 [vm-test-run-centjes-e2e-test] docsserver # [ 0.531992] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages [vm-test-run-centjes-e2e-test] client # [ 0.459409] LSM: initializing lsm=capability,landlock,yama,bpf [vm-test-run-centjes-e2e-test] docsserver # [ 0.533993] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page [vm-test-run-centjes-e2e-test] client # [ 0.461443] landlock: Up and running. [vm-test-run-centjes-e2e-test] client # [ 0.463363] Yama: becoming mindful. [vm-test-run-centjes-e2e-test] client # [ 0.465490] LSM support for eBPF active [vm-test-run-centjes-e2e-test] docsserver # [ 0.539792] ACPI: Added _OSI(Module Device) [vm-test-run-centjes-e2e-test] client # [ 0.466389] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 0.540993] ACPI: Added _OSI(Processor Device) [vm-test-run-centjes-e2e-test] docsserver # [ 0.541993] ACPI: Added _OSI(Processor Aggregator Device) [vm-test-run-centjes-e2e-test] client # [ 0.468365] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 0.544615] ACPI: 1 ACPI AML tables successfully acquired and loaded [vm-test-run-centjes-e2e-test] client # [ 0.471742] smpboot: CPU0: AMD Ryzen 9 5950X 16-Core Processor (family: 0x19, model: 0x21, stepping: 0x0) [vm-test-run-centjes-e2e-test] docsserver # [ 0.547216] ACPI: Interpreter enabled [vm-test-run-centjes-e2e-test] client # [ 0.473636] Performance Events: Fam17h+ core perfctr, AMD PMU driver. [vm-test-run-centjes-e2e-test] docsserver # [ 0.548005] ACPI: PM: (supports S0 S3 S4 S5) [vm-test-run-centjes-e2e-test] client # [ 0.475380] ... version: 0 [vm-test-run-centjes-e2e-test] docsserver # [ 0.548993] ACPI: Using IOAPIC for interrupt routing [vm-test-run-centjes-e2e-test] client # [ 0.476386] ... bit width: 48 [vm-test-run-centjes-e2e-test] client # [ 0.477369] ... generic registers: 6 [vm-test-run-centjes-e2e-test] docsserver # [ 0.550005] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [vm-test-run-centjes-e2e-test] client # [ 0.478369] ... value mask: 0000ffffffffffff [vm-test-run-centjes-e2e-test] docsserver # [ 0.551992] PCI: Using E820 reservations for host bridge windows [vm-test-run-centjes-e2e-test] client # [ 0.479369] ... max period: 00007fffffffffff [vm-test-run-centjes-e2e-test] docsserver # [ 0.553140] ACPI: Enabled 2 GPEs in block 00 to 0F [vm-test-run-centjes-e2e-test] client # [ 0.480369] ... fixed-purpose events: 0 [vm-test-run-centjes-e2e-test] client # [ 0.481369] ... event mask: 000000000000003f [vm-test-run-centjes-e2e-test] client # [ 0.482443] signal: max sigframe size: 3376 [vm-test-run-centjes-e2e-test] docsserver # [ 0.557597] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [vm-test-run-centjes-e2e-test] client # [ 0.483415] rcu: Hierarchical SRCU implementation. [vm-test-run-centjes-e2e-test] client # [ 0.484373] rcu: Max phase no-delay instances is 400. [vm-test-run-centjes-e2e-test] docsserver # [ 0.558996] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] [vm-test-run-centjes-e2e-test] docsserver # [ 0.561314] acpiphp: Slot [3] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.562033] acpiphp: Slot [4] registered [vm-test-run-centjes-e2e-test] client # [ 0.488404] smp: Bringing up secondary CPUs ... [vm-test-run-centjes-e2e-test] docsserver # [ 0.563086] acpiphp: Slot [5] registered [vm-test-run-centjes-e2e-test] client # [ 0.489380] smp: Brought up 1 node, 1 CPU [vm-test-run-centjes-e2e-test] docsserver # [ 0.564032] acpiphp: Slot [6] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.565029] acpiphp: Slot [7] registered [vm-test-run-centjes-e2e-test] client # [ 0.490371] smpboot: Total of 1 processors activated (6799.99 BogoMIPS) [vm-test-run-centjes-e2e-test] docsserver # [ 0.566041] acpiphp: Slot [8] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.567030] acpiphp: Slot [9] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.568031] acpiphp: Slot [10] registered [vm-test-run-centjes-e2e-test] client # [ 0.491682] Memory: 962116K/1048036K available (16384K kernel code, 2645K rwdata, 12580K rodata, 3408K init, 3360K bss, 78836K reserved, 0K cma-reserved) [vm-test-run-centjes-e2e-test] docsserver # [ 0.569030] acpiphp: Slot [11] registered [vm-test-run-centjes-e2e-test] client # [ 0.493458] devtmpfs: initialized [vm-test-run-centjes-e2e-test] docsserver # [ 0.570034] acpiphp: Slot [12] registered [vm-test-run-centjes-e2e-test] client # [ 0.494428] x86/mm: Memory block size: 128MB [vm-test-run-centjes-e2e-test] docsserver # [ 0.571031] acpiphp: Slot [13] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.572030] acpiphp: Slot [14] registered [vm-test-run-centjes-e2e-test] client # [ 0.495804] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.573029] acpiphp: Slot [15] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.574031] acpiphp: Slot [16] registered [vm-test-run-centjes-e2e-test] client # [ 0.497371] futex hash table entries: 256 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 0.575030] acpiphp: Slot [17] registered [vm-test-run-centjes-e2e-test] client # [ 0.498416] pinctrl core: initialized pinctrl subsystem [vm-test-run-centjes-e2e-test] docsserver # [ 0.576029] acpiphp: Slot [18] registered [vm-test-run-centjes-e2e-test] client # [ 0.499650] PM: RTC time: 14:36:07, date: 2026-10-02 [vm-test-run-centjes-e2e-test] docsserver # [ 0.577030] acpiphp: Slot [19] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.578031] acpiphp: Slot [20] registered [vm-test-run-centjes-e2e-test] client # [ 0.501893] NET: Registered PF_NETLINK/PF_ROUTE protocol family [vm-test-run-centjes-e2e-test] docsserver # [ 0.579030] acpiphp: Slot [21] registered [vm-test-run-centjes-e2e-test] client # [ 0.503522] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations [vm-test-run-centjes-e2e-test] docsserver # [ 0.580029] acpiphp: Slot [22] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.581030] acpiphp: Slot [23] registered [vm-test-run-centjes-e2e-test] client # [ 0.505377] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations [vm-test-run-centjes-e2e-test] docsserver # [ 0.582031] acpiphp: Slot [24] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.583029] acpiphp: Slot [25] registered [vm-test-run-centjes-e2e-test] client # [ 0.507481] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations [vm-test-run-centjes-e2e-test] docsserver # [ 0.584028] acpiphp: Slot [26] registered [vm-test-run-centjes-e2e-test] client # [ 0.509376] audit: initializing netlink subsys (disabled) [vm-test-run-centjes-e2e-test] docsserver # [ 0.585029] acpiphp: Slot [27] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.586031] acpiphp: Slot [28] registered [vm-test-run-centjes-e2e-test] client # [ 0.510400] audit: type=2000 audit(1790951767.431:1): state=initialized audit_enabled=0 res=1 [vm-test-run-centjes-e2e-test] docsserver # [ 0.587029] acpiphp: Slot [29] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.588029] acpiphp: Slot [30] registered [vm-test-run-centjes-e2e-test] client # [ 0.512473] thermal_sys: Registered thermal governor 'bang_bang' [vm-test-run-centjes-e2e-test] docsserver # [ 0.589031] acpiphp: Slot [31] registered [vm-test-run-centjes-e2e-test] client # [ 0.512475] thermal_sys: Registered thermal governor 'step_wise' [vm-test-run-centjes-e2e-test] docsserver # [ 0.590021] PCI host bridge to bus 0000:00 [vm-test-run-centjes-e2e-test] client # [ 0.513370] thermal_sys: Registered thermal governor 'user_space' [vm-test-run-centjes-e2e-test] docsserver # [ 0.590997] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [vm-test-run-centjes-e2e-test] client # [ 0.514384] cpuidle: using governor menu [vm-test-run-centjes-e2e-test] docsserver # [ 0.591993] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [vm-test-run-centjes-e2e-test] client # [ 0.518211] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [vm-test-run-centjes-e2e-test] docsserver # [ 0.592993] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [vm-test-run-centjes-e2e-test] client # [ 0.519602] PCI: Using configuration type 1 for base access [vm-test-run-centjes-e2e-test] docsserver # [ 0.594993] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] [vm-test-run-centjes-e2e-test] client # [ 0.521369] PCI: Using configuration type 1 for extended access [vm-test-run-centjes-e2e-test] docsserver # [ 0.596993] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] [vm-test-run-centjes-e2e-test] docsserver # [ 0.598994] pci_bus 0000:00: root bus resource [bus 00-ff] [vm-test-run-centjes-e2e-test] client # [ 0.522518] kprobes: kprobe jump-optimization is enabled. All kprobes are optimized if possible. [vm-test-run-centjes-e2e-test] docsserver # [ 0.600444] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.603095] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.606559] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.611409] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] [vm-test-run-centjes-e2e-test] client # [ 0.544426] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages [vm-test-run-centjes-e2e-test] docsserver # [ 0.614458] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk [vm-test-run-centjes-e2e-test] client # [ 0.545369] HugeTLB: 16380 KiB vmemmap can be freed for a 1.00 GiB page [vm-test-run-centjes-e2e-test] docsserver # [ 0.615993] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk [vm-test-run-centjes-e2e-test] client # [ 0.546370] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages [vm-test-run-centjes-e2e-test] docsserver # [ 0.616993] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk [vm-test-run-centjes-e2e-test] client # [ 0.547369] HugeTLB: 28 KiB vmemmap can be freed for a 2.00 MiB page [vm-test-run-centjes-e2e-test] docsserver # [ 0.617993] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk [vm-test-run-centjes-e2e-test] docsserver # [ 0.619346] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.552831] ACPI: Added _OSI(Module Device) [vm-test-run-centjes-e2e-test] client # [ 0.555166] ACPI: Added _OSI(Processor Device) [vm-test-run-centjes-e2e-test] docsserver # [ 0.623794] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] [vm-test-run-centjes-e2e-test] client # [ 0.556371] ACPI: Added _OSI(Processor Aggregator Device) [vm-test-run-centjes-e2e-test] client # [ 0.559093] ACPI: 1 ACPI AML tables successfully acquired and loaded [vm-test-run-centjes-e2e-test] docsserver # [ 0.627523] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.561607] ACPI: Interpreter enabled [vm-test-run-centjes-e2e-test] docsserver # [ 0.630227] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [vm-test-run-centjes-e2e-test] client # [ 0.562382] ACPI: PM: (supports S0 S3 S4 S5) [vm-test-run-centjes-e2e-test] client # [ 0.563370] ACPI: Using IOAPIC for interrupt routing [vm-test-run-centjes-e2e-test] docsserver # [ 0.632029] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [vm-test-run-centjes-e2e-test] client # [ 0.564383] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug [vm-test-run-centjes-e2e-test] docsserver # [ 0.633542] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.566369] PCI: Using E820 reservations for host bridge windows [vm-test-run-centjes-e2e-test] client # [ 0.567516] ACPI: Enabled 2 GPEs in block 00 to 0F [vm-test-run-centjes-e2e-test] docsserver # [ 0.636564] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.640026] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] [vm-test-run-centjes-e2e-test] client # [ 0.572084] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [vm-test-run-centjes-e2e-test] client # [ 0.573374] acpi PNP0A03:00: _OSC: OS supports [ExtendedConfig ASPM ClockPM Segments MSI HPX-Type3] [vm-test-run-centjes-e2e-test] client # [ 0.575740] acpiphp: Slot [3] registered [vm-test-run-centjes-e2e-test] client # [ 0.577429] acpiphp: Slot [4] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.645771] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] [vm-test-run-centjes-e2e-test] client # [ 0.578432] acpiphp: Slot [5] registered [vm-test-run-centjes-e2e-test] client # [ 0.579406] acpiphp: Slot [6] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.647204] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [vm-test-run-centjes-e2e-test] client # [ 0.580406] acpiphp: Slot [7] registered [vm-test-run-centjes-e2e-test] client # [ 0.581438] acpiphp: Slot [8] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.649677] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.582408] acpiphp: Slot [9] registered [vm-test-run-centjes-e2e-test] client # [ 0.583406] acpiphp: Slot [10] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.651993] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] [vm-test-run-centjes-e2e-test] client # [ 0.584407] acpiphp: Slot [11] registered [vm-test-run-centjes-e2e-test] client # [ 0.585406] acpiphp: Slot [12] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.653993] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] [vm-test-run-centjes-e2e-test] client # [ 0.586408] acpiphp: Slot [13] registered [vm-test-run-centjes-e2e-test] client # [ 0.587423] acpiphp: Slot [14] registered [vm-test-run-centjes-e2e-test] client # [ 0.588413] acpiphp: Slot [15] registered [vm-test-run-centjes-e2e-test] client # [ 0.589413] acpiphp: Slot [16] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.657850] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.590406] acpiphp: Slot [17] registered [vm-test-run-centjes-e2e-test] client # [ 0.591406] acpiphp: Slot [18] registered [vm-test-run-centjes-e2e-test] client # [ 0.592406] acpiphp: Slot [19] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.660992] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] [vm-test-run-centjes-e2e-test] client # [ 0.593407] acpiphp: Slot [20] registered [vm-test-run-centjes-e2e-test] client # [ 0.594406] acpiphp: Slot [21] registered [vm-test-run-centjes-e2e-test] client # [ 0.595406] acpiphp: Slot [22] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.665758] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.596406] acpiphp: Slot [23] registered [vm-test-run-centjes-e2e-test] client # [ 0.597407] acpiphp: Slot [24] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.667995] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] [vm-test-run-centjes-e2e-test] client # [ 0.598408] acpiphp: Slot [25] registered [vm-test-run-centjes-e2e-test] client # [ 0.599406] acpiphp: Slot [26] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.670956] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] [vm-test-run-centjes-e2e-test] client # [ 0.600428] acpiphp: Slot [27] registered [vm-test-run-centjes-e2e-test] client # [ 0.601412] acpiphp: Slot [28] registered [vm-test-run-centjes-e2e-test] client # [ 0.602406] acpiphp: Slot [29] registered [vm-test-run-centjes-e2e-test] client # [ 0.603406] acpiphp: Slot [30] registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.675621] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.604415] acpiphp: Slot [31] registered [vm-test-run-centjes-e2e-test] client # [ 0.605396] PCI host bridge to bus 0000:00 [vm-test-run-centjes-e2e-test] client # [ 0.606374] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [vm-test-run-centjes-e2e-test] client # [ 0.607370] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [vm-test-run-centjes-e2e-test] docsserver # [ 0.680380] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.608370] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [vm-test-run-centjes-e2e-test] docsserver # [ 0.682964] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] [vm-test-run-centjes-e2e-test] client # [ 0.610370] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] [vm-test-run-centjes-e2e-test] docsserver # [ 0.684971] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] [vm-test-run-centjes-e2e-test] client # [ 0.612370] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] [vm-test-run-centjes-e2e-test] client # [ 0.614370] pci_bus 0000:00: root bus resource [bus 00-ff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.688543] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.615864] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.618534] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.693366] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.695944] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] [vm-test-run-centjes-e2e-test] client # [ 0.621942] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.697803] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] [vm-test-run-centjes-e2e-test] client # [ 0.626836] pci 0000:00:01.1: BAR 4 [io 0xc1e0-0xc1ef] [vm-test-run-centjes-e2e-test] docsserver # [ 0.702480] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.630072] pci 0000:00:01.1: BAR 0 [io 0x01f0-0x01f7]: legacy IDE quirk [vm-test-run-centjes-e2e-test] client # [ 0.631370] pci 0000:00:01.1: BAR 1 [io 0x03f6]: legacy IDE quirk [vm-test-run-centjes-e2e-test] docsserver # [ 0.707425] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.632369] pci 0000:00:01.1: BAR 2 [io 0x0170-0x0177]: legacy IDE quirk [vm-test-run-centjes-e2e-test] docsserver # [ 0.709975] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] [vm-test-run-centjes-e2e-test] client # [ 0.633369] pci 0000:00:01.1: BAR 3 [io 0x0376]: legacy IDE quirk [vm-test-run-centjes-e2e-test] docsserver # [ 0.711928] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] [vm-test-run-centjes-e2e-test] client # [ 0.634712] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.638892] pci 0000:00:01.2: BAR 4 [io 0xc100-0xc11f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.715993] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.643128] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.721559] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.645640] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [vm-test-run-centjes-e2e-test] docsserver # [ 0.723992] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] [vm-test-run-centjes-e2e-test] client # [ 0.647400] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [vm-test-run-centjes-e2e-test] docsserver # [ 0.725992] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] [vm-test-run-centjes-e2e-test] client # [ 0.648902] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.651983] pci 0000:00:02.0: BAR 0 [mem 0xfd000000-0xfdffffff pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.729700] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.655402] pci 0000:00:02.0: BAR 2 [mem 0xfebd0000-0xfebd0fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.734504] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.736992] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] [vm-test-run-centjes-e2e-test] client # [ 0.660929] pci 0000:00:02.0: ROM [mem 0xfebc0000-0xfebcffff pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.738857] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] [vm-test-run-centjes-e2e-test] client # [ 0.662548] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.741992] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.665117] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.667369] pci 0000:00:03.0: BAR 0 [io 0xc120-0xc13f] [vm-test-run-centjes-e2e-test] client # [ 0.669369] pci 0000:00:03.0: BAR 1 [mem 0xfebd1000-0xfebd1fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.743995] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] [vm-test-run-centjes-e2e-test] client # [ 0.674369] pci 0000:00:03.0: BAR 4 [mem 0xfe000000-0xfe003fff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.748583] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.677371] pci 0000:00:03.0: ROM [mem 0xfeb40000-0xfeb7ffff pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.751341] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] [vm-test-run-centjes-e2e-test] client # [ 0.681929] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.754992] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.684369] pci 0000:00:04.0: BAR 0 [io 0xc140-0xc15f] [vm-test-run-centjes-e2e-test] client # [ 0.686330] pci 0000:00:04.0: BAR 1 [mem 0xfebd2000-0xfebd2fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.760347] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.762995] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.764893] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] [vm-test-run-centjes-e2e-test] client # [ 0.690371] pci 0000:00:04.0: BAR 4 [mem 0xfe004000-0xfe007fff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.768743] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.695863] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.698369] pci 0000:00:05.0: BAR 0 [io 0xc080-0xc0bf] [vm-test-run-centjes-e2e-test] docsserver # [ 0.773481] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.700348] pci 0000:00:05.0: BAR 1 [mem 0xfebd3000-0xfebd3fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.775946] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] [vm-test-run-centjes-e2e-test] docsserver # [ 0.777854] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] [vm-test-run-centjes-e2e-test] client # [ 0.705874] pci 0000:00:05.0: BAR 4 [mem 0xfe008000-0xfe00bfff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.781471] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] [vm-test-run-centjes-e2e-test] client # [ 0.710851] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.786680] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [vm-test-run-centjes-e2e-test] client # [ 0.713369] pci 0000:00:06.0: BAR 0 [io 0xc160-0xc17f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.788245] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [vm-test-run-centjes-e2e-test] client # [ 0.715335] pci 0000:00:06.0: BAR 1 [mem 0xfebd4000-0xfebd4fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.790232] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [vm-test-run-centjes-e2e-test] docsserver # [ 0.792239] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [vm-test-run-centjes-e2e-test] client # [ 0.719871] pci 0000:00:06.0: BAR 4 [mem 0xfe00c000-0xfe00ffff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.794088] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [vm-test-run-centjes-e2e-test] docsserver # [ 0.795380] iommu: Default domain type: Translated [vm-test-run-centjes-e2e-test] docsserver # [ 0.796992] iommu: DMA domain TLB invalidation policy: lazy mode [vm-test-run-centjes-e2e-test] client # [ 0.724938] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.798017] ACPI: bus type USB registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.799022] usbcore: registered new interface driver usbfs [vm-test-run-centjes-e2e-test] client # [ 0.727344] pci 0000:00:07.0: BAR 0 [io 0xc180-0xc19f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.800002] usbcore: registered new interface driver hub [vm-test-run-centjes-e2e-test] client # [ 0.729338] pci 0000:00:07.0: BAR 1 [mem 0xfebd5000-0xfebd5fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.801002] usbcore: registered new device driver usb [vm-test-run-centjes-e2e-test] docsserver # [ 0.802316] NetLabel: Initializing [vm-test-run-centjes-e2e-test] docsserver # [ 0.802992] NetLabel: domain hash size = 128 [vm-test-run-centjes-e2e-test] client # [ 0.733780] pci 0000:00:07.0: BAR 4 [mem 0xfe010000-0xfe013fff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.803992] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [vm-test-run-centjes-e2e-test] docsserver # [ 0.805020] NetLabel: unlabeled traffic allowed by default [vm-test-run-centjes-e2e-test] docsserver # [ 0.805993] PCI: Using ACPI for IRQ routing [vm-test-run-centjes-e2e-test] client # [ 0.738909] pci 0000:00:08.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.807768] pci 0000:00:02.0: vgaarb: setting as boot VGA device [vm-test-run-centjes-e2e-test] docsserver # [ 0.807984] pci 0000:00:02.0: vgaarb: bridge control possible [vm-test-run-centjes-e2e-test] client # [ 0.741369] pci 0000:00:08.0: BAR 0 [io 0xc000-0xc07f] [vm-test-run-centjes-e2e-test] docsserver # [ 0.807984] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [vm-test-run-centjes-e2e-test] client # [ 0.743369] pci 0000:00:08.0: BAR 1 [mem 0xfebd6000-0xfebd6fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.807994] vgaarb: loaded [vm-test-run-centjes-e2e-test] docsserver # [ 0.809085] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [vm-test-run-centjes-e2e-test] docsserver # [ 0.809994] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [vm-test-run-centjes-e2e-test] client # [ 0.748882] pci 0000:00:08.0: BAR 4 [mem 0xfe014000-0xfe017fff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.814033] clocksource: Switched to clocksource kvm-clock [vm-test-run-centjes-e2e-test] docsserver # [ 0.817460] VFS: Disk quotas dquot_6.6.0 [vm-test-run-centjes-e2e-test] client # [ 0.753874] pci 0000:00:09.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.819522] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [vm-test-run-centjes-e2e-test] docsserver # [ 0.822978] pnp: PnP ACPI init [vm-test-run-centjes-e2e-test] client # [ 0.756316] pci 0000:00:09.0: BAR 0 [io 0xc1a0-0xc1bf] [vm-test-run-centjes-e2e-test] docsserver # [ 0.825128] pnp: PnP ACPI: found 6 devices [vm-test-run-centjes-e2e-test] client # [ 0.758233] pci 0000:00:09.0: BAR 1 [mem 0xfebd7000-0xfebd7fff] [vm-test-run-centjes-e2e-test] client # [ 0.762230] pci 0000:00:09.0: BAR 4 [mem 0xfe018000-0xfe01bfff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.833134] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [vm-test-run-centjes-e2e-test] docsserver # [ 0.837007] clocksource: Switched to clocksource acpi_pm [vm-test-run-centjes-e2e-test] docsserver # [ 0.839562] NET: Registered PF_INET protocol family [vm-test-run-centjes-e2e-test] docsserver # [ 0.841941] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.764207] pci 0000:00:09.0: ROM [mem 0xfeb80000-0xfebbffff pref] [vm-test-run-centjes-e2e-test] client # [ 0.767898] pci 0000:00:0a.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] client # [ 0.770692] pci 0000:00:0a.0: BAR 1 [mem 0xfebd8000-0xfebd8fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.854447] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 0.858262] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.774106] pci 0000:00:0a.0: BAR 4 [mem 0xfe01c000-0xfe01ffff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.861792] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 0.865426] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.778531] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.868744] TCP: Hash tables configured (established 8192 bind 8192) [vm-test-run-centjes-e2e-test] client # [ 0.781369] pci 0000:00:0b.0: BAR 0 [io 0xc0c0-0xc0ff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.871846] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.784212] pci 0000:00:0b.0: BAR 1 [mem 0xfebd9000-0xfebd9fff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.875619] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 0.879206] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.787780] pci 0000:00:0b.0: BAR 4 [mem 0xfe020000-0xfe023fff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.882471] NET: Registered PF_UNIX/PF_LOCAL protocol family [vm-test-run-centjes-e2e-test] docsserver # [ 0.885074] NET: Registered PF_XDP protocol family [vm-test-run-centjes-e2e-test] client # [ 0.792703] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint [vm-test-run-centjes-e2e-test] docsserver # [ 0.887570] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [vm-test-run-centjes-e2e-test] docsserver # [ 0.890959] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [vm-test-run-centjes-e2e-test] client # [ 0.795333] pci 0000:00:0c.0: BAR 0 [io 0xc1c0-0xc1df] [vm-test-run-centjes-e2e-test] docsserver # [ 0.894197] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [vm-test-run-centjes-e2e-test] client # [ 0.797377] pci 0000:00:0c.0: BAR 1 [mem 0xfebda000-0xfebdafff] [vm-test-run-centjes-e2e-test] docsserver # [ 0.897991] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] [vm-test-run-centjes-e2e-test] docsserver # [ 0.901181] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] [vm-test-run-centjes-e2e-test] client # [ 0.800726] pci 0000:00:0c.0: BAR 4 [mem 0xfe024000-0xfe027fff 64bit pref] [vm-test-run-centjes-e2e-test] docsserver # [ 0.904540] pci 0000:00:01.0: PIIX3: Enabling Passive Release [vm-test-run-centjes-e2e-test] docsserver # [ 0.907181] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [vm-test-run-centjes-e2e-test] client # [ 0.806156] ACPI: PCI: Interrupt link LNKA configured for IRQ 10 [vm-test-run-centjes-e2e-test] docsserver # [ 0.911287] ACPI: \_SB_.LNKD: Enabled at IRQ 11 [vm-test-run-centjes-e2e-test] client # [ 0.807585] ACPI: PCI: Interrupt link LNKB configured for IRQ 10 [vm-test-run-centjes-e2e-test] docsserver # [ 0.915505] PCI: CLS 0 bytes, default 64 [vm-test-run-centjes-e2e-test] client # [ 0.808599] ACPI: PCI: Interrupt link LNKC configured for IRQ 11 [vm-test-run-centjes-e2e-test] docsserver # [ 0.917687] Trying to unpack rootfs image as initramfs... [vm-test-run-centjes-e2e-test] client # [ 0.810579] ACPI: PCI: Interrupt link LNKD configured for IRQ 11 [vm-test-run-centjes-e2e-test] client # [ 0.812483] ACPI: PCI: Interrupt link LNKS configured for IRQ 9 [vm-test-run-centjes-e2e-test] client # [ 0.813774] iommu: Default domain type: Translated [vm-test-run-centjes-e2e-test] docsserver # [ 0.922241] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns [vm-test-run-centjes-e2e-test] client # [ 0.815371] iommu: DMA domain TLB invalidation policy: lazy mode [vm-test-run-centjes-e2e-test] client # [ 0.816443] ACPI: bus type USB registered [vm-test-run-centjes-e2e-test] client # [ 0.817395] usbcore: registered new interface driver usbfs [vm-test-run-centjes-e2e-test] client # [ 0.818386] usbcore: registered new interface driver hub [vm-test-run-centjes-e2e-test] client # [ 0.819381] usbcore: registered new device driver usb [vm-test-run-centjes-e2e-test] client # [ 0.820713] NetLabel: Initializing [vm-test-run-centjes-e2e-test] client # [ 0.821371] NetLabel: domain hash size = 128 [vm-test-run-centjes-e2e-test] client # [ 0.822370] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO [vm-test-run-centjes-e2e-test] client # [ 0.823400] NetLabel: unlabeled traffic allowed by default [vm-test-run-centjes-e2e-test] client # [ 0.824371] PCI: Using ACPI for IRQ routing [vm-test-run-centjes-e2e-test] client # [ 0.826151] pci 0000:00:02.0: vgaarb: setting as boot VGA device [vm-test-run-centjes-e2e-test] client # [ 0.826361] pci 0000:00:02.0: vgaarb: bridge control possible [vm-test-run-centjes-e2e-test] docsserver # [ 0.953489] Initialise system trusted keyrings [vm-test-run-centjes-e2e-test] client # [ 0.826361] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none [vm-test-run-centjes-e2e-test] client # [ 0.826372] vgaarb: loaded [vm-test-run-centjes-e2e-test] docsserver # [ 0.958294] workingset: timestamp_bits=40 max_order=18 bucket_order=0 [vm-test-run-centjes-e2e-test] client # [ 0.827479] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [vm-test-run-centjes-e2e-test] client # [ 0.828369] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [vm-test-run-centjes-e2e-test] client # [ 0.833412] clocksource: Switched to clocksource kvm-clock [vm-test-run-centjes-e2e-test] client # [ 0.836840] VFS: Disk quotas dquot_6.6.0 [vm-test-run-centjes-e2e-test] client # [ 0.838748] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [vm-test-run-centjes-e2e-test] client # [ 0.842479] pnp: PnP ACPI init [vm-test-run-centjes-e2e-test] client # [ 0.844509] pnp: PnP ACPI: found 6 devices [vm-test-run-centjes-e2e-test] docsserver # [ 0.983344] Key type asymmetric registered [vm-test-run-centjes-e2e-test] docsserver # [ 0.989176] Asymmetric key parser 'x509' registered [vm-test-run-centjes-e2e-test] client # [ 0.852517] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [vm-test-run-centjes-e2e-test] client # [ 0.856661] clocksource: Switched to clocksource acpi_pm [vm-test-run-centjes-e2e-test] docsserver # [ 0.994303] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [vm-test-run-centjes-e2e-test] client # [ 0.859140] NET: Registered PF_INET protocol family [vm-test-run-centjes-e2e-test] client # [ 0.861952] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.003305] io scheduler mq-deadline registered [vm-test-run-centjes-e2e-test] docsserver # [ 1.005401] io scheduler kyber registered [vm-test-run-centjes-e2e-test] docsserver # [ 1.009965] Freeing initrd memory: 12300K [vm-test-run-centjes-e2e-test] docsserver # [ 1.012474] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [vm-test-run-centjes-e2e-test] client # [ 0.875708] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear) [vm-test-run-centjes-e2e-test] client # [ 0.879389] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.016284] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [vm-test-run-centjes-e2e-test] client # [ 0.882849] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.021438] Linux agpgart interface v0.103 [vm-test-run-centjes-e2e-test] client # [ 0.886366] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.023577] ACPI: bus type drm_connector registered [vm-test-run-centjes-e2e-test] client # [ 0.889722] TCP: Hash tables configured (established 8192 bind 8192) [vm-test-run-centjes-e2e-test] docsserver # [ 1.026460] usbcore: registered new interface driver usbserial_generic [vm-test-run-centjes-e2e-test] client # [ 0.892671] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.029656] usbserial: USB Serial support registered for generic [vm-test-run-centjes-e2e-test] client # [ 0.896051] UDP hash table entries: 512 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.032655] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled [vm-test-run-centjes-e2e-test] client # [ 0.899021] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes, linear) [vm-test-run-centjes-e2e-test] docsserver # [ 1.036357] drop_monitor: Initializing network drop monitor service [vm-test-run-centjes-e2e-test] client # [ 0.902218] NET: Registered PF_UNIX/PF_LOCAL protocol family [vm-test-run-centjes-e2e-test] docsserver # [ 1.039519] NET: Registered PF_INET6 protocol family [vm-test-run-centjes-e2e-test] client # [ 0.904860] NET: Registered PF_XDP protocol family [vm-test-run-centjes-e2e-test] docsserver # [ 1.042717] Segment Routing with IPv6 [vm-test-run-centjes-e2e-test] client # [ 0.907192] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] [vm-test-run-centjes-e2e-test] docsserver # [ 1.044575] In-situ OAM (IOAM) with IPv6 [vm-test-run-centjes-e2e-test] docsserver # [ 1.046775] IPI shorthand broadcast: enabled [vm-test-run-centjes-e2e-test] client # [ 0.909982] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] [vm-test-run-centjes-e2e-test] client # [ 0.912761] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] [vm-test-run-centjes-e2e-test] docsserver # [ 1.051043] registered taskstats version 1 [vm-test-run-centjes-e2e-test] docsserver # [ 1.053367] Loading compiled-in X.509 certificates [vm-test-run-centjes-e2e-test] client # [ 0.915817] pci_bus 0000:00: resource 7 [mem 0x40000000-0xfebfffff window] [vm-test-run-centjes-e2e-test] client # [ 0.919384] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window] [vm-test-run-centjes-e2e-test] client # [ 0.922700] pci 0000:00:01.0: PIIX3: Enabling Passive Release [vm-test-run-centjes-e2e-test] docsserver # [ 1.060339] Demotion targets for Node 0: null [vm-test-run-centjes-e2e-test] docsserver # [ 1.062463] Key type .fscrypt registered [vm-test-run-centjes-e2e-test] client # [ 0.925500] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [vm-test-run-centjes-e2e-test] docsserver # [ 1.064328] Key type fscrypt-provisioning registered [vm-test-run-centjes-e2e-test] docsserver # [ 1.066718] PM: Magic number: 14:240:636 [vm-test-run-centjes-e2e-test] client # [ 0.930394] ACPI: \_SB_.LNKD: Enabled at IRQ 11 [vm-test-run-centjes-e2e-test] docsserver # [ 1.069517] RAS: Correctable Errors collector initialized. [vm-test-run-centjes-e2e-test] client # [ 0.935220] PCI: CLS 0 bytes, default 64 [vm-test-run-centjes-e2e-test] client # [ 0.937332] Trying to unpack rootfs image as initramfs... [vm-test-run-centjes-e2e-test] docsserver # [ 1.074934] Unstable clock detected, switching default tracing clock to "global" [vm-test-run-centjes-e2e-test] docsserver # [ 1.074934] If you want to keep using the local clock, then add: [vm-test-run-centjes-e2e-test] client # [ 0.941717] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x31024cfe468, max_idle_ns: 440795307017 ns [vm-test-run-centjes-e2e-test] docsserver # [ 1.074934] "trace_clock=local" [vm-test-run-centjes-e2e-test] docsserver # [ 1.074934] on the kernel command line [vm-test-run-centjes-e2e-test] docsserver # [ 1.083775] clk: Disabling unused clocks [vm-test-run-centjes-e2e-test] docsserver # [ 1.085717] PM: genpd: Disabling unused power domains [vm-test-run-centjes-e2e-test] docsserver # [ 1.089292] Freeing unused decrypted memory: 2028K [vm-test-run-centjes-e2e-test] docsserver # [ 1.092044] Freeing unused kernel image (initmem) memory: 3408K [vm-test-run-centjes-e2e-test] docsserver # [ 1.094885] Write protecting the kernel read-only data: 30720k [vm-test-run-centjes-e2e-test] docsserver # [ 1.097918] Freeing unused kernel image (rodata/data gap) memory: 1756K [vm-test-run-centjes-e2e-test] client # [ 0.970936] Initialise system trusted keyrings [vm-test-run-centjes-e2e-test] client # [ 0.976750] workingset: timestamp_bits=40 max_order=18 bucket_order=0 [vm-test-run-centjes-e2e-test] client # [ 1.001782] Key type asymmetric registered [vm-test-run-centjes-e2e-test] docsserver # [ 1.140947] x86/mm: Checked W+X mappings: passed, no W+X pages found. [vm-test-run-centjes-e2e-test] client # [ 1.006671] Asymmetric key parser 'x509' registered [vm-test-run-centjes-e2e-test] docsserver # [ 1.144397] Run /init as init process [vm-test-run-centjes-e2e-test] client # [ 1.012676] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [vm-test-run-centjes-e2e-test] client # [ 1.021734] io scheduler mq-deadline registered [vm-test-run-centjes-e2e-test] client # [ 1.023853] io scheduler kyber registered [vm-test-run-centjes-e2e-test] client # [ 1.027226] Freeing initrd memory: 12300K [vm-test-run-centjes-e2e-test] client # [ 1.029511] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [vm-test-run-centjes-e2e-test] client # [ 1.032867] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [vm-test-run-centjes-e2e-test] client # [ 1.037479] Linux agpgart interface v0.103 [vm-test-run-centjes-e2e-test] client # [ 1.039549] ACPI: bus type drm_connector registered [vm-test-run-centjes-e2e-test] client # [ 1.042093] usbcore: registered new interface driver usbserial_generic [vm-test-run-centjes-e2e-test] client # [ 1.045089] usbserial: USB Serial support registered for generic [vm-test-run-centjes-e2e-test] client # [ 1.047819] amd_pstate: the _CPC object is not present in SBIOS or ACPI disabled [vm-test-run-centjes-e2e-test] client # [ 1.051141] drop_monitor: Initializing network drop monitor service [vm-test-run-centjes-e2e-test] docsserver # [ 1.188693] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev [vm-test-run-centjes-e2e-test] client # [ 1.054072] NET: Registered PF_INET6 protocol family [vm-test-run-centjes-e2e-test] client # [ 1.057063] Segment Routing with IPv6 [vm-test-run-centjes-e2e-test] client # [ 1.058885] In-situ OAM (IOAM) with IPv6 [vm-test-run-centjes-e2e-test] client # [ 1.061012] IPI shorthand broadcast: enabled [vm-test-run-centjes-e2e-test] client # [ 1.065219] registered taskstats version 1 [vm-test-run-centjes-e2e-test] client # [ 1.067387] Loading compiled-in X.509 certificates [vm-test-run-centjes-e2e-test] client # [ 1.074316] Demotion targets for Node 0: null [vm-test-run-centjes-e2e-test] client # [ 1.076472] Key type .fscrypt registered [vm-test-run-centjes-e2e-test] client # [ 1.078471] Key type fscrypt-provisioning registered [vm-test-run-centjes-e2e-test] client # [ 1.080916] PM: Magic number: 14:240:636 [vm-test-run-centjes-e2e-test] client # [ 1.083417] RAS: Correctable Errors collector initialized. [vm-test-run-centjes-e2e-test] client # [ 1.088826] Unstable clock detected, switching default tracing clock to "global" [vm-test-run-centjes-e2e-test] client # [ 1.088826] If you want to keep using the local clock, then add: [vm-test-run-centjes-e2e-test] client # [ 1.088826] "trace_clock=local" [vm-test-run-centjes-e2e-test] client # [ 1.088826] on the kernel command line [vm-test-run-centjes-e2e-test] client # [ 1.097154] clk: Disabling unused clocks [vm-test-run-centjes-e2e-test] client # [ 1.099104] PM: genpd: Disabling unused power domains [vm-test-run-centjes-e2e-test] client # [ 1.102414] Freeing unused decrypted memory: 2028K [vm-test-run-centjes-e2e-test] client # [ 1.104992] Freeing unused kernel image (initmem) memory: 3408K [vm-test-run-centjes-e2e-test] client # [ 1.107662] Write protecting the kernel read-only data: 30720k [vm-test-run-centjes-e2e-test] client # [ 1.110529] Freeing unused kernel image (rodata/data gap) memory: 1756K [vm-test-run-centjes-e2e-test] client # [ 1.153241] x86/mm: Checked W+X mappings: passed, no W+X pages found. [vm-test-run-centjes-e2e-test] client # [ 1.156129] Run /init as init process [vm-test-run-centjes-e2e-test] client # [ 1.203417] device-mapper: ioctl: 4.48.0-ioctl (2023-03-01) initialised: dm-devel@lists.linux.dev [vm-test-run-centjes-e2e-test] docsserver # [ 1.350395] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [vm-test-run-centjes-e2e-test] docsserver # [ 1.358189] uhci_hcd 0000:00:01.2: UHCI Host Controller [vm-test-run-centjes-e2e-test] docsserver # [ 1.377423] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 [vm-test-run-centjes-e2e-test] docsserver # [ 1.382392] serio: i8042 KBD port at 0x60,0x64 irq 1 [vm-test-run-centjes-e2e-test] docsserver # [ 1.385251] SCSI subsystem initialized [vm-test-run-centjes-e2e-test] docsserver # [ 1.388489] ACPI: \_SB_.LNKC: Enabled at IRQ 10 [vm-test-run-centjes-e2e-test] docsserver # [ 1.393170] serio: i8042 AUX port at 0x60,0x64 irq 12 [vm-test-run-centjes-e2e-test] docsserver # [ 1.398240] uhci_hcd 0000:00:01.2: detected 2 ports [vm-test-run-centjes-e2e-test] docsserver # [ 1.408852] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 [vm-test-run-centjes-e2e-test] docsserver # [ 1.419317] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12 [vm-test-run-centjes-e2e-test] docsserver # [ 1.423377] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [vm-test-run-centjes-e2e-test] docsserver # [ 1.427392] usb usb1: Product: UHCI Host Controller [vm-test-run-centjes-e2e-test] docsserver # [ 1.429790] usb usb1: Manufacturer: Linux 6.12.62 uhci_hcd [vm-test-run-centjes-e2e-test] docsserver # [ 1.432542] usb usb1: SerialNumber: 0000:00:01.2 [vm-test-run-centjes-e2e-test] docsserver # [ 1.439078] ACPI: \_SB_.LNKA: Enabled at IRQ 10 [vm-test-run-centjes-e2e-test] docsserver # [ 1.444564] scsi host0: ata_piix [vm-test-run-centjes-e2e-test] docsserver # [ 1.450536] scsi host1: ata_piix [vm-test-run-centjes-e2e-test] docsserver # [ 1.453974] ACPI: \_SB_.LNKB: Enabled at IRQ 11 [vm-test-run-centjes-e2e-test] docsserver # [ 1.457327] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 [vm-test-run-centjes-e2e-test] docsserver # [ 1.461003] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 [vm-test-run-centjes-e2e-test] docsserver # [ 1.467699] hub 1-0:1.0: USB hub found [vm-test-run-centjes-e2e-test] docsserver # [ 1.473527] hub 1-0:1.0: 2 ports detected [vm-test-run-centjes-e2e-test] client # [ 1.372757] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [vm-test-run-centjes-e2e-test] client # [ 1.397037] SCSI subsystem initialized [vm-test-run-centjes-e2e-test] client # [ 1.402068] serio: i8042 KBD port at 0x60,0x64 irq 1 [vm-test-run-centjes-e2e-test] client # [ 1.406935] ACPI: \_SB_.LNKC: Enabled at IRQ 10 [vm-test-run-centjes-e2e-test] client # [ 1.411339] uhci_hcd 0000:00:01.2: UHCI Host Controller [vm-test-run-centjes-e2e-test] client # [ 1.415658] serio: i8042 AUX port at 0x60,0x64 irq 12 [vm-test-run-centjes-e2e-test] client # [ 1.423656] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 [vm-test-run-centjes-e2e-test] client # [ 1.436844] uhci_hcd 0000:00:01.2: detected 2 ports [vm-test-run-centjes-e2e-test] client # [ 1.443276] ACPI: \_SB_.LNKA: Enabled at IRQ 10 [vm-test-run-centjes-e2e-test] client # [ 1.448052] uhci_hcd 0000:00:01.2: irq 11, io port 0x0000c100 [vm-test-run-centjes-e2e-test] client # [ 1.452498] scsi host0: ata_piix [vm-test-run-centjes-e2e-test] client # [ 1.456350] scsi host1: ata_piix [vm-test-run-centjes-e2e-test] client # [ 1.458339] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 6.12 [vm-test-run-centjes-e2e-test] client # [ 1.461947] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [vm-test-run-centjes-e2e-test] client # [ 1.465186] usb usb1: Product: UHCI Host Controller [vm-test-run-centjes-e2e-test] client # [ 1.467484] usb usb1: Manufacturer: Linux 6.12.62 uhci_hcd [vm-test-run-centjes-e2e-test] client # [ 1.470044] usb usb1: SerialNumber: 0000:00:01.2 [vm-test-run-centjes-e2e-test] client # [ 1.473729] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1e0 irq 14 lpm-pol 0 [vm-test-run-centjes-e2e-test] client # [ 1.477094] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1e8 irq 15 lpm-pol 0 [vm-test-run-centjes-e2e-test] client # [ 1.482430] ACPI: \_SB_.LNKB: Enabled at IRQ 11 [vm-test-run-centjes-e2e-test] docsserver # [ 1.619065] ata2: found unknown device (class 0) [vm-test-run-centjes-e2e-test] docsserver # [ 1.622629] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 [vm-test-run-centjes-e2e-test] docsserver # [ 1.627484] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 [vm-test-run-centjes-e2e-test] client # [ 1.495054] hub 1-0:1.0: USB hub found [vm-test-run-centjes-e2e-test] client # [ 1.497736] hub 1-0:1.0: 2 ports detected [vm-test-run-centjes-e2e-test] docsserver # [ 1.698185] usb 1-1: new full-speed USB device number 2 using uhci_hcd [vm-test-run-centjes-e2e-test] docsserver # [ 1.706683] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [vm-test-run-centjes-e2e-test] docsserver # [ 1.731790] virtio_blk virtio5: 1/0/0 default/read/poll queues [vm-test-run-centjes-e2e-test] docsserver # [ 1.762399] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [vm-test-run-centjes-e2e-test] client # [ 1.638527] ata2: found unknown device (class 0) [vm-test-run-centjes-e2e-test] docsserver # [ 1.777607] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray [vm-test-run-centjes-e2e-test] client # [ 1.641896] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 [vm-test-run-centjes-e2e-test] docsserver # [ 1.780639] cdrom: Uniform CD-ROM driver Revision: 3.20 [vm-test-run-centjes-e2e-test] client # [ 1.646881] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 [vm-test-run-centjes-e2e-test] docsserver # [ 1.785319] netfs: FS-Cache loaded [vm-test-run-centjes-e2e-test] docsserver # [ 1.799784] 9pnet: Installing 9P2000 support [vm-test-run-centjes-e2e-test] client # [ 1.721053] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [vm-test-run-centjes-e2e-test] client # [ 1.728661] usb 1-1: new full-speed USB device number 2 using uhci_hcd [vm-test-run-centjes-e2e-test] docsserver # [ 1.873446] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 [vm-test-run-centjes-e2e-test] docsserver # [ 1.877165] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 [vm-test-run-centjes-e2e-test] docsserver # [ 1.880677] usb 1-1: Product: QEMU USB Tablet [vm-test-run-centjes-e2e-test] docsserver # [ 1.882862] usb 1-1: Manufacturer: QEMU [vm-test-run-centjes-e2e-test] docsserver # [ 1.884854] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 [vm-test-run-centjes-e2e-test] client # [ 1.749307] virtio_blk virtio5: 1/0/0 default/read/poll queues [vm-test-run-centjes-e2e-test] docsserver # [ 1.900184] hid: raw HID events driver (C) Jiri Kosina [vm-test-run-centjes-e2e-test] client # [ 1.779759] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB) [vm-test-run-centjes-e2e-test] client # [ 1.788340] netfs: FS-Cache loaded [vm-test-run-centjes-e2e-test] docsserver # [ 1.930185] usbcore: registered new interface driver usbhid [vm-test-run-centjes-e2e-test] client # [ 1.796236] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray [vm-test-run-centjes-e2e-test] docsserver # [ 1.932643] usbhid: USB HID core driver [vm-test-run-centjes-e2e-test] client # [ 1.799259] cdrom: Uniform CD-ROM driver Revision: 3.20 [vm-test-run-centjes-e2e-test] client # [ 1.809100] 9pnet: Installing 9P2000 support [vm-test-run-centjes-e2e-test] docsserver # [ 1.942976] 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 [vm-test-run-centjes-e2e-test] docsserver # [ 1.948376] 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 [vm-test-run-centjes-e2e-test] client # [ 1.905835] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00 [vm-test-run-centjes-e2e-test] client # [ 1.909642] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=10 [vm-test-run-centjes-e2e-test] client # [ 1.912930] usb 1-1: Product: QEMU USB Tablet [vm-test-run-centjes-e2e-test] client # [ 1.915058] usb 1-1: Manufacturer: QEMU [vm-test-run-centjes-e2e-test] client # [ 1.916991] usb 1-1: SerialNumber: 28754-0000:00:01.2-1 [vm-test-run-centjes-e2e-test] client # [ 1.937505] hid: raw HID events driver (C) Jiri Kosina [vm-test-run-centjes-e2e-test] docsserver # [ 2.081173] EXT4-fs (vda): mounted filesystem d8d433f3-a725-481a-a7ff-a218e1210a9a r/w with ordered data mode. Quota mode: none. [vm-test-run-centjes-e2e-test] client # [ 1.958338] usbcore: registered new interface driver usbhid [vm-test-run-centjes-e2e-test] client # [ 1.960965] usbhid: USB HID core driver [vm-test-run-centjes-e2e-test] docsserver # [ 2.102496] 9p: Installing v9fs 9p2000 file system support [vm-test-run-centjes-e2e-test] client # [ 1.968979] 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 [vm-test-run-centjes-e2e-test] client # [ 1.975877] 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 [vm-test-run-centjes-e2e-test] client # [ 2.095321] EXT4-fs (vda): mounted filesystem 1eff4a94-67d8-4533-9e9d-a2d04e660a4c r/w with ordered data mode. Quota mode: none. [vm-test-run-centjes-e2e-test] client # [ 2.115217] 9p: Installing v9fs 9p2000 file system support [vm-test-run-centjes-e2e-test] docsserver # [ 2.329215] EXT4-fs (vda): re-mounted d8d433f3-a725-481a-a7ff-a218e1210a9a. [vm-test-run-centjes-e2e-test] docsserver # [ 2.334386] booting system configuration /nix/store/3bh2pzd647lgkl010yjc6xwbynahfd9w-nixos-system-docsserver-test [vm-test-run-centjes-e2e-test] client # [ 2.348692] EXT4-fs (vda): re-mounted 1eff4a94-67d8-4533-9e9d-a2d04e660a4c. [vm-test-run-centjes-e2e-test] client # [ 2.352999] booting system configuration /nix/store/001k9r4jinw78ih5x5hxggb82ynlbkqn-nixos-system-client-test [vm-test-run-centjes-e2e-test] docsserver # [ 3.960795] systemd[1]: Inserted module 'autofs4' [vm-test-run-centjes-e2e-test] client # [ 3.832692] systemd[1]: Inserted module 'autofs4' [vm-test-run-centjes-e2e-test] docsserver # [ 4.011973] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) [vm-test-run-centjes-e2e-test] client # [ 3.875422] systemd[1]: systemd 258.2 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 -IDN -IPTC +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP -SYSVINIT +LIBARCHIVE) [vm-test-run-centjes-e2e-test] docsserver # [ 4.025022] systemd[1]: Detected virtualization kvm. [vm-test-run-centjes-e2e-test] client # [ 3.888770] systemd[1]: Detected virtualization kvm. [vm-test-run-centjes-e2e-test] docsserver # [ 4.027372] systemd[1]: Detected architecture x86-64. [vm-test-run-centjes-e2e-test] client # [ 3.891041] systemd[1]: Detected architecture x86-64. [vm-test-run-centjes-e2e-test] docsserver # [ 4.029659] systemd[1]: Detected first boot. [vm-test-run-centjes-e2e-test] client # [ 3.893417] systemd[1]: Detected first boot. [vm-test-run-centjes-e2e-test] client # [ 3.901050] systemd[1]: Initializing machine ID from random generator. [vm-test-run-centjes-e2e-test] docsserver # [ 4.053366] systemd[1]: Initializing machine ID from random generator. [vm-test-run-centjes-e2e-test] client # [ 3.924855] systemd[1]: Hostname set to . [vm-test-run-centjes-e2e-test] docsserver # [ 4.082296] systemd[1]: Hostname set to . [vm-test-run-centjes-e2e-test] client # [ 4.034703] systemd[1]: bpf-restrict-fs: LSM BPF program attached [vm-test-run-centjes-e2e-test] docsserver # [ 4.192072] systemd[1]: bpf-restrict-fs: LSM BPF program attached [vm-test-run-centjes-e2e-test] client # [ 4.175871] systemd[1]: Applying preset policy. [vm-test-run-centjes-e2e-test] docsserver # [ 4.325361] systemd[1]: Applying preset policy. [vm-test-run-centjes-e2e-test] docsserver # [ 4.812243] systemd[1]: Populated /etc with preset unit settings. [vm-test-run-centjes-e2e-test] client # [ 4.714522] systemd[1]: Populated /etc with preset unit settings. [vm-test-run-centjes-e2e-test] docsserver # [ 5.168400] systemd[1]: /etc/systemd/system/centjes-docs-site-production.service:3: Invalid URL, ignoring: /nix/store/nciahq33l541v3i4y2dnpk28dxjk66k8-settings-check [vm-test-run-centjes-e2e-test] docsserver # [ 5.267637] systemd[1]: Queued start job for default target Multi-User System. [vm-test-run-centjes-e2e-test] docsserver # [ 5.295703] systemd[1]: Created slice Slice /system/getty. [vm-test-run-centjes-e2e-test] docsserver # [ 5.298443] systemd[1]: Created slice Slice /system/modprobe. [vm-test-run-centjes-e2e-test] docsserver # [ 5.301041] systemd[1]: Created slice User and Session Slice. [vm-test-run-centjes-e2e-test] docsserver # [ 5.303629] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [vm-test-run-centjes-e2e-test] docsserver # [ 5.306487] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [vm-test-run-centjes-e2e-test] docsserver # [ 5.309416] systemd[1]: Expecting device /dev/hvc0... [vm-test-run-centjes-e2e-test] docsserver # [ 5.311341] systemd[1]: Expecting device /dev/ttyS0... [vm-test-run-centjes-e2e-test] docsserver # [ 5.313252] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... [vm-test-run-centjes-e2e-test] docsserver # [ 5.315693] systemd[1]: Reached target Local Encrypted Volumes. [vm-test-run-centjes-e2e-test] docsserver # [ 5.317844] systemd[1]: Reached target Virtual Machines and Containers. [vm-test-run-centjes-e2e-test] docsserver # [ 5.320273] systemd[1]: Reached target Path Units. [vm-test-run-centjes-e2e-test] docsserver # [ 5.322065] systemd[1]: Reached target Remote File Systems. [vm-test-run-centjes-e2e-test] docsserver # [ 5.324195] systemd[1]: Reached target Slice Units. [vm-test-run-centjes-e2e-test] docsserver # [ 5.326035] systemd[1]: Reached target Swaps. [vm-test-run-centjes-e2e-test] docsserver # [ 5.331263] systemd[1]: Listening on Process Core Dump Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.335670] systemd[1]: Listening on Credential Encryption/Decryption. [vm-test-run-centjes-e2e-test] docsserver # [ 5.338454] systemd[1]: Listening on Journal Audit Socket. [vm-test-run-centjes-e2e-test] client # [ 5.203214] systemd[1]: Queued start job for default target Multi-User System. [vm-test-run-centjes-e2e-test] docsserver # [ 5.340643] systemd[1]: Listening on Journal Socket (/dev/log). [vm-test-run-centjes-e2e-test] docsserver # [ 5.342989] systemd[1]: Listening on Journal Sockets. [vm-test-run-centjes-e2e-test] docsserver # [ 5.345362] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.347977] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). [vm-test-run-centjes-e2e-test] docsserver # [ 5.351747] systemd[1]: Listening on udev Control Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.353877] systemd[1]: Listening on udev Kernel Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.359774] systemd[1]: Mounting Huge Pages File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.364930] systemd[1]: Mounting POSIX Message Queue File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.372308] systemd[1]: Mounting Kernel Debug File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.383849] systemd[1]: Mounting Kernel Trace File System... [vm-test-run-centjes-e2e-test] client # [ 5.257123] systemd[1]: Created slice Slice /system/getty. [vm-test-run-centjes-e2e-test] client # [ 5.260033] systemd[1]: Created slice Slice /system/modprobe. [vm-test-run-centjes-e2e-test] docsserver # [ 5.398878] systemd[1]: Starting Create List of Static Device Nodes... [vm-test-run-centjes-e2e-test] client # [ 5.263031] systemd[1]: Created slice User and Session Slice. [vm-test-run-centjes-e2e-test] client # [ 5.265492] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [vm-test-run-centjes-e2e-test] client # [ 5.268307] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [vm-test-run-centjes-e2e-test] docsserver # [ 5.404980] systemd[1]: Load Kernel Module 9pnet_virtio was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!9pnet_virtio). [vm-test-run-centjes-e2e-test] client # [ 5.271020] systemd[1]: Expecting device /dev/hvc0... [vm-test-run-centjes-e2e-test] client # [ 5.272931] systemd[1]: Expecting device /dev/ttyS0... [vm-test-run-centjes-e2e-test] client # [ 5.274865] systemd[1]: Expecting device /sys/subsystem/net/devices/eth1... [vm-test-run-centjes-e2e-test] client # [ 5.277254] systemd[1]: Reached target Local Encrypted Volumes. [vm-test-run-centjes-e2e-test] docsserver # [ 5.420966] systemd[1]: Starting Load Kernel Module configfs... [vm-test-run-centjes-e2e-test] client # [ 5.279390] systemd[1]: Reached target Virtual Machines and Containers. [vm-test-run-centjes-e2e-test] client # [ 5.281728] systemd[1]: Reached target Path Units. [vm-test-run-centjes-e2e-test] client # [ 5.283382] systemd[1]: Reached target Remote File Systems. [vm-test-run-centjes-e2e-test] client # [ 5.285357] systemd[1]: Reached target Slice Units. [vm-test-run-centjes-e2e-test] client # [ 5.287206] systemd[1]: Reached target Swaps. [vm-test-run-centjes-e2e-test] docsserver # [ 5.425677] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). [vm-test-run-centjes-e2e-test] client # [ 5.292551] systemd[1]: Listening on Process Core Dump Socket. [vm-test-run-centjes-e2e-test] client # [ 5.297092] systemd[1]: Listening on Credential Encryption/Decryption. [vm-test-run-centjes-e2e-test] client # [ 5.300270] systemd[1]: Listening on Journal Audit Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.439329] systemd[1]: Starting Load Kernel Module efi_pstore... [vm-test-run-centjes-e2e-test] client # [ 5.302974] systemd[1]: Listening on Journal Socket (/dev/log). [vm-test-run-centjes-e2e-test] client # [ 5.305850] systemd[1]: Listening on Journal Sockets. [vm-test-run-centjes-e2e-test] client # [ 5.308338] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.447607] systemd[1]: Starting Load Kernel Module fuse... [vm-test-run-centjes-e2e-test] client # [ 5.311395] systemd[1]: Make TPM PCR Policy was skipped because of an unmet condition check (ConditionSecurity=measured-uki). [vm-test-run-centjes-e2e-test] client # [ 5.315436] systemd[1]: Listening on udev Control Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 5.451522] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). [vm-test-run-centjes-e2e-test] client # [ 5.317895] systemd[1]: Listening on udev Kernel Socket. [vm-test-run-centjes-e2e-test] client # [ 5.323723] systemd[1]: Mounting Huge Pages File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.456562] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). [vm-test-run-centjes-e2e-test] client # [ 5.329819] systemd[1]: Mounting POSIX Message Queue File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.472970] systemd[1]: Starting Journal Service... [vm-test-run-centjes-e2e-test] client # [ 5.338510] systemd[1]: Mounting Kernel Debug File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.483294] systemd[1]: Starting Load Kernel Modules... [vm-test-run-centjes-e2e-test] client # [ 5.350957] systemd[1]: Mounting Kernel Trace File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.493902] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... [vm-test-run-centjes-e2e-test] client # [ 5.365121] systemd[1]: Starting Create List of Static Device Nodes... [vm-test-run-centjes-e2e-test] docsserver # [ 5.503344] systemd[1]: Starting Remount Root and Kernel File Systems... [vm-test-run-centjes-e2e-test] docsserver # [ 5.509288] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). [vm-test-run-centjes-e2e-test] client # [ 5.375741] systemd[1]: Load Kernel Module 9pnet_virtio was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!9pnet_virtio). [vm-test-run-centjes-e2e-test] docsserver # [ 5.523627] systemd[1]: Starting Coldplug All udev Devices... [vm-test-run-centjes-e2e-test] client # [ 5.391807] systemd[1]: Starting Load Kernel Module configfs... [vm-test-run-centjes-e2e-test] docsserver # [ 5.534287] systemd[1]: Mounted Huge Pages File System. [vm-test-run-centjes-e2e-test] client # [ 5.396270] systemd[1]: Load Kernel Module drm was skipped because of an unmet condition check (ConditionKernelModuleLoaded=!drm). [vm-test-run-centjes-e2e-test] docsserver # [ 5.539434] systemd[1]: Mounted POSIX Message Queue File System. [vm-test-run-centjes-e2e-test] client # [ 5.404269] systemd[1]: Starting Load Kernel Module efi_pstore... [vm-test-run-centjes-e2e-test] docsserver # [ 5.544488] systemd[1]: Mounted Kernel Debug File System. [vm-test-run-centjes-e2e-test] docsserver # [ 5.548422] systemd[1]: Mounted Kernel Trace File System. [vm-test-run-centjes-e2e-test] client # [ 5.412736] systemd[1]: Starting Load Kernel Module fuse... [vm-test-run-centjes-e2e-test] client # [ 5.417205] systemd[1]: File System Check on Root Device was skipped because of an unmet condition check (ConditionPathIsReadWrite=!/). [vm-test-run-centjes-e2e-test] docsserver # [ 5.555681] systemd[1]: Finished Create List of Static Device Nodes. [vm-test-run-centjes-e2e-test] client # [ 5.423012] systemd[1]: Clear Stale Hibernate Storage Info was skipped because of an unmet condition check (ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67). [vm-test-run-centjes-e2e-test] docsserver # [ 5.568867] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... [vm-test-run-centjes-e2e-test] client # [ 5.436840] systemd[1]: Starting Journal Service... [vm-test-run-centjes-e2e-test] docsserver # [ 5.574923] systemd[1]: modprobe@configfs.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 5.581652] systemd[1]: Finished Load Kernel Module configfs. [vm-test-run-centjes-e2e-test] client # [ 5.447366] systemd[1]: Starting Load Kernel Modules... [vm-test-run-centjes-e2e-test] docsserver # [ 5.586734] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] client # [ 5.455063] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer... [vm-test-run-centjes-e2e-test] docsserver # [ 5.594031] systemd[1]: Finished Load Kernel Module efi_pstore. [vm-test-run-centjes-e2e-test] client # [ 5.464729] systemd[1]: Starting Remount Root and Kernel File Systems... [vm-test-run-centjes-e2e-test] docsserver # [ 5.602653] systemd[1]: Mounting Kernel Configuration File System... [vm-test-run-centjes-e2e-test] client # [ 5.470716] systemd[1]: Early TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). [vm-test-run-centjes-e2e-test] client # [ 5.483698] systemd[1]: Starting Coldplug All udev Devices... [vm-test-run-centjes-e2e-test] docsserver # [ 5.626909] systemd[1]: Mounted Kernel Configuration File System. [vm-test-run-centjes-e2e-test] client # [ 5.493261] systemd[1]: Mounted Huge Pages File System. [vm-test-run-centjes-e2e-test] client # [ 5.497893] systemd[1]: Mounted POSIX Message Queue File System. [vm-test-run-centjes-e2e-test] client # [ 5.502363] systemd[1]: Mounted Kernel Debug File System. [vm-test-run-centjes-e2e-test] client # [ 5.506267] systemd[1]: Mounted Kernel Trace File System. [vm-test-run-centjes-e2e-test] docsserver # [ 5.648372] EXT4-fs (vda): re-mounted d8d433f3-a725-481a-a7ff-a218e1210a9a. [vm-test-run-centjes-e2e-test] client # [ 5.514219] systemd[1]: Finished Create List of Static Device Nodes. [vm-test-run-centjes-e2e-test] docsserver # [ 5.657044] fuse: init (API version 7.41) [vm-test-run-centjes-e2e-test] docsserver # [ 5.660431] systemd-journald[381]: Collecting audit messages is enabled. [vm-test-run-centjes-e2e-test] client # [ 5.525141] systemd[1]: Starting Create Static Device Nodes in /dev gracefully... [vm-test-run-centjes-e2e-test] docsserver # [ 5.670324] loop: module loaded [vm-test-run-centjes-e2e-test] client # [ 5.536228] systemd[1]: modprobe@configfs.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 5.676679] systemd[1]: modprobe@fuse.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] client # [ 5.541948] systemd[1]: Finished Load Kernel Module configfs. [vm-test-run-centjes-e2e-test] docsserver # [ 5.681955] systemd[1]: Finished Load Kernel Module fuse. [vm-test-run-centjes-e2e-test] client # [ 5.551097] systemd[1]: Mounting Kernel Configuration File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.689304] systemd[1]: Finished Remount Root and Kernel File Systems. [vm-test-run-centjes-e2e-test] client # [ 5.560955] systemd[1]: modprobe@efi_pstore.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 5.695799] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [vm-test-run-centjes-e2e-test] client # [ 5.569880] systemd[1]: Finished Load Kernel Module efi_pstore. [vm-test-run-centjes-e2e-test] docsserver # [ 5.710542] systemd[1]: Starting Load/Save OS Random Seed... [vm-test-run-centjes-e2e-test] docsserver # [ 5.715279] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). [vm-test-run-centjes-e2e-test] client # [ 5.582441] systemd[1]: Mounted Kernel Configuration File System. [vm-test-run-centjes-e2e-test] docsserver # [ 5.727455] systemd[1]: Finished Load Kernel Modules. [vm-test-run-centjes-e2e-test] docsserver # [ 5.735447] systemd[1]: Starting Firewall... [vm-test-run-centjes-e2e-test] docsserver # [ 5.746319] systemd[1]: Starting Apply Kernel Variables... [vm-test-run-centjes-e2e-test] client # [ 5.613836] EXT4-fs (vda): re-mounted 1eff4a94-67d8-4533-9e9d-a2d04e660a4c. [vm-test-run-centjes-e2e-test] client # [ 5.617079] systemd-journald[387]: Collecting audit messages is enabled. [vm-test-run-centjes-e2e-test] client # [ 5.629343] fuse: init (API version 7.41) [vm-test-run-centjes-e2e-test] client # [ 5.631836] loop: module loaded [vm-test-run-centjes-e2e-test] client # [ 5.643506] systemd[1]: Finished Remount Root and Kernel File Systems. [vm-test-run-centjes-e2e-test] client # [ 5.648074] systemd[1]: Platform Persistent Storage Archival was skipped because of an unmet condition check (ConditionDirectoryNotEmpty=/sys/fs/pstore). [vm-test-run-centjes-e2e-test] client # [ 5.663460] systemd[1]: Starting Load/Save OS Random Seed... [vm-test-run-centjes-e2e-test] client # [ 5.667768] systemd[1]: TPM SRK Setup was skipped because of an unmet condition check (ConditionSecurity=measured-uki). [vm-test-run-centjes-e2e-test] client # [ 5.676161] systemd[1]: modprobe@fuse.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] client # [ 5.683227] systemd[1]: Finished Load Kernel Module fuse. [vm-test-run-centjes-e2e-test] docsserver # [ 5.819226] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. [vm-test-run-centjes-e2e-test] client # [ 5.690107] systemd[1]: Finished Load Kernel Modules. [vm-test-run-centjes-e2e-test] docsserver # [ 5.830368] systemd[1]: Starting Create Static Device Nodes in /dev... [vm-test-run-centjes-e2e-test] client # [ 5.698393] systemd[1]: Mounting FUSE Control File System... [vm-test-run-centjes-e2e-test] docsserver # [ 5.843974] systemd[1]: Finished Load/Save OS Random Seed. [vm-test-run-centjes-e2e-test] client # [ 5.709280] systemd[1]: Starting Firewall... [vm-test-run-centjes-e2e-test] docsserver # [ 5.848582] systemd[1]: Reached target First Boot Complete. [vm-test-run-centjes-e2e-test] docsserver # [ 5.854452] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. [vm-test-run-centjes-e2e-test] client # [ 5.720000] systemd[1]: Starting Apply Kernel Variables... [vm-test-run-centjes-e2e-test] client # [ 5.732193] systemd[1]: Mounted FUSE Control File System. [vm-test-run-centjes-e2e-test] docsserver # [ 5.881713] systemd[1]: Finished Apply Kernel Variables. [vm-test-run-centjes-e2e-test] client # [ 5.798077] systemd[1]: Finished Create Static Device Nodes in /dev gracefully. [vm-test-run-centjes-e2e-test] client # [ 5.808851] systemd[1]: Starting Create Static Device Nodes in /dev... [vm-test-run-centjes-e2e-test] client # [ 5.817153] systemd[1]: Finished Load/Save OS Random Seed. [vm-test-run-centjes-e2e-test] client # [ 5.822014] systemd[1]: Reached target First Boot Complete. [vm-test-run-centjes-e2e-test] docsserver # [ 5.966836] systemd[1]: Finished Create Static Device Nodes in /dev. [vm-test-run-centjes-e2e-test] docsserver # [ 5.971630] systemd[1]: Reached target Preparation for Local File Systems. [vm-test-run-centjes-e2e-test] client # [ 5.845075] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer. [vm-test-run-centjes-e2e-test] docsserver # [ 5.981301] systemd[1]: Starting Rule-based Manager for Device Events and Files... [vm-test-run-centjes-e2e-test] client # [ 5.864443] systemd[1]: Finished Apply Kernel Variables. [vm-test-run-centjes-e2e-test] client # [ 5.943098] systemd[1]: Finished Create Static Device Nodes in /dev. [vm-test-run-centjes-e2e-test] client # [ 5.948291] systemd[1]: Reached target Preparation for Local File Systems. [vm-test-run-centjes-e2e-test] client # [ 5.957772] systemd[1]: Starting Rule-based Manager for Device Events and Files... [vm-test-run-centjes-e2e-test] docsserver # [ 6.156479] systemd[1]: Started Journal Service. [vm-test-run-centjes-e2e-test] docsserver # [ 5.816213] systemd-modules-load[382]: Inserted module 'loop' [vm-test-run-centjes-e2e-test] docsserver # [ 5.823846] systemd-oomd[383]: [0;1;38:5:185mNo swap; memory pressure usage will be degraded [vm-test-run-centjes-e2e-test] docsserver # [ 5.838979] systemd-udevd[405]: Using default interface naming scheme 'v258'. [vm-test-run-centjes-e2e-test] docsserver # [ 5.853444] systemd[1]: Starting Flush Journal to Persistent Storage... [vm-test-run-centjes-e2e-test] docsserver # [ 6.246690] systemd-journald[381]: Received client request to flush runtime journal. [vm-test-run-centjes-e2e-test] client # [ 6.164539] systemd[1]: Started Journal Service. [vm-test-run-centjes-e2e-test] client # [ 5.810664] systemd-modules-load[388]: Inserted module 'loop' [vm-test-run-centjes-e2e-test] client # [ 5.822832] systemd-oomd[389]: [0;1;38:5:185mNo swap; memory pressure usage will be degraded [vm-test-run-centjes-e2e-test] client # [ 5.849517] systemd-udevd[412]: Using default interface naming scheme 'v258'. [vm-test-run-centjes-e2e-test] client # [ 5.869473] systemd[1]: Starting Flush Journal to Persistent Storage... [vm-test-run-centjes-e2e-test] client # [ 6.279959] systemd-journald[387]: Received client request to flush runtime journal. [vm-test-run-centjes-e2e-test] docsserver # [ 6.117822] systemd[1]: Started Rule-based Manager for Device Events and Files. [vm-test-run-centjes-e2e-test] docsserver # [ 6.127320] systemd[1]: Finished Coldplug All udev Devices. [vm-test-run-centjes-e2e-test] docsserver # [ 6.132545] systemd[1]: Finished Flush Journal to Persistent Storage. [vm-test-run-centjes-e2e-test] docsserver # [ 6.189224] systemd[1]: Mounting /run/wrappers... [vm-test-run-centjes-e2e-test] docsserver # [ 6.195775] systemd[1]: Mounting FUSE Control File System... [vm-test-run-centjes-e2e-test] docsserver # [ 6.221890] systemd[1]: Mounted FUSE Control File System. [vm-test-run-centjes-e2e-test] docsserver # [ 6.243506] systemd[1]: Mounted /run/wrappers. [vm-test-run-centjes-e2e-test] docsserver # [ 6.249211] systemd[1]: Reached target Local File Systems. [vm-test-run-centjes-e2e-test] docsserver # [ 6.255306] systemd[1]: Listening on Boot Entries Service Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 6.262324] systemd[1]: Starting Create SUID/SGID Wrappers... [vm-test-run-centjes-e2e-test] client # [ 6.128355] systemd[1]: Started Rule-based Manager for Device Events and Files. [vm-test-run-centjes-e2e-test] docsserver # [ 6.272595] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. [vm-test-run-centjes-e2e-test] client # [ 6.138711] systemd[1]: Finished Coldplug All udev Devices. [vm-test-run-centjes-e2e-test] docsserver # [ 6.286212] systemd[1]: Starting Save Transient machine-id to Disk... [vm-test-run-centjes-e2e-test] client # [ 6.148503] systemd[1]: Finished Flush Journal to Persistent Storage. [vm-test-run-centjes-e2e-test] docsserver # [ 6.294349] systemd[1]: Starting Create System Files and Directories... [vm-test-run-centjes-e2e-test] client # [ 6.155971] systemd[1]: Mounting /run/wrappers... [vm-test-run-centjes-e2e-test] client # [ 6.186833] systemd[1]: Mounted /run/wrappers. [vm-test-run-centjes-e2e-test] client # [ 6.195311] systemd[1]: Reached target Local File Systems. [vm-test-run-centjes-e2e-test] client # [ 6.204230] systemd[1]: Listening on Boot Entries Service Socket. [vm-test-run-centjes-e2e-test] client # [ 6.211598] systemd[1]: Starting Create SUID/SGID Wrappers... [vm-test-run-centjes-e2e-test] client # [ 6.221171] systemd[1]: Update Boot Loader Random Seed was skipped because no trigger condition checks were met. [vm-test-run-centjes-e2e-test] client # [ 6.233804] systemd[1]: Starting Save Transient machine-id to Disk... [vm-test-run-centjes-e2e-test] client # [ 6.246371] systemd[1]: Starting Create System Files and Directories... [vm-test-run-centjes-e2e-test] docsserver # [ 6.406838] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 6.420209] systemd[1]: Finished Save Transient machine-id to Disk. [vm-test-run-centjes-e2e-test] docsserver # [ 6.426648] systemd[1]: Finished Create System Files and Directories. [vm-test-run-centjes-e2e-test] docsserver # [ 6.438467] systemd[1]: Starting Rebuild Journal Catalog... [vm-test-run-centjes-e2e-test] docsserver # [ 6.446885] systemd[1]: Starting Record System Boot/Shutdown in UTMP... [vm-test-run-centjes-e2e-test] client # [ 6.370637] systemd[1]: Finished Create System Files and Directories. [vm-test-run-centjes-e2e-test] client # [ 6.381631] systemd[1]: etc-machine\x2did.mount: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 6.533582] systemd[1]: Finished Record System Boot/Shutdown in UTMP. [vm-test-run-centjes-e2e-test] client # [ 6.392677] systemd[1]: Starting Rebuild Journal Catalog... [vm-test-run-centjes-e2e-test] client # [ 6.402728] systemd[1]: Starting Record System Boot/Shutdown in UTMP... [vm-test-run-centjes-e2e-test] client # [ 6.414956] systemd[1]: Finished Save Transient machine-id to Disk. [vm-test-run-centjes-e2e-test] docsserver # [ 6.600308] systemd[1]: Finished Rebuild Journal Catalog. [vm-test-run-centjes-e2e-test] docsserver # [ 6.607217] systemd[1]: Starting Update is Completed... [vm-test-run-centjes-e2e-test] client # [ 6.474832] systemd[1]: Finished Record System Boot/Shutdown in UTMP. [vm-test-run-centjes-e2e-test] docsserver # [ 6.655362] systemd[1]: Found device /dev/hvc0. [vm-test-run-centjes-e2e-test] docsserver # [ 6.675475] systemd[1]: Finished Update is Completed. [vm-test-run-centjes-e2e-test] client # [ 6.531256] systemd[1]: Finished Rebuild Journal Catalog. [vm-test-run-centjes-e2e-test] client # [ 6.537481] systemd[1]: Starting Update is Completed... [vm-test-run-centjes-e2e-test] docsserver # [ 6.704228] systemd[1]: Found device /dev/ttyS0. [vm-test-run-centjes-e2e-test] client # [ 6.604948] systemd[1]: Finished Update is Completed. [vm-test-run-centjes-e2e-test] docsserver # [ 6.777701] (udev-worker)[475]: Network interface NamePolicy= disabled on kernel command line. [vm-test-run-centjes-e2e-test] docsserver # [ 6.787545] (udev-worker)[483]: [0;1;38:5:185meth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. [vm-test-run-centjes-e2e-test] docsserver # [ 6.800705] (udev-worker)[483]: Network interface NamePolicy= disabled on kernel command line. [vm-test-run-centjes-e2e-test] client # [ 6.735802] systemd[1]: Found device /dev/hvc0. [vm-test-run-centjes-e2e-test] client # [ 6.774926] systemd[1]: Found device /dev/ttyS0. [vm-test-run-centjes-e2e-test] docsserver # [ 6.958539] systemd[1]: Finished Firewall. [vm-test-run-centjes-e2e-test] client # [ 6.819417] (udev-worker)[487]: [0;1;38:5:185meth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name. [vm-test-run-centjes-e2e-test] client # [ 6.836856] (udev-worker)[487]: Network interface NamePolicy= disabled on kernel command line. [vm-test-run-centjes-e2e-test] client # [ 6.847509] (udev-worker)[500]: Network interface NamePolicy= disabled on kernel command line. [vm-test-run-centjes-e2e-test] docsserver # [ 6.998181] systemd[1]: Found device Virtio network device. [vm-test-run-centjes-e2e-test] docsserver # [ 7.047578] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 7.055850] systemd[1]: Finished Create SUID/SGID Wrappers. [vm-test-run-centjes-e2e-test] client # [ 6.912865] systemd[1]: Finished Firewall. [vm-test-run-centjes-e2e-test] docsserver # [ 7.062328] systemd[1]: Reached target System Initialization. [vm-test-run-centjes-e2e-test] docsserver # [ 7.068443] systemd[1]: Started Discard unused filesystem blocks once a week. [vm-test-run-centjes-e2e-test] docsserver # [ 7.078311] systemd[1]: Started Daily Cleanup of Temporary Directories. [vm-test-run-centjes-e2e-test] docsserver # [ 7.087636] systemd[1]: Reached target Timer Units. [vm-test-run-centjes-e2e-test] docsserver # [ 7.100899] systemd[1]: Listening on D-Bus System Message Bus Socket. [vm-test-run-centjes-e2e-test] client # [ 6.975308] systemd[1]: Found device Virtio network device. [vm-test-run-centjes-e2e-test] docsserver # [ 7.121300] systemd[1]: Listening on Nix Daemon Socket. [vm-test-run-centjes-e2e-test] client # [ 6.979902] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 7.130343] systemd[1]: Listening on Hostname Service Socket. [vm-test-run-centjes-e2e-test] client # [ 6.989801] systemd[1]: Finished Create SUID/SGID Wrappers. [vm-test-run-centjes-e2e-test] docsserver # [ 7.140144] systemd[1]: Reached target Socket Units. [vm-test-run-centjes-e2e-test] client # [ 6.996924] systemd[1]: Reached target System Initialization. [vm-test-run-centjes-e2e-test] docsserver # [ 7.152268] systemd[1]: Reached target Basic System. [vm-test-run-centjes-e2e-test] client # [ 7.002843] systemd[1]: Started Discard unused filesystem blocks once a week. [vm-test-run-centjes-e2e-test] client # [ 7.015466] systemd[1]: Started Daily Cleanup of Temporary Directories. [vm-test-run-centjes-e2e-test] docsserver # [ 7.165580] systemd[1]: System is tainted: support-ended [vm-test-run-centjes-e2e-test] client # [ 7.030795] systemd[1]: Reached target Timer Units. [vm-test-run-centjes-e2e-test] docsserver # [ 7.181505] systemd[1]: Started backdoor.service. [vm-test-run-centjes-e2e-test] client # [ 7.042764] systemd[1]: Listening on D-Bus System Message Bus Socket. [vm-test-run-centjes-e2e-test] client # [ 7.057511] systemd[1]: Listening on Nix Daemon Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 7.197669] systemd[1]: Starting Import lastlog data into lastlog2 database... [vm-test-run-centjes-e2e-test] client # [ 7.066453] systemd[1]: Listening on Hostname Service Socket. [vm-test-run-centjes-e2e-test] docsserver # [ 7.221487] systemd[1]: Starting Name Service Cache Daemon (nsncd)... [vm-test-run-centjes-e2e-test] client # [ 7.083548] systemd[1]: Reached target Socket Units. [vm-test-run-centjes-e2e-test] docsserver # [ 7.238236] systemd[1]: Started Reset console on configuration changes. [vm-test-run-centjes-e2e-test] client # [ 7.097269] systemd[1]: Reached target Basic System. [vm-test-run-centjes-e2e-test] docsserver # [ 7.252408] systemd[1]: Starting resolvconf update... [vm-test-run-centjes-e2e-test] docsserver # connecting to host... [vm-test-run-centjes-e2e-test] client # [ 7.110395] systemd[1]: System is tainted: support-ended [vm-test-run-centjes-e2e-test] docsserver # [ 7.267343] systemd[1]: Started Centjes docs site production Service. [vm-test-run-centjes-e2e-test] client # [ 7.124675] systemd[1]: Started backdoor.service. [vm-test-run-centjes-e2e-test] docsserver # [ 7.281834] systemd[1]: Starting D-Bus System Message Bus... [vm-test-run-centjes-e2e-test] client # [ 7.133622] systemd[1]: Starting Import lastlog data into lastlog2 database... [vm-test-run-centjes-e2e-test] client # [ 7.149214] systemd[1]: Starting Name Service Cache Daemon (nsncd)... [vm-test-run-centjes-e2e-test] docsserver # [ 7.294194] systemd[1]: Finished Import lastlog data into lastlog2 database. [vm-test-run-centjes-e2e-test] client # connecting to host... [vm-test-run-centjes-e2e-test] client # [ 7.163202] systemd[1]: Started Reset console on configuration changes. [vm-test-run-centjes-e2e-test] docsserver # [ 7.309569] systemd[1]: Started Name Service Cache Daemon (nsncd). [vm-test-run-centjes-e2e-test] client # [ 7.175613] systemd[1]: Starting resolvconf update... [vm-test-run-centjes-e2e-test] docsserver: Guest shell says: b'Spawning backdoor root shell...\n' [vm-test-run-centjes-e2e-test] docsserver: connected to guest root shell [vm-test-run-centjes-e2e-test] docsserver: (connecting took 8.28 seconds) [vm-test-run-centjes-e2e-test] client # [ 7.181902] systemd[1]: Starting D-Bus System Message Bus... [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for the VM to finish booting, in 8.28 seconds) [vm-test-run-centjes-e2e-test] docsserver # [ 7.323358] nsncd[621]: Oct 02 14:36:14.434 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" [vm-test-run-centjes-e2e-test] client # [ 7.192803] systemd[1]: Finished Import lastlog data into lastlog2 database. [vm-test-run-centjes-e2e-test] docsserver # [ 7.346636] systemd[1]: Reached target Host and Network Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.208724] systemd[1]: Started Name Service Cache Daemon (nsncd). [vm-test-run-centjes-e2e-test] docsserver # [ 7.360542] systemd[1]: Reached target User and Group Name Lookups. [vm-test-run-centjes-e2e-test] docsserver # [ 7.370293] systemd[1]: Starting User Login Management... [vm-test-run-centjes-e2e-test] client # [ 7.217887] nsncd[626]: Oct 02 14:36:14.471 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" [vm-test-run-centjes-e2e-test] client # [ 7.240778] systemd[1]: Reached target Host and Network Name Lookups. [vm-test-run-centjes-e2e-test] docsserver # [ 7.380274] dbus-daemon[625]: dbus[625]: Unknown username "systemd-timesync" in message bus configuration file [vm-test-run-centjes-e2e-test] client # [ 7.252590] systemd[1]: Reached target User and Group Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.259799] systemd[1]: Starting User Login Management... [vm-test-run-centjes-e2e-test] client # [ 7.268899] dbus-daemon[629]: dbus[629]: Unknown username "systemd-timesync" in message bus configuration file [vm-test-run-centjes-e2e-test] docsserver # [ 7.435694] systemd[1]: Started D-Bus System Message Bus. [vm-test-run-centjes-e2e-test] client # [ 7.308148] systemd[1]: Started D-Bus System Message Bus. [vm-test-run-centjes-e2e-test] docsserver # [ 7.480660] systemd[1]: Stopped target Host and Network Name Lookups. [vm-test-run-centjes-e2e-test] docsserver # [ 7.491947] systemd[1]: Stopping Host and Network Name Lookups... [vm-test-run-centjes-e2e-test] docsserver # [ 7.495420] systemd[1]: Stopped target User and Group Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.346769] systemd[1]: Stopped target Host and Network Name Lookups. [vm-test-run-centjes-e2e-test] docsserver # [ 7.501603] systemd[1]: Stopping User and Group Name Lookups...[ 7.850762] mousedev: PS/2 mouse device common for all mice [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # [ 7.507936] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... [vm-test-run-centjes-e2e-test] client # [ 7.360975] systemd[1]: Stopping Host and Network Name Lookups... [vm-test-run-centjes-e2e-test] docsserver # [ 7.862496] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 [vm-test-run-centjes-e2e-test] client # [ 7.371336] systemd[1]: Stopped target User and Group Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.378368] systemd[1]: Stopping User and Group Name Lookups... [vm-test-run-centjes-e2e-test] client # [ 7.385854] systemd[1]: Stopping Name Service Cache Daemon (nsncd)... [vm-test-run-centjes-e2e-test] docsserver # [ 7.540280] systemd-logind[646]: New seat seat0. [vm-test-run-centjes-e2e-test] client # [ 7.394412] systemd[1]: nscd.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] client # [ 7.402530] systemd[1]: Stopped Name Service Cache Daemon (nsncd). [vm-test-run-centjes-e2e-test] docsserver # [ 7.553216] systemd[1]: Started User Login Management. [vm-test-run-centjes-e2e-test] client # [ 7.410376] systemd[1]: Starting Name Service Cache Daemon (nsncd)... [vm-test-run-centjes-e2e-test] docsserver # [ 7.559627] systemd[1]: nscd.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 7.570835] systemd[1]: Stopped Name Service Cache Daemon (nsncd).[ 7.921514] ACPI: button: Power Button [PWRF] [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] client # [ 7.425454] systemd-logind[651]: New seat seat0. [vm-test-run-centjes-e2e-test] client # [ 7.438679] systemd[1]: Started User Login Management. [vm-test-run-centjes-e2e-test] docsserver # [ 7.585950] systemd[1]: Starting linger-users.service... [vm-test-run-centjes-e2e-test] client # [ 7.446447] systemd[1]: Starting linger-users.service... [vm-test-run-centjes-e2e-test] docsserver # [ 7.594876] systemd[1]: Starting Name Service Cache Daemon (nsncd)... [vm-test-run-centjes-e2e-test] client # [ 7.464684] nsncd[688]: Oct 02 14:36:14.737 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" [vm-test-run-centjes-e2e-test] client # [ 7.486361] systemd[1]: Started Name Service Cache Daemon (nsncd). [vm-test-run-centjes-e2e-test] client # [ 7.850425] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3 [vm-test-run-centjes-e2e-test] client # [ 7.496885] systemd[1]: Reached target Host and Network Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.500427] systemd[1]: Reached target User and Group Name Lookups. [vm-test-run-centjes-e2e-test] docsserver # [ 7.645418] systemd[1]: linger-users.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 7.655245] systemd[1]: Finished linger-users.service. [vm-test-run-centjes-e2e-test] client # [ 7.506691] systemd[1]: linger-users.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] client # [ 7.512510] systemd[1]: Finished linger-users.service. [vm-test-run-centjes-e2e-test] client # [ 7.874364] mousedev: PS/2 mouse device common for all mice [vm-test-run-centjes-e2e-test] docsserver # [ 7.676377] systemd[1]: Started Name Service Cache Daemon (nsncd). [vm-test-run-centjes-e2e-test] client # [ 7.536329] systemd[1]: Finished resolvconf update. [vm-test-run-centjes-e2e-test] docsserver # [ 7.685480] systemd[1]: Reached target Host and Network Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.541886] systemd[1]: Reached target Preparation for Network. [vm-test-run-centjes-e2e-test] client # [ 7.548891] systemd[1]: Starting DHCP Client... [vm-test-run-centjes-e2e-test] docsserver # [ 7.694224] nsncd[694]: Oct 02 14:36:14.820 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket" [vm-test-run-centjes-e2e-test] client # [ 7.556661] systemd[1]: Starting Address configuration of eth1... [vm-test-run-centjes-e2e-test] docsserver # [ 7.708224] systemd[1]: Reached target User and Group Name Lookups. [vm-test-run-centjes-e2e-test] client # [ 7.923521] ACPI: button: Power Button [PWRF] [vm-test-run-centjes-e2e-test] docsserver # [ 7.729200] systemd[1]: Finished resolvconf update. [vm-test-run-centjes-e2e-test] docsserver # [ 7.740896] systemd[1]: Reached target Preparation for Network. [vm-test-run-centjes-e2e-test] docsserver # [ 7.752424] systemd[1]: Starting DHCP Client... [vm-test-run-centjes-e2e-test] docsserver # [ 7.758836] systemd[1]: Starting Address configuration of eth1...[ 8.107863] rtc_cmos 00:05: RTC can wake from S4 [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] client # [ 7.975459] rtc_cmos 00:05: RTC can wake from S4 [vm-test-run-centjes-e2e-test] client # [ 7.996531] Floppy drive(s): fd0 is 2.88M AMI BIOS [vm-test-run-centjes-e2e-test] client # [ 7.667525] network-addresses-eth1-start[718]: adding address 192.168.1.1/24... done[ 8.026294] parport_pc 00:03: reported by Plug and Play ACPI [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # [ 7.687217] network-addresses-eth1-start[718]: adding address 2001:db8:1::1/64... done[ 8.045836] rtc_cmos 00:05: registered as rtc0 [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # [ 8.061083] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] [vm-test-run-centjes-e2e-test] docsserver # [ 8.202431] parport_pc 00:03: reported by Plug and Play ACPI [vm-test-run-centjes-e2e-test] client # [ 8.068214] FDC 0 is a S82078B [vm-test-run-centjes-e2e-test] client # [ 7.720233] systemd[1]: Finished Address configuration of eth1. [vm-test-run-centjes-e2e-test] docsserver # [ 8.213994] Floppy drive(s): fd0 is 2.88M AMI BIOS [vm-test-run-centjes-e2e-test] client # [ 8.081179] rtc_cmos 00:05: setting system clock to 2026-10-02T14:36:14 UTC (1790951774) [vm-test-run-centjes-e2e-test] docsserver # [ 7.872900] network-addresses-eth1-start[728]: adding address 192.168.1.2/24... done[ 8.221639] rtc_cmos 00:05: registered as rtc0 [vm-test-run-centjes-e2e-test] client # [ 8.085922] systemd-journald[387]: Time jumped backwards, rotating. [vm-test-run-centjes-e2e-test] docsserver #  [vm-test-run-centjes-e2e-test] docsserver # [ 8.231314] systemd-journald[381]: Time jumped backwards, rotating. [vm-test-run-centjes-e2e-test] docsserver # [ 8.246272] rtc_cmos 00:05: setting system clock to 2026-10-02T14:36:14 UTC (1790951774) [vm-test-run-centjes-e2e-test] client # [ 8.116543] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [vm-test-run-centjes-e2e-test] docsserver # [ 8.260457] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)] [vm-test-run-centjes-e2e-test] docsserver # [ 8.281624] FDC 0 is a S82078B [vm-test-run-centjes-e2e-test] client # [ 7.792564] systemd[1]: Starting Networking Setup... [vm-test-run-centjes-e2e-test] client # [ 7.806906] dhcpcd[725]: dhcpcd-10.2.4 starting [vm-test-run-centjes-e2e-test] docsserver # [ 8.305718] rtc_cmos 00:05: alarms up to one day, y3k, 242 bytes nvram, hpet irqs [vm-test-run-centjes-e2e-test] client # [ 7.817348] dhcpcd[738]: dev: loaded udev [vm-test-run-centjes-e2e-test] docsserver # [ 7.965234] systemd[1]: Finished Address configuration of eth1. [vm-test-run-centjes-e2e-test] client # [ 8.179846] 8021q: 802.1Q VLAN Support v1.8 [vm-test-run-centjes-e2e-test] client # [ 8.183546] 8021q: adding VLAN 0 to HW filter on device eth1 [vm-test-run-centjes-e2e-test] docsserver # [ 7.975810] network-addresses-eth1-start[728]: adding address 2001:db8:1::2/64... done [vm-test-run-centjes-e2e-test] docsserver # [ 7.987860] systemd[1]: Starting Networking Setup... [vm-test-run-centjes-e2e-test] docsserver # [ 8.007352] dhcpcd[735]: dhcpcd-10.2.4 starting [vm-test-run-centjes-e2e-test] docsserver # [ 8.019743] dhcpcd[750]: dev: loaded udev [vm-test-run-centjes-e2e-test] docsserver # [ 8.380568] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [vm-test-run-centjes-e2e-test] docsserver # [ 8.388067] 8021q: 802.1Q VLAN Support v1.8 [vm-test-run-centjes-e2e-test] docsserver # [ 8.391601] 8021q: adding VLAN 0 to HW filter on device eth1 [vm-test-run-centjes-e2e-test] client # [ 8.266458] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [vm-test-run-centjes-e2e-test] docsserver # [ 8.405261] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD [vm-test-run-centjes-e2e-test] docsserver # [ 8.418543] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console [vm-test-run-centjes-e2e-test] client # [ 8.304219] cfg80211: Loading compiled-in X.509 certificates for regulatory database [vm-test-run-centjes-e2e-test] client # [ 8.330220] i2c i2c-0: Memory type 0x07 not supported yet, not instantiating SPD [vm-test-run-centjes-e2e-test] client # [ 8.337549] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [vm-test-run-centjes-e2e-test] client # [ 7.985435] systemd[1]: Finished Networking Setup.[ 8.343376] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' [vm-test-run-centjes-e2e-test] client # [ 8.349518] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 [vm-test-run-centjes-e2e-test] client #  [vm-test-run-centjes-e2e-test] client # [ 8.354977] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 [vm-test-run-centjes-e2e-test] client # [ 8.001484] systemd[1]: Reached target Network. [vm-test-run-centjes-e2e-test] client # [ 8.361538] cfg80211: failed to load regulatory.db [vm-test-run-centjes-e2e-test] client # [ 8.008942] systemd[1]: Starting Permit User Sessions... [vm-test-run-centjes-e2e-test] client # [ 8.400755] bochs-drm 0000:00:02.0: vgaarb: deactivate vga console [vm-test-run-centjes-e2e-test] docsserver # [ 8.200887] systemd[1]: Finished Networking Setup. [vm-test-run-centjes-e2e-test] client # [ 8.053730] systemd[1]: Finished Permit User Sessions. [vm-test-run-centjes-e2e-test] docsserver # [ 8.208360] systemd[1]: Reached target Network. [vm-test-run-centjes-e2e-test] client # [ 8.061468] systemd[1]: Started Getty on tty1. [vm-test-run-centjes-e2e-test] client # [ 8.066577] systemd[1]: Reached target Login Prompts. [vm-test-run-centjes-e2e-test] docsserver # [ 8.213595] systemd[1]: Starting Permit User Sessions... [vm-test-run-centjes-e2e-test] client # [ 8.434998] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 [vm-test-run-centjes-e2e-test] client # [ 8.439522] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 [vm-test-run-centjes-e2e-test] docsserver # [ 8.511709] cfg80211: Loading compiled-in X.509 certificates for regulatory database [vm-test-run-centjes-e2e-test] docsserver # [ 8.534912] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7' [vm-test-run-centjes-e2e-test] client # [ 8.125627] dhcpcd[738]: eth0: waiting for carrier [vm-test-run-centjes-e2e-test] docsserver # [ 8.535036] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600' [vm-test-run-centjes-e2e-test] docsserver # [ 8.536891] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2 [vm-test-run-centjes-e2e-test] client # [ 8.481452] 8021q: adding VLAN 0 to HW filter on device eth0 [vm-test-run-centjes-e2e-test] docsserver # [ 8.536895] cfg80211: failed to load regulatory.db [vm-test-run-centjes-e2e-test] client # [ 8.496474] cryptd: max_cpu_qlen set to 1000 [vm-test-run-centjes-e2e-test] docsserver # [ 8.586389] input: QEMU Virtio Keyboard as /devices/pci0000:00/0000:00:0a.0/virtio7/input/input4 [vm-test-run-centjes-e2e-test] client # [ 8.512009] Console: switching to colour dummy device 80x25 [vm-test-run-centjes-e2e-test] docsserver # [ 8.603876] Console: switching to colour dummy device 80x25 [vm-test-run-centjes-e2e-test] client # [ 8.520194] AES CTR mode by8 optimization enabled [vm-test-run-centjes-e2e-test] docsserver # [ 8.608422] cryptd: max_cpu_qlen set to 1000 [vm-test-run-centjes-e2e-test] client # [ 8.553987] [drm] Found bochs VGA, ID 0xb0c5. [vm-test-run-centjes-e2e-test] client # [ 8.554951] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. [vm-test-run-centjes-e2e-test] docsserver # [ 8.612805] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input6 [vm-test-run-centjes-e2e-test] docsserver # [ 8.613355] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input5 [vm-test-run-centjes-e2e-test] client # [ 8.236445] systemd[1]: Starting Virtual Console Setup... [vm-test-run-centjes-e2e-test] client # [ 8.242464] systemd-logind[651]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) [vm-test-run-centjes-e2e-test] docsserver # [ 8.625219] 8021q: adding VLAN 0 to HW filter on device eth0 [vm-test-run-centjes-e2e-test] client # [ 8.616215] [drm] Found EDID data blob. [vm-test-run-centjes-e2e-test] docsserver # [ 8.641517] AES CTR mode by8 optimization enabled [vm-test-run-centjes-e2e-test] client # [ 8.627426] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 [vm-test-run-centjes-e2e-test] docsserver # [ 8.279546] dhcpcd[750]: eth0: waiting for carrier [vm-test-run-centjes-e2e-test] docsserver # [ 8.767309] [drm] Found bochs VGA, ID 0xb0c5. [vm-test-run-centjes-e2e-test] docsserver # [ 8.768231] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. [vm-test-run-centjes-e2e-test] docsserver # [ 8.420084] systemd[1]: Starting Virtual Console Setup... [vm-test-run-centjes-e2e-test] docsserver # [ 8.425529] dhcpcd[750]: libudev: received NULL device [vm-test-run-centjes-e2e-test] docsserver # [ 8.427451] dhcpcd[750]: libudev: received NULL device [vm-test-run-centjes-e2e-test] docsserver # [ 8.429302] systemd-logind[646]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard) [vm-test-run-centjes-e2e-test] docsserver # [ 8.461520] systemd[1]: Finished Permit User Sessions. [vm-test-run-centjes-e2e-test] docsserver # [ 8.469689] systemd[1]: Started Getty on tty1. [vm-test-run-centjes-e2e-test] docsserver # [ 8.475502] systemd[1]: Reached target Login Prompts. [vm-test-run-centjes-e2e-test] docsserver # [ 8.482769] systemd-logind[646]: Watching system buttons on /dev/input/event2 (Power Button) [vm-test-run-centjes-e2e-test] docsserver # [ 8.864948] [drm] Found EDID data blob. [vm-test-run-centjes-e2e-test] docsserver # [ 8.875856] [drm] Initialized bochs-drm 1.0.0 for 0000:00:02.0 on minor 0 [vm-test-run-centjes-e2e-test] docsserver # [ 8.882039] ppdev: user-space parallel port driver [vm-test-run-centjes-e2e-test] client # [ 8.822224] dhcpcd[738]: eth0: carrier acquired [vm-test-run-centjes-e2e-test] client # [ 8.833163] dhcpcd[738]: DUID 00:01:00:01:32:52:7d:df:52:54:00:12:34:56 [vm-test-run-centjes-e2e-test] client # [ 8.835198] dhcpcd[738]: eth0: IAID 00:12:34:56 [vm-test-run-centjes-e2e-test] client # [ 8.836903] dhcpcd[738]: eth0: adding address fe80::5054:ff:fe12:3456 [vm-test-run-centjes-e2e-test] client # [ 8.857300] systemd-logind[651]: Watching system buttons on /dev/input/event2 (Power Button) [vm-test-run-centjes-e2e-test] docsserver # [ 9.071891] dhcpcd[750]: eth0: carrier acquired [vm-test-run-centjes-e2e-test] docsserver # [ 9.087694] dhcpcd[750]: DUID 00:01:00:01:32:52:7d:df:52:54:00:12:34:56 [vm-test-run-centjes-e2e-test] docsserver # [ 9.095298] dhcpcd[750]: eth0: IAID 00:12:34:56 [vm-test-run-centjes-e2e-test] docsserver # [ 9.097102] dhcpcd[750]: eth0: adding address fe80::5054:ff:fe12:3456 [vm-test-run-centjes-e2e-test] client # [ 8.652010] fbcon: bochs-drmdrmfb (fb0) is primary device [vm-test-run-centjes-e2e-test] client # [ 9.216878] Console: switching to colour frame buffer device 160x50 [vm-test-run-centjes-e2e-test] client # [ 9.352883] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device [vm-test-run-centjes-e2e-test] docsserver # [ 8.892926] fbcon: bochs-drmdrmfb (fb0) is primary device [vm-test-run-centjes-e2e-test] docsserver # [ 9.477677] Console: switching to colour frame buffer device 160x50 [vm-test-run-centjes-e2e-test] docsserver # [ 9.618982] bochs-drm 0000:00:02.0: [drm] fb0: bochs-drmdrmfb frame buffer device [vm-test-run-centjes-e2e-test] client # [ 9.542236] ppdev: user-space parallel port driver [vm-test-run-centjes-e2e-test] client # [ 9.204461] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. [vm-test-run-centjes-e2e-test] client # [ 9.622406] kvm_amd: TSC scaling supported [vm-test-run-centjes-e2e-test] client # [ 9.623338] kvm_amd: Nested Virtualization enabled [vm-test-run-centjes-e2e-test] client # [ 9.624428] kvm_amd: Nested Paging enabled [vm-test-run-centjes-e2e-test] client # [ 9.625426] kvm_amd: LBR virtualization supported [vm-test-run-centjes-e2e-test] docsserver # [ 9.768938] kvm_amd: TSC scaling supported [vm-test-run-centjes-e2e-test] docsserver # [ 9.770783] kvm_amd: Nested Virtualization enabled [vm-test-run-centjes-e2e-test] docsserver # [ 9.771921] kvm_amd: Nested Paging enabled [vm-test-run-centjes-e2e-test] docsserver # [ 9.773562] kvm_amd: LBR virtualization supported [vm-test-run-centjes-e2e-test] docsserver # [ 9.781067] kvm_amd: Virtual VMLOAD VMSAVE supported [vm-test-run-centjes-e2e-test] docsserver # [ 9.782391] kvm_amd: Virtual GIF supported [vm-test-run-centjes-e2e-test] client # [ 9.290915] systemd-logind[651]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) [vm-test-run-centjes-e2e-test] docsserver # [ 9.447711] dhcpcd[750]: eth0: soliciting a DHCP lease [vm-test-run-centjes-e2e-test] docsserver # [ 9.813340] NET: Registered PF_PACKET protocol family [vm-test-run-centjes-e2e-test] docsserver # [ 9.475868] dhcpcd[750]: eth0: offered 10.0.2.15 from 10.0.2.2 [vm-test-run-centjes-e2e-test] client # [ 9.326971] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 9.479447] dhcpcd[750]: eth0: probing address 10.0.2.15/24 [vm-test-run-centjes-e2e-test] client # [ 9.689729] kvm_amd: Virtual VMLOAD VMSAVE supported [vm-test-run-centjes-e2e-test] client # [ 9.690886] kvm_amd: Virtual GIF supported [vm-test-run-centjes-e2e-test] client # [ 9.338887] systemd[1]: Stopped Virtual Console Setup. [vm-test-run-centjes-e2e-test] client # [ 9.346124] systemd[1]: Starting Virtual Console Setup... [vm-test-run-centjes-e2e-test] docsserver # [ 9.532806] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. [vm-test-run-centjes-e2e-test] client # [ 9.389188] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 9.888292] EDAC MC: Ver: 3.0.0 [vm-test-run-centjes-e2e-test] client # [ 9.396887] systemd[1]: Stopped Virtual Console Setup. [vm-test-run-centjes-e2e-test] client # [ 9.403482] systemd[1]: Starting Virtual Console Setup... [vm-test-run-centjes-e2e-test] client # [ 9.787867] EDAC MC: Ver: 3.0.0 [vm-test-run-centjes-e2e-test] docsserver # [ 9.628852] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 9.640294] systemd[1]: Stopped Virtual Console Setup. [vm-test-run-centjes-e2e-test] docsserver # [ 9.643963] systemd-logind[646]: Watching system buttons on /dev/input/event3 (QEMU Virtio Keyboard) [vm-test-run-centjes-e2e-test] docsserver # [ 9.650637] systemd[1]: Starting Virtual Console Setup... [vm-test-run-centjes-e2e-test] client # [ 9.548148] dhcpcd[738]: eth0: soliciting a DHCP lease [vm-test-run-centjes-e2e-test] docsserver # [ 9.700241] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully. [vm-test-run-centjes-e2e-test] docsserver # [ 9.706086] systemd[1]: Stopped Virtual Console Setup. [vm-test-run-centjes-e2e-test] docsserver # [ 9.710667] systemd[1]: Starting Virtual Console Setup... [vm-test-run-centjes-e2e-test] client # [ 9.923806] NET: Registered PF_PACKET protocol family [vm-test-run-centjes-e2e-test] client # [ 9.575870] dhcpcd[738]: eth0: offered 10.0.2.15 from 10.0.2.2 [vm-test-run-centjes-e2e-test] client # [ 9.580323] dhcpcd[738]: eth0: probing address 10.0.2.15/24 [vm-test-run-centjes-e2e-test] client # [ 9.785179] systemd[1]: Finished Virtual Console Setup. [vm-test-run-centjes-e2e-test] docsserver # [ 10.052254] systemd[1]: Finished Virtual Console Setup. [vm-test-run-centjes-e2e-test] client # [ 10.239911] dhcpcd[738]: eth0: soliciting an IPv6 router [vm-test-run-centjes-e2e-test] client # [ 10.241569] dhcpcd[738]: eth0: Router Advertisement from fe80::2 [vm-test-run-centjes-e2e-test] client # [ 10.243478] dhcpcd[738]: eth0: adding address fec0::5054:ff:fe12:3456/64 [vm-test-run-centjes-e2e-test] client # [ 10.245492] dhcpcd[738]: eth0: adding route to fec0::/64 [vm-test-run-centjes-e2e-test] client # [ 10.247245] dhcpcd[738]: eth0: adding default route via fe80::2 [vm-test-run-centjes-e2e-test] docsserver # [ 11.113146] dhcpcd[750]: eth0: soliciting an IPv6 router [vm-test-run-centjes-e2e-test] docsserver # [ 11.115160] dhcpcd[750]: eth0: Router Advertisement from fe80::2 [vm-test-run-centjes-e2e-test] docsserver # [ 11.117533] dhcpcd[750]: eth0: adding address fec0::5054:ff:fe12:3456/64 [vm-test-run-centjes-e2e-test] docsserver # [ 11.119814] dhcpcd[750]: eth0: adding route to fec0::/64 [vm-test-run-centjes-e2e-test] docsserver # [ 11.121796] dhcpcd[750]: eth0: adding default route via fe80::2 [vm-test-run-centjes-e2e-test] docsserver # [ 14.495876] dhcpcd[750]: eth0: leased 10.0.2.15 for 86400 seconds [vm-test-run-centjes-e2e-test] docsserver # [ 14.498154] dhcpcd[750]: eth0: adding route to 10.0.2.0/24 [vm-test-run-centjes-e2e-test] docsserver # [ 14.500230] dhcpcd[750]: eth0: adding default route via 10.0.2.2 [vm-test-run-centjes-e2e-test] docsserver # [ 14.611915] systemd[1]: Started DHCP Client. [vm-test-run-centjes-e2e-test] docsserver # [ 14.617810] systemd[1]: Reached target Multi-User System. [vm-test-run-centjes-e2e-test] docsserver # [ 14.621684] systemd[1]: Startup finished in 3.559s (kernel) + 11.055s (userspace) = 14.614s. [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for unit default.target, in 15.87 seconds) [vm-test-run-centjes-e2e-test] client: waiting for unit default.target [vm-test-run-centjes-e2e-test] client: waiting for the VM to finish booting [vm-test-run-centjes-e2e-test] client: Guest shell says: b'Spawning backdoor root shell...\n' [vm-test-run-centjes-e2e-test] client: connected to guest root shell [vm-test-run-centjes-e2e-test] client: (connecting took 0.00 seconds) [vm-test-run-centjes-e2e-test] client: (finished: waiting for the VM to finish booting, in 0.00 seconds) [vm-test-run-centjes-e2e-test] client # [ 14.850138] dhcpcd[738]: eth0: leased 10.0.2.15 for 86400 seconds [vm-test-run-centjes-e2e-test] client # [ 14.853608] dhcpcd[738]: eth0: adding route to 10.0.2.0/24 [vm-test-run-centjes-e2e-test] client # [ 14.855558] dhcpcd[738]: eth0: adding default route via 10.0.2.2 [vm-test-run-centjes-e2e-test] client # [ 14.976293] systemd[1]: Started DHCP Client. [vm-test-run-centjes-e2e-test] client # [ 14.979626] systemd[1]: Reached target Multi-User System. [vm-test-run-centjes-e2e-test] client # [ 14.982476] systemd[1]: Startup finished in 3.432s (kernel) + 11.548s (userspace) = 14.980s. [vm-test-run-centjes-e2e-test] client: (finished: waiting for unit default.target, in 1.21 seconds) [vm-test-run-centjes-e2e-test] docsserver: waiting for unit centjes-docs-site-production.service [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for unit centjes-docs-site-production.service, in 0.05 seconds) [vm-test-run-centjes-e2e-test] docsserver: waiting for unit default.target [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for unit default.target, in 0.04 seconds) [vm-test-run-centjes-e2e-test] docsserver: waiting for TCP port 8001 on localhost [vm-test-run-centjes-e2e-test] docsserver # Connection to localhost (127.0.0.1) 8001 port [tcp/vcom-tunnel] succeeded! [vm-test-run-centjes-e2e-test] docsserver: (finished: waiting for TCP port 8001 on localhost, in 0.08 seconds) [vm-test-run-centjes-e2e-test] client: must succeed: curl docsserver:8001 [vm-test-run-centjes-e2e-test] client # % Total % Received % Xferd Average Speed Time Time Time Current [vm-test-run-centjes-e2e-test] client # Dload Upload Total Spent Left Speed [vm-test-run-centjes-e2e-test] docsserver # [ 16.485434] centjes-docs-site-production-start[629]: 192.168.1.1 - - [02/Oct/2026:14:36:23 +0000] "GET / HTTP/1.1" 200 3866 "" "curl/8.17.0" [vm-test-run-centjes-e2e-test] client # 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0100 3866 100 3866 0 0 68307 0 --:--:-- --:--:-- --:--:-- 69035 [vm-test-run-centjes-e2e-test] client: (finished: must succeed: curl docsserver:8001, in 0.13 seconds) [vm-test-run-centjes-e2e-test] (finished: run the VM test script, in 17.82 seconds) [vm-test-run-centjes-e2e-test] test script finished in 17.94s [vm-test-run-centjes-e2e-test] cleanup [vm-test-run-centjes-e2e-test] kill machine (pid 31) [vm-test-run-centjes-e2e-test] qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/jj6jldlw37r8yy9kc1smrax9dhnjm2x4-python3-3.13.9/bin/python3.13) [vm-test-run-centjes-e2e-test] kill machine (pid 9) [vm-test-run-centjes-e2e-test] qemu-system-x86_64: terminating on signal 15 from pid 6 (/nix/store/jj6jldlw37r8yy9kc1smrax9dhnjm2x4-python3-3.13.9/bin/python3.13) [vm-test-run-centjes-e2e-test] kill vlan (pid 7) [vm-test-run-centjes-e2e-test] (finished: cleanup, in 0.02 seconds) [vm-test-run-centjes-e2e-test:post-build] Uploading to cachix cache "centjes": /nix/store/sx9l6vv37jk29lpdmkrx35cnnxa158dz-vm-test-run-centjes-e2e-test [vm-test-run-centjes-e2e-test:post-build] Pushing 1 paths (0 are already present) using zstd to cache centjes ⏳ [vm-test-run-centjes-e2e-test:post-build]  [vm-test-run-centjes-e2e-test:post-build] Pushing /nix/store/sx9l6vv37jk29lpdmkrx35cnnxa158dz-vm-test-run-centjes-e2e-test (96.00 B) [vm-test-run-centjes-e2e-test:post-build]  [vm-test-run-centjes-e2e-test:post-build] All done. [vm-test-run-centjes-e2e-test:post-build] Uploading to the NixCI staging cache: /nix/store/sx9l6vv37jk29lpdmkrx35cnnxa158dz-vm-test-run-centjes-e2e-test [vm-test-run-centjes-e2e-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [vm-test-run-centjes-e2e-test:post-build] copying 1 paths... [vm-test-run-centjes-e2e-test:post-build] copying path '/nix/store/sx9l6vv37jk29lpdmkrx35cnnxa158dz-vm-test-run-centjes-e2e-test' to 'https://cache.staging.nix-ci.com'... [vm-test-run-centjes-e2e-test:post-build] warning: 'warn-short-path-literals' is deprecated, use 'lint-short-path-literals = ignore' instead [vm-test-run-centjes-e2e-test:post-build] copying 1 paths... [vm-test-run-centjes-e2e-test:post-build] copying path '/nix/store/1l2n1nwfzll9v7nzhc8d25h85v1980vx-vm-test-run-centjes-e2e-test.drv' to 'https://cache.staging.nix-ci.com'... Uploaded vm-test-run-centjes-e2e-test in 5.3s Progress: 12 of 13 built Built vm-test-run-centjes-e2e-test in 23.6s Progress: 13 of 13 built /nix/store/sx9l6vv37jk29lpdmkrx35cnnxa158dz-vm-test-run-centjes-e2e-test Build succeeded.