Help
Invalid job definition:

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

Description
[lavafed 2019.05.0008.gbefefba4f] qemu - hikey
Device-type
qemu
Submitter
Rémi Duraffort
Created
3 months, 1 week ago
Priority
Medium
Visibility
Public
Required Tags
staging.validation.linaro.org
#584
Complete
Device
staging-qemu01@staging.validation.linaro.org
Started
3 months, 1 week ago
Duration
3 minutes
Results
  
lava-dispatcher, installed at version: 2019.05.0008.gbefefba4f+stretch start: 0 validate Start time: 2019-06-07 09:10:15.877011+00:00 (UTC) Validating that http://snapshots.linaro.org/openembedded/lkft/morty/hikey/rpb/linux-stable-rc-4.14/64/Image--4.14+git0+ae407d95ee-r0-hikey-20180108141340-64.bin exists Validating that http://snapshots.linaro.org/openembedded/lkft/morty/hikey/rpb/linux-stable-rc-4.14/64/rpb-console-image-hikey-20180108141340-64.rootfs.ext4.gz exists Using GET because HEAD is not supported properly qemu-system-arm, installed at version: 1:2.8+dfsg-6+deb9u6, host architecture: amd64 validate duration: 1.43 case: validate
case_id: 12682
definition: lava
result: pass
start: 1 deployimages (timeout 00:10:00) [common] start: 1.1 download-retry (timeout 00:10:00) [common] start: 1.1.1 http-download (timeout 00:10:00) [common] downloading http://snapshots.linaro.org/openembedded/lkft/morty/hikey/rpb/linux-stable-rc-4.14/64/Image--4.14+git0+ae407d95ee-r0-hikey-20180108141340-64.bin saving as /var/lib/lava/dispatcher/tmp/lavafed-584/deployimages-nikxzhu3/kernel/Image--4.14+git0+ae407d95ee-r0-hikey-20180108141340-64.bin total size: 19952128 (19MB) No compression specified progress 0% (0MB) progress 5% (0MB) progress 10% (1MB) progress 15% (2MB) progress 20% (3MB) progress 25% (4MB) progress 30% (5MB) progress 35% (6MB) progress 40% (7MB) progress 45% (8MB) progress 50% (9MB) progress 55% (10MB) progress 60% (11MB) progress 65% (12MB) progress 70% (13MB) progress 75% (14MB) progress 80% (15MB) progress 85% (16MB) progress 90% (17MB) progress 95% (18MB) progress 100% (19MB) 19MB downloaded in 0.72s (26.60MB/s) end: 1.1.1 http-download (duration 00:00:01) [common] case: http-download
case_id: 12683
definition: lava
duration: 0.72
extra: ...
level: 1.1.1
namespace: common
result: pass
end: 1.1 download-retry (duration 00:00:01) [common] start: 1.2 download-retry (timeout 00:09:59) [common] start: 1.2.1 http-download (timeout 00:09:59) [common] downloading http://snapshots.linaro.org/openembedded/lkft/morty/hikey/rpb/linux-stable-rc-4.14/64/rpb-console-image-hikey-20180108141340-64.rootfs.ext4.gz saving as /var/lib/lava/dispatcher/tmp/lavafed-584/deployimages-nikxzhu3/rootfs/rpb-console-image-hikey-20180108141340-64.rootfs.ext4 total size: 361037083 (344MB) Using gunzip to decompress gz progress 0% (0MB) progress 5% (17MB) progress 10% (34MB) progress 15% (51MB) progress 20% (68MB) progress 25% (86MB) progress 30% (103MB) progress 35% (120MB) progress 40% (137MB) progress 45% (154MB) progress 50% (172MB) progress 55% (189MB) progress 60% (206MB) progress 65% (223MB) progress 70% (241MB) progress 75% (258MB) progress 80% (275MB) progress 85% (292MB) progress 90% (309MB) progress 95% (327MB) progress 100% (344MB) 344MB downloaded in 46.41s (7.42MB/s) end: 1.2.1 http-download (duration 00:00:46) [common] case: http-download
case_id: 12683
definition: lava
duration: 46.41
extra: ...
level: 1.2.1
namespace: common
result: pass
end: 1.2 download-retry (duration 00:00:46) [common] start: 1.3 lava-overlay (timeout 00:09:13) [common] [common] Preparing overlay tarball in /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6 makedir: /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin makedir: /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/tests makedir: /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/results Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-add-keys Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-add-sources Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-background-process-start Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-background-process-stop Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-common-functions Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-echo-ipv4 Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-install-packages Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-installed-packages Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-os-build Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-probe-channel Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-probe-ip Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-target-ip Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-target-mac Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-target-storage Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-case Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-event Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-feedback Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-raise Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-reference Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-runner Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-set Creating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-test-shell Updating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-install-packages (oe) Updating /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/bin/lava-installed-packages (oe) start: 1.3.1 lava-vland-overlay (timeout 00:09:13) [common] skipped lava-vland-overlay end: 1.3.1 lava-vland-overlay (duration 00:00:00) [common] start: 1.3.2 lava-multinode-overlay (timeout 00:09:13) [common] skipped lava-multinode-overlay end: 1.3.2 lava-multinode-overlay (duration 00:00:00) [common] start: 1.3.3 test-definition (timeout 00:09:13) [common] Loading test definitions start: 1.3.3.1 git-repo-action (timeout 00:09:13) [common] Using /lava-584 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-584/lava-overlay-ah7fnxm6/lava-584/0/tests/0_smoke-tests --depth=1' Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/0/tests/0_smoke-tests/lava-test-shell/smoke-tests-basic.yaml uuid=584_1.3.3.1 testdef=None end: 1.3.3.1 git-repo-action (duration 00:00:00) [common] case: git-repo-action
case_id: 12734
definition: lava
duration: 0.40
extra: ...
level: 1.3.3.1
namespace: common
result: pass
start: 1.3.3.2 test-overlay (timeout 00:09:12) [common] end: 1.3.3.2 test-overlay (duration 00:00:00) [common] case: test-overlay
case_id: 12735
definition: lava
duration: 0.01
extra: ...
level: 1.3.3.2
namespace: common
result: pass
start: 1.3.3.3 test-install-overlay (timeout 00:09:12) [common] end: 1.3.3.3 test-install-overlay (duration 00:00:00) [common] case: test-install-overlay
case_id: 12736
definition: lava
duration: 0.04
extra: ...
level: 1.3.3.3
namespace: common
result: pass
start: 1.3.3.4 test-runscript-overlay (timeout 00:09:12) [common] runner path: /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/0/tests/0_smoke-tests test_uuid 584_1.3.3.1 end: 1.3.3.4 test-runscript-overlay (duration 00:00:00) [common] case: test-runscript-overlay
case_id: 12737
definition: lava
duration: 0.04
extra: ...
level: 1.3.3.4
namespace: common
result: pass
start: 1.3.3.5 git-repo-action (timeout 00:09:12) [common] Using /lava-584 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-584/lava-overlay-ah7fnxm6/lava-584/0/tests/1_singlenode-basic --depth=1' Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/0/tests/1_singlenode-basic/lava-test-shell/single-node/singlenode01.yaml uuid=584_1.3.3.5 testdef=None end: 1.3.3.5 git-repo-action (duration 00:00:00) [common] case: git-repo-action
case_id: 12734
definition: lava
duration: 0.19
extra: ...
level: 1.3.3.5
namespace: common
result: pass
start: 1.3.3.6 test-overlay (timeout 00:09:12) [common] end: 1.3.3.6 test-overlay (duration 00:00:00) [common] case: test-overlay
case_id: 12735
definition: lava
duration: 0.01
extra: ...
level: 1.3.3.6
namespace: common
result: pass
start: 1.3.3.7 test-install-overlay (timeout 00:09:12) [common] end: 1.3.3.7 test-install-overlay (duration 00:00:00) [common] case: test-install-overlay
case_id: 12736
definition: lava
duration: 0.04
extra: ...
level: 1.3.3.7
namespace: common
result: pass
start: 1.3.3.8 test-runscript-overlay (timeout 00:09:12) [common] runner path: /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/0/tests/1_singlenode-basic test_uuid 584_1.3.3.5 end: 1.3.3.8 test-runscript-overlay (duration 00:00:00) [common] case: test-runscript-overlay
case_id: 12737
definition: lava
duration: 0.03
extra: ...
level: 1.3.3.8
namespace: common
result: pass
Creating lava-test-runner.conf files Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/lavafed-584/lava-overlay-ah7fnxm6/lava-584/0 for stage 0 - 0_smoke-tests - 1_singlenode-basic end: 1.3.3 test-definition (duration 00:00:01) [common] start: 1.3.4 compress-overlay (timeout 00:09:12) [common] end: 1.3.4 compress-overlay (duration 00:00:00) [common] start: 1.3.5 persistent-nfs-overlay (timeout 00:09:12) [common] end: 1.3.5 persistent-nfs-overlay (duration 00:00:00) [common] end: 1.3 lava-overlay (duration 00:00:01) [common] start: 1.4 apply-overlay-guest (timeout 00:09:12) [common] Overlay: /var/lib/lava/dispatcher/tmp/lavafed-584/compress-overlay-8km84xm5/overlay-1.3.4.tar.gz end: 1.4 apply-overlay-guest (duration 00:00:06) [common] case: apply-overlay-guest
case_id: 12742
definition: lava
duration: 5.68
extra: ...
level: 1.4
namespace: common
result: pass
start: 1.5 deploy-device-env (timeout 00:09:06) [common] end: 1.5 deploy-device-env (duration 00:00:00) [common] end: 1 deployimages (duration 00:00:54) [common] start: 2 boot-image-retry (timeout 00:05:00) [common] start: 2.1 boot-qemu-image (timeout 00:05:00) [common] start: 2.1.1 execute-qemu (timeout 00:05:00) [common] Extending command line for qcow2 test overlay Boot command: /usr/bin/qemu-system-aarch64 -cpu cortex-a57 -machine virt -nographic -net nic,model=virtio,macaddr=DE:AD:BE:EF:32:01 -net user -m 1024 -monitor none -kernel /var/lib/lava/dispatcher/tmp/lavafed-584/deployimages-nikxzhu3/kernel/Image--4.14+git0+ae407d95ee-r0-hikey-20180108141340-64.bin --append "console=ttyAMA0 root=/dev/vda rw" -drive format=raw,file=/var/lib/lava/dispatcher/tmp/lavafed-584/deployimages-nikxzhu3/rootfs/rpb-console-image-hikey-20180108141340-64.rootfs.ext4 -cpu cortex-a57 -machine type=virt -nographic -smp 4 -m 2048 -drive format=qcow2,file=/var/lib/lava/dispatcher/tmp/lavafed-584/apply-overlay-guest-1o_85xad/lava-guest.qcow2,media=disk,if=virtio,id=lavatest started a shell command end: 2.1.1 execute-qemu (duration 00:00:01) [common] case: execute-qemu
case_id: 12743
definition: lava
duration: 1.14
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:04:59) [common] auto-login-action: Wait for prompt ['Linux version [0-9]'] (timeout 00:05:00) [ 0.000000] Booting Linux on physical CPU 0x0 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@hikey:~#', 'login:', 'Login incorrect'] [auto-login-action] Waiting for messages, (timeout 00:04:57) [ 0.000000] Linux version 4.14.13-rc1 (buildslave@x86-64-08) (gcc version 6.2.1 20161016 (Linaro GCC 6.2-2016.11)) #1 SMP PREEMPT Mon Jan 8 14:21:41 UTC 2018 [ 0.000000] Boot CPU: AArch64 Processor [411fd070] [ 0.000000] Machine model: linux,dummy-virt [ 0.000000] efi: Getting EFI parameters from FDT: [ 0.000000] efi: UEFI not found. [ 0.000000] cma: Reserved 16 MiB at 0x00000000bf000000 [ 0.000000] NUMA: No NUMA configuration found [ 0.000000] NUMA: Faking a node at [mem 0x0000000000000000-0x00000000bfffffff] [ 0.000000] NUMA: NODE_DATA [mem 0xbefe9480-0xbefeb0ff] [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] Initmem setup node 0 [mem 0x0000000040000000-0x00000000bfffffff] [ 0.000000] psci: probing for conduit method from DT. [ 0.000000] psci: PSCIv0.2 detected in firmware. [ 0.000000] psci: Using standard PSCI v0.2 function IDs [ 0.000000] psci: Trusted OS migration not required [ 0.000000] percpu: Embedded 25 pages/cpu @ffff80007ef80000 s64456 r8192 d29752 u102400 [ 0.000000] Detected PIPT I-cache on CPU0 [ 0.000000] CPU features: enabling workaround for ARM erratum 832075 [ 0.000000] CPU features: enabling workaround for ARM erratum 834220 [ 0.000000] Built 1 zonelists, mobility grouping on. Total pages: 516096 [ 0.000000] Policy zone: DMA [ 0.000000] Kernel command line: console=ttyAMA0 root=/dev/vda rw [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Memory: 2015476K/2097152K available (11324K kernel code, 1820K rwdata, 5044K rodata, 1280K init, 12405K bss, 65292K reserved, 16384K cma-reserved) [ 0.000000] Virtual kernel memory layout: [ 0.000000] modules : 0xffff000000000000 - 0xffff000008000000 ( 128 MB) [ 0.000000] vmalloc : 0xffff000008000000 - 0xffff7dffbfff0000 (129022 GB) [ 0.000000] .text : 0xffff000008080000 - 0xffff000008b90000 ( 11328 KB) [ 0.000000] .rodata : 0xffff000008b90000 - 0xffff000009080000 ( 5056 KB) [ 0.000000] .init : 0xffff000009080000 - 0xffff0000091c0000 ( 1280 KB) [ 0.000000] .data : 0xffff0000091c0000 - 0xffff000009387200 ( 1821 KB) [ 0.000000] .bss : 0xffff000009387200 - 0xffff000009fa4868 ( 12406 KB) [ 0.000000] fixed : 0xffff7dfffe7fb000 - 0xffff7dfffec00000 ( 4116 KB) [ 0.000000] PCI I/O : 0xffff7dfffee00000 - 0xffff7dffffe00000 ( 16 MB) [ 0.000000] vmemmap : 0xffff7e0000000000 - 0xffff800000000000 ( 2048 GB maximum) [ 0.000000] 0xffff7e0000000000 - 0xffff7e0002000000 ( 32 MB actual) [ 0.000000] memory : 0xffff800000000000 - 0xffff800080000000 ( 2048 MB) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.000000] Running RCU self tests [ 0.000000] Preemptible hierarchical RCU implementation. [ 0.000000] RCU lockdep checking is enabled. [ 0.000000] RCU restricting CPUs from NR_CPUS=64 to nr_cpu_ids=4. [ 0.000000] Tasks RCU enabled. [ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4 [ 0.000000] NR_IRQS: 64, nr_irqs: 64, preallocated irqs: 0 [ 0.000000] GICv2m: range[mem 0x08020000-0x08020fff], SPI[80:143] [ 0.000000] arch_timer: WARNING: Invalid trigger for IRQ3, assuming level low [ 0.000000] arch_timer: WARNING: Please fix your firmware [ 0.000000] arch_timer: cp15 timer(s) running at 62.50MHz (virt). [ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x1cd42e208c, max_idle_ns: 881590405314 ns [ 0.000273] sched_clock: 56 bits at 62MHz, resolution 16ns, wraps every 4398046511096ns [ 0.015544] Console: colour dummy device 80x25 [ 0.016869] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.016967] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.017048] ... MAX_LOCK_DEPTH: 48 [ 0.017128] ... MAX_LOCKDEP_KEYS: 8191 [ 0.017207] ... CLASSHASH_SIZE: 4096 [ 0.017285] ... MAX_LOCKDEP_ENTRIES: 32768 [ 0.017363] ... MAX_LOCKDEP_CHAINS: 65536 [ 0.017441] ... CHAINHASH_SIZE: 32768 [ 0.017519] memory used by lock dependency info: 7391 kB [ 0.017596] per task-struct memory footprint: 1920 bytes [ 0.019463] Calibrating delay loop (skipped), value calculated using timer frequency.. 125.00 BogoMIPS (lpj=250000) [ 0.019805] pid_max: default: 32768 minimum: 301 [ 0.022666] Security Framework initialized [ 0.030192] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes) [ 0.033778] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.034489] Mount-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.034721] Mountpoint-cache hash table entries: 4096 (order: 3, 32768 bytes) [ 0.117213] ASID allocator initialised with 65536 entries [ 0.121326] Hierarchical SRCU implementation. [ 0.148657] EFI services will not be available. [ 0.160558] smp: Bringing up secondary CPUs ... [ 0.189694] Detected PIPT I-cache on CPU1 [ 0.192574] CPU1: Booted secondary processor [411fd070] [ 0.236533] Detected PIPT I-cache on CPU2 [ 0.236948] CPU2: Booted secondary processor [411fd070] [ 0.272107] Detected PIPT I-cache on CPU3 [ 0.273191] CPU3: Booted secondary processor [411fd070] [ 0.276980] smp: Brought up 1 node, 4 CPUs [ 0.277758] SMP: Total of 4 processors activated. [ 0.278005] CPU features: detected feature: 32-bit EL0 Support [ 0.315230] CPU: All CPU(s) started at EL1 [ 0.318440] alternatives: patching kernel code [ 0.390587] devtmpfs: initialized [ 0.458168] random: get_random_u32 called from bucket_table_alloc+0x11c/0x270 with crng_init=0 [ 0.539684] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns [ 0.540840] futex hash table entries: 1024 (order: 5, 131072 bytes) [ 0.557326] pinctrl core: initialized pinctrl subsystem [ 0.597321] random: fast init done [ 0.675126] DMI not present or invalid. [ 0.731857] NET: Registered protocol family 16 [ 0.849038] cpuidle: using governor menu [ 0.878616] vdso: 2 pages (1 code @ ffff000008b96000, 1 data @ ffff0000091c5000) [ 0.891508] hw-breakpoint: found 6 breakpoint and 4 watchpoint registers. [ 0.943975] DMA: preallocated 256 KiB pool for atomic allocations [ 0.988943] Serial: AMBA PL011 UART driver [ 1.434018] 9000000.pl011: ttyAMA0 at MMIO 0x9000000 (irq = 39, base_baud = 0) is a PL011 rev1 [ 1.503134] console [ttyAMA0] enabled [ 1.579671] irq: type mismatch, failed to map hwirq-27 for /intc! [ 3.169757] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages [ 3.240098] ACPI: Interpreter disabled. [ 3.315515] vgaarb: loaded [ 3.336853] SCSI subsystem initialized [ 3.390476] usbcore: registered new interface driver usbfs [ 3.392420] usbcore: registered new interface driver hub [ 3.399267] usbcore: registered new device driver usb [ 3.461072] pps_core: LinuxPPS API ver. 1 registered [ 3.461529] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> [ 3.462618] PTP clock support registered [ 3.473861] EDAC MC: Ver: 3.0.0 [ 3.512156] dmi: Firmware registration failed. [ 3.551990] Advanced Linux Sound Architecture Driver Initialized. [ 3.621221] clocksource: Switched to clocksource arch_sys_counter [ 5.924414] VFS: Disk quotas dquot_6.6.0 [ 5.926279] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 5.942242] pnp: PnP ACPI: disabled [ 6.811228] NET: Registered protocol family 2 [ 6.890206] TCP established hash table entries: 16384 (order: 5, 131072 bytes) [ 6.898029] TCP bind hash table entries: 16384 (order: 8, 1048576 bytes) [ 6.962393] TCP: Hash tables configured (established 16384 bind 16384) [ 6.977669] UDP hash table entries: 1024 (order: 5, 163840 bytes) [ 6.989947] UDP-Lite hash table entries: 1024 (order: 5, 163840 bytes) [ 7.010629] NET: Registered protocol family 1 [ 7.039581] RPC: Registered named UNIX socket transport module. [ 7.040937] RPC: Registered udp transport module. [ 7.041471] RPC: Registered tcp transport module. [ 7.041966] RPC: Registered tcp NFSv4.1 backchannel transport module. [ 7.078069] kvm [1]: HYP mode not available [ 7.447017] audit: initializing netlink subsys (disabled) [ 7.469819] audit: type=2000 audit(6.592:1): state=initialized audit_enabled=0 res=1 [ 7.526332] workingset: timestamp_bits=44 max_order=19 bucket_order=0 [ 8.788653] squashfs: version 4.0 (2009/01/31) Phillip Lougher [ 8.885462] NFS: Registering the id_resolver key type [ 8.893230] Key type id_resolver registered [ 8.893906] Key type id_legacy registered [ 8.894760] nfs4filelayout_init: NFSv4 File Layout Driver Registering... [ 8.924443] 9p: Installing v9fs 9p2000 file system support [ 9.151071] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246) [ 9.153964] io scheduler noop registered [ 9.165598] io scheduler cfq registered (default) [ 9.166198] io scheduler mq-deadline registered [ 9.166737] io scheduler kyber registered [ 9.189055] test_firmware: interface ready [ 9.431199] pl061_gpio 9030000.pl061: PL061 GPIO chip @0x0000000009030000 registered [ 9.834325] OF: PCI: host bridge /pcie@10000000 ranges: [ 9.837598] OF: PCI: IO 0x3eff0000..0x3effffff -> 0x00000000 [ 9.839339] OF: PCI: MEM 0x10000000..0x3efeffff -> 0x10000000 [ 9.841589] OF: PCI: MEM 0x8000000000..0xffffffffff -> 0x8000000000 [ 9.862373] pci-host-generic 3f000000.pcie: ECAM at [mem 0x3f000000-0x3fffffff] for [bus 00-0f] [ 9.886516] pci-host-generic 3f000000.pcie: PCI host bridge to bus 0000:00 [ 9.889971] pci_bus 0000:00: root bus resource [bus 00-0f] [ 9.890588] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 9.891108] pci_bus 0000:00: root bus resource [mem 0x10000000-0x3efeffff] [ 9.894569] pci_bus 0000:00: root bus resource [mem 0x8000000000-0xffffffffff] [ 9.969178] pci 0000:00:01.0: BAR 6: assigned [mem 0x10000000-0x1003ffff pref] [ 9.973344] pci 0000:00:01.0: BAR 4: assigned [mem 0x8000000000-0x8000003fff 64bit pref] [ 9.977156] pci 0000:00:02.0: BAR 4: assigned [mem 0x8000004000-0x8000007fff 64bit pref] [ 9.978896] pci 0000:00:03.0: BAR 4: assigned [mem 0x8000008000-0x800000bfff 64bit pref] [ 9.983100] pci 0000:00:01.0: BAR 1: assigned [mem 0x10040000-0x10040fff] [ 9.986632] pci 0000:00:02.0: BAR 1: assigned [mem 0x10041000-0x10041fff] [ 9.987390] pci 0000:00:03.0: BAR 1: assigned [mem 0x10042000-0x10042fff] [ 9.990342] pci 0000:00:02.0: BAR 0: assigned [io 0x1000-0x103f] [ 9.991084] pci 0000:00:03.0: BAR 0: assigned [io 0x1040-0x107f] [ 9.994171] pci 0000:00:01.0: BAR 0: assigned [io 0x1080-0x109f] [ 10.676773] virtio-pci 0000:00:01.0: enabling device (0000 -> 0003) [ 10.698196] virtio-pci 0000:00:02.0: enabling device (0000 -> 0003) [ 10.729231] virtio-pci 0000:00:03.0: enabling device (0000 -> 0003) [ 11.248782] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled [ 11.373803] SuperH (H)SCI(F) driver initialized [ 11.438013] msm_serial: driver initialized [ 11.501563] cacheinfo: Unable to detect cache hierarchy for CPU 0 [ 12.010973] loop: module loaded [ 13.035176] libphy: Fixed MDIO Bus: probed [ 13.324763] e1000e: Intel(R) PRO/1000 Network Driver - 3.2.6-k [ 13.325275] e1000e: Copyright(c) 1999 - 2015 Intel Corporation. [ 13.326814] igb: Intel(R) Gigabit Ethernet Network Driver - version 5.4.0-k [ 13.327372] igb: Copyright (c) 2007-2014 Intel Corporation. [ 13.330834] igbvf: Intel(R) Gigabit Virtual Function Network Driver - version 2.4.0-k [ 13.331440] igbvf: Copyright (c) 2009 - 2012 Intel Corporation. [ 13.342731] sky2: driver version 1.30 [ 13.403165] VFIO - User Level meta-driver version: 0.3 [ 13.513874] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 13.514530] ehci-pci: EHCI PCI platform driver [ 13.517526] ehci-platform: EHCI generic platform driver [ 13.521136] ehci-orion: EHCI orion driver [ 13.523181] ehci-exynos: EHCI EXYNOS driver [ 13.528730] ehci-msm: Qualcomm On-Chip EHCI Host Controller [ 13.530855] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 13.532974] ohci-pci: OHCI PCI platform driver [ 13.534728] ohci-platform: OHCI generic platform driver [ 13.538136] ohci-exynos: OHCI EXYNOS driver [ 13.574582] usbcore: registered new interface driver usb-storage [ 13.818736] rtc-pl031 9010000.pl031: rtc core: registered pl031 as rtc0 [ 13.841282] i2c /dev entries driver [ 14.165560] sdhci: Secure Digital Host Controller Interface driver [ 14.166244] sdhci: Copyright(c) Pierre Ossman [ 14.173775] Synopsys Designware Multimedia Card Interface Driver [ 14.197534] sdhci-pltfm: SDHCI platform and OF driver helper [ 14.410443] ledtrig-cpu: registered to indicate activity on CPUs [ 14.494038] usbcore: registered new interface driver usbhid [ 14.494663] usbhid: USB HID core driver [ 14.745944] NET: Registered protocol family 10 [ 14.886050] Segment Routing with IPv6 [ 14.889016] sit: IPv6, IPv4 and MPLS over IPv4 tunneling driver [ 14.933835] NET: Registered protocol family 17 [ 14.945887] 9pnet: Installing 9P2000 support [ 14.953491] Key type dns_resolver registered [ 15.106962] registered taskstats version 1 [ 15.177456] input: gpio-keys as /devices/platform/gpio-keys/input/input0 [ 15.218448] rtc-pl031 9010000.pl031: setting system clock to 2019-06-07 09:11:28 UTC (1559898688) [ 15.235177] ALSA device list: [ 15.237327] No soundcards found. [ 15.260937] uart-pl011 9000000.pl011: no DMA platform data [ 15.305704] EXT4-fs (vda): couldn't mount as ext3 due to feature incompatibilities [ 15.485994] EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null) [ 15.489683] VFS: Mounted root (ext4 filesystem) on device 254:0. [ 15.542832] devtmpfs: mounted [ 15.785465] Freeing unused kernel memory: 1280K [ 16.828314] systemd[1]: systemd 230 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT +GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN) [ 16.843162] systemd[1]: Detected virtualization qemu. [ 16.845550] systemd[1]: Detected architecture arm64. [ 16.847042] systemd[1]: Running with unpopulated /etc. Welcome to [1mReference-Platform-Build-X11 2.2+linaro[0m! [ 16.870446] systemd[1]: Set hostname to <hikey>. [ 16.902021] systemd[1]: Initializing machine ID from random generator. [ 18.666277] systemd[1]: Failed to populate /etc with preset unit settings, ignoring: Too many levels of symbolic links [ 21.347007] systemd[1]: Reached target Remote File Systems. [[0;32m OK [0m] Reached target Remote File Systems. [ 21.370747] systemd[1]: Listening on Journal Audit Socket. [[0;32m OK [0m] Listening on Journal Audit Socket. [ 21.380865] systemd[1]: Listening on Network Service Netlink Socket. [[0;32m OK [0m] Listening on Network Service Netlink Socket. [[0;32m OK [0m] Listening on udev Control Socket. [[0;32m OK [0m] Listening on udev Kernel Socket. [[0;32m OK [0m] Listening on Journal Socket (/dev/log). [[0;32m OK [0m] Reached target Swap. [[0;32m OK [0m] Created slice System Slice. [[0;32m OK [0m] Created slice system-serial\x2dgetty.slice. [[0;32m OK [0m] Started Forward Password Requests to Wall Directory Watch. [[0;32m OK [0m] Listening on Syslog Socket. [[0;32m OK [0m] Created slice User and Session Slice. [[0;32m OK [0m] Reached target Slices. [[0;32m OK [0m] Listening on Journal Socket. Starting Setup Virtual Console... Mounting Temporary Directory... [ 21.830663] systemd[1]: Mounting Debug File System... Mounting Debug File System... [ 21.910187] systemd[1]: Mounting Huge Pages File System... Mounting Huge Pages File System... [ 22.116679] systemd[1]: Starting Journal Service... Starting Journal Service... [ 22.799238] systemd[1]: Mounting POSIX Message Queue File System... Mounting POSIX Message Queue File System... [ 23.535412] systemd[1]: Starting Load Kernel Modules... Starting Load Kernel Modules... [ 23.607268] systemd[1]: Created slice system-getty.slice. [[0;32m OK [0m] Created slice system-getty.slice. [ 23.650602] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. [[0;32m OK [0m] Listening on /dev/initctl Compatibility Named Pipe. [ 24.413319] 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... [ 24.546243] systemd[1]: Started Dispatch Password Requests to Console Directory Watch. [[0;32m OK [0m] Started Dispatch Password Requests to Console Directory Watch. [ 24.621634] systemd[1]: Reached target Paths. [[0;32m OK [0m] Reached target Paths. Starting Remount Root and Kernel File Systems... [[0;32m OK [0m] Mounted Debug File System. [[0;32m OK [0m] Mounted Huge Pages File System. [[0;32m OK [0m] Mounted POSIX Message Queue File System. [[0;32m OK [0m] Mounted Temporary Directory. [ 26.761583] fuse init (API version 7.26) [ 26.829464] EXT4-fs (vda): re-mounted. Opts: (null) [[0;32m OK [0m] Started Setup Virtual Console. [ 27.367195] systemd[1]: Started Create list of required static device nodes for the current kernel. [[0;32m OK [0m] Started Create list of required sta...ce nodes for the current kernel. [ 27.476368] systemd[1]: Started Load Kernel Modules. [[0;32m OK [0m] Started Load Kernel Modules. [ 27.612641] systemd[1]: Started Remount Root and Kernel File Systems. [[0;32m OK [0m] Started Remount Root and Kernel File Systems. [ 28.166016] systemd[1]: Started Journal Service. [[0;32m OK [0m] Started Journal Service. Starting Flush Journal to Persistent Storage... Starting Create System Users... Starting Rebuild Hardware Database... Mounting Configuration File System... Starting Apply Kernel Variables... Mounting FUSE Control File System... [[0;32m OK [0m] Mounted Configuration File System. [[0;32m OK [0m] Mounted FUSE Control File System. [[0;32m OK [0m] Started Apply Kernel Variables. [[0;32m OK [0m] Started Create System Users. [ 34.338851] systemd-journald[1315]: Received request to flush runtime journal from PID 1 Starting Create Static Device Nodes in /dev... [[0;32m OK [0m] Started Flush Journal to Persistent Storage. [[0;32m OK [0m] Started Create Static Device Nodes in /dev. Starting udev Kernel Device Manager... [[0;32m OK [0m] Reached target Local File Systems (Pre). Mounting /var/volatile... [[0;32m OK [0m] Mounted /var/volatile. [[0;32m OK [0m] Reached target Local File Systems. Starting Create Volatile Files and Directories... Starting Rebuild Journal Catalog... Starting Rebuild Dynamic Linker Cache... Starting Load/Save Random Seed... [[0;32m OK [0m] Started Create Volatile Files and Directories. Starting Network Time Synchronization... Starting Update UTMP about System Boot/Shutdown... [[0;32m OK [0m] Started udev Kernel Device Manager. [[0;32m OK [0m] Started Rebuild Journal Catalog. [[0;32m OK [0m] Started Load/Save Random Seed. [[0;32m OK [0m] Started Update UTMP about System Boot/Shutdown. [[0;32m OK [0m] Started Network Time Synchronization. [[0;32m OK [0m] Reached target System Time Synchronized. [[0m[0;31m* [0m] (1 of 5) A start job is running for...-ttyAMA2.device (32s / 1min 30s)[K[[0;1;31m*[0m[0;31m* [0m] (1 of 5) A start job is running for...-ttyAMA2.device (32s / 1min 30s)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 5) A start job is running for...-ttyAMA2.device (33s / 1min 30s)[K[[0;32m OK [0m] Started Rebuild Dynamic Linker Cache. [[0;32m OK [0m] Started Rebuild Hardware Database. Starting udev Coldplug all Devices... Starting Update is Completed... [[0;32m OK [0m] Started Update is Completed. [ [0;31m*[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (45s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (45s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (2 of 4) A start job is running for...-ttyAMA3.device (45s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m] (3 of 4) A start job is running for...lug all Devices (46s / no limit)[K[ [0;31m*[0m] (3 of 4) A start job is running for...lug all Devices (46s / no limit)[K[ [0;31m*[0;1;31m*[0m] (3 of 4) A start job is running for...lug all Devices (47s / no limit)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (4 of 4) A start job is running for...-ttyAMA0.device (48s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (4 of 4) A start job is running for...-ttyAMA0.device (48s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (4 of 4) A start job is running for...-ttyAMA0.device (49s / 1min 30s)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 4) A start job is running for...-ttyAMA2.device (49s / 1min 30s)[K[[0;1;31m*[0m[0;31m* [0m] (1 of 4) A start job is running for...-ttyAMA2.device (50s / 1min 30s)[K[[0m[0;31m* [0m] (1 of 4) A start job is running for...-ttyAMA2.device (50s / 1min 30s)[ 72.464367] hrtimer: interrupt took 12056512 ns [K[[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (51s / 1min 30s)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (51s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (52s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (3 of 4) A start job is running for...lug all Devices (52s / no limit)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (3 of 4) A start job is running for...lug all Devices (53s / no limit)[K[ [0;31m*[0;1;31m*[0m] (3 of 4) A start job is running for...lug all Devices (53s / no limit)[K[ [0;31m*[0m] (4 of 4) A start job is running for...-ttyAMA0.device (54s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m] (4 of 4) A start job is running for...-ttyAMA0.device (54s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (4 of 4) A start job is running for...-ttyAMA0.device (55s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 4) A start job is running for...-ttyAMA2.device (55s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 4) A start job is running for...-ttyAMA2.device (56s / 1min 30s)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 4) A start job is running for...-ttyAMA2.device (56s / 1min 30s)[K[[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (57s / 1min 30s)[K[[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (57s / 1min 30s)[K[[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...-ttyAMA3.device (58s / 1min 30s)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (3 of 4) A start job is running for...lug all Devices (58s / no limit)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (3 of 4) A start job is running for...lug all Devices (59s / no limit)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (3 of 4) A start job is running for...lug all Devices (59s / no limit)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (4 of 4) A start job is running for...ttyAMA0.device (1min / 1min 30s)[K[ [0;31m*[0;1;31m*[0m] (4 of 4) A start job is running for...ttyAMA0.device (1min / 1min 30s)[K[ [0;31m*[0m] (4 of 4) A start job is running for...AMA0.device (1min 1s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m] (1 of 4) A start job is running for...AMA2.device (1min 1s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (1 of 4) A start job is running for...AMA2.device (1min 2s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (1 of 4) A start job is running for...AMA2.device (1min 2s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...AMA3.device (1min 2s / 1min 30s)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...AMA3.device (1min 3s / 1min 30s)[K[[0;1;31m*[0m[0;31m* [0m] (2 of 4) A start job is running for...AMA3.device (1min 3s / 1min 30s)[K[[0m[0;31m* [0m] (3 of 4) A start job is running for...all Devices (1min 4s / no limit)[K[[0;1;31m*[0m[0;31m* [0m] (3 of 4) A start job is running for...all Devices (1min 4s / no limit)[K[[0;31m*[0;1;31m*[0m[0;31m* [0m] (3 of 4) A start job is running for...all Devices (1min 5s / no limit)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (4 of 4) A start job is running for...AMA0.device (1min 5s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m* [0m] (4 of 4) A start job is running for...AMA0.device (1min 6s / 1min 30s)[K[ [0;31m*[0;1;31m*[0m[0;31m*[0m] (4 of 4) A start job is running for...AMA0.device (1min 7s / 1min 30s)[K[[0;32m OK [0m] Started udev Coldplug all Devices. [[0;32m OK [0m] Found device /dev/ttyAMA0. [[0;32m OK [0m] Reached target System Initialization. Starting sshd.socket. [[0;32m OK [0m] Listening on Avahi mDNS/DNS-SD Stack Activation Socket. [[0;32m OK [0m] Started Daily Cleanup of Temporary Directories. [[0;32m OK [0m] Reached target Timers. [[0;32m OK [0m] Listening on D-Bus System Message Bus Socket. [[0;32m OK [0m] Listening on RPCbind Server Activation Socket. [[0;32m OK [0m] Listening on sshd.socket. [[0;32m OK [0m] Reached target Sockets. [[0;32m OK [0m] Reached target Basic System. [[0;32m OK [0m] Started Kernel Logging Service. Starting Login Service... [[0;32m OK [0m] Started Periodic Command Scheduler. Starting Resize root filesystem to fit available disk space... [[0;32m OK [0m] Started System Logging Service. [[0;32m OK [0m] Started Job spooling tools. [ 96.583385] virtio_net virtio0 enp0s1: renamed from eth0 Starting Avahi mDNS/DNS-SD Stack... [[0;32m OK [0m] Started TEE Supplicant. [[0;32m OK [0m] Started D-Bus System Message Bus. [[0;32m OK [0m] Started Avahi mDNS/DNS-SD Stack. Starting Network Service... Starting Network Manager... [[0;1;31m TIME [0m] Timed out waiting for device dev-ttyAMA2.device. [[0;1;33mDEPEND[0m] Dependency failed for Serial Getty on ttyAMA2. [[0;1;31m TIME [0m] Timed out waiting for device dev-ttyAMA3.device. [[0;1;33mDEPEND[0m] Dependency failed for Serial Getty on ttyAMA3. [[0;32m OK [0m] Started Network Service. [ [0;31m*[0;1;31m*[0m] (2 of 3) A start job is running for...in Service (1min 37s / 2min 41s)[K[ [0;31m*[0m] (2 of 3) A start job is running for...in Service (1min 38s / 2min 41s)[K[ [0;31m*[0;1;31m*[0m] (2 of 3) A start job is running for...in Service (1min 38s / 2min 41s)[K[[0;32m OK [0m] Started Network Manager. [[0;32m OK [0m] Started Login Service. [[0;32m OK [0m] Reached target Network. Starting DNS forwarder and DHCP server... Starting Network Name Resolution... Starting Permit User Sessions... [ 123.750515] IPv6: ADDRCONF(NETDEV_UP): enp0s1: link is not ready [[0;32m OK [0m] Started Permit User Sessions. [[0;32m OK [0m] Started Getty on tty1. [[0;32m OK [0m] Started Serial Getty on ttyAMA0. [[0;32m OK [0m] Reached target Login Prompts. [[0;32m OK [0m] Started DNS forwarder and DHCP server. [[0;32m OK [0m] Started Network Name Resolution. Starting Authorization Manager... [[0;32m OK [0m] Reached target Multi-User System. Starting Update UTMP about System Runlevel Changes... [[0;32m OK [0m] Started Update UTMP about System Runlevel Changes. Reference-Platform-Build-X11 2.2+linaro hikey ttyAMA0 Matched prompt #5: login: case: kernel-messages
case_id: 12763
definition: lava
duration: 134.18
extra: ...
level: 2.2
namespace: common
result: pass
Sending username root root hikey login: root auto-login-action: Wait for prompt ['root@hikey:~#', 'Login incorrect', 'Login timed out'] (timeout 00:02:42) root [ 149.416899] audit: type=1006 audit(1559898822.672:2): pid=2311 uid=0 old-auid=4294967295 auid=0 tty=(none) old-ses=4294967295 ses=1 res=1 Running login commands su 7[r[999;999H[6nroot@hikey:~# su su end: 2.2 auto-login-action (duration 00:02:43) [common] case: auto-login-action
case_id: 12764
definition: lava
duration: 163.28
extra: ...
level: 2.2
namespace: common
result: pass
start: 2.3 expect-shell-connection (timeout 00:02:16) [common] Forcing a shell prompt, looking for ['root@hikey:~#'] root@hikey:~# expect-shell-connection: Wait for prompt ['root@hikey:~#'] (timeout 00:05:00) Waiting using forced prompt support. 149.97403824329376s timeout end: 2.3 expect-shell-connection (duration 00:00:00) [common] start: 2.4 export-device-env (timeout 00:02:16) [common] end: 2.4 export-device-env (duration 00:00:00) [common] end: 2 boot-image-retry (duration 00:02:44) [common] start: 3 lava-test-retry (timeout 00:05:00) [common] start: 3.1 lava-test-shell (timeout 00:05:00) [common] Using namespace: common # root@hikey:~# # lava-test-shell: Wait for prompt ['root@hikey:~#'] (timeout 00:05:00) # mkdir /lava-584 root@hikey:~# mkdir /lava-584 mkdir /lava-584 mount /dev/disk/by-uuid/fa707801-ae66-4529-abed-7f30e3a5eef1 -t ext2 /lava-584 root@hikey:~# mount /dev/disk/by-uuid/fa707801-ae66-4529-abed-7f30e3a5eef1 -t ext2 /lava-584 mount /dev/disk/by-uuid/fa707801-ae66-4529-abed-7f30e3a5eef1 -t ex t2 /lava-584 ls -la /lava-584/bin/lava-test-runner root@hikey:~# ls -la /lava-584/bin/lava-test-runner ls -la /lava-584/bin/lava-test-runner -rwxr-xr-x 1 root root 1039 Jun 7 09:11 /lava-584/bin/lava-test-runner Using /lava-584 export SHELL=/bin/sh root@hikey:~# export SHELL=/bin/sh export SHELL=/bin/sh /lava-584/bin/lava-test-runner /lava-584/0 root@hikey:~# /lava-584/bin/lava-test-runner /lava-584/0 Test shell timeout: 10s (minimum of the action and connection timeout) /lava-584/bin/lava-test-runner /lava-584/0 + export TESTRUN_ID=0_smoke-tests + TESTRUN_ID=0_smoke-tests + cd /lava-584/0/tests/0_smoke-tests ++ cat uuid + UUID=584_1.3.3.1 + set +x Received signal: <STARTRUN> 0_smoke-tests 584_1.3.3.1 Starting test lava.0_smoke-tests (584_1.3.3.1) Skipping test definition patterns. <LAVA_SIGNAL_STARTRUN 0_smoke-tests 584_1.3.3.1> + lava-test-case linux-posix-pwd --shell pwd <LAVA_SIGNAL_STARTTC linux-posix-pwd> Received signal: <STARTTC> linux-posix-pwd /lava-584/0/tests/0_smoke-tests <LAVA_SIGNAL_ENDTC linux-posix-pwd> Received 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: 12765
definition: 0_smoke-tests
result: pass
+ lava-test-case linux-posix-uname --shell uname -a <LAVA_SIGNAL_STARTTC linux-posix-uname> Received signal: <STARTTC> linux-posix-uname Linux hikey 4.14.13-rc1 #1 SMP PREEMPT Mon Jan 8 14:21:41 UTC 2018 aarch64 aarch64 aarch64 GNU/Linux <LAVA_SIGNAL_ENDTC linux-posix-uname> Received signal: <ENDTC> linux-posix-uname <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-uname RESULT=pass> Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-uname RESULT=pass case: linux-posix-uname
case_id: 12766
definition: 0_smoke-tests
result: pass
+ lava-test-case linux-posix-vmstat --shell vmstat <LAVA_SIGNAL_STARTTC linux-posix-vmstat> Received signal: <STARTTC> linux-posix-vmstat /lava-584/0/../bin/lava-test-case: line 27: vmstat: command not found <LAVA_SIGNAL_ENDTC linux-posix-vmstat> Received signal: <ENDTC> linux-posix-vmstat Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-vmstat RESULT=fail case: linux-posix-vmstat
case_id: 12767
definition: 0_smoke-tests
result: fail
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-vmstat RESULT=fail> + lava-test-case linux-posix-ifconfig --shell ifconfig -a <LAVA_SIGNAL_STARTTC linux-posix-ifconfig> Received signal: <STARTTC> linux-posix-ifconfig enp0s1 Link encap:Ethernet HWaddr de:ad:be:ef:32:01 inet addr:10.0.2.15 Bcast:10.0.2.255 Mask:255.255.255.0 inet6 addr: fec0::dcad:beff:feef:3201/64 Scope:Site inet6 addr: fe80::dcad:beff:feef:3201/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:40 errors:0 dropped:0 overruns:0 frame:0 TX packets:69 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:9277 (9.0 KiB) TX bytes:11468 (11.1 KiB) lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 inet6 addr: ::1/128 Scope:Host UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:488 errors:0 dropped:0 overruns:0 frame:0 TX packets:488 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:35488 (34.6 KiB) TX bytes:35488 (34.6 KiB) sit0 Link encap:UNSPEC HWaddr 00-00-00-00-3A-30-30-30-00-00-00-00-00-00-00-00 NOARP MTU:1480 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:0 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:0 (0.0 B) TX bytes:0 (0.0 B) <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: 12768
definition: 0_smoke-tests
result: pass
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-ifconfig RESULT=pass> + lava-test-case linux-posix-lscpu --shell lscpu <LAVA_SIGNAL_STARTTC linux-posix-lscpu> Received signal: <STARTTC> linux-posix-lscpu /lava-584/0/../bin/lava-test-case: line 27: lscpu: command not found Received signal: <ENDTC> linux-posix-lscpu <LAVA_SIGNAL_ENDTC linux-posix-lscpu> Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-lscpu RESULT=fail case: linux-posix-lscpu
case_id: 12769
definition: 0_smoke-tests
result: fail
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-lscpu RESULT=fail> + lava-test-case linux-posix-lsb_release --shell lsb_release -a <LAVA_SIGNAL_STARTTC linux-posix-lsb_release> Received signal: <STARTTC> linux-posix-lsb_release /lava-584/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 Received signal: <TESTCASE> TEST_CASE_ID=linux-posix-lsb_release RESULT=fail case: linux-posix-lsb_release
case_id: 12770
definition: 0_smoke-tests
result: fail
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-posix-lsb_release RESULT=fail> + set +x Received signal: <ENDRUN> 0_smoke-tests 584_1.3.3.1 Ending use of test pattern. Ending test lava.0_smoke-tests (584_1.3.3.1), duration 2.23 case: 0_smoke-tests
case_id: 12771
commit_id: 0f8952f18e992371f8686c59b36f44e9c6a94a1a
definition: lava
duration: 2.23
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: 584_1.3.3.1
<LAVA_SIGNAL_ENDRUN 0_smoke-tests 584_1.3.3.1> + export TESTRUN_ID=1_singlenode-basic + TESTRUN_ID=1_singlenode-basic + cd /lava-584/0/tests/1_singlenode-basic ++ cat uuid + UUID=584_1.3.3.5 + set +x Received signal: <STARTRUN> 1_singlenode-basic 584_1.3.3.5 Starting test lava.1_singlenode-basic (584_1.3.3.5) Skipping test definition patterns. <LAVA_SIGNAL_STARTRUN 1_singlenode-basic 584_1.3.3.5> + 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 10.0.2.15:53 0.0.0.0:* LISTEN tcp 0 0 127.0.0.1:53 0.0.0.0:* LISTEN tcp6 0 0 :::5355 :::* LISTEN tcp6 0 0 fec0::dcad:beff:feef:53 :::* LISTEN tcp6 0 0 fe80::dcad:beff:feef:53 :::* LISTEN tcp6 0 0 ::1:53 :::* LISTEN tcp6 0 0 :::22 :::* LISTEN udp 0 0 0.0.0.0:5353 0.0.0.0:* udp 0 0 0.0.0.0:5355 0.0.0.0:* udp 0 0 0.0.0.0:44583 0.0.0.0:* udp 0 0 0.0.0.0:38808 0.0.0.0:* udp 0 0 10.0.2.15:53 0.0.0.0:* udp 0 0 127.0.0.1:53 0.0.0.0:* udp 0 0 0.0.0.0:68 0.0.0.0:* udp6 0 0 :::5353 :::* udp6 0 0 :::5355 :::* udp6 0 0 :::40753 :::* udp6 0 0 fec0::dcad:beff:feef:53 :::* udp6 0 0 fe80::dcad:beff:feef:53 :::* udp6 0 0 ::1:53 :::* udp6 0 0 :::37942 :::* 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 255 /run/systemd/private unix 13 [ ] DGRAM 8456 /run/systemd/journal/dev-log unix 2 [ ] DGRAM 8460 /run/systemd/journal/syslog unix 2 [ ACC ] SEQPACKET LISTENING 267 /run/udev/control unix 2 [ ACC ] STREAM LISTENING 8462 /run/systemd/journal/stdout unix 9 [ ] DGRAM 8464 /run/systemd/journal/socket unix 2 [ ACC ] STREAM LISTENING 9010 /var/run/avahi-daemon/socket unix 2 [ ACC ] STREAM LISTENING 10579 /var/run/NetworkManager/private-dhcp unix 2 [ ACC ] STREAM LISTENING 9048 /var/run/dbus/system_bus_socket unix 2 [ ACC ] STREAM LISTENING 9051 /var/run/rpcbind.sock unix 2 [ ACC ] STREAM LISTENING 9581 /var/run/NetworkManager/private unix 2 [ ] DGRAM 7869 /run/user/0/systemd/notify unix 2 [ ACC ] STREAM LISTENING 7871 /run/user/0/systemd/private unix 3 [ ] DGRAM 251 /run/systemd/notify unix 2 [ ] DGRAM 253 /run/systemd/cgroups-agent unix 3 [ ] STREAM CONNECTED 7554 unix 2 [ ] DGRAM 2763 unix 3 [ ] STREAM CONNECTED 8756 unix 3 [ ] STREAM CONNECTED 533 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 3019 /run/systemd/journal/stdout unix 3 [ ] DGRAM 2771 unix 3 [ ] DGRAM 2770 unix 2 [ ] DGRAM 7510 unix 3 [ ] STREAM CONNECTED 7755 unix 3 [ ] STREAM CONNECTED 7675 /var/run/dbus/system_bus_socket unix 3 [ ] DGRAM 2708 unix 3 [ ] STREAM CONNECTED 8757 /run/systemd/journal/stdout unix 3 [ ] DGRAM 2709 unix 3 [ ] STREAM CONNECTED 7670 unix 3 [ ] DGRAM 2769 unix 3 [ ] DGRAM 2768 unix 3 [ ] STREAM CONNECTED 10367 /run/systemd/journal/stdout unix 2 [ ] DGRAM 3069 unix 3 [ ] STREAM CONNECTED 669 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 9213 unix 3 [ ] STREAM CONNECTED 9116 /run/systemd/journal/stdout unix 2 [ ] DGRAM 9990 unix 2 [ ] DGRAM 8811 unix 2 [ ] DGRAM 856 unix 3 [ ] STREAM CONNECTED 9115 unix 3 [ ] STREAM CONNECTED 7506 unix 3 [ ] STREAM CONNECTED 9263 unix 3 [ ] STREAM CONNECTED 9431 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 7434 unix 3 [ ] STREAM CONNECTED 7435 /run/systemd/journal/stdout unix 2 [ ] DGRAM 2433 unix 3 [ ] STREAM CONNECTED 9432 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 3064 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 9733 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 3063 unix 2 [ ] DGRAM 9266 unix 3 [ ] STREAM CONNECTED 9488 unix 3 [ ] STREAM CONNECTED 705 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 10359 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 9583 unix 2 [ ] DGRAM 738 unix 2 [ ] DGRAM 10793 unix 2 [ ] DGRAM 827 unix 3 [ ] STREAM CONNECTED 9429 unix 3 [ ] STREAM CONNECTED 10778 unix 2 [ ] DGRAM 9712 unix 3 [ ] STREAM CONNECTED 10779 /run/systemd/journal/stdout unix 2 [ ] DGRAM 621 unix 3 [ ] STREAM CONNECTED 9430 unix 2 [ ] DGRAM 9438 unix 3 [ ] STREAM CONNECTED 7567 /run/systemd/journal/stdout unix 3 [ ] STREAM CONNECTED 9374 unix 3 [ ] STREAM CONNECTED 10433 unix 3 [ ] STREAM CONNECTED 635 unix 3 [ ] STREAM CONNECTED 9375 unix 3 [ ] STREAM CONNECTED 9499 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 9584 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 592 unix 2 [ ] DGRAM 10551 unix 3 [ ] STREAM CONNECTED 9379 unix 3 [ ] STREAM CONNECTED 9433 /var/run/dbus/system_bus_socket unix 3 [ ] STREAM CONNECTED 9730 unix 2 [ ] DGRAM 10630 unix 2 [ ] DGRAM 9580 unix 3 [ ] STREAM CONNECTED 704 unix 3 [ ] STREAM CONNECTED 9346 unix 2 [ ] DGRAM 10700 unix 3 [ ] STREAM CONNECTED 536 /run/systemd/journal/stdout unix 2 [ ] DGRAM 9371 Received signal: <ENDTC> linux-linaro-ubuntu-netstat <LAVA_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: 12772
definition: 1_singlenode-basic
result: pass
+ lava-test-case linux-linaro-ubuntu-ifconfig-dump --shell ifconfig -a <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-ifconfig-dump> Received signal: <STARTTC> linux-linaro-ubuntu-ifconfig-dump enp0s1 Link encap:Ethernet HWaddr de:ad:be:ef:32:01 inet addr:10.0.2.15 Bcast:10.0.2.255 Mask:255.255.255.0 inet6 addr: fec0::dcad:beff:feef:3201/64 Scope:Site inet6 addr: fe80::dcad:beff:feef:3201/64 Scope:Link UP BROADCAST RUNNING MULTICAST MTU:1500 Metric:1 RX packets:40 errors:0 dropped:0 overruns:0 frame:0 TX packets:69 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:9277 (9.0 KiB) TX bytes:11468 (11.1 KiB) lo Link encap:Local Loopback inet addr:127.0.0.1 Mask:255.0.0.0 inet6 addr: ::1/128 Scope:Host UP LOOPBACK RUNNING MTU:65536 Metric:1 RX packets:488 errors:0 dropped:0 overruns:0 frame:0 TX packets:488 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:35488 (34.6 KiB) TX bytes:35488 (34.6 KiB) sit0 Link encap:UNSPEC HWaddr 00-00-00-00-3A-30-30-30-00-00-00-00-00-00-00-00 NOARP MTU:1480 Metric:1 RX packets:0 errors:0 dropped:0 overruns:0 frame:0 TX packets:0 errors:0 dropped:0 overruns:0 carrier:0 collisions:0 txqueuelen:1000 RX bytes:0 (0.0 B) TX bytes:0 (0.0 B) <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-ifconfig-dump> Received signal: <ENDTC> linux-linaro-ubuntu-ifconfig-dump Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-ifconfig-dump RESULT=pass case: linux-linaro-ubuntu-ifconfig-dump
case_id: 12773
definition: 1_singlenode-basic
result: pass
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-ifconfig-dump RESULT=pass> + lava-test-case linux-linaro-ubuntu-route-dump-a --shell route <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-route-dump-a> Received signal: <STARTTC> linux-linaro-ubuntu-route-dump-a Kernel IP routing table Destination Gateway Genmask Flags Metric Ref Use Iface default gateway 0.0.0.0 UG 100 0 0 enp0s1 10.0.2.0 * 255.255.255.0 U 100 0 0 enp0s1 Received signal: <ENDTC> linux-linaro-ubuntu-route-dump-a <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-route-dump-a> Received signal: <TESTCASE> TEST_CASE_ID=linux-linaro-ubuntu-route-dump-a RESULT=pass case: linux-linaro-ubuntu-route-dump-a
case_id: 12774
definition: 1_singlenode-basic
result: pass
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-route-dump-a RESULT=pass> + 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> <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-route-ifconfig-up-lo> Received signal: <ENDTC> linux-linaro-ubuntu-route-ifconfig-up-lo <LAVA_SIGNAL_TESTCASE TEST_CASE_ID=linux-linaro-ubuntu-route-ifconfig-up-lo RESULT=pass> 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: 12775
definition: 1_singlenode-basic
result: pass
+ lava-test-case linux-linaro-ubuntu-route-dump-b --shell route <LAVA_SIGNAL_STARTTC linux-linaro-ubuntu-route-dump-b> Received signal: <STARTTC> linux-linaro-ubuntu-route-dump-b Kernel IP routing table Destination Gateway Genmask Flags Metric Ref Use Iface default gateway 0.0.0.0 UG 100 0 0 enp0s1 10.0.2.0 * 255.255.255.0 U 100 0 0 enp0s1 <LAVA_SIGNAL_ENDTC linux-linaro-ubuntu-route-dump-b> Received 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: 12776
definition: 1_singlenode-basic
result: pass
<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 <LAVA_SIGNAL_STARTTC ping-test> Received signal: <STARTTC> ping-test PING www.linaro.org (143.204.181.39): 56 data bytes --- www.linaro.org ping statistics --- 1 packets transmitted, 0 packets received, 100% packet loss <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: 12777
definition: 1_singlenode-basic
result: fail
<LAVA_SIGNAL_TESTCASE TEST_CASE_ID=ping-test RESULT=fail> + set +x <LAVA_SIGNAL_ENDRUN 1_singlenode-basic 584_1.3.3.5> Received signal: <ENDRUN> 1_singlenode-basic 584_1.3.3.5 Ending use of test pattern. Ending test lava.1_singlenode-basic (584_1.3.3.5), duration 4.28 case: 1_singlenode-basic
case_id: 12778
commit_id: 0f8952f18e992371f8686c59b36f44e9c6a94a1a
definition: lava
duration: 4.28
namespace: common
path: lava-test-shell/single-node/singlenode01.yaml
repository: http://git.linaro.org/lava-team/lava-functional-tests.git
result: pass
revision: unspecified
uuid: 584_1.3.3.5
<LAVA_TEST_RUNNER EXIT> ok: lava_test_shell seems to have completed 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: fail linux-posix-pwd: pass linux-posix-uname: pass linux-posix-vmstat: fail ping-test: fail end: 3.1 lava-test-shell (duration 00:00:10) [common] end: 3 lava-test-retry (duration 00:00:10) [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@hikey:~# poweroff Disconnecting QemuSession Disconnecting from qemu: end: 4.2 read-feedback (duration 00:00:06) [common] Disconnecting QemuSession Disconnecting from qemu: end: 4 finalize (duration 00:00:06) [common] Cleaning after the job Cleaning up download directory: /var/lib/lava/dispatcher/tmp/lavafed-584/deployimages-nikxzhu3/kernel Cleaning up download directory: /var/lib/lava/dispatcher/tmp/lavafed-584/deployimages-nikxzhu3/rootfs Root tmp directory removed at /var/lib/lava/dispatcher/tmp/lavafed-584 Job finished correctly case: job
case_id: 12779
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 Description 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.

features.2.name
test.definition.git
features.1.type
device
features.0.type
device
features.3.description
Inline test definition
features.2.description
Test definition from git
features.0.name
deploy.tmpfs
job.url
https://federation.lavasoftware.org/lava/scheduler/job/{id}
slave.arch
amd64
slave.version
2019.05.0008.gbefefba4f
features.2.action
test
job.type
test
device.type
qemu
features.3.action
test
features.3.type
device
features.0.action
deploy
features.1.name
boot.qemu
features.3.name
test.definition.inline
job.name
qemu - hikey
lab.name
staging.validation.linaro.org
features.1.description
Boot qemu
features.2.type
device
features.1.action
boot
device.name
staging-qemu01
features.0.description
Deploy to tmpfs
device type
hostname
timeouts
  • actions: {'seconds': 30}{'minutes': 3}{'minutes': 2}{'minutes': 10}{'minutes': 3}{'minutes': 2}{'minutes': 2}{'minutes': 2}{'minutes': 3}{'minutes': 10}{'minutes': 5}{'seconds': 45}{'minutes': 3}{'minutes': 3}{'minutes': 3}{'minutes': 20}{'seconds': 10}{'seconds': 30}{'minutes': 5} bootloader-interruptbootloader-commandsboot-qemu-imagenfs-deployuboot-retryboot-image-retryapply-overlay-imageauto-login-actionbootloader-retrydd-imagehttp-downloadumount-retrylava-test-shellbootloader-actionuboot-actionflash-uboot-umspower-offu-boot-interruptdownload-retry
  • connections: {'seconds': 30}{'seconds': 30}{'minutes': 2}{'minutes': 10}{'seconds': 30}{'seconds': 30}{'seconds': 10} bootloader-interruptbootloader-commandsauto-login-actiondd-imageu-boot-interruptuboot-retrylava-test-shell
device action methods
deploy:
  • nfs:
  • image:
    • guest: {'driveid': 'lavatest', 'size': 512, 'interface': 'virtio'}
boot:
  • qemu:
    • boot_options: {'mem': '1024M', 'ip': 'dhcp', 'console': 'ttyAMA0 115200', 'root': '/dev/vda2 rw rootwait'}
    • options: ['-cpu cortex-a57', '-machine virt', '-nographic', '-net nic,model=virtio,macaddr=DE:AD:BE:EF:32:01 -net user', '-m 1024', '-monitor none']
    • command: qemu-system-aarch64
  • qemu-nfs:
    • append: {'console': 'ttyAMA0', 'ipargs': 'ip=dhcp', 'nfsrootargs': 'nfsroot={NFS_SERVER_IP}:{NFSROOTFS},tcp,hard,intr', 'root': '/dev/nfs'}
    • boot_options: {'mem': '1024M', 'ip': 'dhcp', 'console': 'ttyAMA0 115200', 'root': '/dev/vda2 rw rootwait'}
    • options: ['-cpu cortex-a57', '-machine virt', '-nographic', '-net nic,model=virtio,macaddr=DE:AD:BE:EF:32:01 -net user', '-m 1024', '-monitor none']
    • command: qemu-system-aarch64
target
...
timeouts
  • job: {'seconds': 900}

  1. namespace
    common
    deployment_data
    {'lava_test_sh_cmd': '/bin/sh', 'lava_test_results_part_attr': 'root_part', 'distro': 'oe', 'lava_test_shell_file': '~/.bashrc', 'boot_cmds': 'boot_cmds_oe', 'TESTER_PS1_PATTERN': 'linaro-test \\[rc=(\\d+)\\]# ', 'lava_test_results_dir': '/lava-%s', 'lava_test_dir': '/lava-%s', 'line_separator': '\n', 'TESTER_PS1_INCLUDES_RC': True, 'TESTER_PS1': 'linaro-test [rc=$(echo \\$?)]# '}
    Timeout
    • 10 minutes
    images
    {'rootfs': {'sparse': False, 'apply-overlay': True, 'compression': 'gz', 'image_arg': '-drive format=raw,file={rootfs} -cpu cortex-a57 -machine type=virt -nographic -smp 4 -m 2048', 'url': 'http://snapshots.linaro.org/openembedded/lkft/morty/hikey/rpb/linux-stable-rc-4.14/64/rpb-console-image-hikey-20180108141340-64.rootfs.ext4.gz'}, 'kernel': {'type': 'image', 'image_arg': '-kernel {kernel} --append "console=ttyAMA0 root=/dev/vda rw"', 'url': 'http://snapshots.linaro.org/openembedded/lkft/morty/hikey/rpb/linux-stable-rc-4.14/64/Image--4.14+git0+ae407d95ee-r0-hikey-20180108141340-64.bin'}}
    os
    oe
    to
    tmpfs

  1. namespace
    common
    media
    tmpfs
    prompts
    ['root@hikey:~#']
    auto_login
    {'login_commands': ['su'], 'login_prompt': 'login:', 'username': 'root'}
    method
    qemu
    Timeout
    • 5 minutes

  1. namespace
    common
    stage
    0
    Definitions
    • 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-basic
    • path lava-test-shell/single-node/singlenode01.yaml
    • repository http://git.linaro.org/lava-team/lava-functional-tests.git
    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...