[56.635119] Initializing watchdogs
[56.635239]   /dev/watchdog0
[56.649766] [FACT before any test] new: hardware.pci.gpu_at_addr.0000:00:02.0: 8086:7d55 Intel Meteorlake (Gen12) Meteor Lake-P [Intel Arc Graphics]
[56.654177] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[56.656436] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[56.659793] [001/132] (960s left) i915_pm_rpm (gem-evict-pwrite)
[58.229584] Starting subtest: gem-evict-pwrite
[58.235024] Subtest gem-evict-pwrite: SKIP (0.000s)
[59.012177] [002/132] (958s left) kms_frontbuffer_tracking (fbc-tiling-y)
[59.107578] Starting subtest: fbc-tiling-y
[59.111911] Subtest fbc-tiling-y: SKIP (0.000s)
[59.224708] [003/132] (958s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[59.315202] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[59.320098] Starting dynamic subtest: A-eDP1
[62.931313] Dynamic subtest A-eDP1: SUCCESS (3.603s)
[62.941479] Starting dynamic subtest: B-eDP1
[66.141223] Dynamic subtest B-eDP1: SUCCESS (3.206s)
[66.149832] Starting dynamic subtest: C-eDP1
[69.252796] Dynamic subtest C-eDP1: SUCCESS (3.109s)
[69.259886] Starting dynamic subtest: D-eDP1
[72.367487] Dynamic subtest D-eDP1: SUCCESS (3.109s)
[72.370046] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.035s)
[73.190350] [004/132] (944s left) gem_pxp (reject-modify-context-protection-off-1)
[73.328351] Starting subtest: reject-modify-context-protection-off-1
[73.330873] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[73.467664] [005/132] (943s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[73.571704] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[73.576205] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[74.716653] [006/132] (942s left) gem_exec_whisper (basic-queues-all)
[74.785156] Starting subtest: basic-queues-all
[85.417741] Subtest basic-queues-all: SUCCESS (10.629s)
[85.622625] [007/132] (931s left) gem_exec_params (rs-invalid)
[85.691636] Starting subtest: rs-invalid
[85.694165] Subtest rs-invalid: SUCCESS (0.003s)
[85.865686] [008/132] (931s left) gem_unfence_active_buffers
[86.057199] [009/132] (931s left) gem_exec_reloc (basic-range-active)
[86.125403] Subtest basic-range-active: SKIP (0.000s)
[86.198069] [010/132] (931s left) api_intel_allocator (reserve-simple)
[86.252489] Starting subtest: reserve-simple
[86.254618] Subtest reserve-simple: SUCCESS (0.004s)
[86.414824] [011/132] (931s left) vgem_basic (dmabuf-fence)
[86.482641] Starting subtest: dmabuf-fence
[86.484936] Subtest dmabuf-fence: SUCCESS (0.001s)
[86.557253] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[86.560192] [012/132] (931s left) gem_ctx_exec (basic-close-race)
[86.626073] Starting subtest: basic-close-race
[92.382276] Subtest basic-close-race: SUCCESS (5.755s)
[92.525636] [013/132] (925s left) gem_exec_await (wide-contexts)
[92.734482] Starting subtest: wide-contexts
[115.764678] Subtest wide-contexts: SUCCESS (23.027s)
[115.980480] [014/132] (901s left) kms_chamelium_audio (dp-audio)
[116.402240] Subtest dp-audio: SKIP (0.000s)
[117.208971] [015/132] (900s left) perf_pmu (init-sema)
[117.256823] Starting subtest: init-sema
[117.259248] Starting dynamic subtest: rcs0
[117.261628] Dynamic subtest rcs0: SUCCESS (0.002s)
[117.274057] Starting dynamic subtest: bcs0
[117.276239] Dynamic subtest bcs0: SUCCESS (0.000s)
[117.288246] Starting dynamic subtest: vcs0
[117.290843] Dynamic subtest vcs0: SUCCESS (0.001s)
[117.300805] Starting dynamic subtest: vcs1
[117.303102] Dynamic subtest vcs1: SUCCESS (0.001s)
[117.311098] Starting dynamic subtest: vecs0
[117.313781] Dynamic subtest vecs0: SUCCESS (0.000s)
[117.321501] Starting dynamic subtest: ccs0
[117.323933] Dynamic subtest ccs0: SUCCESS (0.000s)
[117.326214] Subtest init-sema: SUCCESS (0.006s)
[117.396310] [016/132] (900s left) gem_exec_schedule (u-submit-early-slice)
[117.473670] Starting subtest: u-submit-early-slice
[117.475766] Starting dynamic subtest: rcs0
[117.507676] Dynamic subtest rcs0: SUCCESS (0.042s)
[117.518843] Starting dynamic subtest: bcs0
[117.541635] Dynamic subtest bcs0: SUCCESS (0.034s)
[117.549984] Starting dynamic subtest: vcs0
[117.576309] Dynamic subtest vcs0: SUCCESS (0.034s)
[117.585899] Starting dynamic subtest: vcs1
[117.608273] Dynamic subtest vcs1: SUCCESS (0.032s)
[117.616260] Starting dynamic subtest: vecs0
[117.638836] Dynamic subtest vecs0: SUCCESS (0.030s)
[117.647043] Starting dynamic subtest: ccs0
[117.672518] Dynamic subtest ccs0: SUCCESS (0.033s)
[117.674849] Subtest u-submit-early-slice: SUCCESS (0.208s)
[119.057983] [017/132] (898s left) syncobj_timeline (invalid-transfer-illegal-handle)
[119.119911] Starting subtest: invalid-transfer-illegal-handle
[119.122119] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[119.246129] [018/132] (898s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[119.359183] Starting subtest: fbc-psr-sprite-mmap-gtt
[119.361478] Starting dynamic subtest: eDP-1
[119.365653] Dynamic subtest eDP-1: SKIP (0.000s)
[119.369835] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.001s)
[119.458882] [019/132] (898s left) perf (buffer-fill)
[119.660706] Starting subtest: buffer-fill
[119.663024] Starting dynamic subtest: 0-rcs0
[121.934397] Dynamic subtest 0-rcs0: SUCCESS (2.273s)
[121.942941] Starting dynamic subtest: 1-vecs0
[126.381714] Dynamic subtest 1-vecs0: SUCCESS (4.445s)
[126.384069] Subtest buffer-fill: SUCCESS (6.719s)
[126.427619] [020/132] (891s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[126.544099] Starting subtest: plane-upscale-20x20-with-pixel-format
[126.546491] Starting dynamic subtest: pipe-A
[127.630845] Dynamic subtest pipe-A: SUCCESS (1.088s)
[127.649355] Starting dynamic subtest: pipe-B
[129.740298] Dynamic subtest pipe-B: SUCCESS (2.109s)
[129.748089] Starting dynamic subtest: pipe-C
[130.938957] Dynamic subtest pipe-C: SUCCESS (1.197s)
[130.948676] Starting dynamic subtest: pipe-D
[132.173522] Dynamic subtest pipe-D: SUCCESS (1.234s)
[132.175955] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.632s)
[133.397248] [021/132] (884s left) gem_fence_thrash (bo-write-verify-x)
[133.438495] Starting subtest: bo-write-verify-x
[133.471415] Subtest bo-write-verify-x: SKIP (0.030s)
[133.542946] [022/132] (884s left) kms_plane_alpha_blend (coverage-7efc)
[133.642869] Starting subtest: coverage-7efc
[133.947539] Starting dynamic subtest: pipe-A-eDP-1
[134.549689] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.600s)
[134.575907] Starting dynamic subtest: pipe-D-eDP-1
[135.917560] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.347s)
[135.919886] Subtest coverage-7efc: SUCCESS (2.274s)
[136.779676] [023/132] (881s left) drm_mm (drm_mm)
[136.830279] Starting subtest: drm_mm
[136.850021] Starting dynamic subtest: drm_test_mm_init
[136.998617] Dynamic subtest drm_test_mm_init: SUCCESS (0.147s)
[137.008340] Starting dynamic subtest: drm_test_mm_debug
[137.128578] Dynamic subtest drm_test_mm_debug: SUCCESS (0.129s)
[137.138627] Starting dynamic subtest: drm_test_mm_align32
[137.271456] Dynamic subtest drm_test_mm_align32: SUCCESS (0.143s)
[137.279647] Starting dynamic subtest: drm_test_mm_align64
[137.373589] Dynamic subtest drm_test_mm_align64: SUCCESS (0.103s)
[137.383018] Starting dynamic subtest: drm_test_mm_lowest
[137.509402] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.132s)
[137.517454] Starting dynamic subtest: drm_test_mm_highest
[137.633652] Dynamic subtest drm_test_mm_highest: SUCCESS (0.123s)
[137.635943] Subtest drm_mm: SUCCESS (0.800s)
[137.849380] [024/132] (880s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[137.952585] Starting subtest: psr-rgb565-draw-blt
[145.016888] Subtest psr-rgb565-draw-blt: SUCCESS (7.068s)
[145.186367] [025/132] (872s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[145.273409] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[145.275615] Starting dynamic subtest: pipe-A-eDP-1
[145.297320] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[145.308251] Starting dynamic subtest: pipe-B-eDP-1
[145.329781] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[145.340442] Starting dynamic subtest: pipe-C-eDP-1
[145.362302] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[145.372103] Starting dynamic subtest: pipe-D-eDP-1
[145.393969] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[145.398082] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.004s)
[147.478766] [026/132] (870s left) gem_exec_alignment (pi-isolated)
[147.538023] Starting subtest: pi-isolated
[195.753665] Subtest pi-isolated: SUCCESS (48.210s)
[196.880272] [027/132] (821s left) gem_exec_reloc (basic-softpin)
[196.972126] Subtest basic-softpin: SKIP (0.000s)
[197.054434] [028/132] (821s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[197.170603] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[197.175409] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.001s)
[197.303465] [029/132] (820s left) kms_chamelium_hpd (hdmi-hpd-fast)
[197.687771] Subtest hdmi-hpd-fast: SKIP (0.000s)
[198.456730] [030/132] (819s left) syncobj_timeline (device-submit-unordered)
[198.519803] Starting subtest: device-submit-unordered
[198.522038] Subtest device-submit-unordered: SUCCESS (0.000s)
[198.666873] [031/132] (819s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[198.771118] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[198.775300] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[198.904689] [032/132] (819s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[199.007796] Starting subtest: psr-rgb565-draw-pwrite
[205.937235] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.931s)
[206.073729] [033/132] (812s left) gem_pread (bench)
[206.134205] Subtest bench: SKIP (0.000s)
[206.196926] [034/132] (812s left) sysfs_timeslice_duration (invalid)
[206.262365] Starting subtest: invalid
[206.264763] Starting dynamic subtest: vecs0
[206.267099] Dynamic subtest vecs0: SUCCESS (0.000s)
[206.277084] Starting dynamic subtest: ccs0
[206.279316] Dynamic subtest ccs0: SUCCESS (0.000s)
[206.287694] Starting dynamic subtest: vcs0
[206.289949] Dynamic subtest vcs0: SUCCESS (0.000s)
[206.298080] Starting dynamic subtest: bcs0
[206.300295] Dynamic subtest bcs0: SUCCESS (0.000s)
[206.308575] Starting dynamic subtest: rcs0
[206.310794] Dynamic subtest rcs0: SUCCESS (0.000s)
[206.319631] Starting dynamic subtest: vcs1
[206.321538] Dynamic subtest vcs1: SUCCESS (0.000s)
[206.323849] Subtest invalid: SUCCESS (0.004s)
[206.394782] [035/132] (812s left) sw_sync (sync_merge)
[206.433639] Starting subtest: sync_merge
[206.436159] Subtest sync_merge: SUCCESS (0.000s)
[206.513970] [036/132] (812s left) kms_big_fb (linear-16bpp-rotate-90)
[206.615992] Starting subtest: linear-16bpp-rotate-90
[206.635040] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[206.784208] [037/132] (811s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[206.868052] Starting subtest: stress-mm-invalidate-close-overlap
[209.017782] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[209.177749] [038/132] (809s left) gem_exec_fence (expired-history)
[209.647885] Starting subtest: expired-history
[216.640945] Subtest expired-history: SUCCESS (6.993s)
[218.263153] [039/132] (800s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[218.362061] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[218.366180] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[218.507399] [040/132] (800s left) gem_workarounds (reset)
[218.569931] Starting subtest: reset
[218.757278] Subtest reset: SUCCESS (0.187s)
[218.895660] [041/132] (799s left) gem_exec_params (no-blt)
[218.971105] Starting subtest: no-blt
[218.973472] Subtest no-blt: SUCCESS (0.002s)
[219.111894] [042/132] (799s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[219.224216] Starting subtest: basic-busy-flip-before-cursor-atomic
[219.228058] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[219.396239] [043/132] (799s left) kms_cursor_crc (cursor-onscreen-256x256)
[219.654644] Starting subtest: cursor-onscreen-256x256
[219.656519] Starting dynamic subtest: pipe-A-eDP-1
[221.769654] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.112s)
[221.796367] Starting dynamic subtest: pipe-D-eDP-1
[224.559419] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.768s)
[224.561725] Subtest cursor-onscreen-256x256: SUCCESS (4.906s)
[225.382555] [044/132] (793s left) gem_ctx_persistence (processes)
[225.454696] Starting subtest: processes
[226.936286] Subtest processes: SUCCESS (1.481s)
[227.034711] [045/132] (791s left) kms_pm_rpm (pm-tiling)
[229.073933] Starting subtest: pm-tiling
[229.079148] Subtest pm-tiling: SKIP (0.000s)
[229.471665] [046/132] (789s left) api_intel_bb (simple-bb)
[229.543805] Starting subtest: simple-bb
[229.547319] Subtest simple-bb: SUCCESS (0.006s)
[229.712325] [047/132] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[229.804507] Starting subtest: psr-2p-primscrn-cur-indfb-move
[229.809295] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[229.930495] [048/132] (789s left) gem_exec_nop (basic-parallel)
[230.014597] Starting subtest: basic-parallel
[245.845361] Subtest basic-parallel: SUCCESS (15.834s)
[246.101151] [049/132] (773s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[251.124156] Starting subtest: pr-cursor-plane-update-sf
[251.128493] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[252.005395] [050/132] (767s left) gem_exec_reloc (basic-write-read-active)
[252.073687] Subtest basic-write-read-active: SKIP (0.000s)
[252.155859] [051/132] (767s left) gem_partial_pwrite_pread (write)
[252.234250] Subtest write: SKIP (0.000s)
[252.321345] [052/132] (766s left) gem_wait (await)
[252.390338] Starting subtest: await
[252.392730] Starting dynamic subtest: all-engines
[253.520838] Dynamic subtest all-engines: SUCCESS (1.130s)
[253.537378] Starting dynamic subtest: rcs0
[254.586186] Dynamic subtest rcs0: SUCCESS (1.063s)
[254.603281] Starting dynamic subtest: bcs0
[255.643347] Dynamic subtest bcs0: SUCCESS (1.055s)
[255.659801] Starting dynamic subtest: vcs0
[256.697246] Dynamic subtest vcs0: SUCCESS (1.052s)
[256.713764] Starting dynamic subtest: vcs1
[257.750054] Dynamic subtest vcs1: SUCCESS (1.050s)
[257.766051] Starting dynamic subtest: vecs0
[258.801768] Dynamic subtest vecs0: SUCCESS (1.050s)
[258.817308] Starting dynamic subtest: ccs0
[259.857491] Dynamic subtest ccs0: SUCCESS (1.054s)
[259.860123] Subtest await: SUCCESS (7.468s)
[260.079447] [053/132] (759s left) prime_busy (hang)
[260.138396] Starting subtest: hang
[260.140794] Starting dynamic subtest: rcs0
[273.458046] Dynamic subtest rcs0: SUCCESS (13.315s)
[273.466561] Starting dynamic subtest: bcs0
[280.542886] Dynamic subtest bcs0: SUCCESS (7.084s)
[280.554651] Starting dynamic subtest: vcs0
[287.585751] Dynamic subtest vcs0: SUCCESS (7.041s)
[287.594794] Starting dynamic subtest: vcs1
[294.560532] Dynamic subtest vcs1: SUCCESS (6.971s)
[294.568779] Starting dynamic subtest: vecs0
[301.538206] Dynamic subtest vecs0: SUCCESS (6.976s)
[301.549471] Starting dynamic subtest: ccs0
[315.439910] Dynamic subtest ccs0: SUCCESS (13.902s)
[315.442998] Subtest hang: SUCCESS (55.299s)
[315.598756] [054/132] (703s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[315.703664] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[322.411989] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.711s)
[322.570663] [055/132] (696s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[322.666110] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[322.683870] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.016s)
[322.787381] [056/132] (696s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[322.904569] Starting subtest: 2x-long-cursor-vs-flip-atomic
[322.909158] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[323.074220] [057/132] (696s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[323.176337] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[323.180599] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[323.315864] [058/132] (696s left) kms_rotation_crc (primary-rotation-180)
[323.412528] Starting subtest: primary-rotation-180
[330.465033] Subtest primary-rotation-180: SUCCESS (7.053s)
[331.696531] [059/132] (687s left) gem_lmem_swapping (parallel-random-verify)
[331.742569] Subtest parallel-random-verify: SKIP (0.000s)
[331.792159] [060/132] (687s left) gem_eio (reset-stress)
[332.033316] Starting subtest: reset-stress
[332.035536] Starting dynamic subtest: render
[337.410508] Dynamic subtest render: SUCCESS (5.375s)
[337.425054] Starting dynamic subtest: bsd1
[355.482727] Dynamic subtest bsd1: SUCCESS (18.070s)
[355.498747] Starting dynamic subtest: bsd2
[373.485736] Dynamic subtest bsd2: SUCCESS (18.001s)
[373.500717] Starting dynamic subtest: blt
[373.504698] Dynamic subtest blt: SKIP (0.000s)
[373.513081] Starting dynamic subtest: vebox
[391.460308] Dynamic subtest vebox: SUCCESS (17.973s)
[391.462766] Subtest reset-stress: SUCCESS (59.424s)
[392.976952] [061/132] (626s left) syncobj_basic (bad-destroy)
[393.045417] Starting subtest: bad-destroy
[393.047732] Subtest bad-destroy: SUCCESS (0.000s)
[393.180535] [062/132] (626s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[393.282160] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[393.284381] Starting dynamic subtest: pipe-A-eDP-1
[393.306592] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[393.317979] Starting dynamic subtest: pipe-B-eDP-1
[393.338189] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[393.346801] Starting dynamic subtest: pipe-C-eDP-1
[393.367348] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[393.376390] Starting dynamic subtest: pipe-D-eDP-1
[393.398883] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[393.403343] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[395.538051] [063/132] (624s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[395.645274] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[396.324920] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[396.530495] [064/132] (623s left) gem_softpin (zero)
[396.596281] Starting subtest: zero
[396.603614] Subtest zero: SUCCESS (0.004s)
[396.776599] [065/132] (623s left) kms_addfb_basic (basic-x-tiled-legacy)
[396.837580] Starting subtest: basic-x-tiled-legacy
[396.842143] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[397.010256] [066/132] (622s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[397.119473] Starting subtest: yf-tiled-8bpp-rotate-180
[397.123642] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[397.258310] [067/132] (622s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[397.368326] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[404.232225] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.864s)
[404.397939] [068/132] (615s left) gem_ctx_exec (basic-norecovery)
[404.468636] Starting subtest: basic-norecovery
[404.802836] Subtest basic-norecovery: SUCCESS (0.334s)
[404.957556] [069/132] (614s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[405.061431] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[405.063620] Starting dynamic subtest: pipe-A-default-mode
[405.354710] Dynamic subtest pipe-A-default-mode: SKIP (0.290s)
[405.359458] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.291s)
[406.192138] [070/132] (613s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[406.255894] Starting subtest: single-wait-all-for-submit-signaled
[406.257966] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[406.395364] [071/132] (613s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[406.460595] Starting subtest: etime-multi-wait-all-submitted-signaled
[406.569331] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.108s)
[406.670407] [072/132] (613s left) perf_pmu (interrupts)
[406.714092] Starting subtest: interrupts
[407.815916] Subtest interrupts: SUCCESS (1.102s)
[407.967225] [073/132] (612s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[408.067377] Starting subtest: compare-crc-sanitycheck-xr24
[408.069284] Starting dynamic subtest: pipe-A-eDP-1
[408.697124] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.628s)
[408.708093] Starting dynamic subtest: pipe-B-eDP-1
[409.911696] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.216s)
[409.922418] Starting dynamic subtest: pipe-C-eDP-1
[411.124107] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.209s)
[411.134391] Starting dynamic subtest: pipe-D-eDP-1
[412.328569] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.203s)
[412.330536] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.260s)
[413.210872] [074/132] (606s left) gem_exec_schedule (preempt-queue-contexts)
[413.289874] Subtest preempt-queue-contexts: SKIP (0.000s)
[413.597916] [075/132] (606s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[413.704552] Starting subtest: plane-ctm3x4-lut1d
[413.721256] Starting dynamic subtest: pipe-A-eDP-1
[414.448591] Dynamic subtest pipe-A-eDP-1: FAIL (0.331s)
[415.173438] Starting dynamic subtest: pipe-B-eDP-1
[415.957509] Dynamic subtest pipe-B-eDP-1: FAIL (0.280s)
[416.493120] Starting dynamic subtest: pipe-C-eDP-1
[417.302781] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[417.825104] Starting dynamic subtest: pipe-D-eDP-1
[418.646433] Dynamic subtest pipe-D-eDP-1: FAIL (0.244s)
[418.648762] Subtest plane-ctm3x4-lut1d: FAIL (4.658s)
[419.230416] [076/132] (601s left) kms_chamelium_frames (hdmi-crc-fast)
[419.610393] Subtest hdmi-crc-fast: SKIP (0.000s)
[420.410905] [077/132] (599s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[420.519400] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[420.523392] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[420.663474] [078/132] (599s left) gem_userptr_blits (dmabuf-unsync)
[420.732944] Subtest dmabuf-unsync: SKIP (0.000s)
[420.901129] [079/132] (599s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[421.014863] Starting subtest: x-tiled-64bpp-rotate-90
[421.034720] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[421.175411] [080/132] (599s left) kms_psr (fbc-psr2-primary-blt)
[421.268182] Starting subtest: fbc-psr2-primary-blt
[421.270466] Starting dynamic subtest: eDP-1
[421.274783] Dynamic subtest eDP-1: SKIP (0.000s)
[421.279165] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[421.364473] [081/132] (599s left) kms_properties (plane-properties-legacy)
[421.459147] Starting subtest: plane-properties-legacy
[421.460976] Starting dynamic subtest: pipe-A-eDP-1
[422.032951] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.574s)
[422.047114] Starting dynamic subtest: pipe-B-eDP-1
[423.310985] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.274s)
[423.323239] Starting dynamic subtest: pipe-C-eDP-1
[424.537267] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.227s)
[424.547601] Starting dynamic subtest: pipe-D-eDP-1
[425.776054] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.235s)
[425.778328] Subtest plane-properties-legacy: SUCCESS (4.317s)
[426.596369] [082/132] (593s left) kms_psr (pr-suspend)
[426.692102] Starting subtest: pr-suspend
[426.696652] Subtest pr-suspend: SKIP (0.000s)
[426.791010] [083/132] (593s left) gen9_exec_parse (bb-chained)
[426.861612] Subtest bb-chained: SKIP (0.000s)
[426.949656] [084/132] (593s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[427.048241] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[427.050562] Starting dynamic subtest: pipe-A-eDP-1
[427.072951] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[427.087055] Starting dynamic subtest: pipe-B-eDP-1
[427.108376] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[427.116891] Starting dynamic subtest: pipe-C-eDP-1
[427.138146] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[427.146607] Starting dynamic subtest: pipe-D-eDP-1
[427.168410] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[427.172765] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[429.260724] [085/132] (591s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[429.366224] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[436.472328] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (7.107s)
[436.608287] [086/132] (584s left) i915_hangman (engine-error-state-capture)
[436.684564] Starting subtest: engine-error-state-capture
[436.686783] Starting dynamic subtest: rcs0
[439.859580] Dynamic subtest rcs0: SUCCESS (3.174s)
[439.872506] Starting dynamic subtest: bcs0
[445.875062] Dynamic subtest bcs0: SUCCESS (6.013s)
[445.887070] Starting dynamic subtest: vcs0
[451.828416] Dynamic subtest vcs0: SUCCESS (5.949s)
[451.840667] Starting dynamic subtest: vcs1
[456.818452] Dynamic subtest vcs1: SUCCESS (4.987s)
[456.833258] Starting dynamic subtest: vecs0
[461.874459] Dynamic subtest vecs0: SUCCESS (5.053s)
[461.887784] Starting dynamic subtest: ccs0
[467.890686] Dynamic subtest ccs0: SUCCESS (6.013s)
[467.893408] Subtest engine-error-state-capture: SUCCESS (31.206s)
[468.004949] [087/132] (552s left) gem_mmap_offset (oob-read)
[468.084049] Starting subtest: oob-read
[468.086388] Subtest oob-read: SUCCESS (0.000s)
[468.200680] [088/132] (552s left) kms_vblank (wait-busy)
[468.304874] Starting subtest: wait-busy
[468.307116] Starting dynamic subtest: pipe-A-eDP-1
[470.193297] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.884s)
[470.208091] Starting dynamic subtest: pipe-D-eDP-1
[472.812601] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.618s)
[472.814887] Subtest wait-busy: SUCCESS (4.507s)
[473.640409] [089/132] (547s left) kms_content_protection (uevent-hdcp14)
[473.783994] Starting subtest: uevent-hdcp14
[473.788364] Subtest uevent-hdcp14: SKIP (0.000s)
[473.961987] [090/132] (546s left) syncobj_wait (single-wait-all-for-submit-submitted)
[474.026086] Starting subtest: single-wait-all-for-submit-submitted
[474.136447] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.109s)
[474.235271] [091/132] (546s left) kms_pm_rpm (legacy-planes)
[476.065657] Starting subtest: legacy-planes
[476.068070] Starting dynamic subtest: plane-63
[484.383992] Dynamic subtest plane-63: SUCCESS (8.317s)
[484.395550] Starting dynamic subtest: plane-93
[492.986205] Dynamic subtest plane-93: SUCCESS (8.598s)
[492.998345] Starting dynamic subtest: plane-123
[501.612301] Dynamic subtest plane-123: SUCCESS (8.624s)
[501.624946] Starting dynamic subtest: plane-133
[510.013949] Dynamic subtest plane-133: SUCCESS (8.399s)
[510.016982] Subtest legacy-planes: SUCCESS (33.949s)
[510.421056] [092/132] (510s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[510.531698] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[510.536172] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[510.674446] [093/132] (510s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[510.742607] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[510.746926] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[510.950887] [094/132] (510s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[515.978668] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[515.980647] Starting dynamic subtest: pipe-A-eDP-1
[522.602683] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.623s)
[522.612435] Starting dynamic subtest: pipe-B-eDP-1
[529.269882] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.663s)
[529.272254] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.290s)
[530.151912] [095/132] (490s left) kms_vblank (ts-continuation-modeset)
[530.257526] Starting subtest: ts-continuation-modeset
[530.259586] Starting dynamic subtest: pipe-A-eDP-1
[531.785910] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.528s)
[531.800788] Starting dynamic subtest: pipe-D-eDP-1
[533.955929] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.169s)
[533.958368] Subtest ts-continuation-modeset: SUCCESS (3.700s)
[534.786079] [096/132] (486s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[534.889166] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[534.893460] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[535.022431] [097/132] (486s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[535.128808] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[535.131196] Starting dynamic subtest: A-eDP1
[544.012214] Dynamic subtest A-eDP1: SUCCESS (8.883s)
[544.023358] Starting dynamic subtest: B-eDP1
[552.947061] Dynamic subtest B-eDP1: SUCCESS (8.933s)
[552.958276] Starting dynamic subtest: C-eDP1
[561.855833] Dynamic subtest C-eDP1: SUCCESS (8.907s)
[561.866674] Starting dynamic subtest: D-eDP1
[570.790870] Dynamic subtest D-eDP1: SUCCESS (8.934s)
[570.795976] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.667s)
[572.049595] [098/132] (449s left) kms_sequence (get-forked-busy)
[572.143794] Starting subtest: get-forked-busy
[572.146033] Starting dynamic subtest: pipe-A-eDP-1
[574.084969] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.940s)
[574.095553] Starting dynamic subtest: pipe-B-eDP-1
[576.708773] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.622s)
[576.719836] Starting dynamic subtest: pipe-C-eDP-1
[579.330142] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.623s)
[579.339846] Starting dynamic subtest: pipe-D-eDP-1
[581.976399] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.644s)
[581.978671] Subtest get-forked-busy: SUCCESS (9.834s)
[582.874443] [099/132] (438s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[582.984388] Starting subtest: y-tiled-64bpp-rotate-180
[582.988480] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[583.122912] [100/132] (438s left) sysfs_heartbeat_interval (idempotent)
[583.185604] Starting subtest: idempotent
[583.187931] Starting dynamic subtest: vecs0
[583.190339] Dynamic subtest vecs0: SUCCESS (0.001s)
[583.201595] Starting dynamic subtest: ccs0
[583.203826] Dynamic subtest ccs0: SUCCESS (0.003s)
[583.212598] Starting dynamic subtest: vcs0
[583.214694] Dynamic subtest vcs0: SUCCESS (0.001s)
[583.223531] Starting dynamic subtest: bcs0
[583.225721] Dynamic subtest bcs0: SUCCESS (0.002s)
[583.234342] Starting dynamic subtest: rcs0
[583.236564] Dynamic subtest rcs0: SUCCESS (0.001s)
[583.245789] Starting dynamic subtest: vcs1
[583.247996] Dynamic subtest vcs1: SUCCESS (0.000s)
[583.250157] Subtest idempotent: SUCCESS (0.015s)
[583.355729] [101/132] (437s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[583.460109] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[583.462389] Starting dynamic subtest: pipe-A
[583.523122] Dynamic subtest pipe-A: SUCCESS (0.065s)
[583.534306] Starting dynamic subtest: pipe-B
[584.679904] Dynamic subtest pipe-B: SUCCESS (1.155s)
[584.694773] Starting dynamic subtest: pipe-C
[585.785655] Dynamic subtest pipe-C: SUCCESS (1.103s)
[585.798712] Starting dynamic subtest: pipe-D
[586.916354] Dynamic subtest pipe-D: SUCCESS (1.127s)
[586.918765] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.459s)
[588.105374] [102/132] (433s left) kms_psr (psr-sprite-plane-onoff)
[588.209262] Starting subtest: psr-sprite-plane-onoff
[588.211517] Starting dynamic subtest: eDP-1
[590.031310] Dynamic subtest eDP-1: SUCCESS (1.821s)
[590.033688] Subtest psr-sprite-plane-onoff: SUCCESS (1.823s)
[590.863534] [103/132] (430s left) kms_cursor_edge_walk (256x256-top-edge)
[590.964689] Starting subtest: 256x256-top-edge
[590.966917] Starting dynamic subtest: pipe-A-eDP-1
[594.406831] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.441s)
[594.417412] Starting dynamic subtest: pipe-D-eDP-1
[597.534060] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.126s)
[597.536313] Subtest 256x256-top-edge: SUCCESS (6.569s)
[598.358175] [104/132] (423s left) fbdev (info)
[598.403470] Starting subtest: info
[598.405447] Subtest info: SUCCESS (0.000s)
[598.492932] [105/132] (422s left) kms_atomic (crtc-invalid-params-fence)
[598.599017] Starting subtest: crtc-invalid-params-fence
[598.601345] Starting dynamic subtest: pipe-A-eDP-1
[598.999447] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.400s)
[599.001701] Subtest crtc-invalid-params-fence: SUCCESS (0.402s)
[599.889801] [106/132] (421s left) sw_sync (sync_merge_same)
[599.925421] Starting subtest: sync_merge_same
[599.927730] Subtest sync_merge_same: SUCCESS (0.000s)
[600.007436] [107/132] (421s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[600.120612] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[600.124972] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[600.258785] [108/132] (421s left) kms_plane_multiple (tiling-4)
[600.361779] Starting subtest: tiling-4
[600.364321] Starting dynamic subtest: pipe-A-eDP-1
[604.102891] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.743s)
[604.113580] Starting dynamic subtest: pipe-B-eDP-1
[608.451076] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.347s)
[608.460568] Starting dynamic subtest: pipe-C-eDP-1
[612.800872] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.347s)
[612.812103] Starting dynamic subtest: pipe-D-eDP-1
[617.122365] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.319s)
[617.124748] Subtest tiling-4: SUCCESS (16.761s)
[617.948815] [109/132] (403s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[618.051960] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[618.054198] Starting dynamic subtest: pipe-A-default-mode
[620.785232] Dynamic subtest pipe-A-default-mode: SUCCESS (2.731s)
[620.787158] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.733s)
[621.636474] [110/132] (400s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[621.741261] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[622.387642] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[622.596526] [111/132] (399s left) kms_lease (empty-lease)
[622.696927] Starting subtest: empty-lease
[622.699230] Starting dynamic subtest: pipe-A-eDP-1
[622.701469] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[622.710767] Starting dynamic subtest: pipe-B-eDP-1
[622.712984] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[622.722183] Starting dynamic subtest: pipe-C-eDP-1
[622.724328] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[622.733087] Starting dynamic subtest: pipe-D-eDP-1
[622.735247] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[622.737418] Subtest empty-lease: SUCCESS (0.008s)
[622.834309] [112/132] (398s left) gem_exec_flush (basic-uc-ro-default)
[622.883059] Starting subtest: basic-uc-ro-default
[628.339933] Subtest basic-uc-ro-default: SUCCESS (5.457s)
[628.546918] [113/132] (393s left) gem_softpin (overlap)
[628.606418] Starting subtest: overlap
[629.489092] Subtest overlap: SUCCESS (0.881s)
[629.664015] [114/132] (392s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[629.773203] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[636.566328] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.795s)
[636.745793] [115/132] (385s left) gem_mmap_wc (copy)
[636.813393] Subtest copy: SKIP (0.000s)
[636.880968] [116/132] (384s left) kms_flip (dpms-vs-vblank-race)
[636.981857] Starting subtest: dpms-vs-vblank-race
[636.983774] Starting dynamic subtest: A-eDP1
[640.828169] Dynamic subtest A-eDP1: SUCCESS (3.845s)
[640.838518] Starting dynamic subtest: B-eDP1
[645.424291] Dynamic subtest B-eDP1: SUCCESS (4.595s)
[645.434755] Starting dynamic subtest: C-eDP1
[650.035609] Dynamic subtest C-eDP1: SUCCESS (4.608s)
[650.044977] Starting dynamic subtest: D-eDP1
[654.649294] Dynamic subtest D-eDP1: SUCCESS (4.613s)
[654.651639] Subtest dpms-vs-vblank-race: SUCCESS (17.670s)
[655.551645] [117/132] (366s left) gem_exec_schedule (preempt-queue)
[655.634790] Subtest preempt-queue: SKIP (0.000s)
[655.945460] [118/132] (366s left) i915_query (query-regions-sanity-check)
[655.996984] Starting subtest: query-regions-sanity-check
[656.005273] Subtest query-regions-sanity-check: SUCCESS (0.012s)
[656.199587] [119/132] (365s left) testdisplay
[656.559899] [120/132] (365s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[656.659377] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[656.663542] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[656.798638] [121/132] (365s left) kms_cursor_legacy (single-move)
[656.931192] Starting subtest: single-move
[656.932735] Starting dynamic subtest: pipe-A
[662.313909] Dynamic subtest pipe-A: SUCCESS (5.379s)
[662.323817] Starting dynamic subtest: pipe-B
[667.701718] Dynamic subtest pipe-B: SUCCESS (5.384s)
[667.713717] Starting dynamic subtest: pipe-C
[673.083959] Dynamic subtest pipe-C: SUCCESS (5.380s)
[673.095870] Starting dynamic subtest: pipe-D
[678.466651] Dynamic subtest pipe-D: SUCCESS (5.379s)
[678.479535] Starting dynamic subtest: all-pipes
[683.857940] Dynamic subtest all-pipes: SUCCESS (5.387s)
[683.860344] Subtest single-move: SUCCESS (26.922s)
[684.025269] [122/132] (338s left) gem_exec_capture (capture)
[684.085401] Starting subtest: capture
[684.087735] Starting dynamic subtest: rcs0-smem
[684.919264] Dynamic subtest rcs0-smem: SUCCESS (0.831s)
[684.931215] Starting dynamic subtest: bcs0-smem
[685.736078] Dynamic subtest bcs0-smem: SUCCESS (0.816s)
[685.745057] Starting dynamic subtest: vcs0-smem
[686.562881] Dynamic subtest vcs0-smem: SUCCESS (0.825s)
[686.573626] Starting dynamic subtest: vcs1-smem
[687.885684] Dynamic subtest vcs1-smem: SUCCESS (1.323s)
[687.895731] Starting dynamic subtest: vecs0-smem
[688.770760] Dynamic subtest vecs0-smem: FAIL (0.816s)
[688.782121] Starting dynamic subtest: ccs0-smem
[690.023798] Dynamic subtest ccs0-smem: SUCCESS (1.321s)
[690.026247] Subtest capture: FAIL (5.937s)
[690.178391] [123/132] (332s left) drm_read (fault-buffer)
[690.328872] Starting subtest: fault-buffer
[690.330908] Subtest fault-buffer: SUCCESS (0.000s)
[690.496100] [124/132] (331s left) syncobj_wait (signal)
[690.567708] Starting subtest: signal
[690.569576] Subtest signal: SUCCESS (0.000s)
[690.704223] [125/132] (331s left) kms_cursor_crc (cursor-random-512x512)
[690.982409] Starting subtest: cursor-random-512x512
[690.986157] Subtest cursor-random-512x512: SKIP (0.001s)
[691.161765] [126/132] (331s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[691.263219] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[695.821531] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.562s)
[697.044803] [127/132] (325s left) gem_exec_balancer (bonded-chain)
[697.114919] Starting subtest: bonded-chain
[704.076299] Subtest bonded-chain: SUCCESS (6.962s)
[704.427150] [128/132] (317s left) gem_eio (throttle)
[704.627422] Starting subtest: throttle
[704.909596] Subtest throttle: SUCCESS (0.281s)
[705.050825] [129/132] (317s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[705.109231] Starting subtest: etime-single-wait-for-submit-submitted
[705.216993] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.108s)
[705.332430] [130/132] (317s left) i915_drm_fdinfo (all-busy-idle-check-all)
[705.370652] Starting subtest: all-busy-idle-check-all
[705.374889] Subtest all-busy-idle-check-all: SKIP (0.004s)
[705.479715] [131/132] (317s left) kms_flip (2x-flip-vs-suspend)
[705.588155] Starting subtest: 2x-flip-vs-suspend
[705.601239] Subtest 2x-flip-vs-suspend: SKIP (0.012s)
[705.751490] [132/132] (316s left) kms_psr (fbc-pr-sprite-plane-onoff)
[705.834820] Starting subtest: fbc-pr-sprite-plane-onoff
[705.839094] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[705.928234] Closing watchdogs
results: parsing output: 0/ for test: i915_pm_rpm
results: parsing output: 1/ for test: kms_frontbuffer_tracking
results: parsing output: 2/ for test: kms_flip
results: parsing output: 3/ for test: gem_pxp
results: parsing output: 4/ for test: kms_ccs
results: parsing output: 5/ for test: gem_exec_whisper
results: parsing output: 6/ for test: gem_exec_params
results: parsing output: 7/ for test: gem_unfence_active_buffers
results: parsing output: 8/ for test: gem_exec_reloc
results: parsing output: 9/ for test: api_intel_allocator
results: parsing output: 10/ for test: vgem_basic
results: parsing output: 11/ for test: gem_ctx_exec
results: parsing output: 12/ for test: gem_exec_await
results: parsing output: 13/ for test: kms_chamelium_audio
results: parsing output: 14/ for test: perf_pmu
results: parsing output: 15/ for test: gem_exec_schedule
results: parsing output: 16/ for test: syncobj_timeline
results: parsing output: 17/ for test: kms_psr
results: parsing output: 18/ for test: perf
results: parsing output: 19/ for test: kms_plane_scaling
results: parsing output: 20/ for test: gem_fence_thrash
results: parsing output: 21/ for test: kms_plane_alpha_blend
results: parsing output: 22/ for test: drm_mm
results: parsing output: 23/ for test: kms_frontbuffer_tracking
results: parsing output: 24/ for test: kms_ccs
results: parsing output: 25/ for test: gem_exec_alignment
results: parsing output: 26/ for test: gem_exec_reloc
results: parsing output: 27/ for test: kms_big_fb
results: parsing output: 28/ for test: kms_chamelium_hpd
results: parsing output: 29/ for test: syncobj_timeline
results: parsing output: 30/ for test: kms_frontbuffer_tracking
results: parsing output: 31/ for test: kms_frontbuffer_tracking
results: parsing output: 32/ for test: gem_pread
results: parsing output: 33/ for test: sysfs_timeslice_duration
results: parsing output: 34/ for test: sw_sync
results: parsing output: 35/ for test: kms_big_fb
results: parsing output: 36/ for test: gem_userptr_blits
results: parsing output: 37/ for test: gem_exec_fence
results: parsing output: 38/ for test: kms_frontbuffer_tracking
results: parsing output: 39/ for test: gem_workarounds
results: parsing output: 40/ for test: gem_exec_params
results: parsing output: 41/ for test: kms_cursor_legacy
results: parsing output: 42/ for test: kms_cursor_crc
results: parsing output: 43/ for test: gem_ctx_persistence
results: parsing output: 44/ for test: kms_pm_rpm
results: parsing output: 45/ for test: api_intel_bb
results: parsing output: 46/ for test: kms_frontbuffer_tracking
results: parsing output: 47/ for test: gem_exec_nop
results: parsing output: 48/ for test: kms_psr2_sf
results: parsing output: 49/ for test: gem_exec_reloc
results: parsing output: 50/ for test: gem_partial_pwrite_pread
results: parsing output: 51/ for test: gem_wait
results: parsing output: 52/ for test: prime_busy
results: parsing output: 53/ for test: kms_frontbuffer_tracking
results: parsing output: 54/ for test: kms_flip
results: parsing output: 55/ for test: kms_cursor_legacy
results: parsing output: 56/ for test: kms_frontbuffer_tracking
results: parsing output: 57/ for test: kms_rotation_crc
results: parsing output: 58/ for test: gem_lmem_swapping
results: parsing output: 59/ for test: gem_eio
results: parsing output: 60/ for test: syncobj_basic
results: parsing output: 61/ for test: kms_ccs
results: parsing output: 62/ for test: kms_big_fb
results: parsing output: 63/ for test: gem_softpin
results: parsing output: 64/ for test: kms_addfb_basic
results: parsing output: 65/ for test: kms_big_fb
results: parsing output: 66/ for test: kms_frontbuffer_tracking
results: parsing output: 67/ for test: gem_ctx_exec
results: parsing output: 68/ for test: kms_flip_scaled_crc
results: parsing output: 69/ for test: syncobj_timeline
results: parsing output: 70/ for test: syncobj_timeline
results: parsing output: 71/ for test: perf_pmu
results: parsing output: 72/ for test: kms_pipe_crc_basic
results: parsing output: 73/ for test: gem_exec_schedule
results: parsing output: 74/ for test: kms_color_pipeline
results: parsing output: 75/ for test: kms_chamelium_frames
results: parsing output: 76/ for test: kms_frontbuffer_tracking
results: parsing output: 77/ for test: gem_userptr_blits
results: parsing output: 78/ for test: kms_big_fb
results: parsing output: 79/ for test: kms_psr
results: parsing output: 80/ for test: kms_properties
results: parsing output: 81/ for test: kms_psr
results: parsing output: 82/ for test: gen9_exec_parse
results: parsing output: 83/ for test: kms_ccs
results: parsing output: 84/ for test: kms_frontbuffer_tracking
results: parsing output: 85/ for test: i915_hangman
results: parsing output: 86/ for test: gem_mmap_offset
results: parsing output: 87/ for test: kms_vblank
results: parsing output: 88/ for test: kms_content_protection
results: parsing output: 89/ for test: syncobj_wait
results: parsing output: 90/ for test: kms_pm_rpm
results: parsing output: 91/ for test: kms_frontbuffer_tracking
results: parsing output: 92/ for test: gem_render_copy
results: parsing output: 93/ for test: kms_psr2_sf
results: parsing output: 94/ for test: kms_vblank
results: parsing output: 95/ for test: kms_frontbuffer_tracking
results: parsing output: 96/ for test: kms_flip
results: parsing output: 97/ for test: kms_sequence
results: parsing output: 98/ for test: kms_big_fb
results: parsing output: 99/ for test: sysfs_heartbeat_interval
results: parsing output: 100/ for test: kms_plane_scaling
results: parsing output: 101/ for test: kms_psr
results: parsing output: 102/ for test: kms_cursor_edge_walk
results: parsing output: 103/ for test: fbdev
results: parsing output: 104/ for test: kms_atomic
results: parsing output: 105/ for test: sw_sync
results: parsing output: 106/ for test: kms_frontbuffer_tracking
results: parsing output: 107/ for test: kms_plane_multiple
results: parsing output: 108/ for test: kms_flip_scaled_crc
results: parsing output: 109/ for test: kms_big_fb
results: parsing output: 110/ for test: kms_lease
results: parsing output: 111/ for test: gem_exec_flush
results: parsing output: 112/ for test: gem_softpin
results: parsing output: 113/ for test: kms_frontbuffer_tracking
results: parsing output: 114/ for test: gem_mmap_wc
results: parsing output: 115/ for test: kms_flip
results: parsing output: 116/ for test: gem_exec_schedule
results: parsing output: 117/ for test: i915_query
results: parsing output: 118/ for test: testdisplay
results: parsing output: 119/ for test: kms_frontbuffer_tracking
results: parsing output: 120/ for test: kms_cursor_legacy
results: parsing output: 121/ for test: gem_exec_capture
results: parsing output: 122/ for test: drm_read
results: parsing output: 123/ for test: syncobj_wait
results: parsing output: 124/ for test: kms_cursor_crc
results: parsing output: 125/ for test: kms_frontbuffer_tracking
results: parsing output: 126/ for test: gem_exec_balancer
results: parsing output: 127/ for test: gem_eio
results: parsing output: 128/ for test: syncobj_timeline
results: parsing output: 129/ for test: i915_drm_fdinfo
results: parsing output: 130/ for test: kms_flip
results: parsing output: 131/ for test: kms_psr
Done.