[68.527773] Initializing watchdogs
[68.527839]   /dev/watchdog0
[68.546981] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:03:00.0: 8086:56a0 Intel Dg2 (Gen12) DG2 [Arc A770]
[68.557785] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:03:00.0: card0
[68.561650] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[68.563978] [001/133] (960s left) kms_frontbuffer_tracking (psr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[68.748270] Starting subtest: psr-2p-primscrn-spr-indfb-draw-mmap-gtt
[68.749982] Subtest psr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[68.947629] [002/133] (960s left) gem_exec_suspend (basic-s3-devices)
[69.034508] Starting subtest: basic-S3-devices
[69.035439] Starting dynamic subtest: smem
[79.250734] Dynamic subtest smem: SUCCESS (10.221s)
[79.259126] Starting dynamic subtest: lmem0
[89.534525] Dynamic subtest lmem0: SUCCESS (10.283s)
[89.535628] Subtest basic-S3-devices: SUCCESS (20.505s)
[89.868152] [003/133] (939s left) gem_render_copy (y-tiled-ccs-to-yf-tiled)
[89.943287] Starting subtest: y-tiled-ccs-to-yf-tiled
[89.945014] Subtest y-tiled-ccs-to-yf-tiled: SKIP (0.000s)
[90.197992] [004/133] (939s left) kms_ccs (ccs-on-another-bo-y-tiled-gen12-mc-ccs)
[90.371904] Starting subtest: ccs-on-another-bo-y-tiled-gen12-mc-ccs
[90.372810] Starting dynamic subtest: pipe-A-DP-3
[90.381071] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[90.389538] Starting dynamic subtest: pipe-B-DP-3
[90.397978] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[90.407128] Starting dynamic subtest: pipe-C-DP-3
[90.415303] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[90.423542] Starting dynamic subtest: pipe-D-DP-3
[90.432938] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[90.435010] Subtest ccs-on-another-bo-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[90.826935] [005/133] (938s left) kms_flip (bo-too-big)
[91.012287] Starting subtest: bo-too-big
[91.016263] Starting dynamic subtest: A-DP3
[91.396888] Dynamic subtest A-DP3: SUCCESS (0.380s)
[91.423638] Starting dynamic subtest: B-DP3
[91.666573] Dynamic subtest B-DP3: SUCCESS (0.269s)
[91.692618] Starting dynamic subtest: C-DP3
[91.941499] Dynamic subtest C-DP3: SUCCESS (0.274s)
[91.966079] Starting dynamic subtest: D-DP3
[92.223655] Dynamic subtest D-DP3: SUCCESS (0.281s)
[92.227331] Subtest bo-too-big: SUCCESS (1.215s)
[92.647480] [006/133] (936s left) syncobj_timeline (multi-wait-available-unsubmitted-signaled)
[92.715895] Starting subtest: multi-wait-available-unsubmitted-signaled
[92.716766] Subtest multi-wait-available-unsubmitted-signaled: SUCCESS (0.001s)
[92.870476] [007/133] (936s left) kms_lease (lease-uevent)
[93.044148] Starting subtest: lease-uevent
[94.064939] Subtest lease-uevent: SUCCESS (1.021s)
[94.181912] [008/133] (935s left) gem_exec_fence (syncobj-timeline-wait)
[94.826981] Starting subtest: syncobj-timeline-wait
[94.941210] Subtest syncobj-timeline-wait: SUCCESS (0.114s)
[95.267833] [FACT gem_exec_fence (syncobj-timeline-wait)] new: kernel.kmod_is_loaded.vgem: true
[95.269457] [009/133] (934s left) kms_chamelium_color (gamma)
[95.452569] Subtest gamma: SKIP (0.000s)
[95.510498] [010/133] (934s left) prime_mmap (test_errors)
[95.585319] Starting subtest: test_errors
[95.586202] Starting dynamic subtest: test_errors-smem
[95.723209] Dynamic subtest test_errors-smem: SUCCESS (0.136s)
[95.732369] Starting dynamic subtest: test_errors-lmem0
[96.277562] Dynamic subtest test_errors-lmem0: SUCCESS (0.555s)
[96.278461] Subtest test_errors: SUCCESS (0.692s)
[96.429765] [011/133] (933s left) i915_drm_fdinfo (idle)
[96.497719] Starting subtest: idle
[96.498562] Starting dynamic subtest: rcs0
[97.129580] Dynamic subtest rcs0: SUCCESS (0.631s)
[97.142631] Starting dynamic subtest: bcs0
[97.635215] Dynamic subtest bcs0: SUCCESS (0.504s)
[97.645573] Starting dynamic subtest: vcs0
[98.140804] Dynamic subtest vcs0: SUCCESS (0.505s)
[98.151243] Starting dynamic subtest: vcs1
[98.646534] Dynamic subtest vcs1: SUCCESS (0.505s)
[98.656814] Starting dynamic subtest: vecs0
[99.152145] Dynamic subtest vecs0: SUCCESS (0.504s)
[99.162182] Starting dynamic subtest: vecs1
[99.657543] Dynamic subtest vecs1: SUCCESS (0.504s)
[99.667710] Starting dynamic subtest: ccs0
[100.163303] Dynamic subtest ccs0: SUCCESS (0.504s)
[100.164427] Subtest idle: SUCCESS (3.665s)
[100.298237] [012/133] (929s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu)
[100.489318] Starting subtest: fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu
[100.490957] Subtest fbc-2p-scndscrn-pri-shrfb-draw-mmap-cpu: SKIP (0.000s)
[100.683730] [013/133] (929s left) kms_invalid_mode (zero-hdisplay)
[100.868842] Starting subtest: zero-hdisplay
[100.869711] Starting dynamic subtest: pipe-A-DP-3
[100.943237] Dynamic subtest pipe-A-DP-3: SUCCESS (0.074s)
[100.954094] Starting dynamic subtest: pipe-B-DP-3
[100.955217] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[100.965811] Starting dynamic subtest: pipe-C-DP-3
[100.967010] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[100.977589] Starting dynamic subtest: pipe-D-DP-3
[100.978534] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[100.979429] Subtest zero-hdisplay: SUCCESS (0.080s)
[101.232506] [014/133] (928s left) kms_plane_scaling (planes-downscale-factor-0-75-unity-scaling)
[101.415863] Starting subtest: planes-downscale-factor-0-75-unity-scaling
[101.416640] Starting dynamic subtest: pipe-A
[101.498337] Dynamic subtest pipe-A: SUCCESS (0.083s)
[101.510485] Starting dynamic subtest: pipe-B
[101.695043] Dynamic subtest pipe-B: SUCCESS (0.196s)
[101.710252] Starting dynamic subtest: pipe-C
[101.907897] Dynamic subtest pipe-C: SUCCESS (0.213s)
[101.923557] Starting dynamic subtest: pipe-D
[102.121945] Dynamic subtest pipe-D: SUCCESS (0.214s)
[102.122941] Subtest planes-downscale-factor-0-75-unity-scaling: SUCCESS (0.707s)
[102.483036] [015/133] (927s left) drm_read (fault-buffer)
[102.735871] Starting subtest: fault-buffer
[102.736763] Subtest fault-buffer: SUCCESS (0.001s)
[102.997789] [016/133] (927s left) gem_ccs (suspend-resume)
[103.081465] Starting subtest: suspend-resume
[103.083291] Starting dynamic subtest: linear-compressed-compfmt0-smem-lmem0
[121.526058] Dynamic subtest linear-compressed-compfmt0-smem-lmem0: SUCCESS (3.898s)
[121.535528] Starting dynamic subtest: linear-compressed-compfmt0-lmem0-lmem0
[139.588760] Dynamic subtest linear-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.765s)
[139.597857] Starting dynamic subtest: xmajor-compressed-compfmt0-smem-lmem0
[157.482670] Dynamic subtest xmajor-compressed-compfmt0-smem-lmem0: SUCCESS (3.631s)
[157.491953] Starting dynamic subtest: xmajor-compressed-compfmt0-lmem0-lmem0
[175.626151] Dynamic subtest xmajor-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.719s)
[175.635556] Starting dynamic subtest: tile4-compressed-compfmt0-smem-lmem0
[193.492324] Dynamic subtest tile4-compressed-compfmt0-smem-lmem0: SUCCESS (3.669s)
[193.501388] Starting dynamic subtest: tile4-compressed-compfmt0-lmem0-lmem0
[211.573065] Dynamic subtest tile4-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.712s)
[211.582309] Starting dynamic subtest: tile64-compressed-compfmt0-smem-lmem0
[229.487021] Dynamic subtest tile64-compressed-compfmt0-smem-lmem0: SUCCESS (3.632s)
[229.496551] Starting dynamic subtest: tile64-compressed-compfmt0-lmem0-lmem0
[247.582050] Dynamic subtest tile64-compressed-compfmt0-lmem0-lmem0: SUCCESS (3.723s)
[247.583053] Subtest suspend-resume: SUCCESS (29.755s)
[247.790972] [017/133] (782s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs)
[247.975203] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs
[247.976065] Starting dynamic subtest: pipe-A-DP-3
[247.984468] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[247.993771] Starting dynamic subtest: pipe-B-DP-3
[248.001899] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[248.010980] Starting dynamic subtest: pipe-C-DP-3
[248.018709] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[248.027646] Starting dynamic subtest: pipe-D-DP-3
[248.035914] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[248.037607] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs: SKIP (0.004s)
[248.452521] [018/133] (781s left) gem_close (many-handles-one-vma)
[248.541702] Starting subtest: many-handles-one-vma
[248.568917] Subtest many-handles-one-vma: SUCCESS (0.029s)
[248.711705] [019/133] (781s left) gem_busy (extended)
[248.944974] Starting subtest: extended
[248.945917] Starting dynamic subtest: rcs0
[249.045690] Dynamic subtest rcs0: SUCCESS (0.101s)
[249.058661] Starting dynamic subtest: bcs0
[249.090008] Dynamic subtest bcs0: SUCCESS (0.044s)
[249.108311] Starting dynamic subtest: vcs0
[249.133179] Dynamic subtest vcs0: SUCCESS (0.043s)
[249.155663] Starting dynamic subtest: vcs1
[249.177630] Dynamic subtest vcs1: SUCCESS (0.044s)
[249.199962] Starting dynamic subtest: vecs0
[249.221591] Dynamic subtest vecs0: SUCCESS (0.044s)
[249.239792] Starting dynamic subtest: vecs1
[249.265612] Dynamic subtest vecs1: SUCCESS (0.044s)
[249.286836] Starting dynamic subtest: ccs0
[249.309640] Dynamic subtest ccs0: SUCCESS (0.044s)
[249.310855] Subtest extended: SUCCESS (0.371s)
[249.615320] [020/133] (780s left) kms_vblank (ts-continuation-suspend)
[249.797267] Starting subtest: ts-continuation-suspend
[249.799198] Starting dynamic subtest: pipe-A-DP-3
[269.535288] Dynamic subtest pipe-A-DP-3: SUCCESS (3.825s)
[269.547885] Starting dynamic subtest: pipe-D-DP-3
[288.925319] Dynamic subtest pipe-D-DP-3: SUCCESS (3.842s)
[288.926154] Subtest ts-continuation-suspend: SUCCESS (7.671s)
[289.149397] [021/133] (741s left) perf_pmu (semaphore-wait-idle)
[289.220300] Starting subtest: semaphore-wait-idle
[289.221184] Starting dynamic subtest: rcs0
[289.759707] Dynamic subtest rcs0: SUCCESS (0.538s)
[289.772736] Starting dynamic subtest: bcs0
[290.273240] Dynamic subtest bcs0: SUCCESS (0.512s)
[290.286407] Starting dynamic subtest: vcs0
[290.785556] Dynamic subtest vcs0: SUCCESS (0.511s)
[290.799067] Starting dynamic subtest: vcs1
[291.298134] Dynamic subtest vcs1: SUCCESS (0.511s)
[291.311650] Starting dynamic subtest: vecs0
[291.810963] Dynamic subtest vecs0: SUCCESS (0.511s)
[291.824612] Starting dynamic subtest: vecs1
[292.323846] Dynamic subtest vecs1: SUCCESS (0.511s)
[292.337367] Starting dynamic subtest: ccs0
[292.836959] Dynamic subtest ccs0: SUCCESS (0.511s)
[292.838990] Subtest semaphore-wait-idle: SUCCESS (3.618s)
[293.036219] [022/133] (737s left) kms_debugfs (display-off-read-all)
[293.222934] Starting subtest: display-off-read-all
[293.298142] Subtest display-off-read-all: SUCCESS (0.075s)
[293.560734] [023/133] (737s left) kms_frontbuffer_tracking (fbc-rgb101010-draw-blt)
[293.751612] Starting subtest: fbc-rgb101010-draw-blt
[296.649368] Subtest fbc-rgb101010-draw-blt: SUCCESS (2.900s)
[296.846874] [024/133] (733s left) gem_ctx_param (invalid-get-no-zeromap)
[296.922512] Starting subtest: invalid-get-no-zeromap
[296.924457] Subtest invalid-get-no-zeromap: SUCCESS (0.001s)
[297.129825] [025/133] (733s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt)
[297.322599] Starting subtest: fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt
[297.324260] Subtest fbcpsr-2p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[297.553116] [026/133] (733s left) gem_exec_big (single)
[297.634815] Starting subtest: single
[303.209544] Subtest single: SUCCESS (5.577s)
[303.967993] [027/133] (726s left) kms_frontbuffer_tracking (psr-rgb101010-draw-mmap-gtt)
[304.226391] Starting subtest: psr-rgb101010-draw-mmap-gtt
[304.228158] Subtest psr-rgb101010-draw-mmap-gtt: SKIP (0.000s)
[304.474460] [028/133] (726s left) gem_exec_flush (basic-uc-prw-default)
[304.560456] Subtest basic-uc-prw-default: SKIP (0.000s)
[304.638718] [029/133] (726s left) kms_frontbuffer_tracking (fbc-1p-shrfb-fliptrack-mmap-gtt)
[304.889649] Starting subtest: fbc-1p-shrfb-fliptrack-mmap-gtt
[304.891291] Subtest fbc-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[305.056714] [030/133] (725s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[305.248578] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[305.250269] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SKIP (0.000s)
[305.457130] [031/133] (725s left) gem_exec_create (forked)
[305.534820] Starting subtest: forked
[305.535724] Starting dynamic subtest: smem
[325.674321] Dynamic subtest smem: SUCCESS (20.149s)
[325.692194] Starting dynamic subtest: lmem0
[345.855290] Dynamic subtest lmem0: SUCCESS (20.191s)
[345.856338] Subtest forked: SUCCESS (40.341s)
[346.135635] [032/133] (685s left) kms_feature_discovery (display-1x)
[346.321222] Starting subtest: display-1x
[346.322193] Subtest display-1x: SUCCESS (0.000s)
[346.471286] [033/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc)
[346.659405] Starting subtest: fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc
[346.661035] Subtest fbcpsr-2p-scndscrn-spr-indfb-draw-mmap-wc: SKIP (0.000s)
[346.871062] [034/133] (684s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-cur-indfb-move)
[347.068651] Starting subtest: fbcpsr-2p-primscrn-cur-indfb-move
[347.070297] Subtest fbcpsr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[347.258790] [035/133] (684s left) gem_render_copy_redux (interruptible)
[347.341310] Starting subtest: interruptible
[348.102548] Subtest interruptible: SUCCESS (0.762s)
[348.274944] [036/133] (683s left) i915_pm_rpm (system-suspend-execbuf)
[350.696881] Starting subtest: system-suspend-execbuf
[410.963131] Subtest system-suspend-execbuf: SUCCESS (45.036s)
[411.367555] [037/133] (620s left) kms_frontbuffer_tracking (psr-2p-scndscrn-indfb-plflip-blt)
[411.555606] Starting subtest: psr-2p-scndscrn-indfb-plflip-blt
[411.557294] Subtest psr-2p-scndscrn-indfb-plflip-blt: SKIP (0.000s)
[411.759274] [038/133] (619s left) gem_request_retire (retire-vma-not-inactive)
[411.838415] Starting subtest: retire-vma-not-inactive
[411.919911] Subtest retire-vma-not-inactive: SUCCESS (0.081s)
[412.112594] [039/133] (619s left) i915_pm_rps (thresholds-idle)
[412.198343] Starting subtest: thresholds-idle
[412.200456] Subtest thresholds-idle: SKIP (0.000s)
[412.334472] [040/133] (619s left) gem_ctx_persistence (legacy-engines-queued)
[412.413850] Starting subtest: legacy-engines-queued
[412.414725] Starting dynamic subtest: render
[412.506266] Dynamic subtest render: SUCCESS (0.092s)
[412.519131] Starting dynamic subtest: bsd1
[412.555422] Dynamic subtest bsd1: SUCCESS (0.048s)
[412.574815] Starting dynamic subtest: bsd2
[412.616574] Dynamic subtest bsd2: SUCCESS (0.060s)
[412.633211] Starting dynamic subtest: blt
[412.643341] Dynamic subtest blt: SUCCESS (0.025s)
[412.655907] Starting dynamic subtest: vebox
[412.690121] Dynamic subtest vebox: SUCCESS (0.046s)
[412.691055] Subtest legacy-engines-queued: SUCCESS (0.277s)
[412.863413] [041/133] (618s left) i915_hangman (gt-error-state-capture)
[412.959217] Starting subtest: gt-error-state-capture
[412.960223] Starting dynamic subtest: rcs0
[423.011753] Dynamic subtest rcs0: SUCCESS (10.054s)
[423.034207] Starting dynamic subtest: bcs0
[433.005450] Dynamic subtest bcs0: SUCCESS (9.996s)
[433.018410] Starting dynamic subtest: vcs0
[443.019786] Dynamic subtest vcs0: SUCCESS (10.017s)
[443.035248] Starting dynamic subtest: vcs1
[452.968592] Dynamic subtest vcs1: SUCCESS (9.952s)
[452.981633] Starting dynamic subtest: vecs0
[463.005578] Dynamic subtest vecs0: SUCCESS (10.041s)
[463.018718] Starting dynamic subtest: vecs1
[472.998946] Dynamic subtest vecs1: SUCCESS (9.989s)
[473.011840] Starting dynamic subtest: ccs0
[483.009394] Dynamic subtest ccs0: SUCCESS (10.007s)
[483.010332] Subtest gt-error-state-capture: SUCCESS (70.062s)
[483.233835] [042/133] (548s left) kms_cursor_crc (cursor-rapid-movement-128x42)
[483.622425] Starting subtest: cursor-rapid-movement-128x42
[483.626568] Starting dynamic subtest: pipe-A-DP-3
[484.110461] Dynamic subtest pipe-A-DP-3: SUCCESS (0.483s)
[484.162003] Starting dynamic subtest: pipe-D-DP-3
[484.554455] Dynamic subtest pipe-D-DP-3: SUCCESS (0.405s)
[484.555380] Subtest cursor-rapid-movement-128x42: SUCCESS (0.932s)
[485.023444] [043/133] (546s left) gem_partial_pwrite_pread (writes-after-reads-uncached)
[485.108321] Subtest writes-after-reads-uncached: SKIP (0.000s)
[485.201843] [044/133] (546s left) gem_mmap_wc (coherency)
[485.285213] Subtest coherency: SKIP (0.000s)
[485.361393] [045/133] (546s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[485.447531] Starting subtest: single-wait-all-for-submit-signaled
[485.448541] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[485.633462] [046/133] (546s left) kms_frontbuffer_tracking (fbc-1p-primscrn-cur-indfb-draw-render)
[485.823921] Starting subtest: fbc-1p-primscrn-cur-indfb-draw-render
[488.566763] Subtest fbc-1p-primscrn-cur-indfb-draw-render: SUCCESS (2.743s)
[488.783836] [047/133] (543s left) kms_psr (fbc-psr-primary-mmap-cpu)
[488.971472] Subtest fbc-psr-primary-mmap-cpu: SKIP (0.000s)
[489.028067] [048/133] (543s left) kms_invalid_mode (bad-vsync-start)
[489.218595] Starting subtest: bad-vsync-start
[489.219468] Starting dynamic subtest: pipe-A-DP-3
[489.289364] Dynamic subtest pipe-A-DP-3: SUCCESS (0.070s)
[489.305017] Starting dynamic subtest: pipe-B-DP-3
[489.306251] Dynamic subtest pipe-B-DP-3: SUCCESS (0.001s)
[489.320063] Starting dynamic subtest: pipe-C-DP-3
[489.321016] Dynamic subtest pipe-C-DP-3: SUCCESS (0.001s)
[489.334424] Starting dynamic subtest: pipe-D-DP-3
[489.335273] Dynamic subtest pipe-D-DP-3: SUCCESS (0.001s)
[489.336170] Subtest bad-vsync-start: SUCCESS (0.078s)
[489.577319] [049/133] (542s left) gem_exec_reloc (basic-wc-gtt)
[489.664523] Subtest basic-wc-gtt: SKIP (0.000s)
[489.751379] [050/133] (542s left) gem_mmap_gtt (cpuset-medium-copy-xy)
[489.836179] Subtest cpuset-medium-copy-XY: SKIP (0.000s)
[489.920649] [051/133] (542s left) kms_prop_blob (blob-multiple)
[489.998465] Starting subtest: blob-multiple
[490.030178] Subtest blob-multiple: SUCCESS (0.033s)
[490.224024] [052/133] (542s left) api_intel_allocator (open-vm)
[490.300225] Starting subtest: open-vm
[490.330026] Subtest open-vm: SUCCESS (0.030s)
[490.541686] [053/133] (542s left) kms_getfb (getfb-repeated-different-handles)
[490.728204] Starting subtest: getfb-repeated-different-handles
[490.729081] Subtest getfb-repeated-different-handles: SUCCESS (0.000s)
[490.957552] [054/133] (541s left) kms_content_protection (legacy-hdcp14)
[491.211311] Starting subtest: legacy-hdcp14
[491.492867] Starting dynamic subtest: pipe-A-DP-3
[613.167592] Dynamic subtest pipe-A-DP-3: FAIL (121.440s)
[613.168970] Subtest legacy-hdcp14: FAIL (121.821s)
[613.314458] [055/133] (419s left) kms_chamelium_hpd (hdmi-hpd-after-suspend)
[613.589730] Subtest hdmi-hpd-after-suspend: SKIP (0.000s)
[613.744942] [056/133] (419s left) kms_flip (blocking-absolute-wf_vblank)
[613.934088] Starting subtest: blocking-absolute-wf_vblank
[613.938461] Starting dynamic subtest: A-DP3
[621.787724] Dynamic subtest A-DP3: SUCCESS (7.844s)
[621.803408] Starting dynamic subtest: B-DP3
[629.559434] Dynamic subtest B-DP3: SUCCESS (7.767s)
[629.574622] Starting dynamic subtest: C-DP3
[637.333671] Dynamic subtest C-DP3: SUCCESS (7.771s)
[637.349295] Starting dynamic subtest: D-DP3
[645.099961] Dynamic subtest D-DP3: SUCCESS (7.764s)
[645.102206] Subtest blocking-absolute-wf_vblank: SUCCESS (31.156s)
[645.450640] [057/133] (387s left) gem_mmap_offset (bad-object)
[645.525368] Starting subtest: bad-object
[645.526288] Subtest bad-object: SUCCESS (0.000s)
[645.679154] [058/133] (387s left) kms_psr (psr2-no-drrs)
[645.868353] Subtest psr2-no-drrs: SKIP (0.000s)
[645.925399] [059/133] (387s left) gem_fenced_exec_thrash (no-spare-fences-interruptible)
[646.008663] Subtest no-spare-fences-interruptible: SKIP (0.000s)
[646.094619] [060/133] (387s left) kms_vblank (wait-idle)
[646.279615] Starting subtest: wait-idle
[646.281968] Starting dynamic subtest: pipe-A-DP-3
[648.631382] Dynamic subtest pipe-A-DP-3: SUCCESS (2.348s)
[648.662052] Starting dynamic subtest: pipe-D-DP-3
[650.890066] Dynamic subtest pipe-D-DP-3: SUCCESS (2.250s)
[650.891076] Subtest wait-idle: SUCCESS (4.610s)
[651.184842] [061/133] (382s left) gem_exec_whisper (basic-contexts-all)
[651.274611] Starting subtest: basic-contexts-all
[673.299698] Subtest basic-contexts-all: SUCCESS (22.023s)
[673.599148] [062/133] (359s left) kms_big_fb (x-tiled-16bpp-rotate-0)
[673.796305] Starting subtest: x-tiled-16bpp-rotate-0
[675.513301] Subtest x-tiled-16bpp-rotate-0: SUCCESS (1.716s)
[675.728522] [063/133] (357s left) kms_atomic (plane-primary-overlay-mutable-zpos)
[675.911951] Starting subtest: plane-primary-overlay-mutable-zpos
[678.058386] Subtest plane-primary-overlay-mutable-zpos: SKIP (2.145s)
[678.452456] [064/133] (355s left) gen9_exec_parse (bb-start-cmd)
[678.535220] Subtest bb-start-cmd: SKIP (0.000s)
[678.611859] [065/133] (354s left) kms_cursor_crc (cursor-alpha-opaque)
[678.804721] Starting subtest: cursor-alpha-opaque
[678.805588] Starting dynamic subtest: pipe-A-DP-3
[679.393612] Dynamic subtest pipe-A-DP-3: SUCCESS (0.596s)
[679.419435] Starting dynamic subtest: pipe-D-DP-3
[679.947060] Dynamic subtest pipe-D-DP-3: SUCCESS (0.550s)
[679.948026] Subtest cursor-alpha-opaque: SUCCESS (1.151s)
[680.597641] [066/133] (352s left) kms_cursor_crc (cursor-sliding-64x64)
[680.919999] Starting subtest: cursor-sliding-64x64
[680.924861] Starting dynamic subtest: pipe-A-DP-3
[685.226071] Dynamic subtest pipe-A-DP-3: SUCCESS (4.301s)
[685.277620] Starting dynamic subtest: pipe-D-DP-3
[689.637567] Dynamic subtest pipe-D-DP-3: SUCCESS (4.374s)
[689.638484] Subtest cursor-sliding-64x64: SUCCESS (8.719s)
[690.164215] [067/133] (343s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-render)
[690.354895] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-render
[690.356516] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[690.581412] [068/133] (343s left) gem_ctx_shared (exec-single-timeline)
[690.672491] Starting subtest: exec-single-timeline
[690.673455] Starting dynamic subtest: rcs0
[691.774224] Dynamic subtest rcs0: SUCCESS (1.101s)
[691.792443] Starting dynamic subtest: bcs0
[692.798973] Dynamic subtest bcs0: SUCCESS (1.021s)
[692.816480] Starting dynamic subtest: vcs0
[693.822498] Dynamic subtest vcs0: SUCCESS (1.019s)
[693.839562] Starting dynamic subtest: vcs1
[694.847141] Dynamic subtest vcs1: SUCCESS (1.021s)
[694.864419] Starting dynamic subtest: vecs0
[695.871122] Dynamic subtest vecs0: SUCCESS (1.019s)
[695.888602] Starting dynamic subtest: vecs1
[696.895130] Dynamic subtest vecs1: SUCCESS (1.019s)
[696.912119] Starting dynamic subtest: ccs0
[697.919153] Dynamic subtest ccs0: SUCCESS (1.020s)
[697.923681] Subtest exec-single-timeline: SUCCESS (7.249s)
[698.208707] [069/133] (335s left) kms_plane_scaling (plane-downscale-factor-0-75-with-pixel-format)
[698.392363] Starting subtest: plane-downscale-factor-0-75-with-pixel-format
[698.393134] Starting dynamic subtest: pipe-A
[700.539289] Dynamic subtest pipe-A: SUCCESS (2.148s)
[700.565200] Starting dynamic subtest: pipe-B
[702.735103] Dynamic subtest pipe-B: SUCCESS (2.194s)
[702.761570] Starting dynamic subtest: pipe-C
[703.047714] Dynamic subtest pipe-C: SUCCESS (0.311s)
[703.068119] Starting dynamic subtest: pipe-D
[703.343941] Dynamic subtest pipe-D: SUCCESS (0.295s)
[703.345096] Subtest plane-downscale-factor-0-75-with-pixel-format: SUCCESS (4.954s)
[703.710810] [070/133] (330s left) gem_wait (write-busy)
[703.804445] Starting subtest: write-busy
[703.805346] Starting dynamic subtest: all-engines
[704.411296] Dynamic subtest all-engines: SUCCESS (0.607s)
[704.427191] Starting dynamic subtest: rcs0
[704.961250] Dynamic subtest rcs0: SUCCESS (0.549s)
[704.975821] Starting dynamic subtest: bcs0
[705.505199] Dynamic subtest bcs0: SUCCESS (0.543s)
[705.520547] Starting dynamic subtest: vcs0
[706.049156] Dynamic subtest vcs0: SUCCESS (0.543s)
[706.063024] Starting dynamic subtest: vcs1
[706.592173] Dynamic subtest vcs1: SUCCESS (0.542s)
[706.607322] Starting dynamic subtest: vecs0
[707.134098] Dynamic subtest vecs0: SUCCESS (0.541s)
[707.148098] Starting dynamic subtest: vecs1
[707.677092] Dynamic subtest vecs1: SUCCESS (0.542s)
[707.691070] Starting dynamic subtest: ccs0
[708.220976] Dynamic subtest ccs0: SUCCESS (0.543s)
[708.221931] Subtest write-busy: SUCCESS (4.418s)
[708.491718] [071/133] (325s left) kms_big_fb (y-tiled-8bpp-rotate-0)
[708.693817] Starting subtest: y-tiled-8bpp-rotate-0
[708.695504] Subtest y-tiled-8bpp-rotate-0: SKIP (0.000s)
[708.894578] [072/133] (325s left) kms_cursor_legacy (basic-busy-flip-before-cursor-legacy)
[709.084667] Starting subtest: basic-busy-flip-before-cursor-legacy
[709.086432] Subtest basic-busy-flip-before-cursor-legacy: SKIP (0.000s)
[709.237479] [073/133] (324s left) gem_basic (bad-close)
[709.312993] Starting subtest: bad-close
[709.314642] Subtest bad-close: SUCCESS (0.000s)
[709.524613] [074/133] (324s left) kms_big_fb (linear-16bpp-rotate-0)
[709.717987] Starting subtest: linear-16bpp-rotate-0
[711.541889] Subtest linear-16bpp-rotate-0: SUCCESS (1.823s)
[711.773991] [075/133] (322s left) kms_psr2_sf (pr-overlay-plane-update-continuous-sf)
[711.966582] Subtest pr-overlay-plane-update-continuous-sf: SKIP (0.000s)
[712.020089] [076/133] (322s left) drm_read (short-buffer-wakeup)
[712.275428] Starting subtest: short-buffer-wakeup
[744.490946] Subtest short-buffer-wakeup: SUCCESS (32.213s)
[744.722993] [077/133] (289s left) kms_frontbuffer_tracking (fbcpsr-1p-offscreen-pri-indfb-draw-pwrite)
[744.913958] Starting subtest: fbcpsr-1p-offscreen-pri-indfb-draw-pwrite
[744.915574] Subtest fbcpsr-1p-offscreen-pri-indfb-draw-pwrite: SKIP (0.000s)
[745.108764] [078/133] (289s left) kms_psr (fbc-pr-cursor-render)
[745.291535] Subtest fbc-pr-cursor-render: SKIP (0.000s)
[745.357834] [079/133] (289s left) kms_ccs (crc-primary-suspend-y-tiled-gen12-mc-ccs)
[745.546675] Starting subtest: crc-primary-suspend-y-tiled-gen12-mc-ccs
[745.548989] Starting dynamic subtest: pipe-A-DP-3
[745.552417] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[745.565805] Starting dynamic subtest: pipe-B-DP-3
[745.569216] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[745.582410] Starting dynamic subtest: pipe-C-DP-3
[745.585854] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[745.598960] Starting dynamic subtest: pipe-D-DP-3
[745.602481] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[745.604577] Subtest crc-primary-suspend-y-tiled-gen12-mc-ccs: SKIP (0.007s)
[746.035678] [080/133] (288s left) kms_ccs (random-ccs-data-4-tiled-mtl-mc-ccs)
[746.221754] Starting subtest: random-ccs-data-4-tiled-mtl-mc-ccs
[746.224094] Starting dynamic subtest: pipe-A-DP-3
[746.233209] Dynamic subtest pipe-A-DP-3: SKIP (0.000s)
[746.246642] Starting dynamic subtest: pipe-B-DP-3
[746.255778] Dynamic subtest pipe-B-DP-3: SKIP (0.000s)
[746.268956] Starting dynamic subtest: pipe-C-DP-3
[746.278024] Dynamic subtest pipe-C-DP-3: SKIP (0.000s)
[746.291481] Starting dynamic subtest: pipe-D-DP-3
[746.303040] Dynamic subtest pipe-D-DP-3: SKIP (0.000s)
[746.305077] Subtest random-ccs-data-4-tiled-mtl-mc-ccs: SKIP (0.007s)
[746.713949] [081/133] (288s left) sw_sync (sync_multi_timeline_wait)
[746.761254] Starting subtest: sync_multi_timeline_wait
[746.762582] Subtest sync_multi_timeline_wait: SUCCESS (0.000s)
[746.922678] [082/133] (287s left) sysfs_heartbeat_interval (idempotent)
[747.005319] Starting subtest: idempotent
[747.007523] Starting dynamic subtest: vecs0
[747.008498] Dynamic subtest vecs0: SUCCESS (0.001s)
[747.022535] Starting dynamic subtest: ccs0
[747.023470] Dynamic subtest ccs0: SUCCESS (0.001s)
[747.037436] Starting dynamic subtest: vcs0
[747.038683] Dynamic subtest vcs0: SUCCESS (0.001s)
[747.052542] Starting dynamic subtest: bcs0
[747.053613] Dynamic subtest bcs0: SUCCESS (0.001s)
[747.067249] Starting dynamic subtest: vecs1
[747.068484] Dynamic subtest vecs1: SUCCESS (0.001s)
[747.081969] Starting dynamic subtest: rcs0
[747.083245] Dynamic subtest rcs0: SUCCESS (0.001s)
[747.096788] Starting dynamic subtest: vcs1
[747.098952] Dynamic subtest vcs1: SUCCESS (0.001s)
[747.099961] Subtest idempotent: SUCCESS (0.015s)
[747.147824] [083/133] (287s left) syncobj_eventfd (invalid-bad-pad)
[747.227461] Starting subtest: invalid-bad-pad
[747.228369] Subtest invalid-bad-pad: SUCCESS (0.000s)
[747.434556] [084/133] (287s left) kms_busy (extended-pageflip-hang-newfb)
[747.630348] Starting subtest: extended-pageflip-hang-newfb
[747.631240] Starting dynamic subtest: pipe-A
[755.524565] Dynamic subtest pipe-A: SUCCESS (7.891s)
[755.542803] Starting dynamic subtest: pipe-D
[763.433038] Dynamic subtest pipe-D: SUCCESS (7.904s)
[763.435599] Subtest extended-pageflip-hang-newfb: SUCCESS (15.803s)
[763.750392] [085/133] (271s left) kms_psr2_sf (psr2-cursor-plane-update-sf)
[763.941929] Subtest psr2-cursor-plane-update-sf: SKIP (0.000s)
[763.994735] [086/133] (271s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-0-async-flip)
[764.189267] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-0-async-flip
[764.930988] Subtest x-tiled-max-hw-stride-32bpp-rotate-0-async-flip: SUCCESS (0.742s)
[765.219585] [087/133] (269s left) gem_exec_balancer (busy)
[765.310577] Starting subtest: busy
[766.174517] Subtest busy: SUCCESS (0.864s)
[766.651749] [088/133] (268s left) kms_frontbuffer_tracking (fbc-2p-primscrn-shrfb-msflip-blt)
[766.845015] Starting subtest: fbc-2p-primscrn-shrfb-msflip-blt
[766.846647] Subtest fbc-2p-primscrn-shrfb-msflip-blt: SKIP (0.000s)
[767.052178] [089/133] (268s left) vgem_slow (nohang)
[767.115526] Starting subtest: nohang
[777.407999] Subtest nohang: SUCCESS (10.291s)
[777.529873] [090/133] (257s left) gem_spin_batch (resubmit-new-all)
[777.622392] Starting subtest: resubmit-new-all
[777.623309] Starting dynamic subtest: rcs0
[777.659669] Dynamic subtest rcs0: SUCCESS (0.038s)
[777.674789] Starting dynamic subtest: bcs0
[777.675616] Dynamic subtest bcs0: SUCCESS (0.010s)
[777.689232] Starting dynamic subtest: vcs0
[777.690265] Dynamic subtest vcs0: SUCCESS (0.008s)
[777.703671] Starting dynamic subtest: vcs1
[777.704538] Dynamic subtest vcs1: SUCCESS (0.009s)
[777.718084] Starting dynamic subtest: vecs0
[777.719007] Dynamic subtest vecs0: SUCCESS (0.008s)
[777.732670] Starting dynamic subtest: vecs1
[777.733802] Dynamic subtest vecs1: SUCCESS (0.008s)
[777.747082] Starting dynamic subtest: ccs0
[777.748178] Dynamic subtest ccs0: SUCCESS (0.010s)
[777.749148] Subtest resubmit-new-all: SUCCESS (0.100s)
[778.096746] [091/133] (257s left) gem_render_copy (mixed-tiled-to-y-tiled-ccs)
[778.189515] Starting subtest: mixed-tiled-to-y-tiled-ccs
[778.191680] Subtest mixed-tiled-to-y-tiled-ccs: SKIP (0.000s)
[778.482596] [092/133] (257s left) syncobj_timeline (invalid-signal-illegal-point)
[778.569937] Starting subtest: invalid-signal-illegal-point
[778.570835] Subtest invalid-signal-illegal-point: SUCCESS (0.000s)
[778.735150] [093/133] (256s left) gem_exec_schedule (preempt-contexts)
[778.827848] Starting subtest: preempt-contexts
[778.828772] Starting dynamic subtest: rcs0
[778.929592] Dynamic subtest rcs0: SUCCESS (0.101s)
[778.944946] Starting dynamic subtest: bcs0
[779.004393] Dynamic subtest bcs0: SUCCESS (0.074s)
[779.019548] Starting dynamic subtest: vcs0
[779.078611] Dynamic subtest vcs0: SUCCESS (0.073s)
[779.093574] Starting dynamic subtest: vcs1
[779.152336] Dynamic subtest vcs1: SUCCESS (0.073s)
[779.167592] Starting dynamic subtest: vecs0
[779.225587] Dynamic subtest vecs0: SUCCESS (0.072s)
[779.240785] Starting dynamic subtest: vecs1
[779.298115] Dynamic subtest vecs1: SUCCESS (0.071s)
[779.312991] Starting dynamic subtest: ccs0
[779.372319] Dynamic subtest ccs0: SUCCESS (0.073s)
[779.373118] Subtest preempt-contexts: SUCCESS (0.545s)
[779.966887] [094/133] (255s left) gem_pwrite_snooped
[780.130392] [095/133] (255s left) kms_tiled_display (basic-test-pattern)
[780.396336] Subtest basic-test-pattern: SKIP (0.000s)
[780.463069] [096/133] (255s left) kms_frontbuffer_tracking (psr-shrfb-scaledprimary)
[780.656170] Starting subtest: psr-shrfb-scaledprimary
[780.657834] Subtest psr-shrfb-scaledprimary: SKIP (0.000s)
[780.851996] [097/133] (255s left) kms_frontbuffer_tracking (fbcpsr-1p-shrfb-fliptrack-mmap-gtt)
[781.041946] Starting subtest: fbcpsr-1p-shrfb-fliptrack-mmap-gtt
[781.043494] Subtest fbcpsr-1p-shrfb-fliptrack-mmap-gtt: SKIP (0.000s)
[781.256174] [098/133] (254s left) gem_pwrite (basic-self)
[781.331277] Subtest basic-self: SKIP (0.000s)
[781.418477] [099/133] (254s left) kms_pm_rpm (dpms-mode-unset-non-lpsp)
[782.927803] Starting subtest: dpms-mode-unset-non-lpsp
[784.291172] Subtest dpms-mode-unset-non-lpsp: SUCCESS (1.363s)
[784.779472] [100/133] (251s left) kms_big_fb (yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip)
[784.976426] Starting subtest: yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip
[784.978303] Subtest yf-tiled-max-hw-stride-64bpp-rotate-0-hflip-async-flip: SKIP (0.000s)
[785.175922] [101/133] (251s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-pri-indfb-draw-render)
[785.365193] Starting subtest: fbcpsr-2p-scndscrn-pri-indfb-draw-render
[785.366911] Subtest fbcpsr-2p-scndscrn-pri-indfb-draw-render: SKIP (0.000s)
[785.575941] [102/133] (250s left) kms_color_pipeline (plane-lut1d-ctm3x4-lut1d)
[785.769306] Starting subtest: plane-lut1d-ctm3x4-lut1d
[785.791347] Starting dynamic subtest: pipe-A-DP-3
[786.173097] Dynamic subtest pipe-A-DP-3: SUCCESS (0.383s)
[786.346273] Starting dynamic subtest: pipe-B-DP-3
[786.681997] Dynamic subtest pipe-B-DP-3: SUCCESS (0.348s)
[786.887706] Starting dynamic subtest: pipe-C-DP-3
[787.221945] Dynamic subtest pipe-C-DP-3: SUCCESS (0.348s)
[787.398910] Starting dynamic subtest: pipe-D-DP-3
[787.700921] Dynamic subtest pipe-D-DP-3: SUCCESS (0.315s)
[787.792033] Subtest plane-lut1d-ctm3x4-lut1d: SUCCESS (2.022s)
[788.133646] [103/133] (248s left) kms_frontbuffer_tracking (psr-1p-primscrn-spr-indfb-draw-render)
[788.329155] Starting subtest: psr-1p-primscrn-spr-indfb-draw-render
[788.330803] Subtest psr-1p-primscrn-spr-indfb-draw-render: SKIP (0.000s)
[788.498153] [104/133] (248s left) kms_frontbuffer_tracking (psr-1p-primscrn-cur-indfb-onoff)
[788.692998] Starting subtest: psr-1p-primscrn-cur-indfb-onoff
[788.694737] Subtest psr-1p-primscrn-cur-indfb-onoff: SKIP (0.000s)
[788.901270] [105/133] (247s left) gem_exec_schedule (preempt-queue-contexts-chain)
[788.993239] Subtest preempt-queue-contexts-chain: SKIP (0.000s)
[789.394111] [106/133] (247s left) api_intel_bb (object-noreloc-keep-cache-simple)
[789.469727] Starting subtest: object-noreloc-keep-cache-simple
[789.500886] Subtest object-noreloc-keep-cache-simple: SUCCESS (0.032s)
[789.691669] [107/133] (247s left) gem_mmap (bad-object)
[789.772274] Subtest bad-object: SKIP (0.000s)
[789.838301] [108/133] (246s left) kms_flip_scaled_crc (flip-32bpp-yftileccs-to-64bpp-yftile-upscaling)
[790.022803] Starting subtest: flip-32bpp-yftileccs-to-64bpp-yftile-upscaling
[790.025176] Starting dynamic subtest: pipe-A-valid-mode
[790.101958] Dynamic subtest pipe-A-valid-mode: SKIP (0.076s)
[790.103789] Subtest flip-32bpp-yftileccs-to-64bpp-yftile-upscaling: SKIP (0.078s)
[790.358957] [109/133] (246s left) kms_addfb_basic (bo-too-small-due-to-tiling)
[790.542891] Starting subtest: bo-too-small-due-to-tiling
[790.544432] Subtest bo-too-small-due-to-tiling: SKIP (0.000s)
[790.758971] [110/133] (246s left) kms_psr (pr-sprite-blt)
[790.949370] Subtest pr-sprite-blt: SKIP (0.000s)
[791.017248] [111/133] (246s left) kms_draw_crc (fill-fb)
[791.203397] Starting subtest: fill-fb
[791.721262] Subtest fill-fb: SUCCESS (0.518s)
[791.941688] [112/133] (245s left) perf_pmu (busy-idle)
[792.011421] Starting subtest: busy-idle
[792.012398] Starting dynamic subtest: rcs0
[792.748708] Dynamic subtest rcs0: SUCCESS (0.736s)
[792.768835] Starting dynamic subtest: bcs0
[793.423507] Dynamic subtest bcs0: SUCCESS (0.670s)
[793.470715] Starting dynamic subtest: vcs0
[794.110661] Dynamic subtest vcs0: SUCCESS (0.682s)
[794.132979] Starting dynamic subtest: vcs1
[794.789436] Dynamic subtest vcs1: SUCCESS (0.674s)
[794.813933] Starting dynamic subtest: vecs0
[795.456794] Dynamic subtest vecs0: SUCCESS (0.662s)
[795.480198] Starting dynamic subtest: vecs1
[796.122548] Dynamic subtest vecs1: SUCCESS (0.660s)
[796.144177] Starting dynamic subtest: ccs0
[796.796560] Dynamic subtest ccs0: SUCCESS (0.669s)
[796.802679] Subtest busy-idle: SUCCESS (4.787s)
[797.023979] [113/133] (240s left) kms_ccs (crc-sprite-planes-basic-4-tiled-dg2-mc-ccs)
[797.212305] Starting subtest: crc-sprite-planes-basic-4-tiled-dg2-mc-ccs
[797.213183] Starting dynamic subtest: pipe-A-DP-3
[797.234325] Dynamic subtest pipe-A-DP-3: SKIP (0.002s)
[797.247912] Starting dynamic subtest: pipe-B-DP-3
[797.268878] Dynamic subtest pipe-B-DP-3: SKIP (0.002s)
[797.282486] Starting dynamic subtest: pipe-C-DP-3
[797.315446] Dynamic subtest pipe-C-DP-3: SKIP (0.002s)
[797.329510] Starting dynamic subtest: pipe-D-DP-3
[797.351911] Dynamic subtest pipe-D-DP-3: SKIP (0.002s)
[797.354171] Subtest crc-sprite-planes-basic-4-tiled-dg2-mc-ccs: SKIP (0.015s)
[797.701364] [114/133] (239s left) gem_exec_flush (basic-batch-kernel-default-uc)
[797.791454] Subtest basic-batch-kernel-default-uc: SKIP (0.000s)
[797.904801] [115/133] (239s left) gem_mmap_wc (write-read-distinct)
[797.982265] Subtest write-read-distinct: SKIP (0.000s)
[798.066260] [116/133] (239s left) kms_plane_lowres (tiling-x)
[798.253439] Starting subtest: tiling-x
[798.254315] Starting dynamic subtest: pipe-A-DP-3
[809.299245] Dynamic subtest pipe-A-DP-3: SUCCESS (11.043s)
[809.417551] Starting dynamic subtest: pipe-B-DP-3
[819.848303] Dynamic subtest pipe-B-DP-3: SUCCESS (10.445s)
[819.958954] Starting dynamic subtest: pipe-C-DP-3
[830.339112] Dynamic subtest pipe-C-DP-3: SUCCESS (10.397s)
[830.459381] Starting dynamic subtest: pipe-D-DP-3
[840.941320] Dynamic subtest pipe-D-DP-3: SUCCESS (10.494s)
[841.045842] Subtest tiling-x: SUCCESS (42.795s)
[841.376971] [117/133] (196s left) sw_sync (alloc_merge_fence)
[841.424594] Starting subtest: alloc_merge_fence
[841.425483] Subtest alloc_merge_fence: SUCCESS (0.000s)
[841.590941] [118/133] (196s left) kms_pm_backlight (fade)
[841.777978] Subtest fade: SKIP (0.000s)
[841.839523] [119/133] (195s left) kms_flip_scaled_crc (flip-64bpp-xtile-to-32bpp-xtile-downscaling)
[842.025383] Starting subtest: flip-64bpp-xtile-to-32bpp-xtile-downscaling
[842.026289] Starting dynamic subtest: pipe-A-valid-mode
[844.435772] Dynamic subtest pipe-A-valid-mode: SUCCESS (2.406s)
[844.437211] Subtest flip-64bpp-xtile-to-32bpp-xtile-downscaling: SUCCESS (2.410s)
[844.762340] [120/133] (192s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-signaled)
[844.848535] Starting subtest: multi-wait-all-for-submit-unsubmitted-signaled
[844.950448] Subtest multi-wait-all-for-submit-unsubmitted-signaled: SUCCESS (0.101s)
[845.143484] [121/133] (192s left) kms_psr (psr-cursor-mmap-cpu)
[845.329836] Subtest psr-cursor-mmap-cpu: SKIP (0.000s)
[845.388985] [122/133] (192s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[845.594395] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[846.341681] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.747s)
[846.644996] [123/133] (191s left) gem_exec_whisper (basic-queues-priority-all)
[846.731736] Starting subtest: basic-queues-priority-all
[868.744996] Subtest basic-queues-priority-all: SUCCESS (22.013s)
[869.040062] [124/133] (169s left) syncobj_timeline (etime-single-wait-all-submitted)
[869.116518] Starting subtest: etime-single-wait-all-submitted
[869.223561] Subtest etime-single-wait-all-submitted: SUCCESS (0.105s)
[869.408447] [125/133] (168s left) kms_frontbuffer_tracking (fbc-2p-primscrn-spr-indfb-onoff)
[869.596047] Starting subtest: fbc-2p-primscrn-spr-indfb-onoff
[869.597824] Subtest fbc-2p-primscrn-spr-indfb-onoff: SKIP (0.000s)
[869.794158] [126/133] (168s left) kms_async_flips (async-flip-dpms)
[869.982474] Starting subtest: async-flip-dpms
[870.214221] Starting dynamic subtest: pipe-A-DP-3
[872.921711] Dynamic subtest pipe-A-DP-3: SUCCESS (2.708s)
[873.243796] Starting dynamic subtest: pipe-B-DP-3
[875.322788] Dynamic subtest pipe-B-DP-3: SUCCESS (2.093s)
[875.545280] Starting dynamic subtest: pipe-C-DP-3
[877.631871] Dynamic subtest pipe-C-DP-3: SUCCESS (2.099s)
[877.849457] Starting dynamic subtest: pipe-D-DP-3
[879.928909] Dynamic subtest pipe-D-DP-3: SUCCESS (2.093s)
[879.929752] Subtest async-flip-dpms: SUCCESS (9.949s)
[880.437982] [127/133] (157s left) gem_exec_reloc (basic-cpu-read-noreloc)
[880.523472] Subtest basic-cpu-read-noreloc: SKIP (0.000s)
[880.625086] [128/133] (157s left) syncobj_wait (invalid-reset-illegal-handle)
[880.708757] Starting subtest: invalid-reset-illegal-handle
[880.709645] Subtest invalid-reset-illegal-handle: SUCCESS (0.000s)
[880.904323] [129/133] (157s left) syncobj_wait (multi-wait-all-for-submit-unsubmitted-submitted)
[880.980553] Starting subtest: multi-wait-all-for-submit-unsubmitted-submitted
[881.086491] Subtest multi-wait-all-for-submit-unsubmitted-submitted: SUCCESS (0.105s)
[881.271217] [130/133] (157s left) gem_tiled_swapping (non-threaded)
[881.352384] Subtest non-threaded: SKIP (0.000s)
[881.433595] [131/133] (157s left) gem_exec_fence (syncobj-timeline-chain-engines)
[882.096886] Starting subtest: syncobj-timeline-chain-engines
[882.256401] Subtest syncobj-timeline-chain-engines: SUCCESS (0.159s)
[882.607657] [132/133] (156s left) kms_cursor_legacy (flip-vs-cursor-legacy)
[882.803388] Starting subtest: flip-vs-cursor-legacy
[892.312283] Subtest flip-vs-cursor-legacy: SUCCESS (9.510s)
[892.633067] [133/133] (146s left) syncobj_basic (illegal-fd-to-handle)
[892.718404] Starting subtest: illegal-fd-to-handle
[892.719370] Subtest illegal-fd-to-handle: SUCCESS (0.000s)
[892.912103] Closing watchdogs
results: parsing output: 0/ for test: kms_frontbuffer_tracking
results: parsing output: 1/ for test: gem_exec_suspend
results: parsing output: 2/ for test: gem_render_copy
results: parsing output: 3/ for test: kms_ccs
results: parsing output: 4/ for test: kms_flip
results: parsing output: 5/ for test: syncobj_timeline
results: parsing output: 6/ for test: kms_lease
results: parsing output: 7/ for test: gem_exec_fence
results: parsing output: 8/ for test: kms_chamelium_color
results: parsing output: 9/ for test: prime_mmap
results: parsing output: 10/ for test: i915_drm_fdinfo
results: parsing output: 11/ for test: kms_frontbuffer_tracking
results: parsing output: 12/ for test: kms_invalid_mode
results: parsing output: 13/ for test: kms_plane_scaling
results: parsing output: 14/ for test: drm_read
results: parsing output: 15/ for test: gem_ccs
results: parsing output: 16/ for test: kms_ccs
results: parsing output: 17/ for test: gem_close
results: parsing output: 18/ for test: gem_busy
results: parsing output: 19/ for test: kms_vblank
results: parsing output: 20/ for test: perf_pmu
results: parsing output: 21/ for test: kms_debugfs
results: parsing output: 22/ for test: kms_frontbuffer_tracking
results: parsing output: 23/ for test: gem_ctx_param
results: parsing output: 24/ for test: kms_frontbuffer_tracking
results: parsing output: 25/ for test: gem_exec_big
results: parsing output: 26/ for test: kms_frontbuffer_tracking
results: parsing output: 27/ for test: gem_exec_flush
results: parsing output: 28/ for test: kms_frontbuffer_tracking
results: parsing output: 29/ for test: kms_frontbuffer_tracking
results: parsing output: 30/ for test: gem_exec_create
results: parsing output: 31/ for test: kms_feature_discovery
results: parsing output: 32/ for test: kms_frontbuffer_tracking
results: parsing output: 33/ for test: kms_frontbuffer_tracking
results: parsing output: 34/ for test: gem_render_copy_redux
results: parsing output: 35/ for test: i915_pm_rpm
results: parsing output: 36/ for test: kms_frontbuffer_tracking
results: parsing output: 37/ for test: gem_request_retire
results: parsing output: 38/ for test: i915_pm_rps
results: parsing output: 39/ for test: gem_ctx_persistence
results: parsing output: 40/ for test: i915_hangman
results: parsing output: 41/ for test: kms_cursor_crc
results: parsing output: 42/ for test: gem_partial_pwrite_pread
results: parsing output: 43/ for test: gem_mmap_wc
results: parsing output: 44/ for test: syncobj_timeline
results: parsing output: 45/ for test: kms_frontbuffer_tracking
results: parsing output: 46/ for test: kms_psr
results: parsing output: 47/ for test: kms_invalid_mode
results: parsing output: 48/ for test: gem_exec_reloc
results: parsing output: 49/ for test: gem_mmap_gtt
results: parsing output: 50/ for test: kms_prop_blob
results: parsing output: 51/ for test: api_intel_allocator
results: parsing output: 52/ for test: kms_getfb
results: parsing output: 53/ for test: kms_content_protection
results: parsing output: 54/ for test: kms_chamelium_hpd
results: parsing output: 55/ for test: kms_flip
results: parsing output: 56/ for test: gem_mmap_offset
results: parsing output: 57/ for test: kms_psr
results: parsing output: 58/ for test: gem_fenced_exec_thrash
results: parsing output: 59/ for test: kms_vblank
results: parsing output: 60/ for test: gem_exec_whisper
results: parsing output: 61/ for test: kms_big_fb
results: parsing output: 62/ for test: kms_atomic
results: parsing output: 63/ for test: gen9_exec_parse
results: parsing output: 64/ for test: kms_cursor_crc
results: parsing output: 65/ for test: kms_cursor_crc
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_shared
results: parsing output: 68/ for test: kms_plane_scaling
results: parsing output: 69/ for test: gem_wait
results: parsing output: 70/ for test: kms_big_fb
results: parsing output: 71/ for test: kms_cursor_legacy
results: parsing output: 72/ for test: gem_basic
results: parsing output: 73/ for test: kms_big_fb
results: parsing output: 74/ for test: kms_psr2_sf
results: parsing output: 75/ for test: drm_read
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: kms_psr
results: parsing output: 78/ for test: kms_ccs
results: parsing output: 79/ for test: kms_ccs
results: parsing output: 80/ for test: sw_sync
results: parsing output: 81/ for test: sysfs_heartbeat_interval
results: parsing output: 82/ for test: syncobj_eventfd
results: parsing output: 83/ for test: kms_busy
results: parsing output: 84/ for test: kms_psr2_sf
results: parsing output: 85/ for test: kms_big_fb
results: parsing output: 86/ for test: gem_exec_balancer
results: parsing output: 87/ for test: kms_frontbuffer_tracking
results: parsing output: 88/ for test: vgem_slow
results: parsing output: 89/ for test: gem_spin_batch
results: parsing output: 90/ for test: gem_render_copy
results: parsing output: 91/ for test: syncobj_timeline
results: parsing output: 92/ for test: gem_exec_schedule
results: parsing output: 93/ for test: gem_pwrite_snooped
results: parsing output: 94/ for test: kms_tiled_display
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_frontbuffer_tracking
results: parsing output: 97/ for test: gem_pwrite
results: parsing output: 98/ for test: kms_pm_rpm
results: parsing output: 99/ for test: kms_big_fb
results: parsing output: 100/ for test: kms_frontbuffer_tracking
results: parsing output: 101/ for test: kms_color_pipeline
results: parsing output: 102/ for test: kms_frontbuffer_tracking
results: parsing output: 103/ for test: kms_frontbuffer_tracking
results: parsing output: 104/ for test: gem_exec_schedule
results: parsing output: 105/ for test: api_intel_bb
results: parsing output: 106/ for test: gem_mmap
results: parsing output: 107/ for test: kms_flip_scaled_crc
results: parsing output: 108/ for test: kms_addfb_basic
results: parsing output: 109/ for test: kms_psr
results: parsing output: 110/ for test: kms_draw_crc
results: parsing output: 111/ for test: perf_pmu
results: parsing output: 112/ for test: kms_ccs
results: parsing output: 113/ for test: gem_exec_flush
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_plane_lowres
results: parsing output: 116/ for test: sw_sync
results: parsing output: 117/ for test: kms_pm_backlight
results: parsing output: 118/ for test: kms_flip_scaled_crc
results: parsing output: 119/ for test: syncobj_wait
results: parsing output: 120/ for test: kms_psr
results: parsing output: 121/ for test: kms_big_fb
results: parsing output: 122/ for test: gem_exec_whisper
results: parsing output: 123/ for test: syncobj_timeline
results: parsing output: 124/ for test: kms_frontbuffer_tracking
results: parsing output: 125/ for test: kms_async_flips
results: parsing output: 126/ for test: gem_exec_reloc
results: parsing output: 127/ for test: syncobj_wait
results: parsing output: 128/ for test: syncobj_wait
results: parsing output: 129/ for test: gem_tiled_swapping
results: parsing output: 130/ for test: gem_exec_fence
results: parsing output: 131/ for test: kms_cursor_legacy
results: parsing output: 132/ for test: syncobj_basic
Done.