Skip to content

Instantly share code, notes, and snippets.

@aszlig
Created February 3, 2019 10:08
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save aszlig/0b5ae4b03208a117b6f737772ff0eed8 to your computer and use it in GitHub Desktop.
Save aszlig/0b5ae4b03208a117b6f737772ff0eed8 to your computer and use it in GitHub Desktop.
(import (fetchTarball {
# Pin to a specific nixpkgs commit, to make sure we have Linux 4.19.
url = "https://github.com/NixOS/nixpkgs/archive/"
+ "776f084cf1bc7d174184e2d51b224e168fcd6fa4.tar.gz";
sha256 = "08rzhhlxb03fvq7pn4pr0f13spmg1k888mrmz5aa1fqcnf5pw9xf";
}) { config = {}; }).nixosTest ({ pkgs, ... }: {
name = "overlayfs-linux-4.19-regression";
machine = { lib, pkgs, ... }: {
virtualisation.writableStore = false;
system.build.regtest = pkgs.runCommand "test-regular" {} ''
mkdir -p "$out/somesubdir"
echo 'regular file in top-level dir' > "$out/regular_top"
echo 'regolar file in subdir' > "$out/somesubdir/regular_sub"
'';
boot = {
consoleLogLevel = lib.mkForce 8;
kernelPackages = pkgs.linuxPackages_4_19;
kernelParams = lib.singleton "dyndbg=\"file fs/overlayfs/* +p\"";
kernelPatches = lib.singleton {
name = "enable-dynamic-debug";
patch = null;
extraConfig = ''
DYNAMIC_DEBUG y
OVERLAY_FS y
'';
};
};
};
testScript = { nodes, ... }: ''
$machine->waitForUnit('multi-user.target');
$machine->succeed('${pkgs.writeScript "reproduce-overlay-regression.sh" ''
#!/bin/sh -ex
tmp="$(mktemp -d)"
trap '
umount "$tmp/result"
find "$tmp" -depth -type d -exec rmdir {} +
' EXIT
mkdir "$tmp/input" "$tmp/upper" "$tmp/work" "$tmp/result"
drv=${pkgs.lib.escapeShellArg nodes.machine.config.system.build.regtest}
mount -t overlay overlay "$tmp/result" \
-o "lowerdir=$drv,upperdir=$tmp/upper,workdir=$tmp/work"
sync
sleep 10
strace -f stat "$tmp/result/regular_top" \
"$tmp/result/somesubdir/regular_sub"
strace -f cat "$tmp/result/regular_top" \
"$tmp/result/somesubdir/regular_sub"
''} 2>&1');
'';
})
starting VDE switch for network 1
running the VM test script
machine: waiting for unit ‘multi-user.target’
machine: running command: systemctl --no-pager show "multi-user.target"
machine: waiting for the VM to finish booting
machine: starting vm
machine# Formatting '/build/vm-state-machine/machine.qcow2', fmt=qcow2 size=536870912 cluster_size=65536 lazy_refcounts=off refcount_bits=16
machine: QEMU running (pid 600)
machine# cSeaBIOS (version rel-1.11.2-0-gf9626ccb91-prebuilt.qemu-project.org)
machine#
machine#
machine# iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+17F910A0+17EF10A0 C980
machine#
machine#
machine#
machine#
machine# iPXE (http://ipxe.org) 00:08.0 CA80 PCI2.10 PnP PMM 17F910A0 17EF10A0 CA80
machine#
machine#
machine# Booting from ROM...
[ 0.000000] Linux version 4.19.7 (nixbld@localhost) (gcc version 7.3.0 (GCC)) #1-NixOS SMP Wed Dec 5 18:32:14 UTC 2018
machine# [ 0.000000] Command line: loglevel=8 console=ttyS0 panic=1 boot.panic_on_fail dyndbg="file fs/overlayfs/* +p" init=/nix/store/50abrqsa1gqj0qf818nmng75f7cdlin6-nixos-system-machine-19.03pre-git/init regInfo=/nix/store/pjwxi9m7b4xxvfaayx51dfhxmhh5y6sg-closure-info/registration console=hvc1 console=ttyS0
machine# [ 0.000000] x86/fpu: x87 FPU will use FXSAVE
machine# [ 0.000000] BIOS-provided physical RAM map:
machine# [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
machine# [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
machine# [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
machine# [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x0000000017fdbfff] usable
machine# [ 0.000000] BIOS-e820: [mem 0x0000000017fdc000-0x0000000017ffffff] reserved
machine# [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
machine# [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
machine# [ 0.000000] NX (Execute Disable) protection: active
machine# [ 0.000000] SMBIOS 2.8 present.
machine# [ 0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS rel-1.11.2-0-gf9626ccb91-prebuilt.qemu-project.org 04/01/2014
machine# [ 0.000000] Hypervisor detected: KVM
machine# [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
machine# [ 0.000000] kvm-clock: cpu 0, msr 9354001, primary cpu clock
machine# [ 0.000000] kvm-clock: using sched offset of 575866192 cycles
machine# [ 0.000001] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
machine# [ 0.000003] tsc: Detected 3499.998 MHz processor
machine# [ 0.001318] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
machine# [ 0.001320] e820: remove [mem 0x000a0000-0x000fffff] usable
machine# [ 0.001323] last_pfn = 0x17fdc max_arch_pfn = 0x400000000
machine# [ 0.001348] MTRR default type: write-back
machine# [ 0.001348] MTRR fixed ranges enabled:
machine# [ 0.001349] 00000-9FFFF write-back
machine# [ 0.001350] A0000-BFFFF uncachable
machine# [ 0.001351] C0000-FFFFF write-protect
machine# [ 0.001352] MTRR variable ranges enabled:
machine# [ 0.001353] 0 base 0080000000 mask FF80000000 uncachable
machine# [ 0.001353] 1 disabled
machine# [ 0.001354] 2 disabled
machine# [ 0.001354] 3 disabled
machine# [ 0.001355] 4 disabled
machine# [ 0.001355] 5 disabled
machine# [ 0.001356] 6 disabled
machine# [ 0.001357] 7 disabled
machine# [ 0.001364] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- UC
machine# [ 0.006155] found SMP MP-table at [mem 0x000f58f0-0x000f58ff] mapped at [(____ptrval____)]
machine# [ 0.006239] Scanning 1 areas for low memory corruption
machine# [ 0.006241] Base memory trampoline at [(____ptrval____)] 99000 size 24576
machine# [ 0.006268] BRK [0x09401000, 0x09401fff] PGTABLE
machine# [ 0.006269] BRK [0x09402000, 0x09402fff] PGTABLE
machine# [ 0.006270] BRK [0x09403000, 0x09403fff] PGTABLE
machine# [ 0.006298] BRK [0x09404000, 0x09404fff] PGTABLE
machine# [ 0.006387] BRK [0x09405000, 0x09405fff] PGTABLE
machine# [ 0.006413] RAMDISK: [mem 0x176a9000-0x17fcffff]
machine# [ 0.006430] ACPI: Early table checksum verification disabled
machine# [ 0.006478] ACPI: RSDP 0x00000000000F5700 000014 (v00 BOCHS )
machine# [ 0.006481] ACPI: RSDT 0x0000000017FE157C 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
machine# [ 0.006485] ACPI: FACP 0x0000000017FE1458 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
machine# [ 0.006489] ACPI: DSDT 0x0000000017FE0040 001418 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
machine# [ 0.006492] ACPI: FACS 0x0000000017FE0000 000040
machine# [ 0.006494] ACPI: APIC 0x0000000017FE14CC 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
machine# [ 0.006496] ACPI: HPET 0x0000000017FE1544 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
machine# [ 0.006502] ACPI: Local APIC address 0xfee00000
machine# [ 0.006815] No NUMA configuration found
machine# [ 0.006816] Faking a node at [mem 0x0000000000000000-0x0000000017fdbfff]
machine# [ 0.006818] NODE_DATA(0) allocated [mem 0x17fd8000-0x17fdbfff]
machine# [ 0.006831] Zone ranges:
machine# [ 0.006832] DMA [mem 0x0000000000001000-0x0000000000ffffff]
machine# [ 0.006833] DMA32 [mem 0x0000000001000000-0x0000000017fdbfff]
machine# [ 0.006834] Normal empty
machine# [ 0.006835] Movable zone start for each node
machine# [ 0.006835] Early memory node ranges
machine# [ 0.006836] node 0: [mem 0x0000000000001000-0x000000000009efff]
machine# [ 0.006837] node 0: [mem 0x0000000000100000-0x0000000017fdbfff]
machine# [ 0.007139] Reserved but unavailable: 134 pages
machine# [ 0.007140] Initmem setup node 0 [mem 0x0000000000001000-0x0000000017fdbfff]
machine# [ 0.007141] On node 0 totalpages: 98170
machine# [ 0.007142] DMA zone: 64 pages used for memmap
machine# [ 0.007143] DMA zone: 21 pages reserved
machine# [ 0.007144] DMA zone: 3998 pages, LIFO batch:0
machine# [ 0.007214] DMA32 zone: 1472 pages used for memmap
machine# [ 0.007215] DMA32 zone: 94172 pages, LIFO batch:31
machine# [ 0.009523] ACPI: PM-Timer IO Port: 0x608
machine# [ 0.009525] ACPI: Local APIC address 0xfee00000
machine# [ 0.009531] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
machine# [ 0.009562] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
machine# [ 0.009564] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
machine# [ 0.009566] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
machine# [ 0.009567] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
machine# [ 0.009568] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
machine# [ 0.009568] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
machine# [ 0.009569] ACPI: IRQ0 used by override.
machine# [ 0.009570] ACPI: IRQ5 used by override.
machine# [ 0.009571] ACPI: IRQ9 used by override.
machine# [ 0.009571] ACPI: IRQ10 used by override.
machine# [ 0.009572] ACPI: IRQ11 used by override.
machine# [ 0.009573] Using ACPI (MADT) for SMP configuration information
machine# [ 0.009575] ACPI: HPET id: 0x8086a201 base: 0xfed00000
machine# [ 0.009577] smpboot: Allowing 1 CPUs, 0 hotplug CPUs
machine# [ 0.009588] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
machine# [ 0.009589] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
machine# [ 0.009590] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
machine# [ 0.009590] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
machine# [ 0.009592] [mem 0x18000000-0xfeffbfff] available for PCI devices
machine# [ 0.009592] Booting paravirtualized kernel on KVM
machine# [ 0.009594] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
machine# [ 0.072810] random: get_random_bytes called from start_kernel+0x94/0x4d4 with crng_init=0
machine# [ 0.072815] setup_percpu: NR_CPUS:384 nr_cpumask_bits:384 nr_cpu_ids:1 nr_node_ids:1
machine# [ 0.073029] percpu: Embedded 44 pages/cpu @(____ptrval____) s141272 r8192 d30760 u2097152
machine# [ 0.073033] pcpu-alloc: s141272 r8192 d30760 u2097152 alloc=1*2097152
machine# [ 0.073034] pcpu-alloc: [0] 0
machine# [ 0.073049] KVM setup async PF for cpu 0
machine# [ 0.073053] kvm-stealtime: cpu 0, msr 16c16180
machine# [ 0.073057] Built 1 zonelists, mobility grouping on. Total pages: 96613
machine# [ 0.073058] Policy zone: DMA32
machine# [ 0.073059] Kernel command line: loglevel=8 console=ttyS0 panic=1 boot.panic_on_fail dyndbg="file fs/overlayfs/* +p" init=/nix/store/50abrqsa1gqj0qf818nmng75f7cdlin6-nixos-system-machine-19.03pre-git/init regInfo=/nix/store/pjwxi9m7b4xxvfaayx51dfhxmhh5y6sg-closure-info/registration console=hvc1 console=ttyS0
machine# [ 0.073141] Calgary: detecting Calgary via BIOS EBDA area
machine# [ 0.073142] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
machine# [ 0.076680] Memory: 354936K/392680K available (10252K kernel code, 1125K rwdata, 1932K rodata, 1456K init, 804K bss, 37744K reserved, 0K cma-reserved)
machine# [ 0.076840] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
machine# [ 0.076844] Kernel/User page tables isolation: enabled
machine# [ 0.076870] ftrace: allocating 28488 entries in 112 pages
machine# [ 0.084659] rcu: Hierarchical RCU implementation.
machine# [ 0.084660] rcu: RCU event tracing is enabled.
machine# [ 0.084661] rcu: RCU restricting CPUs from NR_CPUS=384 to nr_cpu_ids=1.
machine# [ 0.084662] rcu: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=1
machine# [ 0.086488] NR_IRQS: 24832, nr_irqs: 256, preallocated irqs: 16
machine# [ 0.092825] Console: colour VGA+ 80x25
machine# [ 0.198418] console [ttyS0] enabled
machine# [ 0.198954] ACPI: Core revision 20180810
machine# [ 0.199738] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
machine# [ 0.201122] hpet clockevent registered
machine# [ 0.201721] APIC: Switch to symmetric I/O mode setup
machine# [ 0.202727] x2apic enabled
machine# [ 0.203444] Switched APIC routing to physical x2apic.
machine# [ 0.205354] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
machine# [ 0.206261] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x32734efdd03, max_idle_ns: 440795244944 ns
machine# [ 0.207809] Calibrating delay loop (skipped) preset value.. 6999.99 BogoMIPS (lpj=3499998)
machine# [ 0.208801] pid_max: default: 32768 minimum: 301
machine# [ 0.209818] Security Framework initialized
machine# [ 0.210801] Yama: becoming mindful.
machine# [ 0.211346] AppArmor: AppArmor initialized
machine# [ 0.211864] Dentry cache hash table entries: 65536 (order: 7, 524288 bytes)
machine# [ 0.212833] Inode-cache hash table entries: 32768 (order: 6, 262144 bytes)
machine# [ 0.213808] Mount-cache hash table entries: 1024 (order: 1, 8192 bytes)
machine# [ 0.214804] Mountpoint-cache hash table entries: 1024 (order: 1, 8192 bytes)
machine# [ 0.215970] mce: CPU supports 10 MCE banks
machine# [ 0.216848] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
machine# [ 0.217801] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
machine# [ 0.218802] Spectre V2 : Mitigation: Full generic retpoline
machine# [ 0.219704] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch
machine# [ 0.219801] Speculative Store Bypass: Vulnerable
machine# [ 0.225504] Freeing SMP alternatives memory: 28K
machine# [ 0.227798] smpboot: CPU0: Intel Common KVM processor (family: 0xf, model: 0x6, stepping: 0x1)
machine# [ 0.227888] Performance Events: unsupported Netburst CPU model 6 no PMU driver, software events only.
machine# [ 0.228870] rcu: Hierarchical SRCU implementation.
machine# [ 0.230187] smp: Bringing up secondary CPUs ...
machine# [ 0.230802] smp: Brought up 1 node, 1 CPU
machine# [ 0.231801] smpboot: Max logical packages: 1
machine# [ 0.232435] smpboot: Total of 1 processors activated (6999.99 BogoMIPS)
machine# [ 0.232900] devtmpfs: initialized
machine# [ 0.233942] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
machine# [ 0.234804] futex hash table entries: 256 (order: 2, 16384 bytes)
machine# [ 0.235834] pinctrl core: initialized pinctrl subsystem
machine# [ 0.236917] NET: Registered protocol family 16
machine# [ 0.237858] audit: initializing netlink subsys (disabled)
machine# [ 0.238883] cpuidle: using governor menu
machine# [ 0.239498] ACPI: bus type PCI registered
machine# [ 0.239801] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
machine# [ 0.240921] PCI: Using configuration type 1 for base access
machine# [ 0.241821] audit: type=2000 audit(1549188165.542:1): state=initialized audit_enabled=0 res=1
machine# [ 0.243217] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
machine# [ 0.243923] ACPI: Added _OSI(Module Device)
machine# [ 0.244803] ACPI: Added _OSI(Processor Device)
machine# [ 0.245802] ACPI: Added _OSI(3.0 _SCP Extensions)
machine# [ 0.246490] ACPI: Added _OSI(Processor Aggregator Device)
machine# [ 0.246807] ACPI: Added _OSI(Linux-Dell-Video)
machine# [ 0.247812] ACPI: Added _OSI(Linux-Lenovo-NV-HDMI-Audio)
machine# [ 0.249181] ACPI: 1 ACPI AML tables successfully acquired and loaded
machine# [ 0.250896] ACPI: Interpreter enabled
machine# [ 0.251813] ACPI: (supports S0 S3 S4 S5)
machine# [ 0.252400] ACPI: Using IOAPIC for interrupt routing
machine# [ 0.252812] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
machine# [ 0.253890] ACPI: Enabled 2 GPEs in block 00 to 0F
machine# [ 0.256938] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
machine# [ 0.257805] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
machine# [ 0.258805] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
machine# [ 0.259761] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
machine# [ 0.259923] acpiphp: Slot [3] registered
machine# [ 0.260858] acpiphp: Slot [4] registered
machine# [ 0.261806] acpiphp: Slot [5] registered
machine# [ 0.262452] acpiphp: Slot [6] registered
machine# [ 0.262862] acpiphp: Slot [7] registered
machine# [ 0.263475] acpiphp: Slot [8] registered
machine# [ 0.263857] acpiphp: Slot [9] registered
machine# [ 0.264856] acpiphp: Slot [10] registered
machine# [ 0.265485] acpiphp: Slot [11] registered
machine# [ 0.265857] acpiphp: Slot [12] registered
machine# [ 0.266855] acpiphp: Slot [13] registered
machine# [ 0.267485] acpiphp: Slot [14] registered
machine# [ 0.267863] acpiphp: Slot [15] registered
machine# [ 0.268494] acpiphp: Slot [16] registered
machine# [ 0.268857] acpiphp: Slot [17] registered
machine# [ 0.269857] acpiphp: Slot [18] registered
machine# [ 0.270521] acpiphp: Slot [19] registered
machine# [ 0.270855] acpiphp: Slot [20] registered
machine# [ 0.271857] acpiphp: Slot [21] registered
machine# [ 0.272493] acpiphp: Slot [22] registered
machine# [ 0.272855] acpiphp: Slot [23] registered
machine# [ 0.273855] acpiphp: Slot [24] registered
machine# [ 0.274488] acpiphp: Slot [25] registered
machine# [ 0.274862] acpiphp: Slot [26] registered
machine# [ 0.275487] acpiphp: Slot [27] registered
machine# [ 0.275857] acpiphp: Slot [28] registered
machine# [ 0.276855] acpiphp: Slot [29] registered
machine# [ 0.277486] acpiphp: Slot [30] registered
machine# [ 0.277857] acpiphp: Slot [31] registered
machine# [ 0.278819] PCI host bridge to bus 0000:00
machine# [ 0.279425] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
machine# [ 0.279802] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
machine# [ 0.280802] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
machine# [ 0.281802] pci_bus 0000:00: root bus resource [mem 0x18000000-0xfebfffff window]
machine# [ 0.282803] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window]
machine# [ 0.283802] pci_bus 0000:00: root bus resource [bus 00-ff]
machine# [ 0.284659] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
machine# [ 0.285983] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
machine# [ 0.287416] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
machine# [ 0.291405] pci 0000:00:01.1: reg 0x20: [io 0xc1c0-0xc1cf]
machine# [ 0.293478] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
machine# [ 0.293802] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
machine# [ 0.294802] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
machine# [ 0.295802] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
machine# [ 0.296976] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
machine# [ 0.301505] pci 0000:00:01.2: reg 0x20: [io 0xc0c0-0xc0df]
machine# [ 0.303396] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
machine# [ 0.304977] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI
machine# [ 0.305819] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB
machine# [ 0.307058] pci 0000:00:02.0: [1234:1111] type 00 class 0x030000
machine# [ 0.309570] pci 0000:00:02.0: reg 0x10: [mem 0xfd000000-0xfdffffff pref]
machine# [ 0.311802] pci 0000:00:02.0: reg 0x18: [mem 0xfebd0000-0xfebd0fff]
machine# [ 0.317803] pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref]
machine# [ 0.319893] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
machine# [ 0.321802] pci 0000:00:03.0: reg 0x10: [io 0xc0e0-0xc0ff]
machine# [ 0.323802] pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff]
machine# [ 0.328802] pci 0000:00:03.0: reg 0x20: [mem 0xfe000000-0xfe003fff 64bit pref]
machine# [ 0.330802] pci 0000:00:03.0: reg 0x30: [mem 0xfeb40000-0xfeb7ffff pref]
machine# [ 0.332501] pci 0000:00:04.0: [1af4:1005] type 00 class 0x00ff00
machine# [ 0.334246] pci 0000:00:04.0: reg 0x10: [io 0xc100-0xc11f]
machine# [ 0.338664] pci 0000:00:04.0: reg 0x20: [mem 0xfe004000-0xfe007fff 64bit pref]
machine# [ 0.340451] pci 0000:00:05.0: [1af4:1009] type 00 class 0x000200
machine# [ 0.342802] pci 0000:00:05.0: reg 0x10: [io 0xc120-0xc13f]
machine# [ 0.344385] pci 0000:00:05.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff]
machine# [ 0.350423] pci 0000:00:05.0: reg 0x20: [mem 0xfe008000-0xfe00bfff 64bit pref]
machine# [ 0.353499] pci 0000:00:06.0: [1af4:1009] type 00 class 0x000200
machine# [ 0.355386] pci 0000:00:06.0: reg 0x10: [io 0xc140-0xc15f]
machine# [ 0.357379] pci 0000:00:06.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff]
machine# [ 0.362802] pci 0000:00:06.0: reg 0x20: [mem 0xfe00c000-0xfe00ffff 64bit pref]
machine# [ 0.365848] pci 0000:00:07.0: [1af4:1009] type 00 class 0x000200
machine# [ 0.367802] pci 0000:00:07.0: reg 0x10: [io 0xc160-0xc17f]
machine# [ 0.369802] pci 0000:00:07.0: reg 0x14: [mem 0xfebd4000-0xfebd4fff]
machine# [ 0.374802] pci 0000:00:07.0: reg 0x20: [mem 0xfe010000-0xfe013fff 64bit pref]
machine# [ 0.377881] pci 0000:00:08.0: [1af4:1000] type 00 class 0x020000
machine# [ 0.379802] pci 0000:00:08.0: reg 0x10: [io 0xc180-0xc19f]
machine# [ 0.381802] pci 0000:00:08.0: reg 0x14: [mem 0xfebd5000-0xfebd5fff]
machine# [ 0.385802] pci 0000:00:08.0: reg 0x20: [mem 0xfe014000-0xfe017fff 64bit pref]
machine# [ 0.388367] pci 0000:00:08.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
machine# [ 0.390050] pci 0000:00:09.0: [1af4:1003] type 00 class 0x078000
machine# [ 0.391802] pci 0000:00:09.0: reg 0x10: [io 0xc000-0xc03f]
machine# [ 0.393803] pci 0000:00:09.0: reg 0x14: [mem 0xfebd6000-0xfebd6fff]
machine# [ 0.398517] pci 0000:00:09.0: reg 0x20: [mem 0xfe018000-0xfe01bfff 64bit pref]
machine# [ 0.401494] pci 0000:00:0a.0: [1af4:1003] type 00 class 0x078000
machine# [ 0.403397] pci 0000:00:0a.0: reg 0x10: [io 0xc040-0xc07f]
machine# [ 0.405392] pci 0000:00:0a.0: reg 0x14: [mem 0xfebd7000-0xfebd7fff]
machine# [ 0.409802] pci 0000:00:0a.0: reg 0x20: [mem 0xfe01c000-0xfe01ffff 64bit pref]
machine# [ 0.413823] pci 0000:00:0b.0: [1af4:1005] type 00 class 0x00ff00
machine# [ 0.415704] pci 0000:00:0b.0: reg 0x10: [io 0xc1a0-0xc1bf]
machine# [ 0.419802] pci 0000:00:0b.0: reg 0x20: [mem 0xfe020000-0xfe023fff 64bit pref]
machine# [ 0.422357] pci 0000:00:0c.0: [1af4:1001] type 00 class 0x010000
machine# [ 0.424803] pci 0000:00:0c.0: reg 0x10: [io 0xc080-0xc0bf]
machine# [ 0.426802] pci 0000:00:0c.0: reg 0x14: [mem 0xfebd8000-0xfebd8fff]
machine# [ 0.431463] pci 0000:00:0c.0: reg 0x20: [mem 0xfe024000-0xfe027fff 64bit pref]
machine# [ 0.436460] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
machine# [ 0.436920] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
machine# [ 0.437912] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
machine# [ 0.438910] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
machine# [ 0.439867] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
machine# [ 0.440984] pci 0000:00:02.0: vgaarb: setting as boot VGA device
machine# [ 0.441798] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none
machine# [ 0.441803] pci 0000:00:02.0: vgaarb: bridge control possible
machine# [ 0.442801] vgaarb: loaded
machine# [ 0.443314] PCI: Using ACPI for IRQ routing
machine# [ 0.443802] PCI: pci_cache_line_size set to 64 bytes
machine# [ 0.445111] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
machine# [ 0.445802] e820: reserve RAM buffer [mem 0x17fdc000-0x17ffffff]
machine# [ 0.446891] NetLabel: Initializing
machine# [ 0.447406] NetLabel: domain hash size = 128
machine# [ 0.447801] NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO
machine# [ 0.448815] NetLabel: unlabeled traffic allowed by default
machine# [ 0.449876] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
machine# [ 0.450831] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
machine# [ 0.451802] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
machine# [ 0.455833] clocksource: Switched to clocksource kvm-clock
machine# [ 0.462443] VFS: Disk quotas dquot_6.6.0
machine# [ 0.463068] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
machine# [ 0.464172] AppArmor: AppArmor Filesystem Enabled
machine# [ 0.464907] pnp: PnP ACPI init
machine# [ 0.465423] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
machine# [ 0.466432] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
machine# [ 0.467437] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
machine# [ 0.468420] pnp 00:03: [dma 2]
machine# [ 0.468922] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
machine# [ 0.469953] pnp 00:04: Plug and Play ACPI device, IDs PNP0400 (active)
machine# [ 0.470980] pnp 00:05: Plug and Play ACPI device, IDs PNP0501 (active)
machine# [ 0.472134] pnp: PnP ACPI: found 6 devices
machine# [ 0.478271] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
machine# [ 0.479574] pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window]
machine# [ 0.480510] pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window]
machine# [ 0.481434] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
machine# [ 0.482460] pci_bus 0000:00: resource 7 [mem 0x18000000-0xfebfffff window]
machine# [ 0.483487] pci_bus 0000:00: resource 8 [mem 0x100000000-0x17fffffff window]
machine# [ 0.484577] NET: Registered protocol family 2
machine# [ 0.485337] tcp_listen_portaddr_hash hash table entries: 256 (order: 0, 4096 bytes)
machine# [ 0.486479] TCP established hash table entries: 4096 (order: 3, 32768 bytes)
machine# [ 0.487544] TCP bind hash table entries: 4096 (order: 4, 65536 bytes)
machine# [ 0.488513] TCP: Hash tables configured (established 4096 bind 4096)
machine# [ 0.489481] UDP hash table entries: 256 (order: 1, 8192 bytes)
machine# [ 0.490356] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
machine# [ 0.491322] NET: Registered protocol family 1
machine# [ 0.492008] pci 0000:00:01.0: PIIX3: Enabling Passive Release
machine# [ 0.492867] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
machine# [ 0.493753] pci 0000:00:01.0: Activating ISA DMA hang workarounds
machine# [ 0.507002] PCI Interrupt Link [LNKD] enabled at IRQ 11
machine# [ 0.520229] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6b0 took 24845 usecs
machine# [ 0.521391] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff]
machine# [ 0.522730] PCI: CLS 0 bytes, default 64
machine# [ 0.523357] Trying to unpack rootfs image as initramfs...
machine# [ 0.623839] Freeing initrd memory: 9372K
machine# [ 0.624510] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x32734efdd03, max_idle_ns: 440795244944 ns
machine# [ 0.626068] Scanning for low memory corruption every 60 seconds
machine# [ 0.627280] Initialise system trusted keyrings
machine# [ 0.628010] workingset: timestamp_bits=40 max_order=17 bucket_order=0
machine# [ 0.629674] zbud: loaded
machine# [ 0.630460] Key type asymmetric registered
machine# [ 0.631093] Asymmetric key parser 'x509' registered
machine# [ 0.631842] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 250)
machine# [ 0.632975] io scheduler noop registered
machine# [ 0.633562] io scheduler deadline registered
machine# [ 0.634249] io scheduler cfq registered (default)
machine# [ 0.634969] io scheduler mq-deadline registered
machine# [ 0.635648] io scheduler kyber registered
machine# [ 0.636415] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
machine# [ 0.660203] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
machine# [ 0.662857] brd: module loaded
machine# [ 0.663443] sched_clock: Marking stable (547662398, 115143803)->(775403808, -112597607)
machine# [ 0.664715] registered taskstats version 1
machine# [ 0.665342] Loading compiled-in X.509 certificates
machine# [ 0.666096] zswap: loaded using pool lzo/zbud
machine# [ 0.666786] AppArmor: AppArmor sha1 policy hashing enabled
machine# [ 0.669314] Freeing unused kernel image memory: 1456K
machine# [ 0.670821] Write protecting the kernel read-only data: 14336k
machine# [ 0.672023] Freeing unused kernel image memory: 2012K
machine# [ 0.672847] Freeing unused kernel image memory: 116K
machine# [ 0.673645] Run /init as init process
machine#
machine# <<< NixOS Stage 1 >>>
machine#
machine# loading module virtio_balloon...
machine# [ 0.692356] stage-1-init: loading module virtio_balloon...
machine# loading module virtio_console...
machine# [ 0.696957] stage-1-init: loading module virtio_console...
machine# loading module virtio_rng...
machine# [ 0.700944] stage-1-init: loading module virtio_rng...
machine# loading module dm_mod...
machine# [ 0.704307] stage-1-init: loading module dm_mod...
machine# [ 0.712084] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com
machine# running udev...
machine# [ 0.713831] stage-1-init: running udev...
machine# [ 0.718077] systemd-udevd[92]: starting version 239
machine# [ 0.765087] rtc_cmos 00:00: RTC can wake from S4
machine# [ 0.775825] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
machine# [ 0.780440] rtc_cmos 00:00: registered as rtc0
machine# [ 0.787826] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
machine# [ 0.791516] serio: i8042 KBD port at 0x60,0x64 irq 1
machine# [ 0.796816] serio: i8042 AUX port at 0x60,0x64 irq 12
machine# [ 0.819207] SCSI subsystem initialized
machine# [ 0.831303] ACPI: bus type USB registered
machine# [ 0.833829] usbcore: registered new interface driver usbfs
machine# [ 0.834667] usbcore: registered new interface driver hub
machine# [ 0.835938] PCI Interrupt Link [LNKC] enabled at IRQ 10
machine# [ 0.841826] usbcore: registered new device driver usb
machine# [ 0.859492] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
machine# [ 0.865904] uhci_hcd: USB Universal Host Controller Interface driver
machine# [ 0.866899] libata version 3.00 loaded.
machine# [ 0.868416] ata_piix 0000:00:01.1: version 2.13
machine# [ 0.881816] scsi host0: ata_piix
machine# [ 0.889815] scsi host1: ata_piix
machine# [ 0.890361] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc1c0 irq 14
machine# [ 0.891369] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc1c8 irq 15
machine# [ 0.901757] uhci_hcd 0000:00:01.2: UHCI Host Controller
machine# [ 0.902544] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
machine# [ 0.903681] uhci_hcd 0000:00:01.2: detected 2 ports
machine# [ 0.904483] random: fast init done
machine# [ 0.906818] random: crng init done
machine# [ 0.911879] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c0c0
machine# [ 0.912824] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.19
machine# [ 0.914064] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
machine# [ 0.915160] usb usb1: Product: UHCI Host Controller
machine# [ 0.915923] usb usb1: Manufacturer: Linux 4.19.7 uhci_hcd
machine# [ 0.916735] usb usb1: SerialNumber: 0000:00:01.2
machine# [ 0.921474] hub 1-0:1.0: USB hub found
machine# [ 0.922818] hub 1-0:1.0: 2 ports detected
machine# [ 0.926318] PCI Interrupt Link [LNKA] enabled at IRQ 10
machine# [ 0.943788] PCI Interrupt Link [LNKB] enabled at IRQ 11
machine# [ 1.025936] console [hvc1] enabled
machine# [ 1.050401] ata2.01: NODEV after polling detection
machine# [ 1.051505] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
machine# [ 1.053435] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5
machine# [ 1.089782] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0
machine# [ 1.117646] virtio_blk virtio9: [vda] 1048576 512-byte logical blocks (537 MB/512 MiB)
machine# [ 1.126616] 9pnet: Installing 9P2000 support
machine# [ 1.136360] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
machine# [ 1.137472] cdrom: Uniform CD-ROM driver Revision: 3.20
machine# [ 1.142422] sr 1:0:0:0: Attached scsi CD-ROM sr0
machine# [ 1.251831] usb 1-1: new full-speed USB device number 2 using uhci_hcd
machine# kbd_mode: KDSKBMODE: Inappropriate ioctl for device
machine# [ 1.339406] stage-1-init: kbd_mode: KDSKBMODE: Inappropriate ioctl for device
machine# %Gstarting device mapper and LVM...
machine# [ 1.342766] stage-1-init: starting device mapper and LVM...
machine# [ 1.351529] clocksource: Switched to clocksource acpi_pm
machine# mke2fs 1.44.4 (18-Aug-2018)
machine# [ 1.358458] stage-1-init: mke2fs 1.44.4 (18-Aug-2018)
machine# Creating filesystem with 131072 4k blocks and 32768 inodes
machine# [ 1.361162] stage-1-init: Creating filesystem with 131072 4k blocks and 32768 inodes
machine# Filesystem UUID: 0f72c5c1-3ff8-4d90-a77a-cd3d1a140c9b
machine# [ 1.363258] stage-1-init: Filesystem UUID: 0f72c5c1-3ff8-4d90-a77a-cd3d1a140c9b
machine# Superblock backups stored on blocks:
machine# 32768, 98304
machine#
machine# Allocating group tables: 0/4 done
machine# Writing inode tables: 0/4 done
machine# Creating journal (4096 blocks): [ 1.369016] stage-1-init: Superblock backups stored on blocks:
machine# [ 1.370077] stage-1-init: 32768, 98304
machine# [ 1.371639] stage-1-init: Allocating group tables: 0/4 done
machine# [ 1.373974] stage-1-init: Writing inode tables: 0/4 done
machine# done
machine# [ 1.378725] stage-1-init: Creating journal (4096 blocks): done
machine# Writing superblocks and filesystem accounting information: 0/4 [ 1.416593] usb 1-1: New USB device found, idVendor=0627, idProduct=0001, bcdDevice= 0.00
machine# [ 1.418027] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=5
machine# [ 1.419402] usb 1-1: Product: QEMU USB Tablet
machine# [ 1.420241] usb 1-1: Manufacturer: QEMU
machine# [ 1.420992] usb 1-1: SerialNumber: 42
machine# [ 1.435485] hidraw: raw HID events driver (C) Jiri Kosina
machine# done
machine#
machine# [ 1.438101] stage-1-init: Writing superblocks and filesystem accounting information: 0/4 done
machine# [ 1.453295] usbcore: registered new interface driver usbhid
machine# [ 1.454347] usbhid: USB HID core driver
machine# [ 1.456351] 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
machine# [ 1.458581] 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
machine# checking /dev/vda...
machine# [ 1.471385] stage-1-init: checking /dev/vda...
machine# fsck (busybox 1.29.3)
machine# [ 1.473141] stage-1-init: fsck (busybox 1.29.3)
machine# [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
machine# [ 1.475012] stage-1-init: [fsck.ext4 (1) -- /mnt-root/] fsck.ext4 -a /dev/vda
machine# /dev/vda: clean, 11/32768 files, 6353/131072 blocks
machine# [ 1.478583] stage-1-init: /dev/vda: clean, 11/32768 files, 6353/131072 blocks
machine# mounting /dev/vda on /...
machine# [ 1.485348] stage-1-init: mounting /dev/vda on /...
machine# [ 1.552197] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null)
machine# mounting store on /nix/store...
machine# [ 1.560873] stage-1-init: mounting store on /nix/store...
machine# [ 1.570116] FS-Cache: Loaded
machine# [ 1.575005] 9p: Installing v9fs 9p2000 file system support
machine# [ 1.577481] FS-Cache: Netfs '9p' registered for caching
machine# mounting shared on /tmp/shared...
machine# [ 1.586871] stage-1-init: mounting shared on /tmp/shared...
machine# mounting xchg on /tmp/xchg...
machine# [ 1.597783] stage-1-init: mounting xchg on /tmp/xchg...
machine#
machine# <<< NixOS Stage 2 >>>
machine#
machine# [ 1.745294] EXT4-fs (vda): re-mounted. Opts: (null)
machine# [ 1.747033] booting system configuration /nix/store/50abrqsa1gqj0qf818nmng75f7cdlin6-nixos-system-machine-19.03pre-git
machine# running activation script...
machine# [ 1.979343] stage-2-init: running activation script...
machine# setting up /etc...
machine# [ 2.344807] stage-2-init: setting up /etc...
machine# error: changing ownership of path '/nix/store': Invalid argument
machine# [ 4.278019] stage-2-init: error: changing ownership of path '/nix/store': Invalid argument
machine# starting systemd...
machine# [ 4.455293] NET: Registered protocol family 10
machine# [ 4.456294] Segment Routing with IPv6
machine# [ 4.468347] systemd[1]: systemd 239 running in system mode. (+PAM +AUDIT -SELINUX +IMA +APPARMOR +SMACK -SYSVINIT +UTMP -LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID -ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid)
machine# [ 4.471853] systemd[1]: Detected virtualization kvm.
machine# [ 4.472792] systemd[1]: Detected architecture x86-64.
machine# [ 4.475792] systemd[1]: Set hostname to <machine>.
machine# [ 4.476705] systemd[1]: Initializing machine ID from random generator.
machine# [ 4.580232] systemd-fstab-generator[423]: Checking was requested for "store", but it is not a device.
machine# [ 4.582527] systemd-fstab-generator[423]: Checking was requested for "shared", but it is not a device.
machine# [ 4.584358] systemd-fstab-generator[423]: Checking was requested for "xchg", but it is not a device.
machine# [ 4.891645] systemd[1]: Listening on Journal Socket (/dev/log).
machine# [ 4.893019] systemd[1]: Listening on Journal Socket.
machine# [ 4.895103] systemd[1]: Starting Create list of required static device nodes for the current kernel...
machine# [ 4.896850] systemd[1]: Reached target Remote File Systems.
machine# [ 4.898040] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
machine# [ 4.994338] loop: module loaded
machine# [ 5.001164] EXT4-fs (vda): re-mounted. Opts: (null)
machine# [ 5.020595] audit: type=1130 audit(1549188169.667:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-remount-fs comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.031534] audit: type=1130 audit(1549188169.676:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.079059] audit: type=1325 audit(1549188169.725:4): table=filter family=2 entries=0
machine# [ 5.080560] audit: type=1300 audit(1549188169.725:4): arch=c000003e syscall=175 success=yes exit=0 a0=2216ba0 a1=1ee0 a2=41af66 a3=0 items=0 ppid=115 pid=444 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="modprobe" exe="/nix/store/4k44jax206vaxl17ajra77qclqjm9lln-kmod-25/bin/kmod" subj==unconfined key=(null)
machine# [ 5.096597] audit: type=1327 audit(1549188169.725:4): proctitle=2F6E69782F73746F72652F346B34346A61783230367661786C3137616A7261373771636C716A6D396C6C6E2D6B6D6F642D32352F62696E2F6D6F6470726F6265002D71002D2D0069707461626C655F66696C746572
machine# [ 5.106037] audit: type=1130 audit(1549188169.740:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-sysctl comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.139652] audit: type=1130 audit(1549188169.786:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-random-seed comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.160388] audit: type=1127 audit(1549188169.807:7): pid=445 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg=' comm="systemd-update-utmp" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd-update-utmp" hostname=? addr=? terminal=? res=success'
machine# [ 5.180639] audit: type=1325 audit(1549188169.817:8): table=filter family=10 entries=0
machine# [ 5.255974] kauditd_printk_skb: 5 callbacks suppressed
machine# [ 5.255975] audit: type=1130 audit(1549188169.902:12): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-update-done comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.346952] audit: type=1130 audit(1549188169.993:13): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-udev-trigger comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.467662] audit: type=1130 audit(1549188170.113:14): pid=1 uid=0 auid=4294967295 ses=4294967295 subj==unconfined msg='unit=systemd-journald comm="systemd" exe="/nix/store/7j4j6z5w6bpfj75krglxbma8wh78f6j3-systemd-239/lib/systemd/systemd" hostname=? addr=? terminal=? res=success'
machine# [ 5.479749] audit: type=1325 audit(1549188170.126:15): table=filter family=2 entries=4
machine# [ 5.481206] audit: type=1300 audit(1549188170.126:15): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=0 a2=40 a3=1c71900 items=0 ppid=438 pid=491 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="iptables" exe="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 5.500452] audit: type=1327 audit(1549188170.126:15): proctitle=69707461626C6573002D77002D4E006E69786F732D66772D616363657074
machine# [ 5.508434] audit: type=1325 audit(1549188170.151:16): table=filter family=10 entries=4
machine# [ 5.513576] audit: type=1300 audit(1549188170.151:16): arch=c000003e syscall=54 success=yes exit=0 a0=4 a1=29 a2=40 a3=1e1da20 items=0 ppid=438 pid=493 auid=4294967295 uid=0 gid=0 euid=0 suid=0 fsuid=0 egid=0 sgid=0 fsgid=0 tty=(none) ses=4294967295 comm="ip6tables" exe="/nix/store/xypia5js0vaymxp8i6kpyi35r8wh8v3g-iptables-1.6.2/bin/xtables-multi" subj==unconfined key=(null)
machine# [ 5.409287] systemd-modules-load[431]: Inserted module 'loop'
machine# [ 5.415314] systemd-modules-load[431]: Failed to find module 'gcov-proc'[ 5.533845] audit: type=1327 audit(1549188170.151:16): proctitle=6970367461626C6573002D77002D4E006E69786F732D66772D616363657074
machine#
machine# [ 5.425563] [ 5.541283] audit: type=1325 audit(1549188170.176:17): table=filter family=2 entries=6
machine# systemd[1]: Starting Flush Journal to Persistent Storage...
machine# [ 5.556775] systemd-journald[435]: Received request to flush runtime journal from PID 1
machine# [ 5.594859] systemd[1]: Started Flush Journal to Persistent Storage.
machine# [ 5.601783] systemd[1]: Starting Create Volatile Files and Directories...
machine# [ 5.642880] systemd[1]: Started Create Volatile Files and Directories.
machine# [ 5.774697] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
machine# [ 5.776401] ACPI: Power Button [PWRF]
machine# [ 5.852476] parport_pc 00:04: reported by Plug and Play ACPI
machine# [ 5.857482] parport0: PC-style at 0x378, irq 7 [PCSPP(,...)]
machine# [ 5.859631] Floppy drive(s): fd0 is 2.88M AMI BIOS
machine# [ 5.875734] FDC 0 is a S82078B
machine# [ 5.885254] Linux agpgart interface v0.103
machine# [ 5.959305] mousedev: PS/2 mouse device common for all mice
machine# [ 5.962981] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
machine# [ 6.032491] systemd[1]: Found device Virtio network device.
machine# [ 6.053021] systemd[1]: Found device /dev/ttyS0.
machine# [ 6.334540] [drm] Found bochs VGA, ID 0xb0c0.
machine# [ 6.335384] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000.
machine# [ 6.355527] [TTM] Zone kernel: Available graphics memory: 183960 kiB
machine# [ 6.356720] [TTM] Initializing pool allocator
machine# [ 6.363048] [TTM] Initializing DMA pool allocator
machine# [ 6.377824] fbcon: bochsdrmfb (fb0) is primary device
machine# [ 6.403609] Console: switching to colour frame buffer device 128x48
machine# [ 6.428642] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device
machine# [ 6.436082] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0
machine# [ 6.327483] systemd[1]: Found device /dev/hvc0.
machine# [ 6.335185] systemd[1]: Found device /dev/hvc1.
machine# [ 6.592631] ppdev: user-space parallel port driver
machine# [ 6.747026] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input4
machine# [ 6.689147] systemd[1]: Started Firewall.
machine# [ 6.691046] systemd[1]: Reached target Network (Pre).
machine# [ 6.845656] systemd[1]: Started udev Wait for Complete Device Initialization.
machine# [ 6.847581] systemd[1]: Reached target System Initialization.
machine# [ 6.852004] systemd[1]: Started Daily Cleanup of Temporary Directories.
machine# [ 6.855914] systemd[1]: Reached target Timers.
machine# [ 6.874460] systemd[1]: Listening on Nix Daemon Socket.
machine# [ 6.886881] systemd[1]: Listening on D-Bus System Message Bus Socket.
machine# [ 6.892925] systemd[1]: Reached target Sockets.
machine# [ 6.899171] systemd[1]: Reached target Basic System.
machine# [ 6.905472] systemd[1]: Starting Name Service Cache Daemon...
machine# [ 6.910166] 5ymg5n228x6apzwshzf4327ch49yv753-audit-disable[645]: No rules
machine# [ 6.916419] 8v5xqy84f881k6n4pp4gxaksri4w82qv-unit-script-network-link-eth1-start[647]: Configuring link...
machine# [ 6.924629] systemd[1]: Starting Address configuration of eth1...
machine# [ 6.933014] systemd[1]: Starting Kernel Auditing...
machine# [ 6.937207] dhcpcd[651]: dev: loaded udev
machine# [ 6.940378] 8v5xqy84f881k6n4pp4gxaksri4w82qv-unit-script-network-link-eth1-start[647]: bringing up interface... done
machine# [ 6.943786] systemd[1]: Started backdoor.service.
machine# [ 6.947321] w3p2xh2p7zdqmvjxmz8686f1pajls8lx-unit-script-network-addresses-eth1-start[644]: adding address 192.168.1.1/24... done
machine# [ 6.951461] systemd[1]: Starting Link configuration of eth1...
machine# [ 6.956199] systemd[1]: Starting DHCP Client...
machine# [ 7.078296] 8021q: 802.1Q VLAN Support v1.8
machine# [ 7.079542] 8021q: adding VLAN 0 to HW filter on device eth1
machine# [ 6.967128] systemd[1]: Started Kernel Auditing.
machine# [ 6.970473] systemd[1]: Started Link configuration of eth1.
machine# [ 6.974859] systemd[1]: Reached target All Network Interfaces (deprecated).
machine# [ 6.980033] nscd[670]: 670 monitoring file `/etc/passwd` (1)
machine# [ 6.986416] nscd[670]: 670 monitoring directory `/etc` (2)
machine# [ 6.990103] systemd[1]: Started Address configuration of eth1.
machine# [ 7.003644] nscd[670]: 670 monitoring file `/etc/group` (3)
machine# [ 7.017181] systemd[1]: Starting Networking Setup...
machine# [ 7.023892] nscd[670]: 670 monitoring directory `/etc` (2)
machine# [ 7.027310] nscd[670]: 670 monitoring file `/etc/hosts` (4)
machine# [ 7.044177] nscd[670]: 670 monitoring directory `/etc` (2)
machine# [ 7.051561] nscd[670]: 670 monitoring file `/etc/resolv.conf` (5)
machine# [ 7.060132] systemd[1]: Started D-Bus System Message Bus.
machine# [ 7.068907] nscd[670]: 670 monitoring directory `/etc` (2)
machine# [ 7.073388] systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
machine# [ 7.218591] cfg80211: Loading compiled-in X.509 certificates for regulatory database
machine# [ 7.266225] cfg80211: Loaded X.509 cert 'sforshee: 00b28ddf47aef9cea7'
machine# [ 7.268786] platform regulatory.0: Direct firmware load for regulatory.db failed with error -2
machine# [ 7.270379] cfg80211: failed to load regulatory.db
machine# [ 7.178473] dbus-daemon[679]: dbus[679]: Unknown username "systemd-timesync" in message bus configuration file
machine# connecting to host...
machine# [ 7.231820] systemd[1]: Started Networking Setup.
machine# [ 7.239251] systemd[1]: Starting Extra networking commands....
machine: connected to guest root shell
machine# [ 7.270246] systemd[1]: Started Extra networking commands..
machine# sh: cannot set terminal process group (-1): Inappropriate ioctl for device
machine# sh: no job control in this shell
machine# [ 7.289822] systemd[1]: Started Name Service Cache Daemon.
machine# [ 7.291100] systemd[1]: Reached target Host and Network Name Lookups.
machine# [ 7.296242] systemd[1]: Reached target User and Group Name Lookups.
machine# [ 7.301259] systemd[1]: Starting Login Service...
machine# [ 7.426649] 8021q: adding VLAN 0 to HW filter on device eth0
machine# [ 7.312813] dhcpcd[651]: eth0: waiting for carrier
machine# [ 7.316805] dhcpcd[651]: eth0: carrier acquired
machine# [ 7.329134] dhcpcd[651]: DUID 00:01:00:01:23:e9:78:cc:52:54:00:12:34:56
machine# [ 7.332294] dhcpcd[651]: eth0: IAID 00:12:34:56
machine# [ 7.334487] dhcpcd[651]: eth0: adding address fe80::5054:ff:fe12:3456
machine# [ 7.336848] dhcpcd[651]: eth0: soliciting an IPv6 router
machine# [ 7.386108] systemd-logind[749]: New seat seat0.
machine# [ 7.395834] systemd-logind[749]: Watching system buttons on /dev/input/event2 (Power Button)
machine# [ 7.398232] systemd-logind[749]: Watching system buttons on /dev/input/event0 (AT Translated Set 2 keyboard)
machine# [ 7.544046] systemd[1]: Started Login Service.
machine: exit status 0
machine: running command: systemctl list-jobs --full 2>&1
machine: exit status 0
machine# [ 7.736725] NET: Registered protocol family 17
machine# [ 7.624538] dhcpcd[651]: eth0: soliciting a DHCP lease
machine# [ 7.625752] dhcpcd[651]: eth0: offered 10.0.2.15 from 10.0.2.2
machine# [ 7.627184] dhcpcd[651]: eth0: leased 10.0.2.15 for 86400 seconds
machine# [ 7.629224] dhcpcd[651]: eth0: adding route to 10.0.2.0/24
machine# [ 7.631192] dhcpcd[651]: eth0: adding default route via 10.0.2.2
machine# [ 7.739404] nscd[670]: 670 monitored file `/etc/resolv.conf` was written to
machine# [ 7.805380] systemd[1]: Stopping Name Service Cache Daemon...
machine# [ 7.809335] systemd[1]: Stopped Name Service Cache Daemon.
machine# [ 7.813005] systemd[1]: Starting Name Service Cache Daemon...
machine# [ 7.895293] nscd[811]: 811 monitoring file `/etc/passwd` (1)
machine# [ 7.896572] nscd[811]: 811 monitoring directory `/etc` (2)
machine# [ 7.898641] nscd[811]: 811 monitoring file `/etc/group` (3)
machine# [ 7.901068] nscd[811]: 811 monitoring directory `/etc` (2)
machine# [ 7.903204] nscd[811]: 811 monitoring file `/etc/hosts` (4)
machine# [ 7.905832] nscd[811]: 811 monitoring directory `/etc` (2)
machine# [ 7.908126] nscd[811]: 811 monitoring file `/etc/resolv.conf` (5)
machine# [ 7.910433] nscd[811]: 811 monitoring directory `/etc` (2)
machine# [ 7.927144] dhcpcd[651]: Failed to try-reload-or-restart ntpd.service: Unit ntpd.service not found.
machine# [ 7.933524] dhcpcd[651]: Failed to try-reload-or-restart openntpd.service: Unit openntpd.service not found.
machine# [ 7.942450] dhcpcd[651]: Failed to try-reload-or-restart chronyd.service: Unit chronyd.service not found.
machine# [ 7.945791] systemd[1]: Started DHCP Client.
machine# [ 7.948005] dhcpcd[651]: forked to background, child pid 822
machine# [ 7.951197] systemd[1]: Reached target Network.
machine# [ 7.953703] systemd[1]: Starting Permit User Sessions...
machine# [ 7.956600] systemd[1]: Reached target Network is Online.
machine# [ 7.958859] systemd[1]: Started Name Service Cache Daemon.
machine# [ 8.017982] systemd[1]: Started Permit User Sessions.
machine# [ 8.019735] systemd[1]: Started Serial Getty on hvc1.
machine# [ 8.022207] systemd[1]: Started Getty on tty1.
machine# [ 8.028699] systemd[1]: Reached target Login Prompts.
machine# [ 8.034075] systemd[1]: Reached target Multi-User System.
machine# [ 8.036917] systemd[1]: Startup finished in 4.277s (kernel) + 3.745s (userspace) = 8.023s.
machine: running command: systemctl --no-pager show "multi-user.target"
machine: exit status 0
machine: must succeed: /nix/store/77dvnlmvzk92g2cmck6l3ighkvncfssh-reproduce-overlay-regression.sh 2>&1
machine# [ 8.879792] mkdir(work/work, 040000) = 0
machine# [ 8.880555] tmpfile(work/work, 0100000) = 0
machine# [ 8.881731] setxattr(work/work, "trusted.overlay.opaque", "0", 1, 0x0) = 0
machine# [ 8.824121] dhcpcd[822]: eth0: Router Advertisement from fe80::2
machine# [ 8.825629] dhcpcd[822]: eth0: adding address fec0::5054:ff:fe12:3456/64
machine# [ 8.827127] dhcpcd[822]: eth0: adding route to fec0::/64
machine# [ 8.828604] dhcpcd[822]: eth0: adding default route via fe80::2
machine# [ 19.096940] open(000000007ee735e6[/regular_top/l], 0100000) -> (0000000080f3d7f9, 00)
machine# [ 19.102029] open(00000000f7778f73[somesubdir/regular_sub/l], 0100000) -> (0000000080f3d7f9, 00)
machine: exit status 1
machine: output: ++ mktemp -d
+ tmp=/tmp/tmp.wZ1jG2MEkD
+ trap '
umount "$tmp/result"
find "$tmp" -depth -type d -exec rmdir {} +
' EXIT
+ mkdir /tmp/tmp.wZ1jG2MEkD/input /tmp/tmp.wZ1jG2MEkD/upper /tmp/tmp.wZ1jG2MEkD/work /tmp/tmp.wZ1jG2MEkD/result
+ drv=/nix/store/hjcziv6ycca3zdanaf2wb848jv0gl3jv-test-regular
+ mount -t overlay overlay /tmp/tmp.wZ1jG2MEkD/result -o lowerdir=/nix/store/hjcziv6ycca3zdanaf2wb848jv0gl3jv-test-regular,upperdir=/tmp/tmp.wZ1jG2MEkD/upper,workdir=/tmp/tmp.wZ1jG2MEkD/work
+ sync
+ sleep 10
+ strace -f stat /tmp/tmp.wZ1jG2MEkD/result/regular_top /tmp/tmp.wZ1jG2MEkD/result/somesubdir/regular_sub
execve("/run/current-system/sw/bin/stat", ["stat", "/tmp/tmp.wZ1jG2MEkD/result/regul"..., "/tmp/tmp.wZ1jG2MEkD/result/somes"...], 0x7ffe9f72a0a8 /* 37 vars */) = 0
brk(NULL) = 0x1d48000
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7eff5367b000
access("/etc/ld-nix.so.preload", R_OK) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib", {st_mode=S_IFDIR|0555, st_size=4096, ...}) = 0
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib", {st_mode=S_IFDIR|0555, st_size=4096, ...}) = 0
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib", {st_mode=S_IFDIR|0555, st_size=4096, ...}) = 0
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64", 0x7ffdb811d980) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 \"\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=41848, ...}) = 0
mmap(NULL, 2128384, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff53251000
mprotect(0x7eff53258000, 2093056, PROT_NONE) = 0
mmap(0x7eff53457000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x6000) = 0x7eff53457000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0pb\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=142424, ...}) = 0
mmap(NULL, 2220624, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff53032000
mprotect(0x7eff5304b000, 2097152, PROT_NONE) = 0
mmap(0x7eff5324b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x19000) = 0x7eff5324b000
mmap(0x7eff5324d000, 12880, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7eff5324d000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libacl.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\"\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0444, st_size=41032, ...}) = 0
mmap(NULL, 2130080, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff52e29000
mprotect(0x7eff52e31000, 2093056, PROT_NONE) = 0
mmap(0x7eff53030000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x7000) = 0x7eff53030000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libattr.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\200\25\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0444, st_size=26080, ...}) = 0
mmap(NULL, 2117656, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff52c23000
mprotect(0x7eff52c27000, 2097152, PROT_NONE) = 0
mmap(0x7eff52e27000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x4000) = 0x7eff52e27000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libcrypto.so.1.0.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libcrypto.so.1.0.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/libcrypto.so.1.0.0", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\22\7\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=2760792, ...}) = 0
mmap(NULL, 4613696, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff527bc000
mprotect(0x7eff529f9000, 2093056, PROT_NONE) = 0
mmap(0x7eff52bf8000, 159744, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x23c000) = 0x7eff52bf8000
mmap(0x7eff52c1f000, 13888, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7eff52c1f000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\34\2\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=2011288, ...}) = 0
mmap(NULL, 3881376, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff52408000
mprotect(0x7eff525b2000, 2097152, PROT_NONE) = 0
mmap(0x7eff527b2000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1aa000) = 0x7eff527b2000
mmap(0x7eff527b8000, 14752, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7eff527b8000
close(3) = 0
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7eff53679000
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`\16\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=18616, ...}) = 0
mmap(NULL, 2109584, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7eff52204000
mprotect(0x7eff52207000, 2093056, PROT_NONE) = 0
mmap(0x7eff52406000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x7eff52406000
close(3) = 0
mmap(NULL, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7eff53676000
arch_prctl(ARCH_SET_FS, 0x7eff53676740) = 0
mprotect(0x7eff527b2000, 16384, PROT_READ) = 0
mprotect(0x7eff52406000, 4096, PROT_READ) = 0
mprotect(0x7eff52bf8000, 114688, PROT_READ) = 0
mprotect(0x7eff52e27000, 4096, PROT_READ) = 0
mprotect(0x7eff53030000, 4096, PROT_READ) = 0
mprotect(0x7eff5324b000, 4096, PROT_READ) = 0
mprotect(0x7eff53457000, 4096, PROT_READ) = 0
mprotect(0x75d000, 45056, PROT_READ) = 0
mprotect(0x7eff5367d000, 4096, PROT_READ) = 0
set_tid_address(0x7eff53676a10) = 845
set_robust_list(0x7eff53676a20, 24) = 0
rt_sigaction(SIGRTMIN, {sa_handler=0x7eff53037cf0, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7eff53043f10}, NULL, 8) = 0
rt_sigaction(SIGRT_1, {sa_handler=0x7eff53037d80, sa_mask=[], sa_flags=SA_RESTORER|SA_RESTART|SA_SIGINFO, sa_restorer=0x7eff53043f10}, NULL, 8) = 0
rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0
prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
prctl(PR_SET_NAME, "stat") = 0
prctl(PR_SET_KEEPCAPS, 140727691641469) = -1 EINVAL (Invalid argument)
brk(NULL) = 0x1d48000
brk(0x1d69000) = 0x1d69000
openat(AT_FDCWD, "/run/current-system/sw/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0444, st_size=126969360, ...}) = 0
mmap(NULL, 126969360, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7eff4a8ed000
close(3) = 0
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/locale.alias", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0444, st_size=2997, ...}) = 0
read(3, "# Locale name alias data base.\n#"..., 8192) = 2997
read(3, "", 8192) = 0
close(3) = 0
openat(AT_FDCWD, "/nix/store/780lziw5g6lfrw2ddaxf6s1f0gq60r89-coreutils-8.30/share/locale/en_US.UTF-8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/780lziw5g6lfrw2ddaxf6s1f0gq60r89-coreutils-8.30/share/locale/en_US.utf8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/780lziw5g6lfrw2ddaxf6s1f0gq60r89-coreutils-8.30/share/locale/en_US/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/780lziw5g6lfrw2ddaxf6s1f0gq60r89-coreutils-8.30/share/locale/en.UTF-8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/780lziw5g6lfrw2ddaxf6s1f0gq60r89-coreutils-8.30/share/locale/en.utf8/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/780lziw5g6lfrw2ddaxf6s1f0gq60r89-coreutils-8.30/share/locale/en/LC_MESSAGES/coreutils.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
lstat("/tmp/tmp.wZ1jG2MEkD/result/regular_top", {st_mode=S_IFREG|0444, st_size=30, ...}) = 0
fstat(1, {st_mode=S_IFCHR|0600, st_rdev=makedev(229, 0), ...}) = 0
ioctl(1, TCGETS, {B38400 -opost -isig -icanon -echo ...}) = 0
write(1, " File: /tmp/tmp.wZ1jG2MEkD/resu"..., 47 File: /tmp/tmp.wZ1jG2MEkD/result/regular_top
) = 47
write(1, " Size: 30 \tBlocks: 8 "..., 68 Size: 30 Blocks: 8 IO Block: 8192 regular file
) = 68
write(1, "Device: 2dh/45d\tInode: 6377034 "..., 44Device: 2dh/45d Inode: 6377034 Links: 1
) = 44
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = 0
sendto(3, "\2\0\0\0\v\0\0\0\7\0\0\0passwd\0", 19, MSG_NOSIGNAL, NULL, 0) = 19
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 5000) = 1 ([{fd=3, revents=POLLIN|POLLHUP}])
recvmsg(3, {msg_name=NULL, msg_namelen=0, msg_iov=[{iov_base="passwd\0", iov_len=7}, {iov_base="\310O\3\0\0\0\0\0", iov_len=8}], msg_iovlen=2, msg_control=[{cmsg_len=20, cmsg_level=SOL_SOCKET, cmsg_type=SCM_RIGHTS, cmsg_data=[4]}], msg_controllen=20, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 15
mmap(NULL, 217032, PROT_READ, MAP_SHARED, 4, 0) = 0x7eff53641000
close(4) = 0
close(3) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = 0
sendto(3, "\2\0\0\0\f\0\0\0\6\0\0\0group\0", 18, MSG_NOSIGNAL, NULL, 0) = 18
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 5000) = 1 ([{fd=3, revents=POLLIN|POLLHUP}])
recvmsg(3, {msg_name=NULL, msg_namelen=0, msg_iov=[{iov_base="group\0", iov_len=6}, {iov_base="\310O\3\0\0\0\0\0", iov_len=8}], msg_iovlen=2, msg_control=[{cmsg_len=20, cmsg_level=SOL_SOCKET, cmsg_type=SCM_RIGHTS, cmsg_data=[4]}], msg_controllen=20, msg_flags=MSG_CMSG_CLOEXEC}, MSG_CMSG_CLOEXEC) = 14
mmap(NULL, 217032, PROT_READ, MAP_SHARED, 4, 0) = 0x7eff5360c000
close(4) = 0
close(3) = 0
socket(AF_UNIX, SOCK_STREAM|SOCK_CLOEXEC|SOCK_NONBLOCK, 0) = 3
connect(3, {sa_family=AF_UNIX, sun_path="/var/run/nscd/socket"}, 110) = 0
sendto(3, "\2\0\0\0\3\0\0\0\2\0\0\0000\0", 14, MSG_NOSIGNAL, NULL, 0) = 14
poll([{fd=3, events=POLLIN|POLLERR|POLLHUP}], 1, 5000) = 1 ([{fd=3, revents=POLLIN|POLLHUP}])
read(3, "\2\0\0\0\1\0\0\0\5\0\0\0\2\0\0\0\0\0\0\0\0\0\0\0", 24) = 24
read(3, "root\0x\0", 7) = 7
close(3) = 0
write(1, "Access: (0444/-r--r--r--) Uid: "..., 73Access: (0444/-r--r--r--) Uid: ( 0/ root) Gid: ( 0/ root)
) = 73
openat(AT_FDCWD, "/etc/localtime", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
write(1, "Access: 2019-02-03 10:02:43.0000"..., 44Access: 2019-02-03 10:02:43.000000000 +0000
) = 44
write(1, "Modify: 1970-01-01 00:00:01.0000"..., 44Modify: 1970-01-01 00:00:01.000000000 +0000
) = 44
write(1, "Change: 2019-02-03 10:02:43.8781"..., 44Change: 2019-02-03 10:02:43.878116994 +0000
) = 44
write(1, " Birth: -\n", 10 Birth: -
) = 10
lstat("/tmp/tmp.wZ1jG2MEkD/result/somesubdir/regular_sub", {st_mode=S_IFREG|0444, st_size=23, ...}) = 0
write(1, " File: /tmp/tmp.wZ1jG2MEkD/resu"..., 58 File: /tmp/tmp.wZ1jG2MEkD/result/somesubdir/regular_sub
) = 58
write(1, " Size: 23 \tBlocks: 8 "..., 68 Size: 23 Blocks: 8 IO Block: 8192 regular file
) = 68
write(1, "Device: 2dh/45d\tInode: 6377036 "..., 44Device: 2dh/45d Inode: 6377036 Links: 1
) = 44
write(1, "Access: (0444/-r--r--r--) Uid: "..., 73Access: (0444/-r--r--r--) Uid: ( 0/ root) Gid: ( 0/ root)
) = 73
write(1, "Access: 2019-02-03 10:02:43.0000"..., 44Access: 2019-02-03 10:02:43.000000000 +0000
) = 44
write(1, "Modify: 1970-01-01 00:00:01.0000"..., 44Modify: 1970-01-01 00:00:01.000000000 +0000
) = 44
write(1, "Change: 2019-02-03 10:02:43.8781"..., 44Change: 2019-02-03 10:02:43.878116994 +0000
) = 44
write(1, " Birth: -\n", 10 Birth: -
) = 10
close(1) = 0
close(2) = 0
exit_group(0) = ?
+++ exited with 0 +++
+ strace -f cat /tmp/tmp.wZ1jG2MEkD/result/regular_top /tmp/tmp.wZ1jG2MEkD/result/somesubdir/regular_sub
execve("/run/current-system/sw/bin/cat", ["cat", "/tmp/tmp.wZ1jG2MEkD/result/regul"..., "/tmp/tmp.wZ1jG2MEkD/result/somes"...], 0x7ffea21d72f8 /* 37 vars */) = 0
brk(NULL) = 0x1a05000
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f648aeb6000
access("/etc/ld-nix.so.preload", R_OK) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/tls", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib", {st_mode=S_IFDIR|0555, st_size=4096, ...}) = 0
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/tls", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib", {st_mode=S_IFDIR|0555, st_size=4096, ...}) = 0
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/tls", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib", {st_mode=S_IFDIR|0555, st_size=4096, ...}) = 0
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/tls", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64/librt.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
stat("/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/x86_64", 0x7ffc27570b40) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/librt.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0 \"\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=41848, ...}) = 0
mmap(NULL, 2128384, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f648aa8c000
mprotect(0x7f648aa93000, 2093056, PROT_NONE) = 0
mmap(0x7f648ac92000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x6000) = 0x7f648ac92000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/libpthread.so.0", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0pb\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=142424, ...}) = 0
mmap(NULL, 2220624, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f648a86d000
mprotect(0x7f648a886000, 2097152, PROT_NONE) = 0
mmap(0x7f648aa86000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x19000) = 0x7f648aa86000
mmap(0x7f648aa88000, 12880, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f648aa88000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libacl.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\220\"\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0444, st_size=41032, ...}) = 0
mmap(NULL, 2130080, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f648a664000
mprotect(0x7f648a66c000, 2093056, PROT_NONE) = 0
mmap(0x7f648a86b000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x7000) = 0x7f648a86b000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libattr.so.1", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libattr.so.1", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\200\25\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0444, st_size=26080, ...}) = 0
mmap(NULL, 2117656, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f648a45e000
mprotect(0x7f648a462000, 2097152, PROT_NONE) = 0
mmap(0x7f648a662000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x4000) = 0x7f648a662000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libcrypto.so.1.0.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libcrypto.so.1.0.0", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/libcrypto.so.1.0.0", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\0\22\7\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=2760792, ...}) = 0
mmap(NULL, 4613696, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f6489ff7000
mprotect(0x7f648a234000, 2093056, PROT_NONE) = 0
mmap(0x7f648a433000, 159744, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x23c000) = 0x7f648a433000
mmap(0x7f648a45a000, 13888, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f648a45a000
close(3) = 0
openat(AT_FDCWD, "/nix/store/wq64r8c06syvr0wdhal6vp70x1ysfqx9-acl-2.2.52/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/p2yifhj4x6ca2zbqf588d4ys05hsnk4z-attr-2.4.47/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/dxjv6jxd59dld0rpvxix4k55p5cfxhsr-openssl-1.0.2p/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/libc.so.6", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\3\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0\260\34\2\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=2011288, ...}) = 0
mmap(NULL, 3881376, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f6489c43000
mprotect(0x7f6489ded000, 2097152, PROT_NONE) = 0
mmap(0x7f6489fed000, 24576, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x1aa000) = 0x7f6489fed000
mmap(0x7f6489ff3000, 14752, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_ANONYMOUS, -1, 0) = 0x7f6489ff3000
close(3) = 0
mmap(NULL, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f648aeb4000
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/lib/libdl.so.2", O_RDONLY|O_CLOEXEC) = 3
read(3, "\177ELF\2\1\1\0\0\0\0\0\0\0\0\0\3\0>\0\1\0\0\0`\16\0\0\0\0\0\0"..., 832) = 832
fstat(3, {st_mode=S_IFREG|0555, st_size=18616, ...}) = 0
mmap(NULL, 2109584, PROT_READ|PROT_EXEC, MAP_PRIVATE|MAP_DENYWRITE, 3, 0) = 0x7f6489a3f000
mprotect(0x7f6489a42000, 2093056, PROT_NONE) = 0
mmap(0x7f6489c41000, 8192, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_FIXED|MAP_DENYWRITE, 3, 0x2000) = 0x7f6489c41000
close(3) = 0
mmap(NULL, 12288, PROT_READ|PROT_WRITE, MAP_PRIVATE|MAP_ANONYMOUS, -1, 0) = 0x7f648aeb1000
arch_prctl(ARCH_SET_FS, 0x7f648aeb1740) = 0
mprotect(0x7f6489fed000, 16384, PROT_READ) = 0
mprotect(0x7f6489c41000, 4096, PROT_READ) = 0
mprotect(0x7f648a433000, 114688, PROT_READ) = 0
mprotect(0x7f648a662000, 4096, PROT_READ) = 0
mprotect(0x7f648a86b000, 4096, PROT_READ) = 0
mprotect(0x7f648aa86000, 4096, PROT_READ) = 0
mprotect(0x7f648ac92000, 4096, PROT_READ) = 0
mprotect(0x75d000, 45056, PROT_READ) = 0
mprotect(0x7f648aeb8000, 4096, PROT_READ) = 0
set_tid_address(0x7f648aeb1a10) = 848
set_robust_list(0x7f648aeb1a20, 24) = 0
rt_sigaction(SIGRTMIN, {sa_handler=0x7f648a872cf0, sa_mask=[], sa_flags=SA_RESTORER|SA_SIGINFO, sa_restorer=0x7f648a87ef10}, NULL, 8) = 0
rt_sigaction(SIGRT_1, {sa_handler=0x7f648a872d80, sa_mask=[], sa_flags=SA_RESTORER|SA_RESTART|SA_SIGINFO, sa_restorer=0x7f648a87ef10}, NULL, 8) = 0
rt_sigprocmask(SIG_UNBLOCK, [RTMIN RT_1], NULL, 8) = 0
prlimit64(0, RLIMIT_STACK, NULL, {rlim_cur=8192*1024, rlim_max=RLIM64_INFINITY}) = 0
prctl(PR_SET_NAME, "cat") = 0
prctl(PR_SET_KEEPCAPS, 140720968508031) = -1 EINVAL (Invalid argument)
brk(NULL) = 0x1a05000
brk(0x1a26000) = 0x1a26000
openat(AT_FDCWD, "/run/current-system/sw/lib/locale/locale-archive", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0444, st_size=126969360, ...}) = 0
mmap(NULL, 126969360, PROT_READ, MAP_PRIVATE, 3, 0) = 0x7f6482128000
close(3) = 0
fstat(1, {st_mode=S_IFCHR|0600, st_rdev=makedev(229, 0), ...}) = 0
openat(AT_FDCWD, "/tmp/tmp.wZ1jG2MEkD/result/regular_top", O_RDONLY) = -1 EPERM (Operation not permitted)
write(2, "cat: ", 5cat: ) = 5
write(2, "/tmp/tmp.wZ1jG2MEkD/result/regul"..., 38/tmp/tmp.wZ1jG2MEkD/result/regular_top) = 38
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/locale.alias", O_RDONLY|O_CLOEXEC) = 3
fstat(3, {st_mode=S_IFREG|0444, st_size=2997, ...}) = 0
read(3, "# Locale name alias data base.\n#"..., 8192) = 2997
read(3, "", 8192) = 0
close(3) = 0
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en_US.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en_US.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en_US/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en.UTF-8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en.utf8/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
openat(AT_FDCWD, "/nix/store/mrfcv8ipiksfdrx3xq7dvcrzgg2jdfsw-glibc-2.27/share/locale/en/LC_MESSAGES/libc.mo", O_RDONLY) = -1 ENOENT (No such file or directory)
write(2, ": Operation not permitted", 25: Operation not permitted) = 25
write(2, "\n", 1
) = 1
openat(AT_FDCWD, "/tmp/tmp.wZ1jG2MEkD/result/somesubdir/regular_sub", O_RDONLY) = -1 EPERM (Operation not permitted)
write(2, "cat: ", 5cat: ) = 5
write(2, "/tmp/tmp.wZ1jG2MEkD/result/somes"..., 49/tmp/tmp.wZ1jG2MEkD/result/somesubdir/regular_sub) = 49
write(2, ": Operation not permitted", 25: Operation not permitted) = 25
write(2, "\n", 1
) = 1
close(1) = 0
close(2) = 0
exit_group(1) = ?
+++ exited with 1 +++
+ umount /tmp/tmp.wZ1jG2MEkD/result
+ find /tmp/tmp.wZ1jG2MEkD -depth -type d -exec rmdir '{}' +
error: command `/nix/store/77dvnlmvzk92g2cmck6l3ighkvncfssh-reproduce-overlay-regression.sh 2>&1' did not succeed (exit code 1)
command `/nix/store/77dvnlmvzk92g2cmck6l3ighkvncfssh-reproduce-overlay-regression.sh 2>&1' did not succeed (exit code 1)
cleaning up
killing machine (pid 600)
vde_switch: EOF on stdin, cleaning up and exiting
vde_switch: Could not remove ctl dir '/build/vde1.ctl': Directory not empty
builder for '/nix/store/2sklkal8cczvl4zs0kcbbjfdw503pfsi-vm-test-run-overlayfs-linux-4.19-regression.drv' failed with exit code 255
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment