Infrastructure error: Connection closed
lava-dispatcher, installed at version: 2023.01
start: 0 validate
Start time: 2023-03-08 19:11:45.667317+00:00 (UTC)
Validating that http://download.automotivelinux.org/AGL/upload/ci/28560/2/qemux86-64/bzImage exists
Validating that http://download.automotivelinux.org/AGL/upload/ci/28560/2/qemux86-64/agl-demo-platform-qemux86-64.ext4.xz exists
qemu-system-x86, installed at version: 1:7.2+dfsg-1~bpo11+2, host architecture: amd64
validate duration: 0.44
case: validate
case_id: 3885183
definition: lava
result: pass
start: 1 deployimages (timeout 01:30:00) [common]
start: 1.1 lava-overlay (timeout 01:30:00) [common]
[common] Preparing overlay tarball in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf
makedir: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin
makedir: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/tests
makedir: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/results
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-add-keys
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-add-sources
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-background-process-start
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-background-process-stop
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-common-functions
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-echo-ipv4
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-install-packages
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-installed-packages
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-os-build
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-probe-channel
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-probe-ip
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-target-ip
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-target-mac
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-target-storage
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-case
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-event
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-feedback
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-raise
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-reference
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-runner
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-set
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-test-shell
Updating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-install-packages (oe)
Updating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/bin/lava-installed-packages (oe)
Creating /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/environment
LAVA metadata
- LAVA_JOB_ID=32176
- LAVA_DISPATCHER_IP=172.21.0.2
start: 1.1.1 lava-vland-overlay (timeout 01:30:00) [common]
skipped lava-vland-overlay
end: 1.1.1 lava-vland-overlay (duration 00:00:00) [common]
start: 1.1.2 lava-multinode-overlay (timeout 01:30:00) [common]
skipped lava-multinode-overlay
end: 1.1.2 lava-multinode-overlay (duration 00:00:00) [common]
start: 1.1.3 test-definition (timeout 01:30:00) [common]
Loading test definitions
start: 1.1.3.1 git-repo-action (timeout 01:30:00) [common]
Using /lava-32176 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/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/0_ci-busybox'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/0_ci-busybox
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/0_ci-busybox/test-suites/short-smoke/busybox.yaml
uuid=32176_1.1.3.1 testdef={'testdef_pattern': {'pattern': '^(?P<test_case_id>[a-zA-Z0-9_-]+):\\s(?P<result>\\w+)', 'fixupdict': {'PASS': 'pass', 'FAIL': 'fail'}}}
end: 1.1.3.1 git-repo-action (duration 00:00:03) [common]
case: git-repo-action
case_id: 3885229
definition: lava
duration: 3.08
extra: ...
level: 1.1.3.1
namespace: common
result: pass
start: 1.1.3.2 test-overlay (timeout 01:29:57) [common]
end: 1.1.3.2 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3885230
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.2
namespace: common
result: pass
start: 1.1.3.3 test-install-overlay (timeout 01:29:57) [common]
end: 1.1.3.3 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3885231
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.3
namespace: common
result: pass
start: 1.1.3.4 test-runscript-overlay (timeout 01:29:57) [common]
runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/0_ci-busybox test_uuid 32176_1.1.3.1
end: 1.1.3.4 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3885232
definition: lava
duration: 0.01
extra: ...
level: 1.1.3.4
namespace: common
result: pass
start: 1.1.3.5 git-repo-action (timeout 01:29:57) [common]
Using /lava-32176 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/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/1_ci-smoke-tests-basic'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/1_ci-smoke-tests-basic
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/1_ci-smoke-tests-basic/test-suites/short-smoke/smoke-tests-basic.yaml
uuid=32176_1.1.3.5 testdef=None
end: 1.1.3.5 git-repo-action (duration 00:00:01) [common]
case: git-repo-action
case_id: 3885229
definition: lava
duration: 1.49
extra: ...
level: 1.1.3.5
namespace: common
result: pass
start: 1.1.3.6 test-overlay (timeout 01:29:55) [common]
end: 1.1.3.6 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3885230
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.6
namespace: common
result: pass
start: 1.1.3.7 test-install-overlay (timeout 01:29:55) [common]
end: 1.1.3.7 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3885231
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.7
namespace: common
result: pass
start: 1.1.3.8 test-runscript-overlay (timeout 01:29:55) [common]
runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/1_ci-smoke-tests-basic test_uuid 32176_1.1.3.5
end: 1.1.3.8 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3885232
definition: lava
duration: 0.03
extra: ...
level: 1.1.3.8
namespace: common
result: pass
start: 1.1.3.9 git-repo-action (timeout 01:29:55) [common]
Using /lava-32176 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/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/2_ci-service-check'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/2_ci-service-check
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/2_ci-service-check/test-suites/short-smoke/service-check.yaml
uuid=32176_1.1.3.9 testdef=None
end: 1.1.3.9 git-repo-action (duration 00:00:01) [common]
case: git-repo-action
case_id: 3885229
definition: lava
duration: 1.46
extra: ...
level: 1.1.3.9
namespace: common
result: pass
start: 1.1.3.10 test-overlay (timeout 01:29:54) [common]
end: 1.1.3.10 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3885230
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.10
namespace: common
result: pass
start: 1.1.3.11 test-install-overlay (timeout 01:29:54) [common]
end: 1.1.3.11 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3885231
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.11
namespace: common
result: pass
start: 1.1.3.12 test-runscript-overlay (timeout 01:29:54) [common]
runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0/tests/2_ci-service-check test_uuid 32176_1.1.3.9
BUILD_TAGS=''
DEVICE_TAGS=''
end: 1.1.3.12 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3885232
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.12
namespace: common
result: pass
start: 1.1.3.13 git-repo-action (timeout 01:29:54) [common]
Using /lava-32176 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/32176/lava-overlay-prpv_hjf/lava-32176/1/tests/3_screenshooter'
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/1/tests/3_screenshooter/test-suites/short-smoke/screenshooter.yaml
uuid=32176_1.1.3.13 testdef=None
end: 1.1.3.13 git-repo-action (duration 00:00:01) [common]
case: git-repo-action
case_id: 3885229
definition: lava
duration: 1.50
extra: ...
level: 1.1.3.13
namespace: common
result: pass
start: 1.1.3.14 test-overlay (timeout 01:29:52) [common]
end: 1.1.3.14 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3885230
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.14
namespace: common
result: pass
start: 1.1.3.15 test-install-overlay (timeout 01:29:52) [common]
end: 1.1.3.15 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3885231
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.15
namespace: common
result: pass
start: 1.1.3.16 test-runscript-overlay (timeout 01:29:52) [common]
runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/1/tests/3_screenshooter test_uuid 32176_1.1.3.13
end: 1.1.3.16 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3885232
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.16
namespace: common
result: pass
start: 1.1.3.17 git-repo-action (timeout 01:29:52) [common]
Using /lava-32176 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/32176/lava-overlay-prpv_hjf/lava-32176/2/tests/4_ci-dumpjournal'
Removing '.git' directory in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/2/tests/4_ci-dumpjournal
Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/2/tests/4_ci-dumpjournal/test-suites/short-smoke/dumpjournal.yaml
uuid=32176_1.1.3.17 testdef={'testdef_pattern': {'pattern': '^(?P<test_case_id>[a-zA-Z0-9_-]+):\\s(?P<result>\\w+)', 'fixupdict': {'PASS': 'pass', 'FAIL': 'fail'}}}
end: 1.1.3.17 git-repo-action (duration 00:00:02) [common]
case: git-repo-action
case_id: 3885229
definition: lava
duration: 1.54
extra: ...
level: 1.1.3.17
namespace: common
result: pass
start: 1.1.3.18 test-overlay (timeout 01:29:51) [common]
end: 1.1.3.18 test-overlay (duration 00:00:00) [common]
case: test-overlay
case_id: 3885230
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.18
namespace: common
result: pass
start: 1.1.3.19 test-install-overlay (timeout 01:29:51) [common]
end: 1.1.3.19 test-install-overlay (duration 00:00:00) [common]
case: test-install-overlay
case_id: 3885231
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.19
namespace: common
result: pass
start: 1.1.3.20 test-runscript-overlay (timeout 01:29:51) [common]
runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/2/tests/4_ci-dumpjournal test_uuid 32176_1.1.3.17
end: 1.1.3.20 test-runscript-overlay (duration 00:00:00) [common]
case: test-runscript-overlay
case_id: 3885232
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.20
namespace: common
result: pass
Creating lava-test-runner.conf files
Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/0 for stage 0
- 0_ci-busybox
- 1_ci-smoke-tests-basic
- 2_ci-service-check
Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/1 for stage 1
- 3_screenshooter
Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32176/lava-overlay-prpv_hjf/lava-32176/2 for stage 2
- 4_ci-dumpjournal
end: 1.1.3 test-definition (duration 00:00:09) [common]
start: 1.1.4 compress-overlay (timeout 01:29:51) [common]
end: 1.1.4 compress-overlay (duration 00:00:00) [common]
start: 1.1.5 persistent-nfs-overlay (timeout 01:29:51) [common]
end: 1.1.5 persistent-nfs-overlay (duration 00:00:00) [common]
end: 1.1 lava-overlay (duration 00:00:09) [common]
start: 1.2 apply-overlay-guest (timeout 01:29:51) [common]
Overlay: /var/lib/lava/dispatcher/tmp/32176/compress-overlay-j091mzs6/overlay-1.1.4.tar.gz
end: 1.2 apply-overlay-guest (duration 00:00:04) [common]
case: apply-overlay-guest
case_id: 3885240
definition: lava
duration: 3.81
extra: ...
level: 1.2
namespace: common
result: pass
start: 1.3 deploy-device-env (timeout 01:29:47) [common]
end: 1.3 deploy-device-env (duration 00:00:00) [common]
start: 1.4 download-retry (timeout 01:29:47) [common]
start: 1.4.1 http-download (timeout 01:29:47) [common]
downloading http://download.automotivelinux.org/AGL/upload/ci/28560/2/qemux86-64/bzImage
saving as /var/lib/lava/dispatcher/tmp/32176/deployimages-h8t570eu/kernel/bzImage
total size: 10508416 (10MB)
No compression specified
progress 0% (0MB)
progress 5% (0MB)
progress 10% (1MB)
progress 15% (1MB)
progress 20% (2MB)
progress 25% (2MB)
progress 30% (3MB)
progress 35% (3MB)
progress 40% (4MB)
progress 45% (4MB)
progress 50% (5MB)
progress 55% (5MB)
progress 60% (6MB)
progress 65% (6MB)
progress 70% (7MB)
progress 75% (7MB)
progress 80% (8MB)
progress 85% (8MB)
progress 90% (9MB)
progress 95% (9MB)
progress 100% (10MB)
10MB downloaded in 3.32s (3.02MB/s)
end: 1.4.1 http-download (duration 00:00:03) [common]
case: http-download
case_id: 3885305
definition: lava
duration: 3.32
extra: ...
level: 1.4.1
namespace: common
result: pass
end: 1.4 download-retry (duration 00:00:03) [common]
start: 1.5 download-retry (timeout 01:29:43) [common]
start: 1.5.1 http-download (timeout 01:29:43) [common]
downloading http://download.automotivelinux.org/AGL/upload/ci/28560/2/qemux86-64/agl-demo-platform-qemux86-64.ext4.xz
saving as /var/lib/lava/dispatcher/tmp/32176/deployimages-h8t570eu/rootvd/agl-demo-platform-qemux86-64.ext4
total size: 544575544 (519MB)
Using unxz to decompress xz
progress 0% (0MB)
progress 5% (25MB)
progress 10% (51MB)
progress 15% (77MB)
progress 20% (103MB)
progress 25% (129MB)
progress 30% (155MB)
progress 35% (181MB)
progress 40% (207MB)
progress 45% (233MB)
progress 50% (259MB)
progress 55% (285MB)
progress 60% (311MB)
progress 65% (337MB)
progress 70% (363MB)
progress 75% (389MB)
progress 80% (415MB)
progress 85% (441MB)
progress 90% (467MB)
progress 95% (493MB)
progress 100% (519MB)
519MB downloaded in 100.40s (5.17MB/s)
end: 1.5.1 http-download (duration 00:01:40) [common]
case: http-download
case_id: 3885305
definition: lava
duration: 100.40
extra: ...
level: 1.5.1
namespace: common
result: pass
end: 1.5 download-retry (duration 00:01:40) [common]
end: 1 deployimages (duration 00:01:57) [common]
start: 2 boot-image-retry (timeout 00:20:00) [common]
start: 2.1 boot-qemu-image (timeout 00:20:00) [common]
start: 2.1.1 execute-qemu (timeout 00:20: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=52:54:00:12:34:58 -net user -m 512 -monitor none -machine q35 -cpu qemu64,+ssse3,+sse4.1,+sse4.2,+popcnt -smp 2 -m 2048 -soundhw hda -device usb-ehci -device virtio-rng-pci -vga virtio -device qemu-xhci -device usb-tablet -device usb-kbd -vnc unix:/tmp/vnc-AGL-qemux86-64-933788 -kernel /var/lib/lava/dispatcher/tmp/32176/deployimages-h8t570eu/kernel/bzImage -append "console=ttyS0,115200 root=/dev/sda verbose systemd.log_color=false rw fstab=no no_timer_check" -drive format=raw,file=/var/lib/lava/dispatcher/tmp/32176/deployimages-h8t570eu/rootvd/agl-demo-platform-qemux86-64.ext4 -drive format=qcow2,file=/var/lib/lava/dispatcher/tmp/32176/apply-overlay-guest-ninkbr_t/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: 3885306
definition: lava
duration: 0.89
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:19:59) [common]
Setting prompt string to ['Linux version [0-9]']
auto-login-action: Wait for prompt ['Linux version [0-9]'] (timeout 00:20:00)
qemu-system-x86_64: -soundhw: invalid option
Connection closed
end: 2.2 auto-login-action (duration 00:00:00) [common]
case: auto-login-action
case_id: 3885307
definition: lava
duration: 0.04
extra: ...
level: 2.2
namespace: common
result: fail
boot-image-retry failed: 1 of 1 attempts. 'Connection closed'
Connection closed
end: 2 boot-image-retry (duration 00:00:01) [common]
case: boot-image-retry
case_id: 3885308
definition: lava
duration: 0.93
extra: ...
level: 2
namespace: common
result: fail
Cleaning after the job
Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32176/deployimages-h8t570eu/kernel
Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32176/deployimages-h8t570eu/rootvd
start: 6.1 power-off (timeout 00:00:10) [common]
end: 6.1 power-off (duration 00:00:00) [common]
start: 6.2 read-feedback (timeout 00:30:00) [common]
Finalising connection for namespace 'common'
Already disconnected
end: 6.2 read-feedback (duration 00:00:00) [common]
Root tmp directory removed at /var/lib/lava/dispatcher/tmp/32176
InfrastructureError: The Infrastructure is not working correctly. Please report this error to LAVA admins.
case: job
case_id: 3885309
definition: lava
error_msg: Connection closed
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.