lava-dispatcher, installed at version: 2023.01 start: 0 validate Start time: 2023-03-09 04:04:12.658192+00:00 (UTC) Validating that https://download.automotivelinux.org/AGL/release/octopus/14.94.0/qemux86-64/deploy/images/qemux86-64/bzImage exists Validating that https://download.automotivelinux.org/AGL/release/octopus/14.94.0/qemux86-64/deploy/images/qemux86-64/agl-demo-platform-crosssdk-qemux86-64.ext4.xz exists qemu-system-x86, installed at version: 1:7.2+dfsg-1~bpo11+2, host architecture: amd64 validate duration: 1.02 case: validate
case_id: 3885582
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/32185/lava-overlay-qvn445cm makedir: /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin makedir: /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/tests makedir: /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/results Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-add-keys Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-add-sources Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-background-process-start Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-background-process-stop Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-common-functions Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-echo-ipv4 Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-install-packages Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-installed-packages Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-os-build Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-probe-channel Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-probe-ip Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-target-ip Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-target-mac Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-target-storage Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-case Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-event Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-feedback Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-raise Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-reference Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-runner Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-set Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-test-shell Updating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-install-packages (oe) Updating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/bin/lava-installed-packages (oe) Creating /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/environment LAVA metadata - LAVA_JOB_ID=32185 - LAVA_DISPATCHER_IP=192.168.111.1 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-32185 at stage 0 Fetching tests from https://github.com/duerpei/yan_test.git Running '/usr/bin/git clone --depth=1 https://github.com/duerpei/yan_test.git /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/0/tests/0_check_space' Tests stored (tmp) in /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/0/tests/0_check_space/check_space.yaml uuid=32185_1.1.3.1 testdef=None end: 1.1.3.1 git-repo-action (duration 00:00:01) [common] case: git-repo-action
case_id: 3885583
definition: lava
duration: 0.64
extra: ...
level: 1.1.3.1
namespace: common
result: pass
start: 1.1.3.2 test-overlay (timeout 01:29:59) [common] end: 1.1.3.2 test-overlay (duration 00:00:00) [common] case: test-overlay
case_id: 3885584
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:59) [common] end: 1.1.3.3 test-install-overlay (duration 00:00:00) [common] case: test-install-overlay
case_id: 3885585
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:59) [common] runner path: /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/0/tests/0_check_space test_uuid 32185_1.1.3.1 end: 1.1.3.4 test-runscript-overlay (duration 00:00:00) [common] case: test-runscript-overlay
case_id: 3885586
definition: lava
duration: 0.00
extra: ...
level: 1.1.3.4
namespace: common
result: pass
Creating lava-test-runner.conf files Using lava-test-runner path: /var/lib/lava/dispatcher/tmp/32185/lava-overlay-qvn445cm/lava-32185/0 for stage 0 - 0_check_space end: 1.1.3 test-definition (duration 00:00:01) [common] start: 1.1.4 compress-overlay (timeout 01:29:59) [common] end: 1.1.4 compress-overlay (duration 00:00:00) [common] start: 1.1.5 persistent-nfs-overlay (timeout 01:29:59) [common] end: 1.1.5 persistent-nfs-overlay (duration 00:00:00) [common] end: 1.1 lava-overlay (duration 00:00:01) [common] start: 1.2 apply-overlay-guest (timeout 01:29:59) [common] Overlay: /var/lib/lava/dispatcher/tmp/32185/compress-overlay-dvpm1ix8/overlay-1.1.4.tar.gz end: 1.2 apply-overlay-guest (duration 00:00:04) [common] case: apply-overlay-guest
case_id: 3885587
definition: lava
duration: 4.29
extra: ...
level: 1.2
namespace: common
result: pass
start: 1.3 deploy-device-env (timeout 01:29:55) [common] end: 1.3 deploy-device-env (duration 00:00:00) [common] start: 1.4 download-retry (timeout 01:29:55) [common] start: 1.4.1 http-download (timeout 01:29:55) [common] downloading https://download.automotivelinux.org/AGL/release/octopus/14.94.0/qemux86-64/deploy/images/qemux86-64/bzImage saving as /var/lib/lava/dispatcher/tmp/32185/deployimages-1wc31zgr/kernel/bzImage total size: 10508640 (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 1.61s (6.22MB/s) end: 1.4.1 http-download (duration 00:00:02) [common] case: http-download
case_id: 3885589
definition: lava
duration: 1.61
extra: ...
level: 1.4.1
namespace: common
result: pass
end: 1.4 download-retry (duration 00:00:02) [common] start: 1.5 download-retry (timeout 01:29:53) [common] start: 1.5.1 http-download (timeout 01:29:53) [common] downloading https://download.automotivelinux.org/AGL/release/octopus/14.94.0/qemux86-64/deploy/images/qemux86-64/agl-demo-platform-crosssdk-qemux86-64.ext4.xz saving as /var/lib/lava/dispatcher/tmp/32185/deployimages-1wc31zgr/rootvd/agl-demo-platform-crosssdk-qemux86-64.ext4 total size: 946577076 (902MB) Using unxz to decompress xz progress 0% (0MB) progress 5% (45MB) progress 10% (90MB) progress 15% (135MB) progress 20% (180MB) progress 25% (225MB) progress 30% (270MB) progress 35% (315MB) progress 40% (361MB) progress 45% (406MB) progress 50% (451MB) progress 55% (496MB) progress 60% (541MB) progress 65% (586MB) progress 70% (631MB) progress 75% (677MB) progress 80% (722MB) progress 85% (767MB) progress 90% (812MB) progress 95% (857MB) progress 100% (902MB) 902MB downloaded in 117.99s (7.65MB/s) end: 1.5.1 http-download (duration 00:01:58) [common] case: http-download
case_id: 3885589
definition: lava
duration: 117.99
extra: ...
level: 1.5.1
namespace: common
result: pass
end: 1.5 download-retry (duration 00:01:58) [common] end: 1 deployimages (duration 00:02:05) [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-184052 -kernel /var/lib/lava/dispatcher/tmp/32185/deployimages-1wc31zgr/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/32185/deployimages-1wc31zgr/rootvd/agl-demo-platform-crosssdk-qemux86-64.ext4 -drive format=qcow2,file=/var/lib/lava/dispatcher/tmp/32185/apply-overlay-guest-plteq1mi/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: 3885590
definition: lava
duration: 0.79
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: 3885591
definition: lava
duration: 0.03
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: 3885592
definition: lava
duration: 0.82
extra: ...
level: 2
namespace: common
result: fail
Cleaning after the job Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32185/deployimages-1wc31zgr/kernel Cleaning up download directory: /var/lib/lava/dispatcher/tmp/32185/deployimages-1wc31zgr/rootvd 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 10:00:00) [common] Finalising connection for namespace 'common' Already disconnected end: 4.2 read-feedback (duration 00:00:00) [common] Root tmp directory removed at /var/lib/lava/dispatcher/tmp/32185 InfrastructureError: The Infrastructure is not working correctly. Please report this error to LAVA admins. case: job
case_id: 3885593
definition: lava
error_msg: Connection closed
error_type: Infrastructure
result: fail