extra keys not allowed @ data['actions[0]']['deploy']['nbd']['initrd']['allow_modify']
Infrastructure error: Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
lava-dispatcher, installed at version: 2023.01
start: 0 validate
Start time: 2023-03-02 07:27:31.500435+00:00 (UTC)
Validating that http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/initramfs-netboot-image-bbe.ext4.gz exists
Validating that http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/zImage exists
Validating that http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/am335x-sancloud-bbe.dtb exists
Validating that http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/agl-telematics-demo-platform-bbe.ext4.xz exists
validate duration: 0.85
case: validate
case_id: 3882324
definition: lava
result: pass
start: 1 nbd-deploy (timeout 01:30:00) [common]
Making protocol call for nbd-deploy using lava-xnbd
[nbd-deploy] Checking protocol data for lava-xnbd
Get a port from pool
Set_port 61977
start: 1.1 download-retry (timeout 01:30:00) [common]
start: 1.1.1 http-download (timeout 01:30:00) [common]
downloading http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/initramfs-netboot-image-bbe.ext4.gz
saving as /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/initrd/initramfs-netboot-image-bbe.ext4.gz
total size: 1677702 (1MB)
No compression specified
progress 1% (0MB)
progress 7% (0MB)
progress 13% (0MB)
progress 19% (0MB)
progress 25% (0MB)
progress 31% (0MB)
progress 37% (0MB)
progress 42% (0MB)
progress 48% (0MB)
progress 54% (0MB)
progress 60% (0MB)
progress 66% (1MB)
progress 72% (1MB)
progress 78% (1MB)
progress 83% (1MB)
progress 89% (1MB)
progress 95% (1MB)
progress 100% (1MB)
1MB downloaded in 0.84s (1.91MB/s)
end: 1.1.1 http-download (duration 00:00:01) [common]
case: http-download
case_id: 3882334
definition: lava
duration: 0.84
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 01:29:59) [common]
start: 1.2.1 http-download (timeout 01:29:59) [common]
downloading http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/zImage
saving as /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/kernel/zImage
total size: 4736736 (4MB)
No compression specified
progress 0% (0MB)
progress 5% (0MB)
progress 10% (0MB)
progress 15% (0MB)
progress 20% (0MB)
progress 25% (1MB)
progress 30% (1MB)
progress 35% (1MB)
progress 40% (1MB)
progress 45% (2MB)
progress 50% (2MB)
progress 55% (2MB)
progress 60% (2MB)
progress 65% (2MB)
progress 70% (3MB)
progress 75% (3MB)
progress 80% (3MB)
progress 85% (3MB)
progress 90% (4MB)
progress 95% (4MB)
progress 100% (4MB)
4MB downloaded in 1.31s (3.46MB/s)
end: 1.2.1 http-download (duration 00:00:01) [common]
case: http-download
case_id: 3882334
definition: lava
duration: 1.31
extra: ...
level: 1.2.1
namespace: common
result: pass
end: 1.2 download-retry (duration 00:00:01) [common]
start: 1.3 download-retry (timeout 01:29:58) [common]
start: 1.3.1 http-download (timeout 01:29:58) [common]
downloading http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/am335x-sancloud-bbe.dtb
saving as /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/dtb/am335x-sancloud-bbe.dtb
total size: 93513 (0MB)
No compression specified
progress 35% (0MB)
progress 70% (0MB)
progress 100% (0MB)
0MB downloaded in 0.50s (0.18MB/s)
end: 1.3.1 http-download (duration 00:00:01) [common]
case: http-download
case_id: 3882334
definition: lava
duration: 0.50
extra: ...
level: 1.3.1
namespace: common
result: pass
end: 1.3 download-retry (duration 00:00:01) [common]
start: 1.4 download-retry (timeout 01:29:57) [common]
start: 1.4.1 http-download (timeout 01:29:57) [common]
downloading http://download.automotivelinux.org/AGL/upload/ci/28547/1/bbe/agl-telematics-demo-platform-bbe.ext4.xz
saving as /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/nbdroot/agl-telematics-demo-platform-bbe.ext4
total size: 246957432 (235MB)
Using unxz to decompress xz
progress 0% (0MB)
progress 5% (11MB)
progress 10% (23MB)
progress 15% (35MB)
progress 20% (47MB)
progress 25% (58MB)
progress 30% (70MB)
progress 35% (82MB)
progress 40% (94MB)
progress 45% (106MB)
progress 50% (117MB)
progress 55% (129MB)
progress 60% (141MB)
progress 65% (153MB)
progress 70% (164MB)
progress 75% (176MB)
progress 80% (188MB)
progress 85% (200MB)
progress 90% (211MB)
progress 95% (223MB)
progress 100% (235MB)
235MB downloaded in 61.26s (3.84MB/s)
end: 1.4.1 http-download (duration 00:01:01) [common]
case: http-download
case_id: 3882334
definition: lava
duration: 61.27
extra: ...
level: 1.4.1
namespace: common
result: pass
end: 1.4 download-retry (duration 00:01:01) [common]
start: 1.5 lava-overlay (timeout 01:28:56) [common]
[common] Preparing overlay tarball in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87
makedir: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin
makedir: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/tests
makedir: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/results
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-add-keys
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-add-sources
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-background-process-start
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-background-process-stop
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-common-functions
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-echo-ipv4
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-install-packages
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-installed-packages
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-os-build
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-probe-channel
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-probe-ip
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-target-ip
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-target-mac
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-target-storage
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-case
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-event
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-feedback
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-raise
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-reference
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-runner
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-set
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-test-shell
Updating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-install-packages (oe)
Updating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/bin/lava-installed-packages (oe)
Creating /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/environment
LAVA metadata
- LAVA_JOB_ID=32063
- LAVA_DISPATCHER_IP=192.168.66.1
start: 1.5.1 ssh-authorize (timeout 01:28:56) [common]
end: 1.5.1 ssh-authorize (duration 00:00:00) [common]
start: 1.5.2 lava-vland-overlay (timeout 01:28:56) [common]
skipped lava-vland-overlay
end: 1.5.2 lava-vland-overlay (duration 00:00:00) [common]
start: 1.5.3 lava-multinode-overlay (timeout 01:28:56) [common]
skipped lava-multinode-overlay
end: 1.5.3 lava-multinode-overlay (duration 00:00:00) [common]
start: 1.5.4 test-definition (timeout 01:28:56) [common]
Loading test definitions
start: 1.5.4.1 git-repo-action (timeout 01:28:56) [common]
Using /lava-32063 at stage 0
Fetching tests from https://git.automotivelinux.org/src/qa-testdefinitions
Running '/usr/bin/git clone --depth=1 https://git.automotivelinux.org/src/qa-testdefinitions /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/0/tests/0_network-veth'
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/0/tests/0_network-veth/test-suites/short-smoke/network-veth.yaml
uuid=32063_1.5.4.1 testdef=None
end: 1.5.4.1 git-repo-action (duration 00:00:02) [common]
case: git-repo-action
case_id: 3882351
definition: lava
duration: 1.65
extra: ...
level: 1.5.4.1
namespace: common
result: pass
start: 1.5.4.2 test-overlay (timeout 01:28:54) [common]
end: 1.5.4.2 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3882352
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.2
namespace: common
result: pass
start: 1.5.4.3 test-install-overlay (timeout 01:28:54) [common]
end: 1.5.4.3 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3882353
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.3
namespace: common
result: pass
start: 1.5.4.4 test-runscript-overlay (timeout 01:28:54) [common]
runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/0/tests/0_network-veth test_uuid 32063_1.5.4.1
end: 1.5.4.4 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3882354
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.4
namespace: common
result: pass
start: 1.5.4.5 git-repo-action (timeout 01:28:54) [common]
Using /lava-32063 at stage 1
Fetching tests from https://git.automotivelinux.org/src/qa-testdefinitions
Running '/usr/bin/git clone --depth=1 https://git.automotivelinux.org/src/qa-testdefinitions /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/1_ci-busybox'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/1_ci-busybox
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/1_ci-busybox/test-suites/short-smoke/busybox.yaml
uuid=32063_1.5.4.5 testdef={'testdef_pattern': {'pattern': '^(?P<test_case_id>[a-zA-Z0-9_-]+):\\s(?P<result>\\w+)', 'fixupdict': {'PASS': 'pass', 'FAIL': 'fail'}}}
end: 1.5.4.5 git-repo-action (duration 00:00:02) [common]
case: git-repo-action
case_id: 3882351
definition: lava
duration: 1.68
extra: ...
level: 1.5.4.5
namespace: common
result: pass
start: 1.5.4.6 test-overlay (timeout 01:28:53) [common]
end: 1.5.4.6 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3882352
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.6
namespace: common
result: pass
start: 1.5.4.7 test-install-overlay (timeout 01:28:53) [common]
end: 1.5.4.7 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3882353
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.7
namespace: common
result: pass
start: 1.5.4.8 test-runscript-overlay (timeout 01:28:53) [common]
runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/1_ci-busybox test_uuid 32063_1.5.4.5
end: 1.5.4.8 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3882354
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.8
namespace: common
result: pass
start: 1.5.4.9 git-repo-action (timeout 01:28:53) [common]
Using /lava-32063 at stage 1
Fetching tests from https://git.automotivelinux.org/src/qa-testdefinitions
Running '/usr/bin/git clone --depth=1 https://git.automotivelinux.org/src/qa-testdefinitions /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/2_ci-smoke-tests-basic'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/2_ci-smoke-tests-basic
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/2_ci-smoke-tests-basic/test-suites/short-smoke/smoke-tests-basic.yaml
uuid=32063_1.5.4.9 testdef=None
end: 1.5.4.9 git-repo-action (duration 00:00:02) [common]
case: git-repo-action
case_id: 3882351
definition: lava
duration: 1.67
extra: ...
level: 1.5.4.9
namespace: common
result: pass
start: 1.5.4.10 test-overlay (timeout 01:28:51) [common]
end: 1.5.4.10 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3882352
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.10
namespace: common
result: pass
start: 1.5.4.11 test-install-overlay (timeout 01:28:51) [common]
end: 1.5.4.11 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3882353
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.11
namespace: common
result: pass
start: 1.5.4.12 test-runscript-overlay (timeout 01:28:51) [common]
runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/2_ci-smoke-tests-basic test_uuid 32063_1.5.4.9
end: 1.5.4.12 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3882354
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.12
namespace: common
result: pass
start: 1.5.4.13 git-repo-action (timeout 01:28:51) [common]
Using /lava-32063 at stage 1
Fetching tests from https://git.automotivelinux.org/src/qa-testdefinitions
Running '/usr/bin/git clone --depth=1 https://git.automotivelinux.org/src/qa-testdefinitions /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/3_ci-service-check'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/3_ci-service-check
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/3_ci-service-check/test-suites/short-smoke/service-check.yaml
uuid=32063_1.5.4.13 testdef=None
end: 1.5.4.13 git-repo-action (duration 00:00:02) [common]
case: git-repo-action
case_id: 3882351
definition: lava
duration: 1.72
extra: ...
level: 1.5.4.13
namespace: common
result: pass
start: 1.5.4.14 test-overlay (timeout 01:28:49) [common]
end: 1.5.4.14 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3882352
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.14
namespace: common
result: pass
start: 1.5.4.15 test-install-overlay (timeout 01:28:49) [common]
end: 1.5.4.15 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3882353
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.15
namespace: common
result: pass
start: 1.5.4.16 test-runscript-overlay (timeout 01:28:49) [common]
runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1/tests/3_ci-service-check test_uuid 32063_1.5.4.13
BUILD_TAGS=''
DEVICE_TAGS=''
end: 1.5.4.16 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3882354
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.16
namespace: common
result: pass
start: 1.5.4.17 git-repo-action (timeout 01:28:49) [common]
Using /lava-32063 at stage 2
Fetching tests from https://git.automotivelinux.org/src/qa-testdefinitions
Running '/usr/bin/git clone --depth=1 https://git.automotivelinux.org/src/qa-testdefinitions /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/2/tests/4_ci-dumpjournal'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/2/tests/4_ci-dumpjournal
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/2/tests/4_ci-dumpjournal/test-suites/short-smoke/dumpjournal.yaml
uuid=32063_1.5.4.17 testdef={'testdef_pattern': {'pattern': '^(?P<test_case_id>[a-zA-Z0-9_-]+):\\s(?P<result>\\w+)', 'fixupdict': {'PASS': 'pass', 'FAIL': 'fail'}}}
end: 1.5.4.17 git-repo-action (duration 00:00:02) [common]
case: git-repo-action
case_id: 3882351
definition: lava
duration: 1.68
extra: ...
level: 1.5.4.17
namespace: common
result: pass
start: 1.5.4.18 test-overlay (timeout 01:28:47) [common]
end: 1.5.4.18 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3882352
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.18
namespace: common
result: pass
start: 1.5.4.19 test-install-overlay (timeout 01:28:47) [common]
end: 1.5.4.19 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3882353
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.19
namespace: common
result: pass
start: 1.5.4.20 test-runscript-overlay (timeout 01:28:47) [common]
runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/2/tests/4_ci-dumpjournal test_uuid 32063_1.5.4.17
end: 1.5.4.20 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3882354
definition: lava
duration: 0.01
extra: ...
level: 1.5.4.20
namespace: common
result: pass
Creating lava-test-runner.conf files
Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/0 for stage 0
- 0_network-veth
Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/1 for stage 1
- 1_ci-busybox
- 2_ci-smoke-tests-basic
- 3_ci-service-check
Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32063/lava-overlay-v8hjqd87/lava-32063/2 for stage 2
- 4_ci-dumpjournal
end: 1.5.4 test-definition (duration 00:00:09) [common]
start: 1.5.5 compress-overlay (timeout 01:28:47) [common]
end: 1.5.5 compress-overlay (duration 00:00:01) [common]
start: 1.5.6 persistent-nfs-overlay (timeout 01:28:47) [common]
end: 1.5.6 persistent-nfs-overlay (duration 00:00:00) [common]
end: 1.5 lava-overlay (duration 00:00:09) [common]
start: 1.6 prepare-kernel (timeout 01:28:47) [common]
start: 1.6.1 uboot-prepare-kernel (timeout 01:28:47) [common]
end: 1.6.1 uboot-prepare-kernel (duration 00:00:00) [common]
end: 1.6 prepare-kernel (duration 00:00:00) [common]
start: 1.7 xnbd-server-deploy (timeout 01:28:47) [common]
xnbd-server-deploy: starting nbd-server
NBD-IP: 192.168.66.1, NBD-PORT: 61977, NBD-ROOT: 32063/nbd-deploy-dr8qv9zo/nbdroot/agl-telematics-demo-platform-bbe.ext4
nbd-server 61977 /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/nbdroot/agl-telematics-demo-platform-bbe.ext4
output:
output: ** (process:475): WARNING **: 07:28:45.480: Specifying an export on the command line no longer uses the oldstyle protocol.
output:
xnbd-server-deploy: starting nbd-server done
end: 1.7 xnbd-server-deploy (duration 00:00:00) [common]
end: 1 nbd-deploy (duration 00:01:13) [common]
start: 2 uboot-action (timeout 00:20:00) [common]
start: 2.1 uboot-from-media (timeout 00:20:00) [common]
end: 2.1 uboot-from-media (duration 00:00:00) [common]
start: 2.2 bootloader-overlay (timeout 00:20:00) [common]
substitutions:
- {BOOTX}: bootz 0x82000000 0x83000000:${initrd_size} 0x88000000
- {DTB_ADDR}: 0x88000000
- {DTB}: 32063/nbd-deploy-dr8qv9zo/dtb/am335x-sancloud-bbe.dtb
- {INITRD}: 32063/nbd-deploy-dr8qv9zo/initrd/initramfs-netboot-image-bbe.ext4.gz
- {KERNEL_ADDR}: 0x82000000
- {KERNEL}: 32063/nbd-deploy-dr8qv9zo/kernel/zImage
- {LAVA_MAC}: None
- {NBDSERVERIP}: 192.168.66.1
- {NBDSERVERPORT}: 61977
- {PRESEED_CONFIG}: None
- {PRESEED_LOCAL}: None
- {RAMDISK_ADDR}: 0x83000000
- {RAMDISK}: 32063/nbd-deploy-dr8qv9zo/initrd/initramfs-netboot-image-bbe.ext4.gz
- {ROOT_PART}: None
- {ROOT}: None
- {SERVER_IP}: 192.168.66.1
- {TEE_ADDR}: 0x83000000
- {TEE}: None
Parsed boot commands:
- setenv autoload no
- setenv initrd_high 0xffffffff
- setenv fdt_high 0xffffffff
- dhcp
- setenv serverip 192.168.66.1
- tftp 0x82000000 32063/nbd-deploy-dr8qv9zo/kernel/zImage
- tftp 0x83000000 32063/nbd-deploy-dr8qv9zo/initrd/initramfs-netboot-image-bbe.ext4.gz
- setenv initrd_size ${filesize}
- tftp 0x88000000 32063/nbd-deploy-dr8qv9zo/dtb/am335x-sancloud-bbe.dtb
- setenv bootargs 'console=ttyO0,115200n8 rw nbd.server=192.168.66.1 nbd.port=61977 root=/dev/ram0 ramdisk_size=16384 rootdelay=7 systemd.mask=systemd-network-generator.service ip=dhcp verbose earlyprintk systemd.log_color=false ${extraargs} rw'
- bootz 0x82000000 0x83000000:${initrd_size} 0x88000000
end: 2.2 bootloader-overlay (duration 00:00:00) [common]
case: bootloader-overlay
case_id: 3882355
definition: lava
duration: 0.02
extra: ...
level: 2.2
namespace: common
result: pass
start: 2.3 connect-device (timeout 00:20:00) [common]
[common] connect-device Connecting to device using 'telnet 127.0.0.1 63005'
Setting prompt string to ['lava-test: # ']
end: 2.3 connect-device (duration 00:00:03) [common]
start: 2.4 uboot-commands (timeout 00:19:57) [common]
start: 2.4.1 reset-device (timeout 00:19:57) [common]
start: 2.4.1.1 pdu-reboot (timeout 00:19:57) [common]
Calling: 'nice' '/usr/local/bin/acme-cli' '-s' '192.168.66.2' 'reset' '4'
>> /usr/bin/nice: ‘/usr/local/bin/acme-cli’: No such file or directory
Returned 127 in 3 seconds
Unable to run 'nice' '['/usr/local/bin/acme-cli', '-s', '192.168.66.2', 'reset', '4']'
Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
end: 2.4.1.1 pdu-reboot (duration 00:00:03) [common]
case: pdu-reboot
case_id: 3882356
definition: lava
duration: 3.16
extra: ...
level: 2.4.1.1
namespace: common
result: fail
Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
end: 2.4.1 reset-device (duration 00:00:03) [common]
case: reset-device
case_id: 3882357
definition: lava
duration: 3.17
extra: ...
level: 2.4.1
namespace: common
result: fail
Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
end: 2.4 uboot-commands (duration 00:00:03) [common]
case: uboot-commands
case_id: 3882358
definition: lava
duration: 3.17
extra: ...
level: 2.4
namespace: common
result: fail
uboot-action failed: 1 of 1 attempts. 'Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed'
Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
end: 2 uboot-action (duration 00:00:06) [common]
case: uboot-action
case_id: 3882359
definition: lava
duration: 6.37
extra: ...
level: 2
namespace: common
result: fail
Cleaning after the job
Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/initrd
Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/kernel
Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/dtb
Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32063/nbd-deploy-dr8qv9zo/nbdroot
start: 6.1 power-off (timeout 00:00:10) [common]
Calling: 'nice' '/usr/local/bin/acme-cli' '-s' '192.168.66.2' 'switch_off' '4'
>> /usr/bin/nice: ‘/usr/local/bin/acme-cli’: No such file or directory
Returned 127 in 3 seconds
Unable to run 'nice' '['/usr/local/bin/acme-cli', '-s', '192.168.66.2', 'switch_off', '4']'
Unable to power-off: '/usr/local/bin/acme-cli -s 192.168.66.2 switch_off 4' failed
end: 6.1 power-off (duration 00:00:03) [common]
case: power-off
case_id: 3882360
definition: lava
duration: 3.17
extra: ...
level: 6.1
namespace: common
result: fail
Failed to run 'finalize': Unable to power-off: '/usr/local/bin/acme-cli -s 192.168.66.2 switch_off 4' failed
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/lava_dispatcher/job.py", line 252, in run
self._run()
File "/usr/lib/python3/dist-packages/lava_dispatcher/job.py", line 242, in _run
self.pipeline.run_actions(self.connection, max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 262, in run_actions
new_connection = action.run(connection, action_max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/logical.py", line 68, in run
connection = self.pipeline.run_actions(connection, max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 262, in run_actions
new_connection = action.run(connection, action_max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 825, in run
return self.pipeline.run_actions(connection, max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 262, in run_actions
new_connection = action.run(connection, action_max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 825, in run
return self.pipeline.run_actions(connection, max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 262, in run_actions
new_connection = action.run(connection, action_max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/power.py", line 119, in run
self.run_cmd(cmd, error_msg="Unable to reboot: '%s' failed" % cmd)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 695, in run_cmd
raise self.command_exception(error_msg)
lava_common.exceptions.InfrastructureError: Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
During handling of the above exception, another exception occurred:
Traceback (most recent call last):
File "/usr/lib/python3/dist-packages/lava_dispatcher/power.py", line 351, in run
connection = super().run(connection, max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 825, in run
return self.pipeline.run_actions(connection, max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 262, in run_actions
new_connection = action.run(connection, action_max_end_time)
File "/usr/lib/python3/dist-packages/lava_dispatcher/power.py", line 244, in run
self.run_cmd(cmd, error_msg="Unable to power-off: '%s' failed" % cmd)
File "/usr/lib/python3/dist-packages/lava_dispatcher/action.py", line 695, in run_cmd
raise self.command_exception(error_msg)
lava_common.exceptions.InfrastructureError: Unable to power-off: '/usr/local/bin/acme-cli -s 192.168.66.2 switch_off 4' failed
lava-xnbd cleanup
clean NBD port 61977
Override tmp directory removed at /var/lib/lava/dispatcher/tmp/32063
Root tmp directory removed at /var/lib/lava/dispatcher/tmp/32063
InfrastructureError: The Infrastructure is not working correctly. Please report this error to LAVA admins.
case: job
case_id: 3882361
definition: lava
error_msg: Unable to reboot: '/usr/local/bin/acme-cli -s 192.168.66.2 reset 4' failed
error_type: Infrastructure
result: fail
Please read the triage guidelines for help on debugging failures in the test job, test definitions or in individual test cases.
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.