[63.902596] Initializing watchdogs
[63.902701]   /dev/watchdog0
[63.916879] [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]
[63.921028] [FACT before any test] new: hardware.pci.drm_card_at_addr.0000:00:02.0: card0
[63.923204] [FACT before any test] new: kernel.kmod_is_loaded.i915: true
[63.926331] [001/132] (960s left) i915_pm_rpm (gem-evict-pwrite)
[66.092396] Starting subtest: gem-evict-pwrite
[66.098052] Subtest gem-evict-pwrite: SKIP (0.000s)
[66.483281] [002/132] (957s left) kms_frontbuffer_tracking (fbc-tiling-y)
[66.578243] Starting subtest: fbc-tiling-y
[66.582283] Subtest fbc-tiling-y: SKIP (0.000s)
[66.714797] [003/132] (957s left) kms_flip (single-buffer-flip-vs-dpms-off-vs-modeset)
[66.840897] Starting subtest: single-buffer-flip-vs-dpms-off-vs-modeset
[66.843315] Starting dynamic subtest: A-eDP1
[70.481513] Dynamic subtest A-eDP1: SUCCESS (3.639s)
[70.494174] Starting dynamic subtest: B-eDP1
[73.676380] Dynamic subtest B-eDP1: SUCCESS (3.194s)
[73.683522] Starting dynamic subtest: C-eDP1
[76.768785] Dynamic subtest C-eDP1: SUCCESS (3.093s)
[76.777879] Starting dynamic subtest: D-eDP1
[79.894490] Dynamic subtest D-eDP1: SUCCESS (3.127s)
[79.896832] Subtest single-buffer-flip-vs-dpms-off-vs-modeset: SUCCESS (13.058s)
[80.709732] [004/132] (943s left) gem_pxp (reject-modify-context-protection-off-1)
[80.841252] Starting subtest: reject-modify-context-protection-off-1
[80.843518] Subtest reject-modify-context-protection-off-1: SUCCESS (0.002s)
[80.981475] [005/132] (943s left) kms_ccs (crc-primary-suspend-4-tiled-bmg-ccs)
[81.070273] Starting subtest: crc-primary-suspend-4-tiled-bmg-ccs
[81.074864] Subtest crc-primary-suspend-4-tiled-bmg-ccs: SKIP (0.000s)
[82.242268] [006/132] (942s left) gem_exec_whisper (basic-queues-all)
[82.312087] Starting subtest: basic-queues-all
[92.894578] Subtest basic-queues-all: SUCCESS (10.580s)
[93.095653] [007/132] (931s left) gem_exec_params (rs-invalid)
[93.168984] Starting subtest: rs-invalid
[93.171288] Subtest rs-invalid: SUCCESS (0.003s)
[93.325232] [008/132] (931s left) gem_unfence_active_buffers
[93.517502] [009/132] (931s left) gem_exec_reloc (basic-range-active)
[93.585553] Subtest basic-range-active: SKIP (0.000s)
[93.678107] [010/132] (931s left) api_intel_allocator (reserve-simple)
[93.742958] Starting subtest: reserve-simple
[93.747424] Subtest reserve-simple: SUCCESS (0.005s)
[93.915916] [011/132] (930s left) vgem_basic (dmabuf-fence)
[93.988080] Starting subtest: dmabuf-fence
[93.990365] Subtest dmabuf-fence: SUCCESS (0.001s)
[94.075055] [FACT vgem_basic (dmabuf-fence)] new: kernel.kmod_is_loaded.vgem: true
[94.077669] [012/132] (930s left) gem_ctx_exec (basic-close-race)
[94.134620] Starting subtest: basic-close-race
[99.855027] Subtest basic-close-race: SUCCESS (5.718s)
[100.027696] [013/132] (924s left) gem_exec_await (wide-contexts)
[100.240132] Starting subtest: wide-contexts
[123.807781] Subtest wide-contexts: SUCCESS (23.567s)
[124.016074] [014/132] (900s left) kms_chamelium_audio (dp-audio)
[124.476837] Subtest dp-audio: SKIP (0.000s)
[125.246597] [015/132] (899s left) perf_pmu (init-sema)
[125.292100] Starting subtest: init-sema
[125.294339] Starting dynamic subtest: rcs0
[125.296681] Dynamic subtest rcs0: SUCCESS (0.002s)
[125.306189] Starting dynamic subtest: bcs0
[125.308063] Dynamic subtest bcs0: SUCCESS (0.000s)
[125.315482] Starting dynamic subtest: vcs0
[125.317430] Dynamic subtest vcs0: SUCCESS (0.001s)
[125.324838] Starting dynamic subtest: vcs1
[125.326840] Dynamic subtest vcs1: SUCCESS (0.001s)
[125.334089] Starting dynamic subtest: vecs0
[125.336085] Dynamic subtest vecs0: SUCCESS (0.001s)
[125.343535] Starting dynamic subtest: ccs0
[125.345533] Dynamic subtest ccs0: SUCCESS (0.000s)
[125.347496] Subtest init-sema: SUCCESS (0.006s)
[125.440598] [016/132] (899s left) gem_exec_schedule (u-submit-early-slice)
[125.530650] Starting subtest: u-submit-early-slice
[125.532945] Starting dynamic subtest: rcs0
[125.565512] Dynamic subtest rcs0: SUCCESS (0.044s)
[125.576390] Starting dynamic subtest: bcs0
[125.599598] Dynamic subtest bcs0: SUCCESS (0.034s)
[125.608646] Starting dynamic subtest: vcs0
[125.633530] Dynamic subtest vcs0: SUCCESS (0.034s)
[125.642286] Starting dynamic subtest: vcs1
[125.664462] Dynamic subtest vcs1: SUCCESS (0.031s)
[125.672958] Starting dynamic subtest: vecs0
[125.691932] Dynamic subtest vecs0: SUCCESS (0.027s)
[125.703132] Starting dynamic subtest: ccs0
[125.725443] Dynamic subtest ccs0: SUCCESS (0.033s)
[125.727641] Subtest u-submit-early-slice: SUCCESS (0.204s)
[127.057108] [017/132] (897s left) syncobj_timeline (invalid-transfer-illegal-handle)
[127.120094] Starting subtest: invalid-transfer-illegal-handle
[127.122441] Subtest invalid-transfer-illegal-handle: SUCCESS (0.000s)
[127.233886] [018/132] (897s left) kms_psr (fbc-psr-sprite-mmap-gtt)
[127.322346] Starting subtest: fbc-psr-sprite-mmap-gtt
[127.324635] Starting dynamic subtest: eDP-1
[127.328726] Dynamic subtest eDP-1: SKIP (0.000s)
[127.332876] Subtest fbc-psr-sprite-mmap-gtt: SKIP (0.000s)
[127.420180] [019/132] (897s left) perf (buffer-fill)
[127.578890] Starting subtest: buffer-fill
[127.581205] Starting dynamic subtest: 0-rcs0
[129.824951] Dynamic subtest 0-rcs0: SUCCESS (2.244s)
[129.833922] Starting dynamic subtest: 1-vcs0
[134.231331] Dynamic subtest 1-vcs0: SUCCESS (4.405s)
[134.233929] Subtest buffer-fill: SUCCESS (6.650s)
[134.277890] [020/132] (890s left) kms_plane_scaling (plane-upscale-20x20-with-pixel-format)
[134.382084] Starting subtest: plane-upscale-20x20-with-pixel-format
[134.384452] Starting dynamic subtest: pipe-A
[135.429483] Dynamic subtest pipe-A: SUCCESS (1.050s)
[135.437088] Starting dynamic subtest: pipe-B
[137.581904] Dynamic subtest pipe-B: SUCCESS (2.152s)
[137.594092] Starting dynamic subtest: pipe-C
[138.762502] Dynamic subtest pipe-C: SUCCESS (1.179s)
[138.772746] Starting dynamic subtest: pipe-D
[139.909814] Dynamic subtest pipe-D: SUCCESS (1.147s)
[139.912196] Subtest plane-upscale-20x20-with-pixel-format: SUCCESS (5.530s)
[141.126527] [021/132] (884s left) gem_fence_thrash (bo-write-verify-x)
[141.159303] Starting subtest: bo-write-verify-x
[141.187842] Subtest bo-write-verify-x: SKIP (0.026s)
[141.249476] [022/132] (883s left) kms_plane_alpha_blend (coverage-7efc)
[141.336504] Starting subtest: coverage-7efc
[141.620419] Starting dynamic subtest: pipe-A-eDP-1
[142.217789] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.595s)
[142.246305] Starting dynamic subtest: pipe-D-eDP-1
[143.520961] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.284s)
[143.523522] Subtest coverage-7efc: SUCCESS (2.184s)
[144.373345] [023/132] (880s left) drm_mm (drm_mm)
[144.410926] Starting subtest: drm_mm
[144.433477] Starting dynamic subtest: drm_test_mm_init
[144.549780] Dynamic subtest drm_test_mm_init: SUCCESS (0.117s)
[144.559875] Starting dynamic subtest: drm_test_mm_debug
[144.664726] Dynamic subtest drm_test_mm_debug: SUCCESS (0.113s)
[144.674684] Starting dynamic subtest: drm_test_mm_align32
[144.772490] Dynamic subtest drm_test_mm_align32: SUCCESS (0.109s)
[144.779972] Starting dynamic subtest: drm_test_mm_align64
[144.889573] Dynamic subtest drm_test_mm_align64: SUCCESS (0.116s)
[144.898897] Starting dynamic subtest: drm_test_mm_lowest
[145.011227] Dynamic subtest drm_test_mm_lowest: SUCCESS (0.122s)
[145.018741] Starting dynamic subtest: drm_test_mm_highest
[145.129185] Dynamic subtest drm_test_mm_highest: SUCCESS (0.115s)
[145.131048] Subtest drm_mm: SUCCESS (0.716s)
[145.320635] [024/132] (879s left) kms_frontbuffer_tracking (psr-rgb565-draw-blt)
[145.419081] Starting subtest: psr-rgb565-draw-blt
[152.478455] Subtest psr-rgb565-draw-blt: SUCCESS (7.063s)
[152.636257] [025/132] (872s left) kms_ccs (missing-ccs-buffer-y-tiled-gen12-mc-ccs)
[152.735070] Starting subtest: missing-ccs-buffer-y-tiled-gen12-mc-ccs
[152.737392] Starting dynamic subtest: pipe-A-eDP-1
[152.760302] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[152.770433] Starting dynamic subtest: pipe-B-eDP-1
[152.791833] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[152.800439] Starting dynamic subtest: pipe-C-eDP-1
[152.823050] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[152.833774] Starting dynamic subtest: pipe-D-eDP-1
[152.854690] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[152.858846] Subtest missing-ccs-buffer-y-tiled-gen12-mc-ccs: SKIP (0.003s)
[155.066385] [026/132] (870s left) gem_exec_alignment (pi-isolated)
[155.124247] Starting subtest: pi-isolated
[203.742960] Subtest pi-isolated: SUCCESS (48.617s)
[204.912096] [027/132] (820s left) gem_exec_reloc (basic-softpin)
[205.012612] Subtest basic-softpin: SKIP (0.000s)
[205.091509] [028/132] (820s left) kms_big_fb (y-tiled-max-hw-stride-64bpp-rotate-0-hflip)
[205.201392] Starting subtest: y-tiled-max-hw-stride-64bpp-rotate-0-hflip
[205.206016] Subtest y-tiled-max-hw-stride-64bpp-rotate-0-hflip: SKIP (0.002s)
[205.332683] [029/132] (820s left) kms_chamelium_hpd (hdmi-hpd-fast)
[205.723361] Subtest hdmi-hpd-fast: SKIP (0.000s)
[206.559456] [030/132] (818s left) syncobj_timeline (device-submit-unordered)
[206.621714] Starting subtest: device-submit-unordered
[206.624085] Subtest device-submit-unordered: SUCCESS (0.001s)
[206.761810] [031/132] (818s left) kms_frontbuffer_tracking (fbc-2p-primscrn-cur-indfb-draw-render)
[206.859683] Starting subtest: fbc-2p-primscrn-cur-indfb-draw-render
[206.863752] Subtest fbc-2p-primscrn-cur-indfb-draw-render: SKIP (0.000s)
[206.966513] [032/132] (818s left) kms_frontbuffer_tracking (psr-rgb565-draw-pwrite)
[207.068040] Starting subtest: psr-rgb565-draw-pwrite
[214.015665] Subtest psr-rgb565-draw-pwrite: SUCCESS (6.950s)
[214.172549] [033/132] (811s left) gem_pread (bench)
[214.235725] Subtest bench: SKIP (0.000s)
[214.332430] [034/132] (811s left) sysfs_timeslice_duration (invalid)
[214.393624] Starting subtest: invalid
[214.396140] Starting dynamic subtest: vecs0
[214.398592] Dynamic subtest vecs0: SUCCESS (0.000s)
[214.412504] Starting dynamic subtest: ccs0
[214.414606] Dynamic subtest ccs0: SUCCESS (0.000s)
[214.424802] Starting dynamic subtest: vcs0
[214.426805] Dynamic subtest vcs0: SUCCESS (0.000s)
[214.434553] Starting dynamic subtest: bcs0
[214.437038] Dynamic subtest bcs0: SUCCESS (0.000s)
[214.444134] Starting dynamic subtest: rcs0
[214.446049] Dynamic subtest rcs0: SUCCESS (0.000s)
[214.453941] Starting dynamic subtest: vcs1
[214.456256] Dynamic subtest vcs1: SUCCESS (0.000s)
[214.458493] Subtest invalid: SUCCESS (0.004s)
[214.527191] [035/132] (811s left) sw_sync (sync_merge)
[214.560909] Starting subtest: sync_merge
[214.563236] Subtest sync_merge: SUCCESS (0.000s)
[214.641139] [036/132] (811s left) kms_big_fb (linear-16bpp-rotate-90)
[214.736228] Starting subtest: linear-16bpp-rotate-90
[214.755321] Subtest linear-16bpp-rotate-90: SKIP (0.018s)
[214.904548] [037/132] (810s left) gem_userptr_blits (stress-mm-invalidate-close-overlap)
[214.988562] Starting subtest: stress-mm-invalidate-close-overlap
[217.137927] Subtest stress-mm-invalidate-close-overlap: SUCCESS (2.148s)
[217.306286] [038/132] (808s left) gem_exec_fence (expired-history)
[217.780726] Starting subtest: expired-history
[224.680627] Subtest expired-history: SUCCESS (6.902s)
[225.194242] [039/132] (800s left) kms_frontbuffer_tracking (fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt)
[225.299227] Starting subtest: fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt
[225.303262] Subtest fbc-1p-offscreen-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[225.428309] [040/132] (800s left) gem_workarounds (reset)
[225.499144] Starting subtest: reset
[225.683072] Subtest reset: SUCCESS (0.183s)
[225.840753] [041/132] (800s left) gem_exec_params (no-blt)
[225.904586] Starting subtest: no-blt
[225.910362] Subtest no-blt: SUCCESS (0.003s)
[226.065287] [042/132] (799s left) kms_cursor_legacy (basic-busy-flip-before-cursor-atomic)
[226.181249] Starting subtest: basic-busy-flip-before-cursor-atomic
[226.184959] Subtest basic-busy-flip-before-cursor-atomic: SKIP (0.000s)
[226.347747] [043/132] (799s left) kms_cursor_crc (cursor-onscreen-256x256)
[226.582271] Starting subtest: cursor-onscreen-256x256
[226.586367] Starting dynamic subtest: pipe-A-eDP-1
[228.705714] Dynamic subtest pipe-A-eDP-1: SUCCESS (2.117s)
[228.740218] Starting dynamic subtest: pipe-D-eDP-1
[231.464564] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.738s)
[231.466974] Subtest cursor-onscreen-256x256: SUCCESS (4.880s)
[232.291323] [044/132] (793s left) gem_ctx_persistence (processes)
[232.350975] Starting subtest: processes
[233.891954] Subtest processes: SUCCESS (1.541s)
[233.998132] [045/132] (792s left) kms_pm_rpm (pm-tiling)
[236.028454] Starting subtest: pm-tiling
[236.033339] Subtest pm-tiling: SKIP (0.000s)
[236.435145] [046/132] (789s left) api_intel_bb (simple-bb)
[236.493360] Starting subtest: simple-bb
[236.495712] Subtest simple-bb: SUCCESS (0.006s)
[236.660842] [047/132] (789s left) kms_frontbuffer_tracking (psr-2p-primscrn-cur-indfb-move)
[236.759265] Starting subtest: psr-2p-primscrn-cur-indfb-move
[236.763689] Subtest psr-2p-primscrn-cur-indfb-move: SKIP (0.000s)
[236.867379] [048/132] (789s left) gem_exec_nop (basic-parallel)
[236.941970] Starting subtest: basic-parallel
[252.886891] Subtest basic-parallel: SUCCESS (15.954s)
[253.158507] [049/132] (773s left) kms_psr2_sf (pr-cursor-plane-update-sf)
[258.187790] Starting subtest: pr-cursor-plane-update-sf
[258.192669] Subtest pr-cursor-plane-update-sf: SKIP (0.002s)
[259.054244] [050/132] (767s left) gem_exec_reloc (basic-write-read-active)
[259.116300] Subtest basic-write-read-active: SKIP (0.000s)
[259.202250] [051/132] (767s left) gem_partial_pwrite_pread (write)
[259.268187] Subtest write: SKIP (0.000s)
[259.363148] [052/132] (767s left) gem_wait (await)
[259.428298] Starting subtest: await
[259.430201] Starting dynamic subtest: all-engines
[260.566413] Dynamic subtest all-engines: SUCCESS (1.141s)
[260.583642] Starting dynamic subtest: rcs0
[261.630382] Dynamic subtest rcs0: SUCCESS (1.061s)
[261.646698] Starting dynamic subtest: bcs0
[262.687272] Dynamic subtest bcs0: SUCCESS (1.055s)
[262.704078] Starting dynamic subtest: vcs0
[263.744265] Dynamic subtest vcs0: SUCCESS (1.054s)
[263.761072] Starting dynamic subtest: vcs1
[264.797207] Dynamic subtest vcs1: SUCCESS (1.051s)
[264.813025] Starting dynamic subtest: vecs0
[265.850228] Dynamic subtest vecs0: SUCCESS (1.051s)
[265.866071] Starting dynamic subtest: ccs0
[266.908252] Dynamic subtest ccs0: SUCCESS (1.056s)
[266.910736] Subtest await: SUCCESS (7.484s)
[267.131375] [053/132] (759s left) prime_busy (hang)
[267.185168] Starting subtest: hang
[267.187260] Starting dynamic subtest: rcs0
[293.425331] Dynamic subtest rcs0: SUCCESS (26.238s)
[293.435724] Starting dynamic subtest: bcs0
[300.578065] Dynamic subtest bcs0: SUCCESS (7.152s)
[300.588680] Starting dynamic subtest: vcs0
[307.552803] Dynamic subtest vcs0: SUCCESS (6.974s)
[307.561612] Starting dynamic subtest: vcs1
[314.595201] Dynamic subtest vcs1: SUCCESS (7.042s)
[314.603291] Starting dynamic subtest: vecs0
[321.567565] Dynamic subtest vecs0: SUCCESS (6.971s)
[321.576063] Starting dynamic subtest: ccs0
[335.403071] Dynamic subtest ccs0: SUCCESS (13.834s)
[335.405545] Subtest hang: SUCCESS (68.219s)
[335.569177] [054/132] (690s left) kms_frontbuffer_tracking (fbcpsr-rgb101010-draw-mmap-wc)
[335.672435] Starting subtest: fbcpsr-rgb101010-draw-mmap-wc
[342.351366] Subtest fbcpsr-rgb101010-draw-mmap-wc: SUCCESS (6.680s)
[342.504340] [055/132] (684s left) kms_flip (2x-flip-vs-dpms-off-vs-modeset-interruptible)
[342.618079] Starting subtest: 2x-flip-vs-dpms-off-vs-modeset-interruptible
[342.629420] Subtest 2x-flip-vs-dpms-off-vs-modeset-interruptible: SKIP (0.010s)
[342.729653] [056/132] (683s left) kms_cursor_legacy (2x-long-cursor-vs-flip-atomic)
[342.854266] Starting subtest: 2x-long-cursor-vs-flip-atomic
[342.858548] Subtest 2x-long-cursor-vs-flip-atomic: SKIP (0.001s)
[343.022048] [057/132] (683s left) kms_frontbuffer_tracking (psr-2p-scndscrn-cur-indfb-draw-pwrite)
[343.126153] Starting subtest: psr-2p-scndscrn-cur-indfb-draw-pwrite
[343.130345] Subtest psr-2p-scndscrn-cur-indfb-draw-pwrite: SKIP (0.000s)
[343.268509] [058/132] (683s left) kms_rotation_crc (primary-rotation-180)
[343.373286] Starting subtest: primary-rotation-180
[350.374027] Subtest primary-rotation-180: SUCCESS (7.002s)
[351.652898] [059/132] (675s left) gem_lmem_swapping (parallel-random-verify)
[351.699088] Subtest parallel-random-verify: SKIP (0.000s)
[351.746142] [060/132] (675s left) gem_eio (reset-stress)
[351.975730] Starting subtest: reset-stress
[351.978061] Starting dynamic subtest: render
[357.289837] Dynamic subtest render: SUCCESS (5.311s)
[357.306426] Starting dynamic subtest: bsd1
[375.517700] Dynamic subtest bsd1: SUCCESS (18.227s)
[375.530923] Starting dynamic subtest: bsd2
[393.493535] Dynamic subtest bsd2: SUCCESS (17.975s)
[393.508712] Starting dynamic subtest: blt
[393.512723] Dynamic subtest blt: SKIP (0.000s)
[393.521052] Starting dynamic subtest: vebox
[411.451033] Dynamic subtest vebox: SUCCESS (17.955s)
[411.453462] Subtest reset-stress: SUCCESS (59.472s)
[412.947411] [061/132] (613s left) syncobj_basic (bad-destroy)
[413.021642] Starting subtest: bad-destroy
[413.023611] Subtest bad-destroy: SUCCESS (0.000s)
[413.132563] [062/132] (613s left) kms_ccs (bad-rotation-90-4-tiled-dg2-rc-ccs-cc)
[413.235171] Starting subtest: bad-rotation-90-4-tiled-dg2-rc-ccs-cc
[413.237439] Starting dynamic subtest: pipe-A-eDP-1
[413.261424] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[413.273412] Starting dynamic subtest: pipe-B-eDP-1
[413.295440] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[413.303911] Starting dynamic subtest: pipe-C-eDP-1
[413.325775] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[413.334225] Starting dynamic subtest: pipe-D-eDP-1
[413.356443] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[413.360524] Subtest bad-rotation-90-4-tiled-dg2-rc-ccs-cc: SKIP (0.005s)
[415.508066] [063/132] (611s left) kms_big_fb (x-tiled-max-hw-stride-32bpp-rotate-180-async-flip)
[415.605899] Starting subtest: x-tiled-max-hw-stride-32bpp-rotate-180-async-flip
[416.285487] Subtest x-tiled-max-hw-stride-32bpp-rotate-180-async-flip: SUCCESS (0.681s)
[416.462961] [064/132] (610s left) gem_softpin (zero)
[416.527435] Starting subtest: zero
[416.534500] Subtest zero: SUCCESS (0.005s)
[416.688529] [065/132] (610s left) kms_addfb_basic (basic-x-tiled-legacy)
[416.762457] Starting subtest: basic-x-tiled-legacy
[416.766972] Subtest basic-x-tiled-legacy: SKIP (0.000s)
[416.933310] [066/132] (610s left) kms_big_fb (yf-tiled-8bpp-rotate-180)
[417.047516] Starting subtest: yf-tiled-8bpp-rotate-180
[417.052166] Subtest yf-tiled-8bpp-rotate-180: SKIP (0.000s)
[417.179077] [067/132] (609s left) kms_frontbuffer_tracking (psr-1p-offscreen-pri-shrfb-draw-render)
[417.286543] Starting subtest: psr-1p-offscreen-pri-shrfb-draw-render
[424.075031] Subtest psr-1p-offscreen-pri-shrfb-draw-render: SUCCESS (6.789s)
[424.241265] [068/132] (602s left) gem_ctx_exec (basic-norecovery)
[424.315162] Starting subtest: basic-norecovery
[424.667857] Subtest basic-norecovery: SUCCESS (0.352s)
[424.832170] [069/132] (602s left) kms_flip_scaled_crc (flip-32bpp-yftile-to-32bpp-yftileccs-downscaling)
[424.932148] Starting subtest: flip-32bpp-yftile-to-32bpp-yftileccs-downscaling
[424.934452] Starting dynamic subtest: pipe-A-default-mode
[425.236049] Dynamic subtest pipe-A-default-mode: SKIP (0.301s)
[425.240746] Subtest flip-32bpp-yftile-to-32bpp-yftileccs-downscaling: SKIP (0.302s)
[426.073688] [070/132] (601s left) syncobj_timeline (single-wait-all-for-submit-signaled)
[426.129970] Starting subtest: single-wait-all-for-submit-signaled
[426.132200] Subtest single-wait-all-for-submit-signaled: SUCCESS (0.000s)
[426.268681] [071/132] (600s left) syncobj_timeline (etime-multi-wait-all-submitted-signaled)
[426.321486] Starting subtest: etime-multi-wait-all-submitted-signaled
[426.425251] Subtest etime-multi-wait-all-submitted-signaled: SUCCESS (0.104s)
[426.528386] [072/132] (600s left) perf_pmu (interrupts)
[426.578757] Starting subtest: interrupts
[427.665106] Subtest interrupts: SUCCESS (1.086s)
[427.807262] [073/132] (599s left) kms_pipe_crc_basic (compare-crc-sanitycheck-xr24)
[427.914467] Starting subtest: compare-crc-sanitycheck-xr24
[427.916777] Starting dynamic subtest: pipe-A-eDP-1
[428.524805] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.611s)
[428.536527] Starting dynamic subtest: pipe-B-eDP-1
[429.788188] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.263s)
[429.798192] Starting dynamic subtest: pipe-C-eDP-1
[430.986273] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.194s)
[430.995854] Starting dynamic subtest: pipe-D-eDP-1
[432.193350] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.206s)
[432.195764] Subtest compare-crc-sanitycheck-xr24: SUCCESS (4.280s)
[433.084147] [074/132] (594s left) gem_exec_schedule (preempt-queue-contexts)
[433.162451] Subtest preempt-queue-contexts: SKIP (0.000s)
[433.467179] [075/132] (593s left) kms_color_pipeline (plane-ctm3x4-lut1d)
[433.554403] Starting subtest: plane-ctm3x4-lut1d
[433.567812] Starting dynamic subtest: pipe-A-eDP-1
[434.264049] Dynamic subtest pipe-A-eDP-1: FAIL (0.309s)
[434.946033] Starting dynamic subtest: pipe-B-eDP-1
[435.745106] Dynamic subtest pipe-B-eDP-1: FAIL (0.290s)
[436.283116] Starting dynamic subtest: pipe-C-eDP-1
[437.102374] Dynamic subtest pipe-C-eDP-1: FAIL (0.235s)
[437.609067] Starting dynamic subtest: pipe-D-eDP-1
[438.448618] Dynamic subtest pipe-D-eDP-1: FAIL (0.257s)
[438.450678] Subtest plane-ctm3x4-lut1d: FAIL (4.607s)
[439.015609] [076/132] (588s left) kms_chamelium_frames (hdmi-crc-fast)
[439.410446] Subtest hdmi-crc-fast: SKIP (0.000s)
[440.212701] [077/132] (587s left) kms_frontbuffer_tracking (fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt)
[440.331266] Starting subtest: fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt
[440.335395] Subtest fbc-2p-scndscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[440.458918] [078/132] (587s left) gem_userptr_blits (dmabuf-unsync)
[440.540054] Subtest dmabuf-unsync: SKIP (0.000s)
[440.708742] [079/132] (586s left) kms_big_fb (x-tiled-64bpp-rotate-90)
[440.816616] Starting subtest: x-tiled-64bpp-rotate-90
[440.836075] Subtest x-tiled-64bpp-rotate-90: SKIP (0.019s)
[441.007576] [080/132] (586s left) kms_psr (fbc-psr2-primary-blt)
[441.099630] Starting subtest: fbc-psr2-primary-blt
[441.101888] Starting dynamic subtest: eDP-1
[441.105988] Dynamic subtest eDP-1: SKIP (0.000s)
[441.110120] Subtest fbc-psr2-primary-blt: SKIP (0.001s)
[441.199344] [081/132] (586s left) kms_properties (plane-properties-legacy)
[441.310525] Starting subtest: plane-properties-legacy
[441.312164] Starting dynamic subtest: pipe-A-eDP-1
[441.857798] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.545s)
[441.868073] Starting dynamic subtest: pipe-B-eDP-1
[443.102726] Dynamic subtest pipe-B-eDP-1: SUCCESS (1.245s)
[443.112204] Starting dynamic subtest: pipe-C-eDP-1
[444.334470] Dynamic subtest pipe-C-eDP-1: SUCCESS (1.232s)
[444.344325] Starting dynamic subtest: pipe-D-eDP-1
[445.568503] Dynamic subtest pipe-D-eDP-1: SUCCESS (1.233s)
[445.570890] Subtest plane-properties-legacy: SUCCESS (4.260s)
[446.389839] [082/132] (581s left) kms_psr (pr-suspend)
[446.506941] Starting subtest: pr-suspend
[446.511186] Subtest pr-suspend: SKIP (0.000s)
[446.601946] [083/132] (581s left) gen9_exec_parse (bb-chained)
[446.670479] Subtest bb-chained: SKIP (0.000s)
[446.766744] [084/132] (581s left) kms_ccs (crc-primary-rotation-180-4-tiled-dg2-rc-ccs)
[446.860810] Starting subtest: crc-primary-rotation-180-4-tiled-dg2-rc-ccs
[446.863063] Starting dynamic subtest: pipe-A-eDP-1
[446.885984] Dynamic subtest pipe-A-eDP-1: SKIP (0.000s)
[446.897580] Starting dynamic subtest: pipe-B-eDP-1
[446.919259] Dynamic subtest pipe-B-eDP-1: SKIP (0.000s)
[446.928196] Starting dynamic subtest: pipe-C-eDP-1
[446.950265] Dynamic subtest pipe-C-eDP-1: SKIP (0.000s)
[446.960685] Starting dynamic subtest: pipe-D-eDP-1
[446.982810] Dynamic subtest pipe-D-eDP-1: SKIP (0.000s)
[446.986853] Subtest crc-primary-rotation-180-4-tiled-dg2-rc-ccs: SKIP (0.005s)
[449.051041] [085/132] (578s left) kms_frontbuffer_tracking (psr-1p-primscrn-pri-shrfb-draw-mmap-cpu)
[449.163777] Starting subtest: psr-1p-primscrn-pri-shrfb-draw-mmap-cpu
[456.067698] Subtest psr-1p-primscrn-pri-shrfb-draw-mmap-cpu: SUCCESS (6.909s)
[456.205086] [086/132] (571s left) i915_hangman (engine-error-state-capture)
[456.275456] Starting subtest: engine-error-state-capture
[456.277826] Starting dynamic subtest: rcs0
[459.827184] Dynamic subtest rcs0: SUCCESS (3.553s)
[459.840487] Starting dynamic subtest: bcs0
[464.882957] Dynamic subtest bcs0: SUCCESS (5.053s)
[464.894686] Starting dynamic subtest: vcs0
[470.834191] Dynamic subtest vcs0: SUCCESS (5.948s)
[470.846545] Starting dynamic subtest: vcs1
[475.826049] Dynamic subtest vcs1: SUCCESS (4.989s)
[475.838563] Starting dynamic subtest: vecs0
[480.883279] Dynamic subtest vecs0: SUCCESS (5.055s)
[480.894900] Starting dynamic subtest: ccs0
[486.835410] Dynamic subtest ccs0: SUCCESS (5.950s)
[486.838336] Subtest engine-error-state-capture: SUCCESS (30.562s)
[487.003752] [087/132] (540s left) gem_mmap_offset (oob-read)
[487.058516] Starting subtest: oob-read
[487.060848] Subtest oob-read: SUCCESS (0.000s)
[487.204433] [088/132] (540s left) kms_vblank (wait-busy)
[487.315186] Starting subtest: wait-busy
[487.317451] Starting dynamic subtest: pipe-A-eDP-1
[489.188652] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.874s)
[489.202865] Starting dynamic subtest: pipe-D-eDP-1
[491.720455] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.528s)
[491.722645] Subtest wait-busy: SUCCESS (4.406s)
[492.557093] [089/132] (535s left) kms_content_protection (uevent-hdcp14)
[492.692641] Starting subtest: uevent-hdcp14
[492.697217] Subtest uevent-hdcp14: SKIP (0.000s)
[492.857616] [090/132] (535s left) syncobj_wait (single-wait-all-for-submit-submitted)
[492.918607] Starting subtest: single-wait-all-for-submit-submitted
[493.024681] Subtest single-wait-all-for-submit-submitted: SUCCESS (0.106s)
[493.127417] [091/132] (534s left) kms_pm_rpm (legacy-planes)
[494.974657] Starting subtest: legacy-planes
[494.976959] Starting dynamic subtest: plane-63
[503.237940] Dynamic subtest plane-63: SUCCESS (8.264s)
[503.257422] Starting dynamic subtest: plane-93
[511.558797] Dynamic subtest plane-93: SUCCESS (8.318s)
[511.578671] Starting dynamic subtest: plane-123
[519.837584] Dynamic subtest plane-123: SUCCESS (8.277s)
[519.849228] Starting dynamic subtest: plane-133
[528.391398] Dynamic subtest plane-133: SUCCESS (8.550s)
[528.394183] Subtest legacy-planes: SUCCESS (33.420s)
[528.789280] [092/132] (499s left) kms_frontbuffer_tracking (psr-2p-primscrn-indfb-plflip-blt)
[528.888079] Starting subtest: psr-2p-primscrn-indfb-plflip-blt
[528.892293] Subtest psr-2p-primscrn-indfb-plflip-blt: SKIP (0.000s)
[529.024387] [093/132] (499s left) gem_render_copy (y-tiled-mc-ccs-to-yf-tiled-ccs)
[529.087550] Starting subtest: y-tiled-mc-ccs-to-yf-tiled-ccs
[529.092048] Subtest y-tiled-mc-ccs-to-yf-tiled-ccs: SKIP (0.000s)
[529.296550] [094/132] (498s left) kms_psr2_sf (psr2-primary-plane-update-sf-dmg-area)
[534.248384] Starting subtest: psr2-primary-plane-update-sf-dmg-area
[534.250615] Starting dynamic subtest: pipe-A-eDP-1
[540.774872] Dynamic subtest pipe-A-eDP-1: SUCCESS (6.523s)
[540.784534] Starting dynamic subtest: pipe-B-eDP-1
[547.411381] Dynamic subtest pipe-B-eDP-1: SUCCESS (6.633s)
[547.413666] Subtest psr2-primary-plane-update-sf-dmg-area: SUCCESS (13.160s)
[548.321671] [095/132] (479s left) kms_vblank (ts-continuation-modeset)
[548.422507] Starting subtest: ts-continuation-modeset
[548.424403] Starting dynamic subtest: pipe-A-eDP-1
[549.855223] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.434s)
[549.870430] Starting dynamic subtest: pipe-D-eDP-1
[552.019973] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.163s)
[552.022595] Subtest ts-continuation-modeset: SUCCESS (3.600s)
[552.857612] [096/132] (475s left) kms_frontbuffer_tracking (fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt)
[552.961711] Starting subtest: fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt
[552.966172] Subtest fbcpsr-2p-primscrn-pri-shrfb-draw-mmap-gtt: SKIP (0.000s)
[553.109237] [097/132] (475s left) kms_flip (flip-vs-absolute-wf_vblank-interruptible)
[553.207744] Starting subtest: flip-vs-absolute-wf_vblank-interruptible
[553.210076] Starting dynamic subtest: A-eDP1
[562.083798] Dynamic subtest A-eDP1: SUCCESS (8.874s)
[562.098245] Starting dynamic subtest: B-eDP1
[571.003401] Dynamic subtest B-eDP1: SUCCESS (8.916s)
[571.014106] Starting dynamic subtest: C-eDP1
[579.932111] Dynamic subtest C-eDP1: SUCCESS (8.925s)
[579.946516] Starting dynamic subtest: D-eDP1
[588.867441] Dynamic subtest D-eDP1: SUCCESS (8.931s)
[588.869874] Subtest flip-vs-absolute-wf_vblank-interruptible: SUCCESS (35.657s)
[590.118616] [098/132] (438s left) kms_sequence (get-forked-busy)
[590.217445] Starting subtest: get-forked-busy
[590.219858] Starting dynamic subtest: pipe-A-eDP-1
[592.142728] Dynamic subtest pipe-A-eDP-1: SUCCESS (1.924s)
[592.152957] Starting dynamic subtest: pipe-B-eDP-1
[594.804386] Dynamic subtest pipe-B-eDP-1: SUCCESS (2.660s)
[594.813756] Starting dynamic subtest: pipe-C-eDP-1
[597.392219] Dynamic subtest pipe-C-eDP-1: SUCCESS (2.587s)
[597.401784] Starting dynamic subtest: pipe-D-eDP-1
[599.939299] Dynamic subtest pipe-D-eDP-1: SUCCESS (2.546s)
[599.941614] Subtest get-forked-busy: SUCCESS (9.723s)
[600.765701] [099/132] (427s left) kms_big_fb (y-tiled-64bpp-rotate-180)
[600.874832] Starting subtest: y-tiled-64bpp-rotate-180
[600.879317] Subtest y-tiled-64bpp-rotate-180: SKIP (0.000s)
[601.012088] [100/132] (427s left) sysfs_heartbeat_interval (idempotent)
[601.077512] Starting subtest: idempotent
[601.079755] Starting dynamic subtest: vecs0
[601.082095] Dynamic subtest vecs0: SUCCESS (0.001s)
[601.091233] Starting dynamic subtest: ccs0
[601.093099] Dynamic subtest ccs0: SUCCESS (0.001s)
[601.101060] Starting dynamic subtest: vcs0
[601.102996] Dynamic subtest vcs0: SUCCESS (0.000s)
[601.111809] Starting dynamic subtest: bcs0
[601.113736] Dynamic subtest bcs0: SUCCESS (0.001s)
[601.122528] Starting dynamic subtest: rcs0
[601.124464] Dynamic subtest rcs0: SUCCESS (0.000s)
[601.133102] Starting dynamic subtest: vcs1
[601.134958] Dynamic subtest vcs1: SUCCESS (0.000s)
[601.137103] Subtest idempotent: SUCCESS (0.007s)
[601.222969] [101/132] (427s left) kms_plane_scaling (planes-downscale-factor-0-75-upscale-factor-0-25)
[601.324970] Starting subtest: planes-downscale-factor-0-75-upscale-factor-0-25
[601.327236] Starting dynamic subtest: pipe-A
[601.388309] Dynamic subtest pipe-A: SUCCESS (0.065s)
[601.398311] Starting dynamic subtest: pipe-B
[602.571490] Dynamic subtest pipe-B: SUCCESS (1.181s)
[602.582211] Starting dynamic subtest: pipe-C
[603.688964] Dynamic subtest pipe-C: SUCCESS (1.115s)
[603.702286] Starting dynamic subtest: pipe-D
[604.835551] Dynamic subtest pipe-D: SUCCESS (1.143s)
[604.837719] Subtest planes-downscale-factor-0-75-upscale-factor-0-25: SUCCESS (3.513s)
[606.018136] [102/132] (422s left) kms_psr (psr-sprite-plane-onoff)
[606.119517] Starting subtest: psr-sprite-plane-onoff
[606.121639] Starting dynamic subtest: eDP-1
[607.903210] Dynamic subtest eDP-1: SUCCESS (1.783s)
[607.905370] Subtest psr-sprite-plane-onoff: SUCCESS (1.784s)
[608.758932] [103/132] (419s left) kms_cursor_edge_walk (256x256-top-edge)
[608.859952] Starting subtest: 256x256-top-edge
[608.862201] Starting dynamic subtest: pipe-A-eDP-1
[612.297816] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.439s)
[612.306489] Starting dynamic subtest: pipe-D-eDP-1
[615.420103] Dynamic subtest pipe-D-eDP-1: SUCCESS (3.118s)
[615.422044] Subtest 256x256-top-edge: SUCCESS (6.560s)
[616.260705] [104/132] (412s left) fbdev (info)
[616.299488] Starting subtest: info
[616.302024] Subtest info: SUCCESS (0.000s)
[616.388051] [105/132] (412s left) kms_atomic (crtc-invalid-params-fence)
[616.477936] Starting subtest: crtc-invalid-params-fence
[616.480149] Starting dynamic subtest: pipe-A-eDP-1
[616.897868] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.421s)
[616.900236] Subtest crtc-invalid-params-fence: SUCCESS (0.422s)
[617.818294] [106/132] (410s left) sw_sync (sync_merge_same)
[617.867158] Starting subtest: sync_merge_same
[617.869457] Subtest sync_merge_same: SUCCESS (0.000s)
[617.953276] [107/132] (410s left) kms_frontbuffer_tracking (fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc)
[618.047956] Starting subtest: fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc
[618.052118] Subtest fbcpsr-2p-scndscrn-cur-indfb-draw-mmap-wc: SKIP (0.000s)
[618.190721] [108/132] (410s left) kms_plane_multiple (tiling-4)
[618.296119] Starting subtest: tiling-4
[618.298346] Starting dynamic subtest: pipe-A-eDP-1
[622.011060] Dynamic subtest pipe-A-eDP-1: SUCCESS (3.714s)
[622.020839] Starting dynamic subtest: pipe-B-eDP-1
[626.344313] Dynamic subtest pipe-B-eDP-1: SUCCESS (4.333s)
[626.354209] Starting dynamic subtest: pipe-C-eDP-1
[630.668870] Dynamic subtest pipe-C-eDP-1: SUCCESS (4.324s)
[630.678067] Starting dynamic subtest: pipe-D-eDP-1
[634.987419] Dynamic subtest pipe-D-eDP-1: SUCCESS (4.317s)
[634.989653] Subtest tiling-4: SUCCESS (16.693s)
[635.834413] [109/132] (393s left) kms_flip_scaled_crc (flip-64bpp-linear-to-32bpp-linear-upscaling)
[635.945753] Starting subtest: flip-64bpp-linear-to-32bpp-linear-upscaling
[635.948084] Starting dynamic subtest: pipe-A-default-mode
[638.646451] Dynamic subtest pipe-A-default-mode: SUCCESS (2.698s)
[638.648653] Subtest flip-64bpp-linear-to-32bpp-linear-upscaling: SUCCESS (2.699s)
[639.526398] [110/132] (389s left) kms_big_fb (4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip)
[639.635572] Starting subtest: 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip
[640.281683] Subtest 4-tiled-max-hw-stride-32bpp-rotate-180-hflip-async-flip: SUCCESS (0.648s)
[640.478686] [111/132] (388s left) kms_lease (empty-lease)
[640.566806] Starting subtest: empty-lease
[640.569046] Starting dynamic subtest: pipe-A-eDP-1
[640.571309] Dynamic subtest pipe-A-eDP-1: SUCCESS (0.001s)
[640.581028] Starting dynamic subtest: pipe-B-eDP-1
[640.582981] Dynamic subtest pipe-B-eDP-1: SUCCESS (0.001s)
[640.591588] Starting dynamic subtest: pipe-C-eDP-1
[640.593454] Dynamic subtest pipe-C-eDP-1: SUCCESS (0.001s)
[640.601977] Starting dynamic subtest: pipe-D-eDP-1
[640.603817] Dynamic subtest pipe-D-eDP-1: SUCCESS (0.001s)
[640.605644] Subtest empty-lease: SUCCESS (0.010s)
[640.708552] [112/132] (388s left) gem_exec_flush (basic-uc-ro-default)
[640.781515] Starting subtest: basic-uc-ro-default
[646.236714] Subtest basic-uc-ro-default: SUCCESS (5.455s)
[646.451009] [113/132] (382s left) gem_softpin (overlap)
[646.513735] Starting subtest: overlap
[647.404705] Subtest overlap: SUCCESS (0.889s)
[647.577563] [114/132] (381s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-cur-indfb-draw-blt)
[647.698518] Starting subtest: fbcpsr-1p-primscrn-cur-indfb-draw-blt
[654.435313] Subtest fbcpsr-1p-primscrn-cur-indfb-draw-blt: SUCCESS (6.740s)
[654.605376] [115/132] (374s left) gem_mmap_wc (copy)
[654.671839] Subtest copy: SKIP (0.000s)
[654.739801] [116/132] (374s left) kms_flip (dpms-vs-vblank-race)
[654.837861] Starting subtest: dpms-vs-vblank-race
[654.840228] Starting dynamic subtest: A-eDP1
[658.689970] Dynamic subtest A-eDP1: SUCCESS (3.853s)
[658.700567] Starting dynamic subtest: B-eDP1
[663.310297] Dynamic subtest B-eDP1: SUCCESS (4.618s)
[663.319503] Starting dynamic subtest: C-eDP1
[667.891131] Dynamic subtest C-eDP1: SUCCESS (4.581s)
[667.901148] Starting dynamic subtest: D-eDP1
[672.498869] Dynamic subtest D-eDP1: SUCCESS (4.604s)
[672.501144] Subtest dpms-vs-vblank-race: SUCCESS (17.663s)
[673.398969] [117/132] (355s left) gem_exec_schedule (preempt-queue)
[673.482153] Subtest preempt-queue: SKIP (0.000s)
[673.790597] [118/132] (355s left) i915_query (query-regions-sanity-check)
[673.839632] Starting subtest: query-regions-sanity-check
[673.850202] Subtest query-regions-sanity-check: SUCCESS (0.014s)
[674.004316] [119/132] (355s left) testdisplay
[674.356944] [120/132] (354s left) kms_frontbuffer_tracking (fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt)
[674.447585] Starting subtest: fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt
[674.452037] Subtest fbcpsr-1p-primscrn-spr-indfb-draw-mmap-gtt: SKIP (0.000s)
[674.581981] [121/132] (354s left) kms_cursor_legacy (single-move)
[674.698422] Starting subtest: single-move
[674.700662] Starting dynamic subtest: pipe-A
[680.081263] Dynamic subtest pipe-A: SUCCESS (5.379s)
[680.092099] Starting dynamic subtest: pipe-B
[685.479747] Dynamic subtest pipe-B: SUCCESS (5.380s)
[685.491261] Starting dynamic subtest: pipe-C
[690.847783] Dynamic subtest pipe-C: SUCCESS (5.379s)
[690.859450] Starting dynamic subtest: pipe-D
[696.229793] Dynamic subtest pipe-D: SUCCESS (5.379s)
[696.241208] Starting dynamic subtest: all-pipes
[701.618352] Dynamic subtest all-pipes: SUCCESS (5.386s)
[701.620777] Subtest single-move: SUCCESS (26.917s)
[701.788221] [122/132] (327s left) gem_exec_capture (capture)
[701.851012] Starting subtest: capture
[701.853178] Starting dynamic subtest: rcs0-smem
[702.681690] Dynamic subtest rcs0-smem: SUCCESS (0.830s)
[702.690649] Starting dynamic subtest: bcs0-smem
[703.496163] Dynamic subtest bcs0-smem: SUCCESS (0.815s)
[703.504965] Starting dynamic subtest: vcs0-smem
[704.334309] Dynamic subtest vcs0-smem: SUCCESS (0.837s)
[704.342917] Starting dynamic subtest: vcs1-smem
[705.192288] Dynamic subtest vcs1-smem: SUCCESS (0.856s)
[705.202282] Starting dynamic subtest: vecs0-smem
[706.079516] Dynamic subtest vecs0-smem: FAIL (0.820s)
[706.090143] Starting dynamic subtest: ccs0-smem
[707.333172] Dynamic subtest ccs0-smem: SUCCESS (1.320s)
[707.335501] Subtest capture: FAIL (5.483s)
[707.497869] [123/132] (321s left) drm_read (fault-buffer)
[707.647579] Starting subtest: fault-buffer
[707.649837] Subtest fault-buffer: SUCCESS (0.001s)
[707.813993] [124/132] (321s left) syncobj_wait (signal)
[707.866956] Starting subtest: signal
[707.869279] Subtest signal: SUCCESS (0.000s)
[707.995117] [125/132] (321s left) kms_cursor_crc (cursor-random-512x512)
[708.257015] Starting subtest: cursor-random-512x512
[708.261471] Subtest cursor-random-512x512: SKIP (0.001s)
[708.450292] [126/132] (321s left) kms_frontbuffer_tracking (fbc-1p-primscrn-spr-indfb-draw-pwrite)
[708.552511] Starting subtest: fbc-1p-primscrn-spr-indfb-draw-pwrite
[713.024211] Subtest fbc-1p-primscrn-spr-indfb-draw-pwrite: SUCCESS (4.473s)
[714.210944] [127/132] (315s left) gem_exec_balancer (bonded-chain)
[714.271849] Starting subtest: bonded-chain
[721.234780] Subtest bonded-chain: SUCCESS (6.960s)
[721.596031] [128/132] (308s left) gem_eio (throttle)
[721.815638] Starting subtest: throttle
[722.114988] Subtest throttle: SUCCESS (0.299s)
[722.293383] [129/132] (307s left) syncobj_timeline (etime-single-wait-for-submit-submitted)
[722.349779] Starting subtest: etime-single-wait-for-submit-submitted
[722.456971] Subtest etime-single-wait-for-submit-submitted: SUCCESS (0.107s)
[722.559671] [130/132] (307s left) i915_drm_fdinfo (all-busy-idle-check-all)
[722.597977] Starting subtest: all-busy-idle-check-all
[722.602509] Subtest all-busy-idle-check-all: SKIP (0.003s)
[722.689631] [131/132] (307s left) kms_flip (2x-flip-vs-suspend)
[722.827896] Starting subtest: 2x-flip-vs-suspend
[722.837048] Subtest 2x-flip-vs-suspend: SKIP (0.010s)
[722.944077] [132/132] (306s left) kms_psr (fbc-pr-sprite-plane-onoff)
[723.037205] Starting subtest: fbc-pr-sprite-plane-onoff
[723.041179] Subtest fbc-pr-sprite-plane-onoff: SKIP (0.000s)
[723.137900] 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.