video Encoder testcase failed on RB3 #288
Description
[Executing test case: Video_V4L2_Runner] 1970-01-01 00:10:17 -
[INFO] 1970-01-01 00:10:17 - Rootfs size OK (>=2GiB).
[INFO] 1970-01-01 00:10:17 - STEP: Bring network online (Wi-Fi credentials if provided)
[WARN] 1970-01-01 00:10:17 - connman not enabled or not found.
[INFO] 1970-01-01 00:10:17 - [NET] wlan0: admin=UP oper=down carrier=0 ip=none
[INFO] 1970-01-01 00:10:17 - [NET] wlan0: bringing up Wi-Fi...
[INFO] 1970-01-01 00:10:23 - [NET] wlan0: Wi-Fi attempt 1/2
[INFO] 1970-01-01 00:10:23 - [NET] wlan0: trying nmcli for SSID='Hydra'
[INFO] 1970-01-01 00:10:23 - Trying to connect using nmcli...
�[2K
Device 'wlan0' successfully activated with '5643a242-4434-460c-9fe7-f19175013977'.
[INFO] 1970-01-01 00:10:29 - [NET] wlan0: admin=UP oper=up carrier=1 ip=10.92.178.18
[PASS] 1970-01-01 00:10:30 - [NET] wlan0: internet reachable
[WARN] 1970-01-01 00:10:30 - System clock looks invalid (epoch=630). Trying local time sources (no network)...
[INFO] 1970-01-01 00:10:30 - date: Thu Jan 1 00:10:30 UTC 1970
[INFO] 1970-01-01 00:10:30 - timedatectl: Local time: Thu 1970-01-01 00:10:30 UTC
[INFO] 1970-01-01 00:10:30 - timedatectl: RTC time: Thu 1970-01-01 00:10:29
[INFO] 1970-01-01 00:10:30 - timedatectl: System clock synchronized: no
[INFO] 1970-01-01 00:10:30 - timedatectl: NTP service: active
[INFO] 1970-01-01 00:10:30 - timesync: server=time2.google.com addr=NA
[INFO] 1970-01-01 00:10:30 - timesync: FallbackNTPServers: time1.google.com time2.google.com time3.google.com time4.google.com
[INFO] 1970-01-01 00:10:30 - timesync-status: Server: n/a (time2.google.com)
[INFO] 1970-01-01 00:10:30 - timesync-status: Packet count: 0
[INFO] 1970-01-01 00:10:30 - systemd-timesyncd: Active: active (running) since Mon 2025-10-13 15:01:57 UTC; 55 years 9 months left
[INFO] 1970-01-01 00:10:30 - systemd-timesyncd: Main PID: 410 (systemd-timesyn)
[INFO] 1970-01-01 00:10:32 - rtc0: since_epoch=632
[INFO] 1970-01-01 00:10:32 - kernel-build-time: parsed='Sat Feb 7 16:37:06 UTC 2026'
[PASS] 2026-02-07 16:37:06 - Clock seeded from kernel build time: Sat Feb 7 16:37:06 UTC 2026
[INFO] 2026-02-07 16:37:11 - STEP: Early bundle fetch (best-effort)
[INFO] 2026-02-07 16:37:11 - File video_clips_iris.tar.gz does not exist in ./logs_Video_V4L2_Runner.
[INFO] 2026-02-07 16:37:11 - Using pre-staged tarball: ./video_clips_iris.tar.gz
[INFO] 2026-02-07 16:37:11 - Extracting video_clips_iris.tar.gz...
./256_144p_h264.h264
./256_144p_hevc.h265
./320_240_10fps.ivf
./Animation_144p.yuv
./case_18003_stream.vp9
[PASS] 2026-02-07 16:37:11 - Files extracted successfully (256_144p_h264.h264 present).
[INFO] 2026-02-07 16:37:11 - ----------------------------------------------------------------------
[INFO] 2026-02-07 16:37:11 - ---------------------- Starting Video_V4L2_Runner (modular) -------------------
[INFO] 2026-02-07 16:37:11 - STACK=base PLATFORM=auto STRICT=0 DMESG_SCAN=1
[INFO] 2026-02-07 16:37:11 - TIMEOUT=60s LOGLEVEL=15 REPEAT=1 REPEAT_POLICY=all
[INFO] 2026-02-07 16:37:11 - APP=/usr/bin/iris_v4l2_test
[INFO] 2026-02-07 16:37:11 - SLEEPS: app-launch=1s, inter-test=2s
[INFO] 2026-02-07 16:37:11 - Detected platform: kodiak
[INFO] 2026-02-07 16:37:11 - Current video stack (pre): upstream
[INFO] 2026-02-07 16:37:11 - STEP: Kodiak upstream firmware install
[WARN] 2026-02-07 16:37:11 - No backup firmware found under /opt (tried patterns: vpu20_p1_gen2_.mbn, vpu20_p1_gen2.mbn., *.mbn.bak, *.bak)
[INFO] 2026-02-07 16:37:11 - Modules (pre):
[INFO] 2026-02-07 16:37:11 - lsmod (iris/venus):
Module Size Used by
venus_dec 28672 0
venus_enc 28672 0
venus_core 131072 2 venus_dec,venus_enc
[INFO] 2026-02-07 16:37:11 - modprobe -n qcom_iris:
[INFO] 2026-02-07 16:37:11 - modprobe -n iris_vpu:
[INFO] 2026-02-07 16:37:11 - modprobe -n venus_core:
[INFO] 2026-02-07 16:37:11 - modprobe -n venus_dec:
[INFO] 2026-02-07 16:37:11 - modprobe -n venus_enc:
[INFO] 2026-02-07 16:37:11 - runtime blocks:
[INFO] 2026-02-07 16:37:11 - (none)
[INFO] 2026-02-07 16:37:11 - STEP: Apply desired stack = upstream
[INFO] 2026-02-07 16:37:11 - Video stack (post): upstream
[INFO] 2026-02-07 16:37:11 - Modules (post):
[INFO] 2026-02-07 16:37:11 - lsmod (iris/venus):
Module Size Used by
venus_dec 28672 0
venus_enc 28672 0
venus_core 131072 2 venus_dec,venus_enc
[INFO] 2026-02-07 16:37:11 - modprobe -n qcom_iris:
[INFO] 2026-02-07 16:37:11 - modprobe -n iris_vpu:
[INFO] 2026-02-07 16:37:11 - modprobe -n venus_core:
[INFO] 2026-02-07 16:37:11 - modprobe -n venus_dec:
[INFO] 2026-02-07 16:37:11 - modprobe -n venus_enc:
[INFO] 2026-02-07 16:37:11 - runtime blocks:
[INFO] 2026-02-07 16:37:11 - (none)
[INFO] 2026-02-07 16:37:11 - STEP: Refresh V4L device nodes (udev trigger + prune stale)
[INFO] 2026-02-07 16:37:11 - udev trigger: video4linux/media
[PASS] 2026-02-07 16:37:11 - Upstream validated: venus_core/dec/enc present
[INFO] 2026-02-07 16:37:11 - No --config passed, searching for JSON under testcase dir: /var/Runner/suites/Multimedia/Video/Video_V4L2_Runner
[INFO] 2026-02-07 16:37:11 - Discovered 5 JSON config(s) to run
[INFO] 2026-02-07 16:37:11 - ----------------------------------------------------------------------
[INFO] 2026-02-07 16:37:11 - [decode-h264-h264Decoder] START �?? mode=decode codec=h264 name="H264 Decoder Testcase" cfg="/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h264Decoder.json"
[INFO] 2026-02-07 16:37:11 - [decode-h264-h264Decoder] STEP: Check /dev/video* presence
[INFO] 2026-02-07 16:37:11 - [decode-h264-h264Decoder] STEP: Ensure clips present or fetch
[INFO] 2026-02-07 16:37:11 - [decode-h264-h264Decoder] STEP: Verify required clips exist
[INFO] 2026-02-07 16:37:12 - [decode-h264-h264Decoder] STEP: Execute app
[INFO] 2026-02-07 16:37:12 - [decode-h264-h264Decoder] CMD: /usr/bin/iris_v4l2_test --config "/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h264Decoder.json" --loglevel 15
[INFO] 2026-02-07 16:37:12 - [decode-h264-h264Decoder] pre-launch sleep 1s
[INFO] 2026-02-07 16:37:13 - [decode-h264-h264Decoder] STEP: DMESG triage
[INFO] 2026-02-07 16:37:13 - No relevant, non-benign errors for modules [oom|memory|BUG|hung task|soft lockup|hard lockup|rcu|page allocation failure|I/O error] in recent dmesg.
[PASS] 2026-02-07 16:37:13 - [decode-h264-h264Decoder] PASS (1/1 ok) �?? H264 Decoder Testcase
[INFO] 2026-02-07 16:37:13 - Inter-test sleep 2s
[INFO] 2026-02-07 16:37:15 - ----------------------------------------------------------------------
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] START �?? mode=encode codec=h264 name="Encoder Testcase" cfg="/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h264Encoder.json"
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] STEP: Check /dev/video* presence
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] STEP: Ensure clips present or fetch
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] STEP: Verify required clips exist
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] STEP: Execute app
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] CMD: /usr/bin/iris_v4l2_test --config "/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h264Encoder.json" --loglevel 15
[INFO] 2026-02-07 16:37:15 - [encode-h264-h264Encoder] pre-launch sleep 1s
[INFO] 2026-02-07 16:37:16 - [encode-h264-h264Encoder] STEP: DMESG triage
[INFO] 2026-02-07 16:37:16 - No relevant, non-benign errors for modules [oom|memory|BUG|hung task|soft lockup|hard lockup|rcu|page allocation failure|I/O error] in recent dmesg.
[FAIL] 2026-02-07 16:37:16 - [encode-h264-h264Encoder] FAIL (pass=0 fail=1) �?? Encoder Testcase
[INFO] 2026-02-07 16:37:16 - Inter-test sleep 2s
[INFO] 2026-02-07 16:37:19 - ----------------------------------------------------------------------
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] START �?? mode=decode codec=hevc name="HEVC Decoder TestCase" cfg="/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h265Decoder.json"
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] STEP: Check /dev/video* presence
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] STEP: Ensure clips present or fetch
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] STEP: Verify required clips exist
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] STEP: Execute app
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] CMD: /usr/bin/iris_v4l2_test --config "/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h265Decoder.json" --loglevel 15
[INFO] 2026-02-07 16:37:19 - [decode-hevc-h265Decoder] pre-launch sleep 1s
[INFO] 2026-02-07 16:37:20 - [decode-hevc-h265Decoder] STEP: DMESG triage
[INFO] 2026-02-07 16:37:20 - No relevant, non-benign errors for modules [oom|memory|BUG|hung task|soft lockup|hard lockup|rcu|page allocation failure|I/O error] in recent dmesg.
[PASS] 2026-02-07 16:37:20 - [decode-hevc-h265Decoder] PASS (1/1 ok) �?? HEVC Decoder TestCase
[INFO] 2026-02-07 16:37:20 - Inter-test sleep 2s
[INFO] 2026-02-07 16:37:22 - ----------------------------------------------------------------------
[INFO] 2026-02-07 16:37:22 - [encode-hevc-h265Encoder] START �?? mode=encode codec=hevc name="HEVC Encode TestCase" cfg="/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h265Encoder.json"
[INFO] 2026-02-07 16:37:22 - [encode-hevc-h265Encoder] STEP: Check /dev/video* presence
[INFO] 2026-02-07 16:37:22 - [encode-hevc-h265Encoder] STEP: Ensure clips present or fetch
[INFO] 2026-02-07 16:37:23 - [encode-hevc-h265Encoder] STEP: Verify required clips exist
[INFO] 2026-02-07 16:37:23 - [encode-hevc-h265Encoder] STEP: Execute app
[INFO] 2026-02-07 16:37:23 - [encode-hevc-h265Encoder] CMD: /usr/bin/iris_v4l2_test --config "/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/h265Encoder.json" --loglevel 15
[INFO] 2026-02-07 16:37:23 - [encode-hevc-h265Encoder] pre-launch sleep 1s
[INFO] 2026-02-07 16:37:24 - [encode-hevc-h265Encoder] STEP: DMESG triage
[INFO] 2026-02-07 16:37:24 - No relevant, non-benign errors for modules [oom|memory|BUG|hung task|soft lockup|hard lockup|rcu|page allocation failure|I/O error] in recent dmesg.
[FAIL] 2026-02-07 16:37:24 - [encode-hevc-h265Encoder] FAIL (pass=0 fail=1) �?? HEVC Encode TestCase
[INFO] 2026-02-07 16:37:24 - Inter-test sleep 2s
[INFO] 2026-02-07 16:37:26 - ----------------------------------------------------------------------
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] START �?? mode=decode codec=vp9 name="VP9 Decode TestCase" cfg="/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/vp9Decoder.json"
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] STEP: Check /dev/video* presence
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] STEP: Ensure clips present or fetch
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] STEP: Verify required clips exist
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] STEP: Execute app
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] CMD: /usr/bin/iris_v4l2_test --config "/var/Runner/suites/Multimedia/Video/Video_V4L2_Runner/vp9Decoder.json" --loglevel 15
[INFO] 2026-02-07 16:37:26 - [decode-vp9-vp9Decoder] pre-launch sleep 1s
[INFO] 2026-02-12 19:37:54 - [decode-vp9-vp9Decoder] STEP: DMESG triage
[INFO] 2026-02-12 19:37:54 - No relevant, non-benign errors for modules [oom|memory|BUG|hung task|soft lockup|hard lockup|rcu|page allocation failure|I/O error] in recent dmesg.
[PASS] 2026-02-12 19:37:54 - [decode-vp9-vp9Decoder] PASS (1/1 ok) �?? VP9 Decode TestCase
[INFO] 2026-02-12 19:37:54 - Summary: total=5 pass=3 fail=2 skip=0
[INFO] 2026-02-12 19:37:54 - ----------------------------------------------------------------------
[INFO] 2026-02-12 19:37:54 - Per-test results (id result):
[INFO] 2026-02-12 19:37:54 - decode-h264-h264Decoder PASS
[INFO] 2026-02-12 19:37:54 - encode-h264-h264Encoder FAIL
[INFO] 2026-02-12 19:37:54 - decode-hevc-h265Decoder PASS
[INFO] 2026-02-12 19:37:54 - encode-hevc-h265Encoder FAIL
[INFO] 2026-02-12 19:37:54 - decode-vp9-vp9Decoder PASS