Help
Invalid job definition:

extra keys not allowed @ data['actions[0]']['deploy']['tmpfs']['root_partition']

Description
[lavafed 2020.09.0034.g6f5ba14a3] qemu - health-check
Device-type
qemu
Submitter
Rémi Duraffort
Created
1 week ago
Priority
Medium
Visibility
Public
Required Tags
staging.validation.linaro.org
#3187
Complete
Device
staging-qemu01@staging.validation.linaro.org
Started
1 week ago
Duration
1 minute
Results
  
lava-dispatcher, installed at version: 2020.09.0034.g6f5ba14a3 start: 0 validate Start time: 2020-10-16 10:00:25.605280+00:00 (UTC) Validating that http://images.validation.linaro.org/kvm/standard/large-stretch-2.img.gz exists qemu-system-x86, installed at version: 1:3.1+dfsg-8+deb10u8, host architecture: amd64 validate duration: 0.11 case: validate
case_id: 60875
definition: lava
result: pass
start: 1 deployimages (timeout 00:06:00) [common] start: 1.1 download-retry (timeout 00:06:00) [common] start: 1.1.1 http-download (timeout 00:06:00) [common] downloading http://images.validation.linaro.org/kvm/standard/large-stretch-2.img.gz saving as /var/lib/lava/dispatcher/tmp/lavafed-3187/deployimages-v4wf_p42/rootfs/large-stretch-2.img total size: 183193985 (174MB) Using gunzip to decompress gz progress 0% (0MB) progress 5% (8MB) progress 10% (17MB) progress 15% (26MB) progress 20% (34MB) progress 25% (43MB) progress 30% (52MB) progress 35% (61MB) progress 40% (69MB) progress 45% (78MB) progress 50% (87MB) progress 55% (96MB) progress 60% (104MB) progress 65% (113MB) progress 70% (122MB) progress 75% (131MB) progress 80% (139MB) progress 85% (148MB) progress 90% (157MB) progress 95% (166MB) progress 100% (174MB) 174MB downloaded in 29.58s (5.91MB/s) end: 1.1.1 http-download (duration 00:00:30) [common] case: http-download
case_id: 60877
definition: lava
duration: 29.58
extra: ...
level: 1.1.1
namespace: common
result: pass
end: 1.1 download-retry (duration 00:00:30) [common] start: 1.2 lava-overlay (timeout 00:05:30) [common] [common] Preparing overlay tarball in /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar makedir: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin makedir: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/tests makedir: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/results Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-add-keys Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-add-sources Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-background-process-start Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-background-process-stop Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-common-functions Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-echo-ipv4 Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-install-packages Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-installed-packages Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-os-build Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-probe-channel Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-probe-ip Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-target-ip Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-target-mac Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-target-storage Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-case Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-event Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-feedback Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-raise Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-reference Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-runner Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-set Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-test-shell Updating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-add-keys (debian) Updating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-add-sources (debian) Updating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-install-packages (debian) Updating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-installed-packages (debian) Updating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/bin/lava-os-build (debian) Creating /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/environment LAVA metadata - LAVA_JOB_ID=3187 start: 1.2.1 lava-vland-overlay (timeout 00:05:30) [common] skipped lava-vland-overlay end: 1.2.1 lava-vland-overlay (duration 00:00:00) [common] start: 1.2.2 lava-multinode-overlay (timeout 00:05:30) [common] skipped lava-multinode-overlay end: 1.2.2 lava-multinode-overlay (duration 00:00:00) [common] start: 1.2.3 test-definition (timeout 00:05:30) [common] Loading test definitions start: 1.2.3.1 inline-repo-action (timeout 00:05:30) [common] Using /lava-3187 at stage 0 uuid=3187_1.2.3.1 testdef=None end: 1.2.3.1 inline-repo-action (duration 00:00:00) [common] start: 1.2.3.2 test-overlay (timeout 00:05:30) [common] end: 1.2.3.2 test-overlay (duration 00:00:00) [common] case: test-overlay
case_id: 60878
definition: lava
duration: 0.00
extra: ...
level: 1.2.3.2
namespace: common
result: pass
start: 1.2.3.3 test-install-overlay (timeout 00:05:30) [common] end: 1.2.3.3 test-install-overlay (duration 00:00:00) [common] case: test-install-overlay
case_id: 60879
definition: lava
duration: 0.02
extra: ...
level: 1.2.3.3
namespace: common
result: pass
start: 1.2.3.4 test-runscript-overlay (timeout 00:05:30) [common] runner path: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/0_env-dut-inline test_uuid 3187_1.2.3.1 end: 1.2.3.4 test-runscript-overlay (duration 00:00:00) [common] case: test-runscript-overlay
case_id: 60880
definition: lava
duration: 0.04
extra: ...
level: 1.2.3.4
namespace: common
result: pass
start: 1.2.3.5 git-repo-action (timeout 00:05:30) [common] Using /lava-3187 at stage 0 Fetching tests from http://git.linaro.org/lava-team/lava-functional-tests.git Running '/usr/bin/git clone http://git.linaro.org/lava-team/lava-functional-tests.git /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/1_smoke-tests --depth=1' Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/1_smoke-tests/lava-test-shell/smoke-tests-basic.yaml uuid=3187_1.2.3.5 testdef=None end: 1.2.3.5 git-repo-action (duration 00:00:00) [common] case: git-repo-action
case_id: 60881
definition: lava
duration: 0.30
extra: ...
level: 1.2.3.5
namespace: common
result: pass
start: 1.2.3.6 test-overlay (timeout 00:05:30) [common] end: 1.2.3.6 test-overlay (duration 00:00:00) [common] case: test-overlay
case_id: 60878
definition: lava
duration: 0.00
extra: ...
level: 1.2.3.6
namespace: common
result: pass
start: 1.2.3.7 test-install-overlay (timeout 00:05:30) [common] end: 1.2.3.7 test-install-overlay (duration 00:00:00) [common] case: test-install-overlay
case_id: 60879
definition: lava
duration: 0.06
extra: ...
level: 1.2.3.7
namespace: common
result: pass
start: 1.2.3.8 test-runscript-overlay (timeout 00:05:30) [common] runner path: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/1_smoke-tests test_uuid 3187_1.2.3.5 end: 1.2.3.8 test-runscript-overlay (duration 00:00:00) [common] case: test-runscript-overlay
case_id: 60880
definition: lava
duration: 0.05
extra: ...
level: 1.2.3.8
namespace: common
result: pass
start: 1.2.3.9 git-repo-action (timeout 00:05:30) [common] Using /lava-3187 at stage 0 Fetching tests from http://git.linaro.org/lava-team/lava-functional-tests.git Running '/usr/bin/git clone http://git.linaro.org/lava-team/lava-functional-tests.git /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/2_singlenode-advanced --depth=1' Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/2_singlenode-advanced/lava-test-shell/single-node/singlenode03.yaml uuid=3187_1.2.3.9 testdef=None end: 1.2.3.9 git-repo-action (duration 00:00:00) [common] case: git-repo-action
case_id: 60881
definition: lava
duration: 0.25
extra: ...
level: 1.2.3.9
namespace: common
result: pass
start: 1.2.3.10 test-overlay (timeout 00:05:30) [common] end: 1.2.3.10 test-overlay (duration 00:00:00) [common] case: test-overlay
case_id: 60878
definition: lava
duration: 0.00
extra: ...
level: 1.2.3.10
namespace: common
result: pass
start: 1.2.3.11 test-install-overlay (timeout 00:05:30) [common] end: 1.2.3.11 test-install-overlay (duration 00:00:00) [common] case: test-install-overlay
case_id: 60879
definition: lava
duration: 0.02
extra: ...
level: 1.2.3.11
namespace: common
result: pass
start: 1.2.3.12 test-runscript-overlay (timeout 00:05:30) [common] runner path: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0/tests/2_singlenode-advanced test_uuid 3187_1.2.3.9 end: 1.2.3.12 test-runscript-overlay (duration 00:00:00) [common] case: test-runscript-overlay
case_id: 60880
definition: lava
duration: 0.03
extra: ...
level: 1.2.3.12
namespace: common
result: pass
Creating lava-test-runner.conf files Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/lavafed-3187/lava-overlay-8djpomar/lava-3187/0 for stage 0 - 0_env-dut-inline - 1_smoke-tests - 2_singlenode-advanced end: 1.2.3 test-definition (duration 00:00:01) [common] start: 1.2.4 compress-overlay (timeout 00:05:30) [common] end: 1.2.4 compress-overlay (duration 00:00:00) [common] start: 1.2.5 persistent-nfs-overlay (timeout 00:05:29) [common] end: 1.2.5 persistent-nfs-overlay (duration 00:00:00) [common] end: 1.2 lava-overlay (duration 00:00:01) [common] start: 1.3 apply-overlay-guest (timeout 00:05:29) [common] Overlay: /var/lib/lava/dispatcher/tmp/lavafed-3187/compress-overlay-qsxs6b2u/overlay-1.2.4.tar.gz end: 1.3 apply-overlay-guest (duration 00:00:30) [common] case: apply-overlay-guest
case_id: 60891
definition: lava
duration: 29.71
extra: ...
level: 1.3
namespace: common
result: pass
start: 1.4 deploy-device-env (timeout 00:05:00) [common] end: 1.4 deploy-device-env (duration 00:00:00) [common] end: 1 deployimages (duration 00:01:00) [common] start: 2 boot-image-retry (timeout 00:02:00) [common] start: 2.1 boot-qemu-image (timeout 00:02:00) [common] start: 2.1.1 execute-qemu (timeout 00:02:00) [common] Extending command line for qcow2 test overlay Boot command: /usr/bin/qemu-system-x86_64 -cpu host -enable-kvm -nographic -net nic,model=virtio,macaddr=DE:AD:BE:EF:32:01 -net tap -m 1024 -monitor none -drive format=raw,file=/var/lib/lava/dispatcher/tmp/lavafed-3187/deployimages-v4wf_p42/rootfs/large-stretch-2.img -drive format=qcow2,file=/var/lib/lava/dispatcher/tmp/lavafed-3187/apply-overlay-guest-y3b6udg2/lava-guest.qcow2,media=disk,if=ide,id=lavatest started a shell command end: 2.1.1 execute-qemu (duration 00:00:01) [common] case: execute-qemu
case_id: 60892
definition: lava
duration: 0.95
extra: ...
level: 2.1.1
namespace: common
result: pass
end: 2.1 boot-qemu-image (duration 00:00:01) [common] start: 2.2 auto-login-action (timeout 00:01:59) [common] Setting prompt string to ['Linux version [0-9]'] auto-login-action: Wait for prompt ['Linux version [0-9]'] (timeout 00:02:00) W: /etc/qemu-ifup: no bridge for guest interface found c[?7l[2J[0mSeaBIOS (version 1.12.0-1) iPXE (http://ipxe.org) 00:03.0 C980 PCI2.10 PnP PMM+3FF90020+3FED0020 C980 Press Ctrl-B to configure iPXE (PCI 00:03.0)... Booting from Hard Disk... error: terminal `gfxterm' isn't found[H[J[1;1H. [?25l[m[H[J[1;1H[2;26HGNU GRUB version 2.02~beta3-1 [m[4;2H+----------------------------------------------------------------------------+[5;2H|[5;79H|[6;2H|[6;79H|[7;2H|[7;79H|[8;2H|[8;79H|[9;2H|[9;79H|[10;2H|[10;79H|[11;2H|[11;79H|[12;2H|[12;79H|[13;2H|[13;79H|[14;2H|[14;79H|[15;2H|[15;79H|[16;2H|[16;79H|[17;2H+----------------------------------------------------------------------------+[m[18;2H[19;2H[m Use the ^ and v keys to select which entry is highlighted. Press enter to boot the selected OS, `e' to edit the commands before booting or `c' for a command-line. [5;80H [7m[5;3H*Debian GNU/Linux [m[5;78H[m[m[6;3H Advanced options for Debian GNU/Linux [m[6;78H[m[m[7;3H [m[7;78H[m[m[8;3H [m[8;78H[m[m[9;3H [m[9;78H[m[m[10;3H [m[10;78H[m[m[11;3H [m[11;78H[m[m[12;3H [m[12;78H[m[m[13;3H [m[13;78H[m[m[14;3H [m[14;78H[m[m[15;3H [m[15;78H[m[m[16;3H [m[16;78H[m[16;80H [5;78H[22;1H The highlighted entry will be executed automatically in 5s. [5;78H[22;1H The highlighted entry will be executed automatically in 4s. [5;78H[22;1H The highlighted entry will be executed automatically in 3s. [5;78H[22;1H The highlighted entry will be executed automatically in 2s. [5;78H[22;1H The highlighted entry will be executed automatically in 1s. [5;78H[22;1H The highlighted entry will be executed automatically in 0s. [5;78H[?25h[H[J[1;1H[H[J[1;1HLoading Linux 4.7.0-1-amd64 ... Loading initial ramdisk ... start: 2.2.1 login-action (timeout 00:01:50) [common] Setting prompt string to ['-+\\[ cut here \\]-+\\s+(.*\\s+-+\\[ end trace (\\w*) \\]-+)', '(Unhandled fault.*)\\r\\n', 'Kernel panic - (.*) end Kernel panic', 'Stack:\\s+(.*\\s+-+\\[ end trace (\\w*) \\]-+)'] Using line separator: #'\n'# Waiting for the login prompt Parsing kernel messages ['-+\\[ cut here \\]-+\\s+(.*\\s+-+\\[ end trace (\\w*) \\]-+)', '(Unhandled fault.*)\\r\\n', 'Kernel panic - (.*) end Kernel panic', 'Stack:\\s+(.*\\s+-+\\[ end trace (\\w*) \\]-+)', 'root@debian:', 'login:', 'Login incorrect'] [login-action] Waiting for messages, (timeout 00:01:50) [ 0.000000] Linux version 4.7.0-1-amd64 (debian-kernel@lists.debian.org) (gcc version 5.4.1 20160904 (Debian 5.4.1-2) ) #1 SMP Debian 4.7.8-1 (2016-10-19) [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.7.0-1-amd64 root=UUID=ff100147-ab71-4be8-81d0-660b5a54911d ro console=tty0 console=tty1 console=ttyS0,38400n8 [ 0.000000] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 [ 0.000000] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' [ 0.000000] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' [ 0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. [ 0.000000] x86/fpu: Using 'eager' FPU context switches. [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffdffff] usable [ 0.000000] BIOS-e820: [mem 0x000000003ffe0000-0x000000003fffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.8 present. [ 0.000000] Hypervisor detected: KVM [ 0.000000] e820: last_pfn = 0x3ffe0 max_arch_pfn = 0x400000000 [ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- WT [ 0.000000] found SMP MP-table at [mem 0x000f5aa0-0x000f5aaf] mapped at [ffff8800000f5aa0] [ 0.000000] Using GB pages for direct mapping [ 0.000000] RAMDISK: [mem 0x36093000-0x37040fff] [ 0.000000] ACPI: Early table checksum verification disabled [ 0.000000] ACPI: RSDP 0x00000000000F58D0 000014 (v00 BOCHS ) [ 0.000000] ACPI: RSDT 0x000000003FFE156F 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACP 0x000000003FFE144B 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) [ 0.000000] ACPI: DSDT 0x000000003FFE0040 00140B (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) [ 0.000000] ACPI: FACS 0x000000003FFE0000 000040 [ 0.000000] ACPI: APIC 0x000000003FFE14BF 000078 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) [ 0.000000] ACPI: HPET 0x000000003FFE1537 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000003ffdffff] [ 0.000000] NODE_DATA(0) allocated [mem 0x3ffdb000-0x3ffdffff] [ 0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 [ 0.000000] kvm-clock: cpu 0, msr 0:3ffd3001, primary cpu clock [ 0.000000] kvm-clock: using sched offset of 8519944340 cycles [ 0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff] [ 0.000000] DMA32 [mem 0x0000000001000000-0x000000003ffdffff] [ 0.000000] Normal empty [ 0.000000] Device empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff] [ 0.000000] node 0: [mem 0x0000000000100000-0x000000003ffdffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffdffff] [ 0.000000] ACPI: PM-Timer IO Port: 0x608 [ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) [ 0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) [ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) [ 0.000000] Using ACPI (MADT) for SMP configuration information [ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000 [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] [ 0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] [ 0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] [ 0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] [ 0.000000] e820: [mem 0x40000000-0xfeffbfff] available for PCI devices [ 0.000000] Booting paravirtualized kernel on KVM [ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns [ 0.000000] setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] percpu: Embedded 33 pages/cpu @ffff88003fc00000 s98264 r8192 d28712 u2097152 [ 0.000000] KVM setup async PF for cpu 0 [ 0.000000] kvm-stealtime: cpu 0, msr 3fc0d9c0 [ 0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes) [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257897 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.7.0-1-amd64 root=UUID=ff100147-ab71-4be8-81d0-660b5a54911d ro console=tty0 console=tty1 console=ttyS0,38400n8 [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Memory: 1001540K/1048056K available (6019K kernel code, 1099K rwdata, 2788K rodata, 1352K init, 800K bss, 46516K reserved, 0K cma-reserved) [ 0.000000] Hierarchical RCU implementation. [ 0.000000] Build-time adjustment of leaf fanout to 64. [ 0.000000] RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=1. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=1 [ 0.000000] NR_IRQS:33024 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] console [ttyS0] enabled [ 0.000000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns [ 0.000000] tsc: Detected 1598.148 MHz processor [ 0.304203] Calibrating delay loop (skipped) preset value.. 3196.29 BogoMIPS (lpj=6392592) [ 0.308088] pid_max: default: 32768 minimum: 301 [ 0.310163] ACPI: Core revision 20160422 [ 0.313490] ACPI: 1 ACPI AML tables successfully acquired and loaded [ 0.316392] [ 0.317496] Security Framework initialized [ 0.319448] Yama: disabled by default; enable with sysctl kernel.yama.* [ 0.322194] AppArmor: AppArmor disabled by boot time parameter [ 0.324826] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.328023] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.331284] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.334071] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes) [ 0.337342] CPU: Physical Processor ID: 0 [ 0.339309] mce: CPU supports 10 MCE banks [ 0.341284] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 [ 0.343619] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 [ 0.370794] Freeing SMP alternatives memory: 24K (ffffffffbb266000 - ffffffffbb26c000) [ 0.383355] ftrace: allocating 24707 entries in 97 pages [ 0.424687] smpboot: Max logical packages: 1 [ 0.426621] smpboot: APIC(0) Converting physical 0 to logical package 0 [ 0.429796] x2apic enabled [ 0.431807] Switched APIC routing to physical x2apic. [ 0.436087] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 [ 0.438700] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2603 v3 @ 1.60GHz (family: 0x6, model: 0x3f, stepping: 0x2) [ 0.443373] Performance Events: 16-deep LBR, Haswell events, Intel PMU driver. [ 0.447197] ... version: 2 [ 0.449088] ... bit width: 48 [ 0.450961] ... generic registers: 8 [ 0.452817] ... value mask: 0000ffffffffffff [ 0.455087] ... max period: 000000007fffffff [ 0.457363] ... fixed-purpose events: 3 [ 0.459211] ... event mask: 00000007000000ff [ 0.461513] KVM setup paravirtual spinlock [ 0.464037] x86: Booted up 1 node, 1 CPUs [ 0.465936] smpboot: Total of 1 processors activated (3196.29 BogoMIPS) [ 0.469119] devtmpfs: initialized [ 0.470811] x86/mm: Memory block size: 128MB [ 0.475068] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.479180] pinctrl core: initialized pinctrl subsystem [ 0.481616] NET: Registered protocol family 16 [ 0.483786] cpuidle: using governor ladder [ 0.485688] cpuidle: using governor menu [ 0.487564] ACPI: bus type PCI registered [ 0.489415] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 [ 0.492207] PCI: Using configuration type 1 for base access [ 0.494592] core: PMU erratum BJ122, BV98, HSD29 workaround disabled, HT off [ 0.498292] HugeTLB registered 1 GB page size, pre-allocated 0 pages [ 0.500901] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 0.503729] ACPI: Added _OSI(Module Device) [ 0.505653] ACPI: Added _OSI(Processor Device) [ 0.507627] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.509687] ACPI: Added _OSI(Processor Aggregator Device) [ 0.513884] ACPI: Interpreter enabled [ 0.515659] ACPI: (supports S0 S3 S4 S5) [ 0.517477] ACPI: Using IOAPIC for interrupt routing [ 0.519619] PCI: Using host bridge windows from ACPI; if necessary, use \"pci=nocrs\" and report a bug [ 0.527595] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) [ 0.530138] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] [ 0.532892] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM [ 0.535732] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.540788] acpiphp: Slot [3] registered [ 0.542653] acpiphp: Slot [4] registered [ 0.544522] acpiphp: Slot [5] registered [ 0.546353] acpiphp: Slot [6] registered [ 0.548200] acpiphp: Slot [7] registered [ 0.550047] acpiphp: Slot [8] registered [ 0.551881] acpiphp: Slot [9] registered [ 0.553725] acpiphp: Slot [10] registered [ 0.555597] acpiphp: Slot [11] registered [ 0.557477] acpiphp: Slot [12] registered [ 0.559341] acpiphp: Slot [13] registered [ 0.561216] acpiphp: Slot [14] registered [ 0.563088] acpiphp: Slot [15] registered [ 0.565094] acpiphp: Slot [16] registered [ 0.566962] acpiphp: Slot [17] registered [ 0.568852] acpiphp: Slot [18] registered [ 0.570722] acpiphp: Slot [19] registered [ 0.572603] acpiphp: Slot [20] registered [ 0.574522] acpiphp: Slot [21] registered [ 0.576415] acpiphp: Slot [22] registered [ 0.578289] acpiphp: Slot [23] registered [ 0.580176] acpiphp: Slot [24] registered [ 0.582045] acpiphp: Slot [25] registered [ 0.583915] acpiphp: Slot [26] registered [ 0.585789] acpiphp: Slot [27] registered [ 0.587654] acpiphp: Slot [28] registered [ 0.589540] acpiphp: Slot [29] registered [ 0.591412] acpiphp: Slot [30] registered [ 0.593296] acpiphp: Slot [31] registered [ 0.595155] PCI host bridge to bus 0000:00 [ 0.625003] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] [ 0.627714] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] [ 0.630438] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] [ 0.633774] pci_bus 0000:00: root bus resource [mem 0x40000000-0xfebfffff window] [ 0.637109] pci_bus 0000:00: root bus resource [mem 0x100000000-0x17fffffff window] [ 0.640506] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.650373] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] [ 0.653263] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] [ 0.655857] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] [ 0.658698] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] [ 0.662625] pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI [ 0.665914] pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB [ 0.696079] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) [ 0.699540] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) [ 0.702944] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) [ 0.706338] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) [ 0.709641] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) [ 0.712619] ACPI: Enabled 2 GPEs in block 00 to 0F [ 0.715419] vgaarb: setting as boot device: PCI:0000:00:02.0 [ 0.717797] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.721341] vgaarb: loaded [ 0.722759] vgaarb: bridge control possible 0000:00:02.0 [ 0.725251] PCI: Using ACPI for IRQ routing [ 0.727731] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0 [ 0.730556] hpet0: 3 comparators, 64-bit 100.000000 MHz counter [ 0.736170] amd_nb: Cannot enumerate AMD northbridges [ 0.738364] clocksource: Switched to clocksource kvm-clock [ 0.748411] VFS: Disk quotas dquot_6.6.0 [ 0.750283] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 0.753188] pnp: PnP ACPI init [ 0.755499] pnp: PnP ACPI: found 6 devices [ 0.763732] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns [ 0.767591] NET: Registered protocol family 2 [ 0.769808] TCP established hash table entries: 8192 (order: 4, 65536 bytes) [ 0.772648] TCP bind hash table entries: 8192 (order: 5, 131072 bytes) [ 0.775295] TCP: Hash tables configured (established 8192 bind 8192) [ 0.777902] UDP hash table entries: 512 (order: 2, 16384 bytes) [ 0.780358] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes) [ 0.782898] NET: Registered protocol family 1 [ 0.785039] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 0.787499] pci 0000:00:01.0: PIIX3: Enabling Passive Release [ 0.789907] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 0.792486] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] [ 0.796197] Unpacking initramfs... [ 3.642552] Freeing initrd memory: 16056K (ffff880036093000 - ffff880037041000) [ 3.646378] futex hash table entries: 256 (order: 2, 16384 bytes) [ 3.649006] audit: initializing netlink subsys (disabled) [ 3.651352] audit: type=2000 audit(1602842498.818:1): initialized [ 3.654297] Initialise system trusted keyrings [ 3.656384] workingset: timestamp_bits=37 max_order=18 bucket_order=0 [ 3.659023] zbud: loaded [ 3.738776] Key type asymmetric registered [ 3.741316] Asymmetric key parser 'x509' registered [ 3.744181] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251) [ 3.748642] io scheduler noop registered [ 3.751066] io scheduler deadline registered [ 3.753647] io scheduler cfq registered (default) [ 3.756475] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 3.759579] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 3.763229] GHES: HEST is not enabled! [ 3.765688] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 3.796166] 00:05: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A [ 3.799979] Linux agpgart interface v0.103 [ 3.801967] AMD IOMMUv2 driver by Joerg Roedel <jroedel@suse.de> [ 3.804446] AMD IOMMUv2 functionality not available on this system [ 3.807134] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 [ 3.811843] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 3.813999] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 3.816324] mousedev: PS/2 mouse device common for all mice [ 3.819110] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input0 [ 3.822913] rtc_cmos 00:00: RTC can wake from S4 [ 3.825754] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0 [ 3.828602] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs [ 3.831936] ledtrig-cpu: registered to indicate activity on CPUs [ 3.834632] NET: Registered protocol family 10 [ 3.836906] mip6: Mobile IPv6 [ 3.838433] NET: Registered protocol family 17 [ 3.840418] mpls_gso: MPLS GSO support [ 3.842344] microcode: CPU0 sig=0x306f2, pf=0x1, revision=0x1 [ 3.844886] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba [ 3.848776] registered taskstats version 1 [ 3.850670] Loading compiled-in X.509 certificates [ 3.854693] alg: No test for pkcs1pad(rsa,sha256) (pkcs1pad(rsa-generic,sha256)) [ 3.858428] Loaded X.509 cert 'Debian Project: Ben Hutchings: 008a018dca80932630' [ 3.861872] zswap: loaded using pool lzo/zbud [ 3.864363] rtc_cmos 00:00: setting system clock to 2020-10-16 10:01:38 UTC (1602842498) [ 3.870074] Freeing unused kernel memory: 1352K (ffffffffbb114000 - ffffffffbb266000) [ 3.873575] Write protecting the kernel read-only data: 10240k [ 3.876237] Freeing unused kernel memory: 108K (ffff88003abe5000 - ffff88003ac00000) [ 3.883726] Freeing unused kernel memory: 1308K (ffff88003aeb9000 - ffff88003b000000) [ 3.896358] x86/mm: Checked W+X mappings: passed, no W+X pages found. Loading, please wait... starting version 231 [ 3.909692] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.914102] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.918301] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.922440] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.926404] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.930588] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.935383] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.939382] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.943374] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 3.947354] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available) [ 4.005435] SCSI subsystem initialized [ 4.022965] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 [ 4.032810] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input2 [ 4.049969] AVX2 version of gcm_enc/dec engaged. [ 4.052053] AES CTR mode by8 optimization enabled [ 4.064681] Floppy drive(s): fd0 is 2.88M AMI BIOS [ 4.083078] FDC 0 is a S82078B [ 4.113173] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11 [ 4.125798] virtio_net virtio0 ens3: renamed from eth0 [ 4.128158] scsi host0: ata_piix [ 4.132481] scsi host1: ata_piix [ 4.134327] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc020 irq 14 [ 4.137102] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc028 irq 15 [ 4.296629] ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 [ 4.299068] ata1.00: 5859375 sectors, multi 16: LBA48 [ 4.301296] ata1.01: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 [ 4.303710] ata1.01: 1048576 sectors, multi 16: LBA48 [ 4.306446] ata2.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100 [ 4.310093] ata2.00: configured for MWDMA2 [ 4.314735] ata1.00: configured for MWDMA2 [ 4.318007] ata1.01: configured for MWDMA2 [ 4.320771] scsi 0:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 [ 4.325670] scsi 0:0:1:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 [ 4.330888] scsi 1:0:0:0: CD-ROM QEMU QEMU DVD-ROM 2.5+ PQ: 0 ANSI: 5 [ 4.344767] sd 0:0:0:0: [sda] 5859375 512-byte logical blocks: (3.00 GB/2.79 GiB) [ 4.349647] sd 0:0:1:0: [sdb] 1048576 512-byte logical blocks: (537 MB/512 MiB) [ 4.353696] sd 0:0:1:0: [sdb] Write Protect is off [ 4.355881] sd 0:0:0:0: [sda] Write Protect is off [ 4.359225] sr 1:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray [ 4.361961] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 4.364645] sd 0:0:1:0: [sdb] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 4.368562] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 4.382184] sda: sda1 [ 4.384484] sd 0:0:1:0: [sdb] Attached SCSI disk [ 4.387418] sd 0:0:0:0: [sda] Attached SCSI disk Begin: Loading essential drivers ... done. Begin: Running /scripts/init-premount ... done. Begin: Mounting root file system ... Begin: Running /scripts/local-top ... done. Begin: Running /scripts/local-premount ... done. Begin: Will now check root file system ... fsck from util-linux 2.28.2 fsck: error 2 (No such file or directory) while executing fsck.ext4 for /dev/sda1 fsck exited with status code 8 done. Warning: File system check failed but did not detect errors [ 4.650543] tsc: Refined TSC clocksource calibration: 1598.158 MHz [ 4.653972] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x170958c9c97, max_idle_ns: 440795207226 ns [ 9.663730] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) done. Begin: Running /scripts/local-bottom ... done. Begin: Running /scripts/init-bottom ... done. [ 10.899553] ip_tables: (C) 2000-2006 Netfilter Core Team [ 10.998514] systemd[1]: systemd 231 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ -LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN) [ 11.007568] systemd[1]: Detected virtualization qemu. [ 11.010101] systemd[1]: Detected architecture x86-64. Welcome to [1mDebian GNU/Linux stretch/sid[0m! [ 11.024156] systemd[1]: Set hostname to <debian>. [ 11.626577] random: nonblocking pool is initialized [ 11.981442] systemd[1]: Listening on Journal Socket (/dev/log). [[0;32m OK [0m] Listening on Journal Socket (/dev/log). [ 11.988184] systemd[1]: Listening on udev Kernel Socket. [[0;32m OK [0m] Listening on udev Kernel Socket. [ 11.992838] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [[0;32m OK [0m] Listening on /dev/initctl Compatibility Named Pipe. [ 11.998181] systemd[1]: Reached target Remote File Systems. [[0;32m OK [0m] Reached target Remote File Systems. [ 12.002921] systemd[1]: Listening on Journal Audit Socket. [[0;32m OK [0m] Listening on Journal Audit Socket. [ 12.007588] systemd[1]: Listening on udev Control Socket. [[0;32m OK [0m] Listening on udev Control Socket. [ 12.012317] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. [[0;32m OK [0m] Set up automount Arbitrary Executab...ats File System Automount Point. [ 12.019347] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [[0;32m OK [0m] Started Dispatch Password Requests to Console Directory Watch. [ 12.025605] systemd[1]: Listening on Syslog Socket. [[0;32m OK [0m] Listening on Syslog Socket. [ 12.029889] systemd[1]: Listening on Journal Socket. [[0;32m OK [0m] Listening on Journal Socket. [ 12.034199] systemd[1]: Reached target Encrypted Volumes. [[0;32m OK [0m] Reached target Encrypted Volumes. [ 12.040323] systemd[1]: Started Forward Password Requests to Wall Directory Watch. [[0;32m OK [0m] Started Forward Password Requests to Wall Directory Watch. [ 12.048334] systemd[1]: Listening on fsck to fsckd communication Socket. [[0;32m OK [0m] Listening on fsck to fsckd communication Socket. [ 12.055346] systemd[1]: Created slice System Slice. [[0;32m OK [0m] Created slice System Slice. [ 12.061776] systemd[1]: Starting Journal Service... Starting Journal Service... [ 12.071328] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 12.084218] systemd[1]: Mounting Huge Pages File System... Mounting Huge Pages File System... [ 12.107121] systemd[1]: Created slice system-getty.slice. [[0;32m OK [0m] Created slice system-getty.slice. [ 12.124648] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 12.131695] systemd[1]: Created slice system-serial\x2dgetty.slice. [[0;32m OK [0m] Created slice system-serial\x2dgetty.slice. [ 12.143356] systemd[1]: Starting Create list of required static device nodes for the current kernel... Starting Create list of required st... nodes for the current kernel... [ 12.160958] systemd[1]: Reached target Slices. [[0;32m OK [0m] Reached target Slices. [ 12.165633] systemd[1]: Mounting Debug File System... Mounting Debug File System... [ 12.172648] systemd[1]: Reached target Swap. [[0;32m OK [0m] Reached target Swap. [ 12.179110] systemd[1]: Starting File System Check on Root Device... Starting File System Check on Root Device... [ 12.188379] systemd[1]: Listening on Network Service Netlink Socket. [[0;32m OK [0m] Listening on Network Service Netlink Socket. [ 12.196077] systemd[1]: Mounted Huge Pages File System. [[0;32m OK [0m] Mounted Huge Pages File System. [ 12.206085] systemd[1]: Mounted Debug File System. [[0;32m OK [0m] Mounted Debug File System. [ 12.216417] systemd[1]: Mounted POSIX Message Queue File System. [[0;32m OK [0m] Mounted POSIX Message Queue File System. [ 12.221597] systemd[1]: Started Journal Service. [[0;32m OK [0m] Started Journal Service. [[0;32m OK [0m] Started Load Kernel Modules. [[0;32m OK [0m] Started Create list of required sta...ce nodes for the current kernel. [[0;32m OK [0m] Started File System Check on Root Device. [[0;32m OK [0m] Started File System Check Daemon to report status. Starting Remount Root and Kernel File Systems... Starting Create Static Device Nodes in /dev... Starting Apply Kernel Variables... [ 12.273904] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro [[0;32m OK [0m] Started Remount Root and Kernel File Systems. Starting Flush Journal to Persistent Storage... Starting Load/Save Random Seed... Starting udev Coldplug all Devices... [[0;32m OK [0m] Started Create Static Device Nodes in /dev. [[0;32m OK [0m] Started Apply Kernel Variables. [[0;32m OK [0m] Started Load/Save Random Seed. [ 12.350685] systemd-journald[465]: Received request to flush runtime journal from PID 1 [[0;32m OK [0m] Started Flush Journal to Persistent Storage. [[0;32m OK [0m] Reached target Local File Systems (Pre). [[0;32m OK [0m] Reached target Local File Systems. Starting Raise network interfaces... Starting Create Volatile Files and Directories... Starting udev Kernel Device Manager... [[0;32m OK [0m] Started udev Coldplug all Devices. [[0;32m OK [0m] Started Create Volatile Files and Directories. Starting Update UTMP about System Boot/Shutdown... Starting Network Time Synchronization... [[0;32m OK [0m] Started udev Kernel Device Manager. [[0;32m OK [0m] Started Update UTMP about System Boot/Shutdown. Starting Network Service... [ 12.536976] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input4 [[0;32m OK [0m] Started Network Time Synchronization. [[0;32m OK [0m] Reached target System Initialization.[ 12.575992] ACPI: Power Button [PWRF] [ 12.584507] parport_pc 00:04: reported by Plug and Play ACPI [[0;32m OK [0m] Started Daily Cleanup of Temporary Directories. [ 12.600836] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE] [[0;32m OK [0m] Listening on ACPID Listen Socket. [[0;32m OK [0m] Reached target Sockets. [[0;32m OK [0m] Started ACPI Events Check. [[0;32m OK [0m] Reached target Paths. [[0;32m OK [0m] Reached target Basic System. [ 12.655407] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 [[0;32m OK [0m] Started Regular background program processing daemon. [ 12.690206] sd 0:0:0:0: Attached scsi generic sg0 type 0 Starting System Logging Service... [ 12.707895] sd 0:0:1:0: Attached scsi generic sg1 type 0 [ 12.717153] [drm] Initialized drm 1.1.0 20060810 [ 12.728110] input: PC Speaker as /devices/platform/pcspkr/input/input5 Starting getty on tty2-tty6 if dbus and logind are not available...[ 12.738673] sr 1:0:0:0: Attached scsi generic sg2 type 5 [[0;32m OK [0m] Reached target System Time Synchronized. [[0;32m OK [0m] Started Daily apt activities. [[0;32m OK [0m[ 12.854681] [drm] Found bochs VGA, ID 0xb0c0. [ 12.856702] [drm] Framebuffer size 16384 kB @ 0xfd000000, mmio @ 0xfebd0000. ] Reached target Timers. [[0;32m OK [0m] Started Network Service. [ 12.884195] ppdev: user-space parallel port driver [[0;32m OK [0m[ 12.899853] intel_powerclamp: No package C-state available] Started System Logging Service. [ 12.910647] [TTM] Zone kernel: Available graphics memory: 510194 kiB [ 12.913961] [TTM] Initializing pool allocator [ 12.916445] intel_powerclamp: No package C-state available [ 12.926422] [TTM] Initializing DMA pool allocator [ 12.929731] EDAC MC: Ver: 3.0.0 [[0;32m OK [0m] Found device /dev/ttyS0. [ 12.940740] EDAC sbridge: Ver: 1.1.1 [ 12.944756] fbcon: bochsdrmfb (fb0) is primary device [ 12.969774] intel_rapl: no valid rapl domains found in package 0 [ 13.009769] Console: switching to colour frame buffer device 128x48 [ 13.021170] bochs-drm 0000:00:02.0: fb0: bochsdrmfb frame buffer device [ 13.030420] [drm] Initialized bochs-drm 1.0.0 20130925 for 0000:00:02.0 on minor 0 [ 13.047943] systemd[1]: apt-daily.timer: Adding 5h 53min 4.853770s random time. [[0;32m OK [0m] Started getty on tty2-tty6 if dbus and logind are not available. [ 13.125880] systemd[1]: apt-daily.timer: Adding 2h 32min 27.542040s random time. [[0;32m OK [0m] Started Raise network interfaces. [[0;32m OK [0m] Reached target Network. Starting Permit User Sessions... Starting Network Name Resolution... [[0;32m OK [0m] Started Permit User Sessions. [[0;32m OK [0m] Started Getty on tty5. [[0;32m OK [0m] Started Getty on tty2. [[0;32m OK [0m] Started Getty on tty1. [[0;32m OK [0m] Started Getty on tty6. [[0;32m OK [0m] Started Serial Getty on ttyS0. [[0;32m OK [0m] Started Getty on tty4. [[0;32m OK [0m] Started Getty on tty3. [[0;32m OK [0m] Reached target Login Prompts. [[0;32m OK [0m] Started Network Name Resolution. [[0;32m OK [0m] Reached target Multi-User System. [[0;32m OK [0m] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [[0;32m OK [0m] Started Update UTMP about System Runlevel Changes. Debian GNU/Linux stretch/sid debian ttyS0 Matched prompt #5: login: case: kernel-messages
case_id: 60913
definition: lava
duration: 14.13
extra: ...
level: 2.2.1
namespace: common
result: pass
Sending username root root debian login: root Setting prompt string to ['root@debian:'] login-action: Wait for prompt ['root@debian:', 'Login incorrect', 'Login timed out'] (timeout 00:01:36) root Linux debian 4.7.0-1-amd64 #1 SMP Debian 4.7.8-1 (2016-10-19) x86_64 The programs included with the Debian GNU/Linux system are free software; the exact distribution terms for each program are described in the individual files in /usr/share/doc/*/copyright. Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent permitted by applicable law. Setting prompt string to ['root@debian:'] end: 2.2.1 login-action (duration 00:00:14) [common] case: login-action
case_id: 60914
definition: lava
duration: 14.32
extra: ...
level: 2.2.1
namespace: common
result: pass
end: 2.2 auto-login-action (duration 00:00:23) [common] start: 2.3 expect-shell-connection (timeout 00:01:36) [common] Setting prompt string to ['root@debian:'] Forcing a shell prompt, looking for ['root@debian:'] root@debian:~# expect-shell-connection: Wait for prompt ['root@debian:'] (timeout 00:02:00) Waiting using forced prompt support (timeout 00:01:00) end: 2.3 expect-shell-connection (duration 00:00:00) [common] start: 2.4 export-device-env (timeout 00:01:36) [common] end: 2.4 export-device-env (duration 00:00:00) [common] end: 2 boot-image-retry (duration 00:00:24) [common] start: 3 lava-test-retry (timeout 00:04:36) [common] start: 3.1 lava-test-shell (timeout 00:04:36) [common] Using namespace: common # root@debian:~# # lava-test-shell: Wait for prompt ['root@debian:'] (timeout 00:05:00) # mkdir /lava-3187 root@debian:~# mkdir /lava-3187 mkdir /lava-3187 mount /dev/disk/by-uuid/d80c5328-7183-4314-bdfc-ef66186eae43 -t ext2 /lava-3187 root@debian:~# mount /dev/disk/by-uuid/d80c5328-7183-4314-bdfc-ef66186eae43 -t ext2 /lava-3187 mount /dev/disk/by-uuid/d80c5328-7183-4314-bdfc-ef66186eae43 -t exxt2 /lava-3187 [ 14.850796] EXT4-fs (sdb): mounting ext2 file system using the ext4 subsystem [ 14.857818] EXT4-fs (sdb): mounted filesystem without journal. Opts: (null) ls -la /lava-3187/bin/lava-test-runner root@debian:~# ls -la /lava-3187/bin/lava-test-runner ls -la /lava-3187/bin/lava-test-runner -rwxr-xr-x 1 root root 1041 Oct 16 10:00 /lava-3187/bin/lava-test-runner Using /lava-3187 export SHELL=/bin/bash root@debian:export SHELL=/bin/bash ~# export SHELL=/bin/bash . /lava-3187/environment root@debian:~# . /lava-3187/environment . /lava-3187/environment /lava-3187/bin/lava-test-runner /lava-3187/0 root@debian:~# /lava-3187/bin/lava-test-runner /lava-3187/0 Test shell timeout: 10s (minimum of the action and connection timeout) /lava-3187/bin/lava-test-runner /lava-3187/0 + export TESTRUN_ID=0_env-dut-inline + TESTRUN_ID=0_env-dut-inline + cd /lava-3187/0/tests/0_env-dut-inline ++ cat uuid + UUID=3187_1.2.3.1 + set +x <LAVA_SIGNAL_STARTRUN 0_env-dut-inline 3187_1.2.3.1> Received signal: <STARTRUN> 0_env-dut-inline 3187_1.2.3.1 Starting test lava.0_env-dut-inline (3187_1.2.3.1) Skipping test definition patterns. + printenv TESTRUN_ID=0_env-dut-inline OLDPWD=/root LAVA_JOB_ID=3187 HUSHLOGIN=FALSE USER=root PWD=/lava-3187/0/tests/0_env-dut-inline HOME=/root MAIL=/var/mail/root TERM=vt220 SHELL=/bin/bash LAVA_RESULT_DIR=/lava-3187/0/results/0_env-dut-inline-1602842509 SHLVL=4 LOGNAME=root PATH=/lava-3187/0/../bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin _=/usr/bin/printenv + set +x <LAVA_SIGNAL_ENDRUN 0_env-dut-inline 3187_1.2.3.1> Received signal: <ENDRUN> 0_env-dut-inline 3187_1.2.3.1 Ending use of test pattern. Ending test lava.0_env-dut-inline (3187_1.2.3.1), duration 0.01 case: 0_env-dut-inline
case_id: 60915
definition: lava
duration: 0.01
namespace: common
path: inline/env-dut.yaml
metadata: {'description': 'Basic system test command for Linaro Ubuntu images', 'format': 'Lava-Test Test Definition 1.0', 'name': 'smoke-tests-basic'}
run: {'steps': ['printenv']}
result: pass
revision: unspecified
uuid: 3187_1.2.3.1
+ export TESTRUN_ID=1_smoke-tests + TESTRUN_ID=1_smoke-tests + cd /lava-3187/0/tests/1_smoke-tests ++ cat uuid + UUID=3187_1.2.3.5 + set +x Received signal: <STARTRUN> 1_smoke-tests 3187_1.2.3.5 Starting test lava.1_smoke-tests (3187_1.2.3.5) Skipping test definition patterns. <LAVA_SIGNAL_STARTRUN 1_smoke-tests 3187_1.2.3.5> + lava-test-case linux-posix-pwd --shell pwd <LAVA_SIGNAL_STARTTC linux-posix-pwd> Received signal: <STARTTC> linux-posix-pwd /lava-3187/0/tests/1_smoke-tests Received signal: <ENDTC> linux-posix-pwd <LAVA_SIGNAL_ENDTC linux-posix-pwd> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-pwd RESULT=pass> Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-pwd RESULT=pass case: linux-posix-pwd
case_id: 60916
definition: 1_smoke-tests
endtc: 787
result: pass
starttc: 785
+ lava-test-case linux-posix-uname --shell uname -a <LAVA_SIGNAL_STARTTC linux-posix-uname> Received signal: <STARTTC> linux-posix-uname Linux debian 4.7.0-1-amd64 #1 SMP Debian 4.7.8-1 (2016-10-19) x86_64 GNU/Linux <LAVA_SIGNAL_ENDTC linux-posix-uname> Received signal: <ENDTC> linux-posix-uname Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-uname RESULT=pass case: linux-posix-uname
case_id: 60917
definition: 1_smoke-tests
endtc: 797
result: pass
starttc: 794
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-uname RESULT=pass> + lava-test-case linux-posix-vmstat --shell vmstat <LAVA_SIGNAL_STARTTC linux-posix-vmstat> Received signal: <STARTTC> linux-posix-vmstat procs -----------memory---------- ---swap-- -----io---- -system-- ------cpu----- r b swpd free buff cache si so bi bo in cs us sy id wa st 0 0 0 953004 6668 33424 0 0 2796 1 380 1216 4 23 56 17 0 Received signal: <ENDTC> linux-posix-vmstat <LAVA_SIGNAL_ENDTC linux-posix-vmstat> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-vmstat RESULT=pass> Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-vmstat RESULT=pass case: linux-posix-vmstat
case_id: 60918
definition: 1_smoke-tests
endtc: 807
result: pass
starttc: 803
+ lava-test-case linux-posix-ifconfig --shell ifconfig -a Received signal: <STARTTC> linux-posix-ifconfig <LAVA_SIGNAL_STARTTC linux-posix-ifconfig> ens3: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500 inet6 fe80::dcad:beff:feef:3201 prefixlen 64 scopeid 0x20<link> ether de:ad:be:ef:32:01 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 15 bytes 1830 (1.7 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536 inet 127.0.0.1 netmask 255.0.0.0 inet6 ::1 prefixlen 128 scopeid 0x10<host> loop txqueuelen 1 (Local Loopback) RX packets 163 bytes 13260 (12.9 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 163 bytes 13260 (12.9 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 <LAVA_SIGNAL_ENDTC linux-posix-ifconfig> Received signal: <ENDTC> linux-posix-ifconfig Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-ifconfig RESULT=pass case: linux-posix-ifconfig
case_id: 60919
definition: 1_smoke-tests
endtc: 833
result: pass
starttc: 813
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-ifconfig RESULT=pass> + lava-test-case linux-posix-lscpu --shell lscpu Received signal: <STARTTC> linux-posix-lscpu <LAVA_SIGNAL_STARTTC linux-posix-lscpu> Architecture: x86_64 CPU op-mode(s): 32-bit, 64-bit Byte Order: Little Endian CPU(s): 1 On-line CPU(s) list: 0 Thread(s) per core: 1 Core(s) per socket: 1 Socket(s): 1 NUMA node(s): 1 Vendor ID: GenuineIntel CPU family: 6 Model: 63 Model name: Intel(R) Xeon(R) CPU E5-2603 v3 @ 1.60GHz Stepping: 2 CPU MHz: 1598.148 BogoMIPS: 3196.29 Hypervisor vendor: KVM Virtualization type: full L1d cache: 32K L1i cache: 32K L2 cache: 4096K L3 cache: 16384K NUMA node0 CPU(s): 0 Flags: fpu vme de pse tsc msr pae mce cx8 apic sep mtrr pge mca cmov pat pse36 clflush mmx fxsr sse sse2 ss syscall nx pdpe1gb rdtscp lm constant_tsc arch_perfmon rep_good nopl xtopology eagerfpu pni pclmulqdq ssse3 fma cx16 pcid sse4_1 sse4_2 x2apic movbe popcnt tsc_deadline_timer aes xsave avx f16c rdrand hypervisor lahf_lm abm fsgsbase tsc_adjust bmi1 avx2 smep bmi2 erms invpcid xsaveopt arat Received signal: <ENDTC> linux-posix-lscpu <LAVA_SIGNAL_ENDTC linux-posix-lscpu> Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-lscpu RESULT=pass case: linux-posix-lscpu
case_id: 60920
definition: 1_smoke-tests
endtc: 864
result: pass
starttc: 838
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-lscpu RESULT=pass> + lava-test-case linux-posix-lsb_release --shell lsb_release -a Received signal: <STARTTC> linux-posix-lsb_release <LAVA_SIGNAL_STARTTC linux-posix-lsb_release> /lava-3187/0/../bin/lava-test-case: line 27: lsb_release: command not found <LAVA_SIGNAL_ENDTC linux-posix-lsb_release> Received signal: <ENDTC> linux-posix-lsb_release <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-lsb_release RESULT=fail> Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-lsb_release RESULT=fail case: linux-posix-lsb_release
case_id: 60921
definition: 1_smoke-tests
endtc: 874
result: fail
starttc: 870
+ set +x <LAVA_SIGNAL_ENDRUN 1_smoke-tests 3187_1.2.3.5> Received signal: <ENDRUN> 1_smoke-tests 3187_1.2.3.5 Ending use of test pattern. Ending test lava.1_smoke-tests (3187_1.2.3.5), duration 0.13 case: 1_smoke-tests
case_id: 60922
commit_id: b79f2809e243d66743b25b3fecc8df3449db1a16
definition: lava
duration: 0.13
namespace: common
path: lava-test-shell/smoke-tests-basic.yaml
repository: http://git.linaro.org/lava-team/lava-functional-tests.git
result: pass
revision: unspecified
uuid: 3187_1.2.3.5
+ export TESTRUN_ID=2_singlenode-advanced + TESTRUN_ID=2_singlenode-advanced + cd /lava-3187/0/tests/2_singlenode-advanced ++ cat uuid + UUID=3187_1.2.3.9 + set +x Received signal: <STARTRUN> 2_singlenode-advanced 3187_1.2.3.9 Starting test lava.2_singlenode-advanced (3187_1.2.3.9) Skipping test definition patterns. <LAVA_SIGNAL_STARTRUN 2_singlenode-advanced 3187_1.2.3.9> + apt-get update -q Err:1 http://mirror.bytemark.co.uk/debian stretch InRelease Temporary failure resolving 'mirror.bytemark.co.uk' Reading package lists... W: Failed to fetch http://mirror.bytemark.co.uk/debian/dists/stretch/InRelease Temporary failure resolving 'mirror.bytemark.co.uk' W: Some index files failed to download. They have been ignored, or old ones used instead. + DEBIAN_FRONTEND=noninteractive + lava-test-case install-base --shell apt-get -q -y install -o Dpkg::Options::=--force-confold curl lsb-release usbutils net-tools iputils-ping Received signal: <STARTTC> install-base <LAVA_SIGNAL_STARTTC install-base> Reading package lists... Building dependency tree... iputils-ping is already the newest version (3:20150815-2). net-tools is already the newest version (1.60+git20150829.73cef8a-2). The following additional packages will be installed: bzip2 ca-certificates dh-python distro-info-data file krb5-locales libcurl3-gnutls libexpat1 libgssapi-krb5-2 libk5crypto3 libkeyutils1 libkrb5-3 libkrb5support0 libldap-2.4-2 libmagic-mgc libmagic1 libmpdec2 libnghttp2-14 libpython3-stdlib libpython3.5-minimal libpython3.5-stdlib librtmp1 libsasl2-2 libsasl2-modules libsasl2-modules-db libssh2-1 libusb-1.0-0 mime-support openssl python3 python3-minimal python3.5 python3.5-minimal xz-utils Suggested packages: bzip2-doc libdpkg-perl krb5-doc krb5-user libsasl2-modules-otp libsasl2-modules-ldap libsasl2-modules-sql libsasl2-modules-gssapi-mit | libsasl2-modules-gssapi-heimdal lsb python3-doc python3-tk python3-venv python3.5-venv python3.5-doc binutils binfmt-support The following NEW packages will be installed: bzip2 ca-certificates curl dh-python distro-info-data file krb5-locales libcurl3-gnutls libexpat1 libgssapi-krb5-2 libk5crypto3 libkeyutils1 libkrb5-3 libkrb5support0 libldap-2.4-2 libmagic-mgc libmagic1 libmpdec2 libnghttp2-14 libpython3-stdlib libpython3.5-minimal libpython3.5-stdlib librtmp1 libsasl2-2 libsasl2-modules libsasl2-modules-db libssh2-1 libusb-1.0-0 lsb-release mime-support openssl python3 python3-minimal python3.5 python3.5-minimal usbutils xz-utils 0 upgraded, 37 newly installed, 0 to remove and 0 not upgraded. Need to get 11.6 MB of archives. After this operation, 40.1 MB of additional disk space will be used. Err:1 http://mirror.bytemark.co.uk/debian stretch/main amd64 libpython3.5-minimal amd64 3.5.2-6+b1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:2 http://mirror.bytemark.co.uk/debian stretch/main amd64 libexpat1 amd64 2.2.0-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:3 http://mirror.bytemark.co.uk/debian stretch/main amd64 python3.5-minimal amd64 3.5.2-6+b1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:4 http://mirror.bytemark.co.uk/debian stretch/main amd64 python3-minimal amd64 3.5.1-4 Temporary failure resolving 'mirror.bytemark.co.uk' Err:5 http://mirror.bytemark.co.uk/debian stretch/main amd64 mime-support all 3.60 Temporary failure resolving 'mirror.bytemark.co.uk' Err:6 http://mirror.bytemark.co.uk/debian stretch/main amd64 libmpdec2 amd64 2.4.2-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:7 http://mirror.bytemark.co.uk/debian stretch/main amd64 libpython3.5-stdlib amd64 3.5.2-6+b1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:8 http://mirror.bytemark.co.uk/debian stretch/main amd64 python3.5 amd64 3.5.2-6+b1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:9 http://mirror.bytemark.co.uk/debian stretch/main amd64 libpython3-stdlib amd64 3.5.1-4 Temporary failure resolving 'mirror.bytemark.co.uk' Err:10 http://mirror.bytemark.co.uk/debian stretch/main amd64 dh-python all 2.20160818 Temporary failure resolving 'mirror.bytemark.co.uk' Err:11 http://mirror.bytemark.co.uk/debian stretch/main amd64 python3 amd64 3.5.1-4 Temporary failure resolving 'mirror.bytemark.co.uk' Err:12 http://mirror.bytemark.co.uk/debian stretch/main amd64 bzip2 amd64 1.0.6-8 Temporary failure resolving 'mirror.bytemark.co.uk' Err:13 http://mirror.bytemark.co.uk/debian stretch/main amd64 libmagic-mgc amd64 1:5.28-4 Temporary failure resolving 'mirror.bytemark.co.uk' Err:14 http://mirror.bytemark.co.uk/debian stretch/main amd64 libmagic1 amd64 1:5.28-4 Temporary failure resolving 'mirror.bytemark.co.uk' Err:15 http://mirror.bytemark.co.uk/debian stretch/main amd64 file amd64 1:5.28-4 Temporary failure resolving 'mirror.bytemark.co.uk' Err:16 http://mirror.bytemark.co.uk/debian stretch/main amd64 krb5-locales all 1.14.3+dfsg-2 Temporary failure resolving 'mirror.bytemark.co.uk' Err:17 http://mirror.bytemark.co.uk/debian stretch/main amd64 libkeyutils1 amd64 1.5.9-9 Temporary failure resolving 'mirror.bytemark.co.uk' Err:18 http://mirror.bytemark.co.uk/debian stretch/main amd64 libkrb5support0 amd64 1.14.3+dfsg-2 Temporary failure resolving 'mirror.bytemark.co.uk' Err:19 http://mirror.bytemark.co.uk/debian stretch/main amd64 libk5crypto3 amd64 1.14.3+dfsg-2 Temporary failure resolving 'mirror.bytemark.co.uk' Err:20 http://mirror.bytemark.co.uk/debian stretch/main amd64 libkrb5-3 amd64 1.14.3+dfsg-2 Temporary failure resolving 'mirror.bytemark.co.uk' Err:21 http://mirror.bytemark.co.uk/debian stretch/main amd64 libgssapi-krb5-2 amd64 1.14.3+dfsg-2 Temporary failure resolving 'mirror.bytemark.co.uk' Err:22 http://mirror.bytemark.co.uk/debian stretch/main amd64 libsasl2-modules-db amd64 2.1.26.dfsg1-15 Temporary failure resolving 'mirror.bytemark.co.uk' Err:23 http://mirror.bytemark.co.uk/debian stretch/main amd64 libsasl2-2 amd64 2.1.26.dfsg1-15 Temporary failure resolving 'mirror.bytemark.co.uk' Err:24 http://mirror.bytemark.co.uk/debian stretch/main amd64 libldap-2.4-2 amd64 2.4.42+dfsg-2+b3 Temporary failure resolving 'mirror.bytemark.co.uk' Err:25 http://mirror.bytemark.co.uk/debian stretch/main amd64 xz-utils amd64 5.2.2-1.2 Temporary failure resolving 'mirror.bytemark.co.uk' Err:26 http://mirror.bytemark.co.uk/debian stretch/main amd64 openssl amd64 1.0.2j-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:27 http://mirror.bytemark.co.uk/debian stretch/main amd64 ca-certificates all 20160104 Temporary failure resolving 'mirror.bytemark.co.uk' Err:28 http://mirror.bytemark.co.uk/debian stretch/main amd64 libnghttp2-14 amd64 1.15.0-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:29 http://mirror.bytemark.co.uk/debian stretch/main amd64 librtmp1 amd64 2.4+20151223.gitfa8646d.1-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:30 http://mirror.bytemark.co.uk/debian stretch/main amd64 libssh2-1 amd64 1.7.0-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:31 http://mirror.bytemark.co.uk/debian stretch/main amd64 libcurl3-gnutls amd64 7.50.1-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:32 http://mirror.bytemark.co.uk/debian stretch/main amd64 curl amd64 7.50.1-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:33 http://mirror.bytemark.co.uk/debian stretch/main amd64 distro-info-data all 0.29 Temporary failure resolving 'mirror.bytemark.co.uk' Err:34 http://mirror.bytemark.co.uk/debian stretch/main amd64 libsasl2-modules amd64 2.1.26.dfsg1-15 Temporary failure resolving 'mirror.bytemark.co.uk' Err:35 http://mirror.bytemark.co.uk/debian stretch/main amd64 libusb-1.0-0 amd64 2:1.0.20-1 Temporary failure resolving 'mirror.bytemark.co.uk' Err:36 http://mirror.bytemark.co.uk/debian stretch/main amd64 lsb-release all 9.20161016 Temporary failure resolving 'mirror.bytemark.co.uk' Err:37 http://mirror.bytemark.co.uk/debian stretch/main amd64 usbutils amd64 1:007-4 Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3.5/libpython3.5-minimal_3.5.2-6+b1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/e/expat/libexpat1_2.2.0-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3.5/python3.5-minimal_3.5.2-6+b1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3-defaults/python3-minimal_3.5.1-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/m/mime-support/mime-support_3.60_all.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/m/mpdecimal/libmpdec2_2.4.2-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3.5/libpython3.5-stdlib_3.5.2-6+b1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3.5/python3.5_3.5.2-6+b1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3-defaults/libpython3-stdlib_3.5.1-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/d/dh-python/dh-python_2.20160818_all.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/p/python3-defaults/python3_3.5.1-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/b/bzip2/bzip2_1.0.6-8_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/f/file/libmagic-mgc_5.28-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/f/file/libmagic1_5.28-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/f/file/file_5.28-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/k/krb5/krb5-locales_1.14.3+dfsg-2_all.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/k/keyutils/libkeyutils1_1.5.9-9_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/k/krb5/libkrb5support0_1.14.3+dfsg-2_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/k/krb5/libk5crypto3_1.14.3+dfsg-2_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/k/krb5/libkrb5-3_1.14.3+dfsg-2_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/k/krb5/libgssapi-krb5-2_1.14.3+dfsg-2_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/c/cyrus-sasl2/libsasl2-modules-db_2.1.26.dfsg1-15_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/c/cyrus-sasl2/libsasl2-2_2.1.26.dfsg1-15_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/o/openldap/libldap-2.4-2_2.4.42+dfsg-2+b3_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/x/xz-utils/xz-utils_5.2.2-1.2_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/o/openssl/openssl_1.0.2j-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/c/ca-certificates/ca-certificates_20160104_all.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/n/nghttp2/libnghttp2-14_1.15.0-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/r/rtmpdump/librtmp1_2.4+20151223.gitfa8646d.1-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/libs/libssh2/libssh2-1_1.7.0-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/c/curl/libcurl3-gnutls_7.50.1-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/c/curl/curl_7.50.1-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/d/distro-info-data/distro-info-data_0.29_all.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/c/cyrus-sasl2/libsasl2-modules_2.1.26.dfsg1-15_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/libu/libusb-1.0/libusb-1.0-0_1.0.20-1_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/l/lsb/lsb-release_9.20161016_all.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Failed to fetch http://mirror.bytemark.co.uk/debian/pool/main/u/usbutils/usbutils_007-4_amd64.deb Temporary failure resolving 'mirror.bytemark.co.uk' E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing? Received signal: <ENDTC> install-base <LAVA_SIGNAL_ENDTC install-base> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=install-base RESULT=fail> Received signal: <TESTCASE> TEST_CASE_ID=install-base RESULT=fail case: install-base
case_id: 60923
definition: 2_singlenode-advanced
endtc: 1044
result: fail
starttc: 902
+ lava-test-case linux-linaro-ubuntu-netstat --shell netstat -an <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-netstat> Received signal: <STARTTC> linux-linaro-ubuntu-netstat Active Internet connections (servers and established) Proto Recv-Q Send-Q Local Address Foreign Address State tcp 0 0 0.0.0.0:5355 0.0.0.0:* LISTEN tcp 0 0 127.0.0.53:53 0.0.0.0:* LISTEN tcp6 0 0 :::5355 :::* LISTEN udp 0 0 0.0.0.0:5355 0.0.0.0:* udp 0 0 127.0.0.53:53 0.0.0.0:* udp6 0 0 :::5355 :::* udp6 0 0 fe80::dcad:beff:fee:546 :::* raw6 0 0 :::58 :::* 7 Active UNIX domain sockets (servers and established) Proto RefCnt Flags Type State I-Node Path unix 2 [ ACC ] STREAM LISTENING 10083 /run/acpid.socket unix 3 [ ] DGRAM 8564 /run/systemd/notify unix 2 [ ] DGRAM 8566 /run/systemd/cgroups-agent unix 2 [ ACC ] STREAM LISTENING 8568 /run/systemd/private unix 3 [ ] DGRAM 8573 /run/systemd/journal/dev-log unix 2 [ ACC ] SEQPACKET LISTENING 8585 /run/udev/control unix 2 [ ] DGRAM 8593 /run/systemd/journal/syslog unix 2 [ ACC ] STREAM LISTENING 8595 /run/systemd/journal/stdout unix 8 [ ] DGRAM 8597 /run/systemd/journal/socket unix 2 [ ACC ] STREAM LISTENING 8599 /run/systemd/fsck.progress unix 3 [ ] STREAM CONNECTED 9596 unix 3 [ ] DGRAM 9905 unix 2 [ ] DGRAM 10691 unix 3 [ ] DGRAM 9903 unix 3 [ ] STREAM CONNECTED 9021 unix 3 [ ] DGRAM 9904 unix 2 [ ] DGRAM 9610 unix 2 [ ] DGRAM 9898 unix 2 [ ] DGRAM 8709 unix 3 [ ] STREAM CONNECTED 9789 unix 3 [ ] DGRAM 9738 unix 2 [ ] DGRAM 9067 unix 3 [ ] STREAM CONNECTED 10189 unix 3 [ ] STREAM CONNECTED 10190 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 9969 unix 2 [ ] DGRAM 11446 unix 2 [ ] DGRAM 10814 unix 3 [ ] STREAM CONNECTED 10803 unix 3 [ ] DGRAM 9906 unix 3 [ ] STREAM CONNECTED 9597 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 10804 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 9790 /run/systemd/journal/stdout unix 3 [ ] DGRAM 9737 unix 3 [ ] STREAM CONNECTED 9970 /run/systemd/journal/stdout unix 2 [ ] DGRAM 10459 unix 2 [ ] DGRAM 10085 unix 3 [ ] STREAM CONNECTED 9022 /run/systemd/journal/stdout <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-netstat> Received signal: <ENDTC> linux-linaro-ubuntu-netstat <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-netstat RESULT=pass> Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-netstat RESULT=pass case: linux-linaro-ubuntu-netstat
case_id: 60924
definition: 2_singlenode-advanced
endtc: 1102
result: pass
starttc: 1051
+ lava-test-case linux-linaro-ubuntu-ifconfig-dump --shell ifconfig -a Received signal: <STARTTC> linux-linaro-ubuntu-ifconfig-dump <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-ifconfig-dump> ens3: flags=4163<UP,BROADCAST,RUNNING,MULTICAST> mtu 1500 inet6 fe80::dcad:beff:feef:3201 prefixlen 64 scopeid 0x20<link> ether de:ad:be:ef:32:01 txqueuelen 1000 (Ethernet) RX packets 0 bytes 0 (0.0 B) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 17 bytes 2262 (2.2 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 lo: flags=73<UP,LOOPBACK,RUNNING> mtu 65536 inet 127.0.0.1 netmask 255.0.0.0 inet6 ::1 prefixlen 128 scopeid 0x10<host> loop txqueuelen 1 (Local Loopback) RX packets 163 bytes 13260 (12.9 KiB) RX errors 0 dropped 0 overruns 0 frame 0 TX packets 163 bytes 13260 (12.9 KiB) TX errors 0 dropped 0 overruns 0 carrier 0 collisions 0 Received signal: <ENDTC> linux-linaro-ubuntu-ifconfig-dump <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-ifconfig-dump> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-ifconfig-dump RESULT=pass> Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-ifconfig-dump RESULT=pass case: linux-linaro-ubuntu-ifconfig-dump
case_id: 60925
definition: 2_singlenode-advanced
endtc: 1126
result: pass
starttc: 1107
+ lava-test-case linux-linaro-ubuntu-route-dump-a --shell route Received signal: <STARTTC> linux-linaro-ubuntu-route-dump-a <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-route-dump-a> Kernel IP routing table Destination Gateway Genmask Flags Metric Ref Use Iface Received signal: <ENDTC> linux-linaro-ubuntu-route-dump-a <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-route-dump-a> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-route-dump-a RESULT=pass> Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-route-dump-a RESULT=pass case: linux-linaro-ubuntu-route-dump-a
case_id: 60926
definition: 2_singlenode-advanced
endtc: 1136
result: pass
starttc: 1132
+ lava-test-case linux-linaro-ubuntu-route-ifconfig-up-lo --shell ifconfig lo up Received signal: <STARTTC> linux-linaro-ubuntu-route-ifconfig-up-lo <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-route-ifconfig-up-lo> Received signal: <ENDTC> linux-linaro-ubuntu-route-ifconfig-up-lo <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-route-ifconfig-up-lo> Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-route-ifconfig-up-lo RESULT=pass case: linux-linaro-ubuntu-route-ifconfig-up-lo
case_id: 60927
definition: 2_singlenode-advanced
endtc: 1144
result: pass
starttc: 1142
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-route-ifconfig-up-lo RESULT=pass> + lava-test-case linux-linaro-ubuntu-route-dump-b --shell route Received signal: <STARTTC> linux-linaro-ubuntu-route-dump-b <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-route-dump-b> Kernel IP routing table Destination Gateway Genmask Flags Metric Ref Use Iface Received signal: <ENDTC> linux-linaro-ubuntu-route-dump-b <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-route-dump-b> Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-route-dump-b RESULT=pass case: linux-linaro-ubuntu-route-dump-b
case_id: 60928
definition: 2_singlenode-advanced
endtc: 1154
result: pass
starttc: 1150
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-route-dump-b RESULT=pass> + lava-test-case ping-test --shell ping -W1 -c1 www.linaro.org Received signal: <STARTTC> ping-test <LAVA_SIGNAL_STARTTC ping-test> ping: www.linaro.org: Temporary failure in name resolution <LAVA_SIGNAL_ENDTC ping-test> Received signal: <ENDTC> ping-test Received signal: <TESTCASE> TEST_CASE_ID=ping-test RESULT=fail case: ping-test
case_id: 60929
definition: 2_singlenode-advanced
endtc: 1164
result: fail
starttc: 1160
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ping-test RESULT=fail> + lava-test-case curl-http --shell curl -o img.tar.gz http://images.validation.linaro.org/lava-masters/dynamic/cubietruck/cbtruck_img.tar.gz <LAVA_SIGNAL_STARTTC curl-http> Received signal: <STARTTC> curl-http /lava-3187/0/../bin/lava-test-case: line 27: curl: command not found Received signal: <ENDTC> curl-http <LAVA_SIGNAL_ENDTC curl-http> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=curl-http RESULT=fail> Received signal: <TESTCASE> TEST_CASE_ID=curl-http RESULT=fail case: curl-http
case_id: 60930
definition: 2_singlenode-advanced
endtc: 1172
result: fail
starttc: 1170
+ lava-test-case tar-tgz --shell tar -tzf img.tar.gz Received signal: <STARTTC> tar-tgz <LAVA_SIGNAL_STARTTC tar-tgz> tar (child): img.tar.gz: Cannot open: No such file or directory tar (child): Error is not recoverable: exiting now tar: Child returned status 2 tar: Error is not recoverable: exiting now <LAVA_SIGNAL_ENDTC tar-tgz> Received signal: <ENDTC> tar-tgz Received signal: <TESTCASE> TEST_CASE_ID=tar-tgz RESULT=fail case: tar-tgz
case_id: 60931
definition: 2_singlenode-advanced
endtc: 1185
result: fail
starttc: 1178
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=tar-tgz RESULT=fail> + lava-test-case remove-tgz --shell rm img.tar.gz Received signal: <STARTTC> remove-tgz <LAVA_SIGNAL_STARTTC remove-tgz> rm: cannot remove 'img.tar.gz': No such file or directory Received signal: <ENDTC> remove-tgz <LAVA_SIGNAL_ENDTC remove-tgz> <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=remove-tgz RESULT=fail> Received signal: <TESTCASE> TEST_CASE_ID=remove-tgz RESULT=fail case: remove-tgz
case_id: 60932
definition: 2_singlenode-advanced
endtc: 1193
result: fail
starttc: 1190
+ set +x Received signal: <ENDRUN> 2_singlenode-advanced 3187_1.2.3.9 Ending use of test pattern. Ending test lava.2_singlenode-advanced (3187_1.2.3.9), duration 3.32 case: 2_singlenode-advanced
case_id: 60933
commit_id: b79f2809e243d66743b25b3fecc8df3449db1a16
definition: lava
duration: 3.32
namespace: common
path: lava-test-shell/single-node/singlenode03.yaml
repository: http://git.linaro.org/lava-team/lava-functional-tests.git
result: pass
revision: unspecified
uuid: 3187_1.2.3.9
<LAVA_SIGNAL_ENDRUN 2_singlenode-advanced 3187_1.2.3.9> <LAVA_TEST_RUNNER EXIT> ok: lava_test_shell seems to have completed curl-http: fail install-base: fail linux-linaro-ubuntu-ifconfig-dump: pass linux-linaro-ubuntu-netstat: pass linux-linaro-ubuntu-route-dump-a: pass linux-linaro-ubuntu-route-dump-b: pass linux-linaro-ubuntu-route-ifconfig-up-lo: pass linux-posix-ifconfig: pass linux-posix-lsb_release: fail linux-posix-lscpu: pass linux-posix-pwd: pass linux-posix-uname: pass linux-posix-vmstat: pass ping-test: fail remove-tgz: fail tar-tgz: fail end: 3.1 lava-test-shell (duration 00:00:04) [common] end: 3 lava-test-retry (duration 00:00:04) [common] start: 4 finalize (timeout 00:00:30) [common] start: 4.1 power-off (timeout 00:00:10) [common] end: 4.1 power-off (duration 00:00:00) [common] start: 4.2 read-feedback (timeout 00:00:30) [common] Listened to connection for namespace 'common' for 1s Finalising connection for namespace 'common' poweroff root@debian:~# poweroff Disconnecting QemuSession Already disconnected end: 4.2 read-feedback (duration 00:00:03) [common] Disconnecting QemuSession Already disconnected end: 4 finalize (duration 00:00:03) [common] Cleaning after the job Cleaning up download directory: /var/lib/lava/dispatcher/tmp/lavafed-3187/deployimages-v4wf_p42/rootfs Root tmp directory removed at /var/lib/lava/dispatcher/tmp/lavafed-3187 Job finished correctly case: job
case_id: 60934
definition: lava
result: pass

Top of page

Please read the triage guidelines for help on debugging failures in the test job, test definitions or in individual test cases.

Job Details YAML

Pipeline jobs use the job definition to generate a descriptive YAML file when the pipeline is validated. The file represents the data sent to the dispatcher at the start of the job, including details of the device as well as the job parameters and the details of the parameters sent to each of the deploy, boot and test actions in the job pipeline.

Click on the Metadata, Device or Job Actions headings below to see some of the information from the description file for this job or download the complete file as YAML using the link above.

device.name
staging-qemu01
device.type
qemu
features.0.action
deploy
features.0.description
Deploy to tmpfs
features.0.name
deploy.tmpfs
features.0.type
device
features.1.action
boot
features.1.description
Boot qemu
features.1.name
boot.qemu
features.1.type
device
features.2.action
test
features.2.description
Test definition from git
features.2.name
test.definition.git
features.2.type
device
features.3.action
test
features.3.description
Inline test definition
features.3.name
test.definition.inline
features.3.type
device
job.name
qemu - health-check
job.type
test
job.url
https://federation.lavasoftware.org/lava/scheduler/job/{id}
lab.name
staging.validation.linaro.org
slave.arch
amd64
slave.version
2020.09.0034.g6f5ba14a3
device type
hostname
timeouts
  • actions: {'minutes': 2}{'minutes': 2}{'minutes': 2}{'minutes': 2}{'minutes': 3}{'minutes': 3}{'seconds': 30}{'minutes': 3}{'minutes': 10}{'minutes': 5}{'minutes': 20}{'minutes': 5}{'minutes': 3}{'minutes': 1}{'minutes': 3}{'minutes': 10}{'seconds': 30}{'seconds': 10}{'seconds': 30}{'seconds': 30}{'minutes': 3}{'minutes': 3}{'seconds': 45} apply-overlay-imageauto-login-actionboot-image-retryboot-qemu-imagebootloader-actionbootloader-commandsbootloader-interruptbootloader-retrydd-imagedownload-retryflash-uboot-umshttp-downloadlava-test-shellmusca-bootmusca-deploynfs-deploypdu-rebootpower-offreset-deviceu-boot-interruptuboot-actionuboot-commandsumount-retry
  • connections: {'minutes': 2}{'seconds': 30}{'seconds': 30}{'minutes': 10}{'seconds': 10}{'seconds': 10}{'seconds': 30}{'seconds': 30} auto-login-actionbootloader-commandsbootloader-interruptdd-imagelava-docker-test-shelllava-test-shellu-boot-interruptuboot-commands
device action methods
boot:
  • qemu:
    • boot_options: {'boot_order': 'c', 'console': 'ttyS0,115200', 'root': '/dev/sda1'}
    • command: qemu-system-x86_64
    • options: ['-cpu host', '-enable-kvm', '-nographic', '-net nic,model=virtio,macaddr=DE:AD:BE:EF:32:01 -net tap', '-m 1024', '-monitor none']
  • qemu-nfs:
    • append: {'console': 'ttyAMA0', 'ipargs': 'ip=dhcp', 'nfsrootargs': 'nfsroot={NFS_SERVER_IP}:{NFSROOTFS},tcp,hard', 'root': '/dev/nfs'}
    • boot_options: {'boot_order': 'c', 'console': 'ttyS0,115200', 'root': '/dev/sda1'}
    • command: qemu-system-x86_64
    • options: ['-cpu host', '-enable-kvm', '-nographic', '-net nic,model=virtio,macaddr=DE:AD:BE:EF:32:01 -net tap', '-m 1024', '-monitor none']
deploy:
  • image:
    • guest: {'driveid': 'lavatest', 'interface': 'ide', 'size': 512}
  • lxc:
  • nfs:
target
...
timeouts
  • job: {'seconds': 360}

  1. deployment_data
    {'TESTER_PS1': 'linaro-test [rc=$(echo \\$?)]# ', 'TESTER_PS1_INCLUDES_RC': True, 'TESTER_PS1_PATTERN': 'linaro-test \\[rc=(\\d+)\\]# ', 'boot_cmds': 'boot_cmds', 'distro': 'debian', 'lava_test_dir': '/lava-%s', 'lava_test_results_dir': '/lava-%s', 'lava_test_results_part_attr': 'root_part', 'lava_test_sh_cmd': '/bin/bash', 'lava_test_shell_file': '~/.bashrc', 'line_separator': '\n', 'tar_flags': '--warning no-timestamp'}
    images
    {'rootfs': {'compression': 'gz', 'image_arg': '-drive format=raw,file={rootfs}', 'url': 'http://images.validation.linaro.org/kvm/standard/large-stretch-2.img.gz'}}
    namespace
    common
    os
    debian
    root_partition
    1
    Timeout
    • 6 minutes
    to
    tmpfs

  1. auto_login
    {'login_prompt': 'login:', 'username': 'root'}
    media
    tmpfs
    method
    qemu
    namespace
    common
    prompts
    ['root@debian:']
    Timeout
    • 2 minutes

  1. Definitions
    • from inline
    • name env-dut-inline
    • path inline/env-dut.yaml
    • repository {'metadata': {'description': 'Basic system test command for Linaro Ubuntu images', 'format': 'Lava-Test Test Definition 1.0', 'name': 'smoke-tests-basic'}, 'run': {'steps': ['printenv']}}
    • from git
    • name smoke-tests
    • path lava-test-shell/smoke-tests-basic.yaml
    • repository http://git.linaro.org/lava-team/lava-functional-tests.git
    • from git
    • name singlenode-advanced
    • path lava-test-shell/single-node/singlenode03.yaml
    • repository http://git.linaro.org/lava-team/lava-functional-tests.git
    namespace
    common
    stage
    0
    Timeout
    • 5 minutes

Job Timings

This section helps test writers to check for actions with a duration which is much shorter than the requested timeout. Reducing these timeouts will allow failures to be identified more quickly.

The graph only shows actions that are longer than 1 second. The full list is anyway available in the table.

Loading the data...