1these 16 derivations will be built:2 /nix/store/fihzb29hirh81mfg68khrd30b82v5whi-system-path.drv3 /nix/store/9m1nv2zfg9p7apjixs50f94x5xdvy03p-dbus-1.drv4 /nix/store/azfl4w3wyrgs4ydij3093yvq7q2jggjn-X-Restart-Triggers-dbus-broker.drv5 /nix/store/q4dcwx83i2qrdachivsprb967ac54gya-unit-dbus-broker.service.drv6 /nix/store/6nldh7hkf009m3vrx2cb5dq2p9b30arf-system-units.drv7 /nix/store/q7cyyl0baii4hr9dawqgqcvrglhmzwky-unit-dbus-broker.service.drv8 /nix/store/dyfih5hnk853ppqnkc69rxlwhlys37jy-user-units.drv9 /nix/store/y8s1krap9ibbpz8y1bgzy7kpqss9qfg9-etc.drv10 /nix/store/795fqf79jl81ph3i2lq7h0mkws1klq4z-activate.drv11 /nix/store/i5fc859p0qp4qkr26z3x2l2mla098dzl-nixos-system-server-test.drv12 /nix/store/yh80qz46s5q0qr7bbfd1jvasn4xl0zkc-closure-info.drv13 /nix/store/1540xabkwjkrabh5i0c5r23amrmxj2mh-run-nixos-vm.drv14 /nix/store/47mrjn6f54mll6y7j4kpc3vx0q7rhkg5-nixos-vm.drv15 /nix/store/p0jhr7lxjsy8bclf69cgpy9qxvxq2f2x-driverConfiguration.json.drv16 /nix/store/cxj79fbkqmgvwwy4khg48vwxx87dmqif-nixos-test-driver-apparmor.drv17 /nix/store/lsc1vr5z4lznivfk5dhsv5rnygs59awp-vm-test-run-apparmor.drv18building '/nix/store/fihzb29hirh81mfg68khrd30b82v5whi-system-path.drv' on 'ssh-ng://nix@eliza'19building '/nix/store/fihzb29hirh81mfg68khrd30b82v5whi-system-path.drv'20system-path> structuredAttrs is enabled21system-path> created 6861 symlinks in user environment22system-path> install-info: warning: no info dir entry in `/nix/store/4i0pmvr9zgccs4viicm46b83qybfcvln-system-path/share/info/notes.info'23building '/nix/store/9m1nv2zfg9p7apjixs50f94x5xdvy03p-dbus-1.drv' on 'ssh-ng://nix@eliza'24building '/nix/store/9m1nv2zfg9p7apjixs50f94x5xdvy03p-dbus-1.drv'25building '/nix/store/azfl4w3wyrgs4ydij3093yvq7q2jggjn-X-Restart-Triggers-dbus-broker.drv' on 'ssh-ng://nix@eliza'26building '/nix/store/azfl4w3wyrgs4ydij3093yvq7q2jggjn-X-Restart-Triggers-dbus-broker.drv'27building '/nix/store/q4dcwx83i2qrdachivsprb967ac54gya-unit-dbus-broker.service.drv' on 'ssh-ng://nix@eliza'28building '/nix/store/q7cyyl0baii4hr9dawqgqcvrglhmzwky-unit-dbus-broker.service.drv' on 'ssh-ng://nix@eliza'29building '/nix/store/q4dcwx83i2qrdachivsprb967ac54gya-unit-dbus-broker.service.drv'30building '/nix/store/6nldh7hkf009m3vrx2cb5dq2p9b30arf-system-units.drv' on 'ssh-ng://nix@eliza'31building '/nix/store/q7cyyl0baii4hr9dawqgqcvrglhmzwky-unit-dbus-broker.service.drv'32building '/nix/store/dyfih5hnk853ppqnkc69rxlwhlys37jy-user-units.drv' on 'ssh-ng://nix@eliza'33building '/nix/store/6nldh7hkf009m3vrx2cb5dq2p9b30arf-system-units.drv'34building '/nix/store/dyfih5hnk853ppqnkc69rxlwhlys37jy-user-units.drv'35building '/nix/store/y8s1krap9ibbpz8y1bgzy7kpqss9qfg9-etc.drv' on 'ssh-ng://nix@eliza'36building '/nix/store/y8s1krap9ibbpz8y1bgzy7kpqss9qfg9-etc.drv'37building '/nix/store/795fqf79jl81ph3i2lq7h0mkws1klq4z-activate.drv' on 'ssh-ng://nix@eliza'38building '/nix/store/795fqf79jl81ph3i2lq7h0mkws1klq4z-activate.drv'39building '/nix/store/i5fc859p0qp4qkr26z3x2l2mla098dzl-nixos-system-server-test.drv' on 'ssh-ng://nix@eliza'40building '/nix/store/i5fc859p0qp4qkr26z3x2l2mla098dzl-nixos-system-server-test.drv'41building '/nix/store/yh80qz46s5q0qr7bbfd1jvasn4xl0zkc-closure-info.drv' on 'ssh-ng://nix@eliza'42building '/nix/store/yh80qz46s5q0qr7bbfd1jvasn4xl0zkc-closure-info.drv'43closure-info> structuredAttrs is enabled44building '/nix/store/1540xabkwjkrabh5i0c5r23amrmxj2mh-run-nixos-vm.drv' on 'ssh-ng://nix@eliza'45building '/nix/store/1540xabkwjkrabh5i0c5r23amrmxj2mh-run-nixos-vm.drv'46building '/nix/store/47mrjn6f54mll6y7j4kpc3vx0q7rhkg5-nixos-vm.drv' on 'ssh-ng://nix@eliza'47building '/nix/store/47mrjn6f54mll6y7j4kpc3vx0q7rhkg5-nixos-vm.drv'48building '/nix/store/p0jhr7lxjsy8bclf69cgpy9qxvxq2f2x-driverConfiguration.json.drv' on 'ssh-ng://nix@eliza'49building '/nix/store/p0jhr7lxjsy8bclf69cgpy9qxvxq2f2x-driverConfiguration.json.drv'50building '/nix/store/cxj79fbkqmgvwwy4khg48vwxx87dmqif-nixos-test-driver-apparmor.drv' on 'ssh-ng://nix@eliza'51building '/nix/store/cxj79fbkqmgvwwy4khg48vwxx87dmqif-nixos-test-driver-apparmor.drv'52nixos-test-driver-apparmor> Running type check (enable/disable: config.skipTypeCheck)53nixos-test-driver-apparmor> See https://nixos.org/manual/nixos/stable/#test-opt-skipTypeCheck54nixos-test-driver-apparmor> All checks passed!------------------------------------------------- 1/1 files 55nixos-test-driver-apparmor> Linting test script (enable/disable: config.skipLint)56nixos-test-driver-apparmor> See https://nixos.org/manual/nixos/stable/#test-opt-skipLint57nixos-test-driver-apparmor> All checks passed!58building '/nix/store/lsc1vr5z4lznivfk5dhsv5rnygs59awp-vm-test-run-apparmor.drv' on 'ssh-ng://nix@eliza'59building '/nix/store/lsc1vr5z4lznivfk5dhsv5rnygs59awp-vm-test-run-apparmor.drv'60vm-test-run-apparmor> Machine state will be reset. To keep it, pass --keep-machine-state61vm-test-run-apparmor> start all VLans62vm-test-run-apparmor> (finished: start all VLans, in 0.00 seconds)63vm-test-run-apparmor> Test will time out and terminate in 3600 seconds64vm-test-run-apparmor> run the VM test script65vm-test-run-apparmor> additionally exposed symbols:66vm-test-run-apparmor> server,67vm-test-run-apparmor> vlan1,68vm-test-run-apparmor> start_all, test_script, machines, machines_qemu, machines_nspawn, vlans, driver, log, os, create_machine, subtest, run_tests, join_all, retry, serial_stdout_off, serial_stdout_on, polling_condition, BaseMachine, QemuMachine, NspawnMachine, t, debug, dump_machine_ssh69vm-test-run-apparmor> start all VMs70vm-test-run-apparmor> server: starting vm71vm-test-run-apparmor> server # Disk image does not exist, creating the virtualisation disk image...72vm-test-run-apparmor> server: QEMU running (pid 13)73vm-test-run-apparmor> server # Formatting '/build/vm-state-server/tmp.fd8unAGlIa', fmt=raw size=107374182474vm-test-run-apparmor> server # mke2fs 1.47.3 (8-Jul-2025)75vm-test-run-apparmor> server # Discarding device blocks: 0/262144 done76vm-test-run-apparmor> server # Creating filesystem with 262144 4k blocks and 65536 inodes77vm-test-run-apparmor> server # Filesystem UUID: cf6ca351-ee7e-46b5-aad1-4615aa3b68f278vm-test-run-apparmor> server # Superblock backups stored on blocks:79vm-test-run-apparmor> server # 32768, 98304, 163840, 22937680vm-test-run-apparmor> server # 81vm-test-run-apparmor> server # Allocating group tables: 0/8 done82vm-test-run-apparmor> server # Writing inode tables: 0/8 done83vm-test-run-apparmor> server # Creating journal (8192 blocks): done84vm-test-run-apparmor> server # Writing superblocks and filesystem accounting information: 0/8 done85vm-test-run-apparmor> server # 86vm-test-run-apparmor> server # Virtualisation disk image created.87vm-test-run-apparmor> (finished: start all VMs, in 0.45 seconds)88vm-test-run-apparmor> subtest: AppArmor is enabled and profile is loaded89vm-test-run-apparmor> server: waiting for unit apparmor.service90vm-test-run-apparmor> server: waiting for the VM to finish booting91vm-test-run-apparmor> server # [ 0.000000] Booting Linux on physical CPU 0x0000000000 [0xc00fac40]92vm-test-run-apparmor> server # [ 0.000000] Linux version 6.18.31 (nixbld@localhost) (gcc (GCC) 15.2.0, GNU ld (GNU Binutils) 2.46) #1-NixOS SMP PREEMPT Fri May 15 12:52:18 UTC 202693vm-test-run-apparmor> server # [ 0.000000] KASLR enabled94vm-test-run-apparmor> server # [ 0.000000] random: crng init done95vm-test-run-apparmor> server # [ 0.000000] Machine model: linux,dummy-virt96vm-test-run-apparmor> server # [ 0.000000] efi: UEFI not found.97vm-test-run-apparmor> server # [ 0.000000] OF: reserved mem: Reserved memory: No reserved-memory node in the DT98vm-test-run-apparmor> server # [ 0.000000] NUMA: Faking a node at [mem 0x0000000040000000-0x000000007fffffff]99vm-test-run-apparmor> server # [ 0.000000] NODE_DATA(0) allocated [mem 0x7fded740-0x7fdf0ebf]100vm-test-run-apparmor> server # [ 0.000000] Zone ranges:101vm-test-run-apparmor> server # [ 0.000000] DMA [mem 0x0000000040000000-0x000000007fffffff]102vm-test-run-apparmor> server # [ 0.000000] DMA32 empty103vm-test-run-apparmor> server # [ 0.000000] Normal empty104vm-test-run-apparmor> server # [ 0.000000] Device empty105vm-test-run-apparmor> server # [ 0.000000] Movable zone start for each node106vm-test-run-apparmor> server # [ 0.000000] Early memory node ranges107vm-test-run-apparmor> server # [ 0.000000] node 0: [mem 0x0000000040000000-0x000000007fffffff]108vm-test-run-apparmor> server # [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x000000007fffffff]109vm-test-run-apparmor> server # [ 0.000000] cma: Reserved 32 MiB at 0x000000007cc00000110vm-test-run-apparmor> server # [ 0.000000] psci: probing for conduit method from DT.111vm-test-run-apparmor> server # [ 0.000000] psci: PSCIv1.3 detected in firmware.112vm-test-run-apparmor> server # [ 0.000000] psci: Using standard PSCI v0.2 function IDs113vm-test-run-apparmor> server # [ 0.000000] psci: Trusted OS migration not required114vm-test-run-apparmor> server # [ 0.000000] psci: SMC Calling Convention v1.1115vm-test-run-apparmor> server # [ 0.000000] smccc: KVM: hypervisor services detected (0x00000000 0x00000000 0x00000000 0x00000003)116vm-test-run-apparmor> server # [ 0.000000] percpu: Embedded 76 pages/cpu s185880 r8192 d117224 u311296117vm-test-run-apparmor> server # [ 0.000000] Detected PIPT I-cache on CPU0118vm-test-run-apparmor> server # [ 0.000000] CPU features: detected: Address authentication (architected QARMA5 algorithm)119vm-test-run-apparmor> server # [ 0.000000] CPU features: detected: GICv3 CPU interface120vm-test-run-apparmor> server # [ 0.000000] CPU features: detected: Spectre-v4121vm-test-run-apparmor> server # [ 0.000000] CPU features: detected: Spectre-BHB122vm-test-run-apparmor> server # [ 0.000000] CPU features: detected: AmpereOne erratum AC03_CPU_38123vm-test-run-apparmor> server # [ 0.000000] CPU features: detected: AmpereOne erratum AC04_CPU_23124vm-test-run-apparmor> server # [ 0.000000] alternatives: applying boot alternatives125vm-test-run-apparmor> server # [ 0.000000] Kernel command line: console=ttyAMA0 console=tty0 panic=1 boot.panic_on_fail clocksource=acpi_pm root=fstab loglevel=7 net.ifnames=0 lsm=landlock,yama,bpf,apparmor apparmor=1 init=/nix/store/wqxdwygl5xyhdl4x28pmkfb5lfzip20w-nixos-system-server-test/init regInfo=/nix/store/7rdnyblasafgfk23ziqcffigyzv5cq1j-closure-info/registration console=ttyAMA0,115200n8 console=tty0126vm-test-run-apparmor> server # [ 0.000000] Unknown kernel command line parameters "regInfo=/nix/store/7rdnyblasafgfk23ziqcffigyzv5cq1j-closure-info/registration", will be passed to user space.127vm-test-run-apparmor> server # [ 0.000000] printk: log buffer data + meta data: 131072 + 458752 = 589824 bytes128vm-test-run-apparmor> server # [ 0.000000] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes, linear)129vm-test-run-apparmor> server # [ 0.000000] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes, linear)130vm-test-run-apparmor> server # [ 0.000000] software IO TLB: SWIOTLB bounce buffer size adjusted to 1MB131vm-test-run-apparmor> server # [ 0.000000] software IO TLB: area num 1.132vm-test-run-apparmor> server # [ 0.000000] software IO TLB: mapped [mem 0x000000007ca80000-0x000000007cb80000] (1MB)133vm-test-run-apparmor> server # [ 0.000000] Fallback order for Node 0: 0134vm-test-run-apparmor> server # [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 262144135vm-test-run-apparmor> server # [ 0.000000] Policy zone: DMA136vm-test-run-apparmor> server # [ 0.000000] mem auto-init: stack:all(zero), heap alloc:on, heap free:off137vm-test-run-apparmor> server # [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1138vm-test-run-apparmor> server # [ 0.000000] allocated 2097152 bytes of page_ext139vm-test-run-apparmor> server # [ 0.000000] ftrace: allocating 74663 entries in 292 pages140vm-test-run-apparmor> server # [ 0.000000] ftrace: allocated 292 pages with 3 groups141vm-test-run-apparmor> server # [ 0.000000] rcu: Hierarchical RCU implementation.142vm-test-run-apparmor> server # [ 0.000000] rcu: RCU event tracing is enabled.143vm-test-run-apparmor> server # [ 0.000000] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.144vm-test-run-apparmor> server # [ 0.000000] Trampoline variant of Tasks RCU enabled.145vm-test-run-apparmor> server # [ 0.000000] Rude variant of Tasks RCU enabled.146vm-test-run-apparmor> server # [ 0.000000] Tracing variant of Tasks RCU enabled.147vm-test-run-apparmor> server # [ 0.000000] rcu: RCU calculated value of scheduler-enlistment delay is 25 jiffies.148vm-test-run-apparmor> server # [ 0.000000] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1149vm-test-run-apparmor> server # [ 0.000000] RCU Tasks: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.150vm-test-run-apparmor> server # [ 0.000000] RCU Tasks Rude: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.151vm-test-run-apparmor> server # [ 0.000000] RCU Tasks Trace: Setting shift to 0 and lim to 1 rcu_task_cb_adjust=1 rcu_task_cpu_ids=1.152vm-test-run-apparmor> server # [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0153vm-test-run-apparmor> server # [ 0.000000] GICv3: 256 SPIs implemented154vm-test-run-apparmor> server # [ 0.000000] GICv3: 0 Extended SPIs implemented155vm-test-run-apparmor> server # [ 0.000000] Root IRQ handler: gic_handle_irq156vm-test-run-apparmor> server # [ 0.000000] GICv3: GICv3 features: 16 PPIs, DirectLPI157vm-test-run-apparmor> server # [ 0.000000] GICv3: GICD_CTLR.DS=1, SCR_EL3.FIQ=0158vm-test-run-apparmor> server # [ 0.000000] GICv3: CPU0: found redistributor 0 region 0:0x00000000080a0000159vm-test-run-apparmor> server # [ 0.000000] ITS [mem 0x08080000-0x0809ffff]160vm-test-run-apparmor> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Devices @44ce0000 (indirect, esz 8, psz 64K, shr 1)161vm-test-run-apparmor> server # [ 0.000000] ITS@0x0000000008080000: allocated 8192 Interrupt Collections @44cf0000 (flat, esz 8, psz 64K, shr 1)162vm-test-run-apparmor> server # [ 0.000000] GICv3: using LPI property table @0x0000000044d00000163vm-test-run-apparmor> server # [ 0.000000] GICv3: CPU0: using allocated LPI pending table @0x0000000044d10000164vm-test-run-apparmor> server # [ 0.000000] rcu: srcu_init: Setting srcu_struct sizes based on contention.165vm-test-run-apparmor> server # [ 0.000000] arch_timer: cp15 timer running at 1000.00MHz (virt).166vm-test-run-apparmor> server # [ 0.000000] clocksource: arch_sys_counter: mask: 0x1fffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns167vm-test-run-apparmor> server # [ 0.000000] sched_clock: 61 bits at 1000MHz, resolution 1ns, wraps every 4398046511103ns168vm-test-run-apparmor> server # [ 0.000025] arm-pv: using stolen time PV169vm-test-run-apparmor> server # [ 0.000375] kfence: initialized - using 2097152 bytes for 255 objects at 0x(____ptrval____)-0x(____ptrval____)170vm-test-run-apparmor> server # [ 0.000491] Console: colour dummy device 80x25171vm-test-run-apparmor> server # [ 0.000498] printk: legacy console [tty0] enabled172vm-test-run-apparmor> server # [ 0.000665] Calibrating delay loop (skipped), value calculated using timer frequency.. 2000.00 BogoMIPS (lpj=4000000)173vm-test-run-apparmor> server # [ 0.000671] pid_max: default: 32768 minimum: 301174vm-test-run-apparmor> server # [ 0.000753] LSM: initializing lsm=capability,landlock,yama,bpf,apparmor,ima175vm-test-run-apparmor> server # [ 0.000854] landlock: Up and running.176vm-test-run-apparmor> server # [ 0.000857] Yama: becoming mindful.177vm-test-run-apparmor> server # [ 0.001248] LSM support for eBPF active178vm-test-run-apparmor> server # [ 0.001843] AppArmor: AppArmor initialized179vm-test-run-apparmor> server # [ 0.001937] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)180vm-test-run-apparmor> server # [ 0.001955] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes, linear)181vm-test-run-apparmor> server # [ 0.002890] cacheinfo: Unable to detect cache hierarchy for CPU 0182vm-test-run-apparmor> server # [ 0.003541] rcu: Hierarchical SRCU implementation.183vm-test-run-apparmor> server # [ 0.003545] rcu: Max phase no-delay instances is 1000.184vm-test-run-apparmor> server # [ 0.004590] fsl-mc MSI: its@8080000 domain created185vm-test-run-apparmor> server # [ 0.004686] EFI services will not be available.186vm-test-run-apparmor> server # [ 0.004773] smp: Bringing up secondary CPUs ...187vm-test-run-apparmor> server # [ 0.004780] smp: Brought up 1 node, 1 CPU188vm-test-run-apparmor> server # [ 0.004783] SMP: Total of 1 processors activated.189vm-test-run-apparmor> server # [ 0.004786] CPU: All CPU(s) started at EL1190vm-test-run-apparmor> server # [ 0.004796] CPU features: detected: Branch Target Identification191vm-test-run-apparmor> server # [ 0.004800] CPU features: detected: ARMv8.4 Translation Table Level192vm-test-run-apparmor> server # [ 0.004803] CPU features: detected: Instruction cache invalidation not required for I/D coherence193vm-test-run-apparmor> server # [ 0.004807] CPU features: detected: Data cache clean to the PoU not required for I/D coherence194vm-test-run-apparmor> server # [ 0.004810] CPU features: detected: Common not Private translations195vm-test-run-apparmor> server # [ 0.004813] CPU features: detected: CRC32 instructions196vm-test-run-apparmor> server # [ 0.004816] CPU features: detected: Data cache clean to Point of Deep Persistence197vm-test-run-apparmor> server # [ 0.004819] CPU features: detected: Data cache clean to Point of Persistence198vm-test-run-apparmor> server # [ 0.004822] CPU features: detected: Data independent timing control (DIT)199vm-test-run-apparmor> server # [ 0.004825] CPU features: detected: E0PD200vm-test-run-apparmor> server # [ 0.004827] CPU features: detected: Enhanced Counter Virtualization201vm-test-run-apparmor> server # [ 0.004831] CPU features: detected: Enhanced Counter Virtualization (CNTPOFF)202vm-test-run-apparmor> server # [ 0.004834] CPU features: detected: Enhanced Virtualization Traps203vm-test-run-apparmor> server # [ 0.004837] CPU features: detected: Fine Grained Traps204vm-test-run-apparmor> server # [ 0.004840] CPU features: detected: Generic authentication (architected QARMA5 algorithm)205vm-test-run-apparmor> server # [ 0.004844] CPU features: detected: RCpc load-acquire (LDAPR)206vm-test-run-apparmor> server # [ 0.004847] CPU features: detected: LSE atomic instructions207vm-test-run-apparmor> server # [ 0.004850] CPU features: detected: Privileged Access Never208vm-test-run-apparmor> server # [ 0.004853] CPU features: detected: PMUv3209vm-test-run-apparmor> server # [ 0.004855] CPU features: detected: RAS Extension Support210vm-test-run-apparmor> server # [ 0.004858] CPU features: detected: RASv1p1 Extension Support211vm-test-run-apparmor> server # [ 0.004861] CPU features: detected: Random Number Generator212vm-test-run-apparmor> server # [ 0.004863] CPU features: detected: Speculation barrier (SB)213vm-test-run-apparmor> server # [ 0.004866] CPU features: detected: Stage-2 Force Write-Back214vm-test-run-apparmor> server # [ 0.004869] CPU features: detected: TLB range maintenance instructions215vm-test-run-apparmor> server # [ 0.004873] CPU features: detected: Speculative Store Bypassing Safe (SSBS)216vm-test-run-apparmor> server # [ 0.004906] alternatives: applying system-wide alternatives217vm-test-run-apparmor> server # [ 0.007590] CPU features: detected: BBM Level 2 without TLB conflict abort218vm-test-run-apparmor> server # [ 0.007756] Memory: 895344K/1048576K available (24256K kernel code, 7078K rwdata, 26296K rodata, 4736K init, 1102K bss, 112000K reserved, 32768K cma-reserved)219vm-test-run-apparmor> server # [ 0.008057] devtmpfs: initialized220vm-test-run-apparmor> server # [ 0.009581] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns221vm-test-run-apparmor> server # [ 0.009602] posixtimers hash table entries: 512 (order: 1, 8192 bytes, linear)222vm-test-run-apparmor> server # [ 0.009620] futex hash table entries: 256 (16384 bytes on 1 NUMA nodes, total 16 KiB, linear).223vm-test-run-apparmor> server # [ 0.009760] 2G module region forced by RANDOMIZE_MODULE_REGION_FULL224vm-test-run-apparmor> server # [ 0.009764] 0 pages in range for non-PLT usage225vm-test-run-apparmor> server # [ 0.009765] 508368 pages in range for PLT usage226vm-test-run-apparmor> server # [ 0.009855] pinctrl core: initialized pinctrl subsystem227vm-test-run-apparmor> server # [ 0.010592] DMI not present or invalid.228vm-test-run-apparmor> server # [ 0.013309] NET: Registered PF_NETLINK/PF_ROUTE protocol family229vm-test-run-apparmor> server # [ 0.015192] DMA: preallocated 128 KiB GFP_KERNEL pool for atomic allocations230vm-test-run-apparmor> server # [ 0.015352] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA pool for atomic allocations231vm-test-run-apparmor> server # [ 0.015529] DMA: preallocated 128 KiB GFP_KERNEL|GFP_DMA32 pool for atomic allocations232vm-test-run-apparmor> server # [ 0.015547] audit: initializing netlink subsys (disabled)233vm-test-run-apparmor> server # [ 0.016045] audit: type=2000 audit(0.012:1): state=initialized audit_enabled=0 res=1234vm-test-run-apparmor> server # [ 0.016092] thermal_sys: Registered thermal governor 'fair_share'235vm-test-run-apparmor> server # [ 0.016094] thermal_sys: Registered thermal governor 'bang_bang'236vm-test-run-apparmor> server # [ 0.016099] thermal_sys: Registered thermal governor 'step_wise'237vm-test-run-apparmor> server # [ 0.016102] thermal_sys: Registered thermal governor 'user_space'238vm-test-run-apparmor> server # [ 0.016105] thermal_sys: Registered thermal governor 'power_allocator'239vm-test-run-apparmor> server # [ 0.016125] cpuidle: using governor ladder240vm-test-run-apparmor> server # [ 0.016132] cpuidle: using governor menu241vm-test-run-apparmor> server # [ 0.016318] hw-breakpoint: found 16 breakpoint and 4 watchpoint registers.242vm-test-run-apparmor> server # [ 0.016333] ASID allocator initialised with 65536 entries243vm-test-run-apparmor> server # [ 0.017504] Serial: AMBA PL011 UART driver244vm-test-run-apparmor> server # [ 0.022471] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 13, base_baud = 0) is a PL011 rev1245vm-test-run-apparmor> server # [ 0.022609] printk: console [ttyAMA0] enabled246vm-test-run-apparmor> server # [ 0.138637] HugeTLB: registered 1.00 GiB page size, pre-allocated 0 pages247vm-test-run-apparmor> server # [ 0.138653] HugeTLB: 0 KiB vmemmap can be freed for a 1.00 GiB page248vm-test-run-apparmor> server # [ 0.138658] HugeTLB: registered 32.0 MiB page size, pre-allocated 0 pages249vm-test-run-apparmor> server # [ 0.138662] HugeTLB: 0 KiB vmemmap can be freed for a 32.0 MiB page250vm-test-run-apparmor> server # [ 0.138666] HugeTLB: registered 2.00 MiB page size, pre-allocated 0 pages251vm-test-run-apparmor> server # [ 0.138670] HugeTLB: 0 KiB vmemmap can be freed for a 2.00 MiB page252vm-test-run-apparmor> server # [ 0.138675] HugeTLB: registered 64.0 KiB page size, pre-allocated 0 pages253vm-test-run-apparmor> server # [ 0.138679] HugeTLB: 0 KiB vmemmap can be freed for a 64.0 KiB page254vm-test-run-apparmor> server # [ 0.145480] fbcon: Taking over console255vm-test-run-apparmor> server # [ 0.145494] ACPI: Interpreter disabled.256vm-test-run-apparmor> server # [ 0.147360] iommu: Default domain type: Translated257vm-test-run-apparmor> server # [ 0.147369] iommu: DMA domain TLB invalidation policy: strict mode258vm-test-run-apparmor> server # [ 0.148951] SCSI subsystem initialized259vm-test-run-apparmor> server # [ 0.149566] usbcore: registered new interface driver usbfs260vm-test-run-apparmor> server # [ 0.149593] usbcore: registered new interface driver hub261vm-test-run-apparmor> server # [ 0.149610] usbcore: registered new device driver usb262vm-test-run-apparmor> server # [ 0.149874] pps_core: LinuxPPS API ver. 1 registered263vm-test-run-apparmor> server # [ 0.149880] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>264vm-test-run-apparmor> server # [ 0.149890] PTP clock support registered265vm-test-run-apparmor> server # [ 0.149950] EDAC MC: Ver: 3.0.0266vm-test-run-apparmor> server # [ 0.154330] scmi_core: SCMI protocol bus registered267vm-test-run-apparmor> server # [ 0.161919] FPGA manager framework268vm-test-run-apparmor> server # [ 0.162736] vgaarb: loaded269vm-test-run-apparmor> server # [ 0.163355] clocksource: Switched to clocksource arch_sys_counter270vm-test-run-apparmor> server # [ 0.163744] VFS: Disk quotas dquot_6.6.0271vm-test-run-apparmor> server # [ 0.163773] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)272vm-test-run-apparmor> server # [ 0.166025] netfs: FS-Cache loaded273vm-test-run-apparmor> server # [ 0.166303] AppArmor: AppArmor Filesystem Enabled274vm-test-run-apparmor> server # [ 0.166332] pnp: PnP ACPI: disabled275vm-test-run-apparmor> server # [ 0.172480] NET: Registered PF_INET protocol family276vm-test-run-apparmor> server # [ 0.172611] IP idents hash table entries: 16384 (order: 5, 131072 bytes, linear)277vm-test-run-apparmor> server # [ 0.198997] tcp_listen_portaddr_hash hash table entries: 512 (order: 1, 8192 bytes, linear)278vm-test-run-apparmor> server # [ 0.199031] Table-perturb hash table entries: 65536 (order: 6, 262144 bytes, linear)279vm-test-run-apparmor> server # [ 0.199053] TCP established hash table entries: 8192 (order: 4, 65536 bytes, linear)280vm-test-run-apparmor> server # [ 0.199098] TCP bind hash table entries: 8192 (order: 6, 262144 bytes, linear)281vm-test-run-apparmor> server # [ 0.199172] TCP: Hash tables configured (established 8192 bind 8192)282vm-test-run-apparmor> server # [ 0.199243] MPTCP token hash table entries: 1024 (order: 3, 24576 bytes, linear)283vm-test-run-apparmor> server # [ 0.199302] UDP hash table entries: 512 (order: 3, 32768 bytes, linear)284vm-test-run-apparmor> server # [ 0.199345] UDP-Lite hash table entries: 512 (order: 3, 32768 bytes, linear)285vm-test-run-apparmor> server # [ 0.206225] NET: Registered PF_UNIX/PF_LOCAL protocol family286vm-test-run-apparmor> server # [ 0.206254] NET: Registered PF_XDP protocol family287vm-test-run-apparmor> server # [ 0.206270] PCI: CLS 0 bytes, default 64288vm-test-run-apparmor> server # [ 0.208170] Trying to unpack rootfs image as initramfs...289vm-test-run-apparmor> server # [ 0.216028] kvm [1]: HYP mode not available290vm-test-run-apparmor> server # [ 0.299209] Initialise system trusted keyrings291vm-test-run-apparmor> server # [ 0.299928] workingset: timestamp_bits=42 max_order=18 bucket_order=0292vm-test-run-apparmor> server # [ 0.301059] squashfs: version 4.0 (2009/01/31) Phillip Lougher293vm-test-run-apparmor> server # [ 0.301796] 9p: Installing v9fs 9p2000 file system support294vm-test-run-apparmor> server # [ 0.325787] Key type asymmetric registered295vm-test-run-apparmor> server # [ 0.325803] Asymmetric key parser 'x509' registered296vm-test-run-apparmor> server # [ 0.325870] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 242)297vm-test-run-apparmor> server # [ 0.331450] io scheduler mq-deadline registered298vm-test-run-apparmor> server # [ 0.331463] io scheduler kyber registered299vm-test-run-apparmor> server # [ 0.339478] pl061_gpio 9030000.pl061: PL061 GPIO chip registered300vm-test-run-apparmor> server # [ 0.340077] ledtrig-cpu: registered to indicate activity on CPUs301vm-test-run-apparmor> server # [ 0.340416] pci-host-generic 4010000000.pcie: host bridge /pcie@10000000 ranges:302vm-test-run-apparmor> server # [ 0.340432] pci-host-generic 4010000000.pcie: IO 0x003eff0000..0x003effffff -> 0x0000000000303vm-test-run-apparmor> server # [ 0.340442] pci-host-generic 4010000000.pcie: MEM 0x0010000000..0x003efeffff -> 0x0010000000304vm-test-run-apparmor> server # [ 0.340451] pci-host-generic 4010000000.pcie: MEM 0x8000000000..0xffffffffff -> 0x8000000000305vm-test-run-apparmor> server # [ 0.340470] pci-host-generic 4010000000.pcie: Memory resource size exceeds max for 32 bits306vm-test-run-apparmor> server # [ 0.340492] pci-host-generic 4010000000.pcie: ECAM at [mem 0x4010000000-0x401fffffff] for [bus 00-ff]307vm-test-run-apparmor> server # [ 0.340569] pci-host-generic 4010000000.pcie: PCI host bridge to bus 0000:00308vm-test-run-apparmor> server # [ 0.340578] pci_bus 0000:00: root bus resource [bus 00-ff]309vm-test-run-apparmor> server # [ 0.340584] pci_bus 0000:00: root bus resource [io 0x0000-0xffff]310vm-test-run-apparmor> server # [ 0.340590] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff]311vm-test-run-apparmor> server # [ 0.340595] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff]312vm-test-run-apparmor> server # [ 0.340655] pci 0000:00:00.0: [1b36:0008] type 00 class 0x060000 conventional PCI endpoint313vm-test-run-apparmor> server # [ 0.341065] pci 0000:00:01.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint314vm-test-run-apparmor> server # [ 0.341237] pci 0000:00:01.0: BAR 0 [io 0x0000-0x001f]315vm-test-run-apparmor> server # [ 0.341253] pci 0000:00:01.0: BAR 1 [mem 0x00000000-0x00000fff]316vm-test-run-apparmor> server # [ 0.341282] pci 0000:00:01.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]317vm-test-run-apparmor> server # [ 0.341297] pci 0000:00:01.0: ROM [mem 0x00000000-0x0003ffff pref]318vm-test-run-apparmor> server # [ 0.341727] pci 0000:00:02.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint319vm-test-run-apparmor> server # [ 0.341896] pci 0000:00:02.0: BAR 0 [io 0x0000-0x001f]320vm-test-run-apparmor> server # [ 0.341911] pci 0000:00:02.0: BAR 1 [mem 0x00000000-0x00000fff]321vm-test-run-apparmor> server # [ 0.341940] pci 0000:00:02.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]322vm-test-run-apparmor> server # [ 0.342373] pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint323vm-test-run-apparmor> server # [ 0.342541] pci 0000:00:03.0: BAR 0 [io 0x0000-0x003f]324vm-test-run-apparmor> server # [ 0.342557] pci 0000:00:03.0: BAR 1 [mem 0x00000000-0x00000fff]325vm-test-run-apparmor> server # [ 0.342585] pci 0000:00:03.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]326vm-test-run-apparmor> server # [ 0.343011] pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint327vm-test-run-apparmor> server # [ 0.343181] pci 0000:00:04.0: BAR 0 [io 0x0000-0x001f]328vm-test-run-apparmor> server # [ 0.343197] pci 0000:00:04.0: BAR 1 [mem 0x00000000-0x00000fff]329vm-test-run-apparmor> server # [ 0.343228] pci 0000:00:04.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]330vm-test-run-apparmor> server # [ 0.343695] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200 conventional PCI endpoint331vm-test-run-apparmor> server # [ 0.343863] pci 0000:00:05.0: BAR 0 [io 0x0000-0x001f]332vm-test-run-apparmor> server # [ 0.343879] pci 0000:00:05.0: BAR 1 [mem 0x00000000-0x00000fff]333vm-test-run-apparmor> server # [ 0.343907] pci 0000:00:05.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]334vm-test-run-apparmor> server # [ 0.344329] pci 0000:00:06.0: [1af4:1001] type 00 class 0x010000 conventional PCI endpoint335vm-test-run-apparmor> server # [ 0.344505] pci 0000:00:06.0: BAR 0 [io 0x0000-0x007f]336vm-test-run-apparmor> server # [ 0.344521] pci 0000:00:06.0: BAR 1 [mem 0x00000000-0x00000fff]337vm-test-run-apparmor> server # [ 0.344549] pci 0000:00:06.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]338vm-test-run-apparmor> server # [ 0.344976] pci 0000:00:07.0: [1af4:1000] type 00 class 0x020000 conventional PCI endpoint339vm-test-run-apparmor> server # [ 0.345144] pci 0000:00:07.0: BAR 0 [io 0x0000-0x001f]340vm-test-run-apparmor> server # [ 0.345160] pci 0000:00:07.0: BAR 1 [mem 0x00000000-0x00000fff]341vm-test-run-apparmor> server # [ 0.345188] pci 0000:00:07.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]342vm-test-run-apparmor> server # [ 0.345203] pci 0000:00:07.0: ROM [mem 0x00000000-0x0003ffff pref]343vm-test-run-apparmor> server # [ 0.345632] pci 0000:00:08.0: [1af4:1052] type 00 class 0x090000 conventional PCI endpoint344vm-test-run-apparmor> server # [ 0.345804] pci 0000:00:08.0: BAR 1 [mem 0x00000000-0x00000fff]345vm-test-run-apparmor> server # [ 0.345832] pci 0000:00:08.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]346vm-test-run-apparmor> server # [ 0.346261] pci 0000:00:09.0: [1af4:1050] type 00 class 0x038000 conventional PCI endpoint347vm-test-run-apparmor> server # [ 0.346433] pci 0000:00:09.0: BAR 1 [mem 0x00000000-0x00000fff]348vm-test-run-apparmor> server # [ 0.346461] pci 0000:00:09.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]349vm-test-run-apparmor> server # [ 0.346824] pci 0000:00:0a.0: [8086:24cd] type 00 class 0x0c0320 conventional PCI endpoint350vm-test-run-apparmor> server # [ 0.346991] pci 0000:00:0a.0: BAR 0 [mem 0x00000000-0x00000fff]351vm-test-run-apparmor> server # [ 0.347225] pci 0000:00:0b.0: [1af4:1003] type 00 class 0x078000 conventional PCI endpoint352vm-test-run-apparmor> server # [ 0.395518] pci 0000:00:0b.0: BAR 0 [io 0x0000-0x003f]353vm-test-run-apparmor> server # [ 0.395547] pci 0000:00:0b.0: BAR 1 [mem 0x00000000-0x00000fff]354vm-test-run-apparmor> server # [ 0.395575] pci 0000:00:0b.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]355vm-test-run-apparmor> server # [ 0.396035] pci 0000:00:0c.0: [1af4:1005] type 00 class 0x00ff00 conventional PCI endpoint356vm-test-run-apparmor> server # [ 0.396207] pci 0000:00:0c.0: BAR 0 [io 0x0000-0x001f]357vm-test-run-apparmor> server # [ 0.396222] pci 0000:00:0c.0: BAR 1 [mem 0x00000000-0x00000fff]358vm-test-run-apparmor> server # [ 0.396250] pci 0000:00:0c.0: BAR 4 [mem 0x00000000-0x00003fff 64bit pref]359vm-test-run-apparmor> server # [ 0.396801] pci 0000:00:01.0: ROM [mem 0x10000000-0x1003ffff pref]: assigned360vm-test-run-apparmor> server # [ 0.396812] pci 0000:00:07.0: ROM [mem 0x10040000-0x1007ffff pref]: assigned361vm-test-run-apparmor> server # [ 0.396818] pci 0000:00:01.0: BAR 4 [mem 0x8000000000-0x8000003fff 64bit pref]: assigned362vm-test-run-apparmor> server # [ 0.396861] pci 0000:00:02.0: BAR 4 [mem 0x8000004000-0x8000007fff 64bit pref]: assigned363vm-test-run-apparmor> server # [ 0.396905] pci 0000:00:03.0: BAR 4 [mem 0x8000008000-0x800000bfff 64bit pref]: assigned364vm-test-run-apparmor> server # [ 0.396949] pci 0000:00:04.0: BAR 4 [mem 0x800000c000-0x800000ffff 64bit pref]: assigned365vm-test-run-apparmor> server # [ 0.396994] pci 0000:00:05.0: BAR 4 [mem 0x8000010000-0x8000013fff 64bit pref]: assigned366vm-test-run-apparmor> server # [ 0.397038] pci 0000:00:06.0: BAR 4 [mem 0x8000014000-0x8000017fff 64bit pref]: assigned367vm-test-run-apparmor> server # [ 0.397082] pci 0000:00:07.0: BAR 4 [mem 0x8000018000-0x800001bfff 64bit pref]: assigned368vm-test-run-apparmor> server # [ 0.397128] pci 0000:00:08.0: BAR 4 [mem 0x800001c000-0x800001ffff 64bit pref]: assigned369vm-test-run-apparmor> server # [ 0.397173] pci 0000:00:09.0: BAR 4 [mem 0x8000020000-0x8000023fff 64bit pref]: assigned370vm-test-run-apparmor> server # [ 0.397218] pci 0000:00:0b.0: BAR 4 [mem 0x8000024000-0x8000027fff 64bit pref]: assigned371vm-test-run-apparmor> server # [ 0.397317] pci 0000:00:0c.0: BAR 4 [mem 0x8000028000-0x800002bfff 64bit pref]: assigned372vm-test-run-apparmor> server # [ 0.397362] pci 0000:00:01.0: BAR 1 [mem 0x10080000-0x10080fff]: assigned373vm-test-run-apparmor> server # [ 0.397383] pci 0000:00:02.0: BAR 1 [mem 0x10081000-0x10081fff]: assigned374vm-test-run-apparmor> server # [ 0.397403] pci 0000:00:03.0: BAR 1 [mem 0x10082000-0x10082fff]: assigned375vm-test-run-apparmor> server # [ 0.397427] pci 0000:00:04.0: BAR 1 [mem 0x10083000-0x10083fff]: assigned376vm-test-run-apparmor> server # [ 0.397448] pci 0000:00:05.0: BAR 1 [mem 0x10084000-0x10084fff]: assigned377vm-test-run-apparmor> server # [ 0.397470] pci 0000:00:06.0: BAR 1 [mem 0x10085000-0x10085fff]: assigned378vm-test-run-apparmor> server # [ 0.397491] pci 0000:00:07.0: BAR 1 [mem 0x10086000-0x10086fff]: assigned379vm-test-run-apparmor> server # [ 0.397513] pci 0000:00:08.0: BAR 1 [mem 0x10087000-0x10087fff]: assigned380vm-test-run-apparmor> server # [ 0.397535] pci 0000:00:09.0: BAR 1 [mem 0x10088000-0x10088fff]: assigned381vm-test-run-apparmor> server # [ 0.397557] pci 0000:00:0a.0: BAR 0 [mem 0x10089000-0x10089fff]: assigned382vm-test-run-apparmor> server # [ 0.397579] pci 0000:00:0b.0: BAR 1 [mem 0x1008a000-0x1008afff]: assigned383vm-test-run-apparmor> server # [ 0.397601] pci 0000:00:0c.0: BAR 1 [mem 0x1008b000-0x1008bfff]: assigned384vm-test-run-apparmor> server # [ 0.397622] pci 0000:00:06.0: BAR 0 [io 0x1000-0x107f]: assigned385vm-test-run-apparmor> server # [ 0.397643] pci 0000:00:03.0: BAR 0 [io 0x1080-0x10bf]: assigned386vm-test-run-apparmor> server # [ 0.397664] pci 0000:00:0b.0: BAR 0 [io 0x10c0-0x10ff]: assigned387vm-test-run-apparmor> server # [ 0.397684] pci 0000:00:01.0: BAR 0 [io 0x1100-0x111f]: assigned388vm-test-run-apparmor> server # [ 0.397705] pci 0000:00:02.0: BAR 0 [io 0x1120-0x113f]: assigned389vm-test-run-apparmor> server # [ 0.397726] pci 0000:00:04.0: BAR 0 [io 0x1140-0x115f]: assigned390vm-test-run-apparmor> server # [ 0.397747] pci 0000:00:05.0: BAR 0 [io 0x1160-0x117f]: assigned391vm-test-run-apparmor> server # [ 0.397769] pci 0000:00:07.0: BAR 0 [io 0x1180-0x119f]: assigned392vm-test-run-apparmor> server # [ 0.397790] pci 0000:00:0c.0: BAR 0 [io 0x11a0-0x11bf]: assigned393vm-test-run-apparmor> server # [ 0.397816] pci_bus 0000:00: resource 4 [io 0x0000-0xffff]394vm-test-run-apparmor> server # [ 0.397825] pci_bus 0000:00: resource 5 [mem 0x10000000-0x3efeffff]395vm-test-run-apparmor> server # [ 0.397830] pci_bus 0000:00: resource 6 [mem 0x8000000000-0xffffffffff]396vm-test-run-apparmor> server # [ 0.398910] pci 0000:00:0a.0: enabling device (0000 -> 0002)397vm-test-run-apparmor> server # [ 0.439390] pci 0000:00:0a.0: quirk_usb_early_handoff+0x0/0xa60 took 39535 usecs398vm-test-run-apparmor> server # [ 0.459270] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003)399vm-test-run-apparmor> server # [ 0.468591] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003)400vm-test-run-apparmor> server # [ 0.470732] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003)401vm-test-run-apparmor> server # [ 0.474245] virtio-pci 0000:00:04.0: enabling device (0000 -> 0003)402vm-test-run-apparmor> server # [ 0.480151] virtio-pci 0000:00:05.0: enabling device (0000 -> 0003)403vm-test-run-apparmor> server # [ 0.487833] virtio-pci 0000:00:06.0: enabling device (0000 -> 0003)404vm-test-run-apparmor> server # [ 0.489912] virtio-pci 0000:00:07.0: enabling device (0000 -> 0003)405vm-test-run-apparmor> server # [ 0.499525] virtio-pci 0000:00:08.0: enabling device (0000 -> 0002)406vm-test-run-apparmor> server # [ 0.501746] virtio-pci 0000:00:09.0: enabling device (0000 -> 0002)407vm-test-run-apparmor> server # [ 0.511510] virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003)408vm-test-run-apparmor> server # [ 0.514083] virtio-pci 0000:00:0c.0: enabling device (0000 -> 0003)409vm-test-run-apparmor> server # [ 0.524568] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled410vm-test-run-apparmor> server # [ 0.526909] msm_serial: driver initialized411vm-test-run-apparmor> server # [ 0.527042] SuperH (H)SCI(F) driver initialized412vm-test-run-apparmor> server # [ 0.527095] STM32 USART driver initialized413vm-test-run-apparmor> server # [ 0.554054] loop: module loaded414vm-test-run-apparmor> server # [ 0.554212] virtio_blk virtio5: 1/0/0 default/read/poll queues415vm-test-run-apparmor> server # [ 0.554859] virtio_blk virtio5: [vda] 2097152 512-byte logical blocks (1.07 GB/1.00 GiB)416vm-test-run-apparmor> server # [ 0.567901] megasas: 07.734.00.00-rc1417vm-test-run-apparmor> server # [ 0.568582] physmap-flash 0.flash: physmap platform flash device: [mem 0x00000000-0x03ffffff]418vm-test-run-apparmor> server # [ 0.570259] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000419vm-test-run-apparmor> server # [ 0.570283] Intel/Sharp Extended Query Table at 0x0031420vm-test-run-apparmor> server # [ 0.571787] Using buffer write method421vm-test-run-apparmor> server # [ 0.571842] physmap-flash 0.flash: physmap platform flash device: [mem 0x04000000-0x07ffffff]422vm-test-run-apparmor> server # [ 0.573516] 0.flash: Found 2 x16 devices at 0x0 in 32-bit bank. Manufacturer ID 0x000000 Chip ID 0x000000423vm-test-run-apparmor> server # [ 0.573538] Intel/Sharp Extended Query Table at 0x0031424vm-test-run-apparmor> server # [ 0.575156] Using buffer write method425vm-test-run-apparmor> server # [ 0.575180] Concatenating MTD devices:426vm-test-run-apparmor> server # [ 0.575184] (0): "0.flash"427vm-test-run-apparmor> server # [ 0.575188] (1): "0.flash"428vm-test-run-apparmor> server # [ 0.575191] into device "0.flash"429vm-test-run-apparmor> server # [ 0.778895] Freeing initrd memory: 25464K430vm-test-run-apparmor> server # [ 0.784838] tun: Universal TUN/TAP device driver, 1.6431vm-test-run-apparmor> server # [ 0.788261] thunder_xcv, ver 1.0432vm-test-run-apparmor> server # [ 0.788298] thunder_bgx, ver 1.0433vm-test-run-apparmor> server # [ 0.788322] nicpf, ver 1.0434vm-test-run-apparmor> server # [ 0.788879] e1000: Intel(R) PRO/1000 Network Driver435vm-test-run-apparmor> server # [ 0.788886] e1000: Copyright (c) 1999-2006 Intel Corporation.436vm-test-run-apparmor> server # [ 0.788914] e1000e: Intel(R) PRO/1000 Network Driver437vm-test-run-apparmor> server # [ 0.788922] e1000e: Copyright(c) 1999 - 2015 Intel Corporation.438vm-test-run-apparmor> server # [ 0.788951] igb: Intel(R) Gigabit Ethernet Network Driver439vm-test-run-apparmor> server # [ 0.788957] igb: Copyright (c) 2007-2014 Intel Corporation.440vm-test-run-apparmor> server # [ 0.788981] igbvf: Intel(R) Gigabit Virtual Function Network Driver441vm-test-run-apparmor> server # [ 0.788987] igbvf: Copyright (c) 2009 - 2012 Intel Corporation.442vm-test-run-apparmor> server # [ 0.789121] sky2: driver version 1.30443vm-test-run-apparmor> server # [ 0.790707] usbcore: registered new interface driver usb-storage444vm-test-run-apparmor> server # [ 0.790755] usbcore: registered new interface driver usbserial_generic445vm-test-run-apparmor> server # [ 0.790769] usbserial: USB Serial support registered for generic446vm-test-run-apparmor> server # [ 0.791988] ehci-pci 0000:00:0a.0: EHCI Host Controller447vm-test-run-apparmor> server # [ 0.792014] ehci-pci 0000:00:0a.0: new USB bus registered, assigned bus number 1448vm-test-run-apparmor> server # [ 0.792209] ehci-pci 0000:00:0a.0: irq 15, io mem 0x10089000449vm-test-run-apparmor> server # [ 0.803139] hv_vmbus: registering driver hyperv_keyboard450vm-test-run-apparmor> server # [ 0.803394] ehci-pci 0000:00:0a.0: USB 2.0 started, EHCI 1.00451vm-test-run-apparmor> server # [ 0.803694] hub 1-0:1.0: USB hub found452vm-test-run-apparmor> server # [ 0.803714] hub 1-0:1.0: 6 ports detected453vm-test-run-apparmor> server # [ 0.806807] rtc-pl031 9010000.pl031: registered as rtc0454vm-test-run-apparmor> server # [ 0.806839] rtc-pl031 9010000.pl031: setting system clock to 2026-06-08T06:47:09 UTC (1780901229)455vm-test-run-apparmor> server # [ 0.807136] i2c_dev: i2c /dev entries driver456vm-test-run-apparmor> server # [ 0.811948] sdhci: Secure Digital Host Controller Interface driver457vm-test-run-apparmor> server # [ 0.811958] sdhci: Copyright(c) Pierre Ossman458vm-test-run-apparmor> server # [ 0.812231] Synopsys Designware Multimedia Card Interface Driver459vm-test-run-apparmor> server # [ 0.812601] sdhci-pltfm: SDHCI platform and OF driver helper460vm-test-run-apparmor> server # [ 0.814288] hid: raw HID events driver (C) Jiri Kosina461vm-test-run-apparmor> server # [ 0.814529] usbcore: registered new interface driver usbhid462vm-test-run-apparmor> server # [ 0.814536] usbhid: USB HID core driver463vm-test-run-apparmor> server # [ 0.855722] hw perfevents: enabled with armv8_pmuv3 PMU driver, 11 (0,800003ff) counters available464vm-test-run-apparmor> server # [ 0.858116] drop_monitor: Initializing network drop monitor service465vm-test-run-apparmor> server # [ 0.858283] NET: Registered PF_INET6 protocol family466vm-test-run-apparmor> server # [ 0.861800] Segment Routing with IPv6467vm-test-run-apparmor> server # [ 0.861818] In-situ OAM (IOAM) with IPv6468vm-test-run-apparmor> server # [ 0.861845] NET: Registered PF_PACKET protocol family469vm-test-run-apparmor> server # [ 0.863383] 9pnet: Installing 9P2000 support470vm-test-run-apparmor> server # [ 0.865300] Key type dns_resolver registered471vm-test-run-apparmor> server # [ 0.871994] registered taskstats version 1472vm-test-run-apparmor> server # [ 0.872130] Loading compiled-in X.509 certificates473vm-test-run-apparmor> server # [ 0.880276] Demotion targets for Node 0: null474vm-test-run-apparmor> server # [ 0.880370] Key type .fscrypt registered475vm-test-run-apparmor> server # [ 0.880376] Key type fscrypt-provisioning registered476vm-test-run-apparmor> server # [ 0.880456] AppArmor: AppArmor sha256 policy hashing enabled477vm-test-run-apparmor> server # [ 0.880470] ima: No TPM chip found, activating TPM-bypass!478vm-test-run-apparmor> server # [ 0.880489] ima: Allocated hash algorithm: sha1479vm-test-run-apparmor> server # [ 0.880508] ima: No architecture policies found480vm-test-run-apparmor> server # [ 0.884733] input: gpio-keys as /devices/platform/gpio-keys/input/input0481vm-test-run-apparmor> server # [ 0.902102] clk: Disabling unused clocks482vm-test-run-apparmor> server # [ 0.902121] PM: genpd: Disabling unused power domains483vm-test-run-apparmor> server # [ 0.906342] Freeing unused kernel memory: 4736K484vm-test-run-apparmor> server # [ 0.906547] Run /init as init process485vm-test-run-apparmor> server # [ 0.925897] systemd[1]: Successfully made /usr/ read-only.486vm-test-run-apparmor> server # [ 1.079431] usb 1-1: new high-speed USB device number 2 using ehci-pci487vm-test-run-apparmor> server # [ 1.231501] input: QEMU QEMU USB Keyboard as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-1/1-1:1.0/0003:0627:0001.0001/input/input1488vm-test-run-apparmor> server # [ 1.260941] systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)489vm-test-run-apparmor> server # [ 1.272390] systemd[1]: Detected virtualization qemu.490vm-test-run-apparmor> server # [ 1.274265] systemd[1]: Detected architecture arm64.491vm-test-run-apparmor> server # [ 1.276188] systemd[1]: Running in initrd.492vm-test-run-apparmor> server # [ 1.278919] systemd[1]: Initializing machine ID from random generator.493vm-test-run-apparmor> server # [ 1.281773] systemd[1]: Hostname set to <server>.494vm-test-run-apparmor> server # [ 1.319814] hid-generic 0003:0627:0001.0001: input,hidraw0: USB HID v1.11 Keyboard [QEMU QEMU USB Keyboard] on usb-0000:00:0a.0-1/input0495vm-test-run-apparmor> server # [ 1.395891] systemd[1]: Queued start job for default target Initrd Default Target.496vm-test-run-apparmor> server # [ 1.443527] usb 1-2: new high-speed USB device number 3 using ehci-pci497vm-test-run-apparmor> server # [ 1.479054] systemd[1]: Created slice Slice /system/modprobe.498vm-test-run-apparmor> server # [ 1.480092] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.499vm-test-run-apparmor> server # [ 1.480129] systemd[1]: Expecting device /dev/disk/by-label/nixos...500vm-test-run-apparmor> server # [ 1.480157] systemd[1]: Reached target Path Units.501vm-test-run-apparmor> server # [ 1.480173] systemd[1]: Reached target Slice Units.502vm-test-run-apparmor> server # [ 1.480191] systemd[1]: Reached target Swaps.503vm-test-run-apparmor> server # [ 1.480207] systemd[1]: Reached target Timer Units.504vm-test-run-apparmor> server # [ 1.480351] systemd[1]: Listening on D-Bus System Message Bus Socket.505vm-test-run-apparmor> server # [ 1.480502] systemd[1]: Listening on Journal Socket (/dev/log).506vm-test-run-apparmor> server # [ 1.480624] systemd[1]: Listening on Journal Sockets.507vm-test-run-apparmor> server # [ 1.480738] systemd[1]: Listening on udev Control Socket.508vm-test-run-apparmor> server # [ 1.480807] systemd[1]: Listening on udev Kernel Socket.509vm-test-run-apparmor> server # [ 1.480824] systemd[1]: Reached target Socket Units.510vm-test-run-apparmor> server # [ 1.491307] systemd[1]: Starting Create List of Static Device Nodes...511vm-test-run-apparmor> server # [ 1.499501] systemd[1]: Starting Load Kernel Module 9pnet_virtio...512vm-test-run-apparmor> server # [ 1.500310] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs513vm-test-run-apparmor> server # [ 1.516406] systemd[1]: Mounting Kernel Configuration File System...514vm-test-run-apparmor> server # [ 1.524232] systemd[1]: Starting Journal Service...515vm-test-run-apparmor> server # [ 1.535826] systemd[1]: Starting Load Kernel Modules...516vm-test-run-apparmor> server # [ 1.536524] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki517vm-test-run-apparmor> server # [ 1.556026] systemd[1]: Starting Coldplug All udev Devices...518vm-test-run-apparmor> server # [ 1.570193] systemd-journald[131]: Collecting audit messages is disabled.519vm-test-run-apparmor> server # [ 1.579808] systemd[1]: Finished Create List of Static Device Nodes.520vm-test-run-apparmor> server # [ 1.580604] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.521vm-test-run-apparmor> server # [ 1.595618] systemd[1]: Finished Load Kernel Module 9pnet_virtio.522vm-test-run-apparmor> server # [ 1.602287] input: QEMU QEMU USB Tablet as /devices/platform/4010000000.pcie/pci0000:00/0000:00:0a.0/usb1/1-2/1-2:1.0/0003:0627:0001.0002/input/input2523vm-test-run-apparmor> server # [ 1.604095] hid-generic 0003:0627:0001.0002: input,hidraw1: USB HID v0.01 Mouse [QEMU QEMU USB Tablet] on usb-0000:00:0a.0-2/input0524vm-test-run-apparmor> server # [ 1.611188] device-mapper: core: CONFIG_IMA_DISABLE_HTABLE is disabled. Duplicate IMA measurements will not be recorded in the IMA log.525vm-test-run-apparmor> server # [ 1.617135] systemd[1]: Mounted Kernel Configuration File System.526vm-test-run-apparmor> server # [ 1.627979] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...527vm-test-run-apparmor> server # [ 1.631471] device-mapper: ioctl: 4.50.0-ioctl (2025-04-28) initialised: dm-devel@lists.linux.dev528vm-test-run-apparmor> server # [ 1.635568] [drm] pci: virtio-gpu-pci detected at 0000:00:09.0529vm-test-run-apparmor> server # [ 1.635765] [drm] features: -virgl +edid -resource_blob -host_visible530vm-test-run-apparmor> server # [ 1.635773] [drm] features: -context_init531vm-test-run-apparmor> server # [ 1.636439] [drm] number of scanouts: 1532vm-test-run-apparmor> server # [ 1.636456] [drm] number of cap sets: 0533vm-test-run-apparmor> server # [ 1.651708] virtio-pci 0000:00:09.0: [drm] Registered 1 planes with drm panic534vm-test-run-apparmor> server # [ 1.651728] [drm] Initialized virtio_gpu 0.1.0 for 0000:00:09.0 on minor 0535vm-test-run-apparmor> server # [ 1.675660] Console: switching to colour frame buffer device 160x50536vm-test-run-apparmor> server # [ 1.695945] virtio-pci 0000:00:09.0: [drm] fb0: virtio_gpudrmfb frame buffer device537vm-test-run-apparmor> server # [ 1.698651] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.538vm-test-run-apparmor> server # [ 1.702531] systemd[1]: Starting Create Static Device Nodes in /dev...539vm-test-run-apparmor> server # [ 1.723778] systemd[1]: Finished Load Kernel Modules.540vm-test-run-apparmor> server # [ 1.739496] systemd[1]: Starting Apply Kernel Variables...541vm-test-run-apparmor> server # [ 1.755663] systemd[1]: Finished Create Static Device Nodes in /dev.542vm-test-run-apparmor> server # [ 1.757935] systemd[1]: Reached target Preparation for Local File Systems.543vm-test-run-apparmor> server # [ 1.760000] systemd[1]: Reached target Local File Systems.544vm-test-run-apparmor> server # [ 1.780169] systemd[1]: Starting Rule-based Manager for Device Events and Files...545vm-test-run-apparmor> server # [ 1.793738] systemd-modules-load[133]: Inserted module 'dm_mod'546vm-test-run-apparmor> server # [ 1.806884] systemd[1]: Finished Apply Kernel Variables.547vm-test-run-apparmor> server # [ 1.807114] systemd[1]: Started Journal Service.548vm-test-run-apparmor> server # [ 1.798489] systemd-modules-load[133]: Module 'virtio_balloon' is built in549vm-test-run-apparmor> server # [ 1.808287] systemd-modules-load[133]: Module 'virtio_console' is built in550vm-test-run-apparmor> server # [ 1.812329] systemd-modules-load[133]: Inserted module 'virtio_gpu'551vm-test-run-apparmor> server # [ 1.814548] systemd-modules-load[133]: Module 'virtio_rng' is built in552vm-test-run-apparmor> server # [ 1.820536] systemd[1]: Starting Create System Files and Directories...553vm-test-run-apparmor> server # [ 1.856280] systemd-udevd[155]: Using default interface naming scheme 'v260'.554vm-test-run-apparmor> server # [ 1.874602] systemd[1]: Finished Create System Files and Directories.555vm-test-run-apparmor> server # [ 1.894687] systemd[1]: Started Rule-based Manager for Device Events and Files.556vm-test-run-apparmor> server # [ 1.972118] systemd[1]: Starting Virtual Console Setup...557vm-test-run-apparmor> server # [ 2.044508] systemd-vconsole-setup[181]: Configuration of first virtual console was skipped, ignoring remaining ones.558vm-test-run-apparmor> server # [ 2.056719] systemd[1]: Finished Virtual Console Setup.559vm-test-run-apparmor> server # [ 2.877114] systemd[1]: Finished Coldplug All udev Devices.560vm-test-run-apparmor> server # [ 2.877995] systemd[1]: Reached target System Initialization.561vm-test-run-apparmor> server # [ 2.878755] systemd[1]: Reached target Basic System.562vm-test-run-apparmor> server # [ 3.027553] (udev-worker)[176]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.563vm-test-run-apparmor> server # [ 3.060399] (udev-worker)[176]: Network interface NamePolicy= disabled on kernel command line.564vm-test-run-apparmor> server # [ 3.071864] (udev-worker)[170]: Network interface NamePolicy= disabled on kernel command line.565vm-test-run-apparmor> server # [ 3.123030] systemd[1]: Found device /dev/disk/by-label/nixos.566vm-test-run-apparmor> server # [ 3.124677] systemd[1]: Reached target Initrd Root Device.567vm-test-run-apparmor> server # [ 3.132118] systemd[1]: Starting File System Check on /dev/disk/by-label/nixos...568vm-test-run-apparmor> server # [ 3.174314] systemd-fsck[193]: nixos: clean, 12/65536 files, 13019/262144 blocks569vm-test-run-apparmor> server # [ 3.183094] systemd[1]: Finished File System Check on /dev/disk/by-label/nixos.570vm-test-run-apparmor> server # [ 3.192842] systemd[1]: Mounting /sysroot...571vm-test-run-apparmor> server # [ 3.248030] EXT4-fs (vda): mounted filesystem cf6ca351-ee7e-46b5-aad1-4615aa3b68f2 r/w with ordered data mode. Quota mode: none.572vm-test-run-apparmor> server # [ 3.242799] systemd[1]: Mounted /sysroot.573vm-test-run-apparmor> server # [ 3.245430] systemd[1]: Reached target Initrd Root File System.574vm-test-run-apparmor> server # [ 3.256194] systemd[1]: Starting Mountpoints Configured in the Real Root...575vm-test-run-apparmor> server # [ 3.276278] systemd-sysroot-fstab-check[204]: /sysroot should be mounted in the initrd, will request daemon-reload.576vm-test-run-apparmor> server # [ 3.289909] systemd[1]: Reload requested from client PID 204 ('systemd-sysroot') (unit initrd-parse-etc.service)...577vm-test-run-apparmor> server # [ 3.291378] systemd[1]: Reloading...578vm-test-run-apparmor> server # [ 3.814580] systemd[1]: Reloading finished in 526 ms.579vm-test-run-apparmor> server # [ 3.854839] systemd-sysroot-fstab-check[204]: Requesting initrd-fs.target/start/replace...580vm-test-run-apparmor> server # [ 3.994594] systemd-sysroot-fstab-check[204]: Requesting swap.target/start/replace...581vm-test-run-apparmor> server # [ 4.003384] systemd[1]: Mounting /sysroot/nix/.rw-store...582vm-test-run-apparmor> server # [ 4.021140] systemd[1]: Mounting /sysroot/run...583vm-test-run-apparmor> server # [ 4.038496] systemd[1]: Starting Load Kernel Module 9pnet_virtio...584vm-test-run-apparmor> server # [ 4.040059] systemd[1]: initrd-parse-etc.service: Deactivated successfully.585vm-test-run-apparmor> server # [ 4.060166] systemd[1]: Finished Mountpoints Configured in the Real Root.586vm-test-run-apparmor> server # [ 4.064207] systemd[1]: initrd-parse-etc.service: Triggering OnSuccess= dependencies.587vm-test-run-apparmor> server # [ 4.077530] systemd[1]: Mounted /sysroot/nix/.rw-store.588vm-test-run-apparmor> server # [ 4.080803] systemd[1]: Mounted /sysroot/run.589vm-test-run-apparmor> server # [ 4.081474] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.590vm-test-run-apparmor> server # [ 4.085244] systemd[1]: Finished Load Kernel Module 9pnet_virtio.591vm-test-run-apparmor> server # [ 4.100202] systemd[1]: Mounting /sysroot/nix/.ro-store...592vm-test-run-apparmor> server # [ 4.117764] systemd[1]: Mounting /sysroot/tmp/shared...593vm-test-run-apparmor> server # [ 4.135203] systemd[1]: Mounting /sysroot/tmp/xchg...594vm-test-run-apparmor> server # [ 4.154077] systemd[1]: Starting rw-sysroot-nix-store.service...595vm-test-run-apparmor> server # [ 4.156137] systemd[1]: Mounted /sysroot/nix/.ro-store.596vm-test-run-apparmor> server # [ 4.193257] systemd[1]: Mounted /sysroot/tmp/shared.597vm-test-run-apparmor> server # [ 4.196110] systemd[1]: Mounted /sysroot/tmp/xchg.598vm-test-run-apparmor> server # [ 4.196814] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.599vm-test-run-apparmor> server # [ 4.203457] systemd[1]: Finished rw-sysroot-nix-store.service.600vm-test-run-apparmor> server # [ 4.864766] (udev-worker)[171]: mtd0ro: Failed to find and pin callout binary "/nix/store/084z7x42nynj9znvqp3c38viqkqvkppx-systemd-260.1/lib/udev/mtd_probe": No such file or directory601vm-test-run-apparmor> server # [ 4.867257] (udev-worker)[171]: mtd0ro: /nix/store/084z7x42nynj9znvqp3c38viqkqvkppx-systemd-260.1/lib/udev/rules.d/75-probe_mtd.rules:5 IMPORT{program}="mtd_probe $devnode": Failed to execute "mtd_probe /dev/mtd0ro", ignoring: No such file or directory602vm-test-run-apparmor> server # [ 4.881338] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.603vm-test-run-apparmor> server # [ 4.885888] systemd[1]: Stopped Virtual Console Setup.604vm-test-run-apparmor> server # [ 4.890264] systemd[1]: Stopping Virtual Console Setup...605vm-test-run-apparmor> server # [ 4.893099] systemd[1]: Starting Virtual Console Setup...606vm-test-run-apparmor> server # [ 4.905290] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.607vm-test-run-apparmor> server # [ 4.908883] systemd[1]: Stopped Virtual Console Setup.608vm-test-run-apparmor> server # [ 4.924670] systemd[1]: Starting Virtual Console Setup...609vm-test-run-apparmor> server # [ 4.970987] systemd-vconsole-setup[439]: Configuration of first virtual console was skipped, ignoring remaining ones.610vm-test-run-apparmor> server # [ 4.980684] systemd[1]: Finished Virtual Console Setup.611vm-test-run-apparmor> server # [ 4.995707] systemd[1]: Mounting /sysroot/nix/store...612vm-test-run-apparmor> server # [ 5.024933] systemd[1]: Mounted /sysroot/nix/store.613vm-test-run-apparmor> server # [ 5.026453] systemd[1]: Reached target Initrd File Systems.614vm-test-run-apparmor> server # [ 5.029285] systemd[1]: Starting Find NixOS closure...615vm-test-run-apparmor> server # [ 5.036550] systemd[1]: Starting Create Volatile Files and Directories in the Real Root...616vm-test-run-apparmor> server # [ 5.063001] systemd[1]: Finished Create Volatile Files and Directories in the Real Root.617vm-test-run-apparmor> server # [ 5.067367] systemd[1]: sysroot-run-credentials-systemd\x2dtmpfiles\x2dsetup\x2dsysroot.service.mount: Deactivated successfully.618vm-test-run-apparmor> server # [ 5.082102] systemd[1]: Finished Find NixOS closure.619vm-test-run-apparmor> server # [ 5.083421] systemd[1]: Reached target Initrd Default Target.620vm-test-run-apparmor> server # [ 5.087248] systemd[1]: Starting Cleaning Up and Shutting Down Daemons...621vm-test-run-apparmor> server # [ 5.110756] systemd[1]: Stopped target Initrd Default Target.622vm-test-run-apparmor> server # [ 5.112159] systemd[1]: Stopped target Basic System.623vm-test-run-apparmor> server # [ 5.113714] systemd[1]: Stopped target Initrd Root Device.624vm-test-run-apparmor> server # [ 5.116299] systemd[1]: Stopped target Path Units.625vm-test-run-apparmor> server # [ 5.117630] systemd[1]: systemd-ask-password-console.path: Deactivated successfully.626vm-test-run-apparmor> server # [ 5.119977] systemd[1]: Stopped Dispatch Password Requests to Console Directory Watch.627vm-test-run-apparmor> server # [ 5.122893] systemd[1]: Stopped target Slice Units.628vm-test-run-apparmor> server # [ 5.124984] systemd[1]: Stopped target Socket Units.629vm-test-run-apparmor> server # [ 5.127828] systemd[1]: Stopped target System Initialization.630vm-test-run-apparmor> server # [ 5.129086] systemd[1]: Stopped target Swaps.631vm-test-run-apparmor> server # [ 5.132157] systemd[1]: Stopped target Timer Units.632vm-test-run-apparmor> server # [ 5.136174] systemd[1]: dbus.socket: Deactivated successfully.633vm-test-run-apparmor> server # [ 5.138920] systemd[1]: Closed D-Bus System Message Bus Socket.634vm-test-run-apparmor> server # [ 5.140685] systemd[1]: initrd-find-nixos-closure.service: Deactivated successfully.635vm-test-run-apparmor> server # [ 5.144136] systemd[1]: Stopped Find NixOS closure.636vm-test-run-apparmor> server # [ 5.144864] systemd[1]: Starting Load Kernel Module 9pnet_virtio...637vm-test-run-apparmor> server # [ 5.145796] systemd[1]: Starting rw-sysroot-nix-store.service...638vm-test-run-apparmor> server # [ 5.152299] systemd[1]: systemd-sysctl.service: Deactivated successfully.639vm-test-run-apparmor> server # [ 5.155198] systemd[1]: Stopped Apply Kernel Variables.640vm-test-run-apparmor> server # [ 5.163100] systemd[1]: systemd-modules-load.service: Deactivated successfully.641vm-test-run-apparmor> server # [ 5.164272] systemd[1]: Stopped Load Kernel Modules.642vm-test-run-apparmor> server # [ 5.166499] systemd[1]: systemd-tmpfiles-setup-sysroot.service: Deactivated successfully.643vm-test-run-apparmor> server # [ 5.168185] systemd[1]: Stopped Create Volatile Files and Directories in the Real Root.644vm-test-run-apparmor> server # [ 5.172217] systemd[1]: systemd-tmpfiles-setup.service: Deactivated successfully.645vm-test-run-apparmor> server # [ 5.174511] systemd[1]: Stopped Create System Files and Directories.646vm-test-run-apparmor> server # [ 5.176995] systemd[1]: Stopped target Local File Systems.647vm-test-run-apparmor> server # [ 5.179657] systemd[1]: Stopped target Preparation for Local File Systems.648vm-test-run-apparmor> server # [ 5.180740] systemd[1]: systemd-udev-trigger.service: Deactivated successfully.649vm-test-run-apparmor> server # [ 5.182986] systemd[1]: Stopped Coldplug All udev Devices.650vm-test-run-apparmor> server # [ 5.184499] systemd[1]: Stopping Rule-based Manager for Device Events and Files...651vm-test-run-apparmor> server # [ 5.188565] systemd[1]: systemd-vconsole-setup.service: Deactivated successfully.652vm-test-run-apparmor> server # [ 5.192091] systemd[1]: Stopped Virtual Console Setup.653vm-test-run-apparmor> server # [ 5.199082] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.654vm-test-run-apparmor> server # [ 5.202008] systemd[1]: Finished Load Kernel Module 9pnet_virtio.655vm-test-run-apparmor> server # [ 5.207697] systemd[1]: systemd-udevd.service: Deactivated successfully.656vm-test-run-apparmor> server # [ 5.213524] systemd[1]: Stopped Rule-based Manager for Device Events and Files.657vm-test-run-apparmor> server # [ 5.216418] systemd[1]: systemd-udevd.service: Consumed 1.700s CPU time over 3.439s wall clock time, 22M memory peak.658vm-test-run-apparmor> server # [ 5.220263] systemd[1]: rw-sysroot-nix-store.service: Deactivated successfully.659vm-test-run-apparmor> server # [ 5.221433] systemd[1]: Finished rw-sysroot-nix-store.service.660vm-test-run-apparmor> server # [ 5.226914] systemd[1]: initrd-cleanup.service: Deactivated successfully.661vm-test-run-apparmor> server # [ 5.229749] systemd[1]: Finished Cleaning Up and Shutting Down Daemons.662vm-test-run-apparmor> server # [ 5.237115] systemd[1]: systemd-udevd-control.socket: Deactivated successfully.663vm-test-run-apparmor> server # [ 5.239572] systemd[1]: Closed udev Control Socket.664vm-test-run-apparmor> server # [ 5.247707] systemd[1]: Starting Cleanup udev Database...665vm-test-run-apparmor> server # [ 5.250654] systemd[1]: systemd-tmpfiles-setup-dev.service: Deactivated successfully.666vm-test-run-apparmor> server # [ 5.251647] systemd[1]: Stopped Create Static Device Nodes in /dev.667vm-test-run-apparmor> server # [ 5.254147] systemd[1]: systemd-tmpfiles-setup-dev-early.service: Deactivated successfully.668vm-test-run-apparmor> server # [ 5.256163] systemd[1]: Stopped Create Static Device Nodes in /dev gracefully.669vm-test-run-apparmor> server # [ 5.259290] systemd[1]: kmod-static-nodes.service: Deactivated successfully.670vm-test-run-apparmor> server # [ 5.264277] systemd[1]: Stopped Create List of Static Device Nodes.671vm-test-run-apparmor> server # [ 5.302092] systemd[1]: initrd-udevadm-cleanup-db.service: Deactivated successfully.672vm-test-run-apparmor> server # [ 5.303389] systemd[1]: Finished Cleanup udev Database.673vm-test-run-apparmor> server # [ 5.307516] systemd[1]: Reached target Switch Root.674vm-test-run-apparmor> server # [ 5.311265] systemd[1]: Starting NixOS Activation...675vm-test-run-apparmor> server # [ 5.477117] initrd-nixos-activation-start[526]: booting system configuration /nix/store/wqxdwygl5xyhdl4x28pmkfb5lfzip20w-nixos-system-server-test676vm-test-run-apparmor> server # [ 5.541175] initrd-nixos-activation-start[526]: running activation script...677vm-test-run-apparmor> server # [ 5.947297] initrd-nixos-activation-start[549]: setting up /etc...678vm-test-run-apparmor> server # [ 6.202350] systemd[1]: initrd-nixos-activation.service: Deactivated successfully.679vm-test-run-apparmor> server # [ 6.205344] systemd[1]: Finished NixOS Activation.680vm-test-run-apparmor> server # [ 6.211656] systemd[1]: Starting Switch Root...681vm-test-run-apparmor> server # [ 6.234093] systemd[1]: Switching root.682vm-test-run-apparmor> server # [ 6.452441] systemd-journald[131]: Received SIGTERM from PID 1 (systemd).683vm-test-run-apparmor> server # [ 7.023915] systemd[1]: systemd 260.1 running in system mode (+PAM +AUDIT -SELINUX +APPARMOR +IMA +IPE +SMACK +SECCOMP +GCRYPT -GNUTLS +OPENSSL +ACL +BLKID +CURL +ELFUTILS +FIDO2 +IDN2 +KMOD +LIBCRYPTSETUP +LIBCRYPTSETUP_PLUGINS +LIBFDISK +PCRE2 +PWQUALITY +P11KIT +QRENCODE +TPM2 +BZIP2 +LZ4 +XZ +ZLIB +ZSTD +BPF_FRAMEWORK -BTF -XKBCOMMON +UTMP +LIBARCHIVE)684vm-test-run-apparmor> server # [ 7.036019] systemd[1]: Detected virtualization qemu.685vm-test-run-apparmor> server # [ 7.038785] systemd[1]: Detected architecture arm64.686vm-test-run-apparmor> server # [ 7.041728] systemd[1]: Detected first boot.687vm-test-run-apparmor> server # [ 7.051022] systemd[1]: Initializing machine ID from random generator.688vm-test-run-apparmor> server # [ 7.374790] systemd[1]: bpf-restrict-fs: LSM BPF program attached689vm-test-run-apparmor> server # [ 7.575350] systemd[1]: Applying preset policy.690vm-test-run-apparmor> server # [ 8.058344] systemd[1]: Populated /etc with preset unit settings.691vm-test-run-apparmor> server # [ 8.537173] systemd[1]: initrd-switch-root.service: Deactivated successfully.692vm-test-run-apparmor> server # [ 8.538407] systemd[1]: Stopped initrd-switch-root.service.693vm-test-run-apparmor> server # [ 8.541601] systemd[1]: systemd-journald.service: Scheduled restart job, restart counter is at 1.694vm-test-run-apparmor> server # [ 8.544265] systemd[1]: Created slice Slice /system/getty.695vm-test-run-apparmor> server # [ 8.546872] systemd[1]: Created slice User and Session Slice.696vm-test-run-apparmor> server # [ 8.549155] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.697vm-test-run-apparmor> server # [ 8.551357] systemd[1]: Started Forward Password Requests to Wall Directory Watch.698vm-test-run-apparmor> server # [ 8.553427] systemd[1]: Expecting device /dev/hvc0...699vm-test-run-apparmor> server # [ 8.555161] systemd[1]: Expecting device /dev/ttyAMA0...700vm-test-run-apparmor> server # [ 8.557012] systemd[1]: Reached target Local Encrypted Volumes.701vm-test-run-apparmor> server # [ 8.558883] systemd[1]: Stopped target initrd-fs.target.702vm-test-run-apparmor> server # [ 8.560793] systemd[1]: Stopped target initrd-root-fs.target.703vm-test-run-apparmor> server # [ 8.561825] systemd[1]: Stopped target initrd-switch-root.target.704vm-test-run-apparmor> server # [ 8.564208] systemd[1]: Reached target Virtual Machines and Containers.705vm-test-run-apparmor> server # [ 8.566145] systemd[1]: Reached target Path Units.706vm-test-run-apparmor> server # [ 8.567947] systemd[1]: Reached target Remote File Systems.707vm-test-run-apparmor> server # [ 8.569739] systemd[1]: Reached target Slice Units.708vm-test-run-apparmor> server # [ 8.571506] systemd[1]: Reached target Swaps.709vm-test-run-apparmor> server # [ 8.577302] systemd[1]: Listening on Process Core Dump Socket.710vm-test-run-apparmor> server # [ 8.581383] systemd[1]: Listening on Credential Encryption/Decryption.711vm-test-run-apparmor> server # [ 8.587457] systemd[1]: Starting Journal Log Access Socket...712vm-test-run-apparmor> server # [ 8.588925] systemd[1]: Listening on Journal Audit Socket.713vm-test-run-apparmor> server # [ 8.590345] systemd[1]: Listening on Userspace Out-Of-Memory (OOM) Killer Socket.714vm-test-run-apparmor> server # [ 8.591888] systemd[1]: Make TPM PCR Policy skipped, unmet condition check ConditionSecurity=measured-uki715vm-test-run-apparmor> server # [ 8.594082] systemd[1]: Listening on udev Control Socket.716vm-test-run-apparmor> server # [ 8.599926] systemd[1]: Mounting Huge Pages File System...717vm-test-run-apparmor> server # [ 8.604053] systemd[1]: Mounting POSIX Message Queue File System...718vm-test-run-apparmor> server # [ 8.612547] systemd[1]: Mounting Kernel Debug File System...719vm-test-run-apparmor> server # [ 8.626745] systemd[1]: Mounting Kernel Trace File System...720vm-test-run-apparmor> server # [ 8.633059] systemd[1]: Starting Create List of Static Device Nodes...721vm-test-run-apparmor> server # [ 8.640938] systemd[1]: Starting Load Kernel Module 9pnet_virtio...722vm-test-run-apparmor> server # [ 8.642343] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs723vm-test-run-apparmor> server # [ 8.657334] systemd[1]: Mounting Kernel Configuration File System...724vm-test-run-apparmor> server # [ 8.658657] systemd[1]: Load Kernel Module drm skipped, unmet condition check ConditionKernelModuleLoaded=!drm725vm-test-run-apparmor> server # [ 8.663155] systemd[1]: Load Kernel Module efi_pstore skipped, unmet condition check ConditionKernelModuleLoaded=!efi_pstore726vm-test-run-apparmor> server # [ 8.681068] systemd[1]: Starting Load Kernel Module fuse...727vm-test-run-apparmor> server # [ 8.682281] systemd[1]: Clear Stale Hibernate Storage Info skipped, unmet condition check ConditionPathExists=/sys/firmware/efi/efivars/HibernateLocation-8cf2644b-4b0b-428f-9387-6d876050dc67728vm-test-run-apparmor> server # [ 8.727159] systemd[1]: Starting Journal Service...729vm-test-run-apparmor> server # [ 8.764612] systemd[1]: Starting Load Kernel Modules...730vm-test-run-apparmor> server # [ 8.786142] systemd[1]: Starting Userspace Out-Of-Memory (OOM) Killer...731vm-test-run-apparmor> server # [ 8.816224] systemd[1]: Starting Remount Root and Kernel File Systems...732vm-test-run-apparmor> server # [ 8.818839] systemd[1]: Early TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki733vm-test-run-apparmor> server # [ 8.834392] systemd[1]: Starting Coldplug All udev Devices...734vm-test-run-apparmor> server # [ 8.865410] systemd[1]: Listening on Journal Log Access Socket.735vm-test-run-apparmor> server # [ 8.880057] systemd-journald[758]: Collecting audit messages is enabled.736vm-test-run-apparmor> server # [ 8.887634] fuse: init (API version 7.45)737vm-test-run-apparmor> server # [ 8.895719] systemd[1]: Mounted Huge Pages File System.738vm-test-run-apparmor> server # [ 8.896242] systemd[1]: Mounted POSIX Message Queue File System.739vm-test-run-apparmor> server # [ 8.896647] systemd[1]: Mounted Kernel Debug File System.740vm-test-run-apparmor> server # [ 8.897047] systemd[1]: Mounted Kernel Trace File System.741vm-test-run-apparmor> server # [ 8.904990] systemd[1]: Finished Create List of Static Device Nodes.742vm-test-run-apparmor> server # [ 8.900599] systemd[1]: Queued start job for default target Multi-User System.743vm-test-run-apparmor> server # [ 8.902283] systemd[1]: systemd-journald.service: Deactivated successfully.744vm-test-run-apparmor> server # [ 8.916666] systemd[1]: modprobe@9pnet_virtio.service: Deactivated successfully.745vm-test-run-apparmor> server # [ 8.909203] systemd-modules-load[759]: Module 'atkbd' is built in746vm-test-run-apparmor> server # [ 8.922093] systemd[1]: Finished Load Kernel Module 9pnet_virtio.747vm-test-run-apparmor> server # [ 8.926847] systemd[1]: Started Journal Service.748vm-test-run-apparmor> server # [ 8.921501] systemd-modules-load[759]: Module 'loop' is built in749vm-test-run-apparmor> server # [ 8.922645] systemd[1]: Mounted Kernel Configuration File System.750vm-test-run-apparmor> server # [ 8.930170] systemd[1]: modprobe@fuse.service: Deactivated successfully.751vm-test-run-apparmor> server # [ 8.931212] systemd[1]: Finished Load Kernel Module fuse.752vm-test-run-apparmor> server # [ 8.937771] systemd[1]: Finished Load Kernel Modules.753vm-test-run-apparmor> server # [ 8.969973] systemd[1]: Mounting FUSE Control File System...754vm-test-run-apparmor> server # [ 8.977002] systemd[1]: Starting Firewall...755vm-test-run-apparmor> server # [ 8.981980] systemd[1]: Starting Apply Kernel Variables...756vm-test-run-apparmor> server # [ 8.999548] EXT4-fs (vda): re-mounted cf6ca351-ee7e-46b5-aad1-4615aa3b68f2.757vm-test-run-apparmor> server # [ 9.003542] systemd[1]: Starting Create Static Device Nodes in /dev gracefully...758vm-test-run-apparmor> server # [ 9.012986] systemd-oomd[760]: No swap; memory pressure usage will be degraded759vm-test-run-apparmor> server # [ 9.016800] systemd[1]: Finished Remount Root and Kernel File Systems.760vm-test-run-apparmor> server # [ 9.032070] systemd[1]: Started Userspace Out-Of-Memory (OOM) Killer.761vm-test-run-apparmor> server # [ 9.061489] systemd[1]: Starting Flush Journal to Persistent Storage...762vm-test-run-apparmor> server # [ 9.062491] systemd[1]: Platform Persistent Storage Archival skipped, unmet condition check ConditionDirectoryNotEmpty=/sys/fs/pstore763vm-test-run-apparmor> server # [ 9.099126] systemd[1]: Starting Load/Save OS Random Seed...764vm-test-run-apparmor> server # [ 9.104266] systemd[1]: TPM SRK Setup skipped, unmet condition check ConditionSecurity=measured-uki765vm-test-run-apparmor> server # [ 9.161031] systemd[1]: Mounted FUSE Control File System.766vm-test-run-apparmor> server # [ 9.197604] systemd[1]: Finished Apply Kernel Variables.767vm-test-run-apparmor> server # [ 9.215227] systemd-journald[758]: Received client request to flush runtime journal.768vm-test-run-apparmor> server # [ 9.283617] systemd[1]: Finished Load/Save OS Random Seed.769vm-test-run-apparmor> server # [ 9.292550] systemd[1]: Reached target First Boot Complete.770vm-test-run-apparmor> server # [ 9.293438] systemd[1]: Finished Create Static Device Nodes in /dev gracefully.771vm-test-run-apparmor> server # [ 9.294418] systemd[1]: Starting Create Static Device Nodes in /dev...772vm-test-run-apparmor> server # [ 9.302261] systemd[1]: Finished Flush Journal to Persistent Storage.773vm-test-run-apparmor> server # [ 9.397610] systemd[1]: Finished Create Static Device Nodes in /dev.774vm-test-run-apparmor> server # [ 9.400172] systemd[1]: Reached target Preparation for Local File Systems.775vm-test-run-apparmor> server # [ 9.407828] systemd[1]: Starting Rule-based Manager for Device Events and Files...776vm-test-run-apparmor> server # [ 9.533331] systemd-udevd[802]: Using default interface naming scheme 'v260'.777vm-test-run-apparmor> server # [ 9.538504] systemd[1]: Mounting /run/wrappers...778vm-test-run-apparmor> server # [ 9.605160] systemd[1]: Mounted /run/wrappers.779vm-test-run-apparmor> server # [ 9.607455] systemd[1]: Reached target Local File Systems.780vm-test-run-apparmor> server # [ 9.616334] systemd[1]: Listening on Boot Loader Control Service Socket.781vm-test-run-apparmor> server # [ 9.619951] systemd[1]: Starting Load AppArmor policies...782vm-test-run-apparmor> server # [ 9.628645] systemd[1]: Starting register-nix-paths.service...783vm-test-run-apparmor> server # [ 9.639571] systemd[1]: Starting Create SUID/SGID Wrappers...784vm-test-run-apparmor> server # [ 9.646518] systemd[1]: Update Boot Loader Random Seed skipped, no trigger condition checks were met.785vm-test-run-apparmor> server # [ 9.671350] systemd[1]: Starting Save Transient machine-id to Disk...786vm-test-run-apparmor> server # [ 9.684233] systemd[1]: Starting Create System Files and Directories...787vm-test-run-apparmor> server # [ 9.852179] systemd[1]: etc-machine\x2did.mount: Deactivated successfully.788vm-test-run-apparmor> server # [ 9.872826] systemd[1]: Finished Save Transient machine-id to Disk.789vm-test-run-apparmor> server # [ 9.903173] systemd[1]: Started Rule-based Manager for Device Events and Files.790vm-test-run-apparmor> server # [ 10.020687] systemd[1]: Finished Create System Files and Directories.791vm-test-run-apparmor> server # [ 10.044327] systemd[1]: Starting Rebuild Journal Catalog...792vm-test-run-apparmor> server # [ 10.056242] systemd[1]: Starting Record System Boot/Shutdown in UTMP...793vm-test-run-apparmor> server # [ 10.196732] systemd[1]: Finished Record System Boot/Shutdown in UTMP.794vm-test-run-apparmor> server # [ 10.207769] apparmor_parser[883]: Cache miss: /nix/store/nsrizcnirwwb7sz970b68pgzf7i8bnma-test-sleep795vm-test-run-apparmor> server # [ 10.295475] audit: type=1400 audit(1780901238.984:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="test-sleep" pid=883 comm="apparmor_parser"796vm-test-run-apparmor> server # [ 10.297996] apparmor_parser[883]: Addition succeeded for "test-sleep".797vm-test-run-apparmor> server # [ 10.304292] systemd[1]: Finished Rebuild Journal Catalog.798vm-test-run-apparmor> server # [ 10.309766] systemd[1]: Finished Load AppArmor policies.799vm-test-run-apparmor> server # [ 10.321458] systemd[1]: Starting Update is Completed...800vm-test-run-apparmor> server # [ 10.408947] systemd[1]: Finished Update is Completed.801vm-test-run-apparmor> server # [ 10.853154] systemd[1]: suid-sgid-wrappers.service: Deactivated successfully.802vm-test-run-apparmor> server # [ 10.855345] systemd[1]: Finished Create SUID/SGID Wrappers.803vm-test-run-apparmor> server # [ 11.062713] systemd[1]: Finished register-nix-paths.service.804vm-test-run-apparmor> server # [ 11.120078] systemd[1]: Finished Firewall.805vm-test-run-apparmor> server # [ 11.469700] systemd[1]: Finished Coldplug All udev Devices.806vm-test-run-apparmor> server # [ 11.470640] systemd[1]: Reached target System Initialization.807vm-test-run-apparmor> server # [ 11.477337] systemd[1]: Started Discard unused filesystem blocks once a week.808vm-test-run-apparmor> server # [ 11.478358] systemd[1]: Started Daily Cleanup of Temporary Directories.809vm-test-run-apparmor> server # [ 11.479363] systemd[1]: Reached target Timer Units.810vm-test-run-apparmor> server # [ 11.480796] systemd[1]: Listening on D-Bus System Message Bus Socket.811vm-test-run-apparmor> server # [ 11.487146] systemd[1]: Listening on Nix Daemon Socket.812vm-test-run-apparmor> server # [ 11.487915] systemd[1]: Listening on Hostname Service Socket.813vm-test-run-apparmor> server # [ 11.489574] systemd[1]: Reached target Socket Units.814vm-test-run-apparmor> server # [ 11.492192] systemd[1]: Reached target Basic System.815vm-test-run-apparmor> server # [ 11.494357] systemd[1]: Started Test service with AppArmor profile.816vm-test-run-apparmor> server # [ 11.497493] systemd[1]: Starting Import lastlog data into lastlog2 database...817vm-test-run-apparmor> server # [ 11.504906] systemd[1]: Starting Name Service Cache Daemon (nsncd)...818vm-test-run-apparmor> server # [ 11.522818] systemd[1]: Starting Post-Boot Actions...819vm-test-run-apparmor> server # [ 11.550989] systemd[1]: Started Reset console on configuration changes.820vm-test-run-apparmor> server # [ 11.564211] systemd[1]: Starting resolvconf update...821vm-test-run-apparmor> server # [ 11.618707] systemd[1]: Starting D-Bus System Message Bus...822vm-test-run-apparmor> server # [ 11.621269] systemd[1]: Load Kernel Module configfs skipped, unmet condition check ConditionKernelModuleLoaded=!configfs823vm-test-run-apparmor> server # [ 11.662667] systemd[1]: Finished Post-Boot Actions.824vm-test-run-apparmor> server # [ 11.677705] nsncd[995]: Jun 08 06:47:20.381 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"825vm-test-run-apparmor> server # [ 11.687049] systemd[1]: Started Name Service Cache Daemon (nsncd).826vm-test-run-apparmor> server # [ 11.694510] systemd[1]: Reached target Host and Network Name Lookups.827vm-test-run-apparmor> server # [ 11.702072] systemd[1]: Reached target User and Group Name Lookups.828vm-test-run-apparmor> server # [ 11.717150] systemd[1]: Starting User Login Management...829vm-test-run-apparmor> server # [ 11.772581] systemd[1]: Finished Import lastlog data into lastlog2 database.830vm-test-run-apparmor> server # [ 11.871704] dbus-broker-launch[1000]: Looking up NSS user entry for 'systemd-timesync'...831vm-test-run-apparmor> server # [ 11.889628] dbus-broker-launch[1000]: NSS returned no entry for 'systemd-timesync'832vm-test-run-apparmor> server # [ 11.893037] dbus-broker-launch[1000]: Invalid user-name in /nix/store/4i0pmvr9zgccs4viicm46b83qybfcvln-system-path/share/dbus-1/system.d/org.freedesktop.timesync1.conf +16: user="systemd-timesync"833vm-test-run-apparmor> server # [ 11.915087] systemd-logind[1017]: New seat seat0.834vm-test-run-apparmor> server # [ 11.919757] systemd[1]: Started User Login Management.835vm-test-run-apparmor> server # [ 11.925142] systemd[1]: Starting linger-users.service...836vm-test-run-apparmor> server # [ 11.934765] systemd[1]: Started D-Bus System Message Bus.837vm-test-run-apparmor> server # [ 11.974365] dbus-broker-launch[1000]: Ready838vm-test-run-apparmor> server # [ 11.989301] systemd[1]: Stopped target Host and Network Name Lookups.839vm-test-run-apparmor> server # [ 11.997151] systemd[1]: Stopping Host and Network Name Lookups...840vm-test-run-apparmor> server # [ 12.002161] systemd[1]: Stopped target User and Group Name Lookups.841vm-test-run-apparmor> server # [ 12.006513] systemd[1]: Stopping User and Group Name Lookups...842vm-test-run-apparmor> server # [ 12.010683] systemd[1]: Stopping Name Service Cache Daemon (nsncd)...843vm-test-run-apparmor> server # [ 12.017224] systemd[1]: nscd.service: Deactivated successfully.844vm-test-run-apparmor> server # [ 12.021630] systemd[1]: Stopped Name Service Cache Daemon (nsncd).845vm-test-run-apparmor> server # [ 12.027716] systemd[1]: linger-users.service: Deactivated successfully.846vm-test-run-apparmor> server # [ 12.032561] systemd[1]: Finished linger-users.service.847vm-test-run-apparmor> server # [ 12.055673] systemd[1]: Starting Name Service Cache Daemon (nsncd)...848vm-test-run-apparmor> server # [ 12.079218] systemd[1]: Condition check resulted in /dev/hvc0 being skipped.849vm-test-run-apparmor> server # [ 12.138886] systemd[1]: Finished resolvconf update.850vm-test-run-apparmor> server # [ 12.140887] systemd[1]: Reached target Preparation for Network.851vm-test-run-apparmor> server # [ 12.148416] nsncd[1066]: Jun 08 06:47:20.852 INFO started, config: Config { ignored_request_types: {}, worker_count: 8, handoff_timeout: 10s }, path: "/var/run/nscd/socket"852vm-test-run-apparmor> server # [ 12.154887] systemd[1]: Starting DHCP Client...853vm-test-run-apparmor> server # [ 12.157662] systemd[1]: Starting Extra networking commands....854vm-test-run-apparmor> server # [ 12.161016] systemd[1]: Started Name Service Cache Daemon (nsncd).855vm-test-run-apparmor> server # [ 12.164764] systemd[1]: Reached target Host and Network Name Lookups.856vm-test-run-apparmor> server # [ 12.169317] systemd[1]: Reached target User and Group Name Lookups.857vm-test-run-apparmor> server # [ 12.174353] systemd[1]: Condition check resulted in /dev/ttyAMA0 being skipped.858vm-test-run-apparmor> server # [ 12.187275] systemd[1]: Started backdoor.service.859vm-test-run-apparmor> server # connecting to host...860vm-test-run-apparmor> server: Guest shell says: b'Spawning backdoor root shell...\n'861vm-test-run-apparmor> server: connected to guest root shell862vm-test-run-apparmor> server: (connecting took 12.64 seconds)863vm-test-run-apparmor> server: (finished: waiting for the VM to finish booting, in 12.64 seconds)864vm-test-run-apparmor> server # [ 12.468968] dhcpcd[1096]: dhcpcd-10.3.1 starting865vm-test-run-apparmor> server # [ 12.489426] dhcpcd[1134]: dev: loaded udev866vm-test-run-apparmor> server: (finished: waiting for unit apparmor.service, in 12.80 seconds)867vm-test-run-apparmor> server: must succeed: aa-status --json | jq -e '.profiles."test-sleep" == "enforce"'868vm-test-run-apparmor> server # [ 12.556479] 8021q: 802.1Q VLAN Support v1.8869vm-test-run-apparmor> server # [ 12.555420] systemd[1]: Finished Extra networking commands..870vm-test-run-apparmor> server # [ 12.560305] systemd[1]: Reached target Network.871vm-test-run-apparmor> server # [ 12.569163] systemd[1]: Starting Permit User Sessions...872vm-test-run-apparmor> server # [ 12.598442] (udev-worker)[852]: eth1: Config file /etc/systemd/network/40-eth1.link is applied to device based on potentially unpredictable interface name.873vm-test-run-apparmor> server # [ 12.606275] (udev-worker)[852]: Network interface NamePolicy= disabled on kernel command line.874vm-test-run-apparmor> server # [ 12.614754] (udev-worker)[863]: Network interface NamePolicy= disabled on kernel command line.875vm-test-run-apparmor> server: (finished: must succeed: aa-status --json | jq -e '.profiles."test-sleep" == "enforce"', in 0.12 seconds)876vm-test-run-apparmor> (finished: subtest: AppArmor is enabled and profile is loaded, in 12.92 seconds)877vm-test-run-apparmor> subtest: Service is running under AppArmor878vm-test-run-apparmor> server: waiting for unit apparmor-test.service879vm-test-run-apparmor> server # [ 12.662647] systemd[1]: Finished Permit User Sessions.880vm-test-run-apparmor> server # [ 12.675563] systemd[1]: Started Getty on tty1.881vm-test-run-apparmor> server # [ 12.678528] systemd[1]: Reached target Login Prompts.882vm-test-run-apparmor> server # [ 12.717414] cfg80211: Loading compiled-in X.509 certificates for regulatory database883vm-test-run-apparmor> server # [ 12.760078] Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'884vm-test-run-apparmor> server # [ 12.760591] Loaded X.509 cert 'wens: 61c038651aabdcf94bd0ac7ff06c7248db18c600'885vm-test-run-apparmor> server # [ 12.765820] faux_driver regulatory: Direct firmware load for regulatory.db failed with error -2886vm-test-run-apparmor> server # [ 12.766150] cfg80211: failed to load regulatory.db887vm-test-run-apparmor> server: (finished: waiting for unit apparmor-test.service, in 0.14 seconds)888vm-test-run-apparmor> server: must succeed: systemctl show -p MainPID --value apparmor-test.service889vm-test-run-apparmor> server # [ 12.775161] systemd[1]: Condition check resulted in Virtio network device being skipped.890vm-test-run-apparmor> server # [ 12.783007] systemd[1]: Starting Address configuration of eth1...891vm-test-run-apparmor> server: (finished: must succeed: systemctl show -p MainPID --value apparmor-test.service, in 0.07 seconds)892vm-test-run-apparmor> server: must succeed: cat /proc/993/attr/apparmor/current893vm-test-run-apparmor> server # [ 12.887639] 8021q: adding VLAN 0 to HW filter on device eth0894vm-test-run-apparmor> server # [ 12.878721] dhcpcd[1134]: eth0: waiting for carrier895vm-test-run-apparmor> server # [ 12.886942] dhcpcd[1134]: eth0: waiting for carrier896vm-test-run-apparmor> server # [ 12.895009] dhcpcd[1134]: eth0: carrier acquired897vm-test-run-apparmor> server: (finished: must succeed: cat /proc/993/attr/apparmor/current, in 0.07 seconds)898vm-test-run-apparmor> (finished: subtest: Service is running under AppArmor, in 0.28 seconds)899vm-test-run-apparmor> subtest: cntr can attach and exec to AppArmor-confined process900vm-test-run-apparmor> server: must succeed: cntr attach -t command 'sleep infinity' true901vm-test-run-apparmor> server # [ 12.916699] dhcpcd[1134]: DUID 00:01:00:01:31:b9:21:f9:52:54:00:12:34:56902vm-test-run-apparmor> server # [ 12.921282] dhcpcd[1134]: eth0: IAID 00:12:34:56903vm-test-run-apparmor> server # [ 12.934093] 8021q: adding VLAN 0 to HW filter on device eth1904vm-test-run-apparmor> server # [ 12.926095] dhcpcd[1134]: eth0: adding address fe80::5054:ff:fe12:3456905vm-test-run-apparmor> server # [ 12.951431] network-addresses-eth1-start[1170]: adding address 192.168.1.1/24... done906vm-test-run-apparmor> server # [ 12.970169] network-addresses-eth1-start[1170]: adding address 2001:db8:1::1/64... done907vm-test-run-apparmor> server # [ 12.997792] systemd[1]: Finished Address configuration of eth1.908vm-test-run-apparmor> server # [ 13.024848] audit: type=1400 audit(1780901241.716:3): apparmor="DENIED" operation="capable" class="cap" profile="test-sleep" pid=1205 comm="true" capability=24 capname="sys_resource"909vm-test-run-apparmor> server: (finished: must succeed: cntr attach -t command 'sleep infinity' true, in 0.11 seconds)910vm-test-run-apparmor> server: must succeed: cntr exec -t command 'sleep infinity' -- /bin/sh -c 'echo exec test passed'911vm-test-run-apparmor> server # [ 13.093477] audit: type=1400 audit(1780901241.784:4): apparmor="DENIED" operation="open" class="file" profile="test-sleep" name="/dev/tty" pid=1210 comm="sh" requested_mask="wr" denied_mask="wr" fsuid=0 ouid=0912vm-test-run-apparmor> server # [ 13.098530] audit: type=1400 audit(1780901241.788:5): apparmor="DENIED" operation="open" class="file" profile="test-sleep" name="/dev/pts/0" pid=1210 comm="sh" requested_mask="wr" denied_mask="wr" fsuid=0 ouid=0913vm-test-run-apparmor> server: (finished: must succeed: cntr exec -t command 'sleep infinity' -- /bin/sh -c 'echo exec test passed', in 0.08 seconds)914vm-test-run-apparmor> (finished: subtest: cntr can attach and exec to AppArmor-confined process, in 0.19 seconds)915vm-test-run-apparmor> (finished: run the VM test script, in 13.84 seconds)916vm-test-run-apparmor> test script finished in 13.90s917vm-test-run-apparmor> cleanup918vm-test-run-apparmor> kill QemuMachine (pid 13)919vm-test-run-apparmor> server # qemu-system-aarch64: terminating on signal 15 from pid 6 (/nix/store/36mns0lq3c2zgky08rsq0xvamfzglzvj-python3-3.13.12/bin/python3.13)920vm-test-run-apparmor> (finished: cleanup, in 0.13 seconds)921922post-build step Upload coverage to codecov: ok923Skipping codecov: project=Mic92/cntr attr=aarch64-linux.apparmor